You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@jmeter.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/03/01 23:05:34 UTC
Build failed in Jenkins: JMeter-trunk #5974
See <https://builds.apache.org/job/JMeter-trunk/5974/display/redirect?page=changes>
Changes:
[pmouawad] Bug 60797 - TestAction in pause mode can last beyond configured duration of test
Move class to correct module
Bugzilla Id: 60797
------------------------------------------
[...truncated 119.36 KB...]
[echo] Starting Bug52968 with file Bug52968.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug52968.jmx
[jmeter] Starting the test @ Wed Mar 01 23:01:43 UTC 2017 (1488409303401)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 30 in 00:00:13 = 2.4/s Avg: 223 Min: 102 Max: 352 Err: 9 (30.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:01:56 UTC 2017 (1488409316527)
[jmeter] ... end of run
[echo] Bug52968 output files compared OK
batchtest:
[echo] Starting Bug50898 with file Bug50898.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug50898.jmx
[jmeter] Starting the test @ Wed Mar 01 23:01:58 UTC 2017 (1488409318608)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 2 in 00:00:01 = 3.7/s Avg: 209 Min: 116 Max: 303 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:01:59 UTC 2017 (1488409319596)
[jmeter] ... end of run
[echo] Bug50898 output files compared OK
batchtest:
[echo] Starting Bug56243 with file Bug56243.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug56243.jmx
[jmeter] Starting the test @ Wed Mar 01 23:02:01 UTC 2017 (1488409321708)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 1 in 00:00:00 = 6.5/s Avg: 5 Min: 5 Max: 5 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 8 in 00:00:00 = 296.3/s Avg: 0 Min: 0 Max: 1 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 9 in 00:00:00 = 49.7/s Avg: 0 Min: 0 Max: 5 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:02:02 UTC 2017 (1488409322349)
[jmeter] ... end of run
[echo] Bug56243 output files compared OK
batchtest:
[echo] Starting Bug54685 with file Bug54685.jmx using -X -Dsample_variables=REFERENCE,JSESSIONID
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug54685.jmx
[jmeter] Starting the test @ Wed Mar 01 23:02:04 UTC 2017 (1488409324449)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 1 in 00:00:00 = 4.1/s Avg: 105 Min: 105 Max: 105 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary = 1 in 00:00:00 = 4.0/s Avg: 105 Min: 105 Max: 105 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:02:05 UTC 2017 (1488409325202)
[jmeter] ... end of run
[echo] Bug54685 output files compared OK
batchtest:
[echo] Starting Bug55375 with file Bug55375.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug55375.jmx
[jmeter] Starting the test @ Wed Mar 01 23:02:07 UTC 2017 (1488409327322)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 1 in 00:00:00 = 4.0/s Avg: 128 Min: 128 Max: 128 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:02:08 UTC 2017 (1488409328044)
[jmeter] ... end of run
[echo] Bug55375 output files compared OK
batchtestserver:
[server] Created remote object: UnicastServerRef [liveRef: [endpoint:[67.195.81.159:36523](local),objID:[-552d32b3:15a8c1c008c:-7fff, -6683613735412365089]]]
batchtest:
[echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2970 -Dsample_variables=REFERENCE,JSESSIONID
[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 @ Wed Mar 01 23:02:12 UTC 2017 (1488409332438)
[server] Starting the test on host localhost:2970 @ Wed Mar 01 23:02:13 UTC 2017 (1488409333684)
[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 @ Wed Mar 01 23:02:14 UTC 2017 (1488409334402) - exit requested.
[client] summary = 1 in 00:00:00 = 4.1/s Avg: 107 Min: 107 Max: 107 Err: 0 (0.00%)
[client] Tidying up remote @ Wed Mar 01 23:02:14 UTC 2017 (1488409334402)
[client] ... end of run
[echo] Bug54685 output files compared OK
batchtest:
[echo] Starting Bug56811 with file Bug56811.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug56811.jmx
[jmeter] Starting the test @ Wed Mar 01 23:02:21 UTC 2017 (1488409341566)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 4 in 00:00:08 = 0.5/s Avg: 197 Min: 2 Max: 271 Err: 1 (25.00%) Active: 1 Started: 4 Finished: 3
[jmeter] summary + 5 in 00:00:01 = 6.4/s Avg: 154 Min: 0 Max: 330 Err: 2 (40.00%) Active: 0 Started: 4 Finished: 4
[jmeter] summary = 9 in 00:00:09 = 1.0/s Avg: 173 Min: 0 Max: 330 Err: 3 (33.33%)
[jmeter] Tidying up ... @ Wed Mar 01 23:02:31 UTC 2017 (1488409351032)
[jmeter] ... end of run
[echo] Bug56811 output files compared OK
batchtest:
batchtest:
[echo] Starting Bug60607 with file Bug60607.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Bug60607.jmx
[jmeter] Starting the test @ Wed Mar 01 23:02:33 UTC 2017 (1488409353129)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 1 in 00:00:01 = 1.6/s Avg: 394 Min: 394 Max: 394 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 1 in 00:00:30 = 0.0/s Avg: 30076 Min: 30076 Max: 30076 Err: 0 (0.00%) Active: 1 Started: 2 Finished: 1
[jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15235 Min: 394 Max: 30076 Err: 0 (0.00%)
[jmeter] summary = 2 in 00:00:31 = 0.1/s Avg: 15235 Min: 394 Max: 30076 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:03:04 UTC 2017 (1488409384318)
[jmeter] ... end of run
[echo] Bug60607 output files compared OK
batchtest:
[echo] Starting SlowCharsFeature_HttpClient4 with file SlowCharsFeature.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx
[jmeter] Starting the test @ Wed Mar 01 23:03:06 UTC 2017 (1488409386666)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 3 in 00:00:18 = 0.2/s Avg: 5772 Min: 340 Max: 11169 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:03:24 UTC 2017 (1488409404836)
[jmeter] ... end of run
[echo] SlowCharsFeature_HttpClient4 output files compared OK
batchtest:
[echo] Starting SlowCharsFeature_Java with file SlowCharsFeature.jmx using -X -Djmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx
[jmeter] Starting the test @ Wed Mar 01 23:03:27 UTC 2017 (1488409407253)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 2 in 00:00:12 = 0.2/s Avg: 5983 Min: 345 Max: 11621 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:03:40 UTC 2017 (1488409420056)
[jmeter] ... end of run
[echo] SlowCharsFeature_Java output files compared OK
batchtest:
[echo] Starting Http4ImplPreemptiveBasicAuth with file Http4ImplPreemptiveBasicAuth.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Http4ImplPreemptiveBasicAuth.jmx
[jmeter] Starting the test @ Wed Mar 01 23:03:42 UTC 2017 (1488409422036)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 12 in 00:00:08 = 1.5/s Avg: 392 Min: 153 Max: 1096 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:03:50 UTC 2017 (1488409430675)
[jmeter] ... end of run
[echo] Http4ImplPreemptiveBasicAuth output files compared OK
batchtest:
[echo] Starting Http4ImplPreemptiveBasicAuth with file Http4ImplPreemptiveBasicAuth.jmx using -X -Djmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/Http4ImplPreemptiveBasicAuth.jmx
[jmeter] Starting the test @ Wed Mar 01 23:03:52 UTC 2017 (1488409432971)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 12 in 00:00:06 = 2.0/s Avg: 244 Min: 152 Max: 1060 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:03:59 UTC 2017 (1488409439832)
[jmeter] ... end of run
[echo] Http4ImplPreemptiveBasicAuth output files compared OK
batchtest:
[echo] Starting TestKeepAlive with file TestKeepAlive.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestKeepAlive.jmx
[jmeter] Starting the test @ Wed Mar 01 23:04:02 UTC 2017 (1488409442120)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 1 in 00:00:00 = 2.3/s Avg: 409 Min: 409 Max: 409 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary + 5 in 00:00:32 = 0.2/s Avg: 239 Min: 154 Max: 416 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary = 6 in 00:00:32 = 0.2/s Avg: 267 Min: 154 Max: 416 Err: 0 (0.00%)
[jmeter] summary + 1 in 00:00:30 = 0.0/s Avg: 324 Min: 324 Max: 324 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
[jmeter] summary = 7 in 00:01:02 = 0.1/s Avg: 275 Min: 154 Max: 416 Err: 0 (0.00%)
[jmeter] summary = 7 in 00:01:02 = 0.1/s Avg: 275 Min: 154 Max: 416 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:05 UTC 2017 (1488409505340)
[jmeter] ... end of run
[echo] TestKeepAlive output files compared OK
batchtest:
[echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx
[jmeter] Starting the test @ Wed Mar 01 23:05:07 UTC 2017 (1488409507313)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 3 in 00:00:00 = 9.0/s Avg: 18 Min: 1 Max: 54 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:08 UTC 2017 (1488409508188)
[jmeter] ... end of run
[echo] TestHeaderManager output files compared OK
batchtest:
[echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X -Djmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx
[jmeter] Starting the test @ Wed Mar 01 23:05:10 UTC 2017 (1488409510235)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 3 in 00:00:00 = 15.5/s Avg: 4 Min: 0 Max: 12 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:10 UTC 2017 (1488409510936)
[jmeter] ... end of run
[echo] TestHeaderManager output files compared OK
batchtest:
[echo] Starting TEST_HTTP_HttpClient4 with file TEST_HTTP.jmx using -X -Djmeter.httpsampler=HttpClient4
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx
[jmeter] Starting the test @ Wed Mar 01 23:05:13 UTC 2017 (1488409513605)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 21 in 00:00:01 = 23.0/s Avg: 27 Min: 1 Max: 353 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:15 UTC 2017 (1488409515036)
[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 -Djmeter.httpsampler=Java
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx
[jmeter] Starting the test @ Wed Mar 01 23:05:18 UTC 2017 (1488409518548)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary = 19 in 00:00:06 = 3.2/s Avg: 288 Min: 0 Max: 5030 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:24 UTC 2017 (1488409524881)
[jmeter] ... end of run
[concat] 2017-03-01 23:05:24,813 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-03-01 23:05:24,815 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException: Server redirected too many times (20)
[concat] 2017-03-01 23:05:24,816 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:r1785063]
[concat] at org.apache.jmeter.protocol.http.sampler.HTTPJavaImpl.sample(HTTPJavaImpl.java:612) [ApacheJMeter_http.jar:r1785063]
[concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74) [ApacheJMeter_http.jar:r1785063]
[concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1189) [ApacheJMeter_http.jar:r1785063]
[concat] at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1178) [ApacheJMeter_http.jar:r1785063]
[concat] at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:486) [ApacheJMeter_core.jar:r1785063]
[concat] at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:425) [ApacheJMeter_core.jar:r1785063]
[concat] at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:254) [ApacheJMeter_core.jar:r1785063]
[concat] at java.lang.Thread.run(Thread.java:745) [?:1.8.0_121]
[concat] 2017-03-01 23:05:24,820 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 -Ddummy=dummy
[jmeter] Creating summariser <summary>
[jmeter] Created the tree successfully using testfiles/TestSchedulerWithTimer.jmx
[jmeter] Starting the test @ Wed Mar 01 23:05:27 UTC 2017 (1488409527995)
[jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
[jmeter] summary + 5 in 00:00:06 = 0.9/s Avg: 73 Min: 0 Max: 357 Err: 0 (0.00%) Active: 1 Started: 3 Finished: 2
[jmeter] summary + 1 in 00:00:00 = 11.5/s Avg: 76 Min: 76 Max: 76 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
[jmeter] summary = 6 in 00:00:06 = 1.1/s Avg: 73 Min: 0 Max: 357 Err: 0 (0.00%)
[jmeter] Tidying up ... @ Wed Mar 01 23:05:34 UTC 2017 (1488409534392)
[jmeter] ... end of run
BUILD FAILED
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/build.xml>:2779: The following error occurred while executing this line:
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/build.xml>:2597: CSV Files are not identical.
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/bin/testfiles/TestSchedulerWithTimer.csv>
JSRCheckDuration,200,tearDown Thread Group 1-1,text,true,null,null,null,null,null,null,null,null,null,null
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/bin/TestSchedulerWithTimer.csv>
JSRCheckDuration,200,tearDown Thread Group 1-1,text,true
Total time: 8 minutes 29 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Archiving artifacts
Jenkins build is back to normal : JMeter-trunk #5975
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/JMeter-trunk/5975/display/redirect?page=changes>