Skip to main content

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] Build failed in Jenkins: 2.0.x #673

See <https://ci.eclipse.org/californium/job/2.0.x/673/display/redirect?page=changes>

Changes:

[Achim Kraus] Add logging to leaking test.

------------------------------------------
[...truncated 335.02 KB...]
4301: CON [MID=54721, T=F01BAE0BB91B2EBB], GET, /test    ----->
4301: <-----   ACK [MID=54721, T=F01BAE0BB91B2EBB], 2.05, 2:0/1/32, size2(152)
4302: CON [MID=54722, T=F01BAE0BB91B2EBB], GET, /test, 2:1/0/32    ----->
4303: <-----   ACK [MID=54722, T=F01BAE0BB91B2EBB], 2.05, 2:1/1/32
4304: CON [MID=54723, T=F01BAE0BB91B2EBB], GET, /test, 2:2/0/32    ----->
4304: <-----   ACK [MID=54723, T=F01BAE0BB91B2EBB], 2.05, 2:2/1/32
4305: CON [MID=54724, T=F01BAE0BB91B2EBB], GET, /test, 2:3/0/32    ----->
4305: <-----   ACK [MID=54724, T=F01BAE0BB91B2EBB], 2.05, 2:3/1/32
4306: CON [MID=54725, T=F01BAE0BB91B2EBB], GET, /test, 2:4/0/32    ----->
4306: <-----   ACK [MID=54725, T=F01BAE0BB91B2EBB], 2.05, 2:4/0/32

Server received GET request
Client received payload [48642057270289295706781776473081702027785731439412177059817099211511019593540226718615281867500436810844511581531956435659347625377620562956442889168693]

4409: CON [MID=54726, T=44F3ACF3FB2D5309], GET, /test    ----->
4409: <-----   ACK [MID=54726, T=44F3ACF3FB2D5309], 2.05, 2:0/1/32, size2(152)
4410: CON [MID=54727, T=44F3ACF3FB2D5309], GET, /test, 2:1/0/32    ----->
4410: <-----   ACK [MID=54727, T=44F3ACF3FB2D5309], 2.05, 2:1/1/32
4411: CON [MID=54728, T=44F3ACF3FB2D5309], GET, /test, 2:2/0/32    ----->
4412: <-----   ACK [MID=54728, T=44F3ACF3FB2D5309], 2.05, 2:2/1/32
4413: CON [MID=54729, T=44F3ACF3FB2D5309], GET, /test, 2:3/0/32    ----->
4413: <-----   ACK [MID=54729, T=44F3ACF3FB2D5309], 2.05, 2:3/1/32
4414: CON [MID=54730, T=44F3ACF3FB2D5309], GET, /test, 2:4/0/32    ----->
4414: <-----   ACK [MID=54730, T=44F3ACF3FB2D5309], 2.05, 2:4/0/32

-- POST long short --
Server received 705064106516399220334323597150931523697547256173281703527424205475803399461972406433658171499986153308217986541886620855723610992764513037824032210514
Client received payload [4443133866277567]

4520: CON [MID=23385, T=223749EE51EA6298], POST, /test, 1:0/1/32, size1(150)    ----->
4520: <-----   ACK [MID=23385, T=223749EE51EA6298], 2.31, 1:0/1/32
4521: CON [MID=23386, T=223749EE51EA6298], POST, /test, 1:1/1/32    ----->
4522: <-----   ACK [MID=23386, T=223749EE51EA6298], 2.31, 1:1/1/32
4523: CON [MID=23387, T=223749EE51EA6298], POST, /test, 1:2/1/32    ----->
4523: <-----   ACK [MID=23387, T=223749EE51EA6298], 2.31, 1:2/1/32
4524: CON [MID=23388, T=223749EE51EA6298], POST, /test, 1:3/1/32    ----->
4524: <-----   ACK [MID=23388, T=223749EE51EA6298], 2.31, 1:3/1/32
4525: CON [MID=23389, T=223749EE51EA6298], POST, /test, 1:4/0/32    ----->
4525: <-----   ACK [MID=23389, T=223749EE51EA6298], 2.05, 1:4/0/32

End BlockwiseTransferTest
[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.628 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)

