[cf-dev] [Hudson] Build failed in Hudson: 1.0.x-nightly #89

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] [Hudson] Build failed in Hudson: 1.0.x-nightly #89
From: hudsonbuild@xxxxxxxxxxx
Date: Wed, 19 Jul 2017 09:58:23 -0400 (EDT)
Delivered-to: cf-dev@xxxxxxxxxxx
List-archive: <https://dev.eclipse.org/mailman/private/cf-dev>
List-help: <mailto:cf-dev-request@eclipse.org?subject=help>
List-subscribe: <https://dev.eclipse.org/mailman/listinfo/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=subscribe>
List-unsubscribe: <https://dev.eclipse.org/mailman/options/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=unsubscribe>
See <https://hudson.eclipse.org/californium/job/1.0.x-nightly/89/changes>

Changes:

[hudson] Release 1.0.6

[hudson] Release 1.0.6

[Achim Kraus] Relax timing waiting for empty collections.

------------------------------------------
[...truncated 3823 lines...]
09:58:18.069: 159 FINE [DirectDatagramSocketImpl]: (E531,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38547, Token=bd09a4, OptionSet={"Observe":1, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.070: 163 FINE [DirectDatagramSocketImpl]: (E532,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39947, Token=79, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.071: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39947, Token=79, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-2
09:58:18.072: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39947, Token=79, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
09:58:18.073: 159 FINE [DirectDatagramSocketImpl]: (E533,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39947, Token=79, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.074: 163 FINE [DirectDatagramSocketImpl]: (E534,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39948, Token=79, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.075: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39948, Token=79, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-1
09:58:18.076: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39948, Token=79, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:18.077: 159 FINE [DirectDatagramSocketImpl]: (E535,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39948, Token=79, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.119: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38548, Token=bd09a4, OptionSet={"Observe":2, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:18.120: 159 FINE [DirectDatagramSocketImpl]: (E536,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38548, Token=bd09a4, OptionSet={"Observe":2, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.122: 163 FINE [DirectDatagramSocketImpl]: (E537,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39949, Token=3e3cef8b09c1, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.122: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39949, Token=3e3cef8b09c1, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-1
09:58:18.124: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39949, Token=3e3cef8b09c1, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:18.125: 159 FINE [DirectDatagramSocketImpl]: (E538,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39949, Token=3e3cef8b09c1, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.126: 163 FINE [DirectDatagramSocketImpl]: (E539,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39950, Token=3e3cef8b09c1, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.127: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39950, Token=3e3cef8b09c1, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-4
09:58:18.128: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39950, Token=3e3cef8b09c1, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:18.129: 159 FINE [DirectDatagramSocketImpl]: (E540,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39950, Token=3e3cef8b09c1, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.131: 163 FINE [DirectDatagramSocketImpl]: (E541,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39951, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Observe":1, "Uri-Port":8232, "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]
09:58:18.131: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39951, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Observe":1, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-3
09:58:18.133: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39951, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:18.134: 159 FINE [DirectDatagramSocketImpl]: (E542,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39951, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.135: 163 FINE [DirectDatagramSocketImpl]: (E543,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39952, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.136: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39952, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=1)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-2
09:58:18.137: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39952, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
09:58:18.138: 159 FINE [DirectDatagramSocketImpl]: (E544,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39952, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.139: 163 FINE [DirectDatagramSocketImpl]: (E545,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39953, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.140: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39953, Token=bd09a4, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Block2":"(szx=0/16, m=false, num=2)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-1
09:58:18.141: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39953, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:18.142: 159 FINE [DirectDatagramSocketImpl]: (E546,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39953, Token=bd09a4, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "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)
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:18.466: 163 FINE [DirectDatagramSocketImpl]: (E547,T163) 127.0.0.1:8,231 ==> :8,232 [NON-POST   MID=39954, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.467: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-POST   MID=39954, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-3
09:58:18.468: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.31   MID=38549, Token=99eac5, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:18.469: 159 FINE [DirectDatagramSocketImpl]: (E548,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.31   MID=38549, Token=99eac5, 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]
09:58:18.470: 163 FINE [DirectDatagramSocketImpl]: (E549,T163) 127.0.0.1:8,231 ==> :8,232 [NON-POST   MID=39955, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.471: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-POST   MID=39955, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-4
09:58:18.472: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:18.472: 159 FINE [DirectDatagramSocketImpl]: (E550,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.474: 163 FINE [DirectDatagramSocketImpl]: (E551,T163) 127.0.0.1:8,231 ==> :8,232 [NON-POST   MID=39956, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.474: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-POST   MID=39956, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-2
09:58:18.475: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.01   MID=38551, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
09:58:18.476: 159 FINE [DirectDatagramSocketImpl]: (E552,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.01   MID=38551, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.477: 163 FINE [DirectDatagramSocketImpl]: (E553,T163) 127.0.0.1:8,231 ==> :8,232 [NON-POST   MID=39957, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:18.478: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-POST   MID=39957, Token=99eac5, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-1
09:58:18.479: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.01   MID=38552, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:18.480: 159 FINE [DirectDatagramSocketImpl]: (E554,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.01   MID=38552, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "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)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 0 elements
ongoingExchanges: 0 elements
incommingMessages: 4 elements
  0 KeyMID[38552 for 7f000001:8232] -> org.eclipse.californium.core.network.Exchange@6be3506d || Request:  NON-POST   MID=   -1, Token=null, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain"}, "123456789.123456789." || Response: NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456789.1234".. 40 bytes
  1 KeyMID[38550 for 7f000001:8232] -> org.eclipse.californium.core.network.Exchange@6be3506d || Request:  NON-POST   MID=   -1, Token=null, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain"}, "123456789.123456789." || Response: NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456789.1234".. 40 bytes
  2 KeyMID[38549 for 7f000001:8232] -> org.eclipse.californium.core.network.Exchange@6be3506d || Request:  NON-POST   MID=   -1, Token=null, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain"}, "123456789.123456789." || Response: NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456789.1234".. 40 bytes
  3 KeyMID[38551 for 7f000001:8232] -> org.eclipse.californium.core.network.Exchange@6be3506d || Request:  NON-POST   MID=   -1, Token=null, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain"}, "123456789.123456789." || Response: NON-2.01   MID=38550, Token=99eac5, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456789.1234".. 40 bytes
Test observe relation with a reactive cancelation to coap://localhost:8232/piggy
09:58:18.748: 163 FINE [DirectDatagramSocketImpl]: (E555,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39958, Token=a8d6, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "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]
09:58:18.749: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39958, Token=a8d6, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-3
09:58:18.750: 166 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8231#a8d6 and resource /piggy - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-19-thread-3
09:58:18.751: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39958, Token=a8d6, OptionSet={"Observe":14, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:18.757: 159 FINE [DirectDatagramSocketImpl]: (E556,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39958, Token=a8d6, 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]
09:58:18.773: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38553, Token=a8d6, OptionSet={"Observe":15, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:18.774: 159 FINE [DirectDatagramSocketImpl]: (E557,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38553, Token=a8d6, 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]
09:58:18.824: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38554, Token=a8d6, OptionSet={"Observe":16, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:18.825: 159 FINE [DirectDatagramSocketImpl]: (E558,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38554, Token=a8d6, OptionSet={"Observe":16, "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)
09:58:18.875: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38555, Token=a8d6, OptionSet={"Observe":17, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:18.876: 159 FINE [DirectDatagramSocketImpl]: (E559,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38555, Token=a8d6, OptionSet={"Observe":17, "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]
09:58:18.877: 163 FINE [DirectDatagramSocketImpl]: (E560,T163) 127.0.0.1:8,231 ==> :8,232 [RST        MID=38555] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:18.877: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> emp RST        MID=38555 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:64) receiveEmptyMessage() in thread pool-19-thread-4
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:19.085: 163 FINE [DirectDatagramSocketImpl]: (E561,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39959, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.086: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39959, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-3
09:58:19.087: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.31   MID=39959, Token=2c23e8ac, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:19.088: 159 FINE [DirectDatagramSocketImpl]: (E562,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.31   MID=39959, Token=2c23e8ac, 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]
09:58:19.089: 163 FINE [DirectDatagramSocketImpl]: (E563,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39960, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.090: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39960, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-2
09:58:19.091: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39960, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
09:58:19.092: 159 FINE [DirectDatagramSocketImpl]: (E564,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39960, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.094: 163 FINE [DirectDatagramSocketImpl]: (E565,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39961, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:19.095: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39961, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-4
09:58:19.096: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39961, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:19.097: 159 FINE [DirectDatagramSocketImpl]: (E566,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39961, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.098: 163 FINE [DirectDatagramSocketImpl]: (E567,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39962, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:19.099: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39962, Token=2c23e8ac, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-1
09:58:19.100: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39962, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:19.106: 159 FINE [DirectDatagramSocketImpl]: (E568,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39962, Token=2c23e8ac, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "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)
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:19.430: 163 FINE [DirectDatagramSocketImpl]: (E569,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39963, Token=5518, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:19.431: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39963, Token=5518, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"separate"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-3
09:58:19.432: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== emp ACK        MID=39963 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:49) sendEmptyMessage() in thread pool-19-thread-3
09:58:19.432: 159 FINE [DirectDatagramSocketImpl]: (E570,T159) 127.0.0.1:8,232 ==> :8,231 [ACK        MID=39963] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.433: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res CON-2.05   MID=38556, Token=5518, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:19.434: 159 FINE [DirectDatagramSocketImpl]: (E571,T159) 127.0.0.1:8,232 ==> :8,231 [CON-2.05   MID=38556, Token=5518, 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)
09:58:19.435: 163 FINE [DirectDatagramSocketImpl]: (E572,T163) 127.0.0.1:8,231 ==> :8,232 [ACK        MID=38556] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:19.435: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> emp ACK        MID=38556 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:64) receiveEmptyMessage() in thread pool-19-thread-2
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:19.757: 163 FINE [DirectDatagramSocketImpl]: (E573,T163) 127.0.0.1:8,231 ==> :8,232 [NON-GET    MID=39964, Token=1c32ffdb6b8e, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:19.758: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-GET    MID=39964, Token=1c32ffdb6b8e, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-1
09:58:19.759: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38557, Token=1c32ffdb6b8e, OptionSet={"Content-Format":"text/plain"}, "simple NON GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:19.760: 159 FINE [DirectDatagramSocketImpl]: (E574,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38557, Token=1c32ffdb6b8e, 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)
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:20.083: 163 FINE [DirectDatagramSocketImpl]: (E575,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39965, Token=4f654a, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "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]
09:58:20.084: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39965, Token=4f654a, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-4
09:58:20.085: 167 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8231#4f654a and resource /piggy - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-19-thread-4
09:58:20.085: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39965, Token=4f654a, OptionSet={"Observe":41, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:20.086: 159 FINE [DirectDatagramSocketImpl]: (E576,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39965, Token=4f654a, OptionSet={"Observe":41, "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]
09:58:20.130: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38558, Token=4f654a, OptionSet={"Observe":42, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:20.131: 159 FINE [DirectDatagramSocketImpl]: (E577,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38558, Token=4f654a, OptionSet={"Observe":42, "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]
09:58:20.181: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=38559, Token=4f654a, OptionSet={"Observe":43, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
09:58:20.182: 159 FINE [DirectDatagramSocketImpl]: (E578,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=38559, Token=4f654a, OptionSet={"Observe":43, "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]
09:58:20.184: 163 FINE [DirectDatagramSocketImpl]: (E579,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39966, Token=4f654a, OptionSet={"Uri-Host":"localhost", "Observe":1, "Uri-Port":8232, "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]
09:58:20.184: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39966, Token=4f654a, OptionSet={"Uri-Host":"localhost", "Observe":1, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-4
09:58:20.185: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39966, Token=4f654a, OptionSet={"Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:20.186: 159 FINE [DirectDatagramSocketImpl]: (E580,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39966, Token=4f654a, 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)
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:20.574: 163 FINE [DirectDatagramSocketImpl]: (E581,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=39967, Token=1ad9, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:20.575: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=39967, Token=1ad9, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-4
09:58:20.575: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=39967, Token=1ad9, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:20.576: 159 FINE [DirectDatagramSocketImpl]: (E582,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=39967, Token=1ad9, 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)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 0 elements
ongoingExchanges: 0 elements
incommingMessages: 1 elements
  0 KeyMID[39967 for null:0] -> org.eclipse.californium.core.network.Exchange@353e58cd || Request:  CON-GET    MID=39967, Token=1ad9, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: ACK-2.05   MID=39967, Token=1ad9, OptionSet={"Content-Format":"text/plain"}, "simple GET"
09:58:20.838: 163 FINE [DirectDatagramSocketImpl]: (E583,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39968, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:20.839: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39968, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=true, num=0)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-2
09:58:20.840: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.31   MID=39968, Token=5ce2fd019a, OptionSet={"Block1":"(szx=0/16, m=true, num=0)"}, no payload - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
09:58:20.841: 159 FINE [DirectDatagramSocketImpl]: (E584,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.31   MID=39968, Token=5ce2fd019a, 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]
09:58:20.842: 163 FINE [DirectDatagramSocketImpl]: (E585,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39969, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789."] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:20.843: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39969, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "Uri-Path":"separate", "Content-Format":"text/plain", "Block1":"(szx=0/16, m=false, num=1)"}, "789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:54) receiveRequest() in thread pool-19-thread-1
09:58:20.844: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== emp ACK        MID=39968 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:49) sendEmptyMessage() in thread pool-19-thread-1
09:58:20.844: 159 FINE [DirectDatagramSocketImpl]: (E586,T159) 127.0.0.1:8,232 ==> :8,231 [ACK        MID=39968] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:20.845: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39969, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
09:58:20.845: 158 INFO [Matcher]: Ignoring unmatchable empty message from localhost/127.0.0.1:8232: ACK        MID=39968 - (org.eclipse.californium.core.network.Matcher.java:400) receiveEmptyMessage() in thread Thread-6
09:58:20.846: 159 FINE [DirectDatagramSocketImpl]: (E587,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39969, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)", "Block1":"(szx=0/16, m=false, num=1)"}, "123456789.123456"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:20.848: 163 FINE [DirectDatagramSocketImpl]: (E588,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39970, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:20.849: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39970, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-3
09:58:20.850: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39970, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-3
09:58:20.851: 159 FINE [DirectDatagramSocketImpl]: (E589,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39970, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=1)"}, "789.123456789.12"] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
09:58:20.853: 163 FINE [DirectDatagramSocketImpl]: (E590,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=39971, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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]
09:58:20.854: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=39971, Token=5ce2fd019a, OptionSet={"Uri-Host":"localhost", "Uri-Port":8232, "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:54) receiveRequest() in thread pool-19-thread-4
09:58:20.855: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=39971, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "3456789." - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-4
09:58:20.856: 159 FINE [DirectDatagramSocketImpl]: (E591,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=39971, Token=5ce2fd019a, OptionSet={"Content-Format":"text/plain", "Block2":"(szx=0/16, m=false, num=2)"}, "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)
Assertion passed: all HashMaps of server are empty
Assertion passed: all HashMaps of client are empty
09:58:21.178:   1 INFO [CoapServer]: Destroy server - (org.eclipse.californium.core.CoapServer.java:220) destroy() in thread main
09:58:21.178:   1 INFO [CoapEndpoint]: Destroying endpoint at address localhost/127.0.0.1:8232 - (org.eclipse.californium.core.network.CoapEndpoint.java:311) destroy() in thread main
09:58:21.179:   1 INFO [CoapEndpoint]: Stopping endpoint at address localhost/127.0.0.1:8232 - (org.eclipse.californium.core.network.CoapEndpoint.java:296) stop() in thread main
09:58:21.180:   1 FINE [DirectDatagramSocketImpl]: closing port 8,232, address localhost/127.0.0.1 - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:158) close() in thread main
09:58:21.182:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
09:58:21.183:   1 INFO [NetworkRule]: Test org.eclipse.californium.core.test.MemoryLeakingHashMapTest did not close all DatagramSockets! - (org.eclipse.californium.elements.rule.NetworkRule.java:374) closeNetwork() in thread main
Tests run: 9, Failures: 2, Errors: 0, Skipped: 0, Time elapsed: 3.151 sec <<< FAILURE! - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
testBlockwiseUsingNONMessages(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.285 sec  <<< FAILURE!
java.lang.AssertionError: expected:<0> but was:<4>
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotEquals(Assert.java:834)
	at org.junit.Assert.assertEquals(Assert.java:645)
	at org.junit.Assert.assertEquals(Assert.java:631)
	at org.eclipse.californium.core.test.EndpointSurveillant.assertHashMapsEmpty(EndpointSurveillant.java:88)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testSimpleGetUsingPiggyBacking(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.263 sec  <<< FAILURE!
java.lang.AssertionError: expected:<0> but was:<1>
	at org.junit.Assert.fail(Assert.java:88)
	at org.junit.Assert.failNotEquals(Assert.java:834)
	at org.junit.Assert.assertEquals(Assert.java:645)
	at org.junit.Assert.assertEquals(Assert.java:631)
	at org.eclipse.californium.core.test.EndpointSurveillant.assertHashMapsEmpty(EndpointSurveillant.java:88)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)


Results :

Failed tests: 
  MemoryLeakingHashMapTest.assertHashMapsEmpty:117 expected:<0> but was:<4>
  MemoryLeakingHashMapTest.assertHashMapsEmpty:117 expected:<0> but was:<1>

Tests run: 28, Failures: 2, Errors: 0, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  4.827 s]
[INFO] element-connector .................................. SUCCESS [  9.420 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  1.765 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 31.126 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 55.383 s]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi Bundle ....................... SKIPPED
[INFO] Californium (Cf) Demo Applications ................. SKIPPED
[INFO] Sc-DTLS-Example .................................... 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: 01:50 min
[INFO] Finished at: 2017-07-19T09:58:21-04:00
[INFO] Final Memory: 44M/308M
[INFO] ------------------------------------------------------------------------
[INFO] o.h.m.e.h.MavenExecutionResultHandler - Build failed with exception(s)
[INFO] o.h.m.e.h.MavenExecutionResultHandler - [1] org.apache.maven.lifecycle.LifecycleExecutionException: Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (large-tests) on project californium-core: There are test failures.

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

--
This message is automatically generated by Hudson. 
For more information on Hudson, see: http://hudson-ci.org/
Follow-Ups:
- [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x-nightly #90
  - From: hudsonbuild
References:
- [cf-dev] [Hudson] Build failed in Hudson: 1.0.x-nightly #88
  - From: hudsonbuild
Prev by Date: [cf-dev] [Hudson] Build failed in Hudson: 1.0.x #91
Next by Date: [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x #92
Previous by thread: [cf-dev] [Hudson] Build failed in Hudson: 1.0.x-nightly #88
Next by thread: [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x-nightly #90
Index(es):
- Date
- Thread
Breadcrumbs
