[
Date Prev][
Date Next][
Thread Prev][
Thread Next][
Date Index][
Thread Index]
[
List Home]
[cf-dev] Build failed in Jenkins: 2.0.x #707
|
See <https://ci.eclipse.org/californium/job/2.0.x/707/display/redirect?page=changes>
Changes:
[Achim Kraus] Fix rare test-race condition.
------------------------------------------
[...truncated 336.77 KB...]
4304: <----- ACK [MID=18056, T=B46A0565DEF34915], 2.05, 2:0/1/32, size2(152)
4305: CON [MID=18057, T=B46A0565DEF34915], GET, /test, 2:1/0/32 ----->
4305: <----- ACK [MID=18057, T=B46A0565DEF34915], 2.05, 2:1/1/32
4307: CON [MID=18058, T=B46A0565DEF34915], GET, /test, 2:2/0/32 ----->
4307: <----- ACK [MID=18058, T=B46A0565DEF34915], 2.05, 2:2/1/32
4308: CON [MID=18059, T=B46A0565DEF34915], GET, /test, 2:3/0/32 ----->
4308: <----- ACK [MID=18059, T=B46A0565DEF34915], 2.05, 2:3/1/32
4309: CON [MID=18060, T=B46A0565DEF34915], GET, /test, 2:4/0/32 ----->
4310: <----- ACK [MID=18060, T=B46A0565DEF34915], 2.05, 2:4/0/32
Server received GET request
Client received payload [81670246200157991671860046039108413725646455811507582080094875159995869955136699327279497751158304188586016539144118009545245099742293553181373971845009]
4412: CON [MID=18061, T=927328B14034A6FC], GET, /test ----->
4412: <----- ACK [MID=18061, T=927328B14034A6FC], 2.05, 2:0/1/32, size2(152)
4413: CON [MID=18062, T=927328B14034A6FC], GET, /test, 2:1/0/32 ----->
4413: <----- ACK [MID=18062, T=927328B14034A6FC], 2.05, 2:1/1/32
4415: CON [MID=18063, T=927328B14034A6FC], GET, /test, 2:2/0/32 ----->
4415: <----- ACK [MID=18063, T=927328B14034A6FC], 2.05, 2:2/1/32
4416: CON [MID=18064, T=927328B14034A6FC], GET, /test, 2:3/0/32 ----->
4416: <----- ACK [MID=18064, T=927328B14034A6FC], 2.05, 2:3/1/32
4417: CON [MID=18065, T=927328B14034A6FC], GET, /test, 2:4/0/32 ----->
4418: <----- ACK [MID=18065, T=927328B14034A6FC], 2.05, 2:4/0/32
-- POST long short --
Server received 471703485238477993563657931880881755108182382448612989526952245673800145136808595200269241834148937267509901613137852871905444931081382484806754362137
Client received payload [6434427055006388]
4523: CON [MID=22858, T=660E93C48D70E354], POST, /test, 1:0/1/32, size1(150) ----->
4523: <----- ACK [MID=22858, T=660E93C48D70E354], 2.31, 1:0/1/32
4525: CON [MID=22859, T=660E93C48D70E354], POST, /test, 1:1/1/32 ----->
4525: <----- ACK [MID=22859, T=660E93C48D70E354], 2.31, 1:1/1/32
4526: CON [MID=22860, T=660E93C48D70E354], POST, /test, 1:2/1/32 ----->
4527: <----- ACK [MID=22860, T=660E93C48D70E354], 2.31, 1:2/1/32
4528: CON [MID=22861, T=660E93C48D70E354], POST, /test, 1:3/1/32 ----->
4528: <----- ACK [MID=22861, T=660E93C48D70E354], 2.31, 1:3/1/32
4529: CON [MID=22862, T=660E93C48D70E354], POST, /test, 1:4/0/32 ----->
4530: <----- ACK [MID=22862, T=660E93C48D70E354], 2.05, 1:4/0/32
End BlockwiseTransferTest
[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.257 s - in org.eclipse.californium.core.test.BlockwiseTransferTest
[INFO] Running org.eclipse.californium.core.test.MemoryLeakingHashMapTest
Wait until deduplicator should be empty (0.647 seconds)
0006: NON [MID=26356, T=A49863DCF589B086], POST, /test, 1:0/1/16, size1(20) ----->
0008: <----- NON [MID=47416, T=A49863DCF589B086], 2.31, 1:0/1/16
0008: NON [MID=26357, T=A49863DCF589B086], POST, /test, 1:1/0/16 ----->
0010: <----- NON [MID=47417, T=A49863DCF589B086], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
0011: NON [MID=26358, T=A49863DCF589B086], POST, /test, 2:1/0/16 ----->
0012: <----- NON [MID=47418, T=A49863DCF589B086], 2.01, 2:1/1/16
0013: NON [MID=26359, T=A49863DCF589B086], POST, /test, 2:2/0/16 ----->
0014: <----- NON [MID=47419, T=A49863DCF589B086], 2.01, 2:2/0/16
Test observe relation with a reactive cancelation to coap://127.0.0.1:8320/test
Wait until deduplicator should be empty (0.647 seconds)
0147: CON [MID=26360, T=D7C1302CFA16304F], GET, /test, observe(0) ----->
0154: <----- ACK [MID=26360, T=D7C1302CFA16304F], 2.05, observe(0)
0347: <----- NON [MID=47420, T=D7C1302CFA16304F], 2.05, observe(1)
0547: <----- NON [MID=47421, T=D7C1302CFA16304F], 2.05, observe(2)
0748: <----- NON [MID=47422, T=D7C1302CFA16304F], 2.05, observe(3)
0748: RST [MID=47422] ----->
Wait until deduplicator should be empty (0.647 seconds)
0806: CON [MID=26361, T=B8A618A3E32977CD], POST, /test, 1:0/1/16, size1(20) ----->
0808: <----- ACK [MID=26361, T=B8A618A3E32977CD], 2.31, 1:0/1/16
0808: CON [MID=26362, T=B8A618A3E32977CD], POST, /test, 1:1/0/16 ----->
0810: <----- ACK [MID=26362, T=B8A618A3E32977CD], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
0810: CON [MID=26363, T=B8A618A3E32977CD], POST, /test, 2:1/0/16 ----->
0812: <----- ACK [MID=26363, T=B8A618A3E32977CD], 2.01, 2:1/1/16
0812: CON [MID=26364, T=B8A618A3E32977CD], POST, /test, 2:2/0/16 ----->
0813: <----- ACK [MID=26364, T=B8A618A3E32977CD], 2.01, 2:2/0/16
Wait until deduplicator should be empty (0.647 seconds)
0943: CON [MID=26365, T=64E215C8B4619C57], GET, /test ----->
0944: <----- ACK [MID=26365]
0945: <----- CON [MID=47423, T=64E215C8B4619C57], 2.05
0945: ACK [MID=47423] ----->
Wait until deduplicator should be empty (0.647 seconds)
1075: NON [MID=26366, T=4667303937C70E3C], GET, /test ----->
1076: <----- NON [MID=47424, T=4667303937C70E3C], 2.05
Wait until deduplicator should be empty (0.647 seconds)
1206: CON [MID=26367, T=8F8FFE25DEBC96C1], GET, /test, observe(0) ----->
1208: <----- ACK [MID=26367, T=8F8FFE25DEBC96C1], 2.05, 2:0/1/16, observe(3), size2(40)
1208: CON [MID=26368, T=2CAF1FCF85350B8A], GET, /test, 2:1/0/16 ----->
1209: <----- ACK [MID=26368, T=2CAF1FCF85350B8A], 2.05, 2:1/1/16
1209: CON [MID=26369, T=2CAF1FCF85350B8A], GET, /test, 2:2/0/16 ----->
1210: <----- ACK [MID=26369, T=2CAF1FCF85350B8A], 2.05, 2:2/0/16
1806: <----- NON [MID=47425, T=8F8FFE25DEBC96C1], 2.05, 2:0/1/16, observe(4), size2(40)
1807: CON [MID=26370, T=B0ECD9DB01ECCD7E], GET, /test, 2:1/0/16 ----->
1808: <----- ACK [MID=26370, T=B0ECD9DB01ECCD7E], 2.05, 2:1/1/16
1808: CON [MID=26371, T=B0ECD9DB01ECCD7E], GET, /test, 2:2/0/16 ----->
1810: <----- ACK [MID=26371, T=B0ECD9DB01ECCD7E], 2.05, 2:2/0/16
2407: <----- NON [MID=47426, T=8F8FFE25DEBC96C1], 2.05, 2:0/1/16, observe(5), size2(40)
2407: CON [MID=26372, T=543CEE44DB7435AD], GET, /test, 2:1/0/16 ----->
2408: <----- ACK [MID=26372, T=543CEE44DB7435AD], 2.05, 2:1/1/16
2409: CON [MID=26373, T=543CEE44DB7435AD], GET, /test, 2:2/0/16 ----->
2410: <----- ACK [MID=26373, T=543CEE44DB7435AD], 2.05, 2:2/0/16
2411: CON [MID=26374, T=8F8FFE25DEBC96C1], GET, /test, observe(1) ----->
2412: <----- ACK [MID=26374, T=8F8FFE25DEBC96C1], 2.05, 2:0/1/16, size2(40)
2412: CON [MID=26375, T=8F8FFE25DEBC96C1], GET, /test, 2:1/0/16 ----->
2415: <----- ACK [MID=26375, T=8F8FFE25DEBC96C1], 2.05, 2:1/1/16
2415: CON [MID=26376, T=8F8FFE25DEBC96C1], GET, /test, 2:2/0/16 ----->
2416: <----- ACK [MID=26376, T=8F8FFE25DEBC96C1], 2.05, 2:2/0/16
Wait until deduplicator should be empty (0.647 seconds)
2546: CON [MID=26377, T=D1A369DFBFD49861], GET, /test, observe(0) ----->
2547: <----- ACK [MID=26377, T=D1A369DFBFD49861], 2.05, observe(5)
2747: <----- NON [MID=47427, T=D1A369DFBFD49861], 2.05, observe(6)
2947: <----- NON [MID=47428, T=D1A369DFBFD49861], 2.05, observe(7)
2947: CON [MID=26378, T=D1A369DFBFD49861], GET, /test, observe(1) ----->
2948: <----- ACK [MID=26378, T=D1A369DFBFD49861], 2.05
Wait until deduplicator should be empty (0.647 seconds)
3078: CON [MID=26379, T=8CB888F41A68725D], GET, /test ----->
3079: <----- ACK [MID=26379, T=8CB888F41A68725D], 2.05
Wait until deduplicator should be empty (0.647 seconds)
3209: CON [MID=26380, T=A077B019B1EE5B93], POST, /test, 1:0/1/16, size1(20) ----->
3210: <----- ACK [MID=26380, T=A077B019B1EE5B93], 2.31, 1:0/1/16
3210: CON [MID=26381, T=A077B019B1EE5B93], POST, /test, 1:1/0/16 ----->
3211: <----- ACK [MID=26381]
3211: <----- CON [MID=47429, T=A077B019B1EE5B93], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
3212: ACK [MID=47429] ----->
3212: CON [MID=26382, T=A077B019B1EE5B93], POST, /test, 2:1/0/16 ----->
3213: <----- ACK [MID=26382, T=A077B019B1EE5B93], 2.01, 2:1/1/16
3213: CON [MID=26383, T=A077B019B1EE5B93], POST, /test, 2:2/0/16 ----->
3214: <----- ACK [MID=26383, T=A077B019B1EE5B93], 2.01, 2:2/0/16
Start ClientSynchronousTest on coap://127.0.0.1:8321
[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.339 s - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
[INFO] Running org.eclipse.californium.core.test.ClientSynchronousTest
End ClientSynchronousTest
[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.818 s - in org.eclipse.californium.core.test.ClientSynchronousTest
[INFO] Running org.eclipse.californium.core.test.RandomAccessBlockTest
Start org.eclipse.californium.core.test.RandomAccessBlockTest
End org.eclipse.californium.core.test.RandomAccessBlockTest
Start org.eclipse.californium.core.test.RandomAccessBlockTest
Request block number 2
Request block number 1
Request block number 5
Request block number 3
End org.eclipse.californium.core.test.RandomAccessBlockTest
Start org.eclipse.californium.core.test.RandomAccessBlockTest
End org.eclipse.californium.core.test.RandomAccessBlockTest
Start org.eclipse.californium.core.test.RandomAccessBlockTest
Request block number 2
Request block number 1
Request block number 5
Request block number 3
End org.eclipse.californium.core.test.RandomAccessBlockTest
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 s - in org.eclipse.californium.core.test.RandomAccessBlockTest
[INFO] Running org.eclipse.californium.core.test.StartStopTest
Start StartStopTest
Socket port: 8331
Start server 1
Stop server 1 and start server 2
Stop server 2 and start server 1
Stop server 1 and start server 2
Stop server 2 and start server 1
Stop server 1 and start server 2
Stop server 2 and start server 1
Stop server 1
End StartStopTest
Start MessageTypeTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.851 s - in org.eclipse.californium.core.test.StartStopTest
[INFO] Running org.eclipse.californium.core.test.MessageTypeTest
gotit
gotit
End MessageTypeTest
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.eclipse.californium.core.test.MessageTypeTest
[INFO]
[INFO] Results:
[INFO]
[ERROR] Failures:
[ERROR] BlockwiseClientSideTest.testPUTFailsWith413IfBodyExceedsMaxBodySize:469
Expected: is not null
but: was null
[INFO]
[ERROR] Tests run: 118, Failures: 1, Errors: 0, Skipped: 0
[INFO]
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary for Californium (Cf) Parent 2.0.0-SNAPSHOT:
[INFO]
[INFO] Californium (Cf) Parent ............................ SUCCESS [ 8.856 s]
[INFO] Legal Documents .................................... SUCCESS [ 5.930 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [ 0.796 s]
[INFO] element-connector .................................. SUCCESS [01:22 min]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:54 min]
[INFO] element-connector-tcp .............................. SUCCESS [ 49.462 s]
[INFO] Californium (Cf) Core .............................. FAILURE [01:45 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] Californium (Cf) Demo Setup for Unix ............... SKIPPED
[INFO] Cf-BenchmarkServer ................................. SKIPPED
[INFO] Cf-ObserveBenchmarkClient .......................... SKIPPED
[INFO] Cf-OSCORE .......................................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 06:16 min
[INFO] Finished at: 2019-04-11T00:51:43-04:00
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.22.1:test (medium-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