See <https://builds.apache.org/job/JMeter%20Windows/582/display/redirect?page=changes>
Changes: [sebb] Add a simpler test to try and debug the Windows failure [sebb] Generics ------------------------------------------ [...truncated 129.74 KB...] [jmeter] Created the tree successfully using testfiles/Bug50898.jmx [jmeter] Starting the test @ Mon Apr 10 11:18:36 UTC 2017 (1491823116947) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 2 in 00:00:01 = 3.6/s Avg: 205 Min: 130 Max: 280 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:18:38 UTC 2017 (1491823118398) [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:18:41 UTC 2017 (1491823121998) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 9 in 00:00:00 = 36.0/s Avg: 1 Min: 0 Max: 13 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:18:43 UTC 2017 (1491823123065) [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:18:46 UTC 2017 (1491823126296) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 1 in 00:00:00 = 2.1/s Avg: 322 Min: 322 Max: 322 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:18:47 UTC 2017 (1491823127684) [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:18:50 UTC 2017 (1491823130800) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 1 in 00:00:00 = 2.9/s Avg: 207 Min: 207 Max: 207 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:18:52 UTC 2017 (1491823132047) [jmeter] ... end of run [echo] Bug55375 output files compared OK batchtestserver: batchtest: [echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2970 -Jsample_variables=REFERENCE,JSESSIONID [server] Created remote object: UnicastServerRef [liveRef: [endpoint:[10.20.2.147:57482](local),objID:[-4ab53be6:15b579687f1:-7fff, -9217727165889179569]]] [client] Creating summariser <summary> [client] Created the tree successfully using testfiles/Bug54685.jmx [client] Configuring remote engine: localhost:2970 [client] Starting remote engines [client] Starting the test @ Mon Apr 10 11:18:58 UTC 2017 (1491823138108) [server] Starting the test on host localhost:2970 @ Mon Apr 10 11:18:59 UTC 2017 (1491823139847) [client] Remote engines have been started [client] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [server] Finished the test on host localhost:2970 @ Mon Apr 10 11:19:01 UTC 2017 (1491823141165) - exit requested. [client] summary + 1 in 00:00:00 = 2.2/s Avg: 292 Min: 292 Max: 292 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [client] summary = 1 in 00:00:00 = 2.2/s Avg: 292 Min: 292 Max: 292 Err: 0 (0.00%) [client] Tidying up remote @ Mon Apr 10 11:19:01 UTC 2017 (1491823141165) [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:19:09 UTC 2017 (1491823149455) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 9 in 00:00:09 = 1.0/s Avg: 130 Min: 1 Max: 308 Err: 3 (33.33%) [jmeter] Tidying up ... @ Mon Apr 10 11:19:19 UTC 2017 (1491823159366) [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:19:22 UTC 2017 (1491823162480) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15316 Min: 527 Max: 30106 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:19:54 UTC 2017 (1491823194299) [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:19:58 UTC 2017 (1491823198314) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 3 in 00:00:19 = 0.2/s Avg: 6077 Min: 666 Max: 11636 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:20:18 UTC 2017 (1491823218013) [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:20:21 UTC 2017 (1491823221879) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary + 2 in 00:00:13 = 0.2/s Avg: 6391 Min: 655 Max: 12128 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary = 2 in 00:00:13 = 0.2/s Avg: 6391 Min: 655 Max: 12128 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:20:35 UTC 2017 (1491823235948) [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:20:39 UTC 2017 (1491823239108) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 12 in 00:00:09 = 1.3/s Avg: 462 Min: 161 Max: 1527 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:20:50 UTC 2017 (1491823250026) [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:20:53 UTC 2017 (1491823253401) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary + 8 in 00:00:05 = 1.5/s Avg: 340 Min: 163 Max: 1360 Err: 0 (0.00%) Active: 1 Started: 4 Finished: 3 [jmeter] summary + 4 in 00:00:01 = 2.7/s Avg: 166 Min: 162 Max: 170 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6 [jmeter] summary = 12 in 00:00:07 = 1.8/s Avg: 282 Min: 162 Max: 1360 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:21:01 UTC 2017 (1491823261683) [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:21:04 UTC 2017 (1491823264882) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 7 in 00:01:03 = 0.1/s Avg: 342 Min: 165 Max: 711 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:09 UTC 2017 (1491823329479) [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:22:13 UTC 2017 (1491823333095) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 3 in 00:00:07 = 0.5/s Avg: 2047 Min: 2009 Max: 2122 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:20 UTC 2017 (1491823340751) [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:22:23 UTC 2017 (1491823343950) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 3 in 00:00:03 = 0.9/s Avg: 1015 Min: 1002 Max: 1033 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:28 UTC 2017 (1491823348124) [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:22:33 UTC 2017 (1491823353190) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary + 1 in 00:00:01 = 1.3/s Avg: 688 Min: 688 Max: 688 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary + 20 in 00:00:01 = 15.7/s Avg: 37 Min: 2 Max: 232 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: 688 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:36 UTC 2017 (1491823356215) [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:22:41 UTC 2017 (1491823361233) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 19 in 00:00:02 = 11.8/s Avg: 61 Min: 1 Max: 638 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:43 UTC 2017 (1491823363646) [jmeter] ... end of run [concat] 2017-04-10 11:22:43,544 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException: Server redirected too many times (20) [concat] 2017-04-10 11:22:43,548 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException: Server redirected too many times (20) [concat] 2017-04-10 11:22:43,549 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:r1790803] [concat] at org.apache.jmeter.protocol.http.sampler.HTTPJavaImpl.sample(HTTPJavaImpl.java:612) [ApacheJMeter_http.jar:r1790803] [concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74) [ApacheJMeter_http.jar:r1790803] [concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1189) [ApacheJMeter_http.jar:r1790803] [concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1178) [ApacheJMeter_http.jar:r1790803] [concat] at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:491) [ApacheJMeter_core.jar:r1790803] [concat] at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:425) [ApacheJMeter_core.jar:r1790803] [concat] at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:254) [ApacheJMeter_core.jar:r1790803] [concat] at java.lang.Thread.run(Thread.java:745) [?:1.8.0_121] [concat] 2017-04-10 11:22:43,556 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:22:47 UTC 2017 (1491823367751) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 6 in 00:00:06 = 1.0/s Avg: 168 Min: 0 Max: 872 Err: 0 (0.00%) [jmeter] Tidying up ... @ Mon Apr 10 11:22:55 UTC 2017 (1491823375461) [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 22 seconds Build step 'Invoke Ant' marked build as failure