Skip to main content

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] [Hudson] Build failed in Hudson: master #125

See <https://hudson.eclipse.org/californium/job/master/125/changes>

Changes:

[Kai Hudalla] [#50] Fix concurrency issue when adding message interceptors.

------------------------------------------
[...truncated 2428 lines...]
Client binds to port 37249
Blockwise Observe:
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   35, Token=bd6ae529015403a1, OptionSet={"Observe":0, "Uri-Port":48952, "Uri-Path":"test"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   35, Token=bd6ae529015403a1, OptionSet={"Observe":0, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   36, Token=4771fcc54d7b12f8, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   36, Token=4771fcc54d7b12f8, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   37, Token=4771fcc54d7b12f8, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   37, Token=4771fcc54d7b12f8, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "16123475" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
CON [MID=35, T=bd6ae529015403a1], GET, /test, (observe=0)    ----->
<-----   ACK [MID=35, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=0)    
CON [MID=36, T=4771fcc54d7b12f8], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=36, T=4771fcc54d7b12f8], 2.05, 2:1/1/16    
CON [MID=37, T=4771fcc54d7b12f8], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=37, T=4771fcc54d7b12f8], 2.05, 2:2/0/16    

348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8001, Token=bd6ae529015403a1, OptionSet={"Observe":1, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8001 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   38, Token=f4b011f389f14d7a, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   38, Token=f4b011f389f14d7a, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   39, Token=f4b011f389f14d7a, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   39, Token=f4b011f389f14d7a, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "16123475" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
<-----   CON [MID=8001, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=1)    
ACK [MID=8001], 0                         ----->
CON [MID=38, T=f4b011f389f14d7a], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=38, T=f4b011f389f14d7a], 2.05, 2:1/1/16    
CON [MID=39, T=f4b011f389f14d7a], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=39, T=f4b011f389f14d7a], 2.05, 2:2/0/16    

348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8002, Token=bd6ae529015403a1, OptionSet={"Observe":2, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8002 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   40, Token=019be34a42242d27, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   40, Token=019be34a42242d27, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   41, Token=019be34a42242d27, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8003, Token=bd6ae529015403a1, OptionSet={"Observe":3, "Block2":"(szx=0/16, m=true, num=0)"}, "abcdefghijklmnop" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8003 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [BlockwiseLayer]: Ongoing blockwise transfer reseted at num=2 by new notification: CON-2.05   MID= 8003, Token=bd6ae529015403a1, OptionSet={"Observe":3, "Block2":"(szx=0/16, m=true, num=0)"}, "abcdefghijklmnop" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:103) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   42, Token=314f5fef42f2567b, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   41, Token=019be34a42242d27, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "16123475" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [UdpMatcher]: Possible MID reuse before lifetime end for token [019be34a42242d27], expected MID 42 but received 41 - (org.eclipse.californium.core.network.UdpMatcher.java:742) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [BlockwiseLayer]: Wrong block number. Expected 1 but received 2: ACK-2.05   MID=   41, Token=019be34a42242d27, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "16123475" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:103) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   42, Token=314f5fef42f2567b, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "qrstuvwxyzabcdef" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   43, Token=314f5fef42f2567b, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   43, Token=314f5fef42f2567b, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "ghijklmn" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
<-----   CON [MID=8002, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=2)    
ACK [MID=8002], 0                         ----->
CON [MID=40, T=019be34a42242d27], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=40, T=019be34a42242d27], 2.05, 2:1/1/16    
CON [MID=41, T=019be34a42242d27], GET, /test, 2:2/0/16    ----->

//////// Overriding notification ////////
<-----   CON [MID=8003, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=3)    
ACK [MID=8003], 0                         ----->
CON [MID=42, T=314f5fef42f2567b], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=41, T=019be34a42242d27], 2.05, 2:2/0/16    
<-----   ACK [MID=42, T=314f5fef42f2567b], 2.05, 2:1/1/16    
CON [MID=43, T=314f5fef42f2567b], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=43, T=314f5fef42f2567b], 2.05, 2:2/0/16    

348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8004, Token=bd6ae529015403a1, OptionSet={"Observe":4, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8004 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   44, Token=3056f852fc8ae871, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8005, Token=bd6ae529015403a1, OptionSet={"Observe":5, "Block2":"(szx=0/16, m=true, num=0)"}, "ABCDEFGHIJKLMNOP" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8005 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [BlockwiseLayer]: Ongoing blockwise transfer reseted at num=1 by new notification: CON-2.05   MID= 8005, Token=bd6ae529015403a1, OptionSet={"Observe":5, "Block2":"(szx=0/16, m=true, num=0)"}, "ABCDEFGHIJKLMNOP" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:103) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   45, Token=518f826dce268144, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   44, Token=3056f852fc8ae871, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [UdpMatcher]: Possible MID reuse before lifetime end for token [3056f852fc8ae871], expected MID 45 but received 44 - (org.eclipse.californium.core.network.UdpMatcher.java:742) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 WARNING [BlockwiseLayer]: Wrong block number. Expected 1 but received 1: ACK-2.05   MID=   44, Token=3056f852fc8ae871, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:103) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   45, Token=518f826dce268144, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "QRSTUVWXYZABCDEF" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   46, Token=518f826dce268144, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   46, Token=518f826dce268144, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "GHIJKLMN" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
<-----   CON [MID=8004, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=4)    
ACK [MID=8004], 0                         ----->
CON [MID=44, T=3056f852fc8ae871], GET, /test, 2:1/0/16    ----->

