jmeter-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Mariusz W <mawa...@gmail.com>
Subject Re: Scripts not running with JMeter 5.2.1 with Java 1.8.0_221-b11 that work with JMeter 5.2.1 with Java 1.8.0_181-b13
Date Mon, 27 Jan 2020 12:10:58 GMT
Hi,
I can also reproduce this error, on
openjdk-1.8.0.191-1.b12.ojdkbuild.windows.x86_64 I don't have
this error: "setEndTime must be called after setStartTime". In openjdk
version "11.0.5" 2019-10-15 LTS  I see error but it is specific to "Debug
PostProcessor" though (it is reaction to the root cause - parsing
hostname). If "Debug PostProcessor" is disabled error disappear - and we
only see error described by Felix (parsing hostname):

java.net.MalformedURLException: Illegal character found in host: '/'

it is seen in "View Result Tree" listener - and it is true problem I think.

But what Lisa is trying to achieve (I think based on her plan from dropbox)
is to get url which is build from  "HTTP Request Defaults/Protocol" + "HTTP
Request Defaults/Server Name or IP" + "HTTP Request sampler/Path" (in
attached jmx plan from dropbox: https +
nothing.api.ibm.com/nothing/${environment}/so2o/rest/hub
<http://nothing.api.ibm.com/nothing/$%7Benvironment%7D/so2o/rest/hub> +
/auth/user => POST
https://nothing.api.ibm.com/nothing/test/so2o/rest/hub/auth/user)

In my test plans I use different approach:
I define schema + server in "user defined variables" and next use this
variabes/properties to build full url in "HTTP Request Sampler/Path" only
eg.
${server_schema}://${server_env}/nothing/${environment}/so2o/rest/hub/auth/user
- this way I can use properties from property file when plan is run from
command line because in "user defined variables" I use ${__P(...)}. Of
course another aproaches are possible but I don't use server/path pattern
in "HTTP Request Defaults/Server Name or IP"

This use of Path in sampler is described in docs:
https://jmeter.apache.org/usermanual/component_reference.html#HTTP_Request
Path: "As a special case, if the path starts with "http://" or "https://"
then this is used as the full URL. "

