Re: How to set corporate proxy for JMeter

Message has been deleted

Dmitri Pribysh

unread,

Sep 6, 2018, 4:37:19 AM9/6/18

to codenam...@googlegroups.com

Hi,

Can you show `effective.yml` and `bzt.log` from unsuccessful runs?

Dimitri

On 09/05/2018 06:51 PM, amitsk...@gmail.com wrote:
> Hi
>
> I have a yaml file where I give local Jmeter path to run the taurus
> like below. But all my requests are timed out because JMeter requires
> corporate proxy. I have set proxy in .bzt-rc file in General settings
> section.
>
> execution:
> - concurrency: 10
> ramp-up: 1m
> hold-for: 5m
> scenario: quick-test
>
> modules:
> jmeter:
> path: C:\dev\jmeter\3.1 #jmeter path
> scenarios:
> quick-test:
> requests:
> - http://blazedemo.com
>
> Regards,
> Amit
> --
> You received this message because you are subscribed to the Google
> Groups "codename-taurus" group.
> To unsubscribe from this group and stop receiving emails from it, send
> an email to codename-taur...@googlegroups.com
> <mailto:codename-taur...@googlegroups.com>.
> To view this discussion on the web visit
> https://groups.google.com/d/msgid/codename-taurus/d15152a8-d30a-4aa7-8834-89adc64715ff%40googlegroups.com
> <https://groups.google.com/d/msgid/codename-taurus/d15152a8-d30a-4aa7-8834-89adc64715ff%40googlegroups.com?utm_medium=email&utm_source=footer>.
> For more options, visit https://groups.google.com/d/optout.

Message has been deleted

Dmitri Pribysh

unread,

Sep 6, 2018, 8:24:16 AM9/6/18

to codenam...@googlegroups.com

Looks like Taurus has seen the proxy addres, but it wasn't able to parse it correctly.

Try to prepend 'http://' (or 'https://') to your proxy address.

On 09/06/2018 02:49 PM, amitsk...@gmail.com wrote:

Hi,

effective.yml is below:

---

cli:

linter:

disable: false

ignored-warnings: []

lint-and-exit: false

warn-on-unfamiliar-fields: false

cli-aliases:

cloud:

provisioning: cloud

detach:

modules:

cloud:

detach: true

func:

modules:

console:

disable: true

settings:

aggregator: functional-consolidator

gui:

modules:

jmeter:

gui: true

install-tools:

services:

- install-checker

lint:

cli:

linter:

lint-and-exit: true

local:

provisioning: local

locations:

modules:

cloud:

dump-locations: true

provisioning: cloud

nolint:

cli:

linter:

disable: true

public:

modules:

blazemeter:

public-report: true

report:

reporting:

- blazemeter

sequential:

modules:

local:

sequential: true

execution:

- concurrency:

local: 1

hold-for: 5m

ramp-up: 1m

scenario: quick-test

throughput:

local: null

included-configs: []

modules:

ab:

class: bzt.modules.ab.ApacheBenchmarkExecutor

android-emulator:

class: bzt.modules.services.AndroidEmulatorLoader

apiritif:

class: bzt.modules.python.ApiritifNoseExecutor

appium:

class: bzt.modules.services.AppiumLoader

blazemeter:

class: bzt.modules.blazemeter.BlazeMeterUploader

capturehar:

class: bzt.modules.blazemeter.ServiceStubCaptureHAR

cloud:

class: bzt.modules.blazemeter.CloudProvisioning

console:

class: bzt.modules.console.ConsoleStatusReporter

consolidator:

class: bzt.modules.aggregator.ConsolidatingAggregator

percentiles:

- 0.0

- 50.0

- 90.0

- 95.0

- 99.0

- 99.9

- 100.0

final-stats:

class: bzt.modules.reporting.FinalStatus

final_stats:

class: bzt.modules.reporting.FinalStatus

functional-consolidator:

class: bzt.modules.functional.FunctionalAggregator

gatling:

class: bzt.modules.gatling.GatlingExecutor

properties:

gatling.data.file.bufferSize: 256

grinder:

class: bzt.modules.grinder.GrinderExecutor

properties:

grinder.useConsole: false

install-checker:

class: bzt.modules.services.InstallChecker

jmeter:

class: bzt.modules.jmeter.JMeterExecutor

path: C:\dev\jmeter\3.1\bin\jmeter.bat

plugins:

- jpgc-casutg

- jpgc-dummy

- jpgc-ffw

- jpgc-fifo

- jpgc-functions

- jpgc-json

- jpgc-perfmon

- jpgc-prmctl

- jpgc-tst

properties:

jmeter.save.saveservice.autoflush: 'true'

jmeter.save.saveservice.connect_time: 'true'

jmeterengine.force.system.exit: 'true'

summariser.name: ''

protocol-handlers:

http: bzt.jmx.http.HTTPProtocolHandler

system-properties:

sun.net.inetaddr.ttl: 0

version: '4.0'

junit:

class: bzt.modules.java.JUnitTester

junit-xml:

class: bzt.modules.reporting.JUnitXMLReporter

local:

class: bzt.modules.provisioning.Local

locust:

class: bzt.modules.locustio.LocustIOExecutor

mocha:

class: bzt.modules.javascript.MochaTester

molotov:

class: bzt.modules.molotov.MolotovExecutor

monitoring:

class: bzt.modules.monitoring.Monitoring

newman:

class: bzt.modules.javascript.NewmanExecutor

nose:

class: bzt.modules.python.ApiritifNoseExecutor

nunit:

class: bzt.modules.csharp.NUnitExecutor

passfail:

class: bzt.modules.passfail.PassFailStatus

pbench:

class: bzt.modules.pbench.PBenchExecutor

proxy2jmx:

class: bzt.modules.proxy2jmx.Proxy2JMX

pytest:

class: bzt.modules.python.PyTestExecutor

robot:

class: bzt.modules.python.RobotExecutor

rspec:

class: bzt.modules.ruby.RSpecTester

screenshoter:

class: bzt.modules.blazemeter.ServiceStubScreenshoter

selenium:

class: bzt.modules.selenium.SeleniumExecutor

shellexec:

class: bzt.modules.shellexec.ShellExecutor

siege:

class: bzt.modules.siege.SiegeExecutor

testng:

class: bzt.modules.java.TestNGTester

tsung:

class: bzt.modules.tsung.TsungExecutor

unpacker:

class: bzt.modules.services.Unpacker

virtual-display:

class: bzt.modules.services.VirtualDisplay

wdio:

class: bzt.modules.javascript.WebdriverIOExecutor

provisioning: local

reporting:

- module: final-stats

- module: console

scenarios:

quick-test:

requests:

- url: http://blazedemo.com

services:

- local:

- metrics:

- cpu

- mem

- bytes-sent

- bytes-recv

- disk-read

- disk-write

- disk-space

- engine-loop

- conn-all

module: monitoring

settings:

aggregator: consolidator

default-executor: jmeter

env:

OBJC_DISABLE_INITIALIZE_FORK_SAFETY: 'YES'

TAURUS_ARTIFACTS_DIR: C:\dev\python\Scripts\2018-09-06_19-33-22.631000

proxy:

address: bc-proxy.rtdomau.local:8080

version: 1.12.1

bzt.log is below:

[2018-09-06 19:33:22,561 INFO root] Taurus CLI Tool v1.12.1

[2018-09-06 19:33:22,565 DEBUG root] Command-line options: {'verbose': None, 'no_system_configs': None, 'quiet': None, 'log': 'c:\\users\\bb84364\\appdata\\local\\temp\\bzt_fevnti.log', 'option': None, 'aliases': []}

[2018-09-06 19:33:22,565 DEBUG root] Python: CPython 2.7.9

[2018-09-06 19:33:22,565 DEBUG root] OS: ('Windows', 'VDG10063233', '8', '6.2.9200', 'AMD64', 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel')

[2018-09-06 19:33:22,566 INFO root] Starting with configs: ['.\\quicktest.yml']

[2018-09-06 19:33:22,572 DEBUG root] Using personal config: C:\Users\bb84364\.bzt-rc

[2018-09-06 19:33:22,572 INFO Engine] Configuring...

[2018-09-06 19:33:22,576 DEBUG Engine] No machine configs dir: c:\etc\bzt.d

[2018-09-06 19:33:22,576 DEBUG Engine] Base configs list: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-06 19:33:22,576 DEBUG Engine.Configuration] Configs: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-06 19:33:22,576 DEBUG Engine.Configuration] Reading c:\dev\python\lib\site-packages\bzt\resources\base-config.yml as YAML

[2018-09-06 19:33:22,605 DEBUG Engine] User configs list: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-06 19:33:22,605 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-06 19:33:22,607 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-06 19:33:22,611 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-06 19:33:22,614 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-06 19:33:22,615 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-06 19:33:22,621 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-06 19:33:22,625 INFO HTTPClient] Using proxy 'bc-proxy.rtdomau.local:8080'

[2018-09-06 19:33:22,630 DEBUG HTTPClient] Using proxy settings: SplitResult(scheme='', netloc='', path='bc-proxy.rtdomau.local:8080', query='', fragment='')

[2018-09-06 19:33:22,631 DEBUG Engine] Requesting updates info: http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-06 19:33:22,631 INFO Engine] Artifacts dir: C:\dev\python\Scripts\2018-09-06_19-33-22.631000

[2018-09-06 19:33:22,631 DEBUG HTTPClient] Making HTTP request GET http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-06 19:33:22,641 DEBUG Engine] Failed to check for updates: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\engine.py", line 607, in _check_updates

response = client.request('GET', addr, timeout=10)

File "c:\dev\python\lib\site-packages\bzt\utils.py", line 989, in request

return self.session.request(method, url, *args, **kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 508, in request

resp = self.send(prep, **send_kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 618, in send

r = adapter.send(request, **kwargs)

File "c:\dev\python\lib\site-packages\requests\adapters.py", line 405, in send

conn = self.get_connection(request.url, proxies)

File "c:\dev\python\lib\site-packages\requests\adapters.py", line 304, in get_connection

conn = proxy_manager.connection_from_url(url)

File "c:\dev\python\lib\site-packages\urllib3\poolmanager.py", line 279, in connection_from_url

pool_kwargs=pool_kwargs)

File "c:\dev\python\lib\site-packages\urllib3\poolmanager.py", line 408, in connection_from_host

self.proxy.host, self.proxy.port, self.proxy.scheme, pool_kwargs=pool_kwargs)

File "c:\dev\python\lib\site-packages\urllib3\poolmanager.py", line 218, in connection_from_host

raise LocationValueError("No host specified.")

LocationValueError: No host specified.

[2018-09-06 19:33:22,641 WARNING Engine] Failed to check for updates

