See
<https://builds.apache.org/job/JMeter%20Windows/583/display/redirect?page=changes>
Changes:
[sebb] More Windows debug
------------------------------------------
[...truncated 129.95 KB...]
[jmeter] Tidying up ... @ Mon Apr 10 11:49:47 UTC 2017 (1491824987469)
[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 Apr 10 11:49:50 UTC 2017 (1491824990550)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 9 in 00:00:00 = 38.8/s Avg: 1 Min: 0 Max:
12 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:49:51 UTC 2017 (1491824991613)
[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 Apr 10 11:49:54 UTC 2017 (1491824994631)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 1 in 00:00:00 = 2.4/s Avg: 221 Min: 221 Max:
221 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:49:56 UTC 2017 (1491824996095)
[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 Apr 10 11:49:59 UTC 2017 (1491824999171)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:00 = 3.0/s Avg: 194 Min: 194 Max:
194 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary = 1 in 00:00:00 = 3.0/s Avg: 194 Min: 194 Max:
194 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:50:00 UTC 2017 (1491825000401)
[jmeter] ... end of run
[echo] Bug55375 output files compared OK
batchtestserver:
batchtest:
[echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2543
-Jsample_variables=REFERENCE,JSESSIONID
[server] Created remote object: UnicastServerRef [liveRef:
[endpoint:[10.20.2.147:58519](local),objID:[736caf48:15b57b30a2e:-7fff,
-4632663341636833565]]]
[client] Creating summariser <summary>
[client] Created the tree successfully using testfiles/Bug54685.jmx
[client] Configuring remote engine: localhost:2543
[client] Starting remote engines
[client] Starting the test @ Mon Apr 10 11:50:05 UTC 2017 (1491825005988)
[server] Starting the test on host localhost:2543 @ Mon Apr 10 11:50:07 UTC
2017 (1491825007675)
[client] Remote engines have been started
[client] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[server] Finished the test on host localhost:2543 @ Mon Apr 10 11:50:09 UTC
2017 (1491825009089) - exit requested.
[client] summary = 1 in 00:00:01 = 1.9/s Avg: 317 Min: 317 Max:
317 Err: 0 (0.00%)
[client] Tidying up remote @ Mon Apr 10 11:50:09 UTC 2017 (1491825009089)
[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 Apr 10 11:50:17 UTC 2017 (1491825017202)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 9 in 00:00:09 = 1.0/s Avg: 152 Min: 0 Max:
309 Err: 3 (33.33%)
[jmeter] Tidying up ... @ Mon Apr 10 11:50:27 UTC 2017 (1491825027148)
[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 Apr 10 11:50:30 UTC 2017 (1491825030898)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:01 = 1.4/s Avg: 251 Min: 251 Max:
251 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 1 in 00:00:30 = 0.0/s Avg: 30123 Min: 30123 Max:
30123 Err: 0 (0.00%) Active: 1 Started: 2 Finished: 1
[jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15187 Min: 251 Max:
30123 Err: 0 (0.00%)
[jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15187 Min: 251 Max:
30123 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:51:02 UTC 2017 (1491825062753)
[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 Apr 10 11:51:06 UTC 2017 (1491825066613)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 3 in 00:00:18 = 0.2/s Avg: 5821 Min: 690 Max:
10999 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:51:25 UTC 2017 (1491825085503)
[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 Apr 10 11:51:29 UTC 2017 (1491825089489)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:01 = 1.4/s Avg: 670 Min: 670 Max:
670 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 1 in 00:00:12 = 0.1/s Avg: 11586 Min: 11586 Max:
11586 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 2 in 00:00:13 = 0.2/s Avg: 6128 Min: 670 Max:
11586 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:51:43 UTC 2017 (1491825103047)
[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 Apr 10 11:51:46 UTC 2017 (1491825106312)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 12 in 00:00:05 = 2.4/s Avg: 129 Min: 15 Max:
860 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:51:52 UTC 2017 (1491825112916)
[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 Apr 10 11:51:56 UTC 2017 (1491825116231)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 3 in 00:00:02 = 1.2/s Avg: 292 Min: 14 Max:
797 Err: 0 (0.00%) Active: 1 Started: 2 Finished: 1
[jmeter] summary + 9 in 00:00:02 = 4.2/s Avg: 16 Min: 14 Max:
21 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6
[jmeter] summary = 12 in 00:00:05 = 2.6/s Avg: 85 Min: 14 Max:
797 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:52:02 UTC 2017 (1491825122432)
[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 Apr 10 11:52:05 UTC 2017 (1491825125835)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 7 in 00:01:01 = 0.1/s Avg: 146 Min: 16 Max:
689 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:08 UTC 2017 (1491825188902)
[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 Apr 10 11:53:12 UTC 2017 (1491825192291)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 3 in 00:00:06 = 0.5/s Avg: 2044 Min: 2003 Max:
2125 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:19 UTC 2017 (1491825199775)
[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 Apr 10 11:53:22 UTC 2017 (1491825202924)
[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:
1032 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:27 UTC 2017 (1491825207348)
[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 Apr 10 11:53:31 UTC 2017 (1491825211712)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary + 1 in 00:00:01 = 1.4/s Avg: 672 Min: 672 Max:
672 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 20 in 00:00:01 = 15.6/s Avg: 37 Min: 2 Max:
240 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 21 in 00:00:02 = 10.4/s Avg: 68 Min: 2 Max:
672 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:34 UTC 2017 (1491825214580)
[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 Apr 10 11:53:39 UTC 2017 (1491825219322)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 19 in 00:00:02 = 10.7/s Avg: 68 Min: 1 Max:
672 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:41 UTC 2017 (1491825221846)
[jmeter] ... end of run
[concat] 2017-04-10 11:53:41,731 ERROR o.a.j.p.h.s.HTTPJavaImpl:
readResponse: java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-04-10 11:53:41,735 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause:
java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-04-10 11:53:41,737 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:r1790804]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPJavaImpl.sample(HTTPJavaImpl.java:612)
[ApacheJMeter_http.jar:r1790804]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74)
[ApacheJMeter_http.jar:r1790804]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1189)
[ApacheJMeter_http.jar:r1790804]
[concat] at
org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1178)
[ApacheJMeter_http.jar:r1790804]
[concat] at
org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:491)
[ApacheJMeter_core.jar:r1790804]
[concat] at
org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:425)
[ApacheJMeter_core.jar:r1790804]
[concat] at
org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:254)
[ApacheJMeter_core.jar:r1790804]
[concat] at java.lang.Thread.run(Thread.java:745) [?:1.8.0_121]
[concat] 2017-04-10 11:53:41,744 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 Apr 10 11:53:46 UTC 2017 (1491825226321)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port
4445
[jmeter] summary = 6 in 00:00:06 = 1.0/s Avg: 134 Min: 1 Max:
631 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Mon Apr 10 11:53:53 UTC 2017 (1491825233875)
[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>:2846: Java
returned: 1
Total time: 9 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
