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 #139

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

Changes:

[Kai Hudalla] Add method for getting the offset into the body based on szx and num.

[Kai Hudalla] Add method for checking whether the payload contains a particular block.

[Kai Hudalla] Add JavaDoc.

[Kai Hudalla] Move methods for payload generation to top level helper class.

[Kai Hudalla] Add properties and expectations to be used with blockwise transfers.

[Kai Hudalla] Introduce BlockwiseInterceptor for tracing blockwise transfers.

[Kai Hudalla] Remove obsolete test cases.

[Kai Hudalla] Clean up code.

[Kai Hudalla] Clean up code.

------------------------------------------
[...truncated 2453 lines...]
<-----   CON [MID=8001, T=fc73725339608fa8], 2.05, observe(101)
ACK [MID=8001]   -----> // lost
<-----   CON [MID=8001, T=fc73725339608fa8], 2.05, observe(101)
ACK [MID=8001]   ----->

Relation established
342 INFO [MessageTracer]: /127.0.0.1:54,145 ==> res CON-2.05   MID= 8002, Token=fc73725339608fa8, OptionSet={"Observe":102}, "8079094565" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
342 INFO [MessageTracer]: /127.0.0.1:54,145 <== 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-12-06 12:21:08)
342 INFO [MessageTracer]: /127.0.0.1:54,145 ==> res CON-2.05   MID= 8002, Token=fc73725339608fa8, OptionSet={"Observe":102}, "8079094565_DUPLICATE" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
342 INFO [MessageTracer]: /127.0.0.1:54,145 <== 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-12-06 12:21:08)
<-----   CON [MID=8002, T=fc73725339608fa8], 2.05, observe(102)
ACK [MID=8002]   -----> // lost
<-----   CON [MID=8002, T=fc73725339608fa8], 2.05, observe(102)
ACK [MID=8002]   ----->

 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:43211 - (org.eclipse.californium.core.network.CoapEndpoint.java:90) destroy() in thread main at (2016-12-06 12:21:08)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:43211 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-12-06 12:21:08)
 1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:83) start() in thread main at (2016-12-06 12:21:08)
Client binds to port 42304
Blockwise Observe:
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  294, Token=ee6fd3a773580ff7, OptionSet={"Observe":0, "Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  294, Token=ee6fd3a773580ff7, OptionSet={"Observe":0, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  295, Token=90bc42db5eb7a24d, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  295, Token=90bc42db5eb7a24d, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  296, Token=90bc42db5eb7a24d, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  296, Token=90bc42db5eb7a24d, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "15243809" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
CON [MID=294, T=ee6fd3a773580ff7], GET, /test, observe(0)    ----->
<-----   ACK [MID=294, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(0)
CON [MID=295, T=90bc42db5eb7a24d], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=295, T=90bc42db5eb7a24d], 2.05, 2:1/1/16
CON [MID=296, T=90bc42db5eb7a24d], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=296, T=90bc42db5eb7a24d], 2.05, 2:2/0/16

348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8001, Token=ee6fd3a773580ff7, OptionSet={"Observe":1, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  297, Token=28a47a0cf3ac6638, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  297, Token=28a47a0cf3ac6638, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  298, Token=28a47a0cf3ac6638, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  298, Token=28a47a0cf3ac6638, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "15243809" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
<-----   CON [MID=8001, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(1)
ACK [MID=8001]   ----->
CON [MID=297, T=28a47a0cf3ac6638], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=297, T=28a47a0cf3ac6638], 2.05, 2:1/1/16
CON [MID=298, T=28a47a0cf3ac6638], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=298, T=28a47a0cf3ac6638], 2.05, 2:2/0/16

