[
Date Prev][
Date Next][
Thread Prev][
Thread Next][
Date Index][
Thread Index]
[
List Home]
|
[cf-dev] [Hudson] Build failed in Hudson: 1.1.x-nightly #4
|
See <https://hudson.eclipse.org/californium/job/1.1.x-nightly/4/changes>
Changes:
[Kai Hudalla] Corrected NullPointerException for CoapClient#ping()
[Kai Hudalla] [#147] Add unit test case verifying Request.getRawCode() behavior.
[Kai Hudalla] Reduce code duplications in CoapStack.
[Kai Hudalla] Reduce code duplication.
[Kai Hudalla] Improve JavaDoc.
[Kai Hudalla] [#138] Deprecate scandium's ConnectorBase for lack of need.
------------------------------------------
[...truncated 2475 lines...]
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:107) destroy() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:212) start() in thread main at (2016-11-24 02:07:31)
Server binds to port 46595
Establish an observe relation. Cancellation due to a reject from the client
299 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:44017#24 and resource /obs - (org.eclipse.californium.core.CoapResource.java:301) addObserveRelation() in thread CoapServer#1 at (2016-11-24 02:07:31)
Resource changed: First notification -209485594
Reject notification
CON [MID=7001], GET, /obs, observe(0) ----->
<----- ACK [MID=7001], 2.05, observe(0)
Observe relation established
<----- CON [MID=460], 2.05, observe(1) // lost
<----- CON [MID=460], 2.05, observe(1)
RST [MID=460], 0 ----->
1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:46595 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:46595 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:107) destroy() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 02:07:31)
1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:212) start() in thread main at (2016-11-24 02:07:31)
Server binds to port 48389
Establish an observe relation. Cancellation after timeout. During the timeouts, the resource still changes.
309 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:52317#25 and resource /obs - (org.eclipse.californium.core.CoapResource.java:301) addObserveRelation() in thread CoapServer#1 at (2016-11-24 02:07:31)
Resource changed: First notification -544200014
Resource changed: Second notification 1590955009
1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 02:07:32)
314 SEVERE [Message]: Faulty MessageObserver for retransmitting events. - (org.eclipse.californium.core.coap.Message.java:637) retransmitting() in thread CoapServer#4 at (2016-11-24 02:07:32)
java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@3e5be948 rejected from java.util.concurrent.ScheduledThreadPoolExecutor@43095f4[Shutting down, pool size = 6, active threads = 1, queued tasks = 0, completed tasks = 5]
at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048)
at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:821)
at java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:325)
at java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:530)
at java.util.concurrent.ScheduledThreadPoolExecutor.execute(ScheduledThreadPoolExecutor.java:619)
at org.eclipse.californium.core.network.stack.ObserveLayer$NotificationController.onRetransmission(ObserveLayer.java:232)
at org.eclipse.californium.core.coap.Message.retransmitting(Message.java:635)
at org.eclipse.californium.core.network.stack.ReliabilityLayer$RetransmissionTask.run(ReliabilityLayer.java:364)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:48389 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 02:07:32)
1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:48389 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:32)
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:107) destroy() in thread main at (2016-11-24 02:07:32)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 02:07:32)
1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:212) start() in thread main at (2016-11-24 02:07:32)
Server binds to port 52082
Establish an observe relation. Cancellation after timeout
320 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:56767#26 and resource /obs - (org.eclipse.californium.core.CoapResource.java:301) addObserveRelation() in thread CoapServer#1 at (2016-11-24 02:07:32)
Resource changed: First notification
Resource changed: Second notification
Resource changed: Third notification
Resource changed: Forth notification
Resource changed: Fifth notification
327 INFO [ObserveLayer$NotificationController]: Notification 26 timed out. Cancel all relations with source /127.0.0.1:56767 - (org.eclipse.californium.core.network.stack.ObserveLayer$NotificationController.java:532) onTimeout() in thread CoapServer#6 at (2016-11-24 02:07:33)
CON [MID=7001], GET, /obs, observe(0) ----->
<----- ACK [MID=7001], 2.05, observe(0)
Observe relation established
<----- NON [MID=930], 2.05, observe(1)
<----- NON [MID=931], 2.05, observe(2)
<----- CON [MID=932], 2.05, observe(3)
ACK [MID=932], 0 ----->
<----- NON [MID=933], 2.05, observe(4)
<----- CON [MID=934], 2.05, observe(5) // lost
<----- CON [MID=934], 2.05, observe(5) // lost
<----- CON [MID=934], 2.05, observe(5) // lost
<----- CON [MID=934], 2.05, observe(5) // lost
<----- CON [MID=934], 2.05, observe(5) // lost
1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 02:07:33)
1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:52082 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 02:07:33)
1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:52082 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:33)
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:107) destroy() in thread main at (2016-11-24 02:07:33)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 02:07:33)
1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:212) start() in thread main at (2016-11-24 02:07:33)
Server binds to port 56500
Establish an observe relation to a quickly changing resource and do no longer respond
335 INFO [CoapResource]: Successfully established observe relation between /127.0.0.1:47053#27 and resource /obs - (org.eclipse.californium.core.CoapResource.java:301) addObserveRelation() in thread CoapServer#1 at (2016-11-24 02:07:33)
Resource changed: First notification -118125769
Resource changed: Second notification 1380513566
Resource changed: NON notification 1 1656878703
Resource changed: NON notification 2 -199319445
Resource changed: NON notification 3 -100418337
Resource changed: NON notification 4 -758969956
342 INFO [ObserveLayer$NotificationController]: Notification 27 timed out. Cancel all relations with source /127.0.0.1:47053 - (org.eclipse.californium.core.network.stack.ObserveLayer$NotificationController.java:532) onTimeout() in thread CoapServer#6 at (2016-11-24 02:07:33)
CON [MID=7001], GET, /obs, observe(0) ----->
<----- ACK [MID=7001], 2.05, observe(0)
Observe relation established
<----- NON [MID=696], 2.05, observe(1)
<----- CON [MID=697], 2.05, observe(2)
<----- CON [MID=697], 2.05, observe(3)
<----- CON [MID=697], 2.05, observe(4)
<----- CON [MID=697], 2.05, observe(5)
<----- CON [MID=697], 2.05, observe(6)
server cancels the relation
1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 02:07:34)
1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:56500 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 02:07:34)
1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:56500 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:34)
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:107) destroy() in thread main at (2016-11-24 02:07:34)
End ObserveServerSideTest
Tests run: 7, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 4.584 sec <<< FAILURE! - in org.eclipse.californium.core.test.lockstep.ObserveServerSideTest
testEstablishmentAndTimeoutWithUpdateInMiddle(org.eclipse.californium.core.test.lockstep.ObserveServerSideTest) Time elapsed: 0.998 sec <<< FAILURE!
java.lang.AssertionError: Wrong payload length: expected:<30> but was:<29>
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation$5.check(LockstepEndpoint.java:256)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation$5.check(LockstepEndpoint.java:252)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation.check(LockstepEndpoint.java:385)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$ResponseExpectation.check(LockstepEndpoint.java:643)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$ResponseExpectation.go(LockstepEndpoint.java:651)
at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation.go(LockstepEndpoint.java:401)
at org.eclipse.californium.core.test.lockstep.ObserveServerSideTest.testEstablishmentAndTimeoutWithUpdateInMiddle(ObserveServerSideTest.java:192)
Running org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
Start LossyBlockwiseTransferTest
1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:75) start() in thread main at (2016-11-24 02:07:34)
1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 02:07:34)
1 INFO [CoapEndpoint]: Starting endpoint at 0.0.0.0/0.0.0.0:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:212) start() in thread main at (2016-11-24 02:07:34)
Client at 33960, middle at 50559, server at 51735
Start man in the middle
uri: coap://localhost:50559/test
Man in the middle will drop packets [5, 6, 8, 9, 15]
Drop packet 5 (burst 1)
Drop packet 6 (burst 2)
Drop packet 8 (burst 3)
Drop packet 9 (burst 4)
Drop packet 15 (burst 1)
Received 250 bytes
Man in the middle will drop packets [0, 3, 3, 5, 5, 10, 12, 12, 12, 15]
Drop packet 0 (burst 1)
Drop packet 3 (burst 1)
Drop packet 5 (burst 2)
Drop packet 10 (burst 1)
Drop packet 12 (burst 2)
Drop packet 15 (burst 2)
Received 250 bytes
Man in the middle will drop packets [0, 0, 4, 5, 5, 8, 8, 12, 14, 15]
Drop packet 0 (burst 1)
Drop packet 4 (burst 1)
Drop packet 5 (burst 2)
Drop packet 8 (burst 2)
Drop packet 12 (burst 1)
Drop packet 14 (burst 2)
Drop packet 15 (burst 3)
Received 250 bytes
Man in the middle will drop packets [4, 4, 6, 6, 7, 8, 10, 11, 12, 13]
Drop packet 4 (burst 1)
Drop packet 6 (burst 2)
Drop packet 7 (burst 3)
Drop packet 8 (burst 4)
Drop packet 12 (burst 1)
Drop packet 13 (burst 2)
Received 250 bytes
Man in the middle will drop packets [1, 5, 5, 6, 6, 8, 8, 11, 14, 14]
Drop packet 1 (burst 1)
Drop packet 5 (burst 1)
Drop packet 6 (burst 2)
Drop packet 8 (burst 3)
Drop packet 11 (burst 3)
Drop packet 14 (burst 3)
Received 250 bytes
Man in the middle will drop packets [4, 5, 7, 8, 9, 10, 11, 12, 13, 14]
Drop packet 4 (burst 1)
Drop packet 5 (burst 2)
Drop packet 7 (burst 3)
Drop packet 8 (burst 4)
Drop packet 12 (burst 1)
Drop packet 13 (burst 2)
Drop packet 14 (burst 3)
Received 250 bytes
1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 02:07:41)
1 INFO [CoapEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:51735 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 02:07:41)
1 INFO [CoapEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:51735 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:41)
1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:93) destroy() in thread main at (2016-11-24 02:07:41)
1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:33960 - (org.eclipse.californium.core.network.CoapEndpoint.java:94) destroy() in thread main at (2016-11-24 02:07:41)
1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:33960 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 02:07:41)
End LossyBlockwiseTransferTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.465 sec - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
Results :
Failed tests:
ObserveServerSideTest.testEstablishmentAndTimeoutWithUpdateInMiddle:192 Wrong payload length: expected:<30> but was:<29>
Tests run: 25, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Californium (Cf) Parent ............................ SUCCESS [ 4.758 s]
[INFO] element-connector .................................. SUCCESS [ 58.213 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [ 1.076 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 21.287 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 45.376 s]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi Bundle ....................... SKIPPED
[INFO] Californium (Cf) Demo Applications ................. SKIPPED
[INFO] Sc-DTLS-Example-Server ............................. SKIPPED
[INFO] Sc-DTLS-Example-Client ............................. SKIPPED
[INFO] Cf-PlugtestClient .................................. SKIPPED
[INFO] Cf-PlugtestChecker ................................. SKIPPED
[INFO] Cf-PlugtestServer .................................. SKIPPED
[INFO] Cf-HelloWorldClient ................................ SKIPPED
[INFO] Cf-HelloWorldServer ................................ SKIPPED
[INFO] Cf-CoCoAClient ..................................... SKIPPED
[INFO] Cf-SecureServer .................................... SKIPPED
[INFO] Cf-ExampleCrossProxy ............................... SKIPPED
[INFO] Cf-BenchmarkServer ................................. SKIPPED
[INFO] Cf-ObserveBenchmarkClient .......................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:16 min
[INFO] Finished at: 2016-11-24T02:07:41-05:00
[INFO] Final Memory: 43M/1934M
[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 (large-tests) on project californium-core: There are test failures.
Please refer to /jobs/genie.californium/1.1.x-nightly/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 (large-tests) on project californium-core: There are test failures.
[ERROR]
[ERROR] Please refer to /jobs/genie.californium/1.1.x-nightly/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
Recording test results
Archiving artifacts
--
This message is automatically generated by Hudson.
For more information on Hudson, see: http://hudson-ci.org/
