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

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
[cf-dev] Build failed in Jenkins: 2.0.x-nightly #434
From: hudsonbuild@xxxxxxxxxxx
Date: Wed, 23 May 2018 02:53:47 -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://ci.eclipse.org/californium/job/2.0.x-nightly/434/display/redirect>

------------------------------------------
[...truncated 621.02 KB...]
Client binds to port 8278
Incomplete  block1 transfer:
CON [MID=32676, T=[8092b41c41047b99]], PUT, /test, 1:0/1/128, size1(400)    ----->
<-----   ACK [MID=32676, T=[8092b41c41047b99]], 2.31, 1:1/0/128
CON [MID=32677, T=[8092b41c41047b99]], PUT, /test, 1:1/1/128    ----->
CON [MID=32677, T=[8092b41c41047b99]], PUT, /test, 1:1/1/128    ----->
<-----   ACK [MID=32677, T=[8092b41c41047b99]], 2.31, 1:2/0/128
CON [MID=32678, T=[8092b41c41047b99]], PUT, /test, 1:2/1/128    ----->
CON [MID=32678, T=[8092b41c41047b99]], PUT, /test, 1:2/1/128    ----->

Wait until deduplicator should be empty (0.647 seconds)

End BlockwiseClientSideTest
[ERROR] Tests run: 24, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 7.179 s <<< FAILURE! - in org.eclipse.californium.core.test.lockstep.BlockwiseClientSideTest
[ERROR] testObserveWithBlockwiseResponse(org.eclipse.californium.core.test.lockstep.BlockwiseClientSideTest)  Time elapsed: 2.475 s  <<< FAILURE!
java.lang.AssertionError: did not receive message within expected time frame (2 secs)
	at org.eclipse.californium.core.test.lockstep.BlockwiseClientSideTest.testObserveWithBlockwiseResponse(BlockwiseClientSideTest.java:836)

[INFO] Running org.eclipse.californium.core.test.lockstep.ClusteringTest

Start ClusteringTest
Client 1 binds to port 8280
Client 2 binds to port 8281

Observe:

Sending Observe Request to client 1 ...

Server send Observe response to client 1.
CON [MID=30510, T=[3160a080f2d32127]], GET, /test, observe(0)    ----->
<-----   ACK [MID=30510]
<-----   CON [MID=8001, T=[3160a080f2d32127]], 2.05, observe(101)
ACK [MID=8001]   ----->
Relation established with client 1

Server send Observe response to client 2.
<-----   CON [MID=8002, T=[3160a080f2d32127]], 2.05, observe(102)
ACK [MID=8002]   ----->
Response received


Server send Observe response to client 1.
<-----   CON [MID=8003, T=[3160a080f2d32127]], 2.05, observe(103)
ACK [MID=8003]   ----->
Response received


Cancel Observation.


Server send Observe response to client 1.
<-----   CON [MID=8004, T=[3160a080f2d32127]], 2.05, observe(104)
RST [MID=8004]   ----->


Server send Observe response to client 2.
<-----   CON [MID=8005, T=[3160a080f2d32127]], 2.05, observe(104)
RST [MID=8005]   ----->

End ClusteringTest

Start ClusteringTest
Client 1 binds to port 8283
Client 2 binds to port 8284

Observe with blockwise:

Sending Observe Request to client 1 ...

Server send Observe response to client 1.
CON [MID=17647, T=[9f39a68d5dbc4c98]], GET, /test, observe(0)    ----->
<-----   ACK [MID=17647, T=[9f39a68d5dbc4c98]], 2.05, 2:0/1/16, observe(100)
CON [MID=17648, T=[6418fcfd80b18d6f]], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=17648, T=[6418fcfd80b18d6f]], 2.05, 2:1/1/16
CON [MID=17649, T=[6418fcfd80b18d6f]], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=17649, T=[6418fcfd80b18d6f]], 2.05, 2:2/0/16
Relation established with client 1

Server send Observe response to client 2.
<-----   CON [MID=8001, T=[9f39a68d5dbc4c98]], 2.05, 2:0/1/16, observe(101)
ACK [MID=8001]   ----->
CON [MID=17800, T=[9c9c9476e87d2f99]], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=17800, T=[9c9c9476e87d2f99]], 2.05, 2:1/1/16
CON [MID=17801, T=[9c9c9476e87d2f99]], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=17801, T=[9c9c9476e87d2f99]], 2.05, 2:2/0/16
Response received


Server send Observe response to client 1.
<-----   CON [MID=8002, T=[9f39a68d5dbc4c98]], 2.05, 2:0/1/16, observe(102)
ACK [MID=8002]   ----->
CON [MID=17650, T=[1ab293a2343fc75b]], GET, /test, 2:1/0/16    ----->
<-----   ACK [MID=17650, T=[1ab293a2343fc75b]], 2.05, 2:1/1/16
CON [MID=17651, T=[1ab293a2343fc75b]], GET, /test, 2:2/0/16    ----->
<-----   ACK [MID=17651, T=[1ab293a2343fc75b]], 2.05, 2:2/0/16
Response received

End ClusteringTest

Start ClusteringTest
Client 1 binds to port 8286
Client 2 binds to port 8287

Observe:

