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

[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 #155
From: hudsonbuild@xxxxxxxxxxx
Date: Tue, 15 Aug 2017 02:51:57 -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/155/>

------------------------------------------
[...truncated 5310 lines...]
02:51:49.506:   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:51:49.507:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:51:49.508:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:51:49.508:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:51:49.509:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.509:   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:51:49.510:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,233 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:51:49.511:   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:51:49.511:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.512:   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:51:49.512:   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:51:49.515: 172 FINE [DirectDatagramSocketImpl]: (E461,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}, "892830449205903359590703".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.516: 175 FINE [DirectDatagramSocketImpl]: (E462,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:51:49.517: 172 FINE [DirectDatagramSocketImpl]: (E463,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)"}, "841130237513892142719823".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.519: 175 FINE [DirectDatagramSocketImpl]: (E464,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:51:49.521: 172 FINE [DirectDatagramSocketImpl]: (E465,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)"}, "446534320054417131557354".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.522: 175 FINE [DirectDatagramSocketImpl]: (E466,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}, "140577523761841186126594".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.524: 172 FINE [DirectDatagramSocketImpl]: (E467,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:51:49.526: 175 FINE [DirectDatagramSocketImpl]: (E468,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)"}, "090298289476774005520277".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.527: 172 FINE [DirectDatagramSocketImpl]: (E469,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:51:49.528: 175 FINE [DirectDatagramSocketImpl]: (E470,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)"}, "282390036752326118904442".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.530: 172 FINE [DirectDatagramSocketImpl]: (E471,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:51:49.531: 175 FINE [DirectDatagramSocketImpl]: (E472,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)"}, "801212027519392396343037".. 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:51:49.532:   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:51:49.533:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:51:49.622:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:51:49.622:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8233 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:51:49.623:   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:51:49.623:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:51:49.624:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:51:49.625:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:51:49.625:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.626:   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:51:49.626:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,235 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:51:49.627:   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:51:49.628:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.628:   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:51:49.629:   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:51:49.632: 181 FINE [DirectDatagramSocketImpl]: (E473,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)"}, "347900430609529074946348".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.633: 184 FINE [DirectDatagramSocketImpl]: (E474,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:51:49.634: 181 FINE [DirectDatagramSocketImpl]: (E475,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)"}, "520817067162215579462556".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.637: 184 FINE [DirectDatagramSocketImpl]: (E476,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:51:49.638: 181 FINE [DirectDatagramSocketImpl]: (E477,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)"}, "427359035916890739142394".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.640: 184 FINE [DirectDatagramSocketImpl]: (E478,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}, "825436329853642351669877".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.641: 181 FINE [DirectDatagramSocketImpl]: (E479,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:51:49.643: 184 FINE [DirectDatagramSocketImpl]: (E480,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)"}, "900004454426544578120603".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.645: 181 FINE [DirectDatagramSocketImpl]: (E481,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:51:49.646: 184 FINE [DirectDatagramSocketImpl]: (E482,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)"}, "835628720251053639109263".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.648: 181 FINE [DirectDatagramSocketImpl]: (E483,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:51:49.649: 184 FINE [DirectDatagramSocketImpl]: (E484,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)"}, "596394370046859884619242".. 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:51:49.650:   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:51:49.650:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:51:49.739:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:51:49.740:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8235 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:51:49.740:   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:51:49.741:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:51:49.744:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:51:49.744:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:51:49.745:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.745:   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:51:49.746:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,237 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:51:49.747:   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:51:49.747:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.748:   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:51:49.748:   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:51:49.750: 190 FINE [DirectDatagramSocketImpl]: (E485,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)"}, "165791264176222876445342".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.751: 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:51:49.752: 193 FINE [DirectDatagramSocketImpl]: (E486,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:51:49.753:   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:51:49.754:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:51:49.852:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:51:49.852:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8237 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:51:49.853:   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:51:49.853:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:51:49.854:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:51:49.855:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:51:49.855:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.856:   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:51:49.856:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,239 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:51:49.857:   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:51:49.858:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.858:   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:51:49.859:   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:51:49.861: 198 FINE [DirectDatagramSocketImpl]: (E487,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}, "174190155864217651077603".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.863: 201 FINE [DirectDatagramSocketImpl]: (E488,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:51:49.864: 198 FINE [DirectDatagramSocketImpl]: (E489,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)"}, "972931122001787889875879".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.866: 201 FINE [DirectDatagramSocketImpl]: (E490,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:51:49.867: 198 FINE [DirectDatagramSocketImpl]: (E491,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}, "174190155864217651077603".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.868: 204 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}, "174190155864217651077603".. 128 bytes - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:973) resetInboundBlock1Status() in thread CoapServer#3
02:51:49.869: 201 FINE [DirectDatagramSocketImpl]: (E492,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:51:49.870: 198 FINE [DirectDatagramSocketImpl]: (E493,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)"}, "972931122001787889875879".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.872: 201 FINE [DirectDatagramSocketImpl]: (E494,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:51:49.873: 198 FINE [DirectDatagramSocketImpl]: (E495,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)"}, "561090820382379054619785".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.875: 201 FINE [DirectDatagramSocketImpl]: (E496,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)"}, "167080901117935036758529".. 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:51:49.875:   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:51:49.876:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:51:49.975:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:51:49.975:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8239 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:51:49.975:   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:51:49.976:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
02:51:49.977:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:203) start() in thread main
02:51:49.977:   1 INFO [CoapEndpoint]: Starting endpoint at coap://localhost:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:414) start() in thread main
02:51:49.978:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.979:   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:51:49.979:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,241 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:51:49.980:   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:51:49.981:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:425) isActive() in thread main
02:51:49.981:   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:51:49.982:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,242 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Simple atomic blockwise PUT
02:51:49.984: 207 FINE [DirectDatagramSocketImpl]: (E497,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}, "030196269305923674006386".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.985: 210 FINE [DirectDatagramSocketImpl]: (E498,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:51:49.986: 207 FINE [DirectDatagramSocketImpl]: (E499,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)"}, "535332458874704249868046".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.988: 210 FINE [DirectDatagramSocketImpl]: (E500,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:51:49.990: 207 FINE [DirectDatagramSocketImpl]: (E501,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)"}, "842773666984074763890791".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:51:49.991: 210 FINE [DirectDatagramSocketImpl]: (E502,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)"}, "950793564602269173066478".. 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:51:49.992:   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:51:49.992:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:251) destroy() in thread main
02:51:50.091:   1 INFO [CoapEndpoint]: Destroying endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:466) destroy() in thread main
02:51:50.092:   1 INFO [CoapEndpoint]: Stopping endpoint at address coap://localhost:8241 - (org.eclipse.californium.core.network.CoapEndpoint.java:453) stop() in thread main
02:51:50.092:   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:51:50.093:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:275) destroy() in thread main
End BlockwiseServerSideTest
02:51:50.093:   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: 1.997 sec - in org.eclipse.californium.core.test.lockstep.BlockwiseServerSideTest

Results :

Failed tests: 
  ObserveClientSideTest.testGETObserveWithLostACK:177 
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.477 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  2.039 s]
[INFO] element-connector .................................. SUCCESS [01:57 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:13 min]
[INFO] Californium (Cf) Core .............................. FAILURE [02:14 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:37 min
[INFO] Finished at: 2017-08-15T02:51:50-04:00
[INFO] Final Memory: 45M/285M
[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 #156
  - From: hudsonbuild
Prev by Date: [cf-dev] [Hudson] Hudson build is back to normal : 1.1.x-nightly #146
Next by Date: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #156
Previous by thread: [cf-dev] [Hudson] Build failed in Hudson: 1.1.x-nightly #144
Next by thread: [cf-dev] [Hudson] Hudson build is back to normal : 2.0.x-nightly #156
Index(es):
- Date
- Thread
Breadcrumbs
