[cf-dev] [Hudson] Build failed in Hudson: 2.0.x-nightly #165

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] [Hudson] Build failed in Hudson: 2.0.x-nightly #165
From: hudsonbuild@xxxxxxxxxxx
Date: Fri, 25 Aug 2017 02:49:54 -0400 (EDT)
Delivered-to: cf-dev@xxxxxxxxxxx
List-archive: <https://dev.eclipse.org/mailman/private/cf-dev>
List-help: <mailto:cf-dev-request@eclipse.org?subject=help>
List-subscribe: <https://dev.eclipse.org/mailman/listinfo/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=subscribe>
List-unsubscribe: <https://dev.eclipse.org/mailman/options/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=unsubscribe>
See <https://hudson.eclipse.org/californium/job/2.0.x-nightly/165/>

------------------------------------------
[...truncated 5286 lines...]
02:49:45.354:   1 FINE [DirectDatagramSocketImpl]: closing port 8,231, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.355:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:45.356:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:45.356:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:45.357:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.357:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.358:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,233 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:45.359:   1 INFO [CoapEndpoint]: Started endpoint at coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:423) start() in thread main
Server binds to port 8233
02:49:45.359:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.359:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.360:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,234 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Atomic blockwise POST with blockwise response:
02:49:45.363: 172 FINE [DirectDatagramSocketImpl]: (E452,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7001, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)", "Size1":300}, "598981932971499034711144".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.364: 175 FINE [DirectDatagramSocketImpl]: (E453,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.31   MID= 7001, Token=1d, OptionSet={"Block1":"(szx=3/128, m=true, num=0)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.365: 172 FINE [DirectDatagramSocketImpl]: (E454,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7002, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "483340581979331367006156".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.367: 175 FINE [DirectDatagramSocketImpl]: (E455,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.31   MID= 7002, Token=1d, OptionSet={"Block1":"(szx=3/128, m=true, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.369: 172 FINE [DirectDatagramSocketImpl]: (E456,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7003, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "662028528902680537014233".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.370: 175 FINE [DirectDatagramSocketImpl]: (E457,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.04   MID= 7003, Token=1d, OptionSet={"ETag":0x0001, "Block2":"(szx=3/128, m=true, num=0)", "Block1":"(szx=3/128, m=false, num=2)", "Size2":500}, "945507552816983109304017".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.372: 172 FINE [DirectDatagramSocketImpl]: (E458,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7004, Token=1d, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=3/128, m=false, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.374: 175 FINE [DirectDatagramSocketImpl]: (E459,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.04   MID= 7004, Token=1d, OptionSet={"ETag":0x0001, "Block2":"(szx=3/128, m=true, num=1)"}, "385885895623264601996599".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.375: 172 FINE [DirectDatagramSocketImpl]: (E460,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7005, Token=1d, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=3/128, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.376: 175 FINE [DirectDatagramSocketImpl]: (E461,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.04   MID= 7005, Token=1d, OptionSet={"ETag":0x0001, "Block2":"(szx=3/128, m=true, num=2)"}, "536420253748294737704761".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.378: 172 FINE [DirectDatagramSocketImpl]: (E462,T172) 127.0.0.1:8,234 ==> :8,233 [CON-POST   MID= 7006, Token=1d, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=3/128, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.379: 175 FINE [DirectDatagramSocketImpl]: (E463,T175) 127.0.0.1:8,233 ==> :8,234 [ACK-2.04   MID= 7006, Token=1d, OptionSet={"ETag":0x0001, "Block2":"(szx=3/128, m=false, num=3)"}, "277315237998704875421975".. 116 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
CON [MID=7001, T=1d], POST, /test, 1:0/1/128, size1(300)    ----->
<-----   ACK [MID=7001, T=1d], 2.31, 1:0/1/128
CON [MID=7002, T=1d], POST, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1d], 2.31, 1:1/1/128
CON [MID=7003, T=1d], POST, /test, 1:2/0/128    ----->
<-----   ACK [MID=7003, T=1d], 2.04, 1:2/0/128, 2:0/1/128, size2(500), ETags(0001)
CON [MID=7004, T=1d], POST, /test, 2:1/0/128, ETags(0001)    ----->
<-----   ACK [MID=7004, T=1d], 2.04, 2:1/1/128, ETags(0001)
CON [MID=7005, T=1d], POST, /test, 2:2/0/128, ETags(0001)    ----->
<-----   ACK [MID=7005, T=1d], 2.04, 2:2/1/128, ETags(0001)
CON [MID=7006, T=1d], POST, /test, 2:3/0/128, ETags(0001)    ----->
<-----   ACK [MID=7006, T=1d], 2.04, 2:3/0/128, ETags(0001)


02:49:45.380:   1 FINE [DirectDatagramSocketImpl]: closing port 8,234, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.380:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:45.470:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:45.471:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:45.471:   1 FINE [DirectDatagramSocketImpl]: closing port 8,233, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.472:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:45.473:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:45.473:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:45.474:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.474:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.475:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,235 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:45.475:   1 INFO [CoapEndpoint]: Started endpoint at coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:423) start() in thread main
Server binds to port 8235
02:49:45.476:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.476:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.477:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,236 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Atomic blockwise POST with blockwise response using early negotiation:
02:49:45.479: 181 FINE [DirectDatagramSocketImpl]: (E464,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7001, Token=1e, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "582693072454759978091474".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.481: 184 FINE [DirectDatagramSocketImpl]: (E465,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.31   MID= 7001, Token=1e, OptionSet={"Block1":"(szx=3/128, m=true, num=0)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.483: 181 FINE [DirectDatagramSocketImpl]: (E466,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7002, Token=1e, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "360678809326656923278796".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.486: 184 FINE [DirectDatagramSocketImpl]: (E467,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.31   MID= 7002, Token=1e, OptionSet={"Block1":"(szx=3/128, m=true, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.487: 181 FINE [DirectDatagramSocketImpl]: (E468,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7003, Token=1e, OptionSet={"Uri-Path":"test", "Block2":"(szx=2/64, m=false, num=0)", "Block1":"(szx=3/128, m=false, num=2)"}, "112826552450628812705250".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.489: 184 FINE [DirectDatagramSocketImpl]: (E469,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.04   MID= 7003, Token=1e, OptionSet={"ETag":0x0001, "Block2":"(szx=2/64, m=true, num=0)", "Block1":"(szx=3/128, m=false, num=2)", "Size2":250}, "480903377584053931690384".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.490: 181 FINE [DirectDatagramSocketImpl]: (E470,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7004, Token=1e, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=2/64, m=false, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.492: 184 FINE [DirectDatagramSocketImpl]: (E471,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.04   MID= 7004, Token=1e, OptionSet={"ETag":0x0001, "Block2":"(szx=2/64, m=true, num=1)"}, "802907828504757663853239".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.494: 181 FINE [DirectDatagramSocketImpl]: (E472,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7005, Token=1e, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=2/64, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.495: 184 FINE [DirectDatagramSocketImpl]: (E473,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.04   MID= 7005, Token=1e, OptionSet={"ETag":0x0001, "Block2":"(szx=2/64, m=true, num=2)"}, "676675323546782203406040".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.497: 181 FINE [DirectDatagramSocketImpl]: (E474,T181) 127.0.0.1:8,236 ==> :8,235 [CON-POST   MID= 7006, Token=1e, OptionSet={"ETag":0x0001, "Uri-Path":"test", "Block2":"(szx=2/64, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.498: 184 FINE [DirectDatagramSocketImpl]: (E475,T184) 127.0.0.1:8,235 ==> :8,236 [ACK-2.04   MID= 7006, Token=1e, OptionSet={"ETag":0x0001, "Block2":"(szx=2/64, m=false, num=3)"}, "750532910351914584430999".. 58 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
CON [MID=7001, T=1e], POST, /test, 1:0/1/128    ----->
<-----   ACK [MID=7001, T=1e], 2.31, 1:0/1/128
CON [MID=7002, T=1e], POST, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1e], 2.31, 1:1/1/128
CON [MID=7003, T=1e], POST, /test, 1:2/0/128, 2:0/0/64    ----->
<-----   ACK [MID=7003, T=1e], 2.04, 1:2/0/128, 2:0/1/64, size2(250), ETags(0001)// early negotiation
CON [MID=7004, T=1e], POST, /test, 2:1/0/64, ETags(0001)    ----->
<-----   ACK [MID=7004, T=1e], 2.04, 2:1/1/64, ETags(0001)
CON [MID=7005, T=1e], POST, /test, 2:2/0/64, ETags(0001)    ----->
<-----   ACK [MID=7005, T=1e], 2.04, 2:2/1/64, ETags(0001)
CON [MID=7006, T=1e], POST, /test, 2:3/0/64, ETags(0001)    ----->
<-----   ACK [MID=7006, T=1e], 2.04, 2:3/0/64, ETags(0001)


02:49:45.499:   1 FINE [DirectDatagramSocketImpl]: closing port 8,236, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.500:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:45.588:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:45.589:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:45.589:   1 FINE [DirectDatagramSocketImpl]: closing port 8,235, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.590:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:45.593:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:45.593:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:45.594:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.595:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.595:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,237 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:45.596:   1 INFO [CoapEndpoint]: Started endpoint at coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:423) start() in thread main
Server binds to port 8237
02:49:45.597:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.597:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.598:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,238 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Random access PUT attempt: (try to put block 2 first is now allowed)
02:49:45.600: 190 FINE [DirectDatagramSocketImpl]: (E476,T190) 127.0.0.1:8,238 ==> :8,237 [CON-PUT    MID= 7001, Token=1f, OptionSet={"Uri-Path":"test", "Block1":"(szx=2/64, m=true, num=2)"}, "321341142406365852291080".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.601: 192 WARNING [BlockwiseLayer]: peer sent wrong block, expected no. 0 but got 2. Responding with 4.08 (Request Entity Incomplete) - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:344) handleInboundBlockwiseUpload() in thread CoapServer#1
02:49:45.602: 193 FINE [DirectDatagramSocketImpl]: (E477,T193) 127.0.0.1:8,237 ==> :8,238 [ACK-4.08   MID= 7001, Token=1f, OptionSet={"Block1":"(szx=2/64, m=true, num=2)"}, "wrong block number"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
CON [MID=7001, T=1f], PUT, /test, 1:2/1/64    ----->
<-----   ACK [MID=7001, T=1f], 4.08, 1:2/1/64


02:49:45.603:   1 FINE [DirectDatagramSocketImpl]: closing port 8,238, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.603:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:45.702:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:45.703:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:45.703:   1 FINE [DirectDatagramSocketImpl]: closing port 8,237, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.703:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:45.705:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:45.705:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:45.706:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.706:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.706:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,239 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:45.707:   1 INFO [CoapEndpoint]: Started endpoint at coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:423) start() in thread main
Server binds to port 8239
02:49:45.708:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.708:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.709:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,240 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Simple atomic blockwise PUT restart of the blockwise transfer
02:49:45.711: 198 FINE [DirectDatagramSocketImpl]: (E478,T198) 127.0.0.1:8,240 ==> :8,239 [CON-PUT    MID= 7001, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)", "Size1":300}, "872093753619946915142798".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.712: 201 FINE [DirectDatagramSocketImpl]: (E479,T201) 127.0.0.1:8,239 ==> :8,240 [ACK-2.31   MID= 7001, Token=20, OptionSet={"Block1":"(szx=3/128, m=true, num=0)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.714: 198 FINE [DirectDatagramSocketImpl]: (E480,T198) 127.0.0.1:8,240 ==> :8,239 [CON-PUT    MID= 7002, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "422740293578412576781613".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.716: 201 FINE [DirectDatagramSocketImpl]: (E481,T201) 127.0.0.1:8,239 ==> :8,240 [ACK-2.31   MID= 7002, Token=20, OptionSet={"Block1":"(szx=3/128, m=true, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.717: 198 FINE [DirectDatagramSocketImpl]: (E482,T198) 127.0.0.1:8,240 ==> :8,239 [CON-PUT    MID= 7003, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)", "Size1":300}, "872093753619946915142798".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.718: 200 WARNING [BlockwiseLayer]: inbound block1 transfer reset at [currentNum=2, currentSzx=0, bufferSize=300, complete=false, random access=false] by peer: CON-PUT    MID= 7003, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)", "Size1":300}, "872093753619946915142798".. 128 bytes - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:973) resetInboundBlock1Status() in thread CoapServer#1
02:49:45.719: 201 FINE [DirectDatagramSocketImpl]: (E483,T201) 127.0.0.1:8,239 ==> :8,240 [ACK-2.31   MID= 7003, Token=20, OptionSet={"Block1":"(szx=3/128, m=true, num=0)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.721: 198 FINE [DirectDatagramSocketImpl]: (E484,T198) 127.0.0.1:8,240 ==> :8,239 [CON-PUT    MID= 7004, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "422740293578412576781613".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.722: 201 FINE [DirectDatagramSocketImpl]: (E485,T201) 127.0.0.1:8,239 ==> :8,240 [ACK-2.31   MID= 7004, Token=20, OptionSet={"Block1":"(szx=3/128, m=true, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.724: 198 FINE [DirectDatagramSocketImpl]: (E486,T198) 127.0.0.1:8,240 ==> :8,239 [CON-PUT    MID= 7005, Token=20, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "063625453400402743371926".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.725: 201 FINE [DirectDatagramSocketImpl]: (E487,T201) 127.0.0.1:8,239 ==> :8,240 [ACK-2.04   MID= 7005, Token=20, OptionSet={"Block1":"(szx=3/128, m=false, num=2)"}, "213029701461764717583498".. 50 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
CON [MID=7001, T=20], PUT, /test, 1:0/1/128, size1(300)    ----->
<-----   ACK [MID=7001, T=20], 2.31, 1:0/1/128
CON [MID=7002, T=20], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=20], 2.31, 1:1/1/128
... client crashes or whatever and restarts transfer
CON [MID=7003, T=20], PUT, /test, 1:0/1/128, size1(300)    ----->
<-----   ACK [MID=7003, T=20], 2.31, 1:0/1/128
CON [MID=7004, T=20], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7004, T=20], 2.31, 1:1/1/128
CON [MID=7005, T=20], PUT, /test, 1:2/0/128    ----->
<-----   ACK [MID=7005, T=20], 2.04, 1:2/0/128


02:49:45.726:   1 FINE [DirectDatagramSocketImpl]: closing port 8,240, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.726:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:45.825:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:45.826:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:45.826:   1 FINE [DirectDatagramSocketImpl]: closing port 8,239, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.826:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:45.828:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:45.828:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:45.829:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.829:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.829:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,241 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:45.830:   1 INFO [CoapEndpoint]: Started endpoint at coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:423) start() in thread main
Server binds to port 8241
02:49:45.831:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:45.831:   1 FINE [DirectDatagramSocketImpl]: binding to port 0, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:49:45.832:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,242 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Simple atomic blockwise PUT
02:49:45.834: 207 FINE [DirectDatagramSocketImpl]: (E488,T207) 127.0.0.1:8,242 ==> :8,241 [CON-PUT    MID= 7001, Token=21, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)", "Size1":300}, "815442392287589219774489".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.835: 210 FINE [DirectDatagramSocketImpl]: (E489,T210) 127.0.0.1:8,241 ==> :8,242 [ACK-2.31   MID= 7001, Token=21, OptionSet={"Block1":"(szx=3/128, m=true, num=0)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.836: 207 FINE [DirectDatagramSocketImpl]: (E490,T207) 127.0.0.1:8,242 ==> :8,241 [CON-PUT    MID= 7002, Token=22, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "368592881805054225691952".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.839: 210 FINE [DirectDatagramSocketImpl]: (E491,T210) 127.0.0.1:8,241 ==> :8,242 [ACK-2.31   MID= 7002, Token=22, OptionSet={"Block1":"(szx=3/128, m=true, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.840: 207 FINE [DirectDatagramSocketImpl]: (E492,T207) 127.0.0.1:8,242 ==> :8,241 [CON-PUT    MID= 7003, Token=23, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "846410445324288087361213".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:45.841: 210 FINE [DirectDatagramSocketImpl]: (E493,T210) 127.0.0.1:8,241 ==> :8,242 [ACK-2.04   MID= 7003, Token=23, OptionSet={"Block1":"(szx=3/128, m=false, num=2)"}, "893757873220563924526490".. 50 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
CON [MID=7001, T=21], PUT, /test, 1:0/1/128, size1(300)    ----->
<-----   ACK [MID=7001, T=21], 2.31, 1:0/1/128
CON [MID=7002, T=22], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=22], 2.31, 1:1/1/128
CON [MID=7003, T=23], PUT, /test, 1:2/0/128    ----->
<-----   ACK [MID=7003, T=23], 2.04, 1:2/0/128


02:49:45.842:   1 FINE [DirectDatagramSocketImpl]: closing port 8,242, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.842:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:45.941:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:45.942:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:45.942:   1 FINE [DirectDatagramSocketImpl]: closing port 8,241, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:49:45.943:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
End BlockwiseServerSideTest
02:49:45.943:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.032 sec - in org.eclipse.californium.core.test.lockstep.BlockwiseServerSideTest

Results :

Failed tests: 
  ObserveClientSideTest.testGETObserveWithLostACK:178 
Expected: is <1>
     but: was <2>

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  3.581 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  1.566 s]
[INFO] element-connector .................................. SUCCESS [01:43 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:07 min]
[INFO] Californium (Cf) Core .............................. FAILURE [02:05 min]
[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-SimpleFileServer ................................ 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: 05:07 min
[INFO] Finished at: 2017-08-25T02:49:46-04:00
[INFO] Final Memory: 45M/284M
[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 <https://hudson.eclipse.org/californium/job/2.0.x-nightly/ws/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 <https://hudson.eclipse.org/californium/job/2.0.x-nightly/ws/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/
Follow-Ups:
- [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #166
  - From: hudsonbuild
Prev by Date: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #164
Next by Date: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #166
Previous by thread: [cf-dev] How To Do Multicast
Next by thread: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #166
Index(es):
- Date
- Thread
Breadcrumbs
