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/20 21:09:50 UTC

Build failed in Jenkins: JMeter-trunk #6054

See <https://builds.apache.org/job/JMeter-trunk/6054/display/redirect?page=changes>

Changes:

[pmouawad] Improve doc

------------------------------------------
[...truncated 116.49 KB...]
   [jmeter] Starting the test @ Mon Mar 20 21:04:56 UTC 2017 (1490043896267)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:03 =    1.0/s Avg:   603 Min:    25 Max:  1287 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:04:59 UTC 2017 (1490043899935)
   [jmeter] ... end of run
     [echo] Bug52310 output files compared OK

batchtest:
     [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 @ Mon Mar 20 21:05:04 UTC 2017 (1490043904334)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:00 =    2.1/s Avg:   218 Min:   218 Max:   218 Err:     0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +     29 in 00:00:12 =    2.4/s Avg:   220 Min:   106 Max:   344 Err:     9 (31.03%) Active: 0 Started: 10 Finished: 10
   [jmeter] summary =     30 in 00:00:12 =    2.4/s Avg:   220 Min:   106 Max:   344 Err:     9 (30.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:05:17 UTC 2017 (1490043917514)
   [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 @ Mon Mar 20 21:05:21 UTC 2017 (1490043921925)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      2 in 00:00:01 =    2.5/s Avg:   168 Min:   146 Max:   190 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:05:23 UTC 2017 (1490043923973)
   [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 @ Mon Mar 20 21:05:28 UTC 2017 (1490043928267)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      9 in 00:00:00 =   20.9/s Avg:     2 Min:     0 Max:    15 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:05:29 UTC 2017 (1490043929844)
   [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 @ Mon Mar 20 21:05:34 UTC 2017 (1490043934093)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      1 in 00:00:01 =    1.1/s Avg:   356 Min:   356 Max:   356 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:05:36 UTC 2017 (1490043936407)
   [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 @ Mon Mar 20 21:05:39 UTC 2017 (1490043939504)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      1 in 00:00:01 =    1.8/s Avg:   196 Min:   196 Max:   196 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:05:40 UTC 2017 (1490043940915)
   [jmeter] ... end of run
     [echo] Bug55375 output files compared OK

batchtestserver:

batchtest:
     [echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2289 -Dsample_variables=REFERENCE,JSESSIONID
   [server] Created remote object: UnicastServerRef [liveRef: [endpoint:[67.195.81.186:58986](local),objID:[7c2fe70f:15aed8a3ab9:-7fff, 4413338461585302087]]]
   [client] Creating summariser <summary>
   [client] Created the tree successfully using testfiles/Bug54685.jmx
   [client] Configuring remote engine: localhost:2289
   [client] Starting remote engines
   [client] Starting the test @ Mon Mar 20 21:05:48 UTC 2017 (1490043948034)
   [client] Remote engines have been started
   [client] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [server] Starting the test on host localhost:2289 @ Mon Mar 20 21:05:51 UTC 2017 (1490043951007)
   [client] summary =      1 in 00:00:01 =    1.3/s Avg:   284 Min:   284 Max:   284 Err:     0 (0.00%)
   [client] Tidying up remote @ Mon Mar 20 21:05:52 UTC 2017 (1490043952687)
   [server] Finished the test on host localhost:2289 @ Mon Mar 20 21:05:52 UTC 2017 (1490043952687) - exit requested.
   [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 @ Mon Mar 20 21:06:01 UTC 2017 (1490043961926)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      9 in 00:00:09 =    1.0/s Avg:   133 Min:     1 Max:   306 Err:     3 (33.33%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:06:11 UTC 2017 (1490043971697)
   [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 @ Mon Mar 20 21:06:15 UTC 2017 (1490043975217)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      2 in 00:00:31 =    0.1/s Avg: 15273 Min:   458 Max: 30089 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:06:46 UTC 2017 (1490044006816)
   [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 @ Mon Mar 20 21:06:50 UTC 2017 (1490044010769)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:19 =    0.2/s Avg:  6007 Min:   671 Max: 11365 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:07:10 UTC 2017 (1490044030700)
   [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 @ Mon Mar 20 21:07:15 UTC 2017 (1490044035389)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      2 in 00:00:14 =    0.1/s Avg:  6629 Min:  1071 Max: 12187 Err:     0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary =      2 in 00:00:14 =    0.1/s Avg:  6629 Min:  1071 Max: 12187 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:07:31 UTC 2017 (1490044051171)
   [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 @ Mon Mar 20 21:07:34 UTC 2017 (1490044054932)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     12 in 00:00:09 =    1.3/s Avg:   453 Min:   155 Max:  1642 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:07:45 UTC 2017 (1490044065867)
   [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 @ Mon Mar 20 21:07:49 UTC 2017 (1490044069015)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     12 in 00:00:08 =    1.6/s Avg:   302 Min:   154 Max:  1701 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:07:58 UTC 2017 (1490044078445)
   [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 @ Mon Mar 20 21:08:02 UTC 2017 (1490044082369)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:01 =    0.9/s Avg:   989 Min:   989 Max:   989 Err:     0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +      6 in 00:01:02 =    0.1/s Avg:   260 Min:   153 Max:   449 Err:     0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =      7 in 00:01:04 =    0.1/s Avg:   364 Min:   153 Max:   989 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:07 UTC 2017 (1490044147879)
   [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 @ Mon Mar 20 21:09:13 UTC 2017 (1490044153055)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:01 =    3.0/s Avg:    31 Min:     1 Max:    88 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:15 UTC 2017 (1490044155296)
   [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 @ Mon Mar 20 21:09:19 UTC 2017 (1490044159128)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:01 =    5.9/s Avg:     4 Min:     1 Max:    12 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:20 UTC 2017 (1490044160354)
   [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 @ Mon Mar 20 21:09:24 UTC 2017 (1490044164571)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     21 in 00:00:02 =    9.0/s Avg:    60 Min:     2 Max:   754 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:28 UTC 2017 (1490044168435)
   [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 @ Mon Mar 20 21:09:33 UTC 2017 (1490044173920)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:01 =    1.3/s Avg:   630 Min:   630 Max:   630 Err:     0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +     18 in 00:00:02 =   11.1/s Avg:    32 Min:     2 Max:   172 Err:     0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =     19 in 00:00:02 =    7.9/s Avg:    63 Min:     2 Max:   630 Err:     0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:37 UTC 2017 (1490044177372)
   [jmeter] ... end of run
   [concat] 2017-03-20 21:09:37,102 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException: Server redirected too many  times (20)
   [concat] 2017-03-20 21:09:37,105 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException: Server redirected too many  times (20)
   [concat] 2017-03-20 21:09:37,106 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:r1787847]
   [concat] 	at org.apache.jmeter.protocol.http.sampler.HTTPJavaImpl.sample(HTTPJavaImpl.java:612) [ApacheJMeter_http.jar:r1787847]
   [concat] 	at org.apache.jmeter.protocol.http.sampler.HTTPSamplerProxy.sample(HTTPSamplerProxy.java:74) [ApacheJMeter_http.jar:r1787847]
   [concat] 	at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1189) [ApacheJMeter_http.jar:r1787847]
   [concat] 	at org.apache.jmeter.protocol.http.sampler.HTTPSamplerBase.sample(HTTPSamplerBase.java:1178) [ApacheJMeter_http.jar:r1787847]
   [concat] 	at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:491) [ApacheJMeter_core.jar:r1787847]
   [concat] 	at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:425) [ApacheJMeter_core.jar:r1787847]
   [concat] 	at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:254) [ApacheJMeter_core.jar:r1787847]
   [concat] 	at java.lang.Thread.run(Thread.java:745) [?:1.8.0_121]
   [concat] 2017-03-20 21:09:37,129 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 @ Mon Mar 20 21:09:42 UTC 2017 (1490044182003)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      6 in 00:00:06 =    0.9/s Avg:   157 Min:     0 Max:   627 Err:     1 (16.67%)
   [jmeter] Tidying up ...    @ Mon Mar 20 21:09:49 UTC 2017 (1490044189833)
   [jmeter] ... end of run

BUILD FAILED
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/build.xml>:2781: The following error occurred while executing this line:
<https://builds.apache.org/job/JMeter-trunk/ws/trunk/build.xml>:2599: 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

        <https://builds.apache.org/job/JMeter-trunk/ws/trunk/bin/TestSchedulerWithTimer.csv>
        JSRCheckDuration,200,tearDown Thread Group 1-1,text,false

Total time: 12 minutes 11 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 #6055

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/JMeter-trunk/6055/display/redirect?page=changes>