0007: NON [MID=12321, T=B4C9AD7C97DCCEF6], POST, /test, 1:0/1/16, size1(20)    ----->
0009: <-----   NON [MID=7466, T=B4C9AD7C97DCCEF6], 2.31, 1:0/1/16
0009: NON [MID=12322, T=B4C9AD7C97DCCEF6], POST, /test, 1:1/0/16    ----->
0011: <-----   NON [MID=7467, T=B4C9AD7C97DCCEF6], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
0011: NON [MID=12323, T=B4C9AD7C97DCCEF6], POST, /test, 2:1/0/16    ----->
0013: <-----   NON [MID=7468, T=B4C9AD7C97DCCEF6], 2.01, 2:1/1/16
0013: NON [MID=12324, T=B4C9AD7C97DCCEF6], POST, /test, 2:2/0/16    ----->
0014: <-----   NON [MID=7469, T=B4C9AD7C97DCCEF6], 2.01, 2:2/0/16
Test observe relation with a reactive cancelation to coap://127.0.0.1:8317/test
Wait until deduplicator should be empty (0.647 seconds)

0340: CON [MID=12325, T=AD8DA1A959F30377], GET, /test, observe(0)    ----->
0342: <-----   ACK [MID=12325, T=AD8DA1A959F30377], 2.05, observe(0)
0540: <-----   NON [MID=7470, T=AD8DA1A959F30377], 2.05, observe(1)
0740: <-----   NON [MID=7471, T=AD8DA1A959F30377], 2.05, observe(2)
0941: <-----   NON [MID=7472, T=AD8DA1A959F30377], 2.05, observe(3)
0941: RST [MID=7472]   ----->
Wait until deduplicator should be empty (0.647 seconds)

1063: CON [MID=12326, T=865B31D1C1D3FCDA], POST, /test, 1:0/1/16, size1(20)    ----->
1064: <-----   ACK [MID=12326, T=865B31D1C1D3FCDA], 2.31, 1:0/1/16
1065: CON [MID=12327, T=865B31D1C1D3FCDA], POST, /test, 1:1/0/16    ----->
1066: <-----   ACK [MID=12327, T=865B31D1C1D3FCDA], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
1067: CON [MID=12328, T=865B31D1C1D3FCDA], POST, /test, 2:1/0/16    ----->
1068: <-----   ACK [MID=12328, T=865B31D1C1D3FCDA], 2.01, 2:1/1/16
1069: CON [MID=12329, T=865B31D1C1D3FCDA], POST, /test, 2:2/0/16    ----->
1069: <-----   ACK [MID=12329, T=865B31D1C1D3FCDA], 2.01, 2:2/0/16
Wait until deduplicator should be empty (0.647 seconds)

1392: CON [MID=12330, T=0C8C223EE405C3CF], GET, /test    ----->
1393: <-----   ACK [MID=12330]
1393: <-----   CON [MID=7473, T=0C8C223EE405C3CF], 2.05
1393: ACK [MID=7473]   ----->
Wait until deduplicator should be empty (0.647 seconds)

1715: NON [MID=12331, T=A6C2637BF22C7DD1], GET, /test    ----->
1716: <-----   NON [MID=7474, T=A6C2637BF22C7DD1], 2.05
Wait until deduplicator should be empty (0.647 seconds)

