See
<https://builds.apache.org/job/JMeter%20Windows/609/display/redirect?page=changes>
Changes:
[pmouawad] Fix test failure
[pmouawad] Improve logging
Fix SONAR error
Clariy code
Use try with resource
------------------------------------------
[...truncated 128.99 KB...]
[jmeter] Starting the test @ Mon May 01 11:05:39 UTC 2017 (1493636739382)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 2 in 00:00:00 = 4.6/s Avg: 145 Min: 116 Max:
174 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:05:40 UTC 2017 (1493636740801)
[jmeter] ... end of run
[echo] Bug50898 output files compared OK
batchtest:
[echo] Starting Bug56243 with file Bug56243.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug56243.jmx
[jmeter] Starting the test @ Mon May 01 11:05:44 UTC 2017 (1493636744014)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 9 in 00:00:00 = 36.1/s Avg: 1 Min: 0 Max:
12 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:05:45 UTC 2017 (1493636745089)
[jmeter] ... end of run
[echo] Bug56243 output files compared OK
batchtest:
[echo] Starting Bug54685 with file Bug54685.jmx using -X
-Jsample_variables=REFERENCE,JSESSIONID
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug54685.jmx
[jmeter] Starting the test @ Mon May 01 11:05:48 UTC 2017 (1493636748233)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 1 in 00:00:00 = 2.7/s Avg: 231 Min: 231 Max:
231 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:05:49 UTC 2017 (1493636749468)
[jmeter] ... end of run
[echo] Bug54685 output files compared OK
batchtest:
[echo] Starting Bug55375 with file Bug55375.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug55375.jmx
[jmeter] Starting the test @ Mon May 01 11:05:52 UTC 2017 (1493636752616)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 1 in 00:00:00 = 2.2/s Avg: 305 Min: 305 Max:
305 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:05:53 UTC 2017 (1493636753948)
[jmeter] ... end of run
[echo] Bug55375 output files compared OK
batchtestserver:
batchtest:
[echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2580
-Jsample_variables=REFERENCE,JSESSIONID
[server] Created remote object: UnicastServerRef [liveRef:
[endpoint:[10.20.2.147:57384](local),objID:[7f17eb42:15bc3b03479:-7fff,
5623934805124253294]]]
[client] Creating summariser <summary>
[client] Created the tree successfully using testfiles/Bug54685.jmx
[client] Configuring remote engine: localhost:2580
[client] Starting remote engines
[client] Starting the test @ Mon May 01 11:05:59 UTC 2017 (1493636759485)
[server] Starting the test on host localhost:2580 @ Mon May 01 11:06:01 UTC
2017 (1493636761161)
[client] Remote engines have been started
[client] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[client] summary + 1 in 00:00:00 = 3.4/s Avg: 134 Min: 134 Max:
134 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[client] summary = 1 in 00:00:00 = 3.3/s Avg: 134 Min: 134 Max:
134 Err: 0 (0.00%)
[client] Tidying up remote @ Mon May 01 11:06:02 UTC 2017 (1493636762306)
[server] Finished the test on host localhost:2580 @ Mon May 01 11:06:02 UTC
2017 (1493636762306) - exit requested.
[client] ... end of run
[echo] Bug54685 output files compared OK
batchtest:
[echo] Starting Bug56811 with file Bug56811.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug56811.jmx
[jmeter] Starting the test @ Mon May 01 11:06:10 UTC 2017 (1493636770549)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 9 in 00:00:09 = 1.0/s Avg: 146 Min: 1 Max:
346 Err: 3 (33.33%)
[jmeter] Tidying up ... @ Mon May 01 11:06:20 UTC 2017 (1493636780496)
[jmeter] ... end of run
[echo] Bug56811 output files compared OK
batchtest:
batchtest:
[echo] Starting Bug60607 with file Bug60607.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug60607.jmx
[jmeter] Starting the test @ Mon May 01 11:06:23 UTC 2017 (1493636783863)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15318 Min: 533 Max:
30103 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:06:55 UTC 2017 (1493636815716)
[jmeter] ... end of run
[echo] Bug60607 output files compared OK
batchtest:
[echo] Starting SlowCharsFeature_HttpClient4 with file
SlowCharsFeature.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx
[jmeter] Starting the test @ Mon May 01 11:06:59 UTC 2017 (1493636819573)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:01 = 1.5/s Avg: 644 Min: 644 Max:
644 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 2 in 00:00:18 = 0.1/s Avg: 8757 Min: 5920 Max:
11595 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 3 in 00:00:19 = 0.2/s Avg: 6053 Min: 644 Max:
11595 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:07:19 UTC 2017 (1493636839120)
[jmeter] ... end of run
[echo] SlowCharsFeature_HttpClient4 output files compared OK
batchtest:
[echo] Starting SlowCharsFeature_Java with file SlowCharsFeature.jmx using
-X -Jjmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx
[jmeter] Starting the test @ Mon May 01 11:07:23 UTC 2017 (1493636843012)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 2 in 00:00:13 = 0.2/s Avg: 6332 Min: 640 Max:
12024 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:07:37 UTC 2017 (1493636857099)
[jmeter] ... end of run
[echo] SlowCharsFeature_Java output files compared OK
batchtest:
[echo] Starting Http4ImplPreemptiveBasicAuth with file
Http4ImplPreemptiveBasicAuth.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using
testfiles/Http4ImplPreemptiveBasicAuth.jmx
[jmeter] Starting the test @ Mon May 01 11:07:40 UTC 2017 (1493636860184)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 12 in 00:00:09 = 1.3/s Avg: 461 Min: 158 Max:
1472 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:07:50 UTC 2017 (1493636870763)
[jmeter] ... end of run
[echo] Http4ImplPreemptiveBasicAuth output files compared OK
batchtest:
[echo] Starting Http4ImplPreemptiveBasicAuth with file
Http4ImplPreemptiveBasicAuth.jmx using -X -Jjmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using
testfiles/Http4ImplPreemptiveBasicAuth.jmx
[jmeter] Starting the test @ Mon May 01 11:07:54 UTC 2017 (1493636874030)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 4 in 00:00:05 = 0.9/s Avg: 730 Min: 169 Max:
1308 Err: 0 (0.00%) Active: 1 Started: 2 Finished: 1
[jmeter] summary + 8 in 00:00:03 = 2.6/s Avg: 185 Min: 161 Max:
319 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6
[jmeter] summary = 12 in 00:00:08 = 1.6/s Avg: 367 Min: 161 Max:
1308 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:08:03 UTC 2017 (1493636883196)
[jmeter] ... end of run
[echo] Http4ImplPreemptiveBasicAuth output files compared OK
batchtest:
[echo] Starting TestKeepAlive with file TestKeepAlive.jmx using -X
-Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestKeepAlive.jmx
[jmeter] Starting the test @ Mon May 01 11:08:06 UTC 2017 (1493636886462)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 7 in 00:01:03 = 0.1/s Avg: 332 Min: 169 Max:
646 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:10 UTC 2017 (1493636950854)
[jmeter] ... end of run
[echo] TestKeepAlive output files compared OK
batchtest:
[echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X
-Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx
[jmeter] Starting the test @ Mon May 01 11:09:13 UTC 2017 (1493636953998)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 3 in 00:00:06 = 0.5/s Avg: 2043 Min: 2000 Max:
2127 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:21 UTC 2017 (1493636961310)
[jmeter] ... end of run
[echo] TestHeaderManager output files compared OK
batchtest:
[echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X
-Jjmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx
[jmeter] Starting the test @ Mon May 01 11:09:24 UTC 2017 (1493636964372)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 3 in 00:00:03 = 0.9/s Avg: 1013 Min: 1002 Max:
1035 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:28 UTC 2017 (1493636968639)
[jmeter] ... end of run
[echo] TestHeaderManager output files compared OK
batchtest:
[echo] Starting TEST_HTTP_HttpClient4 with file TEST_HTTP.jmx using -X
-Jjmeter.httpsampler=HttpClient4
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx
[jmeter] Starting the test @ Mon May 01 11:09:32 UTC 2017 (1493636972468)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:01 = 1.4/s Avg: 664 Min: 664 Max:
664 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 20 in 00:00:01 = 17.3/s Avg: 33 Min: 2 Max:
204 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 21 in 00:00:02 = 11.1/s Avg: 63 Min: 2 Max:
664 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:35 UTC 2017 (1493636975135)
[jmeter] ... end of run
[echo] TEST_HTTP_HttpClient4 output files compared OK
batchtest:
[echo] Starting TEST_HTTP_Java with file TEST_HTTP.jmx using -X
-Jjmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx
[jmeter] Starting the test @ Mon May 01 11:09:39 UTC 2017 (1493636979908)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 19 in 00:00:02 = 11.4/s Avg: 63 Min: 2 Max:
699 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:42 UTC 2017 (1493636982320)
[jmeter] ... end of run
[concat] 2017-05-01 11:09:42,164 ERROR o.a.j.p.h.s.HTTPJavaImpl:
readResponse: java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-05-01 11:09:42,170 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause:
java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-05-01 11:09:42,172 ERROR o.a.j.s.SampleResult: sampleEnd
called twice
[concat] java.lang.Throwable: Invalid call sequence
[concat] at
org.apache.jmeter.samplers.SampleResult.sampleEnd(SampleResult.java:1099)
[ApacheJMeter_core.jar:r1793304]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPJavaImpl.sample(HTTPJavaImpl.java:612)
[ApacheJMeter_http.jar:r1793304]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74)
[ApacheJMeter_http.jar:r1793304]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1189)
[ApacheJMeter_http.jar:r1793304]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1178)
[ApacheJMeter_http.jar:r1793304]
[concat] at
org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:491)
[ApacheJMeter_core.jar:r1793304]
[concat] at
org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:425)
[ApacheJMeter_core.jar:r1793304]
[concat] at
org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:254)
[ApacheJMeter_core.jar:r1793304]
[concat] at java.lang.Thread.run(Thread.java:745) [?:1.8.0_121]
[concat] 2017-05-01 11:09:42,186 ERROR o.a.j.p.h.c.HttpMirrorThread: Invalid
request received:''
[echo] TEST_HTTP_Java output files compared OK
batchtest:
[echo] Starting TestSchedulerWithTimer with file
TestSchedulerWithTimer.jmx using -X -Jdummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using
testfiles/TestSchedulerWithTimer.jmx
[jmeter] Starting the test @ Mon May 01 11:09:46 UTC 2017 (1493636986327)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 6 in 00:00:06 = 1.0/s Avg: 127 Min: 0 Max:
636 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon May 01 11:09:53 UTC 2017 (1493636993643)
[jmeter] ... end of run
[echo] TestSchedulerWithTimer output files compared OK
_allbatchtests:
Cannot execute 'test' - '_test' failed or was not executed.
download_checkstyle:
_process_checkstyle_jars:
_check_exists:
_check_jarfile:
[echo] Checking checkstyle-6.13-all.jar
[echo] Deleting checkstyle-6.13-all.jar (excluding checkstyle-6.13-all.jar)
setproxy:
_get_jarfile:
setproxy:
_get_zipfile:
checkstyle:
_process_checkstyle_jars:
_check_exists:
_check_jarfile:
[checkstyle] Running Checkstyle 6.13 on 1045 files
BUILD FAILED
<https://builds.apache.org/job/JMeter%20Windows/ws/trunk\build.xml>:2848: Java
returned: 1
Total time: 9 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure