[cf-dev] Build failed in Jenkins: 2.0.x #690

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] Build failed in Jenkins: 2.0.x #690
From: hudsonbuild@xxxxxxxxxxx
Date: Wed, 13 Mar 2019 13:35:12 -0400 (EDT)
Delivered-to: cf-dev@xxxxxxxxxxx
List-archive: <https://www.eclipse.org/mailman/private/cf-dev>
List-help: <mailto:cf-dev-request@eclipse.org?subject=help>
List-subscribe: <https://www.eclipse.org/mailman/listinfo/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=subscribe>
List-unsubscribe: <https://www.eclipse.org/mailman/options/cf-dev>, <mailto:cf-dev-request@eclipse.org?subject=unsubscribe>
See <https://ci.eclipse.org/californium/job/2.0.x/690/display/redirect?page=changes>

Changes:

[Achim Kraus] Fix javadoc.

------------------------------------------
[...truncated 413.48 KB...]
Wait until deduplicator should be empty (2.97 seconds)
Wait until deduplicator should be empty (2.97 seconds)


Client binds to port 8269
Proactive cancel
Wait until deduplicator should be empty (2.97 seconds)
Wait until deduplicator should be empty (2.97 seconds)

0003: CON [MID=10018, T=C9CE20F24B6D9602], GET, /test, observe(0)    ----->
0004: <-----   ACK [MID=10018, T=C9CE20F24B6D9602], 2.05, observe(1)
0005: <-----   CON [MID=8001, T=C9CE20F24B6D9602], 2.05, observe(3)
0005: ACK [MID=8001]   ----->
0006: CON [MID=10019, T=C9CE20F24B6D9602], GET, /test, observe(1)    ----->
0006: <-----   ACK [MID=10019, T=C9CE20F24B6D9602], 2.05
0007: <-----   CON [MID=8002, T=C9CE20F24B6D9602], 2.05, observe(4)
0007: RST [MID=8002]   ----->
0007: <-----   NON [MID=8003, T=C9CE20F24B6D9602], 2.05, observe(5)
0007: RST [MID=8003]   ----->