348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8002, Token=ee6fd3a773580ff7, OptionSet={"Observe":2, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  299, Token=c858a015d2a50115, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  299, Token=c858a015d2a50115, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  300, Token=c858a015d2a50115, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8003, Token=ee6fd3a773580ff7, 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 WARNING [BlockwiseLayer]: ongoing blockwise transfer reset at num = 2 by new notification: CON-2.05   MID= 8003, Token=ee6fd3a773580ff7, OptionSet={"Observe":3, "Block2":"(szx=0/16, m=true, num=0)"}, "abcdefghijklmnop" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:398) handleBlock2Response() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  301, Token=95ef07364b65bbfc, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  300, Token=c858a015d2a50115, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "15243809" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 WARNING [UdpMatcher]: Possible MID reuse before lifetime end for token [c858a015d2a50115], expected MID 301 but received 300 - (org.eclipse.californium.core.network.UdpMatcher.java:742) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 WARNING [BlockwiseLayer]: Wrong block number. Expected 1 but received 2: ACK-2.05   MID=  300, Token=c858a015d2a50115, OptionSet={"Block2":"(szx=0/16, m=false, num=2)"}, "15243809" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:398) handleBlock2Response() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  301, Token=95ef07364b65bbfc, 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  302, Token=95ef07364b65bbfc, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  302, Token=95ef07364b65bbfc, 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-12-06 12:21:08)
<-----   CON [MID=8002, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(2)
ACK [MID=8002]   ----->
CON [MID=299, T=c858a015d2a50115], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=299, T=c858a015d2a50115], 2.05, 2:1/1/16
CON [MID=300, T=c858a015d2a50115], GET, /test, 2:2/0/16    ----->

//////// Overriding notification ////////
<-----   CON [MID=8003, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(3)
ACK [MID=8003]   ----->
CON [MID=301, T=95ef07364b65bbfc], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=300, T=c858a015d2a50115], 2.05, 2:2/0/16
<-----   ACK [MID=301, T=95ef07364b65bbfc], 2.05, 2:1/1/16
CON [MID=302, T=95ef07364b65bbfc], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=302, T=95ef07364b65bbfc], 2.05, 2:2/0/16

348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8004, Token=ee6fd3a773580ff7, OptionSet={"Observe":4, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  303, Token=a97aa2372423a745, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8005, Token=ee6fd3a773580ff7, 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 WARNING [BlockwiseLayer]: ongoing blockwise transfer reset at num = 1 by new notification: CON-2.05   MID= 8005, Token=ee6fd3a773580ff7, OptionSet={"Observe":5, "Block2":"(szx=0/16, m=true, num=0)"}, "ABCDEFGHIJKLMNOP" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:398) handleBlock2Response() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  304, Token=b934ffcf69b7ff19, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  303, Token=a97aa2372423a745, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 WARNING [UdpMatcher]: Possible MID reuse before lifetime end for token [a97aa2372423a745], expected MID 304 but received 303 - (org.eclipse.californium.core.network.UdpMatcher.java:742) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 WARNING [BlockwiseLayer]: Wrong block number. Expected 1 but received 1: ACK-2.05   MID=  303, Token=a97aa2372423a745, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:398) handleBlock2Response() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  304, Token=b934ffcf69b7ff19, 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  305, Token=b934ffcf69b7ff19, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  305, Token=b934ffcf69b7ff19, 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-12-06 12:21:08)
<-----   CON [MID=8004, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(4)
ACK [MID=8004]   ----->
CON [MID=303, T=a97aa2372423a745], GET, /test, 2:1/0/16    ----->

//////// Overriding notification 2 ////////
<-----   CON [MID=8005, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(5)
ACK [MID=8005]   ----->
CON [MID=304, T=b934ffcf69b7ff19], GET, /test, 2:1/0/16    ----->

//////// Conflicting notification block ////////
<-----   ACK [MID=303, T=a97aa2372423a745], 2.05, 2:1/1/16
<-----   ACK [MID=304, T=b934ffcf69b7ff19], 2.05, 2:1/1/16
CON [MID=305, T=b934ffcf69b7ff19], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=305, T=b934ffcf69b7ff19], 2.05, 2:2/0/16

348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8006, Token=ee6fd3a773580ff7, OptionSet={"Observe":6, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== req CON-GET    MID=  306, Token=7d8273c1ab6d8156, OptionSet={"Uri-Port":52061, "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-12-06 12:21:08)

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

348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res ACK-2.05   MID=  306, Token=7d8273c1ab6d8156, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "2084236674349367" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 ==> res CON-2.05   MID= 8007, Token=ee6fd3a773580ff7, OptionSet={"Observe":7, "Block2":"(szx=0/16, m=true, num=0)"}, "7028194849197849" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:737) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1 at (2016-12-06 12:21:08)
348 INFO [MessageTracer]: /127.0.0.1:52,061 <== 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-12-06 12:21:08)
<-----   ACK [MID=306, T=7d8273c1ab6d8156], 2.05, 2:1/1/16
<-----   CON [MID=8007, T=ee6fd3a773580ff7], 2.05, 2:0/1/16, observe(7)
RST [MID=8007]   ----->

 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:42304 - (org.eclipse.californium.core.network.CoapEndpoint.java:90) destroy() in thread main at (2016-12-06 12:21:08)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:42304 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-12-06 12:21:08)
End ObserveClientSideTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.133 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:78) start() in thread main at (2016-12-06 12:21:08)
 1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:200) start() in thread main at (2016-12-06 12:21:08)
 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-12-06 12:21:08)
Starting man in the middle...
Client at 46535, middle at 127.0.0.1:47633, server at 54504
uri: coap://localhost:47633/test
Man in the middle will drop packets [5, 6, 8, 9, 15]
Dropping packet 5 (burst 1)
Dropping packet 6 (burst 2)
Dropping packet 8 (burst 3)
Dropping packet 9 (burst 4)
Dropping packet 15 (burst 1)
Received 250 bytes
Man in the middle will drop packets [3, 4, 5, 5, 5, 7, 11, 13, 15, 15]
Dropping packet 3 (burst 1)
Dropping packet 4 (burst 2)
Dropping packet 5 (burst 3)
Dropping packet 7 (burst 4)
Dropping packet 11 (burst 1)
Dropping packet 13 (burst 2)
Dropping packet 15 (burst 3)
Received 250 bytes
Man in the middle will drop packets [0, 1, 3, 5, 8, 9, 9, 10, 11, 12]
Dropping packet 0 (burst 1)
Dropping packet 1 (burst 2)
Dropping packet 3 (burst 3)
Dropping packet 5 (burst 4)
Dropping packet 9 (burst 1)
Dropping packet 10 (burst 2)
Dropping packet 11 (burst 3)
Dropping packet 12 (burst 4)
Received 250 bytes
Man in the middle will drop packets [2, 7, 7, 7, 9, 9, 10, 10, 10, 12]
Dropping packet 2 (burst 1)
Dropping packet 7 (burst 1)
Dropping packet 9 (burst 2)
Dropping packet 10 (burst 3)
Dropping packet 12 (burst 4)
Received 250 bytes
Man in the middle will drop packets [0, 1, 2, 3, 5, 6, 6, 7, 10, 14]
Dropping packet 0 (burst 1)
Dropping packet 1 (burst 2)
Dropping packet 2 (burst 3)
Dropping packet 3 (burst 4)
Dropping packet 7 (burst 1)
Dropping packet 10 (burst 1)
Dropping packet 14 (burst 1)
Received 250 bytes
Man in the middle will drop packets [0, 2, 4, 4, 5, 6, 8, 10, 13, 13]
Dropping packet 0 (burst 1)
Dropping packet 2 (burst 2)
Dropping packet 4 (burst 3)
Dropping packet 5 (burst 4)
Dropping packet 10 (burst 1)
Dropping packet 13 (burst 1)
Received 250 bytes

 1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:248) destroy() in thread main at (2016-12-06 12:21:15)
 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:54504 - (org.eclipse.californium.core.network.CoapEndpoint.java:270) destroy() in thread main at (2016-12-06 12:21:15)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:54504 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-12-06 12:21:15)
 1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:104) destroy() in thread main at (2016-12-06 12:21:15)
 1 INFO [CoapEndpoint]: Destroying endpoint at address /127.0.0.1:46535 - (org.eclipse.californium.core.network.CoapEndpoint.java:105) destroy() in thread main at (2016-12-06 12:21:15)
 1 INFO [CoapEndpoint]: Stopping endpoint at address /127.0.0.1:46535 - (org.eclipse.californium.core.network.CoapEndpoint.java:396) stop() in thread main at (2016-12-06 12:21:15)
End LossyBlockwiseTransferTestTests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.729 sec - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest

Results :

Failed tests: 
  ObserveServerSideTest.testEstablishmentAndTimeoutWithUpdateInMiddle:201 Did not receive a message (but nothing)

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  2.109 s]
[INFO] element-connector .................................. SUCCESS [ 54.425 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  1.010 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 20.161 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 42.712 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:03 min
[INFO] Finished at: 2016-12-06T12:21:16-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