[2018-09-06 19:33:22,648 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective

[2018-09-06 19:33:22,650 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.yml

[2018-09-06 19:33:22,681 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.json

[2018-09-06 19:33:22,683 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\merged.yml

[2018-09-06 19:33:22,684 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\merged.yml

[2018-09-06 19:33:22,687 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\merged.json

[2018-09-06 19:33:22,687 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\merged.json

[2018-09-06 19:33:22,687 DEBUG Engine] Add existing artifact (move=False): .\quicktest.yml

[2018-09-06 19:33:22,688 DEBUG Engine] Copying .\quicktest.yml to C:\dev\python\Scripts\2018-09-06_19-33-22.631000\quicktest.yml

[2018-09-06 19:33:22,690 DEBUG Engine.Environment] Replace 'TAURUS_ARTIFACTS_DIR' in environment

[2018-09-06 19:33:22,690 DEBUG root] Closing log handler: c:\users\bb84364\appdata\local\temp\bzt_fevnti.log

[2018-09-06 19:33:22,693 DEBUG root] Switched writing logs to C:\dev\python\Scripts\2018-09-06_19-33-22.631000\bzt.log

[2018-09-06 19:33:22,693 DEBUG root] Linting config

[2018-09-06 19:33:22,696 INFO Engine] Preparing...

[2018-09-06 19:33:22,700 DEBUG Engine] Module config: consolidator defaultdict(None, {'class': u'bzt.modules.aggregator.ConsolidatingAggregator'})

[2018-09-06 19:33:22,700 DEBUG root] Importing module: bzt.modules.aggregator

[2018-09-06 19:33:22,851 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'c:\dev\python\lib\site-packages\bzt\modules\aggregator.pyc'>

[2018-09-06 19:33:22,851 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

[2018-09-06 19:33:22,851 DEBUG Engine] Module config: monitoring defaultdict(None, {'class': u'bzt.modules.monitoring.Monitoring'})

[2018-09-06 19:33:22,851 DEBUG root] Importing module: bzt.modules.monitoring

[2018-09-06 19:33:22,855 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'c:\dev\python\lib\site-packages\bzt\modules\monitoring.pyc'>

[2018-09-06 19:33:22,855 DEBUG Engine] Module config: local defaultdict(None, {'class': u'bzt.modules.provisioning.Local'})

[2018-09-06 19:33:22,855 DEBUG root] Importing module: bzt.modules.provisioning

[2018-09-06 19:33:22,855 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'c:\dev\python\lib\site-packages\bzt\modules\provisioning.pyc'>

[2018-09-06 19:33:22,855 DEBUG Engine] Module config: jmeter defaultdict(None, {'path': u'C:\\dev\\jmeter\\3.1', 'class': u'bzt.modules.jmeter.JMeterExecutor', 'protocol-handlers': defaultdict(None, {'http': u'bzt.jmx.http.HTTPProtocolHandler'}), 'properties': defaultdict(None, {'jmeter.save.saveservice.autoflush': u'true', 'jmeter.save.saveservice.connect_time': u'true', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true'}), 'plugins': [u'jpgc-casutg', u'jpgc-dummy', u'jpgc-ffw', u'jpgc-fifo', u'jpgc-functions', u'jpgc-json', u'jpgc-perfmon', u'jpgc-prmctl', u'jpgc-tst']})

[2018-09-06 19:33:22,855 DEBUG root] Importing module: bzt.modules.jmeter

[2018-09-06 19:33:22,875 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'c:\dev\python\lib\site-packages\bzt\modules\jmeter.pyc'>

[2018-09-06 19:33:22,875 DEBUG Engine.local] Preparing executor: None/43503176

[2018-09-06 19:33:22,875 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\jmeter.log

[2018-09-06 19:33:22,875 DEBUG Engine.jmeter] Checking if port 4445 is free

[2018-09-06 19:33:22,878 DEBUG Engine.jmeter] Port 4445 is free

[2018-09-06 19:33:22,878 DEBUG Engine.jmeter] Using port 4445 for management

[2018-09-06 19:33:22,878 DEBUG Engine.jmeter.JavaVM] Trying JavaVM: ['java', '-version']

[2018-09-06 19:33:23,092 DEBUG Engine.jmeter.JavaVM] JavaVM output: java version "1.8.0_144"

Java(TM) SE Runtime Environment (build 1.8.0_144-b01)

Java HotSpot(TM) 64-Bit Server VM (build 25.144-b01, mixed mode)

Picked up _JAVA_OPTIONS: -Xmx1024M

[2018-09-06 19:33:23,092 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment

[2018-09-06 19:33:23,092 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present

[2018-09-06 19:33:23,094 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\dev\jmeter\3.1\bin\jmeter.bat

[2018-09-06 19:33:23,094 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\jmeter.bat', '-j', 'c:\\users\\bb84364\\appdata\\local\\temp\\jmeterxnbtfelog', '--version'] at .

[2018-09-06 19:33:23,872 DEBUG Engine.jmeter.JMeter] JMeter check: Writing log file to: c:\users\bb84364\appdata\local\temp\jmeterxnbtfelog

_ ____ _ ____ _ _ _____ _ __ __ _____ _____ _____ ____

/ \ | _ \ / \ / ___| | | | ____| | | \/ | ____|_ _| ____| _ \

/ _ \ | |_) / _ \| | | |_| | _| _ | | |\/| | _| | | | _| | |_) |

/ ___ \| __/ ___ \ |___| _ | |___ | |_| | | | | |___ | | | |___| _ <

/_/ \_\_| /_/ \_\____|_| |_|_____| \___/|_| |_|_____| |_| |_____|_| \_\ 3.1 r1770033

Copyright (c) 1999-2016 The Apache Software Foundation

Picked up _JAVA_OPTIONS: -Xmx1024M

/ None

[2018-09-06 19:33:23,874 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\requests.jmx

[2018-09-06 19:33:23,875 DEBUG root] Importing module: bzt.jmx.http

[2018-09-06 19:33:23,875 DEBUG root] Loading class: 'HTTPProtocolHandler' from <module 'bzt.jmx.http' from 'c:\dev\python\lib\site-packages\bzt\jmx\http.pyc'>

[2018-09-06 19:33:23,875 DEBUG JMeterScenarioBuilder] Saving JMX to: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\requests.jmx

[2018-09-06 19:33:23,878 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=1, throughput=None, ramp_up=60.0, hold=300.0, iterations=0, duration=360.0, steps=None)

[2018-09-06 19:33:23,880 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\kpi.jtl

[2018-09-06 19:33:23,880 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\error.jtl

[2018-09-06 19:33:23,881 WARNING Engine.jmeter.LoadSettingsProcessor] Thread group detection: plugin for ConcurrentThreadGroup not found, regular ThreadGroup will be used

[2018-09-06 19:33:23,894 DEBUG Engine.jmeter.LoadSettingsProcessor.ThreadGroupHandler] Converting ThreadGroup (quick-test) to ThreadGroup and apply load parameters

[2018-09-06 19:33:23,894 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\modified_requests.jmx

[2018-09-06 19:33:23,894 DEBUG JMX] Saving JMX to: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\modified_requests.jmx

[2018-09-06 19:33:23,895 DEBUG Engine.jmeter] Additional properties: defaultdict(None, {'jmeter.save.saveservice.autoflush': u'true', 'jmeter.save.saveservice.connect_time': u'true', 'user.classpath': 'C:/dev/python/Scripts/2018-09-06_19-33-22.631000;C:/dev/python/Scripts/2018-09-06_19-33-22.631000', 'sampleresult.default.encoding': 'UTF-8', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true', 'jmeter.save.saveservice.timestamp_format': 'ms', 'jmeterengine.nongui.maxport': 4445, 'jmeterengine.nongui.port': 4445})

[2018-09-06 19:33:23,897 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\jmeter-bzt.properties

[2018-09-06 19:33:23,898 DEBUG Engine.jmeter] Additional system properties defaultdict(None, {'sun.net.inetaddr.ttl': 0})

[2018-09-06 19:33:23,898 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\system.properties

[2018-09-06 19:33:23,898 DEBUG Engine.jmeter.JMeter] Passing JVM_ARGS: '-Dhttp.proxyHost=None -Dhttp.proxyPort=80 -Dhttps.proxyHost=None -Dhttps.proxyPort=80'

[2018-09-06 19:33:23,898 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\PluginsManagerCMD.bat', 'install-for-jmx', 'C:\\dev\\python\\Scripts\\2018-09-06_19-33-22.631000\\modified_requests.jmx'] at .

[2018-09-06 19:33:23,900 WARNING Engine.jmeter.JMeter] Failed to detect plugins for C:\dev\python\Scripts\2018-09-06_19-33-22.631000\modified_requests.jmx: [Error 2] The system cannot find the file specified

[2018-09-06 19:33:23,917 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\jmeter.out

[2018-09-06 19:33:23,917 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\jmeter.err

[2018-09-06 19:33:23,917 DEBUG Engine] Module config: final-stats defaultdict(None, {'class': u'bzt.modules.reporting.FinalStatus'})

[2018-09-06 19:33:23,917 DEBUG root] Importing module: bzt.modules.reporting

[2018-09-06 19:33:23,941 DEBUG easyprocess] version=0.2.3

[2018-09-06 19:33:23,947 DEBUG pyvirtualdisplay] version=0.2.1

[2018-09-06 19:33:23,950 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'c:\dev\python\lib\site-packages\bzt\modules\reporting.pyc'>

[2018-09-06 19:33:23,950 DEBUG Engine] Module config: console defaultdict(None, {'class': u'bzt.modules.console.ConsoleStatusReporter'})

[2018-09-06 19:33:23,950 DEBUG root] Importing module: bzt.modules.console

[2018-09-06 19:33:23,950 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'c:\dev\python\lib\site-packages\bzt\modules\console.pyc'>

[2018-09-06 19:33:23,950 DEBUG Engine.console] Can't use 'console' screen, trying 'gui'

[2018-09-06 19:33:23,961 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.yml

[2018-09-06 19:33:23,994 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.json

[2018-09-06 19:33:23,996 INFO Engine] Starting...

[2018-09-06 19:33:24,000 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x000000000295FE10>

[2018-09-06 19:33:24,000 DEBUG Engine] Startup <bzt.modules.aggregator.ConsolidatingAggregator object at 0x0000000003582B38>

[2018-09-06 19:33:24,000 DEBUG Engine] Startup <bzt.modules.reporting.FinalStatus object at 0x0000000003E27390>

[2018-09-06 19:33:24,000 DEBUG Engine] Startup <bzt.modules.console.ConsoleStatusReporter object at 0x0000000003E573C8>

[2018-09-06 19:33:24,000 INFO Engine.console] Waiting for results...

[2018-09-06 19:33:24,005 DEBUG Engine] Startup <bzt.modules.provisioning.Local object at 0x0000000003582278>

[2018-09-06 19:33:24,005 DEBUG Engine.local] Delay setup for None/quick-test: 0(start-at) + 0(delay) = 0

[2018-09-06 19:33:24,007 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.yml

[2018-09-06 19:33:24,035 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.json

[2018-09-06 19:33:24,036 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-06 19:33:24,036 DEBUG root] Leveled up log file verbosity

[2018-09-06 19:33:24,039 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\jmeter.bat', '-n', '-t', 'C:\\dev\\python\\Scripts\\2018-09-06_19-33-22.631000\\modified_requests.jmx', '-j', 'C:\\dev\\python\\Scripts\\2018-09-06_19-33-22.631000\\jmeter.log', '-q', 'C:\\dev\\python\\Scripts\\2018-09-06_19-33-22.631000\\jmeter-bzt.properties', '-S', 'C:\\dev\\python\\Scripts\\2018-09-06_19-33-22.631000\\system.properties'] at C:\dev\python\Scripts

[2018-09-06 19:33:24,042 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-06 19:33:24,289 INFO Engine.console] Did not mute console logging

[2018-09-06 19:33:24,417 INFO Engine.console] Waiting for finish...

[2018-09-06 19:35:33,042 INFO Engine.jmeter.JTLReader] Changed data analysis delay to 126s

[2018-09-06 19:38:43,039 INFO Engine.jmeter.JTLReader] Changed data analysis delay to 127s

[2018-09-06 19:39:46,122 WARNING Engine] Please wait for graceful shutdown...

[2018-09-06 19:39:46,125 DEBUG root] Leveled up log file verbosity

[2018-09-06 19:39:46,125 INFO Engine] Shutting down...

[2018-09-06 19:39:46,127 DEBUG Engine] Current stop reason: None

[2018-09-06 19:39:46,127 DEBUG Engine.local] Shutdown None/quick-test

[2018-09-06 19:39:46,141 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-06 19:39:46,144 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.yml

[2018-09-06 19:39:46,173 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.json

[2018-09-06 19:39:46,174 INFO Engine] Post-processing...

[2018-09-06 19:39:46,177 DEBUG Engine.local] Post-process None/quick-test

[2018-09-06 19:39:46,177 DEBUG Engine] Add existing artifact (move=True): C:\dev\python\Scripts\2018-09-06_19-33-22.631000\modified_requests.jmx

[2018-09-06 19:39:46,177 DEBUG Engine] No need to copy C:\dev\python\Scripts\2018-09-06_19-33-22.631000\modified_requests.jmx

[2018-09-06 19:39:46,177 DEBUG Engine.jmeter.JTLErrorsReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\error.jtl

[2018-09-06 19:39:46,177 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\kpi.jtl

[2018-09-06 19:39:46,177 DEBUG Engine.jmeter.JTLReader] Buffer len: 3; Known errors count: 1

[2018-09-06 19:39:46,178 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536233795

[2018-09-06 19:39:46,226 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536233858

[2018-09-06 19:39:46,273 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536233921

[2018-09-06 19:39:46,322 DEBUG Engine.consolidator] Consolidator buffer[4]: [1536233921, 1536233795, 1536233731, 1536233858]

[2018-09-06 19:39:46,322 DEBUG Engine.consolidator] Merging into 1536233731

[2018-09-06 19:39:46,322 DEBUG Engine.consolidator] Merging 1536233731

[2018-09-06 19:39:46,424 DEBUG Engine.consolidator] Processed datapoint: 1536233731/None

[2018-09-06 19:39:46,424 DEBUG Engine.consolidator] Merging into 1536233795

[2018-09-06 19:39:46,424 DEBUG Engine.consolidator] Merging 1536233795

[2018-09-06 19:39:46,526 DEBUG Engine.consolidator] Processed datapoint: 1536233795/None

[2018-09-06 19:39:46,526 DEBUG Engine.consolidator] Merging into 1536233858

[2018-09-06 19:39:46,526 DEBUG Engine.consolidator] Merging 1536233858

[2018-09-06 19:39:46,632 DEBUG Engine.consolidator] Processed datapoint: 1536233858/None

[2018-09-06 19:39:46,632 DEBUG Engine.consolidator] Merging into 1536233921

[2018-09-06 19:39:46,632 DEBUG Engine.consolidator] Merging 1536233921

[2018-09-06 19:39:46,736 DEBUG Engine.consolidator] Processed datapoint: 1536233921/None

[2018-09-06 19:39:46,736 INFO Engine.final-stats] Test duration: 0:06:22

[2018-09-06 19:39:46,737 INFO Engine.final-stats] Samples count: 6, 100.00% failures

[2018-09-06 19:39:46,740 INFO Engine.final-stats] Average times: total 63.241, latency 0.000, connect 63.241

[2018-09-06 19:39:46,743 INFO Engine.final-stats] Percentiles:

┌───────────────┬───────────────┐

│ Percentile, % │ Resp. Time, s │

├───────────────┼───────────────┤

│ 0.0 │ 63.04 │

│ 50.0 │ 63.231 │

│ 90.0 │ 63.263 │

│ 95.0 │ 63.487 │

│ 99.0 │ 63.487 │

│ 99.9 │ 63.487 │

│ 100.0 │ 63.487 │

└───────────────┴───────────────┘

[2018-09-06 19:39:46,759 INFO Engine.final-stats] Request label stats:

┌──────────────────────┬────────┬───────┬────────┬──────────────────────────────────────────────────────────┐

│ label │ status │ succ │ avg_rt │ error │

├──────────────────────┼────────┼───────┼────────┼──────────────────────────────────────────────────────────┤

│ http://blazedemo.com │ FAIL │ 0.00% │ 63.241 │ Non HTTP response message: Connection timed out: connect │

└──────────────────────┴────────┴───────┴────────┴──────────────────────────────────────────────────────────┘

[2018-09-06 19:39:46,776 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-06 19:39:46,779 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.yml

[2018-09-06 19:39:46,802 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-06_19-33-22.631000\effective.json

[2018-09-06 19:39:46,803 INFO root] Artifacts dir: C:\dev\python\Scripts\2018-09-06_19-33-22.631000

[2018-09-06 19:39:46,806 INFO root] Done performing with code: 0

[2018-09-06 19:39:46,809 DEBUG root] Closing log handler: C:\dev\python\Scripts\2018-09-06_19-33-22.631000\bzt.log

regards,

Amit

> <mailto:codename-taurus+unsub...@googlegroups.com>.

> To view this discussion on the web visit
> https://groups.google.com/d/msgid/codename-taurus/d15152a8-d30a-4aa7-8834-89adc64715ff%40googlegroups.com
> <https://groups.google.com/d/msgid/codename-taurus/d15152a8-d30a-4aa7-8834-89adc64715ff%40googlegroups.com?utm_medium=email&utm_source=footer>.
> For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "codename-taurus" group.

To unsubscribe from this group and stop receiving emails from it, send an email to codename-taur...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/codename-taurus/6ae962c8-6d20-4551-817c-d477c0267d8c%40googlegroups.com.

Message has been deleted

Dmitri Pribysh

unread,

Sep 10, 2018, 4:31:14 AM9/10/18

to codenam...@googlegroups.com

You need to apply proxy settings to JMeter separately through system properties.

Try this:

```
modules:
jmeter:
    system-properties:
      https.proxyHost: myproxy.com
      https.proxyPort: 8080
      https.proxyUser: john
      https.proxyPass: mypass

      http.proxyHost: myproxy.com
      http.proxyPort: 8080
      http.proxyUser: john
      http.proxyPass: mypass
```

Dimitri

On 09/07/2018 05:43 PM, amitsk...@gmail.com wrote:

Hi Dmitri,

Still the same with prepending http and https

bzt.log:

[2018-09-07 16:32:34,220 INFO root] Taurus CLI Tool v1.12.1

[2018-09-07 16:32:34,224 DEBUG root] Command-line options: {'verbose': None, 'no_system_configs': None, 'quiet': None, 'log': 'c:\\users\\bb84364\\appdata\\local\\temp\\bzt_bcjsgc.log', 'option': None, 'aliases': []}

[2018-09-07 16:32:34,224 DEBUG root] Python: CPython 2.7.9

[2018-09-07 16:32:34,224 DEBUG root] OS: ('Windows', 'VDG10063233', '8', '6.2.9200', 'AMD64', 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel')

[2018-09-07 16:32:34,226 INFO root] Starting with configs: ['.\\quicktest.yml']

[2018-09-07 16:32:34,230 DEBUG root] Using personal config: C:\Users\bb84364\.bzt-rc

[2018-09-07 16:32:34,230 INFO Engine] Configuring...

[2018-09-07 16:32:34,233 DEBUG Engine] No machine configs dir: c:\etc\bzt.d

[2018-09-07 16:32:34,233 DEBUG Engine] Base configs list: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-07 16:32:34,233 DEBUG Engine.Configuration] Configs: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-07 16:32:34,233 DEBUG Engine.Configuration] Reading c:\dev\python\lib\site-packages\bzt\resources\base-config.yml as YAML

[2018-09-07 16:32:34,262 DEBUG Engine] User configs list: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-07 16:32:34,262 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-07 16:32:34,263 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-07 16:32:34,269 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-07 16:32:34,270 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-07 16:32:34,272 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-07 16:32:34,279 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-07 16:32:34,282 INFO HTTPClient] Using proxy 'http://bc-proxy.rtdomau.local:8080'

[2018-09-07 16:32:34,286 DEBUG HTTPClient] Using proxy settings: SplitResult(scheme='http', netloc='bc-proxy.rtdomau.local:8080', path='', query='', fragment='')

[2018-09-07 16:32:34,288 DEBUG Engine] Requesting updates info: http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-07 16:32:34,289 INFO Engine] Artifacts dir: C:\dev\python\Scripts\2018-09-07_16-32-34.288000

[2018-09-07 16:32:34,289 DEBUG HTTPClient] Making HTTP request GET http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-07 16:32:34,293 DEBUG urllib3.connectionpool] Starting new HTTP connection (1): bc-proxy.rtdomau.local

[2018-09-07 16:32:34,295 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective

[2018-09-07 16:32:34,296 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.yml

[2018-09-07 16:32:34,302 DEBUG urllib3.connectionpool] http://bc-proxy.rtdomau.local:8080 "GET http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477 HTTP/1.1" 407 814

[2018-09-07 16:32:34,311 DEBUG Engine] Failed to check for updates: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\engine.py", line 609, in _check_updates

data = response.json()

File "c:\dev\python\lib\site-packages\requests\models.py", line 892, in json

return complexjson.loads(self.text, **kwargs)

File "c:\dev\python\lib\json\__init__.py", line 338, in loads

return _default_decoder.decode(s)

File "c:\dev\python\lib\json\decoder.py", line 366, in decode

obj, end = self.raw_decode(s, idx=_w(s, 0).end())

File "c:\dev\python\lib\json\decoder.py", line 384, in raw_decode

raise ValueError("No JSON object could be decoded")

ValueError: No JSON object could be decoded

[2018-09-07 16:32:34,311 WARNING Engine] Failed to check for updates

[2018-09-07 16:32:34,334 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.json

[2018-09-07 16:32:34,335 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\merged.yml

[2018-09-07 16:32:34,336 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\merged.yml

[2018-09-07 16:32:34,338 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\merged.json

[2018-09-07 16:32:34,338 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\merged.json

[2018-09-07 16:32:34,339 DEBUG Engine] Add existing artifact (move=False): .\quicktest.yml

[2018-09-07 16:32:34,339 DEBUG Engine] Copying .\quicktest.yml to C:\dev\python\Scripts\2018-09-07_16-32-34.288000\quicktest.yml

[2018-09-07 16:32:34,342 DEBUG Engine.Environment] Replace 'TAURUS_ARTIFACTS_DIR' in environment

[2018-09-07 16:32:34,342 DEBUG root] Closing log handler: c:\users\bb84364\appdata\local\temp\bzt_bcjsgc.log

[2018-09-07 16:32:34,344 DEBUG root] Switched writing logs to C:\dev\python\Scripts\2018-09-07_16-32-34.288000\bzt.log

[2018-09-07 16:32:34,344 DEBUG root] Linting config

[2018-09-07 16:32:34,346 INFO Engine] Preparing...

[2018-09-07 16:32:34,349 DEBUG Engine] Module config: consolidator defaultdict(None, {'class': u'bzt.modules.aggregator.ConsolidatingAggregator'})

[2018-09-07 16:32:34,349 DEBUG root] Importing module: bzt.modules.aggregator

[2018-09-07 16:32:34,493 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'c:\dev\python\lib\site-packages\bzt\modules\aggregator.pyc'>

[2018-09-07 16:32:34,493 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

[2018-09-07 16:32:34,493 DEBUG Engine] Module config: monitoring defaultdict(None, {'class': u'bzt.modules.monitoring.Monitoring'})

[2018-09-07 16:32:34,493 DEBUG root] Importing module: bzt.modules.monitoring

[2018-09-07 16:32:34,496 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'c:\dev\python\lib\site-packages\bzt\modules\monitoring.pyc'>

[2018-09-07 16:32:34,496 DEBUG Engine] Module config: local defaultdict(None, {'class': u'bzt.modules.provisioning.Local'})

[2018-09-07 16:32:34,496 DEBUG root] Importing module: bzt.modules.provisioning

[2018-09-07 16:32:34,496 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'c:\dev\python\lib\site-packages\bzt\modules\provisioning.pyc'>

[2018-09-07 16:32:34,496 DEBUG Engine] Module config: jmeter defaultdict(None, {'path': u'C:\\dev\\jmeter\\3.1', 'class': u'bzt.modules.jmeter.JMeterExecutor', 'protocol-handlers': defaultdict(None, {'http': u'bzt.jmx.http.HTTPProtocolHandler'}), 'properties': defaultdict(None, {'jmeter.save.saveservice.autoflush': u'true', 'jmeter.save.saveservice.connect_time': u'true', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true'}), 'plugins': [u'jpgc-casutg', u'jpgc-dummy', u'jpgc-ffw', u'jpgc-fifo', u'jpgc-functions', u'jpgc-json', u'jpgc-perfmon', u'jpgc-prmctl', u'jpgc-tst']})

[2018-09-07 16:32:34,497 DEBUG root] Importing module: bzt.modules.jmeter

[2018-09-07 16:32:34,513 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'c:\dev\python\lib\site-packages\bzt\modules\jmeter.pyc'>

[2018-09-07 16:32:34,513 DEBUG Engine.local] Preparing executor: None/43210960

[2018-09-07 16:32:34,513 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\jmeter.log

[2018-09-07 16:32:34,513 DEBUG Engine.jmeter] Checking if port 4445 is free

[2018-09-07 16:32:34,515 DEBUG Engine.jmeter] Port 4445 is free

[2018-09-07 16:32:34,515 DEBUG Engine.jmeter] Using port 4445 for management

[2018-09-07 16:32:34,515 DEBUG Engine.jmeter.JavaVM] Trying JavaVM: ['java', '-version']

[2018-09-07 16:32:34,664 DEBUG Engine.jmeter.JavaVM] JavaVM output: java version "1.8.0_144"

Java(TM) SE Runtime Environment (build 1.8.0_144-b01)

Java HotSpot(TM) 64-Bit Server VM (build 25.144-b01, mixed mode)

Picked up _JAVA_OPTIONS: -Xmx1024M

[2018-09-07 16:32:34,664 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment

[2018-09-07 16:32:34,664 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present

[2018-09-07 16:32:34,664 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\dev\jmeter\3.1\bin\jmeter.bat

[2018-09-07 16:32:34,665 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\jmeter.bat', '-j', 'c:\\users\\bb84364\\appdata\\local\\temp\\jmeterafiyvelog', '--version'] at .

[2018-09-07 16:32:35,414 DEBUG Engine.jmeter.JMeter] JMeter check: Writing log file to: c:\users\bb84364\appdata\local\temp\jmeterafiyvelog

_ ____ _ ____ _ _ _____ _ __ __ _____ _____ _____ ____

/ \ | _ \ / \ / ___| | | | ____| | | \/ | ____|_ _| ____| _ \

/ _ \ | |_) / _ \| | | |_| | _| _ | | |\/| | _| | | | _| | |_) |

/ ___ \| __/ ___ \ |___| _ | |___ | |_| | | | | |___ | | | |___| _ <

/_/ \_\_| /_/ \_\____|_| |_|_____| \___/|_| |_|_____| |_| |_____|_| \_\ 3.1 r1770033

Copyright (c) 1999-2016 The Apache Software Foundation

Picked up _JAVA_OPTIONS: -Xmx1024M

/ None

[2018-09-07 16:32:35,414 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\requests.jmx

[2018-09-07 16:32:35,415 DEBUG root] Importing module: bzt.jmx.http

[2018-09-07 16:32:35,417 DEBUG root] Loading class: 'HTTPProtocolHandler' from <module 'bzt.jmx.http' from 'c:\dev\python\lib\site-packages\bzt\jmx\http.pyc'>

[2018-09-07 16:32:35,418 DEBUG JMeterScenarioBuilder] Saving JMX to: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\requests.jmx

[2018-09-07 16:32:35,420 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=1, throughput=None, ramp_up=60.0, hold=300.0, iterations=0, duration=360.0, steps=None)

[2018-09-07 16:32:35,421 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\kpi.jtl

[2018-09-07 16:32:35,421 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\error.jtl

[2018-09-07 16:32:35,423 WARNING Engine.jmeter.LoadSettingsProcessor] Thread group detection: plugin for ConcurrentThreadGroup not found, regular ThreadGroup will be used

[2018-09-07 16:32:35,430 DEBUG Engine.jmeter.LoadSettingsProcessor.ThreadGroupHandler] Converting ThreadGroup (quick-test) to ThreadGroup and apply load parameters

[2018-09-07 16:32:35,431 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\modified_requests.jmx

[2018-09-07 16:32:35,431 DEBUG JMX] Saving JMX to: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\modified_requests.jmx

[2018-09-07 16:32:35,433 DEBUG Engine.jmeter] Additional properties: defaultdict(None, {'jmeter.save.saveservice.autoflush': u'true', 'jmeter.save.saveservice.connect_time': u'true', 'user.classpath': 'C:/dev/python/Scripts/2018-09-07_16-32-34.288000;C:/dev/python/Scripts/2018-09-07_16-32-34.288000', 'sampleresult.default.encoding': 'UTF-8', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true', 'jmeter.save.saveservice.timestamp_format': 'ms', 'jmeterengine.nongui.maxport': 4445, 'jmeterengine.nongui.port': 4445})

[2018-09-07 16:32:35,434 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\jmeter-bzt.properties

[2018-09-07 16:32:35,434 DEBUG Engine.jmeter] Additional system properties defaultdict(None, {'sun.net.inetaddr.ttl': 0})

[2018-09-07 16:32:35,434 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\system.properties

[2018-09-07 16:32:35,436 DEBUG Engine.jmeter.JMeter] Passing JVM_ARGS: u'-Dhttp.proxyHost=bc-proxy.rtdomau.local -Dhttp.proxyPort=8080 -Dhttp.proxyUser=bb84364 -Dhttp.proxyPass=********-Dhttps.proxyHost=bc-proxy.rtdomau.local -Dhttps.proxyPort=8080 -Dhttps.proxyUser=bb84364 -Dhttps.proxyPass=********'

[2018-09-07 16:32:35,437 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\PluginsManagerCMD.bat', 'install-for-jmx', 'C:\\dev\\python\\Scripts\\2018-09-07_16-32-34.288000\\modified_requests.jmx'] at .

[2018-09-07 16:32:35,437 WARNING Engine.jmeter.JMeter] Failed to detect plugins for C:\dev\python\Scripts\2018-09-07_16-32-34.288000\modified_requests.jmx: environment can only contain strings

[2018-09-07 16:32:35,447 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\jmeter.out

[2018-09-07 16:32:35,447 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\jmeter.err

[2018-09-07 16:32:35,450 DEBUG Engine] Module config: final-stats defaultdict(None, {'class': u'bzt.modules.reporting.FinalStatus'})

[2018-09-07 16:32:35,450 DEBUG root] Importing module: bzt.modules.reporting

[2018-09-07 16:32:35,474 DEBUG easyprocess] version=0.2.3

[2018-09-07 16:32:35,480 DEBUG pyvirtualdisplay] version=0.2.1

[2018-09-07 16:32:35,484 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'c:\dev\python\lib\site-packages\bzt\modules\reporting.pyc'>

[2018-09-07 16:32:35,484 DEBUG Engine] Module config: console defaultdict(None, {'class': u'bzt.modules.console.ConsoleStatusReporter'})

[2018-09-07 16:32:35,484 DEBUG root] Importing module: bzt.modules.console

[2018-09-07 16:32:35,484 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'c:\dev\python\lib\site-packages\bzt\modules\console.pyc'>

[2018-09-07 16:32:35,484 DEBUG Engine.console] Can't use 'console' screen, trying 'gui'

[2018-09-07 16:32:35,496 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.yml

[2018-09-07 16:32:35,523 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.json

[2018-09-07 16:32:35,525 INFO Engine] Starting...

[2018-09-07 16:32:35,528 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x000000000354F278>

[2018-09-07 16:32:35,528 DEBUG Engine] Startup <bzt.modules.aggregator.ConsolidatingAggregator object at 0x00000000035C0470>

[2018-09-07 16:32:35,528 DEBUG Engine] Startup <bzt.modules.reporting.FinalStatus object at 0x0000000003E29D68>

[2018-09-07 16:32:35,529 DEBUG Engine] Startup <bzt.modules.console.ConsoleStatusReporter object at 0x0000000003E6AEF0>

[2018-09-07 16:32:35,529 INFO Engine.console] Waiting for results...

[2018-09-07 16:32:35,530 DEBUG Engine] Startup <bzt.modules.provisioning.Local object at 0x00000000035C09B0>

[2018-09-07 16:32:35,532 DEBUG Engine.local] Delay setup for None/quick-test: 0(start-at) + 0(delay) = 0

[2018-09-07 16:32:35,533 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.yml

[2018-09-07 16:32:35,559 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.json

[2018-09-07 16:32:35,561 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-07 16:32:35,561 DEBUG root] Leveled up log file verbosity

[2018-09-07 16:32:35,562 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\jmeter\\3.1\\bin\\jmeter.bat', '-n', '-t', 'C:\\dev\\python\\Scripts\\2018-09-07_16-32-34.288000\\modified_requests.jmx', '-j', 'C:\\dev\\python\\Scripts\\2018-09-07_16-32-34.288000\\jmeter.log', '-q', 'C:\\dev\\python\\Scripts\\2018-09-07_16-32-34.288000\\jmeter-bzt.properties', '-S', 'C:\\dev\\python\\Scripts\\2018-09-07_16-32-34.288000\\system.properties'] at C:\dev\python\Scripts

[2018-09-07 16:32:35,565 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-07 16:32:35,802 INFO Engine.console] Did not mute console logging

[2018-09-07 16:32:35,931 INFO Engine.console] Waiting for finish...

[2018-09-07 16:34:44,585 INFO Engine.jmeter.JTLReader] Changed data analysis delay to 127s

[2018-09-07 16:38:56,878 WARNING Engine] Please wait for graceful shutdown...

[2018-09-07 16:38:56,884 DEBUG root] Leveled up log file verbosity

[2018-09-07 16:38:56,884 INFO Engine] Shutting down...

[2018-09-07 16:38:56,887 DEBUG Engine] Current stop reason: None

[2018-09-07 16:38:56,887 DEBUG Engine.local] Shutdown None/quick-test

[2018-09-07 16:38:56,891 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-07 16:38:56,894 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.yml

[2018-09-07 16:38:56,923 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.json

[2018-09-07 16:38:56,924 INFO Engine] Post-processing...

[2018-09-07 16:38:56,930 DEBUG Engine.local] Post-process None/quick-test

[2018-09-07 16:38:56,930 DEBUG Engine] Add existing artifact (move=True): C:\dev\python\Scripts\2018-09-07_16-32-34.288000\modified_requests.jmx

[2018-09-07 16:38:56,931 DEBUG Engine] No need to copy C:\dev\python\Scripts\2018-09-07_16-32-34.288000\modified_requests.jmx

[2018-09-07 16:38:56,933 DEBUG Engine.jmeter.JTLErrorsReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\error.jtl

[2018-09-07 16:38:56,933 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\kpi.jtl

[2018-09-07 16:38:56,933 DEBUG Engine.jmeter.JTLReader] Buffer len: 3; Known errors count: 1

[2018-09-07 16:38:56,934 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536309346

[2018-09-07 16:38:56,984 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536309409

[2018-09-07 16:38:57,032 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536309472

[2018-09-07 16:38:57,078 DEBUG Engine.consolidator] Consolidator buffer[4]: [1536309472, 1536309409, 1536309346, 1536309283]

[2018-09-07 16:38:57,078 DEBUG Engine.consolidator] Merging into 1536309283

[2018-09-07 16:38:57,078 DEBUG Engine.consolidator] Merging 1536309283

[2018-09-07 16:38:57,184 DEBUG Engine.consolidator] Processed datapoint: 1536309283/None

[2018-09-07 16:38:57,184 DEBUG Engine.consolidator] Merging into 1536309346

[2018-09-07 16:38:57,184 DEBUG Engine.consolidator] Merging 1536309346

[2018-09-07 16:38:57,290 DEBUG Engine.consolidator] Processed datapoint: 1536309346/None

[2018-09-07 16:38:57,290 DEBUG Engine.consolidator] Merging into 1536309409

[2018-09-07 16:38:57,290 DEBUG Engine.consolidator] Merging 1536309409

[2018-09-07 16:38:57,401 DEBUG Engine.consolidator] Processed datapoint: 1536309409/None

[2018-09-07 16:38:57,401 DEBUG Engine.consolidator] Merging into 1536309472

[2018-09-07 16:38:57,401 DEBUG Engine.consolidator] Merging 1536309472

[2018-09-07 16:38:57,506 DEBUG Engine.consolidator] Processed datapoint: 1536309472/None

[2018-09-07 16:38:57,506 INFO Engine.final-stats] Test duration: 0:06:21

[2018-09-07 16:38:57,510 INFO Engine.final-stats] Samples count: 6, 100.00% failures

[2018-09-07 16:38:57,513 INFO Engine.final-stats] Average times: total 63.149, latency 0.000, connect 63.149

[2018-09-07 16:38:57,519 INFO Engine.final-stats] Percentiles:

┌───────────────┬───────────────┐

│ Percentile, % │ Resp. Time, s │

├───────────────┼───────────────┤

│ 0.0 │ 63.04 │

│ 50.0 │ 63.071 │

│ 90.0 │ 63.295 │

│ 95.0 │ 63.391 │

│ 99.0 │ 63.391 │

│ 99.9 │ 63.391 │

│ 100.0 │ 63.391 │

└───────────────┴───────────────┘

[2018-09-07 16:38:57,546 INFO Engine.final-stats] Request label stats:

┌──────────────────────┬────────┬───────┬────────┬──────────────────────────────────────────────────────────┐

│ label │ status │ succ │ avg_rt │ error │

├──────────────────────┼────────┼───────┼────────┼──────────────────────────────────────────────────────────┤

│ http://blazedemo.com │ FAIL │ 0.00% │ 63.149 │ Non HTTP response message: Connection timed out: connect │

└──────────────────────┴────────┴───────┴────────┴──────────────────────────────────────────────────────────┘

[2018-09-07 16:38:57,585 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-07 16:38:57,586 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.yml

[2018-09-07 16:38:57,618 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-07_16-32-34.288000\effective.json

[2018-09-07 16:38:57,619 INFO root] Artifacts dir: C:\dev\python\Scripts\2018-09-07_16-32-34.288000

[2018-09-07 16:38:57,627 INFO root] Done performing with code: 0

[2018-09-07 16:38:57,631 DEBUG root] Closing log handler: C:\dev\python\Scripts\2018-09-07_16-32-34.288000\bzt.log

effective.yml :

- hide quoted text -

TAURUS_ARTIFACTS_DIR: C:\dev\python\Scripts\2018-09-07_16-32-34.288000

proxy:

address: http://bc-proxy.rtdomau.local:8080

password: '********'

username: bb84364

version: 1.12.1

Regards,

Amit

To view this discussion on the web visit https://groups.google.com/d/msgid/codename-taurus/b87abb63-f6e1-4e9e-82ce-ef2bea1f5ae6%40googlegroups.com.

Message has been deleted

Andrey Pokhilko

unread,

Sep 18, 2018, 3:51:49 AM9/18/18

to codenam...@googlegroups.com

Taurus always makes proxy configuration same way. So it's unlikely that something goes wrong on Taurus side. Are you sure it's not proxy that causes these intermittent failures?

--

Andrey Pokhilko
Open Source Initiatives Leader
CA
BlazeMeter

17.09.2018 03:42, amitsk...@gmail.com пишет:

CAUTION: This email originated from outside of CA. Do not click links or open attachments unless you recognize the sender and know the content is safe.

Hi,

Has anyone faced below issue with Taurus ?

The tests are failing On & Off for Proxy Authentication - sometimes it pass and sometime it fails with the same settings. Have you seen this before ? bzt.log and effective.yml are below:

Regards,

Amit

On Thursday, 13 September 2018 23:09:39 UTC+8, amitsk...@gmail.com wrote:

Hi Dmitri,

The tests are failing On & Off for Proxy Authentication - sometimes it pass and sometime it fails with the same settings. Have you seen this before ? bzt.log and effective.yml are below:

bzt log:

[2018-09-13 22:58:39,358 INFO root] Taurus CLI Tool v1.12.1

[2018-09-13 22:58:39,361 DEBUG root] Command-line options: {'verbose': None, 'no_system_configs': None, 'quiet': None, 'log': 'c:\\users\\bb84364\\appdata\\local\\temp\\bzt_ahoy88.log', 'option': None, 'aliases': []}

[2018-09-13 22:58:39,361 DEBUG root] Python: CPython 2.7.9

[2018-09-13 22:58:39,361 DEBUG root] OS: ('Windows', 'VDG10063233', '8', '6.2.9200', 'AMD64', 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel')

[2018-09-13 22:58:39,362 INFO root] Starting with configs: ['.\\quicktest.yml']

[2018-09-13 22:58:39,368 DEBUG root] Using personal config: C:\Users\bb84364\.bzt-rc

[2018-09-13 22:58:39,368 INFO Engine] Configuring...

[2018-09-13 22:58:39,371 DEBUG Engine] No machine configs dir: c:\etc\bzt.d

[2018-09-13 22:58:39,371 DEBUG Engine] Base configs list: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-13 22:58:39,371 DEBUG Engine.Configuration] Configs: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-13 22:58:39,371 DEBUG Engine.Configuration] Reading c:\dev\python\lib\site-packages\bzt\resources\base-config.yml as YAML

[2018-09-13 22:58:39,405 DEBUG Engine] User configs list: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-13 22:58:39,405 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-13 22:58:39,407 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-13 22:58:39,413 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-13 22:58:39,415 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-13 22:58:39,415 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-13 22:58:39,424 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-13 22:58:39,426 INFO HTTPClient] Using proxy 'https://bc-proxy.rtdomau.local:8080'

[2018-09-13 22:58:39,434 DEBUG HTTPClient] Using proxy settings: SplitResult(scheme='https', netloc='bc-proxy.rtdomau.local:8080', path='', query='', fragment='')

[2018-09-13 22:58:39,434 DEBUG Engine] Requesting updates info: http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-13 22:58:39,434 INFO Engine] Artifacts dir: C:\dev\python\Scripts\2018-09-13_22-58-39.435000

[2018-09-13 22:58:39,434 DEBUG HTTPClient] Making HTTP request GET http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477

[2018-09-13 22:58:39,437 DEBUG urllib3.connectionpool] Starting new HTTPS connection (1): bc-proxy.rtdomau.local

[2018-09-13 22:58:39,444 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective

[2018-09-13 22:58:39,447 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.yml

[2018-09-13 22:58:39,474 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.json

[2018-09-13 22:58:39,476 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\merged.yml

[2018-09-13 22:58:39,477 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\merged.yml

[2018-09-13 22:58:39,483 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\merged.json

[2018-09-13 22:58:39,483 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\merged.json

[2018-09-13 22:58:39,483 DEBUG Engine] Add existing artifact (move=False): .\quicktest.yml

[2018-09-13 22:58:39,483 DEBUG Engine] Copying .\quicktest.yml to C:\dev\python\Scripts\2018-09-13_22-58-39.435000\quicktest.yml

[2018-09-13 22:58:39,486 DEBUG Engine.Environment] Replace 'TAURUS_ARTIFACTS_DIR' in environment

[2018-09-13 22:58:39,486 DEBUG root] Closing log handler: c:\users\bb84364\appdata\local\temp\bzt_ahoy88.log

[2018-09-13 22:58:39,489 DEBUG root] Switched writing logs to C:\dev\python\Scripts\2018-09-13_22-58-39.435000\bzt.log

[2018-09-13 22:58:39,489 DEBUG root] Linting config

[2018-09-13 22:58:39,490 INFO Engine] Preparing...

[2018-09-13 22:58:39,494 DEBUG Engine] Module config: consolidator defaultdict(None, {'class': u'bzt.modules.aggregator.ConsolidatingAggregator'})

[2018-09-13 22:58:39,494 DEBUG root] Importing module: bzt.modules.aggregator

[2018-09-13 22:58:39,569 DEBUG HTTPClient] Request resulted in exception: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\utils.py", line 989, in request

return self.session.request(method, url, *args, **kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 508, in request

resp = self.send(prep, **send_kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 618, in send

r = adapter.send(request, **kwargs)

File "c:\dev\python\lib\site-packages\requests\adapters.py", line 502, in send

raise ProxyError(e, request=request)

ProxyError: HTTPSConnectionPool(host='bc-proxy.rtdomau.local', port=8080): Max retries exceeded with url: http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477 (Caused by ProxyError('Cannot connect to proxy.', error('Tunnel connection failed: 407 Proxy Authentication Required',)))

[2018-09-13 22:58:39,582 DEBUG Engine] Failed to check for updates: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\engine.py", line 607, in _check_updates

response = client.request('GET', addr, timeout=10)

File "c:\dev\python\lib\site-packages\bzt\utils.py", line 996, in request

raise TaurusNetworkError(msg)

TaurusNetworkError: Request to http://gettaurus.org/updates/?version=1.12.1&installID=windows-5056b87477 failed

[2018-09-13 22:58:39,584 WARNING Engine] Failed to check for updates

[2018-09-13 22:58:39,650 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'c:\dev\python\lib\site-packages\bzt\modules\aggregator.pyc'>

[2018-09-13 22:58:39,651 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

[2018-09-13 22:58:39,651 DEBUG Engine] Module config: monitoring defaultdict(None, {'class': u'bzt.modules.monitoring.Monitoring'})

[2018-09-13 22:58:39,651 DEBUG root] Importing module: bzt.modules.monitoring

[2018-09-13 22:58:39,654 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'c:\dev\python\lib\site-packages\bzt\modules\monitoring.pyc'>

[2018-09-13 22:58:39,654 DEBUG Engine] Module config: local defaultdict(None, {'class': u'bzt.modules.provisioning.Local'})

[2018-09-13 22:58:39,654 DEBUG root] Importing module: bzt.modules.provisioning

[2018-09-13 22:58:39,654 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'c:\dev\python\lib\site-packages\bzt\modules\provisioning.pyc'>

[2018-09-13 22:58:39,654 DEBUG Engine] Module config: jmeter defaultdict(None, {'class': u'bzt.modules.jmeter.JMeterExecutor', 'system-properties': defaultdict(None, {'https.proxyPort': 8080, 'http.proxyPort': 8080, 'https.proxyUser': u'Uname', 'http.proxyUser': u'Uname', 'http.proxyHost': u'bc-proxy.rtdomau.local', 'http.proxyPass': u'********', 'https.proxyPass': u'********', 'https.proxyHost': u'bc-proxy.rtdomau.local'}), 'plugins': [u'jpgc-casutg', u'jpgc-dummy', u'jpgc-ffw', u'jpgc-fifo', u'jpgc-functions', u'jpgc-json', u'jpgc-perfmon', u'jpgc-prmctl', u'jpgc-tst'], 'path': u'C:\\dev\\apache-jmeter-4.0', 'properties': defaultdict(None, {'prop_name': u'system-properties', 'summariser.name': u'', 'jmeter.save.saveservice.connect_time': u'true', 'jmeter.save.saveservice.autoflush': u'true', 'jmeterengine.force.system.exit': u'true'}), 'protocol-handlers': defaultdict(None, {'http': u'bzt.jmx.http.HTTPProtocolHandler'})})

[2018-09-13 22:58:39,655 DEBUG root] Importing module: bzt.modules.jmeter

[2018-09-13 22:58:39,673 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'c:\dev\python\lib\site-packages\bzt\modules\jmeter.pyc'>

[2018-09-13 22:58:39,673 DEBUG Engine.local] Preparing executor: None/42859040

[2018-09-13 22:58:39,674 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\jmeter.log

[2018-09-13 22:58:39,674 DEBUG Engine.jmeter] Checking if port 4445 is free

[2018-09-13 22:58:39,676 DEBUG Engine.jmeter] Port 4445 is free

[2018-09-13 22:58:39,676 DEBUG Engine.jmeter] Using port 4445 for management

[2018-09-13 22:58:39,677 DEBUG Engine.jmeter.JavaVM] Trying JavaVM: ['java', '-version']

[2018-09-13 22:58:39,805 DEBUG Engine.jmeter.JavaVM] JavaVM output: java version "1.8.0_144"

Java(TM) SE Runtime Environment (build 1.8.0_144-b01)

Java HotSpot(TM) 64-Bit Server VM (build 25.144-b01, mixed mode)

Picked up _JAVA_OPTIONS: -Xmx1024M

[2018-09-13 22:58:39,805 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment

[2018-09-13 22:58:39,805 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present

[2018-09-13 22:58:39,805 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\dev\apache-jmeter-4.0\bin\jmeter.bat

[2018-09-13 22:58:39,806 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\jmeter.bat', '-j', 'c:\\users\\bb84364\\appdata\\local\\temp\\jmeterqb_zwvlog', '--version'] at .

[2018-09-13 22:58:39,966 DEBUG Engine.jmeter.JMeter] JMeter check: The JMETER_HOME environment variable is not defined correctly

This environment variable is needed to run this program

/ None

[2018-09-13 22:58:39,967 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\requests.jmx

[2018-09-13 22:58:39,967 DEBUG root] Importing module: bzt.jmx.http

[2018-09-13 22:58:39,969 DEBUG root] Loading class: 'HTTPProtocolHandler' from <module 'bzt.jmx.http' from 'c:\dev\python\lib\site-packages\bzt\jmx\http.pyc'>

[2018-09-13 22:58:39,970 DEBUG JMeterScenarioBuilder] Saving JMX to: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\requests.jmx

[2018-09-13 22:58:39,970 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=1, throughput=None, ramp_up=60.0, hold=60.0, iterations=0, duration=120.0, steps=None)

[2018-09-13 22:58:39,973 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\kpi.jtl

[2018-09-13 22:58:39,973 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\error.jtl

[2018-09-13 22:58:39,974 WARNING Engine.jmeter.LoadSettingsProcessor] Thread group detection: plugin for ConcurrentThreadGroup not found, regular ThreadGroup will be used

[2018-09-13 22:58:39,983 DEBUG Engine.jmeter.LoadSettingsProcessor.ThreadGroupHandler] Converting ThreadGroup (quick-test) to ThreadGroup and apply load parameters

[2018-09-13 22:58:39,983 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\modified_requests.jmx

[2018-09-13 22:58:39,983 DEBUG JMX] Saving JMX to: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\modified_requests.jmx

[2018-09-13 22:58:39,986 DEBUG Engine.jmeter] Additional properties: defaultdict(None, {'prop_name': u'system-properties', 'jmeter.save.saveservice.connect_time': u'true', 'jmeter.save.saveservice.autoflush': u'true', 'sampleresult.default.encoding': 'UTF-8', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true', 'user.classpath': 'C:/dev/python/Scripts/2018-09-13_22-58-39.435000;C:/dev/python/Scripts/2018-09-13_22-58-39.435000', 'jmeter.save.saveservice.timestamp_format': 'ms', 'jmeterengine.nongui.maxport': 4445, 'jmeterengine.nongui.port': 4445})

[2018-09-13 22:58:39,986 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\jmeter-bzt.properties

[2018-09-13 22:58:39,986 DEBUG Engine.jmeter] Additional system properties defaultdict(None, {'https.proxyPort': 8080, 'sun.net.inetaddr.ttl': 0, 'http.proxyPort': 8080, 'https.proxyUser': u'Uname', 'http.proxyUser': u'Uname', 'http.proxyHost': u'bc-proxy.rtdomau.local', 'http.proxyPass': u'********', 'https.proxyPass': u'********', 'https.proxyHost': u'bc-proxy.rtdomau.local'})

[2018-09-13 22:58:39,986 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\system.properties

[2018-09-13 22:58:39,987 DEBUG Engine.jmeter.JMeter] Passing JVM_ARGS: u'-Dhttp.proxyHost=bc-proxy.rtdomau.local -Dhttp.proxyPort=8080 -Dhttp.proxyUser=Uname -Dhttp.proxyPass=******** -Dhttps.proxyHost=bc-proxy.rtdomau.local -Dhttps.proxyPort=8080 -Dhttps.proxyUser=Uname -Dhttps.proxyPass=********'

[2018-09-13 22:58:39,987 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\PluginsManagerCMD.bat', 'install-for-jmx', 'C:\\dev\\python\\Scripts\\2018-09-13_22-58-39.435000\\modified_requests.jmx'] at .

[2018-09-13 22:58:39,987 WARNING Engine.jmeter.JMeter] Failed to detect plugins for C:\dev\python\Scripts\2018-09-13_22-58-39.435000\modified_requests.jmx: environment can only contain strings

[2018-09-13 22:58:39,996 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\jmeter.out

[2018-09-13 22:58:39,996 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\jmeter.err

[2018-09-13 22:58:39,999 DEBUG Engine] Module config: final-stats defaultdict(None, {'class': u'bzt.modules.reporting.FinalStatus'})

[2018-09-13 22:58:39,999 DEBUG root] Importing module: bzt.modules.reporting

[2018-09-13 22:58:40,017 DEBUG easyprocess] version=0.2.3

[2018-09-13 22:58:40,022 DEBUG pyvirtualdisplay] version=0.2.1

[2018-09-13 22:58:40,023 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'c:\dev\python\lib\site-packages\bzt\modules\reporting.pyc'>

[2018-09-13 22:58:40,023 DEBUG Engine] Module config: console defaultdict(None, {'class': u'bzt.modules.console.ConsoleStatusReporter'})

[2018-09-13 22:58:40,025 DEBUG root] Importing module: bzt.modules.console

[2018-09-13 22:58:40,025 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'c:\dev\python\lib\site-packages\bzt\modules\console.pyc'>

[2018-09-13 22:58:40,025 DEBUG Engine.console] Can't use 'console' screen, trying 'gui'

[2018-09-13 22:58:40,033 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.yml

[2018-09-13 22:58:40,061 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.json

[2018-09-13 22:58:40,062 INFO Engine] Starting...

[2018-09-13 22:58:40,065 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x00000000028BEEF0>

[2018-09-13 22:58:40,065 DEBUG Engine] Startup <bzt.modules.aggregator.ConsolidatingAggregator object at 0x000000000354F198>

[2018-09-13 22:58:40,065 DEBUG Engine] Startup <bzt.modules.reporting.FinalStatus object at 0x0000000003D91FD0>

[2018-09-13 22:58:40,065 DEBUG Engine] Startup <bzt.modules.console.ConsoleStatusReporter object at 0x0000000003DD1DA0>

[2018-09-13 22:58:40,065 INFO Engine.console] Waiting for results...

[2018-09-13 22:58:40,069 DEBUG Engine] Startup <bzt.modules.provisioning.Local object at 0x00000000034CE278>

[2018-09-13 22:58:40,069 DEBUG Engine.local] Delay setup for None/quick-test: 0(start-at) + 0(delay) = 0

[2018-09-13 22:58:40,072 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.yml

[2018-09-13 22:58:40,098 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.json

[2018-09-13 22:58:40,098 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-13 22:58:40,098 DEBUG root] Leveled up log file verbosity

[2018-09-13 22:58:40,099 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\jmeter.bat', '-n', '-t', 'C:\\dev\\python\\Scripts\\2018-09-13_22-58-39.435000\\modified_requests.jmx', '-j', 'C:\\dev\\python\\Scripts\\2018-09-13_22-58-39.435000\\jmeter.log', '-q', 'C:\\dev\\python\\Scripts\\2018-09-13_22-58-39.435000\\jmeter-bzt.properties', '-S', 'C:\\dev\\python\\Scripts\\2018-09-13_22-58-39.435000\\system.properties'] at C:\dev\python\Scripts

[2018-09-13 22:58:40,104 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-13 22:58:40,332 INFO Engine.console] Did not mute console logging

[2018-09-13 22:58:40,440 INFO Engine.console] Waiting for finish...

[2018-09-13 22:58:46,101 INFO Engine.jmeter.JTLReader] Changed data analysis delay to 3s

[2018-09-13 22:58:52,105 INFO Engine.jmeter.JTLReader] Changed data analysis delay to 2s

[2018-09-13 23:00:43,233 WARNING Engine] Please wait for graceful shutdown...

[2018-09-13 23:00:43,236 DEBUG root] Leveled up log file verbosity

[2018-09-13 23:00:43,236 INFO Engine] Shutting down...

[2018-09-13 23:00:43,240 DEBUG Engine] Current stop reason: None

[2018-09-13 23:00:43,240 DEBUG Engine.local] Shutdown None/quick-test

[2018-09-13 23:00:43,244 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-13 23:00:43,247 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.yml

[2018-09-13 23:00:43,276 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.json

[2018-09-13 23:00:43,276 INFO Engine] Post-processing...

[2018-09-13 23:00:43,279 DEBUG Engine.local] Post-process None/quick-test

[2018-09-13 23:00:43,279 DEBUG Engine] Add existing artifact (move=True): C:\dev\python\Scripts\2018-09-13_22-58-39.435000\modified_requests.jmx

[2018-09-13 23:00:43,280 DEBUG Engine] No need to copy C:\dev\python\Scripts\2018-09-13_22-58-39.435000\modified_requests.jmx

[2018-09-13 23:00:43,280 DEBUG Engine.jmeter.JTLErrorsReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\error.jtl

[2018-09-13 23:00:43,282 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\kpi.jtl

[2018-09-13 23:00:43,282 DEBUG Engine.jmeter.JTLReader] Buffer len: 2; Known errors count: 2

[2018-09-13 23:00:43,282 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536850840

[2018-09-13 23:00:43,290 DEBUG Engine.jmeter.JTLReader] Aggregating: 1536850841

[2018-09-13 23:00:43,301 DEBUG Engine.consolidator] Consolidator buffer[4]: [1536850838, 1536850839, 1536850840, 1536850841]

[2018-09-13 23:00:43,301 DEBUG Engine.consolidator] Merging into 1536850838

[2018-09-13 23:00:43,301 DEBUG Engine.consolidator] Merging 1536850838

[2018-09-13 23:00:43,326 DEBUG Engine.consolidator] Processed datapoint: 1536850838/None

[2018-09-13 23:00:43,326 DEBUG Engine.consolidator] Merging into 1536850839

[2018-09-13 23:00:43,328 DEBUG Engine.consolidator] Merging 1536850839

[2018-09-13 23:00:43,345 DEBUG Engine.consolidator] Processed datapoint: 1536850839/None

[2018-09-13 23:00:43,345 DEBUG Engine.consolidator] Merging into 1536850840

[2018-09-13 23:00:43,345 DEBUG Engine.consolidator] Merging 1536850840

[2018-09-13 23:00:43,364 DEBUG Engine.consolidator] Processed datapoint: 1536850840/None

[2018-09-13 23:00:43,364 DEBUG Engine.consolidator] Merging into 1536850841

[2018-09-13 23:00:43,365 DEBUG Engine.consolidator] Merging 1536850841

[2018-09-13 23:00:43,382 DEBUG Engine.consolidator] Processed datapoint: 1536850841/None

[2018-09-13 23:00:43,382 INFO Engine.final-stats] Test duration: 0:02:03

[2018-09-13 23:00:43,387 INFO Engine.final-stats] Samples count: 301, 54.49% failures

[2018-09-13 23:00:43,391 INFO Engine.final-stats] Average times: total 0.396, latency 0.361, connect 0.000

[2018-09-13 23:00:43,398 INFO Engine.final-stats] Percentiles:

┌───────────────┬───────────────┐

│ Percentile, % │ Resp. Time, s │

├───────────────┼───────────────┤

│ 0.0 │ 0.367 │

│ 50.0 │ 0.374 │

│ 90.0 │ 0.39 │

│ 95.0 │ 0.485 │

│ 99.0 │ 0.857 │

│ 99.9 │ 1.349 │

│ 100.0 │ 1.349 │

└───────────────┴───────────────┘

[2018-09-13 23:00:43,426 INFO Engine.final-stats] Request label stats:

┌──────────────────────┬────────┬────────┬────────┬───────────────────────────────┐

│ label │ status │ succ │ avg_rt │ error │

├──────────────────────┼────────┼────────┼────────┼───────────────────────────────┤

│ http://blazedemo.com │ FAIL │ 45.00% │ 0.396 │ Forbidden │

│ │ │ │ │ Proxy Authentication Required │

└──────────────────────┴────────┴────────┴────────┴───────────────────────────────┘

[2018-09-13 23:00:43,476 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-13 23:00:43,480 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.yml

[2018-09-13 23:00:43,506 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-13_22-58-39.435000\effective.json

[2018-09-13 23:00:43,509 INFO root] Artifacts dir: C:\dev\python\Scripts\2018-09-13_22-58-39.435000

[2018-09-13 23:00:43,519 INFO root] Done performing with code: 0

[2018-09-13 23:00:43,525 DEBUG root] Closing log handler: C:\dev\python\Scripts\2018-09-13_22-58-39.435000\bzt.log

effective.yml

hold-for: 1m

path: C:\dev\apache-jmeter-4.0\bin\jmeter.bat

plugins:

- jpgc-casutg

- jpgc-dummy

- jpgc-ffw

- jpgc-fifo

- jpgc-functions

- jpgc-json

- jpgc-perfmon

- jpgc-prmctl

- jpgc-tst

properties:

jmeter.save.saveservice.autoflush: 'true'

jmeter.save.saveservice.connect_time: 'true'

jmeterengine.force.system.exit: 'true'

prop_name: system-properties

summariser.name: ''

protocol-handlers:

http: bzt.jmx.http.HTTPProtocolHandler

system-properties:

http.proxyHost: bc-proxy.rtdomau.local

http.proxyPass: ********

http.proxyPort: 8080

http.proxyUser: Uname

https.proxyHost: bc-proxy.rtdomau.local

https.proxyPass: ********

https.proxyPort: 8080

https.proxyUser: Uname

TAURUS_ARTIFACTS_DIR: C:\dev\python\Scripts\2018-09-13_22-58-39.435000

proxy:

address: https://bc-proxy.rtdomau.local:8080

password: '********'

username: SVC-TFSBuild

version: 1.12.1

Regards,

Amit

On Monday, 10 September 2018 18:23:02 UTC+8, amitsk...@gmail.com wrote:

Thanks a lot Dimitri, it is working now.

Regards,

Amit

...

--
You received this message because you are subscribed to the Google Groups "codename-taurus" group.
To unsubscribe from this group and stop receiving emails from it, send an email to codename-taur...@googlegroups.com.

To view this discussion on the web visit https://groups.google.com/d/msgid/codename-taurus/52c9b747-caa1-4fd4-a50a-9c6f14741f29%40googlegroups.com.

Message has been deleted

Andrey Pokhilko

unread,

Sep 18, 2018, 4:32:33 AM9/18/18

to codenam...@googlegroups.com

Try upgrading your Taurus to latest version, we've been improving proxy support recently, while you use 1.12.1 which is slightly old.

--

Andrey Pokhilko
Open Source Initiatives Leader
CA
BlazeMeter

18.09.2018 11:24, amitsk...@gmail.com пишет:

CAUTION: This email originated from outside of CA. Do not click links or open attachments unless you recognize the sender and know the content is safe.

Hi Andrey,

It's failing for Proxy Authentication Required. bzt.log and effective.yml attached below:

bzt.log:

...

--
You received this message because you are subscribed to the Google Groups "codename-taurus" group.
To unsubscribe from this group and stop receiving emails from it, send an email to codename-taur...@googlegroups.com.

To view this discussion on the web visit https://groups.google.com/d/msgid/codename-taurus/7040a767-bf3e-4d47-875d-7921ed9a14a3%40googlegroups.com.

Message has been deleted

Andrey Pokhilko

unread,

Sep 18, 2018, 6:29:00 AM9/18/18

to codenam...@googlegroups.com

As I said, if it sometimes work and sometimes not - it is most likely your proxy that refuses to work, not Taurus.

For example, your proxy blocks you because of too many connections open.

--

Andrey Pokhilko
Open Source Initiatives Leader
CA
BlazeMeter

18.09.2018 13:26, amitsk...@gmail.com пишет:

CAUTION: This email originated from outside of CA. Do not click links or open attachments unless you recognize the sender and know the content is safe.

Hi Andrey,

Same proxy authentication error with 1.13.0.

bzt.log below:

[2018-09-18 18:16:33,355 INFO root] Taurus CLI Tool v1.13.0

[2018-09-18 18:16:33,358 DEBUG root] Command-line options: {'verbose': None, 'no_system_configs': None, 'quiet': None, 'log': 'c:\\users\\bb84364\\appdata\\local\\temp\\bzt_hczqka.log', 'option': None, 'aliases': []}

[2018-09-18 18:16:33,358 DEBUG root] Python: CPython 2.7.9

[2018-09-18 18:16:33,358 DEBUG root] OS: ('Windows', 'VDG10063233', '8', '6.2.9200', 'AMD64', 'Intel64 Family 6 Model 63 Stepping 2, GenuineIntel')

[2018-09-18 18:16:33,359 INFO root] Starting with configs: ['.\\quicktest.yml']

[2018-09-18 18:16:33,364 DEBUG root] Using personal config: C:\Users\bb84364\.bzt-rc

[2018-09-18 18:16:33,364 INFO Engine] Configuring...

[2018-09-18 18:16:33,365 DEBUG Engine] No machine configs dir: c:\etc\bzt.d

[2018-09-18 18:16:33,365 DEBUG Engine] Base configs list: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-18 18:16:33,365 DEBUG Engine.Configuration] Configs: ['c:\\dev\\python\\lib\\site-packages\\bzt\\resources\\base-config.yml']

[2018-09-18 18:16:33,365 DEBUG Engine.Configuration] Reading c:\dev\python\lib\site-packages\bzt\resources\base-config.yml as YAML

[2018-09-18 18:16:33,394 DEBUG Engine] User configs list: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-18 18:16:33,394 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-18 18:16:33,394 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-18 18:16:33,403 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-18 18:16:33,404 DEBUG Engine.Configuration] Configs: ['C:\\Users\\bb84364\\.bzt-rc', '.\\quicktest.yml']

[2018-09-18 18:16:33,405 DEBUG Engine.Configuration] Reading C:\Users\bb84364\.bzt-rc as YAML

[2018-09-18 18:16:33,414 DEBUG Engine.Configuration] Reading .\quicktest.yml as YAML

[2018-09-18 18:16:33,415 INFO HTTPClient] Using proxy 'https://bc-proxy.rtdomau.local:8080'

[2018-09-18 18:16:33,421 DEBUG HTTPClient] Using proxy settings: SplitResult(scheme='https', netloc='bc-proxy.rtdomau.local:8080', path='', query='', fragment='')

[2018-09-18 18:16:33,421 DEBUG Engine] Requesting updates info: http://gettaurus.org/updates/?version=1.13.0&installID=windows-5056b87477

[2018-09-18 18:16:33,421 INFO Engine] Artifacts dir: C:\dev\python\Scripts\2018-09-18_18-16-33.422000

[2018-09-18 18:16:33,423 DEBUG HTTPClient] Making HTTP request GET http://gettaurus.org/updates/?version=1.13.0&installID=windows-5056b87477

[2018-09-18 18:16:33,427 DEBUG urllib3.connectionpool] Starting new HTTPS connection (1): bc-proxy.rtdomau.local

[2018-09-18 18:16:33,428 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective

[2018-09-18 18:16:33,431 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.yml

[2018-09-18 18:16:33,463 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.json

[2018-09-18 18:16:33,467 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\merged.yml

[2018-09-18 18:16:33,469 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\merged.yml

[2018-09-18 18:16:33,473 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\merged.json

[2018-09-18 18:16:33,473 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\merged.json

[2018-09-18 18:16:33,473 DEBUG Engine] Add existing artifact (move=False): .\quicktest.yml

[2018-09-18 18:16:33,473 DEBUG Engine] Copying .\quicktest.yml to C:\dev\python\Scripts\2018-09-18_18-16-33.422000\quicktest.yml

[2018-09-18 18:16:33,476 DEBUG Engine.Environment] Replace 'TAURUS_ARTIFACTS_DIR' in environment

[2018-09-18 18:16:33,476 DEBUG root] Closing log handler: c:\users\bb84364\appdata\local\temp\bzt_hczqka.log

[2018-09-18 18:16:33,477 DEBUG root] Switched writing logs to C:\dev\python\Scripts\2018-09-18_18-16-33.422000\bzt.log

[2018-09-18 18:16:33,477 DEBUG root] Linting config

[2018-09-18 18:16:33,482 INFO Engine] Preparing...

[2018-09-18 18:16:33,483 DEBUG Engine] Module config: consolidator {'class': u'bzt.modules.aggregator.ConsolidatingAggregator'}

[2018-09-18 18:16:33,483 DEBUG root] Importing module: bzt.modules.aggregator

[2018-09-18 18:16:33,555 DEBUG HTTPClient] Request resulted in exception: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\utils.py", line 1014, in request

return self.session.request(method, url, *args, **kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 508, in request

resp = self.send(prep, **send_kwargs)

File "c:\dev\python\lib\site-packages\requests\sessions.py", line 618, in send

r = adapter.send(request, **kwargs)

File "c:\dev\python\lib\site-packages\requests\adapters.py", line 502, in send

raise ProxyError(e, request=request)

ProxyError: HTTPSConnectionPool(host='bc-proxy.rtdomau.local', port=8080): Max retries exceeded with url: http://gettaurus.org/updates/?version=1.13.0&installID=windows-5056b87477 (Caused by ProxyError('Cannot connect to proxy.', error('Tunnel connection failed: 407 Proxy Authentication Required',)))

[2018-09-18 18:16:33,565 DEBUG Engine] Failed to check for updates: Traceback (most recent call last):

File "c:\dev\python\lib\site-packages\bzt\engine.py", line 620, in _check_updates

response = client.request('GET', addr, timeout=10)

File "c:\dev\python\lib\site-packages\bzt\utils.py", line 1021, in request

raise TaurusNetworkError(msg)

TaurusNetworkError: Request to http://gettaurus.org/updates/?version=1.13.0&installID=windows-5056b87477 failed

[2018-09-18 18:16:33,568 WARNING Engine] Failed to check for updates

[2018-09-18 18:16:33,625 DEBUG root] Loading class: 'ConsolidatingAggregator' from <module 'bzt.modules.aggregator' from 'c:\dev\python\lib\site-packages\bzt\modules\aggregator.pyc'>

[2018-09-18 18:16:33,625 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

[2018-09-18 18:16:33,625 DEBUG Engine] Module config: monitoring {'class': u'bzt.modules.monitoring.Monitoring'}

[2018-09-18 18:16:33,627 DEBUG root] Importing module: bzt.modules.monitoring

[2018-09-18 18:16:33,628 DEBUG root] Loading class: 'Monitoring' from <module 'bzt.modules.monitoring' from 'c:\dev\python\lib\site-packages\bzt\modules\monitoring.pyc'>

[2018-09-18 18:16:33,628 DEBUG Engine] Module config: local {'class': u'bzt.modules.provisioning.Local'}

[2018-09-18 18:16:33,630 DEBUG root] Importing module: bzt.modules.provisioning

[2018-09-18 18:16:33,630 DEBUG root] Loading class: 'Local' from <module 'bzt.modules.provisioning' from 'c:\dev\python\lib\site-packages\bzt\modules\provisioning.pyc'>

[2018-09-18 18:16:33,630 DEBUG Engine] Module config: jmeter {'system-properties': {'https.proxyPort': 8080, 'http.proxyPort': 8080, 'https.proxyUser': u'Uname', 'http.proxyUser': u'Uname', 'http.proxyHost': u'bc-proxy.rtdomau.local', 'http.proxyPass': u'********', 'https.proxyPass': u'********', 'https.proxyHost': u'bc-proxy.rtdomau.local'}, 'plugins': [u'jpgc-casutg', u'jpgc-dummy', u'jpgc-ffw', u'jpgc-fifo', u'jpgc-functions', u'jpgc-json', u'jpgc-perfmon', u'jpgc-prmctl', u'jpgc-tst'], 'path': u'C:\\dev\\apache-jmeter-4.0', 'protocol-handlers': {'http': u'bzt.jmx.http.HTTPProtocolHandler'}, 'class': u'bzt.modules.jmeter.JMeterExecutor', 'properties': {'jmeter.save.saveservice.autoflush': u'true', 'prop_name': u'system-properties', 'jmeter.save.saveservice.connect_time': u'true', 'summariser.name': u'', 'jmeterengine.force.system.exit': u'true'}}

[2018-09-18 18:16:33,630 DEBUG root] Importing module: bzt.modules.jmeter

[2018-09-18 18:16:33,644 DEBUG root] Loading class: 'JMeterExecutor' from <module 'bzt.modules.jmeter' from 'c:\dev\python\lib\site-packages\bzt\modules\jmeter.pyc'>

[2018-09-18 18:16:33,644 DEBUG Engine.local] Preparing executor: None/44528416

[2018-09-18 18:16:33,644 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\jmeter.log

[2018-09-18 18:16:33,644 DEBUG Engine.jmeter] Checking if port 4445 is free

[2018-09-18 18:16:33,645 DEBUG Engine.jmeter] Port 4445 is free

[2018-09-18 18:16:33,645 DEBUG Engine.jmeter] Using port 4445 for management

[2018-09-18 18:16:33,647 DEBUG Engine.jmeter.JavaVM] Trying JavaVM: ['java', '-version']

[2018-09-18 18:16:33,779 DEBUG Engine.jmeter.JavaVM] JavaVM output: java version "1.8.0_144"

Java(TM) SE Runtime Environment (build 1.8.0_144-b01)

Java HotSpot(TM) 64-Bit Server VM (build 25.144-b01, mixed mode)

Picked up _JAVA_OPTIONS: -Xmx1024M

[2018-09-18 18:16:33,779 DEBUG Engine.jmeter.TclLibrary] Checking if TCL_LIBRARY variable is present in environment

[2018-09-18 18:16:33,780 DEBUG Engine.jmeter.TclLibrary] TCL_LIBRARY environment variable is present

[2018-09-18 18:16:33,780 DEBUG Engine.jmeter.JMeter] Trying jmeter: C:\dev\apache-jmeter-4.0\bin\jmeter.bat

[2018-09-18 18:16:33,782 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\jmeter.bat', '-j', 'c:\\users\\bb84364\\appdata\\local\\temp\\jmeteryurwjdlog', '--version'] at .

[2018-09-18 18:16:33,940 DEBUG Engine.jmeter.JMeter] JMeter check: The JMETER_HOME environment variable is not defined correctly

This environment variable is needed to run this program

/ None

[2018-09-18 18:16:33,941 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\requests.jmx

[2018-09-18 18:16:33,943 DEBUG root] Importing module: bzt.jmx.http

[2018-09-18 18:16:33,943 DEBUG root] Loading class: 'HTTPProtocolHandler' from <module 'bzt.jmx.http' from 'c:\dev\python\lib\site-packages\bzt\jmx\http.pyc'>

[2018-09-18 18:16:33,944 DEBUG JMeterScenarioBuilder] Saving JMX to: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\requests.jmx

[2018-09-18 18:16:33,946 DEBUG Engine.jmeter] Load: LoadSpec(concurrency=1, throughput=None, ramp_up=60.0, hold=60.0, iterations=0, duration=120.0, steps=None)

[2018-09-18 18:16:33,947 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\kpi.jtl

[2018-09-18 18:16:33,948 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\error.jtl

[2018-09-18 18:16:33,950 WARNING Engine.jmeter.LoadSettingsProcessor] Thread group detection: plugin for ConcurrentThreadGroup not found, regular ThreadGroup will be used

[2018-09-18 18:16:33,959 DEBUG Engine.jmeter.LoadSettingsProcessor.ThreadGroupHandler] Converting ThreadGroup (quick-test) to ThreadGroup and apply load parameters

[2018-09-18 18:16:33,960 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\modified_requests.jmx

[2018-09-18 18:16:33,960 DEBUG JMX] Saving JMX to: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\modified_requests.jmx

[2018-09-18 18:16:33,960 DEBUG Engine.jmeter] Additional properties: {'prop_name': u'system-properties', 'jmeter.save.saveservice.connect_time': u'true', 'user.classpath': 'C:/dev/python/Scripts/2018-09-18_18-16-33.422000;C:/dev/python/Scripts/2018-09-18_18-16-33.422000', 'sampleresult.default.encoding': 'UTF-8', 'jmeter.save.saveservice.autoflush': u'true', 'jmeterengine.force.system.exit': u'true', 'jmeter.save.saveservice.timestamp_format': 'ms', 'jmeterengine.nongui.maxport': 4445, 'summariser.name': u'', 'jmeterengine.nongui.port': 4445}

[2018-09-18 18:16:33,960 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\jmeter-bzt.properties

[2018-09-18 18:16:33,961 DEBUG Engine.jmeter] Additional system properties {'https.proxyPort': 8080, 'sun.net.inetaddr.ttl': 0, 'http.proxyPort': 8080, 'https.proxyUser': u'Uname', 'http.proxyUser': u'Uname', 'http.proxyHost': u'bc-proxy.rtdomau.local', 'http.proxyPass': u'********', 'https.proxyPass': u'********', 'https.proxyHost': u'bc-proxy.rtdomau.local'}

[2018-09-18 18:16:33,961 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\system.properties

[2018-09-18 18:16:33,963 DEBUG Engine.jmeter.JMeter] Passing JVM_ARGS: u'-Dhttp.proxyHost=bc-proxy.rtdomau.local -Dhttp.proxyPort=8080 -Dhttp.proxyUser=Uname -Dhttp.proxyPass=******** -Dhttps.proxyHost=bc-proxy.rtdomau.local -Dhttps.proxyPort=8080 -Dhttps.proxyUser=Uname -Dhttps.proxyPass=********'

[2018-09-18 18:16:33,963 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\PluginsManagerCMD.bat', 'install-for-jmx', 'C:\\dev\\python\\Scripts\\2018-09-18_18-16-33.422000\\modified_requests.jmx'] at .

[2018-09-18 18:16:33,963 WARNING Engine.jmeter.JMeter] Failed to detect plugins for C:\dev\python\Scripts\2018-09-18_18-16-33.422000\modified_requests.jmx: environment can only contain strings

[2018-09-18 18:16:33,973 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\jmeter.out

[2018-09-18 18:16:33,973 DEBUG Engine] New artifact filename: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\jmeter.err

[2018-09-18 18:16:33,973 DEBUG Engine] Module config: final-stats {'class': u'bzt.modules.reporting.FinalStatus'}

[2018-09-18 18:16:33,973 DEBUG root] Importing module: bzt.modules.reporting

[2018-09-18 18:16:33,993 DEBUG easyprocess] version=0.2.3

[2018-09-18 18:16:33,996 DEBUG pyvirtualdisplay] version=0.2.1

[2018-09-18 18:16:34,000 DEBUG root] Loading class: 'FinalStatus' from <module 'bzt.modules.reporting' from 'c:\dev\python\lib\site-packages\bzt\modules\reporting.pyc'>

[2018-09-18 18:16:34,000 DEBUG Engine] Module config: console {'class': u'bzt.modules.console.ConsoleStatusReporter'}

[2018-09-18 18:16:34,000 DEBUG root] Importing module: bzt.modules.console

[2018-09-18 18:16:34,000 DEBUG root] Loading class: 'ConsoleStatusReporter' from <module 'bzt.modules.console' from 'c:\dev\python\lib\site-packages\bzt\modules\console.pyc'>

[2018-09-18 18:16:34,000 DEBUG Engine.console] Can't use 'console' screen, trying 'gui'

[2018-09-18 18:16:34,010 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.yml

[2018-09-18 18:16:34,039 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.json

[2018-09-18 18:16:34,040 INFO Engine] Starting...

[2018-09-18 18:16:34,042 DEBUG Engine] Startup <bzt.modules.monitoring.Monitoring object at 0x0000000003AB1E80>

[2018-09-18 18:16:34,042 DEBUG Engine] Startup <bzt.modules.aggregator.ConsolidatingAggregator object at 0x000000000364F748>

[2018-09-18 18:16:34,043 DEBUG Engine] Startup <bzt.modules.reporting.FinalStatus object at 0x0000000003E71828>

[2018-09-18 18:16:34,043 DEBUG Engine] Startup <bzt.modules.console.ConsoleStatusReporter object at 0x0000000003EAD5C0>

[2018-09-18 18:16:34,043 INFO Engine.console] Waiting for results...

[2018-09-18 18:16:34,046 DEBUG Engine] Startup <bzt.modules.provisioning.Local object at 0x00000000035C66A0>

[2018-09-18 18:16:34,046 DEBUG Engine.local] Delay setup for None/quick-test: 0(start-at) + 0(delay) = 0

[2018-09-18 18:16:34,049 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.yml

[2018-09-18 18:16:34,075 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.json

[2018-09-18 18:16:34,078 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-18 18:16:34,078 DEBUG root] Leveled up log file verbosity

[2018-09-18 18:16:34,078 DEBUG bzt.utils] Executing shell: [u'C:\\dev\\apache-jmeter-4.0\\bin\\jmeter.bat', '-n', '-t', 'C:\\dev\\python\\Scripts\\2018-09-18_18-16-33.422000\\modified_requests.jmx', '-j', 'C:\\dev\\python\\Scripts\\2018-09-18_18-16-33.422000\\jmeter.log', '-q', 'C:\\dev\\python\\Scripts\\2018-09-18_18-16-33.422000\\jmeter-bzt.properties', '-S', 'C:\\dev\\python\\Scripts\\2018-09-18_18-16-33.422000\\system.properties'] at C:\dev\python\Scripts

[2018-09-18 18:16:34,082 DEBUG root] Leveling down log file verbosity to INFO, use -v option to have DEBUG messages enabled

[2018-09-18 18:16:34,319 INFO Engine.console] Did not mute console logging

[2018-09-18 18:16:34,424 INFO Engine.console] Waiting for finish...

[2018-09-18 18:18:37,517 WARNING Engine] Please wait for graceful shutdown...

[2018-09-18 18:18:37,522 DEBUG root] Leveled up log file verbosity

[2018-09-18 18:18:37,522 INFO Engine] Shutting down...

[2018-09-18 18:18:37,523 DEBUG Engine] Current stop reason: None

[2018-09-18 18:18:37,525 DEBUG Engine.local] Shutdown None/quick-test

[2018-09-18 18:18:37,530 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-18 18:18:37,532 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.yml

[2018-09-18 18:18:37,565 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.json

[2018-09-18 18:18:37,565 INFO Engine] Post-processing...

[2018-09-18 18:18:37,569 DEBUG Engine.local] Post-process None/quick-test

[2018-09-18 18:18:37,569 DEBUG Engine] Add existing artifact (move=True): C:\dev\python\Scripts\2018-09-18_18-16-33.422000\modified_requests.jmx

[2018-09-18 18:18:37,569 DEBUG Engine] No need to copy C:\dev\python\Scripts\2018-09-18_18-16-33.422000\modified_requests.jmx

[2018-09-18 18:18:37,569 DEBUG Engine.jmeter.JTLErrorsReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\error.jtl

[2018-09-18 18:18:37,569 DEBUG Engine.jmeter.JTLReader.IncrementalCSVReader.FileReader] Reading: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\kpi.jtl

[2018-09-18 18:18:37,571 DEBUG Engine.jmeter.JTLReader] Buffer len: 2; Known errors count: 1

[2018-09-18 18:18:37,571 DEBUG Engine.jmeter.JTLReader] Aggregating: 1537265914

[2018-09-18 18:18:37,572 DEBUG Engine.jmeter.JTLReader] Aggregating: 1537265915

[2018-09-18 18:18:37,573 DEBUG Engine.consolidator] Consolidator buffer[4]: [1537265912, 1537265913, 1537265914, 1537265915]

[2018-09-18 18:18:37,573 DEBUG Engine.consolidator] Merging into 1537265912

[2018-09-18 18:18:37,573 DEBUG Engine.consolidator] Merging 1537265912

[2018-09-18 18:18:37,581 DEBUG Engine.consolidator] Processed datapoint: 1537265912/None

[2018-09-18 18:18:37,581 DEBUG Engine.consolidator] Merging into 1537265913

[2018-09-18 18:18:37,581 DEBUG Engine.consolidator] Merging 1537265913

[2018-09-18 18:18:37,585 DEBUG Engine.consolidator] Processed datapoint: 1537265913/None

[2018-09-18 18:18:37,585 DEBUG Engine.consolidator] Merging into 1537265914

[2018-09-18 18:18:37,586 DEBUG Engine.consolidator] Merging 1537265914

[2018-09-18 18:18:37,591 DEBUG Engine.consolidator] Processed datapoint: 1537265914/None

[2018-09-18 18:18:37,591 DEBUG Engine.consolidator] Merging into 1537265915

[2018-09-18 18:18:37,591 DEBUG Engine.consolidator] Merging 1537265915

[2018-09-18 18:18:37,596 DEBUG Engine.consolidator] Processed datapoint: 1537265915/None

[2018-09-18 18:18:37,596 INFO Engine.final-stats] Test duration: 0:02:03

[2018-09-18 18:18:37,599 INFO Engine.final-stats] Samples count: 301, 45.18% failures

[2018-09-18 18:18:37,602 INFO Engine.final-stats] Average times: total 0.397, latency 0.360, connect 0.000

[2018-09-18 18:18:37,608 INFO Engine.final-stats] Percentiles:

+---------------+---------------+

| Percentile, % | Resp. Time, s |

+---------------+---------------+

| 0.0 | 0.366 |

| 50.0 | 0.373 |

| 90.0 | 0.39 |

| 95.0 | 0.557 |

| 99.0 | 0.743 |

| 99.9 | 1.436 |

| 100.0 | 1.436 |

+---------------+---------------+

[2018-09-18 18:18:37,631 INFO Engine.final-stats] Request label stats:

+----------------------+--------+--------+--------+-------------------------------+

| label | status | succ | avg_rt | error |

+----------------------+--------+--------+--------+-------------------------------+

| http://blazedemo.com | FAIL | 54.00% | 0.397 | Proxy Authentication Required |

+----------------------+--------+--------+--------+-------------------------------+

[2018-09-18 18:18:37,657 DEBUG Engine.console] No logger_handler or orig_stream was detected

[2018-09-18 18:18:37,660 DEBUG Engine.Configuration] Dumping YAML config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.yml

[2018-09-18 18:18:37,684 DEBUG Engine.Configuration] Dumping JSON config into C:\dev\python\Scripts\2018-09-18_18-16-33.422000\effective.json

[2018-09-18 18:18:37,687 INFO root] Artifacts dir: C:\dev\python\Scripts\2018-09-18_18-16-33.422000

[2018-09-18 18:18:37,691 INFO root] Done performing with code: 0

[2018-09-18 18:18:37,694 DEBUG root] Closing log handler: C:\dev\python\Scripts\2018-09-18_18-16-33.422000\bzt.log

effective.yml

default-location: us-central1-a

console:

class: bzt.modules.console.ConsoleStatusReporter

consolidator:

class: bzt.modules.aggregator.ConsolidatingAggregator

percentiles:

- 0.0

- 50.0

- 90.0

- 95.0

- 99.0

- 99.9

- 100.0

external-results-loader:

class: bzt.modules.external.ExternalResultsLoader

TAURUS_ARTIFACTS_DIR: C:\dev\python\Scripts\2018-09-18_18-16-33.422000

proxy:

address: https://bc-proxy.rtdomau.local:8080

password: '********'

username: Uname

version: 1.13.0

...

--
You received this message because you are subscribed to the Google Groups "codename-taurus" group.
To unsubscribe from this group and stop receiving emails from it, send an email to codename-taur...@googlegroups.com.

To view this discussion on the web visit https://groups.google.com/d/msgid/codename-taurus/bbb90023-d546-43e1-96bd-b05db7fdb7f1%40googlegroups.com.

Reply all

Reply to author

Forward