and here there is not info about path in server field in "HTTP Request
Defaults":
https://jmeter.apache.org/usermanual/component_reference.html#HTTP_Request_Defaults
Server: "Domain name or IP address of the web server. E.g. www.example.com.
[Do not include the http:// prefix."

IMHO: Lisa's plan should be changed  because it depend on undocumented
feature. Regarding error "setEndTime must be called after setStartTime" it
was not main problem - script was not runnig beacuse sampler is not even
constructed and it's hard to require proper behaviour from preprocessors in
this situation. "Debug PostProcessor" is working (it log
properties/variables in "View Result Tree" though plan is not starting and
jmeter.log has this "setEndTime must be called after setStartTime" line in
it.

Regards,
Mariusz

On Sat, 25 Jan 2020 at 15:07, Felix Schumacher <
felix.schumacher@internetallee.de> wrote:

>
> Am 24.01.20 um 18:37 schrieb Felix Schumacher:
> > Am 22.01.20 um 22:10 schrieb Lisa Waugh - waugh@us.ibm.com:
> >> Hi,
> >> I’m sorry this took me awhile to get figured out.  I think I have a
> small imx with the issue at this link:
> >>
> >>
> https://www.dropbox.com/sh/mxzuyuwcdziii6c/AAD5e1nZHlJA4cWKlvie2mzCa?dl=0
> >>
> >> Please let me know if you have any questions or issues.
> > OK, I can reproduce the issue using openjdk 1.8.0 Update 232. Will look
> > into it, but I am not unhappy if anyone else is faster than me :)
>
> It seems, as there is some change in behaviour of parsing hostnames from
> Update 212 to 222. The test plan uses hostname/path as the hostname.
>
> That scheme worked for a long time, but it doesn't work in Lisa's plan.
> If you transfer the path into the "HTTP Request Path" field, the error
> will go away.
>
> That leads to a few questions.
>
>  * Should we warn more strongly about misuse of the hostname field?
>
>  * Should we investigate into the originally reported problem of the
> invalid call sequence?
>
> Felix
>
> >
> > Felix
> >
> >> Regards,
> >>
> >> Lisa JM Waugh
> >> Performance Test Engineer
> >> Pricing@IBM
> >> Phone: 1-720-342-5373 | Mobile: 1-704-907-7008
> >> E-mail: waugh@us.ibm.com<mailto:waugh@us.ibm.com>
> >>
> >> 3039 E Cornwallis Rd
> >> Research Triangle Park, NC 27709-2195
> >> United States
> >>
> >> On Dec 25, 2019, at 6:14 AM, Felix Schumacher <
> felix.schumacher@internetallee.de<mailto:felix.schumacher@internetallee.de>>
> wrote:
> >>
> >>
> >> Am 12.12.19 um 15:48 schrieb Lisa Waugh - waugh@us.ibm.com<mailto:
> waugh@us.ibm.com>:
> >> This has driven us nuts.
> >>
> >> We have a script that works fine in JMeter 5.2.1 with Java
> 1.8.0_181-b13.  It produces data in the tree view and summary view and runs
> clean.
> >>
> >> We try the same script with JMeter 5.2.1 with Java 1.8.0_221-b11 and
> the tree view doesn’t display at all.  An error message about:
> >>
> >> ERROR o.a.j.s.SampleResult: setEndTime must be called after setStartTime
> >> java.lang.Throwable: Invalid call sequence
> >> at
> org.apache.jmeter.samplers.SampleResult.setEndTime(SampleResult.java:1106)
> [ApacheJMeter_core.jar:5.2.1]
> >>
> >> And the start time in the output from the file writer shows a start
> time of 0.
> >>
> >> Here is the entire log:
> >>
> >> 2019-12-12 09:37:54,639 INFO o.a.j.e.StandardJMeterEngine: Running the
> test!
> >> 2019-12-12 09:37:54,639 INFO o.a.j.s.SampleEvent: List of
> sample_variables: []
> >> 2019-12-12 09:37:54,640 INFO o.a.j.g.u.JMeterMenuBar: setRunning(true,
> *local*)
> >> 2019-12-12 09:37:54,878 INFO o.a.j.e.StandardJMeterEngine: Starting
> ThreadGroup: 1 : Transaction Services
> >> 2019-12-12 09:37:54,879 INFO o.a.j.e.StandardJMeterEngine: Starting 1
> threads for group Transaction Services.
> >> 2019-12-12 09:37:54,879 INFO o.a.j.e.StandardJMeterEngine: Thread will
> continue on error
> >> 2019-12-12 09:37:54,879 INFO o.a.j.t.ThreadGroup: Starting thread
> group... number=1 threads=1 ramp-up=0 delayedStart=false
> >> 2019-12-12 09:37:54,879 INFO o.a.j.t.ThreadGroup: Started thread group
> number 1
> >> 2019-12-12 09:37:54,879 INFO o.a.j.e.StandardJMeterEngine: All thread
> groups have been started
> >> 2019-12-12 09:37:54,880 INFO o.a.j.t.JMeterThread: Thread started:
> Transaction Services 1-1
> >> 2019-12-12 09:37:54,880 INFO o.a.j.s.FileServer: Stored:
> /Users/perftest/ibm/QuoteHub/Credentials.csv
> >> 2019-12-12 09:37:54,880 INFO o.a.j.s.FileServer: Stored:
> /Users/perftest/github/quote-hub-test-automation/Jmeter/Non_Json.csv
> >> 2019-12-12 09:37:54,881 INFO o.a.j.s.FileServer: Stored:
> /Users/perftest/github/quote-hub-test-automation/Jmeter/Json.csv
> >> 2019-12-12 09:37:54,882 ERROR o.a.j.s.SampleResult: setEndTime must be
> called after setStartTime
> >> java.lang.Throwable: Invalid call sequence
> >> at
> org.apache.jmeter.samplers.SampleResult.setEndTime(SampleResult.java:1106)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:654)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:623)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.extractor.DebugPostProcessor.process(DebugPostProcessor.java:92)
> [ApacheJMeter_components.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.runPostProcessors(JMeterThread.java:931)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:569)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490)
> [ApacheJMeter_core.jar:5.2.1]
> >> at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257)
> [ApacheJMeter_core.jar:5.2.1]
> >> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_221]
> >> 2019-12-12 09:37:54,887 ERROR o.a.j.s.SampleResult: setEndTime must be
> called after setStartTime
> >> java.lang.Throwable: Invalid call sequence
> >> at
> org.apache.jmeter.samplers.SampleResult.setEndTime(SampleResult.java:1106)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:654)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:623)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.extractor.DebugPostProcessor.process(DebugPostProcessor.java:92)
> [ApacheJMeter_components.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.runPostProcessors(JMeterThread.java:931)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:569)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490)
> [ApacheJMeter_core.jar:5.2.1]
> >> at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257)
> [ApacheJMeter_core.jar:5.2.1]
> >> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_221]
> >> 2019-12-12 09:37:54,891 ERROR o.a.j.s.SampleResult: setEndTime must be
> called after setStartTime
> >> java.lang.Throwable: Invalid call sequence
> >> at
> org.apache.jmeter.samplers.SampleResult.setEndTime(SampleResult.java:1106)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:654)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.samplers.SampleResult.addSubResult(SampleResult.java:623)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.extractor.DebugPostProcessor.process(DebugPostProcessor.java:92)
> [ApacheJMeter_components.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.runPostProcessors(JMeterThread.java:931)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:569)
> [ApacheJMeter_core.jar:5.2.1]
> >> at
> org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490)
> [ApacheJMeter_core.jar:5.2.1]
> >> at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257)
> [ApacheJMeter_core.jar:5.2.1]
> >> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_221]
> >> 2019-12-12 09:37:54,894 INFO o.a.j.t.JMeterThread: Thread is done:
> Transaction Services 1-1
> >> 2019-12-12 09:37:54,894 INFO o.a.j.t.JMeterThread: Thread finished:
> Transaction Services 1-1
> >> 2019-12-12 09:37:54,894 INFO o.a.j.e.StandardJMeterEngine: Notifying
> test listeners of end of test
> >> 2019-12-12 09:37:54,894 INFO o.a.j.s.FileServer: Close:
> /Users/perftest/github/quote-hub-test-automation/Jmeter/Json.csv
> >> 2019-12-12 09:37:54,894 INFO o.a.j.s.FileServer: Close:
> /Users/perftest/github/quote-hub-test-automation/Jmeter/Non_Json.csv
> >> 2019-12-12 09:37:54,895 INFO o.a.j.s.FileServer: Close:
> /Users/perftest/ibm/QuoteHub/Credentials.csv
> >> 2019-12-12 09:37:54,895 INFO o.a.j.g.u.JMeterMenuBar: setRunning(false,
> *local*)
> >>
> >> Any ideas why?
> >>
> >> Can you give a simple test plan, that we can use to reproduce the issue?
> >>
> >> If I use a simple test plan with a JSR223 Sampler and one Debug Post
> >> Processor with Java 8 U232 and get no such error. So we are probably
> >> looking for a sampler that doesn't call setStartTime early enough.
> >>
> >> (On the tomcat project we had a report of errors after changing minor
> >> versions of Java 8 where a class had done too much overwriting over a
> >> parent class (jsp tags), maybe we have something similar here)
> >>
> >> Felix
> >>
> >>
> >> Regards,
> >>
> >> Lisa JM Waugh
> >> Performance Test Engineer
> >> Pricing@IBM
> >> Phone: 1-720-342-5373 | Mobile: 1-704-907-7008
> >> E-mail: waugh@us.ibm.com<mailto:waugh@us.ibm.com><mailto:
> waugh@us.ibm.com>
> >>
> >> 3039 E Cornwallis Rd
> >> Research Triangle Park, NC 27709-2195
> >> United States
> >>
> >>
> >> ---------------------------------------------------------------------
> >> To unsubscribe, e-mail: user-unsubscribe@jmeter.apache.org<mailto:
> user-unsubscribe@jmeter.apache.org>
> >> For additional commands, e-mail: user-help@jmeter.apache.org<mailto:
> user-help@jmeter.apache.org>
> >>
> > ---------------------------------------------------------------------
> > To unsubscribe, e-mail: user-unsubscribe@jmeter.apache.org
> > For additional commands, e-mail: user-help@jmeter.apache.org
> >
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: user-unsubscribe@jmeter.apache.org
> For additional commands, e-mail: user-help@jmeter.apache.org
>
>

Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message