Skip to main content

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] [Hudson] Build failed in Hudson: master #222

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

Changes:

[Achim Kraus] Fix wrongly reported blockwise timeout.

------------------------------------------
[...truncated 3865 lines...]
ACK [MID=8004]   ----->
CON [MID=2396, T=98996f737009724d], GET, /test, 2:1/0/16    ----->

//////// Overriding notification 2 ////////
<-----   CON [MID=8005, T=3dc588668d3a39a6], 2.05, 2:0/1/16, observe(5)
ACK [MID=8005]   ----->
CON [MID=2397, T=eb8019b64352ecee], GET, /test, 2:1/0/16    ----->

//////// Conflicting notification block ////////
<-----   ACK [MID=2396, T=98996f737009724d], 2.05, 2:1/1/16
<-----   ACK [MID=2397, T=eb8019b64352ecee], 2.05, 2:1/1/16
CON [MID=2398, T=eb8019b64352ecee], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=2398, T=eb8019b64352ecee], 2.05, 2:2/0/16

07:47:43.986: 246 FINE [DirectDatagramSocketImpl]: (E183,T246) 127.0.0.1:8,225 ==> :8,224 [CON-2.05   MID= 8006, Token=3dc588668d3a39a6, OptionSet={"Observe":6, "Block2":"(szx=0/16, m=true, num=0)"}, "7439506015345639"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:43.986: 248 INFO [MessageTracer]: localhost/127.0.0.1:8,225 ==> res CON-2.05   MID= 8006, Token=3dc588668d3a39a6, OptionSet={"Observe":6, "Block2":"(szx=0/16, m=true, num=0)"}, "7439506015345639" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:62) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.987: 248 INFO [MessageTracer]: localhost/127.0.0.1:8,225 <== emp ACK        MID= 8006 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:52) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.988: 249 FINE [DirectDatagramSocketImpl]: (E184,T249) 127.0.0.1:8,224 ==> :8,225 [ACK        MID= 8006] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:43.988: 248 INFO [MessageTracer]: /127.0.0.1:8,225 <== req CON-GET    MID= 2399, Token=b10c842b86c6022a, OptionSet={"Uri-Path":"test", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:42) sendRequest() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.990: 249 FINE [DirectDatagramSocketImpl]: (E185,T249) 127.0.0.1:8,224 ==> :8,225 [CON-GET    MID= 2399, Token=b10c842b86c6022a, OptionSet={"Uri-Path":"test", "Block2":"(szx=0/16, 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]

//////// Notification after cancellation ////////
<-----   CON [MID=8006, T=3dc588668d3a39a6], 2.05, 2:0/1/16, observe(6)
ACK [MID=8006]   ----->
CON [MID=2399, T=b10c842b86c6022a], GET, /test, 2:1/0/16    ----->

07:47:43.992: 246 FINE [DirectDatagramSocketImpl]: (E186,T246) 127.0.0.1:8,225 ==> :8,224 [ACK-2.05   MID= 2399, Token=b10c842b86c6022a, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "0123416708434871"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:43.993: 246 FINE [DirectDatagramSocketImpl]: (E187,T246) 127.0.0.1:8,225 ==> :8,224 [CON-2.05   MID= 8007, Token=3dc588668d3a39a6, OptionSet={"Observe":7, "Block2":"(szx=0/16, m=true, num=0)"}, "7439506015345639"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:43.992: 248 INFO [MessageTracer]: localhost/127.0.0.1:8,225 ==> res ACK-2.05   MID= 2399, Token=b10c842b86c6022a, OptionSet={"Block2":"(szx=0/16, m=true, num=1)"}, "0123416708434871" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:62) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.994: 248 INFO [MessageTracer]: localhost/127.0.0.1:8,225 ==> res CON-2.05   MID= 8007, Token=3dc588668d3a39a6, OptionSet={"Observe":7, "Block2":"(szx=0/16, m=true, num=0)"}, "7439506015345639" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:62) receiveResponse() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.995: 248 INFO [MessageTracer]: localhost/127.0.0.1:8,225 <== emp RST        MID= 8007 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:52) sendEmptyMessage() in thread CoapEndpoint-localhost/127.0.0.1:0#1
07:47:43.995: 249 FINE [DirectDatagramSocketImpl]: (E188,T249) 127.0.0.1:8,224 ==> :8,225 [RST        MID= 8007] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
<-----   ACK [MID=2399, T=b10c842b86c6022a], 2.05, 2:1/1/16
<-----   CON [MID=8007, T=3dc588668d3a39a6], 2.05, 2:0/1/16, observe(7)
RST [MID=8007]   ----->

07:47:43.996:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8224 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
07:47:43.996:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8224 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
07:47:43.996:   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
07:47:43.997:   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
End ObserveClientSideTest
07:47:43.998:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
07:47:43.998:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:277) applyConfig() in thread main
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.182 sec - in org.eclipse.californium.core.test.lockstep.ObserveClientSideTest
Running org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest

