[
Date Prev][
Date Next][
Thread Prev][
Thread Next][
Date Index][
Thread Index]
[
List Home]
[cf-dev] [Hudson] Build failed in Hudson: 1.1.x-nightly #71
|
See <https://hudson.eclipse.org/californium/job/1.1.x-nightly/71/changes>
Changes:
[Achim Kraus] Re-encrypt AEAD Record when record sequence number is incremented.
[Achim Kraus] Fix retransmission of last flights.
------------------------------------------
[...truncated 2694 lines...]
02:26:49.517: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req NON-POST MID=64568, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)", "Size1":20}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:49.519: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.31 MID=36260, Token=e73c2d0633e19728, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:49.520: 309 FINE [DirectDatagramSocketImpl]: (E385,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.31 MID=36260, Token=e73c2d0633e19728, OptionSet={"Block1":"(szx=0/16, 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:26:49.521: 314 FINE [DirectDatagramSocketImpl]: (E386,T314) 127.0.0.1:8,259 ==> :8,260 [NON-POST MID=64569, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:49.522: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req NON-POST MID=64569, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:49.524: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.01 MID=36261, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:49.525: 309 FINE [DirectDatagramSocketImpl]: (E387,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.01 MID=36261, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:49.526: 314 FINE [DirectDatagramSocketImpl]: (E388,T314) 127.0.0.1:8,259 ==> :8,260 [NON-POST MID=64570, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "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]
02:26:49.527: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req NON-POST MID=64570, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:49.528: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.01 MID=36262, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:49.529: 309 FINE [DirectDatagramSocketImpl]: (E389,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.01 MID=36262, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:49.530: 314 FINE [DirectDatagramSocketImpl]: (E390,T314) 127.0.0.1:8,259 ==> :8,260 [NON-POST MID=64571, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, 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:26:49.531: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req NON-POST MID=64571, Token=e73c2d0633e19728, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:49.531: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.01 MID=36263, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:49.532: 309 FINE [DirectDatagramSocketImpl]: (E391,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.01 MID=36263, Token=e73c2d0633e19728, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
Test observe relation with a reactive cancelation to coap://127.0.0.1:8260/piggy
02:26:49.866: 314 FINE [DirectDatagramSocketImpl]: (E392,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64572, Token=5b213c5cca290e47, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:49.867: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64572, Token=5b213c5cca290e47, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#3
02:26:49.868: 318 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8259#5b213c5cca290e47 and resource /piggy - (org.eclipse.californium.core.CoapResource.java:691) addObserveRelation() in thread CoapServer#3
02:26:49.868: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64572, Token=5b213c5cca290e47, OptionSet={"Observe":1, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#3
02:26:49.870: 309 FINE [DirectDatagramSocketImpl]: (E393,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64572, Token=5b213c5cca290e47, OptionSet={"Observe":1, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:49.912: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36264, Token=5b213c5cca290e47, OptionSet={"Observe":2, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:49.914: 309 FINE [DirectDatagramSocketImpl]: (E394,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36264, Token=5b213c5cca290e47, OptionSet={"Observe":2, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.114: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36265, Token=5b213c5cca290e47, OptionSet={"Observe":3, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:50.115: 309 FINE [DirectDatagramSocketImpl]: (E395,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36265, Token=5b213c5cca290e47, OptionSet={"Observe":3, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:50.315: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36266, Token=5b213c5cca290e47, OptionSet={"Observe":4, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:50.316: 309 FINE [DirectDatagramSocketImpl]: (E396,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36266, Token=5b213c5cca290e47, OptionSet={"Observe":4, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.317: 314 FINE [DirectDatagramSocketImpl]: (E397,T314) 127.0.0.1:8,259 ==> :8,260 [RST MID=36266] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.318: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> emp RST MID=36266 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:67) receiveEmptyMessage() in thread CoapServer#2
02:26:50.376: 314 FINE [DirectDatagramSocketImpl]: (E398,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64573, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)", "Size1":20}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.377: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64573, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)", "Size1":20}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:50.377: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.31 MID=64573, Token=7be6718afd751116, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:50.378: 309 FINE [DirectDatagramSocketImpl]: (E399,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.31 MID=64573, Token=7be6718afd751116, OptionSet={"Block1":"(szx=0/16, 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:26:50.380: 314 FINE [DirectDatagramSocketImpl]: (E400,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64574, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.380: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64574, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:50.381: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64574, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:50.382: 309 FINE [DirectDatagramSocketImpl]: (E401,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64574, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.384: 314 FINE [DirectDatagramSocketImpl]: (E402,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64575, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "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]
02:26:50.385: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64575, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#3
02:26:50.385: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64575, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#3
02:26:50.387: 309 FINE [DirectDatagramSocketImpl]: (E403,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64575, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.388: 314 FINE [DirectDatagramSocketImpl]: (E404,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64576, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, 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:26:50.389: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64576, Token=7be6718afd751116, OptionSet={"Uri-Path":"piggy", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:50.390: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64576, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:50.391: 309 FINE [DirectDatagramSocketImpl]: (E405,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64576, Token=7be6718afd751116, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:50.716: 314 FINE [DirectDatagramSocketImpl]: (E406,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64577, Token=2aba22d62f42b016, OptionSet={"Uri-Path":"separate"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.717: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64577, Token=2aba22d62f42b016, OptionSet={"Uri-Path":"separate"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:50.717: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== emp ACK MID=64577 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:52) sendEmptyMessage() in thread CoapServer#1
02:26:50.718: 309 FINE [DirectDatagramSocketImpl]: (E407,T309) 127.0.0.1:8,260 ==> :8,259 [ACK MID=64577] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.718: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res CON-2.05 MID=36267, Token=2aba22d62f42b016, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:50.719: 309 FINE [DirectDatagramSocketImpl]: (E408,T309) 127.0.0.1:8,260 ==> :8,259 [CON-2.05 MID=36267, Token=2aba22d62f42b016, OptionSet={"Content-Format":"text/plain"}, "simple GET"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:50.719: 314 FINE [DirectDatagramSocketImpl]: (E409,T314) 127.0.0.1:8,259 ==> :8,260 [ACK MID=36267] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:50.720: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> emp ACK MID=36267 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:67) receiveEmptyMessage() in thread CoapServer#2
02:26:51.043: 314 FINE [DirectDatagramSocketImpl]: (E410,T314) 127.0.0.1:8,259 ==> :8,260 [NON-GET MID=64578, Token=9931c556fba0d959, OptionSet={"Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.043: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req NON-GET MID=64578, Token=9931c556fba0d959, OptionSet={"Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:51.044: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36268, Token=9931c556fba0d959, OptionSet={"Content-Format":"text/plain"}, "simple NON GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:51.045: 309 FINE [DirectDatagramSocketImpl]: (E411,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36268, Token=9931c556fba0d959, OptionSet={"Content-Format":"text/plain"}, "simple NON GET"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:51.370: 314 FINE [DirectDatagramSocketImpl]: (E412,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64579, Token=dd3f391e5f5d015c, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.370: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64579, Token=dd3f391e5f5d015c, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:51.371: 319 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8259#dd3f391e5f5d015c and resource /piggy - (org.eclipse.californium.core.CoapResource.java:691) addObserveRelation() in thread CoapServer#4
02:26:51.371: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64579, Token=dd3f391e5f5d015c, OptionSet={"Observe":9, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:51.372: 309 FINE [DirectDatagramSocketImpl]: (E413,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64579, Token=dd3f391e5f5d015c, OptionSet={"Observe":9, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.373: 314 FINE [DirectDatagramSocketImpl]: (E414,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64580, Token=846a2fcbc4b46633, OptionSet={"Uri-Path":"piggy", "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]
02:26:51.373: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64580, Token=846a2fcbc4b46633, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:51.374: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64580, Token=846a2fcbc4b46633, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:51.375: 309 FINE [DirectDatagramSocketImpl]: (E415,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64580, Token=846a2fcbc4b46633, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.376: 314 FINE [DirectDatagramSocketImpl]: (E416,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64581, Token=846a2fcbc4b46633, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, 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:26:51.376: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64581, Token=846a2fcbc4b46633, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:51.377: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64581, Token=846a2fcbc4b46633, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:51.378: 309 FINE [DirectDatagramSocketImpl]: (E417,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64581, Token=846a2fcbc4b46633, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.518: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36269, Token=dd3f391e5f5d015c, OptionSet={"Observe":10, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:51.519: 309 FINE [DirectDatagramSocketImpl]: (E418,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36269, Token=dd3f391e5f5d015c, OptionSet={"Observe":10, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.521: 314 FINE [DirectDatagramSocketImpl]: (E419,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64582, Token=9d325d39e2af5932, OptionSet={"Uri-Path":"piggy", "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]
02:26:51.521: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64582, Token=9d325d39e2af5932, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:51.522: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64582, Token=9d325d39e2af5932, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:51.523: 309 FINE [DirectDatagramSocketImpl]: (E420,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64582, Token=9d325d39e2af5932, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.524: 314 FINE [DirectDatagramSocketImpl]: (E421,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64583, Token=9d325d39e2af5932, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, 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:26:51.524: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64583, Token=9d325d39e2af5932, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:51.525: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64583, Token=9d325d39e2af5932, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:51.526: 309 FINE [DirectDatagramSocketImpl]: (E422,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64583, Token=9d325d39e2af5932, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.720: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36270, Token=dd3f391e5f5d015c, OptionSet={"Observe":11, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:51.722: 309 FINE [DirectDatagramSocketImpl]: (E423,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36270, Token=dd3f391e5f5d015c, OptionSet={"Observe":11, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.723: 314 FINE [DirectDatagramSocketImpl]: (E424,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64584, Token=bef9a55362d9f582, OptionSet={"Uri-Path":"piggy", "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]
02:26:51.724: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64584, Token=bef9a55362d9f582, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#3
02:26:51.725: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64584, Token=bef9a55362d9f582, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#3
02:26:51.726: 309 FINE [DirectDatagramSocketImpl]: (E425,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64584, Token=bef9a55362d9f582, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.727: 314 FINE [DirectDatagramSocketImpl]: (E426,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64585, Token=bef9a55362d9f582, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, 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:26:51.728: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64585, Token=bef9a55362d9f582, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:51.729: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64585, Token=bef9a55362d9f582, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:51.730: 309 FINE [DirectDatagramSocketImpl]: (E427,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64585, Token=bef9a55362d9f582, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.732: 314 FINE [DirectDatagramSocketImpl]: (E428,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64586, Token=dd3f391e5f5d015c, OptionSet={"Observe":1, "Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.732: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64586, Token=dd3f391e5f5d015c, OptionSet={"Observe":1, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:51.733: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64586, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:51.735: 309 FINE [DirectDatagramSocketImpl]: (E429,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64586, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.736: 314 FINE [DirectDatagramSocketImpl]: (E430,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64587, Token=dd3f391e5f5d015c, OptionSet={"Uri-Path":"piggy", "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]
02:26:51.737: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64587, Token=dd3f391e5f5d015c, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:51.738: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64587, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:51.739: 309 FINE [DirectDatagramSocketImpl]: (E431,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64587, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:51.741: 314 FINE [DirectDatagramSocketImpl]: (E432,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64588, Token=dd3f391e5f5d015c, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, 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:26:51.741: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64588, Token=dd3f391e5f5d015c, OptionSet={"Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#3
02:26:51.742: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64588, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#3
02:26:51.743: 309 FINE [DirectDatagramSocketImpl]: (E433,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64588, Token=dd3f391e5f5d015c, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:52.133: 314 FINE [DirectDatagramSocketImpl]: (E434,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64589, Token=3307553158a00c10, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.133: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64589, Token=3307553158a00c10, OptionSet={"Observe":0, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:52.134: 316 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8259#3307553158a00c10 and resource /piggy - (org.eclipse.californium.core.CoapResource.java:691) addObserveRelation() in thread CoapServer#1
02:26:52.134: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64589, Token=3307553158a00c10, OptionSet={"Observe":13, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:52.136: 309 FINE [DirectDatagramSocketImpl]: (E435,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64589, Token=3307553158a00c10, OptionSet={"Observe":13, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.322: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36271, Token=3307553158a00c10, OptionSet={"Observe":14, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:52.324: 309 FINE [DirectDatagramSocketImpl]: (E436,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36271, Token=3307553158a00c10, OptionSet={"Observe":14, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.524: 312 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res NON-2.05 MID=36272, Token=3307553158a00c10, OptionSet={"Observe":15, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread pool-1-thread-1
02:26:52.525: 309 FINE [DirectDatagramSocketImpl]: (E437,T309) 127.0.0.1:8,260 ==> :8,259 [NON-2.05 MID=36272, Token=3307553158a00c10, OptionSet={"Observe":15, "Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.526: 314 FINE [DirectDatagramSocketImpl]: (E438,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64590, Token=3307553158a00c10, OptionSet={"Observe":1, "Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.527: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64590, Token=3307553158a00c10, OptionSet={"Observe":1, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:52.528: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64590, Token=3307553158a00c10, OptionSet={"Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:52.529: 309 FINE [DirectDatagramSocketImpl]: (E439,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64590, Token=3307553158a00c10, OptionSet={"Content-Format":"text/plain"}, "Hello observer"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:52.854: 314 FINE [DirectDatagramSocketImpl]: (E440,T314) 127.0.0.1:8,259 ==> :8,260 [CON-GET MID=64591, Token=3120384415bbee91, OptionSet={"Uri-Path":"piggy"}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:52.855: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-GET MID=64591, Token=3120384415bbee91, OptionSet={"Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:52.855: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.05 MID=64591, Token=3120384415bbee91, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:52.857: 309 FINE [DirectDatagramSocketImpl]: (E441,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.05 MID=64591, Token=3120384415bbee91, OptionSet={"Content-Format":"text/plain"}, "simple GET"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:53.182: 314 FINE [DirectDatagramSocketImpl]: (E442,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64592, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)", "Size1":20}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:53.183: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64592, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)", "Size1":20}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#3
02:26:53.184: 318 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.31 MID=64592, Token=eb806aa3040a227f, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#3
02:26:53.185: 309 FINE [DirectDatagramSocketImpl]: (E443,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.31 MID=64592, Token=eb806aa3040a227f, OptionSet={"Block1":"(szx=0/16, 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:26:53.187: 314 FINE [DirectDatagramSocketImpl]: (E444,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64593, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:53.187: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64593, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)", "Size1":20}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#1
02:26:53.188: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== emp ACK MID=64592 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:52) sendEmptyMessage() in thread CoapServer#1
02:26:53.189: 309 FINE [DirectDatagramSocketImpl]: (E445,T309) 127.0.0.1:8,260 ==> :8,259 [ACK MID=64592] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:53.189: 316 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64593, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#1
02:26:53.191: 309 FINE [DirectDatagramSocketImpl]: (E446,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64593, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)", "Size2":40}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:53.192: 314 FINE [DirectDatagramSocketImpl]: (E447,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64594, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "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]
02:26:53.193: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64594, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#2
02:26:53.194: 317 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64594, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#2
02:26:53.195: 309 FINE [DirectDatagramSocketImpl]: (E448,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64594, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:26:53.196: 314 FINE [DirectDatagramSocketImpl]: (E449,T314) 127.0.0.1:8,259 ==> :8,260 [CON-POST MID=64595, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block2":"(szx=0/16, 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:26:53.197: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 ==> req CON-POST MID=64595, Token=eb806aa3040a227f, OptionSet={"Uri-Path":"separate", "Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:57) receiveRequest() in thread CoapServer#4
02:26:53.198: 319 INFO [MessageTracer]: localhost/127.0.0.1:8,259 <== res ACK-2.01 MID=64595, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:47) sendResponse() in thread CoapServer#4
02:26:53.199: 309 FINE [DirectDatagramSocketImpl]: (E450,T309) 127.0.0.1:8,260 ==> :8,259 [ACK-2.01 MID=64595, Token=eb806aa3040a227f, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
Wait until deduplicator should be empty (0.647 seconds)
02:26:53.522: 1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8259 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
02:26:53.522: 1 FINE [DirectDatagramSocketImpl]: closing port 8,259, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:26:53.523: 1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:26:53.525: 1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8260 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
02:26:53.525: 1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8260 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
02:26:53.525: 1 FINE [DirectDatagramSocketImpl]: closing port 8,260, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:26:53.526: 1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:26:53.526: 1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
02:26:53.527: 1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:277) applyConfig() in thread main
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.004 sec - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
Running org.eclipse.californium.core.test.RandomAccessBlockTest
Start RandomAccessBlockTest
02:26:53.532: 1 INFO [CoapServer]: Starting server - (org.eclipse.californium.core.CoapServer.java:201) start() in thread main
02:26:53.533: 1 INFO [CoapEndpoint]: Starting endpoint at localhost/127.0.0.1:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:339) start() in thread main
02:26:53.533: 1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:26:53.534: 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:26:53.534: 1 FINE [DirectDatagramSocketImpl]: assigned port 8,261 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
Request block number 2
02:26:53.537: 1 INFO [CoapEndpoint]: Starting endpoint at 0.0.0.0/0.0.0.0:0 - (org.eclipse.californium.core.network.CoapEndpoint.java:339) start() in thread main
02:26:53.538: 1 INFO [NetworkRule]: 1 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:429) isActive() in thread main
02:26:53.538: 1 FINE [DirectDatagramSocketImpl]: binding to port 0, address 0.0.0.0/0.0.0.0 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:138) bind() in thread main
02:26:53.539: 1 FINE [DirectDatagramSocketImpl]: assigned port 8,262 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:366) bind() in thread main
02:26:53.540: 1 INFO [EndpointManager]: Created implicit default endpoint 0.0.0.0/0.0.0.0:8262 - (org.eclipse.californium.core.network.EndpointManager.java:166) createDefaultEndpoint() in thread main
02:26:53.542: 337 FINE [DirectDatagramSocketImpl]: (E451,T337) 127.0.0.1:8,262 ==> :8,261 [CON-GET MID=55596, Token=a2362969368ff054, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=0/16, 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:26:53.543: 341 FINE [DirectDatagramSocketImpl]: (E452,T341) 127.0.0.1:8,261 ==> :8,262 [ACK-2.05 MID=55596, Token=a2362969368ff054, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)", "Size2":40}, "28048045"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-0.0.0.0/0.0.0.0:0[0]
Request block number 1
02:26:53.545: 337 FINE [DirectDatagramSocketImpl]: (E453,T337) 127.0.0.1:8,262 ==> :8,261 [CON-GET MID=55597, Token=0af518995742aa00, OptionSet={"Uri-Host":"localhost", "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]
02:26:53.546: 341 FINE [DirectDatagramSocketImpl]: (E454,T341) 127.0.0.1:8,261 ==> :8,262 [ACK-2.05 MID=55597, Token=0af518995742aa00, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)", "Size2":40}, "6917123037626047"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-0.0.0.0/0.0.0.0:0[0]
Request block number 3
02:26:53.548: 337 FINE [DirectDatagramSocketImpl]: (E455,T337) 127.0.0.1:8,262 ==> :8,261 [CON-GET MID=55598, Token=b1c9ed108b55c45e, OptionSet={"Uri-Host":"localhost", "Uri-Path":"test", "Block2":"(szx=0/16, 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:26:53.549: 341 FINE [DirectDatagramSocketImpl]: (E456,T341) 127.0.0.1:8,261 ==> :8,262 [ACK-2.05 MID=55598, Token=b1c9ed108b55c45e, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=3)", "Size2":40}, no payload] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-0.0.0.0/0.0.0.0:0[0]
02:26:53.549: 1 INFO [CoapServer]: Destroying server - (org.eclipse.californium.core.CoapServer.java:249) destroy() in thread main
02:26:53.550: 1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8261 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
02:26:53.550: 1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8261 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
02:26:53.551: 1 FINE [DirectDatagramSocketImpl]: closing port 8,261, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
02:26:53.551: 1 INFO [CoapServer]: CoAP server has been destroyed - (org.eclipse.californium.core.CoapServer.java:273) destroy() in thread main
02:26:53.552: 1 INFO [CoapEndpoint]: Destroying endpoint at address 0.0.0.0/0.0.0.0:8262 - (org.eclipse.californium.core.network.CoapEndpoint.java:390) destroy() in thread main
02:26:53.552: 1 INFO [CoapEndpoint]: Stopping endpoint at address 0.0.0.0/0.0.0.0:8262 - (org.eclipse.californium.core.network.CoapEndpoint.java:377) stop() in thread main
02:26:53.552: 1 FINE [DirectDatagramSocketImpl]: closing port 8,262, address 0.0.0.0/0.0.0.0 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
End RandomAccessBlockTest
02:26:53.553: 1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.024 sec - in org.eclipse.californium.core.test.RandomAccessBlockTest
Results :
Failed tests:
BlockwiseClientSideTest.testGETWithDisorderedResponses:305 did not receive message within expected time frame (2 secs)
Tests run: 63, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Californium (Cf) Parent ............................ SUCCESS [ 3.403 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [ 1.514 s]
[INFO] element-connector .................................. SUCCESS [01:07 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 30.035 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 39.843 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-06-01T02:26:53-04:00
[INFO] Final Memory: 47M/313M
[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 (medium-tests) on project californium-core: There are test failures.
Please refer to <https://hudson.eclipse.org/californium/job/1.1.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 (medium-tests) on project californium-core: There are test failures.
[ERROR]
[ERROR] Please refer to <https://hudson.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
[DEBUG] Waiting for process to finish
[DEBUG] Result: 1
Archiving artifacts
Recording test results
--
This message is automatically generated by Hudson.
For more information on Hudson, see: http://hudson-ci.org/