jmeter-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: JMeter-trunk #6092
Date Mon, 10 Apr 2017 11:29:29 GMT
See <https://builds.apache.org/job/JMeter-trunk/6092/display/redirect?page=changes>

Changes:

[sebb] Add a simpler test to try and debug the Windows failure

------------------------------------------
[...truncated 144.07 KB...]
   [jmeter] summary +      1 in 00:00:01 =    1.4/s Avg:    13 Min:    13 Max:    13 Err:
    0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +      2 in 00:00:03 =    0.7/s Avg:  1074 Min:   477 Max:  1672 Err:
    0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =      3 in 00:00:03 =    0.9/s Avg:   720 Min:    13 Max:  1672 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:07 UTC 2017 (1491823447720)
   [jmeter] ... end of run
     [echo] Bug52310 output files compared OK

batchtest:
     [echo] Starting Bug52968 with file Bug52968.jmx using -X -Jdummy=dummy
   [jmeter] Creating summariser <summary>
   [jmeter] Created the tree successfully using testfiles/Bug52968.jmx
   [jmeter] Starting the test @ Mon Apr 10 11:24:13 UTC 2017 (1491823453431)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     30 in 00:00:13 =    2.3/s Avg:   219 Min:   106 Max:   352 Err:
    9 (30.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:28 UTC 2017 (1491823468079)
   [jmeter] ... end of run
     [echo] Bug52968 output files compared OK

batchtest:
     [echo] Starting Bug50898 with file Bug50898.jmx using -X -Jdummy=dummy
   [jmeter] Creating summariser <summary>
   [jmeter] Created the tree successfully using testfiles/Bug50898.jmx
   [jmeter] Starting the test @ Mon Apr 10 11:24:31 UTC 2017 (1491823471863)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:01 =    1.5/s Avg:   173 Min:   173 Max:   173 Err:
    0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +      1 in 00:00:00 =    8.4/s Avg:   111 Min:   111 Max:   111 Err:
    0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =      2 in 00:00:01 =    2.6/s Avg:   142 Min:   111 Max:   173 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:34 UTC 2017 (1491823474298)
   [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:24:38 UTC 2017 (1491823478885)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      9 in 00:00:01 =   17.1/s Avg:     1 Min:     0 Max:    10 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:40 UTC 2017 (1491823480874)
   [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:24:45 UTC 2017 (1491823485126)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      1 in 00:00:01 =    1.2/s Avg:   316 Min:   316 Max:   316 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:47 UTC 2017 (1491823487995)
   [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:24:52 UTC 2017 (1491823492724)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      1 in 00:00:01 =    1.5/s Avg:   272 Min:   272 Max:   272 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:24:54 UTC 2017 (1491823494786)
   [jmeter] ... end of run
     [echo] Bug55375 output files compared OK

batchtestserver:

batchtest:
     [echo] Starting Bug54685 with file Bug54685.jmx using -Rlocalhost:2177 -Jsample_variables=REFERENCE,JSESSIONID
   [server] Created remote object: UnicastServerRef [liveRef: [endpoint:[67.195.81.186:41843](local),objID:[36b701e6:15b579c14b7:-7fff,
-3013493004499926883]]]
   [client] Creating summariser <summary>
   [client] Created the tree successfully using testfiles/Bug54685.jmx
   [client] Configuring remote engine: localhost:2177
   [client] Starting remote engines
   [client] Starting the test @ Mon Apr 10 11:25:02 UTC 2017 (1491823502704)
   [server] Starting the test on host localhost:2177 @ Mon Apr 10 11:25:06 UTC 2017 (1491823506663)
   [client] Remote engines have been started
   [client] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [client] summary =      1 in 00:00:01 =    1.5/s Avg:   267 Min:   267 Max:   267 Err:
    0 (0.00%)
   [client] Tidying up remote @ Mon Apr 10 11:25:08 UTC 2017 (1491823508423)
   [server] Finished the test on host localhost:2177 @ Mon Apr 10 11:25:08 UTC 2017 (1491823508418)
- 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 Apr 10 11:25:19 UTC 2017 (1491823519123)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      9 in 00:00:09 =    1.0/s Avg:   141 Min:     0 Max:   309 Err:
    3 (33.33%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:25:29 UTC 2017 (1491823529969)
   [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:25:34 UTC 2017 (1491823534906)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      2 in 00:00:31 =    0.1/s Avg: 15340 Min:   501 Max: 30180 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:26:07 UTC 2017 (1491823567306)
   [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:26:13 UTC 2017 (1491823573053)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      3 in 00:00:20 =    0.2/s Avg:  6196 Min:  1039 Max: 11656 Err:
    0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary =      3 in 00:00:20 =    0.2/s Avg:  6196 Min:  1039 Max: 11656 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:26:34 UTC 2017 (1491823594592)
   [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:26:40 UTC 2017 (1491823600489)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      2 in 00:00:15 =    0.1/s Avg:  6661 Min:   953 Max: 12370 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:26:56 UTC 2017 (1491823616598)
   [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:27:01 UTC 2017 (1491823621140)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     12 in 00:00:10 =    1.2/s Avg:   427 Min:   154 Max:  1347 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:27:13 UTC 2017 (1491823633169)
   [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:27:17 UTC 2017 (1491823637708)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     12 in 00:00:07 =    1.7/s Avg:   271 Min:   152 Max:  1329 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:27:27 UTC 2017 (1491823647645)
   [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:27:32 UTC 2017 (1491823652706)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:01 =    1.2/s Avg:   741 Min:   741 Max:   741 Err:
    0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +      6 in 00:01:02 =    0.1/s Avg:   256 Min:   154 Max:   432 Err:
    0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =      7 in 00:01:03 =    0.1/s Avg:   325 Min:   154 Max:   741 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:28:37 UTC 2017 (1491823717998)
   [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:28:43 UTC 2017 (1491823723058)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:02 =    1.6/s Avg:    95 Min:     3 Max:   279 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:28:46 UTC 2017 (1491823726481)
   [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:28:50 UTC 2017 (1491823730915)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      3 in 00:00:01 =    3.2/s Avg:    10 Min:     1 Max:    29 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:28:53 UTC 2017 (1491823733799)
   [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:28:59 UTC 2017 (1491823739609)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary +      1 in 00:00:01 =    1.1/s Avg:   726 Min:   726 Max:   726 Err:
    0 (0.00%) Active: 1 Started: 1 Finished: 0
   [jmeter] summary +     20 in 00:00:01 =   15.7/s Avg:    23 Min:     3 Max:   124 Err:
    0 (0.00%) Active: 0 Started: 1 Finished: 1
   [jmeter] summary =     21 in 00:00:02 =    9.7/s Avg:    56 Min:     3 Max:   726 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:29:03 UTC 2017 (1491823743474)
   [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:29:10 UTC 2017 (1491823750435)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =     19 in 00:00:03 =    7.1/s Avg:    87 Min:     1 Max:   875 Err:
    0 (0.00%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:29:14 UTC 2017 (1491823754296)
   [jmeter] ... end of run
   [concat] 2017-04-10 11:29:13,950 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException:
Server redirected too many  times (20)
   [concat] 2017-04-10 11:29:13,952 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException:
Server redirected too many  times (20)
   [concat] 2017-04-10 11:29:13,959 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:29:13,965 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:29:18 UTC 2017 (1491823758993)
   [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445
   [jmeter] summary =      6 in 00:00:07 =    0.9/s Avg:   169 Min:     0 Max:   775 Err:
    1 (16.67%)
   [jmeter] Tidying up ...    @ Mon Apr 10 11:29:28 UTC 2017 (1491823768788)
   [jmeter] ... end of run

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

Mime
View raw message