End ObserveClientSideTest
[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.965 s - in org.eclipse.californium.core.test.lockstep.ObserveClientSideTest
[INFO] Running org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest

StartLossyBlockwiseTransferTest
Starting man in the middle...
client at localhost:8271, middle at 127.0.0.1:8273, server at localhost:8272


doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 2761 ms
Man in the middle will drop packets [5, 6, 8, 9, 15]
0011: CON [MID=62650, T=A22A1506E37FA19D], GET, /test    ----->
0013: <-----   ACK [MID=62650, T=A22A1506E37FA19D], 2.05, 2:0/1/32, size2(250)
0013: CON [MID=62651, T=A22A1506E37FA19D], GET, /test, 2:1/0/32    ----->
0015: <-----   ACK [MID=62651, T=A22A1506E37FA19D], 2.05, 2:1/1/32
0015: CON [MID=62652, T=A22A1506E37FA19D], GET, /test, 2:2/0/32    -----> Dropping packet 5 (burst 1/4) from server
0316: CON [MID=62652, T=A22A1506E37FA19D], GET, /test, 2:2/0/32    -----> Dropping packet 6 (burst 2/4) from client
0767: CON [MID=62652, T=A22A1506E37FA19D], GET, /test, 2:2/0/32    -----> Dropping packet 8 (burst 3/4) from server
1443: CON [MID=62652, T=A22A1506E37FA19D], GET, /test, 2:2/0/32    -----> Dropping packet 9 (burst 4/4) from client
2456: CON [MID=62652, T=A22A1506E37FA19D], GET, /test, 2:2/0/32    ----->
2458: <-----   ACK [MID=62652, T=A22A1506E37FA19D], 2.05, 2:2/1/32
2458: CON [MID=62653, T=A22A1506E37FA19D], GET, /test, 2:3/0/32    ----->
2460: <-----   ACK [MID=62653, T=A22A1506E37FA19D], 2.05, 2:3/1/32
2460: CON [MID=62654, T=A22A1506E37FA19D], GET, /test, 2:4/0/32    -----> Dropping packet 15 (burst 1/4) from server
2761: CON [MID=62654, T=A22A1506E37FA19D], GET, /test, 2:4/0/32    ----->
2763: <-----   ACK [MID=62654, T=A22A1506E37FA19D], 2.05, 2:4/1/32
2763: CON [MID=62655, T=A22A1506E37FA19D], GET, /test, 2:5/0/32    ----->
2765: <-----   ACK [MID=62655, T=A22A1506E37FA19D], 2.05, 2:5/1/32
2765: CON [MID=62656, T=A22A1506E37FA19D], GET, /test, 2:6/0/32    ----->
2767: <-----   ACK [MID=62656, T=A22A1506E37FA19D], 2.05, 2:6/1/32
2767: CON [MID=62657, T=A22A1506E37FA19D], GET, /test, 2:7/0/32    ----->
2768: <-----   ACK [MID=62657, T=A22A1506E37FA19D], 2.05, 2:7/0/32

doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 2343 ms
Man in the middle will drop packets [0, 0, 0, 3, 6, 6, 6, 7, 9, 14]
2770: CON [MID=62658, T=1C860560E146BD6D], GET, /test    -----> Dropping packet 0 (burst 1/4) from client
3071: CON [MID=62658, T=1C860560E146BD6D], GET, /test    ----->
3073: <-----   ACK [MID=62658, T=1C860560E146BD6D], 2.05, 2:0/1/32, size2(250)
3073: CON [MID=62659, T=1C860560E146BD6D], GET, /test, 2:1/0/32    -----> Dropping packet 3 (burst 1/4) from client
3374: CON [MID=62659, T=1C860560E146BD6D], GET, /test, 2:1/0/32    ----->
3375: <-----   ACK [MID=62659, T=1C860560E146BD6D], 2.05, 2:1/1/32
3375: CON [MID=62660, T=1C860560E146BD6D], GET, /test, 2:2/0/32    -----> Dropping packet 6 (burst 1/4) from client
3676: CON [MID=62660, T=1C860560E146BD6D], GET, /test, 2:2/0/32    -----> Dropping packet 7 (burst 2/4) from client
4127: CON [MID=62660, T=1C860560E146BD6D], GET, /test, 2:2/0/32    -----> Dropping packet 9 (burst 3/4) from server
4802: CON [MID=62660, T=1C860560E146BD6D], GET, /test, 2:2/0/32    ----->
4803: <-----   ACK [MID=62660, T=1C860560E146BD6D], 2.05, 2:2/1/32
4804: CON [MID=62661, T=1C860560E146BD6D], GET, /test, 2:3/0/32    ----->
4805: <-----   ACK [MID=62661, T=1C860560E146BD6D], 2.05, 2:3/1/32
4805: CON [MID=62662, T=1C860560E146BD6D], GET, /test, 2:4/0/32    -----> Dropping packet 14 (burst 1/4) from client
5106: CON [MID=62662, T=1C860560E146BD6D], GET, /test, 2:4/0/32    ----->
5107: <-----   ACK [MID=62662, T=1C860560E146BD6D], 2.05, 2:4/1/32
5108: CON [MID=62663, T=1C860560E146BD6D], GET, /test, 2:5/0/32    ----->
5109: <-----   ACK [MID=62663, T=1C860560E146BD6D], 2.05, 2:5/1/32
5109: CON [MID=62664, T=1C860560E146BD6D], GET, /test, 2:6/0/32    ----->
5111: <-----   ACK [MID=62664, T=1C860560E146BD6D], 2.05, 2:6/1/32
5111: CON [MID=62665, T=1C860560E146BD6D], GET, /test, 2:7/0/32    ----->
5113: <-----   ACK [MID=62665, T=1C860560E146BD6D], 2.05, 2:7/0/32

doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 3955 ms
Man in the middle will drop packets [0, 0, 1, 2, 3, 5, 7, 8, 13, 15]
5114: CON [MID=62666, T=64499EB11B5ACBFB], GET, /test    -----> Dropping packet 0 (burst 1/4) from client
5415: CON [MID=62666, T=64499EB11B5ACBFB], GET, /test    -----> Dropping packet 1 (burst 2/4) from client
5866: CON [MID=62666, T=64499EB11B5ACBFB], GET, /test    -----> Dropping packet 2 (burst 3/4) from client
6541: CON [MID=62666, T=64499EB11B5ACBFB], GET, /test    -----> Dropping packet 3 (burst 4/4) from client
7554: CON [MID=62666, T=64499EB11B5ACBFB], GET, /test    ----->
7555: <-----   ACK [MID=62666, T=64499EB11B5ACBFB], 2.05, 2:0/1/32, size2(250)
7556: CON [MID=62667, T=64499EB11B5ACBFB], GET, /test, 2:1/0/32    -----> Dropping packet 7 (burst 1/4) from server
7856: CON [MID=62667, T=64499EB11B5ACBFB], GET, /test, 2:1/0/32    -----> Dropping packet 8 (burst 2/4) from client
8307: CON [MID=62667, T=64499EB11B5ACBFB], GET, /test, 2:1/0/32    ----->
8308: <-----   ACK [MID=62667, T=64499EB11B5ACBFB], 2.05, 2:1/1/32
8309: CON [MID=62668, T=64499EB11B5ACBFB], GET, /test, 2:2/0/32    ----->
8310: <-----   ACK [MID=62668, T=64499EB11B5ACBFB], 2.05, 2:2/1/32
8310: CON [MID=62669, T=64499EB11B5ACBFB], GET, /test, 2:3/0/32    -----> Dropping packet 13 (burst 1/4) from client
8611: CON [MID=62669, T=64499EB11B5ACBFB], GET, /test, 2:3/0/32    -----> Dropping packet 15 (burst 2/4) from server
9062: CON [MID=62669, T=64499EB11B5ACBFB], GET, /test, 2:3/0/32    ----->
9063: <-----   ACK [MID=62669, T=64499EB11B5ACBFB], 2.05, 2:3/1/32
9063: CON [MID=62670, T=64499EB11B5ACBFB], GET, /test, 2:4/0/32    ----->
9064: <-----   ACK [MID=62670, T=64499EB11B5ACBFB], 2.05, 2:4/1/32
9065: CON [MID=62671, T=64499EB11B5ACBFB], GET, /test, 2:5/0/32    ----->
9066: <-----   ACK [MID=62671, T=64499EB11B5ACBFB], 2.05, 2:5/1/32
9066: CON [MID=62672, T=64499EB11B5ACBFB], GET, /test, 2:6/0/32    ----->
9067: <-----   ACK [MID=62672, T=64499EB11B5ACBFB], 2.05, 2:6/1/32
9068: CON [MID=62673, T=64499EB11B5ACBFB], GET, /test, 2:7/0/32    ----->
9069: <-----   ACK [MID=62673, T=64499EB11B5ACBFB], 2.05, 2:7/0/32

doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 3506 ms
Man in the middle will drop packets [0, 2, 2, 5, 5, 9, 11, 13, 14, 15]
9070: CON [MID=62674, T=B05099924E6AE088], GET, /test    -----> Dropping packet 0 (burst 1/4) from client
9371: CON [MID=62674, T=B05099924E6AE088], GET, /test    -----> Dropping packet 2 (burst 2/4) from server
9822: CON [MID=62674, T=B05099924E6AE088], GET, /test    ----->
9823: <-----   ACK [MID=62674, T=B05099924E6AE088], 2.05, 2:0/1/32, size2(250)
9823: CON [MID=62675, T=B05099924E6AE088], GET, /test, 2:1/0/32    -----> Dropping packet 5 (burst 2/4) from client
10124: CON [MID=62675, T=B05099924E6AE088], GET, /test, 2:1/0/32    ----->
10125: <-----   ACK [MID=62675, T=B05099924E6AE088], 2.05, 2:1/1/32
10126: CON [MID=62676, T=B05099924E6AE088], GET, /test, 2:2/0/32    -----> Dropping packet 9 (burst 1/4) from server
10426: CON [MID=62676, T=B05099924E6AE088], GET, /test, 2:2/0/32    -----> Dropping packet 11 (burst 2/4) from server
10877: CON [MID=62676, T=B05099924E6AE088], GET, /test, 2:2/0/32    -----> Dropping packet 13 (burst 3/4) from server
11553: CON [MID=62676, T=B05099924E6AE088], GET, /test, 2:2/0/32    -----> Dropping packet 14 (burst 4/4) from client
12565: CON [MID=62676, T=B05099924E6AE088], GET, /test, 2:2/0/32    ----->
12566: <-----   ACK [MID=62676, T=B05099924E6AE088], 2.05, 2:2/1/32
12567: CON [MID=62677, T=B05099924E6AE088], GET, /test, 2:3/0/32    ----->
12568: <-----   ACK [MID=62677, T=B05099924E6AE088], 2.05, 2:3/1/32
12569: CON [MID=62678, T=B05099924E6AE088], GET, /test, 2:4/0/32    ----->
12570: <-----   ACK [MID=62678, T=B05099924E6AE088], 2.05, 2:4/1/32
12571: CON [MID=62679, T=B05099924E6AE088], GET, /test, 2:5/0/32    ----->
12572: <-----   ACK [MID=62679, T=B05099924E6AE088], 2.05, 2:5/1/32
12573: CON [MID=62680, T=B05099924E6AE088], GET, /test, 2:6/0/32    ----->
12574: <-----   ACK [MID=62680, T=B05099924E6AE088], 2.05, 2:6/1/32
12574: CON [MID=62681, T=B05099924E6AE088], GET, /test, 2:7/0/32    ----->
12576: <-----   ACK [MID=62681, T=B05099924E6AE088], 2.05, 2:7/0/32

doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 2792 ms
Man in the middle will drop packets [0, 3, 4, 4, 4, 7, 9, 11, 12, 15]
12577: CON [MID=62682, T=6ED659958C40FB20], GET, /test    -----> Dropping packet 0 (burst 1/4) from client
12878: CON [MID=62682, T=6ED659958C40FB20], GET, /test    ----->
12879: <-----   ACK [MID=62682, T=6ED659958C40FB20], 2.05, 2:0/1/32, size2(250)
12880: CON [MID=62683, T=6ED659958C40FB20], GET, /test, 2:1/0/32    -----> Dropping packet 3 (burst 1/4) from client
13180: CON [MID=62683, T=6ED659958C40FB20], GET, /test, 2:1/0/32    -----> Dropping packet 4 (burst 2/4) from client
13631: CON [MID=62683, T=6ED659958C40FB20], GET, /test, 2:1/0/32    ----->
13632: <-----   ACK [MID=62683, T=6ED659958C40FB20], 2.05, 2:1/1/32
13633: CON [MID=62684, T=6ED659958C40FB20], GET, /test, 2:2/0/32    -----> Dropping packet 7 (burst 2/4) from client
13933: CON [MID=62684, T=6ED659958C40FB20], GET, /test, 2:2/0/32    -----> Dropping packet 9 (burst 3/4) from server
14384: CON [MID=62684, T=6ED659958C40FB20], GET, /test, 2:2/0/32    -----> Dropping packet 11 (burst 4/4) from server
15060: CON [MID=62684, T=6ED659958C40FB20], GET, /test, 2:2/0/32    ----->
15061: <-----   ACK [MID=62684, T=6ED659958C40FB20], 2.05, 2:2/1/32
15061: CON [MID=62685, T=6ED659958C40FB20], GET, /test, 2:3/0/32    -----> Dropping packet 15 (burst 1/4) from server
15362: CON [MID=62685, T=6ED659958C40FB20], GET, /test, 2:3/0/32    ----->
15363: <-----   ACK [MID=62685, T=6ED659958C40FB20], 2.05, 2:3/1/32
15363: CON [MID=62686, T=6ED659958C40FB20], GET, /test, 2:4/0/32    ----->
15364: <-----   ACK [MID=62686, T=6ED659958C40FB20], 2.05, 2:4/1/32
15365: CON [MID=62687, T=6ED659958C40FB20], GET, /test, 2:5/0/32    ----->
15366: <-----   ACK [MID=62687, T=6ED659958C40FB20], 2.05, 2:5/1/32
15366: CON [MID=62688, T=6ED659958C40FB20], GET, /test, 2:6/0/32    ----->
15367: <-----   ACK [MID=62688, T=6ED659958C40FB20], 2.05, 2:6/1/32
15367: CON [MID=62689, T=6ED659958C40FB20], GET, /test, 2:7/0/32    ----->
15368: <-----   ACK [MID=62689, T=6ED659958C40FB20], 2.05, 2:7/0/32

doing a blockwise GET on: coap://localhost:8273/test
Received 250 bytes after 2118 ms

End LossyBlockwiseTransferTestMan in the middle will drop packets [1, 1, 2, 5, 5, 9, 10, 10, 15, 15]
15370: CON [MID=62690, T=0EA1460E92491CB9], GET, /test    -----> Dropping packet 1 (burst 1/4) from server
15671: CON [MID=62690, T=0EA1460E92491CB9], GET, /test    -----> Dropping packet 2 (burst 2/4) from client
16122: CON [MID=62690, T=0EA1460E92491CB9], GET, /test    ----->
16123: <-----   ACK [MID=62690, T=0EA1460E92491CB9], 2.05, 2:0/1/32, size2(250)
16123: CON [MID=62691, T=0EA1460E92491CB9], GET, /test, 2:1/0/32    -----> Dropping packet 5 (burst 2/4) from client
16424: CON [MID=62691, T=0EA1460E92491CB9], GET, /test, 2:1/0/32    ----->
16425: <-----   ACK [MID=62691, T=0EA1460E92491CB9], 2.05, 2:1/1/32
16426: CON [MID=62692, T=0EA1460E92491CB9], GET, /test, 2:2/0/32    -----> Dropping packet 9 (burst 1/4) from server
16726: CON [MID=62692, T=0EA1460E92491CB9], GET, /test, 2:2/0/32    -----> Dropping packet 10 (burst 2/4) from client
17177: CON [MID=62692, T=0EA1460E92491CB9], GET, /test, 2:2/0/32    ----->
17178: <-----   ACK [MID=62692, T=0EA1460E92491CB9], 2.05, 2:2/1/32
17179: CON [MID=62693, T=0EA1460E92491CB9], GET, /test, 2:3/0/32    ----->
17180: <-----   ACK [MID=62693, T=0EA1460E92491CB9], 2.05, 2:3/1/32
17180: CON [MID=62694, T=0EA1460E92491CB9], GET, /test, 2:4/0/32    -----> Dropping packet 15 (burst 1/4) from client
17481: CON [MID=62694, T=0EA1460E92491CB9], GET, /test, 2:4/0/32    ----->
17482: <-----   ACK [MID=62694, T=0EA1460E92491CB9], 2.05, 2:4/1/32
17482: CON [MID=62695, T=0EA1460E92491CB9], GET, /test, 2:5/0/32    ----->
17483: <-----   ACK [MID=62695, T=0EA1460E92491CB9], 2.05, 2:5/1/32
17484: CON [MID=62696, T=0EA1460E92491CB9], GET, /test, 2:6/0/32    ----->
17485: <-----   ACK [MID=62696, T=0EA1460E92491CB9], 2.05, 2:6/1/32
17485: CON [MID=62697, T=0EA1460E92491CB9], GET, /test, 2:7/0/32    ----->
17486: <-----   ACK [MID=62697, T=0EA1460E92491CB9], 2.05, 2:7/0/32
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.698 s - in org.eclipse.californium.core.test.maninmiddle.LossyBlockwiseTransferTest
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Failures: 
[ERROR]   BlockwiseServerSideTest.testIncompleteGET:354
[INFO] 
[ERROR] Tests run: 39, Failures: 1, Errors: 0, Skipped: 0
[INFO] 
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent 2.0.0-SNAPSHOT ............. SUCCESS [  2.769 s]
[INFO] Legal Documents .................................... SUCCESS [  3.686 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  0.128 s]
[INFO] element-connector .................................. SUCCESS [ 42.634 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:31 min]
[INFO] element-connector-tcp .............................. SUCCESS [ 38.574 s]
[INFO] Californium (Cf) Core .............................. FAILURE [01:50 min]
[INFO] Californium (Cf) Demo Applications ................. SKIPPED
[INFO] Cf-NAT ............................................. SKIPPED
[INFO] Californium (Cf) Integration Tests ................. SKIPPED
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi .............................. 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-ExtendedPlugtestClient .......................... SKIPPED
[INFO] Cf-ExtendedPlugtestServer .......................... SKIPPED
[INFO] Cf-HelloWorldClient ................................ SKIPPED
[INFO] Cf-HelloWorldServer ................................ SKIPPED
[INFO] Cf-SimpleFileServer ................................ SKIPPED
[INFO] Cf-CoCoAClient ..................................... SKIPPED
[INFO] Cf-SecureServer .................................... SKIPPED
[INFO] Cf-ExampleCrossProxy ............................... SKIPPED
[INFO] Cf-BenchmarkServer ................................. SKIPPED
[INFO] Cf-ObserveBenchmarkClient .......................... SKIPPED
[INFO] Cf-OSCORE 2.0.0-SNAPSHOT ........................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 04:53 min
[INFO] Finished at: 2019-03-13T13:35:12-04:00
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.22.1:test (large-tests) on project californium-core: There are test failures.
[ERROR] 
[ERROR] Please refer to /jobs/genie.californium/2.0.x/workspace/californium-core/target/surefire-reports for the individual test results.
[ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :californium-core
Build step 'Invoke top-level Maven targets' marked build as failure
Follow-Ups:
- [cf-dev] Build failed in Jenkins: 2.0.x #691
  - From: hudsonbuild
Prev by Date: [cf-dev] Jenkins build is back to normal : 2.0.x #685
Next by Date: [cf-dev] Build failed in Jenkins: 2.0.x #691
Previous by thread: [cf-dev] Build failed in Jenkins: 2.0.x #683
Next by thread: [cf-dev] Build failed in Jenkins: 2.0.x #691
Index(es):
- Date
- Thread
Breadcrumbs
