[cf-dev] Build failed in Jenkins: 1.1.x-nightly #360

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] Build failed in Jenkins: 1.1.x-nightly #360
From: hudsonbuild@xxxxxxxxxxx
Date: Tue, 13 Mar 2018 02:23:09 -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://ci.eclipse.org/californium/job/1.1.x-nightly/360/display/redirect>

------------------------------------------
[...truncated 893.95 KB...]
02:22:57.037:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:22:57.038:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:22:57.038:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:341) start() in thread main
02:22:57.038:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.039:   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:22:57.039:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,219 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Server binds to port 8219
02:22:57.040:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.040:   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:22:57.041:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,220 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Atomic blockwise POST with blockwise response:
02:22:57.045: 124 FINE [DirectDatagramSocketImpl]: (E401,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7001, Token=1a, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "251085513245091709777532".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.047: 127 FINE [DirectDatagramSocketImpl]: (E402,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.31   MID= 7001, Token=1a, 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:22:57.049: 124 FINE [DirectDatagramSocketImpl]: (E403,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7002, Token=1a, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "115748445635747166277602".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.051: 127 FINE [DirectDatagramSocketImpl]: (E404,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.31   MID= 7002, Token=1a, 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:22:57.052: 124 FINE [DirectDatagramSocketImpl]: (E405,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7003, Token=1a, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "379247118411704252681428".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Server has received request payload: 251085513245091709777532166259452644883732750354651842606053572858158970816577587754197293714961328253426275944388989156740888961157484456357471662776023991428660301365788047371427499816203157080426519380955676188630401157726043829802938877513633581587763637924711841170425268142851482425321483750578
02:22:57.054: 127 FINE [DirectDatagramSocketImpl]: (E406,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.04   MID= 7003, Token=1a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=3/128, m=true, num=0)", "Block1":"(szx=3/128, m=false, num=2)", "Size2":500}, "801784846169916036991643".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.055: 124 FINE [DirectDatagramSocketImpl]: (E407,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7004, Token=1a, OptionSet={"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:22:57.057: 127 FINE [DirectDatagramSocketImpl]: (E408,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.04   MID= 7004, Token=1a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=3/128, m=true, num=1)", "Size2":500}, "994293972618945201527995".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.058: 124 FINE [DirectDatagramSocketImpl]: (E409,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7005, Token=1a, OptionSet={"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:22:57.060: 127 FINE [DirectDatagramSocketImpl]: (E410,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.04   MID= 7005, Token=1a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=3/128, m=true, num=2)", "Size2":500}, "437443980335102483356992".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.061: 124 FINE [DirectDatagramSocketImpl]: (E411,T124) 127.0.0.1:8,220 ==> :8,219 [CON-POST   MID= 7006, Token=1a, OptionSet={"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:22:57.063: 127 FINE [DirectDatagramSocketImpl]: (E412,T127) 127.0.0.1:8,219 ==> :8,220 [ACK-2.04   MID= 7006, Token=1a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=3/128, m=false, num=3)", "Size2":500}, "464745096967624462315619".. 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=1a], POST, /test, 1:0/1/128    ----->
<-----   ACK [MID=7001, T=1a], 2.31, 1:0/1/128
CON [MID=7002, T=1a], POST, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1a], 2.31, 1:1/1/128
CON [MID=7003, T=1a], POST, /test, 1:2/0/128    ----->
<-----   ACK [MID=7003, T=1a], 2.04, 1:2/0/128, 2:0/1/128, size2(500)
CON [MID=7004, T=1a], POST, /test, 2:1/0/128    ----->
<-----   ACK [MID=7004, T=1a], 2.04, 2:1/1/128, size2(500)
CON [MID=7005, T=1a], POST, /test, 2:2/0/128    ----->
<-----   ACK [MID=7005, T=1a], 2.04, 2:2/1/128, size2(500)
CON [MID=7006, T=1a], POST, /test, 2:3/0/128    ----->
<-----   ACK [MID=7006, T=1a], 2.04, 2:3/0/128, size2(500)


02:22:57.064:   1 FINE [DirectDatagramSocketImpl]: closing port 8,220, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.064:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:22:57.066:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8219 - (org.eclipse.californium.core.network.CoapEndpoint.java:392) destroy() in thread main
02:22:57.067:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8219 - (org.eclipse.californium.core.network.CoapEndpoint.java:379) stop() in thread main
02:22:57.067:   1 FINE [DirectDatagramSocketImpl]: closing port 8,219, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.068:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:22:57.070:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:22:57.071:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:341) start() in thread main
02:22:57.072:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.072:   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:22:57.072:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,221 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Server binds to port 8221
02:22:57.074:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.075:   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:22:57.075:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,222 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Atomic blockwise POST with blockwise response:
02:22:57.078: 133 FINE [DirectDatagramSocketImpl]: (E413,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7001, Token=1b, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "489577005423719380148271".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.080: 136 FINE [DirectDatagramSocketImpl]: (E414,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.31   MID= 7001, Token=1b, 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:22:57.081: 133 FINE [DirectDatagramSocketImpl]: (E415,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7002, Token=1b, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "464372343278894674177192".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.084: 136 FINE [DirectDatagramSocketImpl]: (E416,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.31   MID= 7002, Token=1b, 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:22:57.086: 133 FINE [DirectDatagramSocketImpl]: (E417,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7003, Token=1b, OptionSet={"Uri-Path":"test", "Block2":"(szx=2/64, m=false, num=0)", "Block1":"(szx=3/128, m=false, num=2)"}, "160494348551534448094296".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Server has received request payload: 489577005423719380148271120666792040408926918518906748190698387254681098947278831255648871381740448562265781344351935503459537244643723432788946741771928276795042394274119030892316480333065502782710448006608560022730193853671737298848919508517051492156377316049434855153444809429622232361238911764250
02:22:57.088: 136 FINE [DirectDatagramSocketImpl]: (E418,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.04   MID= 7003, Token=1b, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=2/64, m=true, num=0)", "Block1":"(szx=3/128, m=false, num=2)", "Size2":250}, "618970838059391837583140".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.089: 133 FINE [DirectDatagramSocketImpl]: (E419,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7004, Token=1b, OptionSet={"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:22:57.091: 136 FINE [DirectDatagramSocketImpl]: (E420,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.04   MID= 7004, Token=1b, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=2/64, m=true, num=1)", "Size2":250}, "503929889645774396271888".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.092: 133 FINE [DirectDatagramSocketImpl]: (E421,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7005, Token=1b, OptionSet={"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:22:57.094: 136 FINE [DirectDatagramSocketImpl]: (E422,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.04   MID= 7005, Token=1b, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=2/64, m=true, num=2)", "Size2":250}, "791498462570796526334252".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.095: 133 FINE [DirectDatagramSocketImpl]: (E423,T133) 127.0.0.1:8,222 ==> :8,221 [CON-POST   MID= 7006, Token=1b, OptionSet={"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:22:57.097: 136 FINE [DirectDatagramSocketImpl]: (E424,T136) 127.0.0.1:8,221 ==> :8,222 [ACK-2.04   MID= 7006, Token=1b, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=2/64, m=false, num=3)", "Size2":250}, "352157951792669199344618".. 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=1b], POST, /test, 1:0/1/128    ----->
<-----   ACK [MID=7001, T=1b], 2.31, 1:0/1/128
CON [MID=7002, T=1b], POST, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1b], 2.31, 1:1/1/128
CON [MID=7003, T=1b], POST, /test, 1:2/0/128, 2:0/0/64    ----->
<-----   ACK [MID=7003, T=1b], 2.04, 1:2/0/128, 2:0/1/64, size2(250)// early negotiation
CON [MID=7004, T=1b], POST, /test, 2:1/0/64    ----->
<-----   ACK [MID=7004, T=1b], 2.04, 2:1/1/64, size2(250)
CON [MID=7005, T=1b], POST, /test, 2:2/0/64    ----->
<-----   ACK [MID=7005, T=1b], 2.04, 2:2/1/64, size2(250)
CON [MID=7006, T=1b], POST, /test, 2:3/0/64    ----->
<-----   ACK [MID=7006, T=1b], 2.04, 2:3/0/64, size2(250)


02:22:57.098:   1 FINE [DirectDatagramSocketImpl]: closing port 8,222, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.099:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:22:57.100:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8221 - (org.eclipse.californium.core.network.CoapEndpoint.java:392) destroy() in thread main
02:22:57.100:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8221 - (org.eclipse.californium.core.network.CoapEndpoint.java:379) stop() in thread main
02:22:57.101:   1 FINE [DirectDatagramSocketImpl]: closing port 8,221, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.101:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:22:57.103:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:22:57.103:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:341) start() in thread main
02:22:57.104:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.104:   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:22:57.105:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,223 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Server binds to port 8223
02:22:57.107:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.107:   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:22:57.108:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,224 - (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:22:57.110: 142 FINE [DirectDatagramSocketImpl]: (E425,T142) 127.0.0.1:8,224 ==> :8,223 [CON-PUT    MID= 7001, Token=1c, OptionSet={"Uri-Path":"test", "Block1":"(szx=2/64, m=true, num=2)"}, "321433946888374802570599".. 64 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.111: 147 WARNING [BlockwiseLayer]: Wrong block number. Expected 0 but received 2. Respond with 4.08 (Request Entity Incomplete) - (org.eclipse.californium.core.network.stack.BlockwiseLayer.java:311) handleInboundBlockwiseUpload() in thread CoapServer#2
02:22:57.112: 145 FINE [DirectDatagramSocketImpl]: (E426,T145) 127.0.0.1:8,223 ==> :8,224 [ACK-4.08   MID= 7001, Token=1c, 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=1c], PUT, /test, 1:2/1/64    ----->
<-----   ACK [MID=7001, T=1c], 4.08, 1:2/1/64


02:22:57.113:   1 FINE [DirectDatagramSocketImpl]: closing port 8,224, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.114:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:22:57.121:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8223 - (org.eclipse.californium.core.network.CoapEndpoint.java:392) destroy() in thread main
02:22:57.122:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8223 - (org.eclipse.californium.core.network.CoapEndpoint.java:379) stop() in thread main
02:22:57.122:   1 FINE [DirectDatagramSocketImpl]: closing port 8,223, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.123:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:22:57.124:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:22:57.124:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:341) start() in thread main
02:22:57.124:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.125:   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:22:57.125:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,225 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Server binds to port 8225
02:22:57.126:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.132:   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:22:57.133:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,226 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Simple atomic blockwise PUT restart of the blockwise transfer
02:22:57.138: 150 FINE [DirectDatagramSocketImpl]: (E427,T150) 127.0.0.1:8,226 ==> :8,225 [CON-PUT    MID= 7001, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "254780996500959480956367".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.139: 153 FINE [DirectDatagramSocketImpl]: (E428,T153) 127.0.0.1:8,225 ==> :8,226 [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:22:57.140: 150 FINE [DirectDatagramSocketImpl]: (E429,T150) 127.0.0.1:8,226 ==> :8,225 [CON-PUT    MID= 7002, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "597128262548510053757789".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.141: 153 FINE [DirectDatagramSocketImpl]: (E430,T153) 127.0.0.1:8,225 ==> :8,226 [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:22:57.142: 150 FINE [DirectDatagramSocketImpl]: (E431,T150) 127.0.0.1:8,226 ==> :8,225 [CON-PUT    MID= 7003, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "254780996500959480956367".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.143: 153 FINE [DirectDatagramSocketImpl]: (E432,T153) 127.0.0.1:8,225 ==> :8,226 [ACK-2.31   MID= 7003, 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:22:57.144: 150 FINE [DirectDatagramSocketImpl]: (E433,T150) 127.0.0.1:8,226 ==> :8,225 [CON-PUT    MID= 7004, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "597128262548510053757789".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.145: 153 FINE [DirectDatagramSocketImpl]: (E434,T153) 127.0.0.1:8,225 ==> :8,226 [ACK-2.31   MID= 7004, 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:22:57.146: 150 FINE [DirectDatagramSocketImpl]: (E435,T150) 127.0.0.1:8,226 ==> :8,225 [CON-PUT    MID= 7005, Token=1d, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "739997931797263885111911".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Server has received request payload: 254780996500959480956367286843854944526231695750064193099985354350567557603186313489823572633370348393415654884429693304670949175971282625485100537577896247834473463363582196424181136912422478714859126219589318732965863819905355282317041438628757838077370973999793179726388511191134212793073255628112
02:22:57.147: 153 FINE [DirectDatagramSocketImpl]: (E436,T153) 127.0.0.1:8,225 ==> :8,226 [ACK-2.04   MID= 7005, Token=1d, OptionSet={"Content-Format":"text/plain", "Block1":"(szx=3/128, m=false, num=2)"}, "977887652109638206713110".. 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=1d], PUT, /test, 1:0/1/128    ----->
<-----   ACK [MID=7001, T=1d], 2.31, 1:0/1/128
CON [MID=7002, T=1d], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1d], 2.31, 1:1/1/128
... client crashes or whatever and restarts transfer
CON [MID=7003, T=1d], PUT, /test, 1:0/1/128    ----->
<-----   ACK [MID=7003, T=1d], 2.31, 1:0/1/128
CON [MID=7004, T=1d], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7004, T=1d], 2.31, 1:1/1/128
CON [MID=7005, T=1d], PUT, /test, 1:2/0/128    ----->
<-----   ACK [MID=7005, T=1d], 2.04, 1:2/0/128


02:22:57.147:   1 FINE [DirectDatagramSocketImpl]: closing port 8,226, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.148:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:22:57.149:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8225 - (org.eclipse.californium.core.network.CoapEndpoint.java:392) destroy() in thread main
02:22:57.149:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8225 - (org.eclipse.californium.core.network.CoapEndpoint.java:379) stop() in thread main
02:22:57.149:   1 FINE [DirectDatagramSocketImpl]: closing port 8,225, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.150:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:22:57.151:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:22:57.151:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:341) start() in thread main
02:22:57.152:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22: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:22:57.152:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,227 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Server binds to port 8227
02:22:57.154:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:22:57.154:   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:22:57.154:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,228 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Simple atomic blockwise PUT
02:22:57.156: 159 FINE [DirectDatagramSocketImpl]: (E437,T159) 127.0.0.1:8,228 ==> :8,227 [CON-PUT    MID= 7001, Token=1e, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=0)"}, "373351634091425721834554".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.157: 162 FINE [DirectDatagramSocketImpl]: (E438,T162) 127.0.0.1:8,227 ==> :8,228 [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:22:57.158: 159 FINE [DirectDatagramSocketImpl]: (E439,T159) 127.0.0.1:8,228 ==> :8,227 [CON-PUT    MID= 7002, Token=1e, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=true, num=1)"}, "064886299773652826377123".. 128 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:22:57.159: 162 FINE [DirectDatagramSocketImpl]: (E440,T162) 127.0.0.1:8,227 ==> :8,228 [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:22:57.160: 159 FINE [DirectDatagramSocketImpl]: (E441,T159) 127.0.0.1:8,228 ==> :8,227 [CON-PUT    MID= 7003, Token=1e, OptionSet={"Uri-Path":"test", "Block1":"(szx=3/128, m=false, num=2)"}, "387076805504153578080419".. 44 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Server has received request payload: 373351634091425721834554015550930776288055328439754946178848718483026369647867643571704591678223927710543659487459237042119763550648862997736528263771239575808299351100117082468924739181498762802668189768735585189942286342649015454625226406536540814085614738707680550415357808041996663816582793022814
02:22:57.161: 162 FINE [DirectDatagramSocketImpl]: (E442,T162) 127.0.0.1:8,227 ==> :8,228 [ACK-2.04   MID= 7003, Token=1e, OptionSet={"Content-Format":"text/plain", "Block1":"(szx=3/128, m=false, num=2)"}, "100499716484259312746913".. 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=1e], PUT, /test, 1:0/1/128    ----->
<-----   ACK [MID=7001, T=1e], 2.31, 1:0/1/128
CON [MID=7002, T=1e], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=7002, T=1e], 2.31, 1:1/1/128
CON [MID=7003, T=1e], PUT, /test, 1:2/0/128    ----->
<-----   ACK [MID=7003, T=1e], 2.04, 1:2/0/128


02:22:57.162:   1 FINE [DirectDatagramSocketImpl]: closing port 8,228, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.162:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:22:57.164:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8227 - (org.eclipse.californium.core.network.CoapEndpoint.java:392) destroy() in thread main
02:22:57.164:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8227 - (org.eclipse.californium.core.network.CoapEndpoint.java:379) stop() in thread main
02:22:57.164:   1 FINE [DirectDatagramSocketImpl]: closing port 8,227, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:22:57.165:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
End BlockwiseServerSideTest
02:22:57.165:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
Tests run: 15, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 1.182 sec <<< FAILURE! - in org.eclipse.californium.core.test.lockstep.BlockwiseServerSideTest
testSimpleAtomicBlockwisePUTWithLostAck(org.eclipse.californium.core.test.lockstep.BlockwiseServerSideTest)  Time elapsed: 0.255 sec  <<< FAILURE!
java.lang.AssertionError: Wrong payload length:  expected:<0> but was:<18>
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotEquals(Assert.java:834)
	at org.junit.Assert.assertEquals(Assert.java:645)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation$9.check(LockstepEndpoint.java:472)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation$9.check(LockstepEndpoint.java:467)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation.check(LockstepEndpoint.java:666)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$ResponseExpectation.check(LockstepEndpoint.java:1072)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$ResponseExpectation.go(LockstepEndpoint.java:1081)
	at org.eclipse.californium.core.test.lockstep.LockstepEndpoint$MessageExpectation.go(LockstepEndpoint.java:701)
	at org.eclipse.californium.core.test.lockstep.BlockwiseServerSideTest.testSimpleAtomicBlockwisePUTWithLostAck(BlockwiseServerSideTest.java:403)


Results :

Failed tests: 
  BlockwiseServerSideTest.testSimpleAtomicBlockwisePUTWithLostAck:403 Wrong payload length:  expected:<0> but was:<18>

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  3.008 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  2.009 s]
[INFO] element-connector .................................. SUCCESS [01:07 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 36.446 s]
[INFO] Californium (Cf) Core .............................. FAILURE [01:03 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-CoCoAClient ..................................... SKIPPED
[INFO] Cf-SecureServer .................................... SKIPPED
[INFO] Cf-ExampleCrossProxy ............................... SKIPPED
[INFO] Cf-BenchmarkServer ................................. SKIPPED
[INFO] Cf-ObserveBenchmarkClient .......................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:58 min
[INFO] Finished at: 2018-03-13T02:22:57-04:00
[INFO] Final Memory: 42M/284M
[INFO] ------------------------------------------------------------------------
[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://ci.eclipse.org/californium/job/1.1.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
Build step 'Invoke top-level Maven targets' marked build as failure
Follow-Ups:
- [cf-dev] Jenkins build is back to normal : 1.1.x-nightly #361
  - From: hudsonbuild
Prev by Date: [cf-dev] Jenkins build is back to normal : 2.0.x #416
Next by Date: [cf-dev] Jenkins build is back to normal : 1.1.x-nightly #361
Previous by thread: [cf-dev] Build failed in Jenkins: 2.0.x #415
Next by thread: [cf-dev] Jenkins build is back to normal : 1.1.x-nightly #361
Index(es):
- Date
- Thread
Breadcrumbs
