[
Date Prev][
Date Next][
Thread Prev][
Thread Next][
Date Index][
Thread Index]
[
List Home]
|
[cf-dev] [Hudson] Build failed in Hudson: californium.core #117
|
See <https://hudson.eclipse.org/californium/job/californium.core/117/changes>
Changes:
[Matthias Kovatsch] Added git attributes file for line ending handling.
[Matthias Kovatsch] Normalized all the line endings to LF.
------------------------------------------
[...truncated 941 lines...]
Establish an observe relation. Cancellation after timeout. During the timeouts, the resource still changes.
297 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:36460#0c and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-6 at (2015-10-08 14:12:36)
Resource changed: First notification -676229973
Resource changed: Second notification 687898811-
Resource changed: Third notification -162746837
306 INFO [ObserveLayer$NotificationController]: Notification 0c timed out. Cancel all relations with source /127.0.0.1:36460 - (org.eclipse.californium.core.network.stack.ObserveLayer$NotificationController.java:225) onTimeout() in thread pool-17-thread-13 at (2015-10-08 14:12:37)
CON [MID=7002], GET, /obs, observe(0) ----->
<----- ACK [MID=7002], 2.05, observe(5)
Observe relation established
<----- CON [MID=30756], 2.05, observe(6) // lost
<----- CON [MID=30756], 2.05, observe(6) // lost (1. retransmission)
<----- CON [MID=30756], 2.05, observe(7) // lost (2. retransmission)
<----- CON [MID=30756], 2.05, observe(8) // lost (3. retransmission)
<----- CON [MID=30756], 2.05, observe(8) // lost (4. retransmission)
Establish an observe relation. Cancellation due to a reject from the client
300 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:34923#0d and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-9 at (2015-10-08 14:12:37)
Resource changed: First notification 1464331019
Reject notification
CON [MID=7003], GET, /obs, observe(0) ----->
<----- ACK [MID=7003], 2.05, observe(8)
Observe relation established
<----- CON [MID=30757], 2.05, observe(9) // lost
<----- CON [MID=30757], 2.05, observe(9)
RST [MID=30757], 0 ----->
Observe with blockwise
299 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:40265#0e and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-8 at (2015-10-08 14:12:37)
Resource changed: 1368965491340306768-44150413-512981946-120794014-17907173142028179538-7107810680
Resource changed: -1623785402-185860316819051608601540535449-81195873-6166577591885339798571937270
CON [MID=7004], GET, /obs, observe(0) ----->
<----- ACK [MID=7004], 2.05, 2:0/1/32, observe(9)
Observe relation established
CON [MID=7005], GET, /obs, 2:1/0/32 ----->
<----- ACK [MID=7005], 2.05, 2:1/1/32
CON [MID=7006], GET, /obs, 2:2/0/32 ----->
<----- ACK [MID=7006], 2.05, 2:2/0/32
<----- CON [MID=30758], 2.05, 2:0/1/32, observe(10)
=== changed ===
ACK [MID=30758], 0 ----->
CON [MID=7007], GET, /obs, 2:1/0/32 ----->
<----- ACK [MID=7007], 2.05, 2:1/1/32
CON [MID=7008], GET, /obs, 2:2/0/32 ----->
<----- ACK [MID=7008], 2.05, 2:2/0/32
<----- CON [MID=30759], 2.05, 2:0/1/32, observe(11)
=== changed ===
RST [MID=30759], 0 ----->
Establish an observe relation and receive NON notifications
301 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:59175#11 and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-10 at (2015-10-08 14:12:38)
Resource changed: First notification -517697115
Resource changed: Second notification -209130884
Resource changed: Third notification 1477087026
Reject notification
NON [MID=7009], GET, /obs, observe(0) ----->
<----- NON [MID=30760], 2.05, observe(11)
Observe relation established
<----- NON [MID=30761], 2.05, observe(12)
<----- CON [MID=30762], 2.05, observe(13)
ACK [MID=30762], 0 ----->
<----- NON [MID=30763], 2.05, observe(14)
RST [MID=30763], 0 ----->
Establish an observe relation and receive NON notifications
299 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:45820#12 and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-8 at (2015-10-08 14:12:38)
Resource changed: First notification -542865961
Resource changed: Second notification -155753313
Resource changed: Third notification 5495751435
Resource changed: Fourth notification 1167815528
Reject notification
NON [MID=7010], GET, /obs, 2:0/0/32, observe(0) ----->
<----- NON [MID=30764], 2.05, 2:0/0/32, observe(14)
Observe relation established
<----- NON [MID=30765], 2.05, observe(15)
<----- CON [MID=30766], 2.05, observe(16)
ACK [MID=30766], 0 ----->
<----- NON [MID=30767], 2.05, observe(17)
<----- NON [MID=30768], 2.05, observe(18)
RST [MID=30768], 0 ----->
Establish an observe relation to a quickly changing resource and do no longer respond
315 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:45026#13 and resource /obs - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-17-thread-20 at (2015-10-08 14:12:38)
Resource changed: First notification 1033295605
Resource changed: Second notification -561683404
Resource changed: NON notification 1 1850708708
Resource changed: NON notification 2 1410857284
Resource changed: NON notification 3 -162585176
Resource changed: NON notification 4 -111987557
298 INFO [ObserveLayer$NotificationController]: Notification 13 timed out. Cancel all relations with source /127.0.0.1:45026 - (org.eclipse.californium.core.network.stack.ObserveLayer$NotificationController.java:225) onTimeout() in thread pool-17-thread-7 at (2015-10-08 14:12:39)
CON [MID=7011], GET, /obs, observe(0) ----->
<----- ACK [MID=7011], 2.05, observe(18)
Observe relation established
<----- NON [MID=30769], 2.05, observe(19)
<----- CON [MID=30770], 2.05, observe(20)
<----- CON [MID=30770], 2.05, observe(21)
<----- CON [MID=30770], 2.05, observe(22)
<----- CON [MID=30770], 2.05, observe(23)
<----- CON [MID=30770], 2.05, observe(24)
server cancels the relation
1 INFO [CoapServer]: Destroy server - (org.eclipse.californium.core.CoapServer.java:220) destroy() in thread main at (2015-10-08 14:12:39)
1 INFO [CoAPEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:49632 - (org.eclipse.californium.core.network.CoAPEndpoint.java:222) destroy() in thread main at (2015-10-08 14:12:39)
1 INFO [CoAPEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:49632 - (org.eclipse.californium.core.network.CoAPEndpoint.java:311) stop() in thread main at (2015-10-08 14:12:39)
1 WARNING [CoapServer]: Server executor did not shutdown in time - (org.eclipse.californium.core.CoapServer.java:227) destroy() in thread main at (2015-10-08 14:12:44)
End ObserveServerSideTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 8.254 sec - in org.eclipse.californium.core.test.lockstep.ObserveServerSideTest
Running org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
Start LossyBlockwiseTransferTest
1 INFO [CoAPEndpoint]: Starting endpoint at 0.0.0.0/0.0.0.0:0 - (org.eclipse.californium.core.network.CoAPEndpoint.java:71) start() in thread main at (2015-10-08 14:12:44)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:180) start() in thread main at (2015-10-08 14:12:44)
1 INFO [CoAPEndpoint]: Starting endpoint at 0.0.0.0/0.0.0.0:0 - (org.eclipse.californium.core.network.CoAPEndpoint.java:192) start() in thread main at (2015-10-08 14:12:44)
Client at 33819, middle at 34287, server at 37023
Start man in the middle
uri: coap://localhost:34287/test
Man in the middle will drop packets [5, 6, 8, 9, 15]
Drop packet 5 (burst 1)
Drop packet 6 (burst 2)
337 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42829, Token=2ed8cb, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-3 at (2015-10-08 14:12:44)
Drop packet 8 (burst 3)
Drop packet 9 (burst 4)
340 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42829, Token=2ed8cb, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-6 at (2015-10-08 14:12:45)
Drop packet 15 (burst 1)
339 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42831, Token=2ed8cb, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-5 at (2015-10-08 14:12:45)
Received 250 bytes
Man in the middle will drop packets [1, 5, 5, 8, 9, 10, 11, 13, 13, 15]
Drop packet 1 (burst 1)
346 INFO [Matcher]: Duplicate request: CON-GET MID=42835, Token=cd55, OptionSet={"Uri-Port":34287, "Uri-Path":"test"}, no payload - (org.eclipse.californium.core.network.Matcher.java:256) receiveRequest() in thread pool-18-thread-12 at (2015-10-08 14:12:45)
Drop packet 5 (burst 1)
343 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42836, Token=cd55, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-9 at (2015-10-08 14:12:45)
Drop packet 8 (burst 1)
Drop packet 9 (burst 2)
Drop packet 10 (burst 3)
Drop packet 11 (burst 4)
Drop packet 15 (burst 1)
340 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42838, Token=cd55, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-6 at (2015-10-08 14:12:46)
Received 250 bytes
Man in the middle will drop packets [1, 1, 4, 4, 6, 8, 8, 9, 11, 15]
Drop packet 1 (burst 1)
332 INFO [Matcher]: Duplicate request: CON-GET MID=42843, Token=0af017, OptionSet={"Uri-Port":34287, "Uri-Path":"test"}, no payload - (org.eclipse.californium.core.network.Matcher.java:256) receiveRequest() in thread pool-18-thread-1 at (2015-10-08 14:12:47)
Drop packet 4 (burst 1)
Drop packet 6 (burst 2)
342 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42844, Token=0af017, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-8 at (2015-10-08 14:12:47)
Drop packet 8 (burst 3)
Drop packet 9 (burst 4)
349 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42844, Token=0af017, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-15 at (2015-10-08 14:12:47)
Drop packet 15 (burst 1)
351 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42846, Token=0af017, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-17 at (2015-10-08 14:12:48)
Received 250 bytes
Man in the middle will drop packets [2, 2, 6, 6, 7, 7, 7, 13, 13, 15]
Drop packet 2 (burst 1)
Drop packet 6 (burst 1)
Drop packet 7 (burst 2)
348 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42853, Token=e52c17d4a02fa165, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-14 at (2015-10-08 14:12:48)
Drop packet 13 (burst 1)
350 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42855, Token=e52c17d4a02fa165, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-16 at (2015-10-08 14:12:48)
Drop packet 15 (burst 2)
340 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42855, Token=e52c17d4a02fa165, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-6 at (2015-10-08 14:12:49)
Received 250 bytes
Man in the middle will drop packets [0, 0, 0, 3, 5, 6, 11, 12, 12, 14]
Drop packet 0 (burst 1)
Drop packet 3 (burst 1)
Drop packet 5 (burst 2)
Drop packet 6 (burst 3)
332 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42860, Token=69355182d15d, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-1 at (2015-10-08 14:12:49)
Drop packet 11 (burst 1)
Drop packet 12 (burst 2)
Drop packet 14 (burst 3)
349 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42862, Token=69355182d15d, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-15 at (2015-10-08 14:12:50)
Received 250 bytes
Man in the middle will drop packets [0, 1, 2, 4, 4, 4, 5, 12, 12, 14]
Drop packet 0 (burst 1)
Drop packet 1 (burst 2)
Drop packet 2 (burst 3)
Drop packet 4 (burst 4)
355 INFO [Matcher]: Duplicate request: CON-GET MID=42867, Token=213b3e72, OptionSet={"Uri-Port":34287, "Uri-Path":"test"}, no payload - (org.eclipse.californium.core.network.Matcher.java:256) receiveRequest() in thread pool-18-thread-21 at (2015-10-08 14:12:51)
Drop packet 12 (burst 1)
346 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42870, Token=213b3e72, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-12 at (2015-10-08 14:12:51)
Drop packet 14 (burst 2)
348 INFO [Matcher]: Duplicate ongoing request: CON-GET MID=42870, Token=213b3e72, OptionSet={"Uri-Port":34287, "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload - (org.eclipse.californium.core.network.Matcher.java:272) receiveRequest() in thread pool-18-thread-14 at (2015-10-08 14:12:51)
Received 250 bytes
1 INFO [CoapServer]: Destroy server - (org.eclipse.californium.core.CoapServer.java:220) destroy() in thread main at (2015-10-08 14:12:51)
1 INFO [CoAPEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:37023 - (org.eclipse.californium.core.network.CoAPEndpoint.java:222) destroy() in thread main at (2015-10-08 14:12:51)
1 INFO [CoAPEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:37023 - (org.eclipse.californium.core.network.CoAPEndpoint.java:311) stop() in thread main at (2015-10-08 14:12:51)
1 INFO [CoAPEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:33819 - (org.eclipse.californium.core.network.CoAPEndpoint.java:90) destroy() in thread main at (2015-10-08 14:12:51)
1 INFO [CoAPEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:33819 - (org.eclipse.californium.core.network.CoAPEndpoint.java:311) stop() in thread main at (2015-10-08 14:12:51)
End LossyBlockwiseTransferTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.273 sec - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
Running org.eclipse.californium.core.network.CoAPEndpointTest
1 INFO [CoAPEndpoint]: Starting endpoint at null - (org.eclipse.californium.core.network.CoAPEndpoint.java:83) start() in thread main at (2015-10-08 14:12:51)
1 INFO [CoAPEndpoint]: Stopping endpoint at address null - (org.eclipse.californium.core.network.CoAPEndpoint.java:60) stop() in thread main at (2015-10-08 14:12:51)
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec - in org.eclipse.californium.core.network.CoAPEndpointTest
Results :
Failed tests:
BlockwiseTransferTest.test_all:103->test_POST_long_short:126->executePOSTRequest:215 null
Tests run: 37, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Californium (Cf) ................................... SUCCESS [ 2.243 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 53.339 s]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi Bundle ....................... SKIPPED
[INFO] Cf-PlugtestClient .................................. SKIPPED
[INFO] Cf-PlugtestChecker ................................. SKIPPED
[INFO] Cf-PlugtestServer .................................. SKIPPED
[INFO] Cf-HelloWorldClient ................................ SKIPPED
[INFO] Cf-HelloWorldServer ................................ SKIPPED
[INFO] Cf-CoCoA-Client .................................... SKIPPED
[INFO] Cf-SecureServer .................................... SKIPPED
[INFO] Cf-ExampleCrossProxy ............................... SKIPPED
[INFO] Cf Benchmark Server ................................ SKIPPED
[INFO] Cf Observe Benchmark Client ........................ SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 57.557 s
[INFO] Finished at: 2015-10-08T14:12:54-04:00
[INFO] Final Memory: 36M/1840M
[INFO] ------------------------------------------------------------------------
[INFO] o.h.m.e.h.MavenExecutionResultHandler - Build failed with exception(s)
[INFO] o.h.m.e.h.MavenExecutionResultHandler - [1] org.apache.maven.lifecycle.LifecycleExecutionException: Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (default-test) on project californium-core: There are test failures.
Please refer to /jobs/genie.californium/californium.core/workspace/californium-core/target/surefire-reports for the individual test results.
[DEBUG] Closing connection to remote
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (default-test) on project californium-core: There are test failures.
[ERROR]
[ERROR] Please refer to /jobs/genie.californium/californium.core/workspace/californium-core/target/surefire-reports for the individual test results.
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :californium-core
[DEBUG] Waiting for process to finish
[DEBUG] Result: 1
Archiving artifacts
Recording test results
--
This message is automatically generated by Hudson.
For more information on Hudson, see: http://hudson-ci.org/