//////// Overriding notification 2 ////////
<-----   CON [MID=8005, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=5)    
ACK [MID=8005], 0                         ----->
CON [MID=45, T=518f826dce268144], GET, /test, 2:1/0/16    ----->

//////// Conflicting notification block ////////
<-----   ACK [MID=44, T=3056f852fc8ae871], 2.05, 2:1/1/16    
<-----   ACK [MID=45, T=518f826dce268144], 2.05, 2:1/1/16    
CON [MID=46, T=518f826dce268144], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=46, T=518f826dce268144], 2.05, 2:2/0/16    

348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8006, Token=bd6ae529015403a1, OptionSet={"Observe":6, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp ACK        MID= 8006 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== req CON-GET    MID=   47, Token=b1e31ae2c4d406c3, OptionSet={"Uri-Port":48952, "Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:532) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)

//////// Notification after cancellation ////////
<-----   CON [MID=8006, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=6)    
ACK [MID=8006], 0                         ----->
CON [MID=47, T=b1e31ae2c4d406c3], GET, /test, 2:1/0/16    ----->

348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res ACK-2.05   MID=   47, Token=b1e31ae2c4d406c3, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "96866-2579387581" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 ==> res CON-2.05   MID= 8007, Token=bd6ae529015403a1, OptionSet={"Observe":7, "Block2":"(szx=0/16, m=true, num=0)"}, "-195558500517006" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
348 INFO [MessageTracer]: /127.0.0.1:48,952 <== emp RST        MID= 8007 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:583) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-11-24 08:28:25)
<-----   ACK [MID=47, T=b1e31ae2c4d406c3], 2.05, 2:1/1/16    
<-----   CON [MID=8007, T=bd6ae529015403a1], 2.05, 2:0/1/16, (observe=7)    
RST [MID=8007], 0                         ----->

 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:37249 - (org.eclipse.californium.core.network.CoapEndpoint.java:89) destroy() in thread main at (2016-11-24 08:28:25)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:37249 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 08:28:25)
End ObserveClientSideTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec - in org.eclipse.californium.core.test.lockstep.ObserveClientSideTest
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 08:28:25)
 1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-11-24 08:28:25)
 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 08:28:25)
Client at 50166, middle at 34875, server at 39053
Start man in the middle
uri: coap://localhost:34875/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 [2, 3, 4, 5, 8, 9, 11, 11, 12, 12]
Drop packet 2 (burst 1)
Drop packet 3 (burst 2)
Drop packet 4 (burst 3)
Drop packet 5 (burst 4)
Drop packet 9 (burst 1)
Drop packet 11 (burst 2)
Drop packet 12 (burst 3)
Received 250 bytes
Man in the middle will drop packets [1, 1, 4, 7, 10, 12, 13, 13, 15, 15]
Drop packet 1 (burst 1)
Drop packet 4 (burst 1)
Drop packet 7 (burst 1)
Drop packet 10 (burst 1)
Drop packet 12 (burst 2)
Drop packet 13 (burst 3)
Drop packet 15 (burst 4)
java.lang.NullPointerException
	at org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest.test(LossyBlockwiseTransferTest.java:128)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:108)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:78)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:54)
	at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:144)
	at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)

 1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-11-24 08:28:33)
 1 INFO [CoapEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:39053 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-11-24 08:28:34)
 1 INFO [CoapEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:39053 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 08:28:34)
 1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:93) destroy() in thread main at (2016-11-24 08:28:34)
 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:50166 - (org.eclipse.californium.core.network.CoapEndpoint.java:94) destroy() in thread main at (2016-11-24 08:28:34)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:50166 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-11-24 08:28:34)
End LossyBlockwiseTransferTest
Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 7.753 sec <<< FAILURE! - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
test(org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest)  Time elapsed: 7.753 sec  <<< ERROR!
java.lang.NullPointerException: null
	at org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest.test(LossyBlockwiseTransferTest.java:128)


Results :

Tests in error: 
  LossyBlockwiseTransferTest.test:128 NullPointer

Tests run: 25, Failures: 0, Errors: 1, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  2.139 s]
[INFO] element-connector .................................. SUCCESS [ 55.240 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  0.852 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 22.647 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 47.061 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:11 min
[INFO] Finished at: 2016-11-24T08:28:35-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/master/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/master/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

--
This message is automatically generated by Hudson. 
For more information on Hudson, see: http://hudson-ci.org/


Back to the top