Sending Observe Request to client 1 ...

Server send Observe response to client 1.
CON [MID=17383, T=[a7601321d0cbb046]], GET, /test, observe(0)    ----->
<-----   ACK [MID=17383]
<-----   CON [MID=8001, T=[a7601321d0cbb046]], 2.05, observe(101)
ACK [MID=8001]   ----->
Relation established with client 1

Server send Observe response to client 2.
<-----   CON [MID=8002, T=[a7601321d0cbb046]], 2.05, observe(102)
ACK [MID=8002]   ----->
Response received


Server send Observe response to client 1.
<-----   CON [MID=8003, T=[a7601321d0cbb046]], 2.05, observe(103)
ACK [MID=8003]   ----->
Response received

End ClusteringTest
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.194 s - in org.eclipse.californium.core.test.lockstep.ClusteringTest
[INFO] Running org.eclipse.californium.core.test.lockstep.DeduplicationTest

Start DeduplicationTest
Client binds to port 8289
Simple GET:

End DeduplicationTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.5 s - in org.eclipse.californium.core.test.lockstep.DeduplicationTest
[INFO] Running org.eclipse.californium.core.test.lockstep.ServerDeduplicationTest
CON [MID=2345, T=[0001]], GET, /test/CON    ----->
<-----   ACK [MID=2345]
<-----   CON [MID=9522, T=[0001]], 2.05
CON [MID=2345, T=[0001]], GET, /test/CON    ----->
<-----   ACK [MID=2345]
<-----   CON [MID=9522, T=[0001]], 2.05
<-----   CON [MID=9522, T=[0001]], 2.05
ACK [MID=9522]    ----->
CON [MID=2346, T=[0001]], GET, /test/CON    ----->
<-----   ACK [MID=2346]
<-----   CON [MID=9523, T=[0001]], 2.05
ACK [MID=9523]    ----->

CON [MID=1234, T=[0000]], GET, /test    ----->
<-----   ACK [MID=1234, T=[0000]], 2.05
CON [MID=1234, T=[0000]], GET, /test    ----->
<-----   ACK [MID=1234, T=[0000]], 2.05
CON [MID=1235, T=[0000]], GET, /test    ----->
<-----   ACK [MID=1235, T=[0000]], 2.05

CON [MID=2345, T=[0001]], GET, /test/NON    ----->
<-----   ACK [MID=2345]
<-----   NON [MID=17544, T=[0001]], 2.05
CON [MID=2345, T=[0001]], GET, /test/NON    ----->
<-----   ACK [MID=2345]
<-----   NON [MID=17544, T=[0001]], 2.05
CON [MID=2346, T=[0001]], GET, /test/NON    ----->
<-----   ACK [MID=2346]
<-----   NON [MID=17545, T=[0001]], 2.05


Start MessageTypeTest
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.623 s - in org.eclipse.californium.core.test.lockstep.ServerDeduplicationTest
[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.012 s - in org.eclipse.californium.core.test.MessageTypeTest
[INFO] Running org.eclipse.californium.core.test.MemoryLeakingHashMapTest
Wait until deduplicator should be empty (0.647 seconds)
Test observe relation with a reactive cancelation to coap://127.0.0.1:8298/test
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
Wait until deduplicator should be empty (0.647 seconds)
[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.951 s - in org.eclipse.californium.core.test.MemoryLeakingHashMapTest
[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.027 s - in org.eclipse.californium.core.test.RandomAccessBlockTest
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Failures: 
[ERROR]   BlockwiseClientSideTest.testObserveWithBlockwiseResponse:836 did not receive message within expected time frame (2 secs)
[INFO] 
[ERROR] Tests run: 89, Failures: 1, Errors: 0, Skipped: 0
[INFO] 
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Californium (Cf) Parent ............................ SUCCESS [  3.273 s]
[INFO] Californium (Cf) Demo Certificates ................. SUCCESS [  4.009 s]
[INFO] element-connector .................................. SUCCESS [ 13.109 s]
[INFO] Scandium (Sc) Core ................................. SUCCESS [ 40.319 s]
[INFO] Californium (Cf) Core .............................. FAILURE [ 41.357 s]
[INFO] Californium (Cf) Proxy ............................. SKIPPED
[INFO] Californium (Cf) OSGi .............................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:47 min
[INFO] Finished at: 2018-05-23T02:53:45-04:00
[INFO] Final Memory: 39M/310M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.20.1:test (medium-tests) on project californium-core: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://ci.eclipse.org/californium/job/2.0.x-nightly/ws/californium-core/target/surefire-reports> for the individual test results.
[ERROR] Please refer to dump files (if any exist) [date]-jvmRun[N].dump, [date].dumpstream and [date]-jvmRun[N].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] Jenkins build is back to normal : 2.0.x-nightly #435
  - From: hudsonbuild
Prev by Date: [cf-dev] Jenkins build is back to normal : 2.0.x #450
Next by Date: [cf-dev] Jenkins build is back to normal : 2.0.x-nightly #435
Previous by thread: [cf-dev] Build failed in Jenkins: 2.0.x #449
Next by thread: [cf-dev] Jenkins build is back to normal : 2.0.x-nightly #435
Index(es):
- Date
- Thread
Breadcrumbs