StartLossyBlockwiseTransferTest
07:47:43.999:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:339) start() in thread main
07:47:44.000:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
07:47:44.000:   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
07:47:44.000:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,226 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
07:47:44.002:   1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
07:47:44.002:   1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:339) start() in thread main
07:47:44.002:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
07:47:44.003:   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
07:47:44.003:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,227 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
07:47:44.004:   1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
07:47:44.004:   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
07:47:44.004:   1 FINE [DirectDatagramSocketImpl]: assigned port 8,228 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Starting man in the middle...
client at localhost:8226, middle at 127.0.0.1:8228, server at localhost:8227
Man in the middle will drop packets [5, 6, 8, 9, 15]
doing a blockwise GET on: coap://localhost:8228/test
07:47:44.009: 259 FINE [DirectDatagramSocketImpl]: (E189,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59413, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.010: 256 FINE [DirectDatagramSocketImpl]: (E190,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59413, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:44.011: 259 FINE [DirectDatagramSocketImpl]: (E191,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59413, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=0)", "Size2":250}, "472589494568768636073642".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.012: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 27 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:44.013: 252 FINE [DirectDatagramSocketImpl]: (E192,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59413, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=0)", "Size2":250}, "472589494568768636073642".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:44.014: 259 FINE [DirectDatagramSocketImpl]: (E193,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59414, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.015: 256 FINE [DirectDatagramSocketImpl]: (E194,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59414, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:44.016: 259 FINE [DirectDatagramSocketImpl]: (E195,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59414, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=1)", "Size2":250}, "186657579462230016030773".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.016: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:44.018: 252 FINE [DirectDatagramSocketImpl]: (E196,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59414, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=1)", "Size2":250}, "186657579462230016030773".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:44.019: 259 FINE [DirectDatagramSocketImpl]: (E197,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.020: 256 FINE [DirectDatagramSocketImpl]: (E198,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:44.021: 259 FINE [DirectDatagramSocketImpl]: (E199,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59415, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.021: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
Dropping packet 5 (burst 1) from server
07:47:44.319: 259 FINE [DirectDatagramSocketImpl]: (E200,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 6 (burst 2) from client
07:47:44.619: 259 FINE [DirectDatagramSocketImpl]: (E201,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.620: 256 FINE [DirectDatagramSocketImpl]: (E202,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:44.621: 259 FINE [DirectDatagramSocketImpl]: (E203,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59415, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:44.621: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
Dropping packet 8 (burst 3) from server
07:47:44.919: 259 FINE [DirectDatagramSocketImpl]: (E204,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 9 (burst 4) from client
07:47:45.220: 259 FINE [DirectDatagramSocketImpl]: (E205,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.222: 256 FINE [DirectDatagramSocketImpl]: (E206,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59415, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:45.223: 259 FINE [DirectDatagramSocketImpl]: (E207,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59415, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.224: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.224: 252 FINE [DirectDatagramSocketImpl]: (E208,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59415, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.226: 259 FINE [DirectDatagramSocketImpl]: (E209,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59416, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.227: 256 FINE [DirectDatagramSocketImpl]: (E210,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59416, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:45.229: 259 FINE [DirectDatagramSocketImpl]: (E211,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59416, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=3)", "Size2":250}, "927661468463623851335159".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.230: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.231: 252 FINE [DirectDatagramSocketImpl]: (E212,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59416, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=3)", "Size2":250}, "927661468463623851335159".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.232: 259 FINE [DirectDatagramSocketImpl]: (E213,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59417, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.234: 256 FINE [DirectDatagramSocketImpl]: (E214,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59417, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.235: 259 FINE [DirectDatagramSocketImpl]: (E215,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59417, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=4)", "Size2":250}, "404389909965244435721473".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.236: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
Dropping packet 15 (burst 1) from server
07:47:45.533: 259 FINE [DirectDatagramSocketImpl]: (E216,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59417, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.534: 256 FINE [DirectDatagramSocketImpl]: (E217,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59417, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=4)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.536: 259 FINE [DirectDatagramSocketImpl]: (E218,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59417, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=4)", "Size2":250}, "404389909965244435721473".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.536: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.537: 252 FINE [DirectDatagramSocketImpl]: (E219,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59417, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=4)", "Size2":250}, "404389909965244435721473".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.539: 259 FINE [DirectDatagramSocketImpl]: (E220,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59418, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=5)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.540: 256 FINE [DirectDatagramSocketImpl]: (E221,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59418, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=5)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.542: 259 FINE [DirectDatagramSocketImpl]: (E222,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59418, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=5)", "Size2":250}, "028015383506296761336085".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.542: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.543: 252 FINE [DirectDatagramSocketImpl]: (E223,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59418, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=5)", "Size2":250}, "028015383506296761336085".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.544: 259 FINE [DirectDatagramSocketImpl]: (E224,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59419, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=6)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.545: 256 FINE [DirectDatagramSocketImpl]: (E225,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59419, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=6)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.547: 259 FINE [DirectDatagramSocketImpl]: (E226,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59419, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=6)", "Size2":250}, "631187640077970332955530".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.547: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.548: 252 FINE [DirectDatagramSocketImpl]: (E227,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59419, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=6)", "Size2":250}, "631187640077970332955530".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.549: 259 FINE [DirectDatagramSocketImpl]: (E228,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59420, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=7)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.550: 256 FINE [DirectDatagramSocketImpl]: (E229,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59420, Token=6366f7ce788c41f3, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=7)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.552: 259 FINE [DirectDatagramSocketImpl]: (E230,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59420, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=false, num=7)", "Size2":250}, "161631369830500879225997".. 26 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.552: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:45.553: 252 FINE [DirectDatagramSocketImpl]: (E231,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59420, Token=6366f7ce788c41f3, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=false, num=7)", "Size2":250}, "161631369830500879225997".. 26 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Received 250 bytes after 1548ms
Man in the middle will drop packets [0, 2, 2, 3, 4, 7, 11, 13, 14, 15]
doing a blockwise GET on: coap://localhost:8228/test
07:47:45.556: 259 FINE [DirectDatagramSocketImpl]: (E232,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 0 (burst 1) from client
07:47:45.856: 259 FINE [DirectDatagramSocketImpl]: (E233,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.857: 256 FINE [DirectDatagramSocketImpl]: (E234,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:45.862: 259 FINE [DirectDatagramSocketImpl]: (E235,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59421, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=0)", "Size2":250}, "472589494568768636073642".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:45.862: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 27 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
Dropping packet 2 (burst 2) from server
07:47:46.156: 259 FINE [DirectDatagramSocketImpl]: (E236,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 3 (burst 3) from client
07:47:46.456: 259 FINE [DirectDatagramSocketImpl]: (E237,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 4 (burst 4) from client
07:47:46.757: 259 FINE [DirectDatagramSocketImpl]: (E238,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.757: 256 FINE [DirectDatagramSocketImpl]: (E239,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59421, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:46.758: 259 FINE [DirectDatagramSocketImpl]: (E240,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59421, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=0)", "Size2":250}, "472589494568768636073642".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.759: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 27 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:46.760: 252 FINE [DirectDatagramSocketImpl]: (E241,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59421, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=0)", "Size2":250}, "472589494568768636073642".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:46.761: 259 FINE [DirectDatagramSocketImpl]: (E242,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59422, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=1)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.762: 256 FINE [DirectDatagramSocketImpl]: (E243,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59422, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:46.763: 259 FINE [DirectDatagramSocketImpl]: (E244,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59422, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=1)", "Size2":250}, "186657579462230016030773".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.764: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:46.765: 252 FINE [DirectDatagramSocketImpl]: (E245,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59422, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=1)", "Size2":250}, "186657579462230016030773".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:46.766: 259 FINE [DirectDatagramSocketImpl]: (E246,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59423, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=2)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.766: 256 FINE [DirectDatagramSocketImpl]: (E247,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59423, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:46.768: 259 FINE [DirectDatagramSocketImpl]: (E248,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59423, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:46.768: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:46.769: 252 FINE [DirectDatagramSocketImpl]: (E249,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59423, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=2)", "Size2":250}, "513399307504370126800395".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
07:47:46.770: 259 FINE [DirectDatagramSocketImpl]: (E250,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 11 (burst 1) from client
07:47:47.070: 259 FINE [DirectDatagramSocketImpl]: (E251,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:47.071: 256 FINE [DirectDatagramSocketImpl]: (E252,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:47.072: 259 FINE [DirectDatagramSocketImpl]: (E253,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59424, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=3)", "Size2":250}, "927661468463623851335159".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:47.073: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
Dropping packet 13 (burst 2) from server
07:47:47.371: 259 FINE [DirectDatagramSocketImpl]: (E254,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 14 (burst 3) from client
07:47:47.671: 259 FINE [DirectDatagramSocketImpl]: (E255,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
Dropping packet 15 (burst 4) from client
07:47:47.971: 259 FINE [DirectDatagramSocketImpl]: (E256,T259) 127.0.0.1:8,226 ==> :8,228 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, m=false, num=3)"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:47.972: 256 FINE [DirectDatagramSocketImpl]: (E257,T256) 127.0.0.1:8,228 ==> :8,227 [CON-GET    MID=59424, Token=f0b0f50535fee617, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=1/32, 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]
07:47:48.616: 259 FINE [DirectDatagramSocketImpl]: (E258,T259) 127.0.0.1:8,227 ==> :8,228 [ACK-2.05   MID=59424, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=3)", "Size2":250}, "927661468463623851335159".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread Thread-1
07:47:48.616: 259 FINE [DirectDatagramSocketImpl]: increasing receive buffer from 29 to full buffer capacity [2,000] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:215) receive() in thread Thread-1
07:47:48.617: 252 FINE [DirectDatagramSocketImpl]: (E259,T252) 127.0.0.1:8,228 ==> :8,226 [ACK-2.05   MID=59424, Token=f0b0f50535fee617, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=1/32, m=true, num=3)", "Size2":250}, "927661468463623851335159".. 32 bytes] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]

07:47:55.558:   1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
07:47:56.561:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8227 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
07:47:56.562:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8227 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
07:47:56.562:   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
07:47:56.563:   1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
07:47:56.563:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8226 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
07:47:56.563:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8226 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
07:47:56.563:   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
07:47:56.564:   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
End LossyBlockwiseTransferTest07:47:56.570:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 12.571 sec <<< FAILURE! - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
testBlockwiseTransferToleratesLostMessages(org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest)  Time elapsed: 12.571 sec  <<< FAILURE!
java.lang.AssertionError: Blockwise GET timed out after 10000ms
Expected: is not null
     but: was null
	at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
	at org.junit.Assert.assertThat(Assert.java:956)
	at org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest.getResourceAndAssertPayload(LossyBlockwiseTransferTest.java:155)
	at org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest.testBlockwiseTransferToleratesLostMessages(LossyBlockwiseTransferTest.java:144)


Results :

Failed tests: 
  LossyBlockwiseTransferTest.testBlockwiseTransferToleratesLostMessages:144->getResourceAndAssertPayload:155 Blockwise GET timed out after 10000ms
Expected: is not null
     but: was null

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  2.364 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  6.150 s]
[INFO] element-connector .................................. SUCCESS [01:13 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 17.480 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 45.302 s]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi Bundle ....................... SKIPPED
[INFO] Californium (Cf) Demo Applications ................. SKIPPED
[INFO] Sc-DTLS-Example-Server ............................. SKIPPED
[INFO] Sc-DTLS-Example-Client ............................. SKIPPED
[INFO] Cf-PlugtestClient .................................. SKIPPED
[INFO] Cf-PlugtestChecker ................................. SKIPPED
[INFO] Cf-PlugtestServer .................................. SKIPPED
[INFO] Cf-HelloWorldClient ................................ SKIPPED
[INFO] Cf-HelloWorldServer ................................ SKIPPED
[INFO] Cf-CoCoAClient ..................................... SKIPPED
[INFO] Cf-SecureServer .................................... SKIPPED
[INFO] Cf-ExampleCrossProxy ............................... SKIPPED
[INFO] Cf-BenchmarkServer ................................. SKIPPED
[INFO] Cf-ObserveBenchmarkClient .......................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:28 min
[INFO] Finished at: 2017-05-11T07:47:56-04:00
[INFO] Final Memory: 44M/1934M
[INFO] ------------------------------------------------------------------------
[INFO] o.h.m.e.h.MavenExecutionResultHandler - Build failed with exception(s)
[INFO] o.h.m.e.h.MavenExecutionResultHandler - [1] org.apache.maven.lifecycle.LifecycleExecutionException: Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (large-tests) on project californium-core: There are test failures.

Please refer to /jobs/genie.californium/master/workspace/californium-core/target/surefire-reports for the individual test results.
[DEBUG] Closing connection to remote
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (large-tests) on project californium-core: There are test failures.
[ERROR] 
[ERROR] Please refer to /jobs/genie.californium/master/workspace/californium-core/target/surefire-reports for the individual test results.
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :californium-core
[DEBUG] Waiting for process to finish
[DEBUG] Result: 1
Recording test results

--
This message is automatically generated by Hudson. 
For more information on Hudson, see: http://hudson-ci.org/


Back to the top