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

[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 #83
From: hudsonbuild@xxxxxxxxxxx
Date: Wed, 12 Jul 2017 02:09:20 -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/83/>

------------------------------------------
[...truncated 8238 lines...]
02:09:14.281: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18372, Token=2cfce0f4ab04, 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-3
02:09:14.283: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18372, Token=2cfce0f4ab04, 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-3
02:09:14.284: 159 FINE [DirectDatagramSocketImpl]: (E571,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18372, Token=2cfce0f4ab04, 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]
02:09:14.285: 163 FINE [DirectDatagramSocketImpl]: (E572,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18373, Token=2cfce0f4ab04, 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]
02:09:14.286: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18373, Token=2cfce0f4ab04, 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-1
02:09:14.287: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18373, Token=2cfce0f4ab04, 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
02:09:14.288: 159 FINE [DirectDatagramSocketImpl]: (E573,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18373, Token=2cfce0f4ab04, 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]
02:09:14.289: 163 FINE [DirectDatagramSocketImpl]: (E574,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18374, Token=2cfce0f4ab04, 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]
02:09:14.290: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18374, Token=2cfce0f4ab04, 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-2
02:09:14.291: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18374, Token=2cfce0f4ab04, 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-2
02:09:14.292: 159 FINE [DirectDatagramSocketImpl]: (E575,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18374, Token=2cfce0f4ab04, 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.447 seconds)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:14.743: 163 FINE [DirectDatagramSocketImpl]: (E576,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=18375, Token=d1b740ecac, 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]
02:09:14.744: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=18375, Token=d1b740ecac, 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-1
02:09:14.744: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== emp ACK        MID=18375 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:49) sendEmptyMessage() in thread pool-19-thread-1
02:09:14.745: 159 FINE [DirectDatagramSocketImpl]: (E577,T159) 127.0.0.1:8,232 ==> :8,231 [ACK        MID=18375] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:09:14.745: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res CON-2.05   MID=60070, Token=d1b740ecac, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
02:09:14.746: 159 FINE [DirectDatagramSocketImpl]: (E578,T159) 127.0.0.1:8,232 ==> :8,231 [CON-2.05   MID=60070, Token=d1b740ecac, 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.447 seconds)
02:09:14.747: 163 FINE [DirectDatagramSocketImpl]: (E579,T163) 127.0.0.1:8,231 ==> :8,232 [ACK        MID=60070] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:09:14.748: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> emp ACK        MID=60070 - (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 failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:15.197: 163 FINE [DirectDatagramSocketImpl]: (E580,T163) 127.0.0.1:8,231 ==> :8,232 [NON-GET    MID=18376, Token=08d536afd8e5, 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]
02:09:15.198: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req NON-GET    MID=18376, Token=08d536afd8e5, 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-2
02:09:15.199: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=60071, Token=08d536afd8e5, OptionSet={"Content-Format":"text/plain"}, "simple NON GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
02:09:15.200: 159 FINE [DirectDatagramSocketImpl]: (E581,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=60071, Token=08d536afd8e5, 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.447 seconds)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:15.651: 163 FINE [DirectDatagramSocketImpl]: (E582,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=18377, Token=6fe1b65e, 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]
02:09:15.652: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=18377, Token=6fe1b65e, 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-1
02:09:15.653: 162 INFO [CoapResource]: Successfully established observe relation between localhost/127.0.0.1:8231#6fe1b65e and resource /piggy - (org.eclipse.californium.core.CoapResource.java:688) addObserveRelation() in thread pool-19-thread-1
02:09:15.653: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=18377, Token=6fe1b65e, OptionSet={"Observe":60, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
02:09:15.654: 159 FINE [DirectDatagramSocketImpl]: (E583,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=18377, Token=6fe1b65e, OptionSet={"Observe":60, "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:09:15.683: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=60072, Token=6fe1b65e, OptionSet={"Observe":61, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
02:09:15.684: 159 FINE [DirectDatagramSocketImpl]: (E584,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=60072, Token=6fe1b65e, OptionSet={"Observe":61, "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:09:15.734: 161 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res NON-2.05   MID=60073, Token=6fe1b65e, OptionSet={"Observe":62, "Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-18-thread-1
02:09:15.735: 159 FINE [DirectDatagramSocketImpl]: (E585,T159) 127.0.0.1:8,232 ==> :8,231 [NON-2.05   MID=60073, Token=6fe1b65e, OptionSet={"Observe":62, "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:09:15.737: 163 FINE [DirectDatagramSocketImpl]: (E586,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=18378, Token=6fe1b65e, 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]
02:09:15.737: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=18378, Token=6fe1b65e, 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-1
02:09:15.738: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=18378, Token=6fe1b65e, OptionSet={"Content-Format":"text/plain"}, "Hello observer" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-1
02:09:15.739: 159 FINE [DirectDatagramSocketImpl]: (E587,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=18378, Token=6fe1b65e, 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.447 seconds)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:16.190: 163 FINE [DirectDatagramSocketImpl]: (E588,T163) 127.0.0.1:8,231 ==> :8,232 [CON-GET    MID=18379, Token=cf, 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]
02:09:16.191: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-GET    MID=18379, Token=cf, 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-2
02:09:16.191: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.05   MID=18379, Token=cf, OptionSet={"Content-Format":"text/plain"}, "simple GET" - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:44) sendResponse() in thread pool-19-thread-2
02:09:16.192: 159 FINE [DirectDatagramSocketImpl]: (E589,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.05   MID=18379, Token=cf, 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.447 seconds)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:16.643: 163 FINE [DirectDatagramSocketImpl]: (E590,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18380, Token=392b9645, 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]
02:09:16.644: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18380, Token=392b9645, 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-3
02:09:16.645: 166 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.31   MID=18380, Token=392b9645, 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
02:09:16.646: 159 FINE [DirectDatagramSocketImpl]: (E591,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.31   MID=18380, Token=392b9645, 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:09:16.648: 163 FINE [DirectDatagramSocketImpl]: (E592,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18381, Token=392b9645, 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]
02:09:16.648: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18381, Token=392b9645, 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-2
02:09:16.649: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== emp ACK        MID=18380 - (org.eclipse.californium.core.network.interceptors.MessageTracer.java:49) sendEmptyMessage() in thread pool-19-thread-2
02:09:16.650: 159 FINE [DirectDatagramSocketImpl]: (E593,T159) 127.0.0.1:8,232 ==> :8,231 [ACK        MID=18380] - (org.eclipse.californium.elements.util.DirectDatagramSocketImpl.java:208) receive() in thread UDP-Receiver-localhost/127.0.0.1:0[0]
02:09:16.650: 165 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18381, Token=392b9645, 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
02:09:16.650: 158 INFO [Matcher]: Ignoring unmatchable empty message from localhost/127.0.0.1:8232: ACK        MID=18380 - (org.eclipse.californium.core.network.Matcher.java:400) receiveEmptyMessage() in thread Thread-6
02:09:16.651: 159 FINE [DirectDatagramSocketImpl]: (E594,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18381, Token=392b9645, 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]
02:09:16.652: 163 FINE [DirectDatagramSocketImpl]: (E595,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18382, Token=392b9645, 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]
02:09:16.653: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18382, Token=392b9645, 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-4
02:09:16.654: 167 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18382, Token=392b9645, 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
02:09:16.655: 159 FINE [DirectDatagramSocketImpl]: (E596,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18382, Token=392b9645, 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]
02:09:16.656: 163 FINE [DirectDatagramSocketImpl]: (E597,T163) 127.0.0.1:8,231 ==> :8,232 [CON-POST   MID=18383, Token=392b9645, 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]
02:09:16.657: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 ==> req CON-POST   MID=18383, Token=392b9645, 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-1
02:09:16.658: 162 INFO [MessageTracer]: localhost/127.0.0.1:8231 <== res ACK-2.01   MID=18383, Token=392b9645, 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
02:09:16.659: 159 FINE [DirectDatagramSocketImpl]: (E598,T159) 127.0.0.1:8,232 ==> :8,231 [ACK-2.01   MID=18383, Token=392b9645, 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.447 seconds)
Assertion passed: all HashMaps of server are empty
Assertion failed: some HashMaps of client are NOT empty:
exchangesByMID: 0 elements
exchangesByToken: 1 elements
  0 KeyToken[49] -> org.eclipse.californium.core.network.Exchange@48ebd302 || Request:  CON-GET    MID=18355, Token=97d5, OptionSet={"Uri-Host":"localhost", "Observe":0, "Uri-Port":8232, "Uri-Path":"piggy"}, no payload || Response: NON-2.05   MID=60062, Token=97d5, OptionSet={"Observe":3, "Content-Format":"text/plain", "Block2":"(szx=0/16, m=true, num=0)"}, "123456789.123456789.1234".. 40 bytes
ongoingExchanges: 0 elements
incommingMessages: 0 elements
02:09:17.108:   1 INFO [CoapServer]: Destroy server - (org.eclipse.californium.core.CoapServer.java:220) destroy() in thread main
02:09:17.109:   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
02:09:17.109:   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
02:09:17.109:   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
02:09:17.112:   1 INFO [NetworkRule]: 0 rules active. - (org.eclipse.californium.elements.rule.NetworkRule.java:299) closeConfig() in thread main
02:09:17.112:   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: 9, Errors: 0, Skipped: 0, Time elapsed: 4.489 sec <<< FAILURE! - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
testObserveBlockwise(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.652 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testBlockwiseUsingNONMessages(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.476 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testObserveReactive(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.518 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testBlockwiseUsingPiggyBacking(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.467 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testSimpleGetUsingSeparateMessage(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.454 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testSimpleNONGet(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.454 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testObserveProactive(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.539 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testSimpleGetUsingPiggyBacking(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.453 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)

testBlockwiseUsingSeparateResponse(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 0.465 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:81)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.assertHashMapsEmpty(MemoryLeakingHashMapTest.java:117)


Results :

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

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

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  2.246 s]
[INFO] element-connector .................................. SUCCESS [ 10.043 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  2.016 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 19.522 s]
[INFO] Californium (Cf) Core .............................. FAILURE [01:13 min]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi Bundle ....................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:52 min
[INFO] Finished at: 2017-07-12T02:09:17-04:00
[INFO] Final Memory: 41M/291M
[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 #84
  - From: hudsonbuild
Prev by Date: [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x-nightly #81
Next by Date: [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x-nightly #84
Previous by thread: [cf-dev] [Hudson] Build failed in Hudson: 1.0.x-nightly #80
Next by thread: [cf-dev] [Hudson] Hudson build is back to normal : 1.0.x-nightly #84
Index(es):
- Date
- Thread
Breadcrumbs
