Please find the log from bzt and jmeter as I am unable to add as an attachment.
bzt log
----------
[2016-05-27 09:25:30,921 INFO root] Taurus CLI Tool v1.5.0
[2016-05-27 09:25:30,923 DEBUG root] Command-line options: {'verbose': None, 'no_system_configs': None, 'quiet': None, 'log': 'bzt.log', 'option': None, 'aliases': []}
[2016-05-27 09:25:30,923 DEBUG root] Python: CPython 2.7.11
[2016-05-27 09:25:30,924 DEBUG root] OS: ('Windows', 'R9P7V0P', '7', '6.1.7601', 'AMD64', 'Intel64 Family 6 Model 42 Stepping 7, GenuineIntel')
[2016-05-27 09:25:30,924 INFO root] Starting with configs: ['ACT_0524.yml']
[2016-05-27 09:25:30,924 INFO Engine] Configuring...
[2016-05-27 09:25:30,924 DEBUG Engine] Reading machine configs from: c:\etc\bzt.d
[2016-05-27 09:25:30,926 INFO Engine] No personal config: C:\WINDOWS\system32\config\systemprofile\.bzt-rc
[2016-05-27 09:25:30,926 DEBUG Engine.Configuration] Configs: ['c:\\etc\\bzt.d\\10-base.json', 'c:\\etc\\bzt.d\\99-installID.yml']
[2016-05-27 09:25:30,927 DEBUG Engine.Configuration] Reading c:\etc\bzt.d\10-base.json as JSON
[2016-05-27 09:25:30,930 DEBUG Engine.Configuration] Reading c:\etc\bzt.d\99-installID.yml as YAML
[2016-05-27 09:25:30,930 DEBUG Engine.Configuration] Configs: ['ACT_0524.yml']
[2016-05-27 09:25:30,931 DEBUG Engine.Configuration] Reading ACT_0524.yml as YAML
[2016-05-27 09:25:30,953 DEBUG root] Configs: ['ACT_0524.yml']
[2016-05-27 09:25:30,953 DEBUG root] Reading ACT_0524.yml as YAML
[2016-05-27 09:25:30,977 DEBUG Engine] Requesting updates info:
http://gettaurus.org/updates/?version=1.5.0&installID=720c39f8-d76a-41fe-92c9-9aab296d7e4c[2016-05-27 09:25:31,451 DEBUG Engine] Result: {"latest":"1.5.0","needsUpgrade":false}
[2016-05-27 09:25:31,451 DEBUG Engine] Installation is up-to-date
[2016-05-27 09:25:31,451 INFO Engine] Artifacts dir: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925
[2016-05-27 09:25:31,470 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective
[2016-05-27 09:25:31,476 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:25:31,523 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:25:31,526 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\merged.yml
[2016-05-27 09:25:31,532 DEBUG root] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\merged.yml
[2016-05-27 09:25:31,546 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\merged.json
[2016-05-27 09:25:31,549 DEBUG root] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\merged.json
[2016-05-27 09:25:31,549 DEBUG Engine] Add existing artifact (move=False): ACT_0524.yml
[2016-05-27 09:25:31,549 DEBUG Engine] Copying ACT_0524.yml to C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\ACT_0524.yml
[2016-05-27 09:25:31,552 INFO Engine] Preparing...
[2016-05-27 09:25:31,553 DEBUG Engine] Module config: consolidator defaultdict(None, {u'ignore-labels': [u'ignore'], u'percentiles': [0.0, 50.0, 90.0, 95.0, 99.0, 99.9, 100.0], u'class': u'bzt.modules.aggregator.ConsolidatingAggregator'})
[2016-05-27 09:25:31,553 DEBUG root] Importing module: bzt.modules.aggregator
[2016-05-27 09:25:31,562 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'c:\python27\lib\site-packages\bzt\modules\aggregator.pyc'>
[2016-05-27 09:25:31,562 DEBUG Engine.consolidator] Buffer scaling setup: percentile 95.0 from [0.0, 50.0, 90.0, 95.0, 99.0, 99.9, 100.0] selected
[2016-05-27 09:25:31,562 DEBUG Engine] Module config: monitoring defaultdict(None, {u'class': u'bzt.modules.monitoring.Monitoring'})
[2016-05-27 09:25:31,562 DEBUG root] Importing module: bzt.modules.monitoring
[2016-05-27 09:25:31,631 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'c:\python27\lib\site-packages\bzt\modules\monitoring.pyc'>
[2016-05-27 09:25:31,779 DEBUG Engine.monitoring.ServerAgentClient] Connected to serverAgent at
172.25.62.15:4444 successfully
[2016-05-27 09:25:32,029 DEBUG Engine.monitoring.ServerAgentClient] Connected to serverAgent at
172.25.62.16:4444 successfully
[2016-05-27 09:25:32,030 DEBUG Engine] Module config: local defaultdict(None, {u'class': u'bzt.modules.provisioning.Local'})
[2016-05-27 09:25:32,030 DEBUG root] Importing module: bzt.modules.provisioning
[2016-05-27 09:25:32,030 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'c:\python27\lib\site-packages\bzt\modules\provisioning.pyc'>
[2016-05-27 09:25:32,032 DEBUG Engine] Module config: jmeter defaultdict(None, {u'path': u'~/.bzt/jmeter-taurus/', 'memory-xmx': '512M', u'class': u'bzt.modules.jmeter.JMeterExecutor', u'properties': defaultdict(None, {u'jmeter.save.saveservice.autoflush': u'true', u'jmeterengine.force.system.exit': u'true', u'jmeter.save.saveservice.connect_time': u'true', u'
summariser.name': u'', u'mode': u'Stripped'})})
[2016-05-27 09:25:32,032 DEBUG root] Importing module: bzt.modules.jmeter
[2016-05-27 09:25:32,059 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'c:\python27\lib\site-packages\bzt\modules\jmeter.pyc'>
[2016-05-27 09:25:32,059 DEBUG Engine.local] Preparing executor: jmeter/38360336
[2016-05-27 09:25:32,061 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\jmeter.log
[2016-05-27 09:25:32,061 DEBUG Engine.jmeter] Checking if port 4445 is free
[2016-05-27 09:25:32,063 DEBUG Engine.jmeter] Port 4445 is free
[2016-05-27 09:25:32,065 DEBUG Engine.jmeter] Using port 4445 for management
[2016-05-27 09:25:32,065 DEBUG Engine.jmeter.JavaVM] Trying: ['java', '-version']
[2016-05-27 09:25:32,319 DEBUG Engine.jmeter.JavaVM] JavaVM output: java version "1.8.0_73"
Java(TM) SE Runtime Environment (build 1.8.0_73-b02)
Java HotSpot(TM) Client VM (build 25.73-b02, mixed mode, sharing)
[2016-05-27 09:25:32,319 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment
[2016-05-27 09:25:32,319 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present
[2016-05-27 09:25:32,321 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\WINDOWS\system32\config\systemprofile\.bzt\jmeter-taurus\bin\jmeter.bat
[2016-05-27 09:25:32,346 DEBUG bzt.utils] Executing shell: [u'C:\\WINDOWS\\system32\\config\\systemprofile\\.bzt\\jmeter-taurus\\bin\\jmeter.bat', '-j', 'c:\\windows\\temp\\jmeterli7qzqlog', '--version']
[2016-05-27 09:25:37,384 DEBUG Engine.jmeter.JMeter] JMeter check: Copyright (c) 1998-2015 The Apache Software Foundation
Version 2.13 r1665067
/ None
[2016-05-27 09:25:37,388 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=4, throughput=None, ramp_up=60.0, hold=300.0, iterations=0, duration=360.0, steps=None)
[2016-05-27 09:25:37,394 DEBUG Engine.jmeter] Original threads: 1.0
[2016-05-27 09:25:37,397 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:37,398 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:37,400 DEBUG Engine.jmeter] Enforcing parent sample for transaction controller
[2016-05-27 09:25:37,401 DEBUG JMX] Saving JMX to: C:\jmeter\apache-jmeter-3.0\apache-jmeter-3.0\bin\modified_CardConnect_Services_V01.jmx
[2016-05-27 09:25:37,403 DEBUG Engine.jmeter] Additional properties: defaultdict(None, {u'jmeter.save.saveservice.autoflush': u'true', u'jmeter.save.saveservice.connect_time': u'true', 'user.classpath': 'C:/jmeter/Jmeter-Taurus/Jenkins/CardConnect_1605270925', u'
summariser.name': u'', u'jmeterengine.force.system.exit': u'true', 'jmeter.save.saveservice.timestamp_format': 'ms', u'mode': u'Stripped', 'jmeterengine.nongui.maxport': 4445, 'jmeterengine.nongui.port': 4445})
[2016-05-27 09:25:37,404 DEBUG Engine] New artifact filename: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\jmeter-bzt.properties
[2016-05-27 09:25:37,404 DEBUG Engine.jmeter] Setting JVM heap size to 512M
[2016-05-27 09:25:37,407 DEBUG Engine] Module config: final_stats defaultdict(None, {u'class': u'bzt.modules.reporting.FinalStatus'})
[2016-05-27 09:25:37,407 DEBUG root] Importing module: bzt.modules.reporting
[2016-05-27 09:25:37,414 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'c:\python27\lib\site-packages\bzt\modules\reporting.pyc'>
[2016-05-27 09:25:37,414 DEBUG Engine] Module config: console defaultdict(None, {u'disable': False, u'class': u'bzt.modules.console.ConsoleStatusReporter'})
[2016-05-27 09:25:37,414 DEBUG root] Importing module: bzt.modules.console
[2016-05-27 09:25:37,414 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'c:\python27\lib\site-packages\bzt\modules\console.pyc'>
[2016-05-27 09:25:37,414 DEBUG Engine] Module config: blazemeter defaultdict(None, {'token': '********', u'class': u'bzt.modules.blazemeter.BlazeMeterUploader'})
[2016-05-27 09:25:37,414 DEBUG root] Importing module: bzt.modules.blazemeter
[2016-05-27 09:25:37,414 DEBUG root] Loading class: 'BlazeMeterUploader' from <module 'bzt.modules.blazemeter' from 'c:\python27\lib\site-packages\bzt\modules\blazemeter.pyc'>
[2016-05-27 09:25:37,437 DEBUG BlazeMeterClient] Request: GET
https://a.blazemeter.com/api/latest/web/version None
[2016-05-27 09:25:39,217 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": "blazemeter-backend-package 2594 release/2016-05-18_39 B2594 Wed May 18 10:42:45 2016 +0300 f98565aea6f8bbc1ab34553a06b63b0f954551d1\n"
}
[2016-05-27 09:25:39,217 DEBUG BlazeMeterClient] Request: GET
https://a.blazemeter.com/api/latest/tests None
[2016-05-27 09:25:39,848 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": [
{
"name": "Taurus Test",
"userId": 151343,
"created": 1464116992,
"updated": 1464116992,
"configuration": {
"type
[2016-05-27 09:25:39,849 DEBUG BlazeMeterClient] Tests for user: 2
[2016-05-27 09:25:39,849 DEBUG BlazeMeterClient] Test: {u'updated': 1464116992, u'name': u'Taurus Test', u'created': 1464116992, u'projectId': None, u'userId': 151343, u'configuration': {u'type': u'external', u'concurrency': 1}, u'id': 5207924}
[2016-05-27 09:25:39,851 DEBUG BlazeMeterClient] Matched: {u'updated': 1464116992, u'name': u'Taurus Test', u'created': 1464116992, u'projectId': None, u'userId': 151343, u'configuration': {u'type': u'external', u'concurrency': 1}, u'id': 5207924}
[2016-05-27 09:25:39,851 DEBUG BlazeMeterClient] Test: {u'updated': 1464116875, u'name': u'Demo Test', u'created': 1464116875, u'projectId': None, u'userId': 151343, u'configuration': {u'consoleSize': u'm3.large', u'indexOffset': 0, u'serversCount': 0, u'location': u'us-west-1', u'delayedStart': False, u'plugins': {u'splitCSV': {u'enabled': False, u'totalEngines': 10}, u'reportEmail': {u'enabled': True}, u'jmeter': {u'override': {u'duration': 20, u'rampup': 300, u'threads': 50, u'iterations': -1}, u'version': u'2.11blazemeter', u'filename': u'rc_dyn_1m.jmx'}, u'remoteControl': [{u'value': u'60', u'key': u'TC1'}, {u'value': u'250', u'key': u'TC2'}, {u'value': u'150', u'key': u'TC3'}, {u'value': u'50', u'key': u'TC4'}, {u'value': u'10000', u'key': u'blazemeter.hps'}]}, u'type': u'jmeter', u'enginesSize': u'm3.large'}, u'id': 5207923}
[2016-05-27 09:25:39,851 DEBUG BlazeMeterClient] Using test ID: 5207924
[2016-05-27 09:25:39,855 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:25:39,930 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:25:39,934 INFO Engine] Starting...
[2016-05-27 09:25:39,936 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:39,937 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:39,937 DEBUG Engine.monitoring.ServerAgentClient] Sending metrics command: metrics:cpu memory
[2016-05-27 09:25:39,937 DEBUG Engine.monitoring.ServerAgentClient] Sending metrics command: metrics:cpu memory
[2016-05-27 09:25:39,937 DEBUG Engine] Startup <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:39,938 DEBUG Engine] Startup <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:39,940 DEBUG Engine] Startup <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:39,940 DEBUG Engine] Startup <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:39,940 INFO BlazeMeterClient] Initiating data feeding...
[2016-05-27 09:25:39,941 DEBUG BlazeMeterClient] Request: POST
https://a.blazemeter.com/api/latest/tests/5207924/start-external None
[2016-05-27 09:25:40,865 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": {
"session": {
"id": "r-ext-574858e489dd6",
"name": "Taurus Test",
"userId": 151343,
"offset": 0,
"statusCode": 15,
"st
[2016-05-27 09:25:40,865 INFO Engine.blazemeter] Started data feeding:
https://a.blazemeter.com/app/#reports/r-ext-574858e489dd6[2016-05-27 09:25:40,913 DEBUG Engine] Startup <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:40,913 DEBUG Engine.local] Delay setup: 0(start-at) + 0.0(delay) = 0.0
[2016-05-27 09:25:40,917 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:25:40,979 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:25:40,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:40,982 DEBUG bzt.utils] Executing shell: [u'C:\\WINDOWS\\system32\\config\\systemprofile\\.bzt\\jmeter-taurus\\bin\\jmeter.bat', '-n', '-t', 'C:\\jmeter\\apache-jmeter-3.0\\apache-jmeter-3.0\\bin\\modified_CardConnect_Services_V01.jmx', '-j', 'C:\\jmeter\\Jmeter-Taurus\\Jenkins\\CardConnect_1605270925\\jmeter.log', '-q', 'C:\\jmeter\\Jmeter-Taurus\\Jenkins\\CardConnect_1605270925\\jmeter-bzt.properties', '-R172.25.62.15,172.25.62.16']
[2016-05-27 09:25:40,999 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:40,999 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:41,000 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:41,000 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:41,000 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:41,000 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:41,000 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:41,220 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:41,220 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:41,220 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:41,220 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:41,220 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:41,221 INFO Engine.console] Waiting to get first results...
[2016-05-27 09:25:41,221 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:41,221 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:41,221 DEBUG Engine] Iteration took 0.240 sec, sleeping for 0.760 sec...
[2016-05-27 09:25:41,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:41,982 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:41,982 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:41,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:41,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:41,983 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:41,983 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:41,983 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:42,009 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:42,009 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:42,009 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:42,009 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.4446776001791585 6.8645162475314425
[2016-05-27 09:25:42,009 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:42,009 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:42,009 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:42,009 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:42,010 DEBUG Engine] Iteration took 0.029 sec, sleeping for 0.971 sec...
[2016-05-27 09:25:42,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:42,982 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:42,982 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:42,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:42,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:42,983 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:42,983 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:42,983 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:43,015 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:43,015 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:43,016 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.5160285472920627 6.8527611284207905
[2016-05-27 09:25:43,016 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:43,016 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.864495054408046
[2016-05-27 09:25:43,016 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:43,016 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:43,016 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:43,016 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:43,016 DEBUG Engine] Iteration took 0.035 sec, sleeping for 0.965 sec...
[2016-05-27 09:25:43,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:43,982 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:43,982 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:43,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:43,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:43,983 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:43,983 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:43,983 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:43,993 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:43,993 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:43,993 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.2547875400673954 6.85274699967186
[2016-05-27 09:25:43,993 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:43,993 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.864495054408046
[2016-05-27 09:25:43,993 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:43,993 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:43,993 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:43,993 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:43,993 DEBUG Engine] Iteration took 0.012 sec, sleeping for 0.988 sec...
[2016-05-27 09:25:44,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:44,982 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:44,982 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:44,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:44,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:44,983 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:44,983 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:44,983 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:44,990 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:44,990 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:44,992 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.852845900914377
[2016-05-27 09:25:44,992 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:44,992 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.7716302741750123 6.860630841575398
[2016-05-27 09:25:44,992 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:44,993 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:44,993 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:44,993 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:44,993 DEBUG Engine] Iteration took 0.011 sec, sleeping for 0.989 sec...
[2016-05-27 09:25:45,982 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:45,982 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:45,982 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:45,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:45,983 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:45,983 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:45,983 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:45,983 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:46,009 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:46,010 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:46,010 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.1314816336592982 6.852909480284567
[2016-05-27 09:25:46,010 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:46,010 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.860758000315777
[2016-05-27 09:25:46,012 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:46,012 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:46,012 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:46,012 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:46,012 DEBUG Engine] Iteration took 0.030 sec, sleeping for 0.970 sec...
[2016-05-27 09:25:46,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:46,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:46,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:46,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:46,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:46,993 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:46,994 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:46,994 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:47,036 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:47,036 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:47,036 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.852909480284567
[2016-05-27 09:25:47,036 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:47,038 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.8607438715668465
[2016-05-27 09:25:47,038 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:47,038 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:47,038 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:47,039 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:47,039 DEBUG Engine] Iteration took 0.046 sec, sleeping for 0.954 sec...
[2016-05-27 09:25:47,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:47,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:47,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:47,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:47,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:47,993 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:47,994 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:47,994 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:48,002 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:48,002 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:48,002 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.38625904010519396 6.852591583433618
[2016-05-27 09:25:48,003 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:48,003 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.860616712826467
[2016-05-27 09:25:48,003 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:48,003 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:48,003 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:48,003 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:48,003 DEBUG Engine] Iteration took 0.011 sec, sleeping for 0.989 sec...
[2016-05-27 09:25:48,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:48,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:48,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:48,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:48,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:48,994 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:48,994 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:48,994 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:49,035 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:49,035 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:49,035 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.852591583433618
[2016-05-27 09:25:49,035 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:49,036 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.26294165981922757 6.860609648452002
[2016-05-27 09:25:49,036 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:49,036 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:49,036 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:49,036 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:49,036 DEBUG Engine] Iteration took 0.043 sec, sleeping for 0.957 sec...
[2016-05-27 09:25:49,994 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:49,996 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:49,996 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:49,999 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:49,999 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:49,999 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:49,999 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:49,999 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:50,013 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:50,013 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:50,013 DEBUG Engine.monitoring.ServerAgentClient] Data line: 1.1587771203155819 6.852598647808083
[2016-05-27 09:25:50,013 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:50,013 DEBUG Engine.monitoring.ServerAgentClient] Data line: 1.142528357718231 6.860793322188105
[2016-05-27 09:25:50,013 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:50,013 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:50,013 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:50,013 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:50,013 DEBUG Engine] Iteration took 0.019 sec, sleeping for 0.981 sec...
[2016-05-27 09:25:50,994 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:50,994 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:50,994 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:50,996 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:50,996 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:50,996 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:50,996 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:50,996 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:51,003 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:51,005 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:51,005 DEBUG Engine.monitoring.ServerAgentClient] Data line: 1.6600920447074292 6.852556261561291
[2016-05-27 09:25:51,005 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:51,005 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:51,006 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:51,006 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:51,006 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:51,006 DEBUG Engine] Iteration took 0.011 sec, sleeping for 0.989 sec...
[2016-05-27 09:25:51,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:51,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:51,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:51,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:51,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:51,994 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:51,994 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:51,994 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:52,002 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:52,002 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:52,002 DEBUG Engine.monitoring.ServerAgentClient] Data line: 1.5368178829717292 6.852803514667584
[2016-05-27 09:25:52,002 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:52,003 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.8958658666885839 6.860885159056157
[2016-05-27 09:25:52,003 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.86084983718383
[2016-05-27 09:25:52,003 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:52,003 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:52,003 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:52,003 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:52,003 DEBUG Engine] Iteration took 0.010 sec, sleeping for 0.990 sec...
[2016-05-27 09:25:52,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:52,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:52,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:52,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:52,994 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:52,994 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:52,994 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:52,994 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:53,002 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:53,003 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:53,003 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.7725180802103879 6.854075102071381
[2016-05-27 09:25:53,003 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:53,003 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.860885159056157
[2016-05-27 09:25:53,003 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:53,003 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:53,003 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:53,003 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:53,005 DEBUG Engine] Iteration took 0.011 sec, sleeping for 0.989 sec...
[2016-05-27 09:25:53,993 DEBUG Engine] Checking <bzt.modules.provisioning.Local object at 0x02485E70>
[2016-05-27 09:25:53,993 DEBUG Engine] Checking <bzt.modules.aggregator.ConsolidatingAggregator object at 0x02485890>
[2016-05-27 09:25:53,993 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:53,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:53,993 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:53,993 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:53,993 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:53,993 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x0249BDF0>
[2016-05-27 09:25:54,000 DEBUG Engine] Checking <bzt.modules.monitoring.Monitoring object at 0x024D8F50>
[2016-05-27 09:25:54,000 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33B0>] / [<socket._socketobject object at 0x024D33B0>] / []
[2016-05-27 09:25:54,000 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.6328073635765943 6.855007599500832
[2016-05-27 09:25:54,000 DEBUG Engine.monitoring.ServerAgentClient] Stream states: [<socket._socketobject object at 0x024D33E8>] / [<socket._socketobject object at 0x024D33E8>] / []
[2016-05-27 09:25:54,000 DEBUG Engine.monitoring.ServerAgentClient] Data line: 0.0 6.860885159056157
[2016-05-27 09:25:54,002 DEBUG Engine] Checking <bzt.modules.reporting.FinalStatus object at 0x0261AA10>
[2016-05-27 09:25:54,002 DEBUG Engine] Checking <bzt.modules.console.ConsoleStatusReporter object at 0x0261A890>
[2016-05-27 09:25:54,002 DEBUG Engine] Checking <bzt.modules.blazemeter.BlazeMeterUploader object at 0x0261AB50>
[2016-05-27 09:25:54,002 DEBUG Engine.blazemeter] KPI bulk buffer len: 0
[2016-05-27 09:25:54,007 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:25:54,065 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:25:54,066 INFO Engine] Shutting down...
[2016-05-27 09:25:54,068 DEBUG Engine.local] Shutdown jmeter/CardConnect_Services_V01.jmx
[2016-05-27 09:25:54,068 DEBUG Engine.console] No logger_handler or orig_stream was detected
[2016-05-27 09:25:54,068 DEBUG Engine.monitoring.ServerAgentClient] Closing connection with
172.25.62.15:4444[2016-05-27 09:25:54,069 DEBUG Engine.monitoring.ServerAgentClient] Closing connection with
172.25.62.16:4444[2016-05-27 09:25:54,075 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:25:54,134 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:25:54,137 INFO Engine] Post-processing...
[2016-05-27 09:25:54,138 DEBUG Engine.local] Post-process jmeter/CardConnect_Services_V01.jmx
[2016-05-27 09:25:54,141 ERROR Engine] Error while post-processing: Traceback (most recent call last):
RuntimeWarning: Empty results JTL, most likely JMeter failed: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:54,141 DEBUG Engine.jmeter.JTLErrorsReader] File not exists: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\error.jtl
[2016-05-27 09:25:54,141 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] File not appeared yet: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:25:54,141 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader] No data to start reading yet
[2016-05-27 09:25:54,141 DEBUG Engine.jmeter.JTLReader] Buffer len: 0
[2016-05-27 09:25:54,141 DEBUG Engine.consolidator] Consolidator buffer[0]: []
[2016-05-27 09:25:54,142 INFO Engine.final_stats] Test duration: 0:00:15
[2016-05-27 09:25:54,142 DEBUG Engine.console] No logger_handler or orig_stream was detected
[2016-05-27 09:25:54,142 DEBUG BlazeMeterClient] Request: POST
https://data.blazemeter.com/submit.php?session_id=r-ext-574858e489dd6&signature=c0b3fe57890c77ea6e60a6d4b4e34a59&test_id=5207924&user_id=151343&pq=0&target=labels_bulk&update=1 {
"sourceID": 39955504,
"labels": [],
"final": true
}
[2016-05-27 09:25:54,947 DEBUG BlazeMeterClient] Response: {"api_version":2,"error":null,"result":{"session":{"_id":"r-ext-574858e489dd6","name":"Taurus Test","statusCode":15,"status":"INITIALIZING"}}}
[2016-05-27 09:25:54,948 INFO Engine.blazemeter] Uploading all artifacts as jtls_and_more.zip ...
[2016-05-27 09:25:55,371 DEBUG BlazeMeterClient] Request: POST
https://a.blazemeter.com/api/latest/image/r-ext-574858e489dd6/files?signature=c0b3fe57890c77ea6e60a6d4b4e34a59 --===============0633525686==
Content-Disposition: file; name="file"; filename="jtls_and_more.zip"
Content-Type: application/zip
PK :K»H@7¼3Y lµ bzt.logå]ûoÛH’þy ˜ÿ¡¡ÃÅÉ l¾)Œwá8ɬsy!öÌì^d ”Ô’™P$ÃG O ûÛ¯ªI=Ù¤I‰’mœ Ø õUWWW}ÕÝ ?È Õ;’Ö‘
"Y
[2016-05-27 09:25:56,655 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": [
"jtls_and_more.zip"
]
}
[2016-05-27 09:25:56,657 INFO Engine.blazemeter] Uploading C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\jmeter.log
[2016-05-27 09:25:56,657 DEBUG BlazeMeterClient] Request: POST
https://a.blazemeter.com/api/latest/image/r-ext-574858e489dd6/files?signature=c0b3fe57890c77ea6e60a6d4b4e34a59 --===============0436931634==
Content-Disposition: file; name="file"; filename="jmeter.log"
Content-Type: application/octet-stream
2016/05/27 09:25:41 INFO - jmeter.util.JMeterUtils: Setting Locale to en_US
2016/05/27 09:25:41 INFO - jmeter.JMeter:
[2016-05-27 09:25:57,782 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": [
"jmeter.log"
]
}
[2016-05-27 09:25:57,782 DEBUG Engine.blazemeter] Set last check time to: 1464359137.42
[2016-05-27 09:25:57,782 INFO BlazeMeterClient] Ending data feeding...
[2016-05-27 09:25:57,783 DEBUG BlazeMeterClient] Request: GET
https://a.blazemeter.com/api/latest/sessions/r-ext-574858e489dd6/terminate None
[2016-05-27 09:25:58,526 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": {
"success": true,
"session": {
"id": "r-ext-574858e489dd6",
"name": "Taurus Test",
"userId": 151343,
"offset": 0,
"statusC
[2016-05-27 09:25:58,526 DEBUG BlazeMeterClient] Request: GET
https://a.blazemeter.com/api/latest/sessions/r-ext-574858e489dd6 None
[2016-05-27 09:25:59,335 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": {
"id": "r-ext-574858e489dd6",
"name": "Taurus Test",
"userId": 151343,
"offset": 0,
"statusCode": 140,
"status": "ENDED",
"ended": 1464359158,
[2016-05-27 09:25:59,336 DEBUG BlazeMeterClient] Request: PUT
https://a.blazemeter.com/api/latest/sessions/r-ext-574858e489dd6 {
"note": "RuntimeWarning: Empty results JTL, most likely JMeter failed: C:\\jmeter\\Jmeter-Taurus\\Jenkins\\CardConnect_1605270925\\kpi.jtl"
}
[2016-05-27 09:26:00,002 DEBUG BlazeMeterClient] Response: {
"api_version": 2,
"error": null,
"result": {
"id": "r-ext-574858e489dd6",
"name": "Taurus Test",
"userId": 151343,
"offset": 0,
"statusCode": 140,
"status": "ENDED",
"ended": 1464359158,
[2016-05-27 09:26:00,002 INFO Engine.blazemeter] Online report link:
https://a.blazemeter.com/app/#reports/r-ext-574858e489dd6[2016-05-27 09:26:00,007 DEBUG Engine.Configuration] Dumping YAML config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.yml
[2016-05-27 09:26:00,072 DEBUG Engine.Configuration] Dumping JSON config into C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\effective.json
[2016-05-27 09:26:00,075 DEBUG Engine] Exception in post-process: Empty results JTL, most likely JMeter failed: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:26:00,075 WARNING Engine] Failed post-processing
[2016-05-27 09:26:00,076 DEBUG root] Caught exception in finally: Traceback (most recent call last):
File "c:\python27\lib\site-packages\bzt\cli.py", line 178, in perform
self.engine.post_process()
File "c:\python27\lib\site-packages\bzt\engine.py", line 228, in post_process
raise exception
RuntimeWarning: Empty results JTL, most likely JMeter failed: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:26:00,076 ERROR root] RuntimeWarning: Empty results JTL, most likely JMeter failed: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925\kpi.jtl
[2016-05-27 09:26:00,078 INFO root] Artifacts dir: C:\jmeter\Jmeter-Taurus\Jenkins\CardConnect_1605270925
[2016-05-27 09:26:00,078 WARNING root] Done performing with code: 1
[2016-05-27 09:26:00,078 DEBUG root] Closing log handler: C:\Python27\Scripts\bzt.log
------------------------------------------
Jmeter Log
-------------------------------------
2016/05/27 09:25:41 INFO - jmeter.util.JMeterUtils: Setting Locale to en_US
2016/05/27 09:25:41 INFO - jmeter.JMeter: Loading user properties from: C:\Windows\System32\config\systemprofile\.bzt\jmeter-taurus\bin\user.properties
2016/05/27 09:25:41 INFO - jmeter.JMeter: Loading system properties from: C:\Windows\System32\config\systemprofile\.bzt\jmeter-taurus\bin\system.properties
2016/05/27 09:25:41 INFO - jmeter.JMeter: Copyright (c) 1998-2015 The Apache Software Foundation
2016/05/27 09:25:41 INFO - jmeter.JMeter: Version 2.13 r1665067
2016/05/27 09:25:41 INFO - jmeter.JMeter: java.version=1.8.0_73
2016/05/27 09:25:41 INFO - jmeter.JMeter:
java.vm.name=Java HotSpot(TM) Client VM
2016/05/27 09:25:41 INFO - jmeter.JMeter:
os.name=Windows 7
2016/05/27 09:25:41 INFO - jmeter.JMeter: os.arch=x86
2016/05/27 09:25:41 INFO - jmeter.JMeter: os.version=6.1
2016/05/27 09:25:41 INFO - jmeter.JMeter: file.encoding=Cp1252
2016/05/27 09:25:41 INFO - jmeter.JMeter: Default Locale=English (United States)
2016/05/27 09:25:41 INFO - jmeter.JMeter: JMeter Locale=English (United States)
2016/05/27 09:25:41 INFO - jmeter.JMeter: JMeterHome=C:\Windows\System32\config\systemprofile\.bzt\jmeter-taurus
2016/05/27 09:25:41 INFO - jmeter.JMeter: user.dir =C:\Python27\Scripts
2016/05/27 09:25:41 INFO - jmeter.JMeter: PWD =C:\Python27\Scripts
2016/05/27 09:25:41 INFO - jmeter.JMeter: IP: 172.18.40.242 Name: R9P7V0P FullName:
R9P7V0P.corporate.act.org 2016/05/27 09:25:41 INFO - jmeter.JMeter: user.classpath=C:/jmeter/Jmeter-Taurus/Jenkins/CardConnect_1605270925
2016/05/27 09:25:41 INFO - jmeter.JMeter: Adding to classpath and loader: C:/jmeter/Jmeter-Taurus/Jenkins/CardConnect_1605270925
2016/05/27 09:25:41 INFO - jmeter.services.FileServer: Default base='C:\Python27\Scripts'
2016/05/27 09:25:41 INFO - jmeter.services.FileServer: Set new base='C:\jmeter\apache-jmeter-3.0\apache-jmeter-3.0\bin'
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: Testplan (JMX) version: 2.2. Testlog (JTL) version: 2.2
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: Using SaveService properties file encoding UTF-8
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: Using SaveService properties file version 1656252
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: Using SaveService properties version 2.8
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: All converter versions present and correct
2016/05/27 09:25:42 INFO - jmeter.save.SaveService: Loading file: C:\jmeter\apache-jmeter-3.0\apache-jmeter-3.0\bin\modified_CardConnect_Services_V01.jmx
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Cannot find .className property for htmlParser, using default
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Parser for text/html is
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Parser for application/xhtml+xml is
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Parser for application/xml is
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Parser for text/xml is
2016/05/27 09:25:42 INFO - jmeter.protocol.http.sampler.HTTPSamplerBase: Parser for text/vnd.wap.wml is org.apache.jmeter.protocol.http.parser.RegexpHTMLParser
2016/05/27 09:25:43 INFO - jmeter.engine.DistributedRunner: Configuring remote engine: 172.25.62.15
2016/05/27 09:25:44 INFO - jmeter.engine.DistributedRunner: Configuring remote engine: 172.25.62.16
2016/05/27 09:25:45 INFO - jmeter.engine.DistributedRunner: Starting remote engines
2016/05/27 09:25:45 INFO - jmeter.engine.DistributedRunner: Starting the test @ Fri May 27 09:25:45 CDT 2016 (1464359145562)
2016/05/27 09:25:45 INFO - jmeter.engine.ClientJMeterEngine: running clientengine run method
2016/05/27 09:25:45 INFO - jmeter.engine.util.CompoundVariable: Note: Function class names must contain the string: '.functions.'
2016/05/27 09:25:45 INFO - jmeter.engine.util.CompoundVariable: Note: Function class names must not contain the string: '.gui.'
2016/05/27 09:25:45 INFO - jmeter.samplers.SampleEvent: List of sample_variables: []
2016/05/27 09:25:46 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:46 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:48 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:51 ERROR - jmeter.engine.ClientJMeterEngine: Error in rconfigure() method java.rmi.UnmarshalException: Error unmarshaling return; nested exception is:
java.net.SocketException: Connection reset
2016/05/27 09:25:51 INFO - jmeter.engine.ClientJMeterEngine: Interrupting RMI Reaper
2016/05/27 09:25:51 INFO - jmeter.engine.ClientJMeterEngine: running clientengine run method
2016/05/27 09:25:51 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:51 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:51 INFO - jmeter.samplers.DataStrippingSampleSender: Using DataStrippingSampleSender for this run
2016/05/27 09:25:53 ERROR - jmeter.engine.ClientJMeterEngine: Error in rconfigure() method java.rmi.UnmarshalException: Error unmarshaling return; nested exception is:
java.net.SocketException: Connection reset
2016/05/27 09:25:53 INFO - jmeter.engine.DistributedRunner: Remote engines have been started