2038: CON [MID=12332, T=E553C90749A51D30], GET, /test, observe(0)    ----->
2039: <-----   ACK [MID=12332, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(3), size2(40)
2040: CON [MID=12333, T=6855996CEEE8B697], GET, /test, 2:1/0/16    ----->
2175: CON [MID=12333, T=6855996CEEE8B697], GET, /test, 2:1/0/16    ----->
5955: <-----   ACK [MID=12333, T=6855996CEEE8B697], 2.05, 2:1/1/16
5955: <-----   NON [MID=7475, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(4), size2(40)
5955: RST [MID=7475]   ----->
5956: <-----   NON [MID=7476, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(5), size2(40)
5956: RST [MID=7476]   ----->
5956: <-----   NON [MID=7477, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(6), size2(40)
5956: RST [MID=7477]   ----->
5956: <-----   ACK [MID=12333, T=6855996CEEE8B697], 2.05, 2:1/1/16
5956: <-----   NON [MID=7478, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(7), size2(40)
5957: RST [MID=7478]   ----->
5957: <-----   NON [MID=7479, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(8), size2(40)
5957: RST [MID=7479]   ----->
5957: <-----   NON [MID=7480, T=E553C90749A51D30], 2.05, 2:0/1/16, observe(9), size2(40)
5957: RST [MID=7480]   ----->
Wait until deduplicator should be empty (0.647 seconds)

12640: CON [MID=12334, T=17434BCD8C8F673B], GET, /test, observe(0)    ----->
12642: <-----   ACK [MID=12334, T=17434BCD8C8F673B], 2.05, observe(20)
12840: <-----   NON [MID=7481, T=17434BCD8C8F673B], 2.05, observe(21)
13041: <-----   NON [MID=7482, T=17434BCD8C8F673B], 2.05, observe(22)
13042: CON [MID=12335, T=17434BCD8C8F673B], GET, /test, observe(1)    ----->
13043: <-----   ACK [MID=12335, T=17434BCD8C8F673B], 2.05
Wait until deduplicator should be empty (0.647 seconds)

13365: CON [MID=12336, T=AE9EBEDB058D9E1B], GET, /test    ----->
13367: <-----   ACK [MID=12336, T=AE9EBEDB058D9E1B], 2.05
Wait until deduplicator should be empty (0.647 seconds)

13690: CON [MID=12337, T=16C7863DDDA817FB], POST, /test, 1:0/1/16, size1(20)    ----->
13691: <-----   ACK [MID=12337, T=16C7863DDDA817FB], 2.31, 1:0/1/16
13692: CON [MID=12338, T=16C7863DDDA817FB], POST, /test, 1:1/0/16    ----->
13693: <-----   ACK [MID=12338]
13694: <-----   CON [MID=7483, T=16C7863DDDA817FB], 2.01, 1:1/0/16, 2:0/1/16, size2(40)
13694: ACK [MID=7483]   ----->
13695: CON [MID=12339, T=16C7863DDDA817FB], POST, /test, 2:1/0/16    ----->
13696: <-----   ACK [MID=12339, T=16C7863DDDA817FB], 2.01, 2:1/1/16
13697: CON [MID=12340, T=16C7863DDDA817FB], POST, /test, 2:2/0/16    ----->
13698: <-----   ACK [MID=12340, T=16C7863DDDA817FB], 2.01, 2:2/0/16

Start ClientSynchronousTest on coap://127.0.0.1:8318
[ERROR] Tests run: 9, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 15.015 s <<< FAILURE! - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
[ERROR] testObserveProactiveBlockwise(org.eclipse.californium.core.test.MemoryLeakingHashMapTest)  Time elapsed: 10.603 s  <<< FAILURE!
java.lang.AssertionError: Client has not received all expected responses, left 4
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.testObserveProactive(MemoryLeakingHashMapTest.java:326)
	at org.eclipse.californium.core.test.MemoryLeakingHashMapTest.testObserveProactiveBlockwise(MemoryLeakingHashMapTest.java:301)

[INFO] Running org.eclipse.californium.core.test.ClientSynchronousTest
End ClientSynchronousTest
[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.25 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.028 s - in org.eclipse.californium.core.test.RandomAccessBlockTest
[INFO] Running org.eclipse.californium.core.test.StartStopTest

Start StartStopTest
Socket port: 8328
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.833 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.009 s - in org.eclipse.californium.core.test.MessageTypeTest
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Failures: 
[ERROR]   MemoryLeakingHashMapTest.testObserveProactiveBlockwise:301->testObserveProactive:326 Client has not received all expected responses, left 4
[ERROR]   ObserveServerSideTest.stopClient:144 endpoint still contains states
[INFO] 
[ERROR] Tests run: 115, Failures: 2, Errors: 0, Skipped: 0
[INFO] 
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent 2.0.0-SNAPSHOT ............. SUCCESS [  3.603 s]
[INFO] Legal Documents .................................... SUCCESS [  1.870 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  0.268 s]
[INFO] element-connector .................................. SUCCESS [ 54.211 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [01:27 min]
[INFO] element-connector-tcp .............................. SUCCESS [ 37.585 s]
[INFO] Californium (Cf) Core .............................. FAILURE [01:03 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:14 min
[INFO] Finished at: 2019-03-01T10:04:43-05: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


Back to the top