builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0076 starttime: 1447774518.5 results: success (0) buildid: 20151117061705 builduid: 59b3964fcac0482689a535763c2c9d5d revision: e37dcb50abc2ed405a480087cf2f63f77f575310 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:18.501338) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:18.501815) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:18.502098) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.006764 basedir: '/builds/slave/test' ========= master_lag: 0.41 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:18.914704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:18.915019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.202518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.202837) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.027765 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.252577) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.252931) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.253358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.253728) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 07:35:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 579M=0s 2015-11-17 07:35:19 (579 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.476329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.476725) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.163060 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:19.655827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 07:35:19.656169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e37dcb50abc2ed405a480087cf2f63f77f575310 --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 e37dcb50abc2ed405a480087cf2f63f77f575310 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 07:35:19,756 truncating revision to first 12 chars 2015-11-17 07:35:19,756 Setting DEBUG logging. 2015-11-17 07:35:19,756 attempt 1/10 2015-11-17 07:35:19,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e37dcb50abc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 07:35:20,562 unpacking tar archive at: fx-team-e37dcb50abc2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 07:35:20.773185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:20.773500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:20.791820) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:20.792149) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 07:35:20.792576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-17 07:35:20.792873) ========= /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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:21 INFO - MultiFileLogger online at 20151117 07:35:21 in /builds/slave/test 07:35:21 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:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:21 INFO - {'append_to_log': False, 07:35:21 INFO - 'base_work_dir': '/builds/slave/test', 07:35:21 INFO - 'blob_upload_branch': 'Fx-Team', 07:35:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:21 INFO - 'branch': 'Fx-Team', 07:35:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:21 INFO - 'config_files': ('talos/mac_config.py',), 07:35:21 INFO - 'default_actions': ('clobber', 07:35:21 INFO - 'read-buildbot-config', 07:35:21 INFO - 'download-and-extract', 07:35:21 INFO - 'populate-webroot', 07:35:21 INFO - 'create-virtualenv', 07:35:21 INFO - 'install', 07:35:21 INFO - 'run-tests'), 07:35:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:21 INFO - 'download_minidump_stackwalk': True, 07:35:21 INFO - 'download_symbols': 'ondemand', 07:35:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:21 INFO - 'installer_path': 'installer.exe', 07:35:21 INFO - 'log_level': 'info', 07:35:21 INFO - 'log_name': 'talos', 07:35:21 INFO - 'log_to_console': True, 07:35:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:21 INFO - 'opt_config_files': (), 07:35:21 INFO - 'pip_index': False, 07:35:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:21 INFO - 'cmd': ('bash', 07:35:21 INFO - '-c', 07:35:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:21 INFO - 'enabled': True, 07:35:21 INFO - 'halt_on_failure': False, 07:35:21 INFO - 'name': 'check_screen_resolution'},), 07:35:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:21 INFO - 'cmd': ('bash', 07:35:21 INFO - '-c', 07:35:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:21 INFO - 'enabled': True, 07:35:21 INFO - 'halt_on_failure': False, 07:35:21 INFO - 'name': 'check_screen_resolution'},), 07:35:21 INFO - 'run_cmd_checks_enabled': True, 07:35:21 INFO - 'sps_profile': False, 07:35:21 INFO - 'sps_profile_interval': 0, 07:35:21 INFO - 'suite': 'dromaeojs', 07:35:21 INFO - 'system_bits': '64', 07:35:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:21 INFO - 'title': 't-yosemite-r5-0076', 07:35:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:21 INFO - 'use_talos_json': True, 07:35:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:21 INFO - 'work_dir': 'build'} 07:35:21 INFO - ##### 07:35:21 INFO - ##### Running clobber step. 07:35:21 INFO - ##### 07:35:21 INFO - Running pre-action listener: _resource_record_pre_action 07:35:21 INFO - Running main action method: clobber 07:35:21 INFO - rmtree: /builds/slave/test/build 07:35:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - ##### 07:35:25 INFO - ##### Running read-buildbot-config step. 07:35:25 INFO - ##### 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: read_buildbot_config 07:35:25 INFO - Using buildbot properties: 07:35:25 INFO - { 07:35:25 INFO - "properties": { 07:35:25 INFO - "buildnumber": 1242, 07:35:25 INFO - "product": "firefox", 07:35:25 INFO - "script_repo_revision": "production", 07:35:25 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 07:35:25 INFO - "repository": "", 07:35:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 07:35:25 INFO - "buildid": "20151117061705", 07:35:25 INFO - "slavename": "t-yosemite-r5-0076", 07:35:25 INFO - "pgo_build": "False", 07:35:25 INFO - "basedir": "/builds/slave/test", 07:35:25 INFO - "project": "", 07:35:25 INFO - "platform": "yosemite", 07:35:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:35:25 INFO - "slavebuilddir": "test", 07:35:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:35:25 INFO - "branch": "fx-team", 07:35:25 INFO - "repo_path": "integration/fx-team", 07:35:25 INFO - "stage_platform": "macosx64", 07:35:25 INFO - "builduid": "59b3964fcac0482689a535763c2c9d5d", 07:35:25 INFO - "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310" 07:35:25 INFO - }, 07:35:25 INFO - "sourcestamp": { 07:35:25 INFO - "repository": "", 07:35:25 INFO - "hasPatch": false, 07:35:25 INFO - "project": "", 07:35:25 INFO - "branch": "fx-team-macosx64-talos", 07:35:25 INFO - "changes": [ 07:35:25 INFO - { 07:35:25 INFO - "category": null, 07:35:25 INFO - "files": [ 07:35:25 INFO - { 07:35:25 INFO - "url": null, 07:35:25 INFO - "name": "https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:35:25 INFO - } 07:35:25 INFO - ], 07:35:25 INFO - "repository": "", 07:35:25 INFO - "rev": "e37dcb50abc2ed405a480087cf2f63f77f575310", 07:35:25 INFO - "who": "mbanner@mozilla.com", 07:35:25 INFO - "when": 1447772851, 07:35:25 INFO - "number": 6672142, 07:35:25 INFO - "comments": "Bug 1201902 - Add new feedback link to Loop's panel menu. r=Standard8", 07:35:25 INFO - "project": "", 07:35:25 INFO - "at": "Tue 17 Nov 2015 07:07:31", 07:35:25 INFO - "branch": "fx-team-macosx64-talos", 07:35:25 INFO - "revlink": "", 07:35:25 INFO - "properties": [ 07:35:25 INFO - [ 07:35:25 INFO - "buildid", 07:35:25 INFO - "20151117061705", 07:35:25 INFO - "Change" 07:35:25 INFO - ], 07:35:25 INFO - [ 07:35:25 INFO - "builduid", 07:35:25 INFO - "59b3964fcac0482689a535763c2c9d5d", 07:35:25 INFO - "Change" 07:35:25 INFO - ], 07:35:25 INFO - [ 07:35:25 INFO - "pgo_build", 07:35:25 INFO - "False", 07:35:25 INFO - "Change" 07:35:25 INFO - ] 07:35:25 INFO - ], 07:35:25 INFO - "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310" 07:35:25 INFO - } 07:35:25 INFO - ], 07:35:25 INFO - "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310" 07:35:25 INFO - } 07:35:25 INFO - } 07:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - ##### 07:35:25 INFO - ##### Running download-and-extract step. 07:35:25 INFO - ##### 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: download_and_extract 07:35:25 INFO - mkdir: /builds/slave/test/build/tests 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:25 INFO - https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/test_packages.json 07:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/test_packages.json 07:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:35:26 INFO - Downloaded 1149 bytes. 07:35:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:35:26 INFO - Using the following test package requirements: 07:35:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:35:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'jsshell-mac.zip'], 07:35:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:35:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:35:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:35:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:35:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:35:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:35:26 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:35:26 INFO - https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:35:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:27 INFO - Downloaded 17461095 bytes. 07:35:27 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:35:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:35:33 INFO - Return code: 0 07:35:33 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:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:33 INFO - https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:34 INFO - Downloaded 17461095 bytes. 07:35:34 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:35:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:35:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:35:40 INFO - Return code: 0 07:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:40 INFO - https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:41 INFO - Downloaded 11131693 bytes. 07:35:41 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:35:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:35:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:35:42 INFO - Return code: 0 07:35:42 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:35:42 INFO - https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2VuK33dVQCyeiBNyr-tJPg/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:35:45 INFO - Downloaded 108799614 bytes. 07:35:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:35:45 INFO - mkdir: /builds/slave/test/properties 07:35:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:45 INFO - Contents: 07:35:45 INFO - build_url:https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:35:45 INFO - Running post-action listener: _resource_record_post_action 07:35:45 INFO - Running post-action listener: set_extra_try_arguments 07:35:45 INFO - ##### 07:35:45 INFO - ##### Running populate-webroot step. 07:35:45 INFO - ##### 07:35:45 INFO - Running pre-action listener: _resource_record_pre_action 07:35:45 INFO - Running main action method: populate_webroot 07:35:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:35:45 INFO - '../fennec_ids.txt'], 07:35:45 INFO - 'tests': ['tcheck2']}, 07:35:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:45 INFO - '--tppagecycles', 07:35:45 INFO - '7'], 07:35:45 INFO - 'tests': ['tsvgm']}}, 07:35:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:35:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:35:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:35:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'tests': ['damp', 'tps']}, 07:35:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['damp', 'tps']}, 07:35:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:35:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:45 INFO - 'other': {'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'other_l64': {'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'other_nol64': {'tests': ['a11yr', 07:35:45 INFO - 'ts_paint', 07:35:45 INFO - 'tpaint', 07:35:45 INFO - 'sessionrestore', 07:35:45 INFO - 'sessionrestore_no_auto_restore']}, 07:35:45 INFO - 'svgr': {'tests': ['tsvgx', 07:35:45 INFO - 'tsvgr_opacity', 07:35:45 INFO - 'tart', 07:35:45 INFO - 'tscrollx', 07:35:45 INFO - 'cart']}, 07:35:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['tsvgx', 07:35:45 INFO - 'tsvgr_opacity', 07:35:45 INFO - 'tart', 07:35:45 INFO - 'tscrollx', 07:35:45 INFO - 'cart']}, 07:35:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'tests': ['tp5o']}, 07:35:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'talos_options': ['--e10s'], 07:35:45 INFO - 'tests': ['tp5o']}, 07:35:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'talos_options': ['--xperf_path', 07:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:45 INFO - 'tests': ['tp5n']}, 07:35:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:45 INFO - 'talos_options': ['--e10s', 07:35:45 INFO - '--xperf_path', 07:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:45 INFO - 'tests': ['tp5n']}}, 07:35:45 INFO - 'talos.zip': {'path': '', 07:35:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:45 INFO - Running post-action listener: _resource_record_post_action 07:35:45 INFO - ##### 07:35:45 INFO - ##### Running create-virtualenv step. 07:35:45 INFO - ##### 07:35:45 INFO - Running pre-action listener: _resource_record_pre_action 07:35:45 INFO - Running main action method: create_virtualenv 07:35:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:45 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:35:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:46 INFO - Using real prefix '/tools/python27' 07:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:50 INFO - Installing pip.................done. 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:50 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:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:35:51 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:35:51 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:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 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:35:51 INFO - Cleaning up... 07:35:51 INFO - Return code: 0 07:35:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:35:51 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:35:51 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:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:52 INFO - Downloading/unpacking psutil>=0.7.1 07:35:52 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:35:52 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:35:52 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:35:52 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:35:52 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:35:52 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:35:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:35:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:55 INFO - Installing collected packages: psutil 07:35:55 INFO - Running setup.py install for psutil 07:35:55 INFO - building 'psutil._psutil_osx' extension 07:35:55 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:35:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:35:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:35:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:35:57 INFO - building 'psutil._psutil_posix' extension 07:35:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:35:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:57 INFO - ^ 07:35:57 INFO - 1 warning generated. 07:35:57 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:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:58 INFO - Successfully installed psutil 07:35:58 INFO - Cleaning up... 07:35:58 INFO - Return code: 0 07:35:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:58 INFO - 'HOME': '/Users/cltbld', 07:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:58 INFO - 'LOGNAME': 'cltbld', 07:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:58 INFO - 'MOZ_NO_REMOTE': '1', 07:35:58 INFO - 'NO_EM_RESTART': '1', 07:35:58 INFO - 'PAGER': '/bin/cat', 07:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:58 INFO - 'PWD': '/builds/slave/test', 07:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:58 INFO - 'SHELL': '/bin/bash', 07:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:35:58 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:58 INFO - 'USER': 'cltbld', 07:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:58 INFO - 'XPC_FLAGS': '0x0', 07:35:58 INFO - 'XPC_SERVICE_NAME': '0', 07:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:36:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:36:01 INFO - Installing collected packages: mozsystemmonitor 07:36:01 INFO - Running setup.py install for mozsystemmonitor 07:36:01 INFO - Successfully installed mozsystemmonitor 07:36:01 INFO - Cleaning up... 07:36:01 INFO - Return code: 0 07:36:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:01 INFO - 'HOME': '/Users/cltbld', 07:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:01 INFO - 'LOGNAME': 'cltbld', 07:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:01 INFO - 'MOZ_NO_REMOTE': '1', 07:36:01 INFO - 'NO_EM_RESTART': '1', 07:36:01 INFO - 'PAGER': '/bin/cat', 07:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:01 INFO - 'PWD': '/builds/slave/test', 07:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:01 INFO - 'SHELL': '/bin/bash', 07:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:36:01 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:01 INFO - 'USER': 'cltbld', 07:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:01 INFO - 'XPC_FLAGS': '0x0', 07:36:01 INFO - 'XPC_SERVICE_NAME': '0', 07:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:05 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:36:05 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:36:05 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:36:05 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:36:05 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:36:05 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:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:06 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:36:06 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:36:06 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:36:06 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:36:06 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:36:06 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:36:06 INFO - Downloading docopt-0.6.1.tar.gz 07:36:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:06 INFO - Running setup.py install for blobuploader 07:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:06 INFO - Running setup.py install for requests 07:36:07 INFO - Running setup.py install for docopt 07:36:07 INFO - Successfully installed blobuploader requests docopt 07:36:07 INFO - Cleaning up... 07:36:07 INFO - Return code: 0 07:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:36:07 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:36:07 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:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:07 INFO - 'HOME': '/Users/cltbld', 07:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PAGER': '/bin/cat', 07:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:36:07 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - 'XPC_FLAGS': '0x0', 07:36:07 INFO - 'XPC_SERVICE_NAME': '0', 07:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-YIiOoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-zabl3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-B2Nb7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-seG34A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-lA0mTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:08 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-6wI_JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-xFTZW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-J4rvhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-DL466a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-0O7mip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-ooOPQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-zhZnla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-izUYDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-5p7k4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-MaVbjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-ke3LLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-pQSDJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:10 INFO - Running setup.py install for manifestparser 07:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozcrash 07:36:11 INFO - Running setup.py install for mozdebug 07:36:11 INFO - Running setup.py install for mozdevice 07:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozfile 07:36:11 INFO - Running setup.py install for mozhttpd 07:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozinfo 07:36:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozInstall 07:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozleak 07:36:12 INFO - Running setup.py install for mozlog 07:36:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for moznetwork 07:36:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozprocess 07:36:13 INFO - Running setup.py install for mozprofile 07:36:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozrunner 07:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozscreenshot 07:36:13 INFO - Running setup.py install for moztest 07:36:13 INFO - Running setup.py install for mozversion 07:36:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:14 INFO - Cleaning up... 07:36:14 INFO - Return code: 0 07:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:14 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 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:36:14 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:36:14 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:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:14 INFO - 'HOME': '/Users/cltbld', 07:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:14 INFO - 'LOGNAME': 'cltbld', 07:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:14 INFO - 'MOZ_NO_REMOTE': '1', 07:36:14 INFO - 'NO_EM_RESTART': '1', 07:36:14 INFO - 'PAGER': '/bin/cat', 07:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:14 INFO - 'PWD': '/builds/slave/test', 07:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:14 INFO - 'SHELL': '/bin/bash', 07:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:36:14 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:14 INFO - 'USER': 'cltbld', 07:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:14 INFO - 'XPC_FLAGS': '0x0', 07:36:14 INFO - 'XPC_SERVICE_NAME': '0', 07:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:14 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-qCTtUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:14 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:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:14 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-7AyXwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:14 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:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:14 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-YL2vXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-uGrsyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-zMx61O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-wVx0bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-7u771d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-AaWG1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-0Q5d8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:15 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:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:15 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-k1GnOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-nmFxiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-OxlOQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-c2ssrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-DvGVyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-nfSmYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-40_g3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:16 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:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:16 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-XcNSvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:17 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:36:17 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:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:17 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:36:17 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:36:17 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:36:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:17 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:36:17 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:36:17 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:36:17 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:36:17 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:36:17 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:36:19 INFO - Downloading blessings-1.5.1.tar.gz 07:36:19 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:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:20 INFO - Installing collected packages: blessings 07:36:20 INFO - Running setup.py install for blessings 07:36:20 INFO - Successfully installed blessings 07:36:20 INFO - Cleaning up... 07:36:20 INFO - Return code: 0 07:36:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:20 INFO - Reading from file tmpfile_stdout 07:36:20 INFO - Current package versions: 07:36:20 INFO - blessings == 1.5.1 07:36:20 INFO - blobuploader == 1.2.4 07:36:20 INFO - docopt == 0.6.1 07:36:20 INFO - manifestparser == 1.1 07:36:20 INFO - mozInstall == 1.12 07:36:20 INFO - mozcrash == 0.16 07:36:20 INFO - mozdebug == 0.1 07:36:20 INFO - mozdevice == 0.47 07:36:20 INFO - mozfile == 1.2 07:36:20 INFO - mozhttpd == 0.7 07:36:20 INFO - mozinfo == 0.9 07:36:20 INFO - mozleak == 0.1 07:36:20 INFO - mozlog == 3.0 07:36:20 INFO - moznetwork == 0.27 07:36:20 INFO - mozprocess == 0.22 07:36:20 INFO - mozprofile == 0.27 07:36:20 INFO - mozrunner == 6.11 07:36:20 INFO - mozscreenshot == 0.1 07:36:20 INFO - mozsystemmonitor == 0.0 07:36:20 INFO - moztest == 0.7 07:36:20 INFO - mozversion == 1.4 07:36:20 INFO - psutil == 3.1.1 07:36:20 INFO - requests == 1.2.3 07:36:20 INFO - wsgiref == 0.1.2 07:36:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:20 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 0x1035e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83d2cdcba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, '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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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:36:20 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:36:20 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:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:20 INFO - 'HOME': '/Users/cltbld', 07:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:20 INFO - 'LOGNAME': 'cltbld', 07:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:20 INFO - 'MOZ_NO_REMOTE': '1', 07:36:20 INFO - 'NO_EM_RESTART': '1', 07:36:20 INFO - 'PAGER': '/bin/cat', 07:36:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:20 INFO - 'PWD': '/builds/slave/test', 07:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:20 INFO - 'SHELL': '/bin/bash', 07:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:36:20 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:20 INFO - 'USER': 'cltbld', 07:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:20 INFO - 'XPC_FLAGS': '0x0', 07:36:20 INFO - 'XPC_SERVICE_NAME': '0', 07:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 INFO - Cleaning up... 07:36:21 INFO - Return code: 0 07:36:21 INFO - Running post-action listener: _resource_record_post_action 07:36:21 INFO - Running post-action listener: _start_resource_monitoring 07:36:21 INFO - Starting resource monitoring. 07:36:21 INFO - ##### 07:36:21 INFO - ##### Running install step. 07:36:21 INFO - ##### 07:36:21 INFO - Running pre-action listener: _resource_record_pre_action 07:36:21 INFO - Running main action method: install 07:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:21 INFO - Reading from file tmpfile_stdout 07:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:21 INFO - Reading from file tmpfile_stdout 07:36:21 INFO - Output received: 07:36:21 INFO - Usage: mozinstall [options] installer 07:36:21 INFO - Options: 07:36:21 INFO - -h, --help show this help message and exit 07:36:21 INFO - -d DEST, --destination=DEST 07:36:21 INFO - Directory to install application into. [default: 07:36:21 INFO - "/builds/slave/test"] 07:36:21 INFO - --app=APP Application being installed. [default: firefox] 07:36:21 INFO - mkdir: /builds/slave/test/build/application 07:36:21 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:36:21 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:37:05 INFO - Reading from file tmpfile_stdout 07:37:05 INFO - Output received: 07:37:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:37:05 INFO - Running post-action listener: _resource_record_post_action 07:37:05 INFO - ##### 07:37:05 INFO - ##### Running run-tests step. 07:37:05 INFO - ##### 07:37:05 INFO - Running pre-action listener: _resource_record_pre_action 07:37:05 INFO - Running main action method: run_tests 07:37:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:05 INFO - 2015-11-17 07:37:05.893 screenresolution[1633:7580] starting screenresolution argv=screenresolution get 07:37:05 INFO - 2015-11-17 07:37:05.897 screenresolution[1633:7580] Display 0: 1600x1200x32@60 07:37:05 INFO - 2015-11-17 07:37:05.905 screenresolution[1634:7582] starting screenresolution argv=screenresolution list 07:37:05 INFO - Available Modes on Display 0 07:37:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:06 INFO - Intel HD Graphics 3000: 07:37:06 INFO - Chipset Model: Intel HD Graphics 3000 07:37:06 INFO - Type: GPU 07:37:06 INFO - Bus: Built-In 07:37:06 INFO - VRAM (Total): 512 MB 07:37:06 INFO - VRAM (Dynamic, Max): 10 07:37:06 INFO - Vendor: Intel (0x8086) 07:37:06 INFO - Device ID: 0x0116 07:37:06 INFO - Revision ID: 0x0009 07:37:06 INFO - Displays: 07:37:06 INFO - Display: 07:37:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:06 INFO - Display Serial Number: 1600x1200 60 07:37:06 INFO - Main Display: Yes 07:37:06 INFO - Mirror: Off 07:37:06 INFO - Online: Yes 07:37:06 INFO - Rotation: Supported 07:37:06 INFO - Return code: 0 07:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:06 INFO - Python 2.7.3 07:37:06 INFO - Return code: 0 07:37:06 INFO - grabbing minidump binary from tooltool 07:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:06 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 0x1035069f0>, '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 0x103266db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034fa8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:06 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:37:06 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:37:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:06 INFO - Return code: 0 07:37:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:37:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:37:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:06 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/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0076', '--webServer', 'localhost'] in /builds/slave/test/build 07:37:06 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/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0076 --webServer localhost 07:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VRjTFuZh4i/Render', 07:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:06 INFO - 'HOME': '/Users/cltbld', 07:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:06 INFO - 'LOGNAME': 'cltbld', 07:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:06 INFO - 'MOZ_NO_REMOTE': '1', 07:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:06 INFO - 'NO_EM_RESTART': '1', 07:37:06 INFO - 'PAGER': '/bin/cat', 07:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:06 INFO - 'PWD': '/builds/slave/test', 07:37:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:06 INFO - 'SHELL': '/bin/bash', 07:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1AmKIO9ZJX/Listeners', 07:37:06 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 07:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:06 INFO - 'USER': 'cltbld', 07:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:06 INFO - 'XPC_FLAGS': '0x0', 07:37:06 INFO - 'XPC_SERVICE_NAME': '0', 07:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:37:06 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/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0076', '--webServer', 'localhost'] with output_timeout 3600 07:37:06 INFO - mozversion INFO | application_buildid: 20151117061705 07:37:06 INFO - mozversion INFO | application_changeset: e37dcb50abc2ed405a480087cf2f63f77f575310 07:37:06 INFO - mozversion INFO | application_display_name: Nightly 07:37:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:06 INFO - mozversion INFO | application_name: Firefox 07:37:06 INFO - mozversion INFO | application_remotingname: firefox 07:37:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:37:06 INFO - mozversion INFO | application_vendor: Mozilla 07:37:06 INFO - mozversion INFO | application_version: 45.0a1 07:37:06 INFO - mozversion INFO | platform_buildid: 20151117061705 07:37:06 INFO - mozversion INFO | platform_changeset: e37dcb50abc2ed405a480087cf2f63f77f575310 07:37:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:06 INFO - mozversion INFO | platform_version: 45.0a1 07:37:06 INFO - 2015-11-17 07:37:06,689 DEBUG : using testdate: 1447774626 07:37:06 INFO - 2015-11-17 07:37:06,689 DEBUG : actual date: 1447774626 07:37:06 INFO - 2015-11-17 07:37:06,700 INFO : starting webserver on 'localhost:49268' 07:37:06 INFO - 2015-11-17 07:37:06,702 INFO : Starting test suite t-yosemite-r5-0076 07:37:06 INFO - 2015-11-17 07:37:06,702 INFO : Starting test dromaeo_css 07:37:06 INFO - 2015-11-17 07:37:06,702 DEBUG : operating with platform_type : mac_ 07:37:06 INFO - 2015-11-17 07:37:06,703 INFO : Initialising browser for dromaeo_css test... 07:37:06 INFO - 2015-11-17 07:37:06,728 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpw_cA1n/profile http://localhost:49268/getInfo.html 07:37:10 INFO - 2015-11-17 07:37:10,562 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:37:10 INFO - 2015-11-17 07:37:10,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:37:10 INFO - 2015-11-17 07:37:10,562 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:37:10 INFO - 2015-11-17 07:37:10,563 DEBUG : BROWSER_OUTPUT: __metrics 07:37:10 INFO - 2015-11-17 07:37:10,581 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:37:11 INFO - 2015-11-17 07:37:11,421 INFO : Browser initialized. 07:37:11 INFO - 2015-11-17 07:37:11,421 INFO : Running cycle 1/1 for dromaeo_css test... 07:37:11 INFO - 2015-11-17 07:37:11,421 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpw_cA1n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:37:23 INFO - 2015-11-17 07:37:23,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 228753408 07:37:23 INFO - 2015-11-17 07:37:23,673 DEBUG : BROWSER_OUTPUT: 07:38:14 INFO - 2015-11-17 07:38:14,858 DEBUG : BROWSER_OUTPUT: 1447774694857 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:40:25 INFO - 2015-11-17 07:40:25,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 07:40:27 INFO - 2015-11-17 07:40:27,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 367947776 07:40:27 INFO - 2015-11-17 07:40:27,334 DEBUG : BROWSER_OUTPUT: 07:43:30 INFO - 2015-11-17 07:43:30,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 07:43:31 INFO - 2015-11-17 07:43:31,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 368185344 07:43:31 INFO - 2015-11-17 07:43:31,060 DEBUG : BROWSER_OUTPUT: 07:46:33 INFO - 2015-11-17 07:46:33,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 07:46:33 INFO - 2015-11-17 07:46:33,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 338444288 07:46:33 INFO - 2015-11-17 07:46:33,996 DEBUG : BROWSER_OUTPUT: 07:49:36 INFO - 2015-11-17 07:49:36,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 07:49:36 INFO - 2015-11-17 07:49:36,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 325414912 07:49:36 INFO - 2015-11-17 07:49:36,825 DEBUG : BROWSER_OUTPUT: 07:52:40 INFO - 2015-11-17 07:52:40,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 07:52:40 INFO - 2015-11-17 07:52:40,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 328429568 07:52:40 INFO - 2015-11-17 07:52:40,756 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-11-17 07:55:43,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 07:55:43 INFO - 2015-11-17 07:55:43,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 388120576 07:55:43 INFO - 2015-11-17 07:55:43,988 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2463.027104293804;2519.672442582465;2530.835495692781;2531.4810463854906;2552.8468291902486;4082.3060079786433;4130.938035929464;4181.770002649853;4210.852620158295;4279.0799978004725;4238.639715624168;4238.8092535835885;4252.957470425295;4254.361845723143;4257.403963445113;4021;4078.0416602098485;4093.5087789465156;4110.938335924963;4113.465249517573;4093.2427500912277;4096.528899176588;4098.180363927211;4127.649149822269;4154.480689913761;4052.756834589934;4069.7965101744794;4099.241640296555;4106.815193316293;4108.897277568055;3857.787821669807;3930.724849260553;3955.545112312092;4004.3993400989793;4029.697772667047;3957.228340473609;3964.32606456903;3964.62336078075;3965.1474932889278;3987.3620220764537;4047.4738284023183;4179.059711564904;4218.557051509578;4232.809523571446;4238.618524332794;4363.672724545671;4368.08270263242;4465.486469056068;4493.03399769048;4495;4542.523035081302;4567.177907976563;4593.127305811919;4612.123696497655;4652.906941861178;4150.190712810973;4242.384854196124;4267.16790225903;4269.295566231537;4322.589354011396;4517.277235642281;4557.111363284128;4571.474280457724;4657.441107067174;4668.043051174501;4400.977995110068;4427.313766366218;4437.090396468716;4439.733615983051;4474.038081812426;4398.582134697199;4554.840580579664;4570.177368073779;4576.519465456079;4631.282151266559;4339.9783001085425;4417.558244175621;4482.260427029569;4499.662525310615;4509.12072145935;4479.955200447954;4517.525659805673;4528.298113792367;4542.477615074243;4560.270356742905;3377.155711072232;3418.8803391881165;3508.9298214035575;3557.48416479609;3594.227241143167;3161.6996385343355;3198.7760856739806;3204.1669166017004;3215.8552865121123;3247.7726559141106;4267.317229243306;4273.786310684453;4279.122779830127;4281.100968796588;4339.761313127745;4392.560743925582;4566.58900698932;4567.931481027787;4583.839565615188;4604.1252162089095;4241.787910604519;4252.255855225385;4265.019045619525;4321.978390108029;4360.978195109004;3997.2605068062503;4051.716379853441;4080.571539988318;4080.8571699990357;4141.668666506672;4494.842680506166;4731.243001119804;4744.027474367746;4779.3070004848405;4823.300621409946;4452.577005184502;4553.635709143195;4560.110778398181;4575.885602859955;4588.472325682455;4583.72497650142;4627.5603817637275;4656.464506581651;4683.578477937002;4697.506761789963;4481.305397663367;4483.327500874764;4545.4545454545405;4547.431571053618;4582.991741816795;4314.201872653569;4427.35803308512;4448.510663827041;4451.577100175478;4530.614897733598;4426.203283409017;4434.711743736647;4444.022315090675;4469.5530446955045;4516.796744146455;4425.933610995773;4433.82264709408;4470.173017991682;4503.211937910787;4512.616427603559;4201.537830838544;4298.075913678574;4313.97843010783;4401.66987475947;4434.490033646172;4219.493660760606;4329.913401731885;4448.733076015449;4455.643548516046;4466.531014243457;4313.913721725485;4318.35224716295;4332.6317263033;4334.28484300087;4407.7796110195 07:55:43 INFO - 2015-11-17 07:55:43,989 DEBUG : BROWSER_OUTPUT: |1;ext.html;447.69109314572944;452.1161129990868;454.6703639861099;464.98372556960516;476.8926991426932;25094.37264068397;25530.87234563827;25598;25775;25797.226083217487;26070.217893463177;26734.866325668343;26789.598156027674;32020.199495012635;32547.186320342003;7137.500374973741;7215.13418389794;7235.059442272497;7251.673674684652;7272.345488905998;7155.928440715605;7175.856482870339;7198.244184360646;7269.3094156055095;7289.307515785992;6650.900236496456;6843.486738494633;6860.725570977155;6905.447564194852;6921.515493915428;6588.407043366096;8808.86786698197;9020.413673111292;9035.819283614357;9051.683191088281;8527.422426851052;8701.912980870173;8706.564671766386;8776;8777;26445.206643800524;26936.32659183536;30549.541756873663;30934.690653093632;31253.687463125534;1969.6060787842346;2064.0092755477453;2281.7376001759844;2358.103920510195;2392.1268736911074;21778.698549784152;21862.344129676134;21890.12439502418;21919.67120493194;22138.667919981213;1839.2036069818344;1850.4171186076478;1881.388548721671;1881.5014021284371;1927.6241132979076;214871;216244;217007;218877;219708.9999999984;43218.7839060809;43364.78317608455;43388;45184.61115416357;45509;45607.543924560996;46193.76903115463;46238.30642540364;46465.7676711621;46683.29975050377;10354.844677329846;10360.119389851796;10392.740181495372;10397.48012599367;10460.110890574386;7648.80877978055;7717.922820771721;7749.070111586646;7754.302112809874;7831.490953088031;14749;14860;14962.476313328982;15031.549053528412;15264.465743698916;6633.2371777246235;6886.724531018804;6922.203946546111;6989.930100698928;7021.473389495808;732.1214542548962;769.3422124083828;794.4518282385136;800.3757069485811;851.2041241439274;22635.773642263368;22822;22997.19509817182;23059;23083.307500775005;798.8042929482314;803.7267329108131;876.0976194519654;908.246155690775;931.7344556801279;10895.673129806119;11105.72235694098;11107.278026928223;11166.385848778233;11247.718807029725;252545;257976;262004;262298;263126;38584.22831543353;38684.226315473534;38706.61293387086;39261.411078833844;39316.41025384622;1069.214127616186;1085.2782899371987;1089.340948726025;1091.8198497248025;1094.813881640139;17866.374676886247;21671.45821354479;23202.76797232006;23686.907314926684;23734.169304074276;37873.24253514969;37926.43110353402;38138.42792358172;38518.614813851505;38620.6137938617;188679;190986;193056;217304;221851;23861.403464913517;24314.87842560776;24361;24375.51248975046;24674.259772206864;29621.407571848875;29904.70095299019;30126.69873301239;30238.54642180413;30280.242993925327;25823.741762582886;27365;28175.933015781044;30057.248568785955;30207.244818879703;26368;27164.728352716218;27232.319192020357;27256.863715681295;27710.72289277162;25684.101056462932;26355.472890542464;26461.470770584096;26699;26863.597046043935;22990.655140173247;23887.761122388554;24262;24702.382440439134;24804.50390992134;18945.621087577896;19048.80951190526;19049.809501904805;19126.713099303244;19172.90413547923 07:55:43 INFO - 2015-11-17 07:55:43,994 DEBUG : BROWSER_OUTPUT: |2;jquery.html;262.72413965336415;267.154456146297;267.1877492423034;274.5922305376516;277.9527480328345;13543.864561354396;14015.789763153549;14123.929380353109;14307.928460357696;15222.08667479952;14351.92824035881;14416.062955907884;14497.63755906103;14814.333354999024;14909.95630305879;3749.9437508437395;4242.15156968606;4389.297712366022;4422.668299877506;4437.046035102452;3868.400397938324;3888.572257051722;3889.124946886942;3906.140649057203;3952.980235098835;2696.164189101375;2746.958795618067;3712.0719820044988;3851.306764782338;3854.2484215577974;3792.127810603549;3829.463875057494;3840.788756618385;3848.749831260959;3898.8830335089992;3244.5295432162206;3250.463673493871;3250.5774249347432;3265.4775235962134;3312.668733126668;8902.421342612774;9127.726168214964;9136.543172841331;9979.600815967426;10376.896231037668;1438.7194497073076;1499.152978567117;1557.0443055313472;1597.8322276161068;1669.0569828047237;7390.778276651709;7614.124375696811;7626.656800443938;7644.617769111522;7697.9230207697765;1159.8840115988419;1177.2583272538332;1185.2888267039793;1188.085174415695;1234.111439763369;45178;46622.300665490046;46927.99999999966;46958.06083878338;47125.764371178266;4989.376327959005;5058.291839142523;5144.6655967362;5173;5193.039287731782;5877.265341832271;5879.235699359056;5899.085641725539;5911.467967882825;5962.642241465526;3954.703397245218;4035.6973227008093;4040.3333449980423;4073.024583077205;4083.4283200351974;3958.7426817256787;3973.5827738087664;4107.54816970133;4134.896627584334;4148.336266197394;2272.511410046815;2294.1855641247453;2304.4814916643622;2310.145246258895;2315.247544547995;805.4482679364654;805.6817557065044;808.4058217210346;809.4940662086196;855.7389996051139;262.76876348813306;303.13152817179065;320.6520924796622;325.2048740828651;331.8622771549828;8500.44747091437;8728.956355218183;8821.294296456397;8981.550922453851;9295.930967938639;357.06627169950394;360.2830367568572;368.557730723128;376.1423953386284;384.60001598337413;4862.5380588844;5023.974880125576;5124.897502050013;5144.636671282114;5254.264402983586;455963;466977;471685.6583879712;477921;490090;53666.7316663422;57543.42456575464;57919;58287.125693114634;60176.39823601796;365.11459710203184;366.42288395776757;367.54975155434914;368.799004542525;379.45737595238523;7518.947347371263;8262.586870656563;8407;8734.30125589964;8918.73243802687;27084.593731093657;27615;28133.43733125367;28323.716762832933;28428.28929276702;38747.59873263047;38862.41706374463;39247.21505569816;39333.08336457943;40236.798816005736;4816.036792641556;4977.203647416396;4992.975035124801;5007.47421520735;5019.347484827095;9136;9150.679726209552;9399.201067909304;9408.670696525589;9482.573284202366;8018.799530011796;8058.556779377191;8239.134890836616;8255.9680039995;8296.211859873303;7881.448298619041;7907.695230286939;8011.118776934416;8042.075161356519;8111.797205069921;8076.596170191349;8283.710070147516;8325.500469971821;8422.115677853737;8574.31405487572;4946.727929963743;4955.5044495550155;4962.057209130254;4970.229614409773;4977.8257760978195;8068.556229407439;8168.3465322772845;8219.342452603896;8321.375896807642;8352.832943340978 07:55:43 INFO - 2015-11-17 07:55:43,995 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1009.3086235928386;1027.7636143686955;1031.3811712972213;1280.9103362764604;1338.9732205355892;5507.118860982244;5700.201971723956;5869.559783016275;5920.792772252972;5950.137230101633;5903.970480147604;5978.4918281945975;6018.277806663206;6028;6131.478824299928;1791.077595038553;1809.5114319133827;1815.5007372972473;1832.3128826689992;1833.065136780245;1803.3057272949877;1820.9544761381005;1834.1012903677235;1836.9081545922718;1838.2279442634126;1777.6000399910047;1785.482210159059;1786.0623172834237;1790.4539115569746;1790.498660375097;1743.5118166913285;1764.1972902329474;1796.2635319518934;1799.1993562864595;1799.7750281214849;1784.5984653453;1815.9182836772245;1834.5597056706429;1843.824836640517;1857.0621835972881;5348.893022139574;5925.377835327272;5937.851553711149;5968.7910923117915;6087.4521293083835;3427.7771944823758;3502.3345564342694;3683.8710645127558;3771.9245615087543;3804.068003339172;2201.900914458853;2214.9889250553642;2232.966505502419;2238.8432809703327;2246.1127854497545;690.0339524665459;702.1644243350397;714.5319815520842;715.0846915947595;724.8836791341328;7781.3385862201785;7831.216878312181;7848.68605255789;7881.724139655084;7947.483413578099;3434.9484757728655;3518.138056176253;3529.6470352964498;3561.3411518869093;3591.299696559146;6969.58182509051;6976.7558135465015;6978.581285122909;6993.4055605274125;7092.007119003344;3908.3746600544346;3913.6673382762215;3916.373380259145;3928.508936382952;3950.229705207457;3528.1708798432346;3539.7168226541817;3560.2701446203464;3565.6612621800887;3587.9641203588153;2777.5694767311097;2806.873690683924;2816.1551534539967;2837.4750671125494;2857.7142285771674;906.4968942237122;907.5144797533288;911.7902882337099;924.3206243411088;925.0518218825757;1024.3700124423426;1026.9794604107876;1038.6053299746047;1054.7890421915647;1071.8552995345685;5615.129654903497;5658.773649054074;5669.546436285087;5671.432856714296;5687.431256874363;375.1746158451418;381.4316668164415;383.762067518135;392.1607759394897;394.1407731146129;4439.067795762861;4522.909541809146;4522.977385113119;4548.158590660738;4559.749213793207;6504.869902601921;6678.465722742169;6770.4922130839395;6775.322467753185;6898.103246577913;6919.34266244716;6923.757668481579;6982.092327997328;7010.929890701028;7088.681009354488;5561.138023606348;5622.971885140548;5645.661260324394;5738.77044918207;5742.712864356766;5436.891262174655;5469.917951230815;5482.698451585042;5495.560355171497;5566.415526369835;6096.603720758137;6175.351588083367;6190.876182476415;6211.689415529296;6298.212723409574;6317.494600432046;6453.967365221542;6463.15978922737;6470.870582588228;6508.479321654351;5283.260343551982;5297;5312.043832110257;5344.144936810092;5367.463253674758;5746.31044274673;5806.65160090396;5809.128630705259;5821.27234095738;5907.17299578068;5305.734713264244;5383.81156659515;5449.128139497661;5519.806806761744;5528.530074943675;5330.387005494418;5362.70505122222;5397.730113494231;5397.86505337354;5461.071617825059;5159.09715799726;5362.088444964287;5427.1316589345515;5448.073827449422;5503.559715222853;4898.902021959612;4970.776315065903;4979.3277907482025;5012.724300163526;5017.54842064216;5020.824271150492;5044.798208071783;5072.34059572268;5078.4159821619505;5122.1804511278015 07:55:43 INFO - 2015-11-17 07:55:43,998 DEBUG : BROWSER_OUTPUT: |4;prototype.html;236.47974456196366;243.03878161869807;244.3305343359195;250.7667868881939;263.1355995554604;4824.517548245174;4911.336969509115;4965.478624744404;5043.7982480700775;5046.293518907356;4800.807967681298;4884.438289596697;4922.975385123078;4969.229769385751;4993.950060499394;3816.9045773855596;3851.61483851614;3869.5550011748587;3889.533256009269;3934.4885164928664;3681.815909204529;3796.297684928283;3815.084379748868;3852.383618621021;3882.611738826123;3750.906227344311;3846.2499812536566;3863.652271295583;3864.381698928172;3921.392184211452;3808.219315040424;3856.6914646828186;3869.6323849234277;3878.5151856017997;3884.3008258513455;3340.0146956647845;3344.1806757344607;3355.2953879685297;3382.847771850248;3395.1851555626718;4802.447718512381;4808.711477311337;4811.975940120312;4858.125537403266;4889.997550502138;4228.386883901817;4238.321868501056;4281.422008028939;4314.1371725655;4380.3210502372185;5190.870228244286;5198.480151984809;5228.764705588258;5229.2417599448245;5264.9736751315995;3333.8999830005137;3485.0590340608146;3557.4130268505664;3581.659742324501;3623.61951995042;5297.073012222845;5326.733663316857;5463.7814487420455;5464.480874316933;5572.693501857356;3601.603823579404;3624.7462677612843;3628.1111127773866;3629.6370362963494;3635.345637785224;3674.191677830873;3689.520362352877;3718.665320121202;3736.23407201523;3757.380032294641;4281.272183728774;4286.057067445157;4288.957110428918;4312.978435107804;4351.26028575143;5014.768428049556;5167.819126330561;5178.145605974972;5181.067407866545;5226.869328266824;1296.3906963727034;1305.7714899892671;1306.817045613615;1309.6398490415022;1310.60026691858;829.867221244598;843.6583183810567;852.748439210422;855.2003876375609;858.3176374782063;4959.677620954626;4966.553010229024;4979.0788704089855;5003.374578177728;5095.286659867622;5426.077566813651;5440.483154100354;5448.83653490396;5461.15352120422;5483.259759932438;4812.927806082912;4987.703197168762;5007.849764506997;5011.173156429149;5019.498050194951;2846.8576571171357;2877.093715479617;2917.212352664769;2920.007197552842;2932.076395935316;5510.228568000483;5522.972385138129;5539.944600554023;5578.665280083208;5588.189712491666;5529.225908372831;5548.195511650788;5559.138333558305;5569;5633.014222511126;5521.696306703089;5531.612787104945;5532.5020748132865;5568.331800184003;5601.047821870292;5179.430262671179;5381.704006279692;5385.1922211667;5450.863728406822;5470.972645136908;5280.155175171954;5284.04887120322;5295.655782374133;5325.893482130258;5356.758945847524;5328.813491527778;5356.946430535645;5500.3949565548555;5523.944760552504;5528.612997090165;3632.2917031178667;3661.450782382664;3668.394714872123;3673.3571624966057;3685.1708365617524;5405.78376864921;5423.322084739408;5429.158480435539;5432.6468779529205;5482.616216864782;5114.974425127851;5250.133727934848;5258.684478931276;5268;5337.252784610236;5255.842324730264;5256.553192978639;5258.763355648928;5258.8948221036135;5262.605304602247;5125.1799712045895;5126.923096153635;5159.019786240602;5165.922511162411;5230.450802665665;5250.159974404077;5265.315508983807;5300.575953923754;5310.389305229948;5345.064613692511;5000.874978125576;5161.638685291993;5164.431912489698;5175.301334319819;5212.713300768494 07:55:44 INFO - 2015-11-17 07:55:44,000 DEBUG : BROWSER_OUTPUT: |5;yui.html;473.1625023708036;477.08399872245286;494.7427337784352;506.3442841520231;521.2389910730336;10162.187025037998;10284.845727314096;10398.22013348998;10419.843702344451;10538;10041.196704263659;10200.336978096437;10205.795884082314;10274;10321.225908056907;699.4998576018133;709.5671640299413;709.9006139140498;711.8896571031498;712.3517598984898;705.4638474759195;713.0552018575382;713.8786406310913;715.7852644206744;717.1107826295408;728.2680905689774;736.4513437489052;741.2994719989612;743.5835931878139;745.6197339356913;726.23019599225;727.6180005497104;733.2594079979233;735.5954225176132;737.7860420478055;544.9509544141047;546.2952790899734;546.5736725354191;551.9034169020406;551.9448055194489;9864.457454839981;10062.597496100147;10064.597416103346;10081.344712593658;10105.090541851268;7537;7831.686732530692;8030.678772849079;8168.305694016016;8289.295409890166;6539.673016349164;6646.534742568022;6767.512770759941;7051.435885129177;7322.597257150855;2344.5662552427857;2507.8746062696973;2588.417606038645;2668.4262883480146;2739.2193224930998;33083.3383332332;33309;35340.646593533995;35516.64483355159;36382.454263186075;5267.473252674702;5367.2485851980755;5439.075357189287;5592.832215033555;5641.887162256732;9631.9036809631;9693.563789629483;9717.416954982724;9743.171830394354;9793.510324483746;4897.3878265216845;4990.426100998359;4994.80020799164;5128.743562821844;5211.765470553834;2926.341573146025;2988.088632966966;3022.894198703035;3065.0498345512515;3191.952120718191;2022.8988550572412;2033.0952726036771;2034.104993802722;2059.7631272403864;2075.107703687429;313.89641418331894;316.68015304542575;317.78549479101514;319.1574243995853;323.0566745104301;420.59202573503654;420.59412666776706;444.44444444444446;470.1850855697007;501.85195367366714;6097.2683278006925;6492.253390860112;6567.310432404529;6607.174103237096;6731.865362692816;375.3824957944221;391.3640334456508;455.0920912778961;479.1208133075845;491.59197865771324;2775.708550602198;2852.7289907458758;2862.470442968016;2938.882444702188;2952.867120979561;43923;44445.777771111585;44448.55551444509;44909;45010;37083.629163708014;38143.427848582294;38417.42373864394;38761;39305.213895722496;32991.50512742311;36362.45456318157;36781.26437471289;37327.813360933564;37994.62005379966;6203.379662033761;6459.128017717548;6601.669916504252;6661.533692641468;6666.600003999775;28149.296267592654;28209.858950705115;28284.85857570699;28431.147065588066;28508.85745571259;33240.1689957753;34415;35624.46563301501;35794.82102589471;36419.81790091139;8361;8450.47891379533;8562.400631955952;8742.431741936754;9097.999220085918;8919.955400222958;8965.551722413722;9022.548872556477;9023.593938272663;9268.768280793034;8252.711155109542;8504.319654427507;8532.530710810717;8554.059053503985;8642.481451112953;8570;8604.10399976176;8670.869936950825;8686.739397818075;8737.475751454933;7927.563983980936;8263.876041859257;8369.623366948625;8576.31389488827;8939.240164585823;6365.777197798055;6516.57642253252;6538.248101468202;6879.621620810904;7130.679119439534;6163.229596300463;6564.934350656432;6791.3548212919695;6932.549384290005;7283.380912622486 07:55:44 INFO - 2015-11-17 07:55:44,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:44 INFO - 2015-11-17 07:55:44,002 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:55:44 INFO - 2015-11-17 07:55:44,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1345 07:55:44 INFO - 2015-11-17 07:55:44,002 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:55:44 INFO - 2015-11-17 07:55:44,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1447775743983__endTimestamp 07:55:44 INFO - 2015-11-17 07:55:44,002 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:44 INFO - 2015-11-17 07:55:44,003 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:55:44 INFO - 2015-11-17 07:55:44,003 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,003 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4239.76 Median:4334.28 stddev:439.52 (10.1%) stddev-sans-first:418.18 07:55:44 INFO - 2015-11-17 07:55:44,004 DEBUG : BROWSER_OUTPUT: Values: 2463.0 2519.7 2530.8 2531.5 2552.8 4082.3 4130.9 4181.8 4210.9 4279.1 4238.6 4238.8 4253.0 4254.4 4257.4 4021.0 4078.0 4093.5 4110.9 4113.5 4093.2 4096.5 4098.2 4127.6 4154.5 4052.8 4069.8 4099.2 4106.8 4108.9 3857.8 3930.7 3955.5 4004.4 4029.7 3957.2 3964.3 3964.6 3965.1 3987.4 4047.5 4179.1 4218.6 4232.8 4238.6 4363.7 4368.1 4465.5 4493.0 4495.0 4542.5 4567.2 4593.1 4612.1 4652.9 4150.2 4242.4 4267.2 4269.3 4322.6 4517.3 4557.1 4571.5 4657.4 4668.0 4401.0 4427.3 4437.1 4439.7 4474.0 4398.6 4554.8 4570.2 4576.5 4631.3 4340.0 4417.6 4482.3 4499.7 4509.1 4480.0 4517.5 4528.3 4542.5 4560.3 3377.2 3418.9 3508.9 3557.5 3594.2 3161.7 3198.8 3204.2 3215.9 3247.8 4267.3 4273.8 4279.1 4281.1 4339.8 4392.6 4566.6 4567.9 4583.8 4604.1 4241.8 4252.3 4265.0 4322.0 4361.0 3997.3 4051.7 4080.6 4080.9 4141.7 4494.8 4731.2 4744.0 4779.3 4823.3 4452.6 4553.6 4560.1 4575.9 4588.5 4583.7 4627.6 4656.5 4683.6 4697.5 4481.3 4483.3 4545.5 4547.4 4583.0 4314.2 4427.4 4448.5 4451.6 4530.6 4426.2 4434.7 4444.0 4469.6 4516.8 4425.9 4433.8 4470.2 4503.2 4512.6 4201.5 4298.1 4314.0 4401.7 4434.5 4219.5 4329.9 4448.7 4455.6 4466.5 4313.9 4318.4 4332.6 4334.3 4407.8 07:55:44 INFO - 2015-11-17 07:55:44,004 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,004 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:35377.46 Median:26899.96 stddev:59609.06 (221.6%) stddev-sans-first:59718.58 07:55:44 INFO - 2015-11-17 07:55:44,006 DEBUG : BROWSER_OUTPUT: Values: 447.7 452.1 454.7 465.0 476.9 25094.4 25530.9 25598.0 25775.0 25797.2 26070.2 26734.9 26789.6 32020.2 32547.2 7137.5 7215.1 7235.1 7251.7 7272.3 7155.9 7175.9 7198.2 7269.3 7289.3 6650.9 6843.5 6860.7 6905.4 6921.5 6588.4 8808.9 9020.4 9035.8 9051.7 8527.4 8701.9 8706.6 8776.0 8777.0 26445.2 26936.3 30549.5 30934.7 31253.7 1969.6 2064.0 2281.7 2358.1 2392.1 21778.7 21862.3 21890.1 21919.7 22138.7 1839.2 1850.4 1881.4 1881.5 1927.6 214871.0 216244.0 217007.0 218877.0 219709.0 43218.8 43364.8 43388.0 45184.6 45509.0 45607.5 46193.8 46238.3 46465.8 46683.3 10354.8 10360.1 10392.7 10397.5 10460.1 7648.8 7717.9 7749.1 7754.3 7831.5 14749.0 14860.0 14962.5 15031.5 15264.5 6633.2 6886.7 6922.2 6989.9 7021.5 732.1 769.3 794.5 800.4 851.2 22635.8 22822.0 22997.2 23059.0 23083.3 798.8 803.7 876.1 908.2 931.7 10895.7 11105.7 11107.3 11166.4 11247.7 252545.0 257976.0 262004.0 262298.0 263126.0 38584.2 38684.2 38706.6 39261.4 39316.4 1069.2 1085.3 1089.3 1091.8 1094.8 17866.4 21671.5 23202.8 23686.9 23734.2 37873.2 37926.4 38138.4 38518.6 38620.6 188679.0 190986.0 193056.0 217304.0 221851.0 23861.4 24314.9 24361.0 24375.5 24674.3 29621.4 29904.7 30126.7 30238.5 30280.2 25823.7 27365.0 28175.9 30057.2 30207.2 26368.0 27164.7 27232.3 27256.9 27710.7 25684.1 26355.5 26461.5 26699.0 26863.6 22990.7 23887.8 24262.0 24702.4 24804.5 18945.6 19048.8 19049.8 19126.7 19172.9 07:55:44 INFO - 2015-11-17 07:55:44,006 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,006 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22471.04 Median:24807.52 stddev:77379.43 (311.9%) stddev-sans-first:77578.53 07:55:44 INFO - 2015-11-17 07:55:44,007 DEBUG : BROWSER_OUTPUT: Values: 262.7 267.2 267.2 274.6 278.0 13543.9 14015.8 14123.9 14307.9 15222.1 14351.9 14416.1 14497.6 14814.3 14910.0 3749.9 4242.2 4389.3 4422.7 4437.0 3868.4 3888.6 3889.1 3906.1 3953.0 2696.2 2747.0 3712.1 3851.3 3854.2 3792.1 3829.5 3840.8 3848.7 3898.9 3244.5 3250.5 3250.6 3265.5 3312.7 8902.4 9127.7 9136.5 9979.6 10376.9 1438.7 1499.2 1557.0 1597.8 1669.1 7390.8 7614.1 7626.7 7644.6 7697.9 1159.9 1177.3 1185.3 1188.1 1234.1 45178.0 46622.3 46928.0 46958.1 47125.8 4989.4 5058.3 5144.7 5173.0 5193.0 5877.3 5879.2 5899.1 5911.5 5962.6 3954.7 4035.7 4040.3 4073.0 4083.4 3958.7 3973.6 4107.5 4134.9 4148.3 2272.5 2294.2 2304.5 2310.1 2315.2 805.4 805.7 808.4 809.5 855.7 262.8 303.1 320.7 325.2 331.9 8500.4 8729.0 8821.3 8981.6 9295.9 357.1 360.3 368.6 376.1 384.6 4862.5 5024.0 5124.9 5144.6 5254.3 455963.0 466977.0 471685.7 477921.0 490090.0 53666.7 57543.4 57919.0 58287.1 60176.4 365.1 366.4 367.5 368.8 379.5 7518.9 8262.6 8407.0 8734.3 8918.7 27084.6 27615.0 28133.4 28323.7 28428.3 38747.6 38862.4 39247.2 39333.1 40236.8 4816.0 4977.2 4993.0 5007.5 5019.3 9136.0 9150.7 9399.2 9408.7 9482.6 8018.8 8058.6 8239.1 8256.0 8296.2 7881.4 7907.7 8011.1 8042.1 8111.8 8076.6 8283.7 8325.5 8422.1 8574.3 4946.7 4955.5 4962.1 4970.2 4977.8 8068.6 8168.3 8219.3 8321.4 8352.8 07:55:44 INFO - 2015-11-17 07:55:44,007 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,007 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4180.64 Median:5337.27 stddev:2122.57 (39.8%) stddev-sans-first:2115.14 07:55:44 INFO - 2015-11-17 07:55:44,009 DEBUG : BROWSER_OUTPUT: Values: 1009.3 1027.8 1031.4 1280.9 1339.0 5507.1 5700.2 5869.6 5920.8 5950.1 5904.0 5978.5 6018.3 6028.0 6131.5 1791.1 1809.5 1815.5 1832.3 1833.1 1803.3 1821.0 1834.1 1836.9 1838.2 1777.6 1785.5 1786.1 1790.5 1790.5 1743.5 1764.2 1796.3 1799.2 1799.8 1784.6 1815.9 1834.6 1843.8 1857.1 5348.9 5925.4 5937.9 5968.8 6087.5 3427.8 3502.3 3683.9 3771.9 3804.1 2201.9 2215.0 2233.0 2238.8 2246.1 690.0 702.2 714.5 715.1 724.9 7781.3 7831.2 7848.7 7881.7 7947.5 3434.9 3518.1 3529.6 3561.3 3591.3 6969.6 6976.8 6978.6 6993.4 7092.0 3908.4 3913.7 3916.4 3928.5 3950.2 3528.2 3539.7 3560.3 3565.7 3588.0 2777.6 2806.9 2816.2 2837.5 2857.7 906.5 907.5 911.8 924.3 925.1 1024.4 1027.0 1038.6 1054.8 1071.9 5615.1 5658.8 5669.5 5671.4 5687.4 375.2 381.4 383.8 392.2 394.1 4439.1 4522.9 4523.0 4548.2 4559.7 6504.9 6678.5 6770.5 6775.3 6898.1 6919.3 6923.8 6982.1 7010.9 7088.7 5561.1 5623.0 5645.7 5738.8 5742.7 5436.9 5469.9 5482.7 5495.6 5566.4 6096.6 6175.4 6190.9 6211.7 6298.2 6317.5 6454.0 6463.2 6470.9 6508.5 5283.3 5297.0 5312.0 5344.1 5367.5 5746.3 5806.7 5809.1 5821.3 5907.2 5305.7 5383.8 5449.1 5519.8 5528.5 5330.4 5362.7 5397.7 5397.9 5461.1 5159.1 5362.1 5427.1 5448.1 5503.6 4898.9 4970.8 4979.3 5012.7 5017.5 5020.8 5044.8 5072.3 5078.4 5122.2 07:55:44 INFO - 2015-11-17 07:55:44,009 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,009 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4372.93 Median:5009.51 stddev:1322.99 (26.4%) stddev-sans-first:1289.76 07:55:44 INFO - 2015-11-17 07:55:44,010 DEBUG : BROWSER_OUTPUT: Values: 236.5 243.0 244.3 250.8 263.1 4824.5 4911.3 4965.5 5043.8 5046.3 4800.8 4884.4 4923.0 4969.2 4994.0 3816.9 3851.6 3869.6 3889.5 3934.5 3681.8 3796.3 3815.1 3852.4 3882.6 3750.9 3846.2 3863.7 3864.4 3921.4 3808.2 3856.7 3869.6 3878.5 3884.3 3340.0 3344.2 3355.3 3382.8 3395.2 4802.4 4808.7 4812.0 4858.1 4890.0 4228.4 4238.3 4281.4 4314.1 4380.3 5190.9 5198.5 5228.8 5229.2 5265.0 3333.9 3485.1 3557.4 3581.7 3623.6 5297.1 5326.7 5463.8 5464.5 5572.7 3601.6 3624.7 3628.1 3629.6 3635.3 3674.2 3689.5 3718.7 3736.2 3757.4 4281.3 4286.1 4289.0 4313.0 4351.3 5014.8 5167.8 5178.1 5181.1 5226.9 1296.4 1305.8 1306.8 1309.6 1310.6 829.9 843.7 852.7 855.2 858.3 4959.7 4966.6 4979.1 5003.4 5095.3 5426.1 5440.5 5448.8 5461.2 5483.3 4812.9 4987.7 5007.8 5011.2 5019.5 2846.9 2877.1 2917.2 2920.0 2932.1 5510.2 5523.0 5539.9 5578.7 5588.2 5529.2 5548.2 5559.1 5569.0 5633.0 5521.7 5531.6 5532.5 5568.3 5601.0 5179.4 5381.7 5385.2 5450.9 5471.0 5280.2 5284.0 5295.7 5325.9 5356.8 5328.8 5356.9 5500.4 5523.9 5528.6 3632.3 3661.5 3668.4 3673.4 3685.2 5405.8 5423.3 5429.2 5432.6 5482.6 5115.0 5250.1 5258.7 5268.0 5337.3 5255.8 5256.6 5258.8 5258.9 5262.6 5125.2 5126.9 5159.0 5165.9 5230.5 5250.2 5265.3 5300.6 5310.4 5345.1 5000.9 5161.6 5164.4 5175.3 5212.7 07:55:44 INFO - 2015-11-17 07:55:44,010 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,011 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10232.25 Median:5403.16 stddev:12285.03 (227.4%) stddev-sans-first:12297.63 07:55:44 INFO - 2015-11-17 07:55:44,012 DEBUG : BROWSER_OUTPUT: Values: 473.2 477.1 494.7 506.3 521.2 10162.2 10284.8 10398.2 10419.8 10538.0 10041.2 10200.3 10205.8 10274.0 10321.2 699.5 709.6 709.9 711.9 712.4 705.5 713.1 713.9 715.8 717.1 728.3 736.5 741.3 743.6 745.6 726.2 727.6 733.3 735.6 737.8 545.0 546.3 546.6 551.9 551.9 9864.5 10062.6 10064.6 10081.3 10105.1 7537.0 7831.7 8030.7 8168.3 8289.3 6539.7 6646.5 6767.5 7051.4 7322.6 2344.6 2507.9 2588.4 2668.4 2739.2 33083.3 33309.0 35340.6 35516.6 36382.5 5267.5 5367.2 5439.1 5592.8 5641.9 9631.9 9693.6 9717.4 9743.2 9793.5 4897.4 4990.4 4994.8 5128.7 5211.8 2926.3 2988.1 3022.9 3065.0 3192.0 2022.9 2033.1 2034.1 2059.8 2075.1 313.9 316.7 317.8 319.2 323.1 420.6 420.6 444.4 470.2 501.9 6097.3 6492.3 6567.3 6607.2 6731.9 375.4 391.4 455.1 479.1 491.6 2775.7 2852.7 2862.5 2938.9 2952.9 43923.0 44445.8 44448.6 44909.0 45010.0 37083.6 38143.4 38417.4 38761.0 39305.2 32991.5 36362.5 36781.3 37327.8 37994.6 6203.4 6459.1 6601.7 6661.5 6666.6 28149.3 28209.9 28284.9 28431.1 28508.9 33240.2 34415.0 35624.5 35794.8 36419.8 8361.0 8450.5 8562.4 8742.4 9098.0 8920.0 8965.6 9022.5 9023.6 9268.8 8252.7 8504.3 8532.5 8554.1 8642.5 8570.0 8604.1 8670.9 8686.7 8737.5 7927.6 8263.9 8369.6 8576.3 8939.2 6365.8 6516.6 6538.2 6879.6 7130.7 6163.2 6564.9 6791.4 6932.5 7283.4 07:55:44 INFO - 2015-11-17 07:55:44,012 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:44 INFO - 2015-11-17 07:55:44,012 DEBUG : BROWSER_OUTPUT: 07:55:44 INFO - 2015-11-17 07:55:44,722 INFO : Browser exited with error code: 0 07:55:44 INFO - 2015-11-17 07:55:44,756 INFO : Completed test dromaeo_css (00:18:38) 07:55:44 INFO - 2015-11-17 07:55:44,756 INFO : Starting test kraken 07:55:44 INFO - 2015-11-17 07:55:44,756 DEBUG : operating with platform_type : mac_ 07:55:44 INFO - 2015-11-17 07:55:44,756 INFO : Initialising browser for kraken test... 07:55:44 INFO - 2015-11-17 07:55:44,771 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpqCAxic/profile http://localhost:49268/getInfo.html 07:55:47 INFO - 2015-11-17 07:55:47,404 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:55:47 INFO - 2015-11-17 07:55:47,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:55:47 INFO - 2015-11-17 07:55:47,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:55:47 INFO - 2015-11-17 07:55:47,405 DEBUG : BROWSER_OUTPUT: __metrics 07:55:47 INFO - 2015-11-17 07:55:47,425 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:55:48 INFO - 2015-11-17 07:55:48,226 INFO : Browser initialized. 07:55:48 INFO - 2015-11-17 07:55:48,227 INFO : Running cycle 1/1 for kraken test... 07:55:48 INFO - 2015-11-17 07:55:48,227 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpqCAxic/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:56:00 INFO - 2015-11-17 07:56:00,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 228884480 07:56:00 INFO - 2015-11-17 07:56:00,470 DEBUG : BROWSER_OUTPUT: 07:56:03 INFO - 2015-11-17 07:56:03,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:04 INFO - 2015-11-17 07:56:04,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 286642176 07:56:04 INFO - 2015-11-17 07:56:04,136 DEBUG : BROWSER_OUTPUT: 07:56:07 INFO - 2015-11-17 07:56:07,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 07:56:07 INFO - 2015-11-17 07:56:07,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 299085824 07:56:07 INFO - 2015-11-17 07:56:07,898 DEBUG : BROWSER_OUTPUT: 07:56:11 INFO - 2015-11-17 07:56:11,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 07:56:11 INFO - 2015-11-17 07:56:11,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 281923584 07:56:11 INFO - 2015-11-17 07:56:11,979 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-11-17 07:56:14,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 07:56:14 INFO - 2015-11-17 07:56:14,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 285704192 07:56:14 INFO - 2015-11-17 07:56:14,945 DEBUG : BROWSER_OUTPUT: 07:56:17 INFO - 2015-11-17 07:56:17,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:18 INFO - 2015-11-17 07:56:18,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 284704768 07:56:18 INFO - 2015-11-17 07:56:18,102 DEBUG : BROWSER_OUTPUT: 07:56:21 INFO - 2015-11-17 07:56:21,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:22 INFO - 2015-11-17 07:56:22,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 280289280 07:56:22 INFO - 2015-11-17 07:56:22,373 DEBUG : BROWSER_OUTPUT: 07:56:26 INFO - 2015-11-17 07:56:26,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:26 INFO - 2015-11-17 07:56:26,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 281374720 07:56:26 INFO - 2015-11-17 07:56:26,794 DEBUG : BROWSER_OUTPUT: 07:56:30 INFO - 2015-11-17 07:56:30,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 07:56:30 INFO - 2015-11-17 07:56:30,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 281530368 07:56:30 INFO - 2015-11-17 07:56:30,788 DEBUG : BROWSER_OUTPUT: 07:56:32 INFO - 2015-11-17 07:56:32,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:33 INFO - 2015-11-17 07:56:33,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 319569920 07:56:33 INFO - 2015-11-17 07:56:33,168 DEBUG : BROWSER_OUTPUT: 07:56:35 INFO - 2015-11-17 07:56:35,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:35 INFO - 2015-11-17 07:56:35,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 318717952 07:56:35 INFO - 2015-11-17 07:56:35,921 DEBUG : BROWSER_OUTPUT: 07:56:38 INFO - 2015-11-17 07:56:38,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:39 INFO - 2015-11-17 07:56:39,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 323104768 07:56:39 INFO - 2015-11-17 07:56:39,045 DEBUG : BROWSER_OUTPUT: 07:56:42 INFO - 2015-11-17 07:56:42,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:42 INFO - 2015-11-17 07:56:42,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 325402624 07:56:42 INFO - 2015-11-17 07:56:42,722 DEBUG : BROWSER_OUTPUT: 07:56:45 INFO - 2015-11-17 07:56:45,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:46 INFO - 2015-11-17 07:56:46,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 318156800 07:56:46 INFO - 2015-11-17 07:56:46,458 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 07:56:48 INFO - 2015-11-17 07:56:48,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 381087744 07:56:48 INFO - 2015-11-17 07:56:48,709 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,709 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:56:48 INFO - 2015-11-17 07:56:48,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:56:48 INFO - 2015-11-17 07:56:48,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:56:48 INFO - 2015-11-17 07:56:48,710 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:56:48 INFO - 2015-11-17 07:56:48,710 DEBUG : BROWSER_OUTPUT: |0;ai-astar;131;135;133;139;139;133;119;138;141;126 07:56:48 INFO - 2015-11-17 07:56:48,710 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;192;166;194;208;163;191;177;158;206;163 07:56:48 INFO - 2015-11-17 07:56:48,710 DEBUG : BROWSER_OUTPUT: |2;audio-dft;202;205;202;195;203;207;201;197;199;203 07:56:48 INFO - 2015-11-17 07:56:48,710 DEBUG : BROWSER_OUTPUT: |3;audio-fft;94;93;106;155;85;88;90;88;141;88 07:56:48 INFO - 2015-11-17 07:56:48,711 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;122;123;172;115;114;118;156;109;107;153 07:56:48 INFO - 2015-11-17 07:56:48,711 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;145;155;155;147;141;153;149;148;143 07:56:48 INFO - 2015-11-17 07:56:48,711 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;162;163;163;163;155;162;163;159;154 07:56:48 INFO - 2015-11-17 07:56:48,711 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;130;120;130;120;130;120;115;132;130 07:56:48 INFO - 2015-11-17 07:56:48,712 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;72;75;74;77;77;76;76;76;76 07:56:48 INFO - 2015-11-17 07:56:48,712 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;81;87;88;89;89;84;85;85 07:56:48 INFO - 2015-11-17 07:56:48,712 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;105;106;110;120;110;110;111;113;119;115 07:56:48 INFO - 2015-11-17 07:56:48,712 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;159;161;158;157;158;169;166;159;160 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;188;182;196;195;187;176;197;199;195;190 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;87;90;90;91;90;91;90;90;86 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 07:56:48 INFO - 2015-11-17 07:56:48,713 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1447775808704__endTimestamp 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,714 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:133.40 Median:136.50 stddev:6.77 (5.0%) stddev-sans-first:7.12 07:56:48 INFO - 2015-11-17 07:56:48,715 DEBUG : BROWSER_OUTPUT: Values: 131.0 135.0 133.0 139.0 139.0 133.0 119.0 138.0 141.0 126.0 07:56:48 INFO - 2015-11-17 07:56:48,715 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,715 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.80 Median:191.50 stddev:18.72 (9.8%) stddev-sans-first:19.49 07:56:48 INFO - 2015-11-17 07:56:48,715 DEBUG : BROWSER_OUTPUT: Values: 192.0 166.0 194.0 208.0 163.0 191.0 177.0 158.0 206.0 163.0 07:56:48 INFO - 2015-11-17 07:56:48,715 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,716 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.40 Median:202.50 stddev:3.60 (1.8%) stddev-sans-first:3.81 07:56:48 INFO - 2015-11-17 07:56:48,716 DEBUG : BROWSER_OUTPUT: Values: 202.0 205.0 202.0 195.0 203.0 207.0 201.0 197.0 199.0 203.0 07:56:48 INFO - 2015-11-17 07:56:48,716 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,716 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:102.80 Median:88.00 stddev:24.73 (28.1%) stddev-sans-first:26.03 07:56:48 INFO - 2015-11-17 07:56:48,717 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 106.0 155.0 85.0 88.0 90.0 88.0 141.0 88.0 07:56:48 INFO - 2015-11-17 07:56:48,717 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,717 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:128.90 Median:122.50 stddev:22.77 (18.6%) stddev-sans-first:24.01 07:56:48 INFO - 2015-11-17 07:56:48,717 DEBUG : BROWSER_OUTPUT: Values: 122.0 123.0 172.0 115.0 114.0 118.0 156.0 109.0 107.0 153.0 07:56:48 INFO - 2015-11-17 07:56:48,717 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,718 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.60 Median:149.50 stddev:4.81 (3.2%) stddev-sans-first:5.08 07:56:48 INFO - 2015-11-17 07:56:48,718 DEBUG : BROWSER_OUTPUT: Values: 150.0 145.0 155.0 155.0 147.0 141.0 153.0 149.0 148.0 143.0 07:56:48 INFO - 2015-11-17 07:56:48,718 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,719 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:160.00 Median:162.50 stddev:3.68 (2.3%) stddev-sans-first:3.61 07:56:48 INFO - 2015-11-17 07:56:48,719 DEBUG : BROWSER_OUTPUT: Values: 156.0 162.0 163.0 163.0 163.0 155.0 162.0 163.0 159.0 154.0 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.50 Median:130.00 stddev:6.42 (4.9%) stddev-sans-first:6.36 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: Values: 118.0 130.0 120.0 130.0 120.0 130.0 120.0 115.0 132.0 130.0 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:76.00 stddev:2.53 (3.3%) stddev-sans-first:1.59 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 75.0 74.0 77.0 77.0 76.0 76.0 76.0 76.0 07:56:48 INFO - 2015-11-17 07:56:48,720 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,721 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.00 Median:86.00 stddev:3.27 (3.8%) stddev-sans-first:2.92 07:56:48 INFO - 2015-11-17 07:56:48,721 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 81.0 87.0 88.0 89.0 89.0 84.0 85.0 85.0 07:56:48 INFO - 2015-11-17 07:56:48,721 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,721 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.90 Median:112.00 stddev:4.95 (4.4%) stddev-sans-first:4.58 07:56:48 INFO - 2015-11-17 07:56:48,721 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 110.0 120.0 110.0 110.0 111.0 113.0 119.0 115.0 07:56:48 INFO - 2015-11-17 07:56:48,722 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,722 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:160.50 stddev:3.82 (2.4%) stddev-sans-first:4.06 07:56:48 INFO - 2015-11-17 07:56:48,722 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 161.0 158.0 157.0 158.0 169.0 166.0 159.0 160.0 07:56:48 INFO - 2015-11-17 07:56:48,722 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,723 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:195.00 stddev:7.35 (3.8%) stddev-sans-first:7.74 07:56:48 INFO - 2015-11-17 07:56:48,723 DEBUG : BROWSER_OUTPUT: Values: 188.0 182.0 196.0 195.0 187.0 176.0 197.0 199.0 195.0 190.0 07:56:48 INFO - 2015-11-17 07:56:48,723 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-11-17 07:56:48,724 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.60 Median:90.00 stddev:3.13 (3.5%) stddev-sans-first:1.74 07:56:48 INFO - 2015-11-17 07:56:48,724 DEBUG : BROWSER_OUTPUT: Values: 81.0 87.0 90.0 90.0 91.0 90.0 91.0 90.0 90.0 86.0 07:56:48 INFO - 2015-11-17 07:56:48,725 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:56:48 INFO - 2015-11-17 07:56:48,725 DEBUG : BROWSER_OUTPUT: 07:56:49 INFO - 2015-11-17 07:56:49,388 INFO : Browser exited with error code: 0 07:56:49 INFO - 2015-11-17 07:56:49,445 INFO : Completed test kraken (00:01:04) 07:56:49 INFO - 2015-11-17 07:56:49,446 INFO : Starting test v8_7 07:56:49 INFO - 2015-11-17 07:56:49,446 DEBUG : operating with platform_type : mac_ 07:56:49 INFO - 2015-11-17 07:56:49,446 INFO : Initialising browser for v8_7 test... 07:56:49 INFO - 2015-11-17 07:56:49,462 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmp8PPFNB/profile http://localhost:49268/getInfo.html 07:56:52 INFO - 2015-11-17 07:56:52,050 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:56:52 INFO - 2015-11-17 07:56:52,050 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:56:52 INFO - 2015-11-17 07:56:52,050 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:56:52 INFO - 2015-11-17 07:56:52,050 DEBUG : BROWSER_OUTPUT: __metrics 07:56:52 INFO - 2015-11-17 07:56:52,071 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:56:52 INFO - 2015-11-17 07:56:52,865 INFO : Browser initialized. 07:56:52 INFO - 2015-11-17 07:56:52,866 INFO : Running cycle 1/1 for v8_7 test... 07:56:52 INFO - 2015-11-17 07:56:52,866 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmp8PPFNB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:57:05 INFO - 2015-11-17 07:57:05,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 230174720 07:57:05 INFO - 2015-11-17 07:57:05,077 DEBUG : BROWSER_OUTPUT: 07:57:27 INFO - 2015-11-17 07:57:27,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 07:57:28 INFO - 2015-11-17 07:57:28,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 310890496 07:57:28 INFO - 2015-11-17 07:57:28,209 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,210 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:57:28 INFO - 2015-11-17 07:57:28,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:57:28 INFO - 2015-11-17 07:57:28,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:57:28 INFO - 2015-11-17 07:57:28,210 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:57:28 INFO - 2015-11-17 07:57:28,210 DEBUG : BROWSER_OUTPUT: |0;Richards;209.11752404851526 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;251.63563160543532 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |2;Encrypt;399.52057530962844 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7142.857142857143 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2394.7368421052633 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |5;Earley;976.5625 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |6;Boyer;16704.918032786885 07:57:28 INFO - 2015-11-17 07:57:28,211 DEBUG : BROWSER_OUTPUT: |7;RegExp;37685.18518518518 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: |8;Splay;809.0614886731391 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7194.244604316546 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: __startTimestamp1447775848207__endTimestamp 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,212 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:57:28 INFO - 2015-11-17 07:57:28,213 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:57:28 INFO - 2015-11-17 07:57:28,213 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,213 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:209.12 Median:209.12 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,213 DEBUG : BROWSER_OUTPUT: Values: 209.1 07:57:28 INFO - 2015-11-17 07:57:28,214 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,214 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:251.64 Median:251.64 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,214 DEBUG : BROWSER_OUTPUT: Values: 251.6 07:57:28 INFO - 2015-11-17 07:57:28,214 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,214 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:399.52 Median:399.52 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: Values: 399.5 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7142.86 Median:7142.86 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: Values: 7142.9 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2394.74 Median:2394.74 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,215 DEBUG : BROWSER_OUTPUT: Values: 2394.7 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:976.56 Median:976.56 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: Values: 976.6 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16704.92 Median:16704.92 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: Values: 16704.9 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,216 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:37685.19 Median:37685.19 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: Values: 37685.2 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: Values: 809.1 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7194.24 Median:7194.24 stddev:0.00 (0.0%) 07:57:28 INFO - 2015-11-17 07:57:28,217 DEBUG : BROWSER_OUTPUT: Values: 7194.2 07:57:28 INFO - 2015-11-17 07:57:28,218 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:57:28 INFO - 2015-11-17 07:57:28,218 DEBUG : BROWSER_OUTPUT: 07:57:28 INFO - 2015-11-17 07:57:28,968 INFO : Browser exited with error code: 0 07:57:28 INFO - 2015-11-17 07:57:28,994 INFO : Completed test v8_7 (00:00:39) 07:57:29 INFO - 2015-11-17 07:57:29,448 INFO : Completed test suite (00:20:22) 07:57:29 INFO - 2015-11-17 07:57:29,448 DEBUG : Working with test: dromaeo_css 07:57:29 INFO - 2015-11-17 07:57:29,448 DEBUG : Generating results file: dromaeo_css 07:57:29 INFO - 2015-11-17 07:57:29,449 DEBUG : Working with test: kraken 07:57:29 INFO - 2015-11-17 07:57:29,449 DEBUG : Generating results file: kraken 07:57:29 INFO - 2015-11-17 07:57:29,449 INFO : javascript benchmark 07:57:29 INFO - 2015-11-17 07:57:29,449 DEBUG : Working with test: v8_7 07:57:29 INFO - 2015-11-17 07:57:29,449 DEBUG : Generating results file: v8_7 07:57:29 INFO - 2015-11-17 07:57:29,450 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:29 INFO - 2015-11-17 07:57:29,503 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 07:57:29 INFO - 2015-11-17 07:57:29,504 DEBUG : process_Request line: dromaeo_css 5172.68 graph.html#tests=[[72,64,55]] 07:57:29 INFO - 2015-11-17 07:57:29,504 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:29 INFO - 2015-11-17 07:57:29,538 DEBUG : process_Request line: kraken 1893.00 graph.html#tests=[[232,64,55]] 07:57:29 INFO - 2015-11-17 07:57:29,538 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:29 INFO - 2015-11-17 07:57:29,567 DEBUG : process_Request line: v8_7 14762.59 graph.html#tests=[[230,64,55]] 07:57:29 INFO - 2015-11-17 07:57:29,568 INFO : javascript benchmark 07:57:29 INFO - 2015-11-17 07:57:29,571 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [262.72413965336415, 267.154456146297, 267.1877492423034, 274.5922305376516, 277.9527480328345, 13543.864561354396, 14015.789763153549, 14123.929380353109, 14307.928460357696, 15222.08667479952, 14351.92824035881, 14416.062955907884, 14497.63755906103, 14814.333354999024, 14909.95630305879, 3749.9437508437395, 4242.15156968606, 4389.297712366022, 4422.668299877506, 4437.046035102452, 3868.400397938324, 3888.572257051722, 3889.124946886942, 3906.140649057203, 3952.980235098835, 2696.164189101375, 2746.958795618067, 3712.0719820044988, 3851.306764782338, 3854.2484215577974, 3792.127810603549, 3829.463875057494, 3840.788756618385, 3848.749831260959, 3898.8830335089992, 3244.5295432162206, 3250.463673493871, 3250.5774249347432, 3265.4775235962134, 3312.668733126668, 8902.421342612774, 9127.726168214964, 9136.543172841331, 9979.600815967426, 10376.896231037668, 1438.7194497073076, 1499.152978567117, 1557.0443055313472, 1597.8322276161068, 1669.0569828047237, 7390.778276651709, 7614.124375696811, 7626.656800443938, 7644.617769111522, 7697.9230207697765, 1159.8840115988419, 1177.2583272538332, 1185.2888267039793, 1188.085174415695, 1234.111439763369, 45178.0, 46622.300665490046, 46927.99999999966, 46958.06083878338, 47125.764371178266, 4989.376327959005, 5058.291839142523, 5144.6655967362, 5173.0, 5193.039287731782, 5877.265341832271, 5879.235699359056, 5899.085641725539, 5911.467967882825, 5962.642241465526, 3954.703397245218, 4035.6973227008093, 4040.3333449980423, 4073.024583077205, 4083.4283200351974, 3958.7426817256787, 3973.5827738087664, 4107.54816970133, 4134.896627584334, 4148.336266197394, 2272.511410046815, 2294.1855641247453, 2304.4814916643622, 2310.145246258895, 2315.247544547995, 805.4482679364654, 805.6817557065044, 808.4058217210346, 809.4940662086196, 855.7389996051139, 262.76876348813306, 303.13152817179065, 320.6520924796622, 325.2048740828651, 331.8622771549828, 8500.44747091437, 8728.956355218183, 8821.294296456397, 8981.550922453851, 9295.930967938639, 357.06627169950394, 360.2830367568572, 368.557730723128, 376.1423953386284, 384.60001598337413, 4862.5380588844, 5023.974880125576, 5124.897502050013, 5144.636671282114, 5254.264402983586, 455963.0, 466977.0, 471685.6583879712, 477921.0, 490090.0, 53666.7316663422, 57543.42456575464, 57919.0, 58287.125693114634, 60176.39823601796, 365.11459710203184, 366.42288395776757, 367.54975155434914, 368.799004542525, 379.45737595238523, 7518.947347371263, 8262.586870656563, 8407.0, 8734.30125589964, 8918.73243802687, 27084.593731093657, 27615.0, 28133.43733125367, 28323.716762832933, 28428.28929276702, 38747.59873263047, 38862.41706374463, 39247.21505569816, 39333.08336457943, 40236.798816005736, 4816.036792641556, 4977.203647416396, 4992.975035124801, 5007.47421520735, 5019.347484827095, 9136.0, 9150.679726209552, 9399.201067909304, 9408.670696525589, 9482.573284202366, 8018.799530011796, 8058.556779377191, 8239.134890836616, 8255.9680039995, 8296.211859873303, 7881.448298619041, 7907.695230286939, 8011.118776934416, 8042.075161356519, 8111.797205069921, 8076.596170191349, 8283.710070147516, 8325.500469971821, 8422.115677853737, 8574.31405487572, 4946.727929963743, 4955.5044495550155, 4962.057209130254, 4970.229614409773, 4977.8257760978195, 8068.556229407439, 8168.3465322772845, 8219.342452603896, 8321.375896807642, 8352.832943340978], "dojo.html": [2463.027104293804, 2519.672442582465, 2530.835495692781, 2531.4810463854906, 2552.8468291902486, 4082.3060079786433, 4130.938035929464, 4181.770002649853, 4210.852620158295, 4279.0799978004725, 4238.639715624168, 4238.8092535835885, 4252.957470425295, 4254.361845723143, 4257.403963445113, 4021.0, 4078.0416602098485, 4093.5087789465156, 4110.938335924963, 4113.465249517573, 4093.2427500912277, 4096.528899176588, 4098.180363927211, 4127.649149822269, 4154.480689913761, 4052.756834589934, 4069.7965101744794, 4099.241640296555, 4106.815193316293, 4108.897277568055, 3857.787821669807, 3930.724849260553, 3955.545112312092, 4004.3993400989793, 4029.697772667047, 3957.228340473609, 3964.32606456903, 3964.62336078075, 3965.1474932889278, 3987.3620220764537, 4047.4738284023183, 4179.059711564904, 4218.557051509578, 4232.809523571446, 4238.618524332794, 4363.672724545671, 4368.08270263242, 4465.486469056068, 4493.03399769048, 4495.0, 4542.523035081302, 4567.177907976563, 4593.127305811919, 4612.123696497655, 4652.906941861178, 4150.190712810973, 4242.384854196124, 4267.16790225903, 4269.295566231537, 4322.589354011396, 4517.277235642281, 4557.111363284128, 4571.474280457724, 4657.441107067174, 4668.043051174501, 4400.977995110068, 4427.313766366218, 4437.090396468716, 4439.733615983051, 4474.038081812426, 4398.582134697199, 4554.840580579664, 4570.177368073779, 4576.519465456079, 4631.282151266559, 4339.9783001085425, 4417.558244175621, 4482.260427029569, 4499.662525310615, 4509.12072145935, 4479.955200447954, 4517.525659805673, 4528.298113792367, 4542.477615074243, 4560.270356742905, 3377.155711072232, 3418.8803391881165, 3508.9298214035575, 3557.48416479609, 3594.227241143167, 3161.6996385343355, 3198.7760856739806, 3204.1669166017004, 3215.8552865121123, 3247.7726559141106, 4267.317229243306, 4273.786310684453, 4279.122779830127, 4281.100968796588, 4339.761313127745, 4392.560743925582, 4566.58900698932, 4567.931481027787, 4583.839565615188, 4604.1252162089095, 4241.787910604519, 4252.255855225385, 4265.019045619525, 4321.978390108029, 4360.978195109004, 3997.2605068062503, 4051.716379853441, 4080.571539988318, 4080.8571699990357, 4141.668666506672, 4494.842680506166, 4731.243001119804, 4744.027474367746, 4779.3070004848405, 4823.300621409946, 4452.577005184502, 4553.635709143195, 4560.110778398181, 4575.885602859955, 4588.472325682455, 4583.72497650142, 4627.5603817637275, 4656.464506581651, 4683.578477937002, 4697.506761789963, 4481.305397663367, 4483.327500874764, 4545.4545454545405, 4547.431571053618, 4582.991741816795, 4314.201872653569, 4427.35803308512, 4448.510663827041, 4451.577100175478, 4530.614897733598, 4426.203283409017, 4434.711743736647, 4444.022315090675, 4469.5530446955045, 4516.796744146455, 4425.933610995773, 4433.82264709408, 4470.173017991682, 4503.211937910787, 4512.616427603559, 4201.537830838544, 4298.075913678574, 4313.97843010783, 4401.66987475947, 4434.490033646172, 4219.493660760606, 4329.913401731885, 4448.733076015449, 4455.643548516046, 4466.531014243457, 4313.913721725485, 4318.35224716295, 4332.6317263033, 4334.28484300087, 4407.7796110195], "mootools.html": [1009.3086235928386, 1027.7636143686955, 1031.3811712972213, 1280.9103362764604, 1338.9732205355892, 5507.118860982244, 5700.201971723956, 5869.559783016275, 5920.792772252972, 5950.137230101633, 5903.970480147604, 5978.4918281945975, 6018.277806663206, 6028.0, 6131.478824299928, 1791.077595038553, 1809.5114319133827, 1815.5007372972473, 1832.3128826689992, 1833.065136780245, 1803.3057272949877, 1820.9544761381005, 1834.1012903677235, 1836.9081545922718, 1838.2279442634126, 1777.6000399910047, 1785.482210159059, 1786.0623172834237, 1790.4539115569746, 1790.498660375097, 1743.5118166913285, 1764.1972902329474, 1796.2635319518934, 1799.1993562864595, 1799.7750281214849, 1784.5984653453, 1815.9182836772245, 1834.5597056706429, 1843.824836640517, 1857.0621835972881, 5348.893022139574, 5925.377835327272, 5937.851553711149, 5968.7910923117915, 6087.4521293083835, 3427.7771944823758, 3502.3345564342694, 3683.8710645127558, 3771.9245615087543, 3804.068003339172, 2201.900914458853, 2214.9889250553642, 2232.966505502419, 2238.8432809703327, 2246.1127854497545, 690.0339524665459, 702.1644243350397, 714.5319815520842, 715.0846915947595, 724.8836791341328, 7781.3385862201785, 7831.216878312181, 7848.68605255789, 7881.724139655084, 7947.483413578099, 3434.9484757728655, 3518.138056176253, 3529.6470352964498, 3561.3411518869093, 3591.299696559146, 6969.58182509051, 6976.7558135465015, 6978.581285122909, 6993.4055605274125, 7092.007119003344, 3908.3746600544346, 3913.6673382762215, 3916.373380259145, 3928.508936382952, 3950.229705207457, 3528.1708798432346, 3539.7168226541817, 3560.2701446203464, 3565.6612621800887, 3587.9641203588153, 2777.5694767311097, 2806.873690683924, 2816.1551534539967, 2837.4750671125494, 2857.7142285771674, 906.4968942237122, 907.5144797533288, 911.7902882337099, 924.3206243411088, 925.0518218825757, 1024.3700124423426, 1026.9794604107876, 1038.6053299746047, 1054.7890421915647, 1071.8552995345685, 5615.129654903497, 5658.773649054074, 5669.546436285087, 5671.432856714296, 5687.431256874363, 375.1746158451418, 381.4316668164415, 383.762067518135, 392.1607759394897, 394.1407731146129, 4439.067795762861, 4522.909541809146, 4522.977385113119, 4548.158590660738, 4559.749213793207, 6504.869902601921, 6678.465722742169, 6770.4922130839395, 6775.322467753185, 6898.103246577913, 6919.34266244716, 6923.757668481579, 6982.092327997328, 7010.929890701028, 7088.681009354488, 5561.138023606348, 5622.971885140548, 5645.661260324394, 5738.77044918207, 5742.712864356766, 5436.891262174655, 5469.917951230815, 5482.698451585042, 5495.560355171497, 5566.415526369835, 6096.603720758137, 6175.351588083367, 6190.876182476415, 6211.689415529296, 6298.212723409574, 6317.494600432046, 6453.967365221542, 6463.15978922737, 6470.870582588228, 6508.479321654351, 5283.260343551982, 5297.0, 5312.043832110257, 5344.144936810092, 5367.463253674758, 5746.31044274673, 5806.65160090396, 5809.128630705259, 5821.27234095738, 5907.17299578068, 5305.734713264244, 5383.81156659515, 5449.128139497661, 5519.806806761744, 5528.530074943675, 5330.387005494418, 5362.70505122222, 5397.730113494231, 5397.86505337354, 5461.071617825059, 5159.09715799726, 5362.088444964287, 5427.1316589345515, 5448.073827449422, 5503.559715222853, 4898.902021959612, 4970.776315065903, 4979.3277907482025, 5012.724300163526, 5017.54842064216, 5020.824271150492, 5044.798208071783, 5072.34059572268, 5078.4159821619505, 5122.1804511278015], "ext.html": [447.69109314572944, 452.1161129990868, 454.6703639861099, 464.98372556960516, 476.8926991426932, 25094.37264068397, 25530.87234563827, 25598.0, 25775.0, 25797.226083217487, 26070.217893463177, 26734.866325668343, 26789.598156027674, 32020.199495012635, 32547.186320342003, 7137.500374973741, 7215.13418389794, 7235.059442272497, 7251.673674684652, 7272.345488905998, 7155.928440715605, 7175.856482870339, 7198.244184360646, 7269.3094156055095, 7289.307515785992, 6650.900236496456, 6843.486738494633, 6860.725570977155, 6905.447564194852, 6921.515493915428, 6588.407043366096, 8808.86786698197, 9020.413673111292, 9035.819283614357, 9051.683191088281, 8527.422426851052, 8701.912980870173, 8706.564671766386, 8776.0, 8777.0, 26445.206643800524, 26936.32659183536, 30549.541756873663, 30934.690653093632, 31253.687463125534, 1969.6060787842346, 2064.0092755477453, 2281.7376001759844, 2358.103920510195, 2392.1268736911074, 21778.698549784152, 21862.344129676134, 21890.12439502418, 21919.67120493194, 22138.667919981213, 1839.2036069818344, 1850.4171186076478, 1881.388548721671, 1881.5014021284371, 1927.6241132979076, 214871.0, 216244.0, 217007.0, 218877.0, 219708.9999999984, 43218.7839060809, 43364.78317608455, 43388.0, 45184.61115416357, 45509.0, 45607.543924560996, 46193.76903115463, 46238.30642540364, 46465.7676711621, 46683.29975050377, 10354.844677329846, 10360.119389851796, 10392.740181495372, 10397.48012599367, 10460.110890574386, 7648.80877978055, 7717.922820771721, 7749.070111586646, 7754.302112809874, 7831.490953088031, 14749.0, 14860.0, 14962.476313328982, 15031.549053528412, 15264.465743698916, 6633.2371777246235, 6886.724531018804, 6922.203946546111, 6989.930100698928, 7021.473389495808, 732.1214542548962, 769.3422124083828, 794.4518282385136, 800.3757069485811, 851.2041241439274, 22635.773642263368, 22822.0, 22997.19509817182, 23059.0, 23083.307500775005, 798.8042929482314, 803.7267329108131, 876.0976194519654, 908.246155690775, 931.7344556801279, 10895.673129806119, 11105.72235694098, 11107.278026928223, 11166.385848778233, 11247.718807029725, 252545.0, 257976.0, 262004.0, 262298.0, 263126.0, 38584.22831543353, 38684.226315473534, 38706.61293387086, 39261.411078833844, 39316.41025384622, 1069.214127616186, 1085.2782899371987, 1089.340948726025, 1091.8198497248025, 1094.813881640139, 17866.374676886247, 21671.45821354479, 23202.76797232006, 23686.907314926684, 23734.169304074276, 37873.24253514969, 37926.43110353402, 38138.42792358172, 38518.614813851505, 38620.6137938617, 188679.0, 190986.0, 193056.0, 217304.0, 221851.0, 23861.403464913517, 24314.87842560776, 24361.0, 24375.51248975046, 24674.259772206864, 29621.407571848875, 29904.70095299019, 30126.69873301239, 30238.54642180413, 30280.242993925327, 25823.741762582886, 27365.0, 28175.933015781044, 30057.248568785955, 30207.244818879703, 26368.0, 27164.728352716218, 27232.319192020357, 27256.863715681295, 27710.72289277162, 25684.101056462932, 26355.472890542464, 26461.470770584096, 26699.0, 26863.597046043935, 22990.655140173247, 23887.761122388554, 24262.0, 24702.382440439134, 24804.50390992134, 18945.621087577896, 19048.80951190526, 19049.809501904805, 19126.713099303244, 19172.90413547923], "prototype.html": [236.47974456196366, 243.03878161869807, 244.3305343359195, 250.7667868881939, 263.1355995554604, 4824.517548245174, 4911.336969509115, 4965.478624744404, 5043.7982480700775, 5046.293518907356, 4800.807967681298, 4884.438289596697, 4922.975385123078, 4969.229769385751, 4993.950060499394, 3816.9045773855596, 3851.61483851614, 3869.5550011748587, 3889.533256009269, 3934.4885164928664, 3681.815909204529, 3796.297684928283, 3815.084379748868, 3852.383618621021, 3882.611738826123, 3750.906227344311, 3846.2499812536566, 3863.652271295583, 3864.381698928172, 3921.392184211452, 3808.219315040424, 3856.6914646828186, 3869.6323849234277, 3878.5151856017997, 3884.3008258513455, 3340.0146956647845, 3344.1806757344607, 3355.2953879685297, 3382.847771850248, 3395.1851555626718, 4802.447718512381, 4808.711477311337, 4811.975940120312, 4858.125537403266, 4889.997550502138, 4228.386883901817, 4238.321868501056, 4281.422008028939, 4314.1371725655, 4380.3210502372185, 5190.870228244286, 5198.480151984809, 5228.764705588258, 5229.2417599448245, 5264.9736751315995, 3333.8999830005137, 3485.0590340608146, 3557.4130268505664, 3581.659742324501, 3623.61951995042, 5297.073012222845, 5326.733663316857, 5463.7814487420455, 5464.480874316933, 5572.693501857356, 3601.603823579404, 3624.7462677612843, 3628.1111127773866, 3629.6370362963494, 3635.345637785224, 3674.191677830873, 3689.520362352877, 3718.665320121202, 3736.23407201523, 3757.380032294641, 4281.272183728774, 4286.057067445157, 4288.957110428918, 4312.978435107804, 4351.26028575143, 5014.768428049556, 5167.819126330561, 5178.145605974972, 5181.067407866545, 5226.869328266824, 1296.3906963727034, 1305.7714899892671, 1306.817045613615, 1309.6398490415022, 1310.60026691858, 829.867221244598, 843.6583183810567, 852.748439210422, 855.2003876375609, 858.3176374782063, 4959.677620954626, 4966.553010229024, 4979.0788704089855, 5003.374578177728, 5095.286659867622, 5426.077566813651, 5440.483154100354, 5448.83653490396, 5461.15352120422, 5483.259759932438, 4812.927806082912, 4987.703197168762, 5007.849764506997, 5011.173156429149, 5019.498050194951, 2846.8576571171357, 2877.093715479617, 2917.212352664769, 2920.007197552842, 2932.076395935316, 5510.228568000483, 5522.972385138129, 5539.944600554023, 5578.665280083208, 5588.189712491666, 5529.225908372831, 5548.195511650788, 5559.138333558305, 5569.0, 5633.014222511126, 5521.696306703089, 5531.612787104945, 5532.5020748132865, 5568.331800184003, 5601.047821870292, 5179.430262671179, 5381.704006279692, 5385.1922211667, 5450.863728406822, 5470.972645136908, 5280.155175171954, 5284.04887120322, 5295.655782374133, 5325.893482130258, 5356.758945847524, 5328.813491527778, 5356.946430535645, 5500.3949565548555, 5523.944760552504, 5528.612997090165, 3632.2917031178667, 3661.450782382664, 3668.394714872123, 3673.3571624966057, 3685.1708365617524, 5405.78376864921, 5423.322084739408, 5429.158480435539, 5432.6468779529205, 5482.616216864782, 5114.974425127851, 5250.133727934848, 5258.684478931276, 5268.0, 5337.252784610236, 5255.842324730264, 5256.553192978639, 5258.763355648928, 5258.8948221036135, 5262.605304602247, 5125.1799712045895, 5126.923096153635, 5159.019786240602, 5165.922511162411, 5230.450802665665, 5250.159974404077, 5265.315508983807, 5300.575953923754, 5310.389305229948, 5345.064613692511, 5000.874978125576, 5161.638685291993, 5164.431912489698, 5175.301334319819, 5212.713300768494], "yui.html": [473.1625023708036, 477.08399872245286, 494.7427337784352, 506.3442841520231, 521.2389910730336, 10162.187025037998, 10284.845727314096, 10398.22013348998, 10419.843702344451, 10538.0, 10041.196704263659, 10200.336978096437, 10205.795884082314, 10274.0, 10321.225908056907, 699.4998576018133, 709.5671640299413, 709.9006139140498, 711.8896571031498, 712.3517598984898, 705.4638474759195, 713.0552018575382, 713.8786406310913, 715.7852644206744, 717.1107826295408, 728.2680905689774, 736.4513437489052, 741.2994719989612, 743.5835931878139, 745.6197339356913, 726.23019599225, 727.6180005497104, 733.2594079979233, 735.5954225176132, 737.7860420478055, 544.9509544141047, 546.2952790899734, 546.5736725354191, 551.9034169020406, 551.9448055194489, 9864.457454839981, 10062.597496100147, 10064.597416103346, 10081.344712593658, 10105.090541851268, 7537.0, 7831.686732530692, 8030.678772849079, 8168.305694016016, 8289.295409890166, 6539.673016349164, 6646.534742568022, 6767.512770759941, 7051.435885129177, 7322.597257150855, 2344.5662552427857, 2507.8746062696973, 2588.417606038645, 2668.4262883480146, 2739.2193224930998, 33083.3383332332, 33309.0, 35340.646593533995, 35516.64483355159, 36382.454263186075, 5267.473252674702, 5367.2485851980755, 5439.075357189287, 5592.832215033555, 5641.887162256732, 9631.9036809631, 9693.563789629483, 9717.416954982724, 9743.171830394354, 9793.510324483746, 4897.3878265216845, 4990.426100998359, 4994.80020799164, 5128.743562821844, 5211.765470553834, 2926.341573146025, 2988.088632966966, 3022.894198703035, 3065.0498345512515, 3191.952120718191, 2022.8988550572412, 2033.0952726036771, 2034.104993802722, 2059.7631272403864, 2075.107703687429, 313.89641418331894, 316.68015304542575, 317.78549479101514, 319.1574243995853, 323.0566745104301, 420.59202573503654, 420.59412666776706, 444.44444444444446, 470.1850855697007, 501.85195367366714, 6097.2683278006925, 6492.253390860112, 6567.310432404529, 6607.174103237096, 6731.865362692816, 375.3824957944221, 391.3640334456508, 455.0920912778961, 479.1208133075845, 491.59197865771324, 2775.708550602198, 2852.7289907458758, 2862.470442968016, 2938.882444702188, 2952.867120979561, 43923.0, 44445.777771111585, 44448.55551444509, 44909.0, 45010.0, 37083.629163708014, 38143.427848582294, 38417.42373864394, 38761.0, 39305.213895722496, 32991.50512742311, 36362.45456318157, 36781.26437471289, 37327.813360933564, 37994.62005379966, 6203.379662033761, 6459.128017717548, 6601.669916504252, 6661.533692641468, 6666.600003999775, 28149.296267592654, 28209.858950705115, 28284.85857570699, 28431.147065588066, 28508.85745571259, 33240.1689957753, 34415.0, 35624.46563301501, 35794.82102589471, 36419.81790091139, 8361.0, 8450.47891379533, 8562.400631955952, 8742.431741936754, 9097.999220085918, 8919.955400222958, 8965.551722413722, 9022.548872556477, 9023.593938272663, 9268.768280793034, 8252.711155109542, 8504.319654427507, 8532.530710810717, 8554.059053503985, 8642.481451112953, 8570.0, 8604.10399976176, 8670.869936950825, 8686.739397818075, 8737.475751454933, 7927.563983980936, 8263.876041859257, 8369.623366948625, 8576.31389488827, 8939.240164585823, 6365.777197798055, 6516.57642253252, 6538.248101468202, 6879.621620810904, 7130.679119439534, 6163.229596300463, 6564.934350656432, 6791.3548212919695, 6932.549384290005, 7283.380912622486]}, "summary": {"lowerIsBetter": false, "suite": 5172.6753651545205, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5291.513491149472, "unit": "ms", "value": 5291.513491149472}, "dojo.html": {"lowerIsBetter": false, "filtered": 4212.587509212241, "unit": "ms", "value": 4212.587509212241}, "mootools.html": {"lowerIsBetter": false, "filtered": 3397.9057159108875, "unit": "ms", "value": 3397.9057159108875}, "ext.html": {"lowerIsBetter": false, "filtered": 14025.247714709209, "unit": "ms", "value": 14025.247714709209}, "prototype.html": {"lowerIsBetter": false, "filtered": 3928.203517674808, "unit": "ms", "value": 3928.203517674808}, "yui.html": {"lowerIsBetter": false, "filtered": 4589.879652691925, "unit": "ms", "value": 4589.879652691925}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447774626, "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": "20151117061705", "branch": "Fx-Team", "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310"}}, {"talos_counters": {}, "results": {"audio-dft": [202.0, 205.0, 202.0, 195.0, 203.0, 207.0, 201.0, 197.0, 199.0, 203.0], "ai-astar": [131.0, 135.0, 133.0, 139.0, 139.0, 133.0, 119.0, 138.0, 141.0, 126.0], "imaging-gaussian-blur": [150.0, 145.0, 155.0, 155.0, 147.0, 141.0, 153.0, 149.0, 148.0, 143.0], "audio-beat-detection": [192.0, 166.0, 194.0, 208.0, 163.0, 191.0, 177.0, 158.0, 206.0, 163.0], "json-stringify-tinderbox": [80.0, 82.0, 81.0, 87.0, 88.0, 89.0, 89.0, 84.0, 85.0, 85.0], "stanford-crypto-pbkdf2": [188.0, 182.0, 196.0, 195.0, 187.0, 176.0, 197.0, 199.0, 195.0, 190.0], "json-parse-financial": [69.0, 72.0, 75.0, 74.0, 77.0, 77.0, 76.0, 76.0, 76.0, 76.0], "stanford-crypto-sha256-iterative": [81.0, 87.0, 90.0, 90.0, 91.0, 90.0, 91.0, 90.0, 90.0, 86.0], "audio-fft": [94.0, 93.0, 106.0, 155.0, 85.0, 88.0, 90.0, 88.0, 141.0, 88.0], "imaging-darkroom": [156.0, 162.0, 163.0, 163.0, 163.0, 155.0, 162.0, 163.0, 159.0, 154.0], "stanford-crypto-ccm": [161.0, 159.0, 161.0, 158.0, 157.0, 158.0, 169.0, 166.0, 159.0, 160.0], "audio-oscillator": [122.0, 123.0, 172.0, 115.0, 114.0, 118.0, 156.0, 109.0, 107.0, 153.0], "stanford-crypto-aes": [105.0, 106.0, 110.0, 120.0, 110.0, 110.0, 111.0, 113.0, 119.0, 115.0], "imaging-desaturate": [118.0, 130.0, 120.0, 130.0, 120.0, 130.0, 120.0, 115.0, 132.0, 130.0]}, "summary": {"lowerIsBetter": true, "suite": 1893.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 190.5, "unit": "ms", "value": 190.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 181.8, "unit": "ms", "value": 181.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 160.8, "unit": "ms", "value": 160.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 160.0, "unit": "ms", "value": 160.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.8, "unit": "ms", "value": 74.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 128.9, "unit": "ms", "value": 128.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 133.4, "unit": "ms", "value": 133.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 201.4, "unit": "ms", "value": 201.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.6, "unit": "ms", "value": 88.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 148.6, "unit": "ms", "value": 148.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 111.9, "unit": "ms", "value": 111.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.5, "unit": "ms", "value": 124.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447774626, "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": "20151117061705", "branch": "Fx-Team", "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310"}}, {"talos_counters": {}, "results": {"DeltaBlue": [251.63563160543532], "Encrypt": [399.52057530962844], "NavierStokes": [7194.244604316546], "Decrypt": [7142.857142857143], "Splay": [809.0614886731391], "Richards": [209.11752404851526], "RegExp": [37685.18518518518], "Earley": [976.5625], "Boyer": [16704.918032786885], "RayTrace": [2394.7368421052633]}, "summary": {"lowerIsBetter": false, "suite": 14762.586539026848, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 262.7529319999999, "unit": "score", "value": 262.7529319999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 666.2510430000002, "unit": "score", "value": 666.2510430000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 206.27599999999984, "unit": "score", "value": 206.27599999999984}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.26534000000002, "unit": "score", "value": 37.26534000000002}, "Splay": {"lowerIsBetter": false, "filtered": 100.72287599999999, "unit": "score", "value": 100.72287599999999}, "RegExp": {"lowerIsBetter": false, "filtered": 24.173557739557737, "unit": "score", "value": 24.173557739557737}, "Richards": {"lowerIsBetter": false, "filtered": 168.81416399999995, "unit": "score", "value": 168.81416399999995}, "Earley": {"lowerIsBetter": false, "filtered": 682.458112, "unit": "score", "value": 682.458112}, "Boyer": {"lowerIsBetter": false, "filtered": 39.89621491658491, "unit": "score", "value": 39.89621491658491}, "RayTrace": {"lowerIsBetter": false, "filtered": 309.0063956043957, "unit": "score", "value": 309.0063956043957}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447774626, "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": "20151117061705", "branch": "Fx-Team", "revision": "e37dcb50abc2ed405a480087cf2f63f77f575310"}}] 07:57:29 INFO - RETURN: dromaeo_css: 5172.68 07:57:29 INFO - RETURN: kraken: 1893.00 07:57:29 INFO - RETURN: v8_7: 14762.59 07:57:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14762.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1893.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5172.68"}}} 07:57:29 INFO - Return code: 0 07:57:29 INFO - # TBPL SUCCESS # 07:57:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:29 INFO - 2015-11-17 07:57:29.692 screenresolution[1661:9905] starting screenresolution argv=screenresolution get 07:57:29 INFO - 2015-11-17 07:57:29.695 screenresolution[1661:9905] Display 0: 1600x1200x32@60 07:57:29 INFO - 2015-11-17 07:57:29.702 screenresolution[1662:9908] starting screenresolution argv=screenresolution list 07:57:29 INFO - Available Modes on Display 0 07:57:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:29 INFO - Intel HD Graphics 3000: 07:57:29 INFO - Chipset Model: Intel HD Graphics 3000 07:57:29 INFO - Type: GPU 07:57:29 INFO - Bus: Built-In 07:57:29 INFO - VRAM (Total): 512 MB 07:57:29 INFO - VRAM (Dynamic, Max): 10 07:57:29 INFO - Vendor: Intel (0x8086) 07:57:29 INFO - Device ID: 0x0116 07:57:29 INFO - Revision ID: 0x0009 07:57:29 INFO - Displays: 07:57:29 INFO - Display: 07:57:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:29 INFO - Display Serial Number: 1600x1200 60 07:57:29 INFO - Main Display: Yes 07:57:29 INFO - Mirror: Off 07:57:29 INFO - Online: Yes 07:57:29 INFO - Rotation: Supported 07:57:29 INFO - Return code: 0 07:57:29 INFO - Running post-action listener: _resource_record_post_action 07:57:29 INFO - Running post-run listener: _resource_record_post_run 07:57:31 INFO - Total resource usage - Wall time: 1268s; CPU: 30.0%; Read bytes: 42312704; Write bytes: 689298432; Read time: 5206; Write time: 48204 07:57:31 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 340072960; Write bytes: 336293888; Read time: 38992; Write time: 5729 07:57:31 INFO - run-tests - Wall time: 1224s; CPU: 30.0%; Read bytes: 41395200; Write bytes: 342641664; Read time: 4719; Write time: 41736 07:57:31 INFO - Running post-run listener: _upload_blobber_files 07:57:31 INFO - Blob upload gear active. 07:57:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:57:31 INFO - Copying logs to upload dir... 07:57:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1330.340172 ========= master_lag: 3.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-17 07:57:34.514852) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:57:34.518200) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010932 build_url: 'https://queue.taskcluster.net/v1/task/2VuK33dVQCyeiBNyr-tJPg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:57:34.564488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:57:34.565308) ========= 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.VRjTFuZh4i/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.1AmKIO9ZJX/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.005537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:57:34.655205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 07:57:34.655508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 07:57:34.659686) ========= ========= Total master_lag: 3.98 =========