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

[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 #163
From: hudsonbuild@xxxxxxxxxxx
Date: Wed, 23 Aug 2017 02:50:07 -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/163/changes>

Changes:

[Achim Kraus] Do not wait client sequentially in ExampleDTLSClient

[Achim Kraus] Wait for all messages exchanged or timeout.

------------------------------------------
[...truncated 5296 lines...]
02:49:56.910:   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:56.911:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:56.912:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:56.912:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:56.913:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:56.913:   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:56.914:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,233 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:56.915:   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:56.915:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:56.916:   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:56.916:   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:56.919: 172 FINE [DirectDatagramSocketImpl]: (E458,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}, "503550543041636499840633".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.920: 175 FINE [DirectDatagramSocketImpl]: (E459,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:56.921: 172 FINE [DirectDatagramSocketImpl]: (E460,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)"}, "908065842947777939418690".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.923: 175 FINE [DirectDatagramSocketImpl]: (E461,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:56.924: 172 FINE [DirectDatagramSocketImpl]: (E462,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)"}, "681090295630055036254585".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.926: 175 FINE [DirectDatagramSocketImpl]: (E463,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}, "147108138628727710376204".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.928: 172 FINE [DirectDatagramSocketImpl]: (E464,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:56.930: 175 FINE [DirectDatagramSocketImpl]: (E465,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)"}, "322899276643791664409775".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.937: 172 FINE [DirectDatagramSocketImpl]: (E466,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:56.938: 175 FINE [DirectDatagramSocketImpl]: (E467,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)"}, "506104702371770071127224".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:56.939: 172 FINE [DirectDatagramSocketImpl]: (E468,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:56.940: 175 FINE [DirectDatagramSocketImpl]: (E469,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)"}, "817869971851095208405882".. 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:56.941:   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:56.942:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:57.026:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:57.026:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:57.027:   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:57.027:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:57.029:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:57.029:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:57.030:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.030:   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:57.031:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,235 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:57.032:   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:57.032:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.033:   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:57.033:   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:57.036: 181 FINE [DirectDatagramSocketImpl]: (E470,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)"}, "531942567712996907339292".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.038: 184 FINE [DirectDatagramSocketImpl]: (E471,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:57.039: 181 FINE [DirectDatagramSocketImpl]: (E472,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)"}, "009189213653891238079054".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.041: 184 FINE [DirectDatagramSocketImpl]: (E473,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:57.042: 181 FINE [DirectDatagramSocketImpl]: (E474,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)"}, "201394443058452545118958".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.045: 184 FINE [DirectDatagramSocketImpl]: (E475,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}, "920995356126815271681968".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.046: 181 FINE [DirectDatagramSocketImpl]: (E476,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:57.048: 184 FINE [DirectDatagramSocketImpl]: (E477,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)"}, "460751457513569255031998".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.049: 181 FINE [DirectDatagramSocketImpl]: (E478,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:57.051: 184 FINE [DirectDatagramSocketImpl]: (E479,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)"}, "388227502129409720893300".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.052: 181 FINE [DirectDatagramSocketImpl]: (E480,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:57.054: 184 FINE [DirectDatagramSocketImpl]: (E481,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)"}, "833096257413703708480351".. 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:57.054:   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:57.055:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:57.144:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:57.145:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:57.145:   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:57.146:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:57.150:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:57.151:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:57.152:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.152:   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:57.153:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,237 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:57.154:   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:57.155:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.155:   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:57.156:   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:57.158: 190 FINE [DirectDatagramSocketImpl]: (E482,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)"}, "096842369669229711731669".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.159: 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:57.160: 193 FINE [DirectDatagramSocketImpl]: (E483,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:57.162:   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:57.163:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:57.260:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:57.261:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:57.261:   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:57.262:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:57.263:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:57.263:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:57.264:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.265:   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:57.266:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,239 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:57.267:   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:57.267:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.268:   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:57.269:   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:57.272: 198 FINE [DirectDatagramSocketImpl]: (E484,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}, "216496894006658000249751".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.273: 201 FINE [DirectDatagramSocketImpl]: (E485,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:57.275: 198 FINE [DirectDatagramSocketImpl]: (E486,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)"}, "797169823847113141410792".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.277: 201 FINE [DirectDatagramSocketImpl]: (E487,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:57.278: 198 FINE [DirectDatagramSocketImpl]: (E488,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}, "216496894006658000249751".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.279: 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}, "216496894006658000249751".. 128 bytes - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:973) resetInboundBlock1Status() in thread CoapServer#1
02:49:57.280: 201 FINE [DirectDatagramSocketImpl]: (E489,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:57.282: 198 FINE [DirectDatagramSocketImpl]: (E490,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)"}, "797169823847113141410792".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.283: 201 FINE [DirectDatagramSocketImpl]: (E491,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:57.284: 198 FINE [DirectDatagramSocketImpl]: (E492,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)"}, "536132107423995603868298".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.286: 201 FINE [DirectDatagramSocketImpl]: (E493,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)"}, "509354871930868730902153".. 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:57.287:   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:57.288:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:57.386:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:57.387:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:57.387:   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:57.388:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:49:57.389:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:49:57.389:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:49:57.390:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.391:   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:57.392:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,241 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:49:57.393:   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:57.394:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:49:57.394:   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:57.395:   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:57.397: 207 FINE [DirectDatagramSocketImpl]: (E494,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}, "355238754482626413816965".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.398: 210 FINE [DirectDatagramSocketImpl]: (E495,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:57.400: 207 FINE [DirectDatagramSocketImpl]: (E496,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)"}, "000348653033990731958573".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.404: 210 FINE [DirectDatagramSocketImpl]: (E497,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:57.405: 207 FINE [DirectDatagramSocketImpl]: (E498,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)"}, "640223962005712889594206".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:49:57.406: 210 FINE [DirectDatagramSocketImpl]: (E499,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)"}, "582737904482580327347146".. 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:57.407:   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:57.407:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:49:57.506:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:49:57.506:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:49:57.507:   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:57.507:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
End BlockwiseServerSideTest
02:49:57.508:   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.002 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.012 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  1.817 s]
[INFO] element-connector .................................. SUCCESS [01:45 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:08 min]
[INFO] Californium (Cf) Core .............................. FAILURE [02:08 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:12 min
[INFO] Finished at: 2017-08-23T02:49:57-04:00
[INFO] Final Memory: 48M/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 #164
  - From: hudsonbuild
References:
- [cf-dev] [Hudson] Build failed in Hudson: 2.0.x-nightly #162
  - From: hudsonbuild
Prev by Date: [cf-dev] How To Do Multicast
Next by Date: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #164
Previous by thread: [cf-dev] [Hudson] Build failed in Hudson: 2.0.x-nightly #162
Next by thread: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #164
Index(es):
- Date
- Thread
Breadcrumbs
