[2017-08-23 13:34:00,782 INFO root] Taurus CLI Tool v1.9.5
[2017-08-23 13:34:00,792 DEBUG root] Command-line options: {'aliases': ['report'], 'verbose': None, 'option': None, 'log': 'C:\\Users\\vsadh\\AppData\\Local\\Temp\\bzt_k1ijsk2y.log', 'no_system_configs': None, 'quiet': None}
[2017-08-23 13:34:00,792 DEBUG root] Python: CPython 3.5.3
[2017-08-23 13:34:00,792 DEBUG root] OS: uname_result(system='Windows', node='299-R90HLL8S', release='7', version='6.1.7601', machine='AMD64', processor='Intel64 Family 6 Model 60 Stepping 3, GenuineIntel')
[2017-08-23 13:34:00,792 DEBUG root] Adding JMX shorthand config for: ['GHRN_POC.jmx']
[2017-08-23 13:34:00,792 DEBUG root] Dumping JSON config into C:\Users\vsadh\AppData\Local\Temp\jmx_h4hejaod.json
[2017-08-23 13:34:00,802 INFO root] Starting with configs: ['C:\\Users\\vsadh\\AppData\\Local\\Temp\\jmx_h4hejaod.json']
[2017-08-23 13:34:00,802 DEBUG root] Using personal config: C:\Users\vsadh\.bzt-rc
[2017-08-23 13:34:00,802 INFO Engine] Configuring...
[2017-08-23 13:34:00,802 DEBUG Engine] No machine configs dir: C:\etc\bzt.d
[2017-08-23 13:34:00,802 DEBUG Engine.Configuration] Configs: ['C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\resources\\base-config.yml']
[2017-08-23 13:34:00,812 DEBUG Engine.Configuration] Reading C:\Program Files\Python35\lib\site-packages\bzt\resources\base-config.yml as YAML
[2017-08-23 13:34:00,872 DEBUG Engine.Configuration] Configs: ['C:\\Users\\vsadh\\.bzt-rc', 'C:\\Users\\vsadh\\AppData\\Local\\Temp\\jmx_h4hejaod.json']
[2017-08-23 13:34:00,872 DEBUG Engine.Configuration] Reading C:\Users\vsadh\.bzt-rc as YAML
[2017-08-23 13:34:00,892 DEBUG Engine.Configuration] Reading C:\Users\vsadh\AppData\Local\Temp\jmx_h4hejaod.json as YAML
[2017-08-23 13:34:00,892 DEBUG Engine.Configuration] Configs: ['C:\\Users\\vsadh\\.bzt-rc', 'C:\\Users\\vsadh\\AppData\\Local\\Temp\\jmx_h4hejaod.json']
[2017-08-23 13:34:00,892 DEBUG Engine.Configuration] Reading C:\Users\vsadh\.bzt-rc as YAML
[2017-08-23 13:34:00,912 DEBUG Engine.Configuration] Reading C:\Users\vsadh\AppData\Local\Temp\jmx_h4hejaod.json as YAML
[2017-08-23 13:34:00,912 DEBUG Engine] Using proxy settings: SplitResult(scheme='http', netloc='
webproxy.igslb.allstate.com:8080', path='', query='', fragment='')
[2017-08-23 13:34:00,922 INFO Engine] Artifacts dir: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669
[2017-08-23 13:34:00,972 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\effective
[2017-08-23 13:34:00,982 DEBUG Engine.Configuration] Dumping YAML config into C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\effective.yml
[2017-08-23 13:34:01,013 DEBUG Engine.Configuration] Dumping JSON config into C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\effective.json
[2017-08-23 13:34:01,033 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\merged.yml
[2017-08-23 13:34:01,033 DEBUG Engine.Configuration] Dumping YAML config into C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\merged.yml
[2017-08-23 13:34:01,043 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\merged.json
[2017-08-23 13:34:01,043 DEBUG Engine.Configuration] Dumping JSON config into C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\merged.json
[2017-08-23 13:34:01,043 DEBUG Engine] Add existing artifact (move=False): C:\Users\vsadh\AppData\Local\Temp\jmx_h4hejaod.json
[2017-08-23 13:34:01,043 DEBUG Engine] Copying C:\Users\vsadh\AppData\Local\Temp\jmx_h4hejaod.json to C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\jmx_h4hejaod.json
[2017-08-23 13:34:01,053 DEBUG root] Closing log handler: C:\Users\vsadh\AppData\Local\Temp\bzt_k1ijsk2y.log
[2017-08-23 13:34:01,063 DEBUG root] Switched writing logs to C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\bzt.log
[2017-08-23 13:34:01,063 INFO Engine] Preparing...
[2017-08-23 13:34:01,063 DEBUG Engine] Module config: consolidator defaultdict(None, {'class': 'bzt.modules.aggregator.ConsolidatingAggregator'})
[2017-08-23 13:34:01,063 DEBUG root] Importing module: bzt.modules.aggregator
[2017-08-23 13:34:01,083 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\aggregator.py'>
[2017-08-23 13:34:01,083 DEBUG Engine.consolidator] Exception in dehumanize_time(inf)
[2017-08-23 13:34:01,083 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
[2017-08-23 13:34:01,083 DEBUG Engine] Module config: monitoring defaultdict(None, {'class': 'bzt.modules.monitoring.Monitoring'})
[2017-08-23 13:34:01,083 DEBUG root] Importing module: bzt.modules.monitoring
[2017-08-23 13:34:01,213 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\monitoring.py'>
[2017-08-23 13:34:01,213 DEBUG Engine] Module config: local defaultdict(None, {'class': 'bzt.modules.provisioning.Local'})
[2017-08-23 13:34:01,213 DEBUG root] Importing module: bzt.modules.provisioning
[2017-08-23 13:34:01,213 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\provisioning.py'>
[2017-08-23 13:34:01,213 DEBUG Engine] Module config: jmeter defaultdict(None, {'properties': defaultdict(None, {'jmeter.save.saveservice.autoflush': 'true', 'jmeter.save.saveservice.connect_time': 'true', 'mode': 'Stripped', '
summariser.name': '', 'jmeterengine.force.system.exit': 'true'}), 'plugins': ['jpgc-casutg', 'jpgc-dummy', 'jpgc-ffw', 'jpgc-fifo', 'jpgc-functions', 'jpgc-json', 'jpgc-perfmon', 'jpgc-prmctl', 'jpgc-tst'], 'class': 'bzt.modules.jmeter.JMeterExecutor', 'path': 'C:\\jmeter\\3.2\\apache-jmeter-3.2'})
[2017-08-23 13:34:01,213 DEBUG root] Importing module: bzt.modules.jmeter
[2017-08-23 13:34:01,263 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\jmeter.py'>
[2017-08-23 13:34:01,263 DEBUG Engine.local] Preparing executor: jmeter/72234880
[2017-08-23 13:34:01,263 DEBUG Engine.jmeter] Extract defaultdict(None, {'script': 'GHRN_POC.jmx'}) into scenarios
[2017-08-23 13:34:01,263 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\jmeter.log
[2017-08-23 13:34:01,263 DEBUG Engine.jmeter] Checking if port 4445 is free
[2017-08-23 13:34:01,273 DEBUG Engine.jmeter] Port 4445 is free
[2017-08-23 13:34:01,273 DEBUG Engine.jmeter] Using port 4445 for management
[2017-08-23 13:34:01,273 DEBUG Engine.jmeter.JavaVM] Trying JavaVM: ['java', '-version']
[2017-08-23 13:34:01,484 DEBUG Engine] Taurus updates info: {"latest":"1.9.5","needsUpgrade":false}
[2017-08-23 13:34:01,484 DEBUG Engine] Installation is up-to-date
[2017-08-23 13:34:01,650 DEBUG Engine.jmeter.JavaVM] JavaVM output: b'java version "1.8.0_141"\r\nJava(TM) SE Runtime Environment (build 1.8.0_141-b15)\r\nJava HotSpot(TM) Client VM (build 25.141-b15, mixed mode)\r\n'
[2017-08-23 13:34:01,650 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment
[2017-08-23 13:34:01,650 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is not present
[2017-08-23 13:34:01,660 DEBUG Engine.jmeter.TclLibrary] Tcl directory was found: C:\Program Files\Python35\tcl\tcl8.6
[2017-08-23 13:34:01,660 DEBUG Engine.jmeter.TclLibrary] Setting environment TCL_LIBRARY=C:\Program Files\Python35\tcl\tcl8.6
[2017-08-23 13:34:01,660 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment
[2017-08-23 13:34:01,660 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present
[2017-08-23 13:34:01,660 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\jmeter\3.2\apache-jmeter-3.2\bin\jmeter.bat
[2017-08-23 13:34:01,660 DEBUG bzt.utils] Executing shell: ['C:\\jmeter\\3.2\\apache-jmeter-3.2\\bin\\jmeter.bat', '-j', 'C:\\Users\\vsadh\\AppData\\Local\\Temp\\jmeter_pjoyzvclog', '--version']
[2017-08-23 13:34:04,696 DEBUG Engine.jmeter.JMeter] JMeter check: b' _ ____ _ ____ _ _ _____ _ __ __ _____ _____ _____ ____ \n / \\ | _ \\ / \\ / ___| | | | ____| | | \\/ | ____|_ _| ____| _ \\ \n / _ \\ | |_) / _ \\| | | |_| | _| _ | | |\\/| | _| | | | _| | |_) | \n / ___ \\| __/ ___ \\ |___| _ | |___ | |_| | | | | |___ | | | |___| _ < \n/_/ \\_\\_| /_/ \\_\\____|_| |_|_____| \\___/|_| |_|_____| |_| |_____|_| \\_\\ 3.2 r1790748 \n\nCopyright (c) 1999-2017 The Apache Software Foundation\n\r\n' / None
[2017-08-23 13:34:04,706 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=None, throughput=None, ramp_up=None, hold=0, iterations=None, duration=0, steps=None)
[2017-08-23 13:34:04,726 DEBUG Engine.jmeter.LoadSettingsProcessor] Thread group detection: duration not found, regular ThreadGroup will be used
[2017-08-23 13:34:04,726 DEBUG Engine.jmeter.LoadSettingsProcessor] No iterations/concurrency/duration found, thread group modification is skipped
[2017-08-23 13:34:04,726 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\kpi.jtl
[2017-08-23 13:34:04,726 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\error.jtl
[2017-08-23 13:34:04,726 DEBUG Engine.jmeter] Enforcing parent sample for transaction controller
[2017-08-23 13:34:04,736 DEBUG JMX] Saving JMX to: C:\jmeter\3.2\apache-jmeter-3.2\bin\modified_GHRN_POC-2.jmx
[2017-08-23 13:34:04,746 DEBUG Engine.jmeter] Additional properties: defaultdict(None, {'jmeter.save.saveservice.timestamp_format': 'ms', 'user.classpath': 'C:/Users/vsadh/bzt-artifacts/2017-08-23_13-34-00.922669', 'sampleresult.default.encoding': 'UTF-8', 'jmeterengine.nongui.port': 4445, 'jmeter.save.saveservice.connect_time': 'true', 'jmeterengine.nongui.maxport': 4445, 'jmeter.save.saveservice.autoflush': 'true', 'jmeterengine.force.system.exit': 'true', 'mode': 'Stripped', '
summariser.name': ''})
[2017-08-23 13:34:04,746 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\jmeter-bzt.properties
[2017-08-23 13:34:04,746 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\jmeter.out
[2017-08-23 13:34:04,746 DEBUG Engine] New artifact filename: C:\Users\vsadh\bzt-artifacts\2017-08-23_13-34-00.922669\jmeter.err
[2017-08-23 13:34:04,756 DEBUG Engine] Module config: final-stats defaultdict(None, {'class': 'bzt.modules.reporting.FinalStatus'})
[2017-08-23 13:34:04,756 DEBUG root] Importing module: bzt.modules.reporting
[2017-08-23 13:34:05,116 DEBUG easyprocess] version=0.2.3
[2017-08-23 13:34:05,136 DEBUG pyvirtualdisplay] version=0.2.1
[2017-08-23 13:34:05,136 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\reporting.py'>
[2017-08-23 13:34:05,136 DEBUG Engine] Module config: console defaultdict(None, {'class': 'bzt.modules.console.ConsoleStatusReporter'})
[2017-08-23 13:34:05,136 DEBUG root] Importing module: bzt.modules.console
[2017-08-23 13:34:05,136 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\console.py'>
[2017-08-23 13:34:05,136 DEBUG Engine] Module config: blazemeter defaultdict(None, {'class': 'bzt.modules.blazemeter.BlazeMeterUploader'})
[2017-08-23 13:34:05,146 DEBUG root] Importing module: bzt.modules.blazemeter
[2017-08-23 13:34:05,146 DEBUG root] Loading class: 'BlazeMeterUploader' from <module 'bzt.modules.blazemeter' from 'C:\\Program Files\\Python35\\lib\\site-packages\\bzt\\modules\\blazemeter.py'>
[2017-08-23 13:34:05,146 DEBUG Engine.console] Can't use 'console' screen, trying 'gui'
[2017-08-23 13:34:05,156 WARNING Engine.blazemeter] No BlazeMeter API key provided, will upload anonymously
[2017-08-23 13:34:05,166 DEBUG urllib3.connectionpool] Starting new HTTPS connection (1):
a.blazemeter.com[2017-08-23 13:34:07,493 ERROR root] ProxyError: HTTPSConnectionPool(host='
a.blazemeter.com', port=443): Max retries exceeded with url: /api/v4/web/version (Caused by ProxyError('Cannot connect to proxy.', NewConnectionError('<urllib3.connection.VerifiedHTTPSConnection object at 0x0000000004629AC8>: Failed to establish a new connection: [Errno 11004] getaddrinfo failed',)))