See https://builds.apache.org/job/Hadoop-Hdfs-trunk/742/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 1096622 lines...]
[junit] 2011-08-07 13:26:49,247 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads
have been shut down.
[junit] 2011-08-07 13:26:49,248 INFO mortbay.log (Slf4jLog.java:info(67))
- Stopped SelectChannelConnector@localhost:0
[junit] 2011-08-07 13:26:49,349 WARN blockmanagement.DecommissionManager
(DecommissionManager.java:run(75)) - Monitor interrupted:
java.lang.InterruptedException: sleep interrupted
[junit] 2011-08-07 13:26:49,349 WARN blockmanagement.BlockManager
(BlockManager.java:run(2370)) - ReplicationMonitor thread received
InterruptedException.
[junit] java.lang.InterruptedException: sleep interrupted
[junit] at java.lang.Thread.sleep(Native Method)
[junit] at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor.run(BlockManager.java:2368)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit] 2011-08-07 13:26:49,349 INFO namenode.FSEditLog
(FSEditLog.java:endCurrentLogSegment(822)) - Ending log segment 1
[junit] 2011-08-07 13:26:49,357 INFO namenode.FSEditLog
(FSEditLog.java:printStatistics(501)) - Number of transactions: 8 Total time
for transactions(ms): 1Number of transactions batched in Syncs: 0 Number of
syncs: 7 SyncTimes(ms): 43 38
[junit] 2011-08-07 13:26:49,359 INFO ipc.Server (Server.java:stop(1715)) -
Stopping server on 53315
[junit] 2011-08-07 13:26:49,359 INFO ipc.Server (Server.java:run(1539)) -
IPC Server handler 0 on 53315: exiting
[junit] 2011-08-07 13:26:49,359 INFO ipc.Server (Server.java:run(505)) -
Stopping IPC Server listener on 53315
[junit] 2011-08-07 13:26:49,359 INFO ipc.Server (Server.java:run(647)) -
Stopping IPC Server Responder
[junit] 2011-08-07 13:26:49,359 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stop(199)) - Stopping DataNode metrics system...
[junit] 2011-08-07 13:26:49,360 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source JvmMetrics
[junit] 2011-08-07 13:26:49,360 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
NameNodeActivity
[junit] 2011-08-07 13:26:49,360 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcActivityForPort53315
[junit] 2011-08-07 13:26:49,360 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcDetailedActivityForPort53315
[junit] 2011-08-07 13:26:49,361 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source FSNamesystem
[junit] 2011-08-07 13:26:49,361 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcActivityForPort53121
[junit] 2011-08-07 13:26:49,361 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcDetailedActivityForPort53121
[junit] 2011-08-07 13:26:49,361 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source JvmMetrics-1
[junit] 2011-08-07 13:26:49,362 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
DataNodeActivity-janus.apache.org-49020
[junit] 2011-08-07 13:26:49,362 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcActivityForPort38528
[junit] 2011-08-07 13:26:49,362 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcDetailedActivityForPort38528
[junit] 2011-08-07 13:26:49,362 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source JvmMetrics-2
[junit] 2011-08-07 13:26:49,363 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
DataNodeActivity-janus.apache.org-49327
[junit] 2011-08-07 13:26:49,363 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcActivityForPort59359
[junit] 2011-08-07 13:26:49,363 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcDetailedActivityForPort59359
[junit] 2011-08-07 13:26:49,363 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source JvmMetrics-3
[junit] 2011-08-07 13:26:49,364 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
DataNodeActivity-janus.apache.org-56851
[junit] 2011-08-07 13:26:49,364 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcActivityForPort56988
[junit] 2011-08-07 13:26:49,364 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
RpcDetailedActivityForPort56988
[junit] 2011-08-07 13:26:49,364 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source JvmMetrics-4
[junit] 2011-08-07 13:26:49,365 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stopSources(408)) - Stopping metrics source
DataNodeActivity-janus.apache.org-43917
[junit] 2011-08-07 13:26:49,365 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:stop(205)) - DataNode metrics system stopped.
[junit] 2011-08-07 13:26:49,365 INFO impl.MetricsSystemImpl
(MetricsSystemImpl.java:shutdown(553)) - DataNode metrics system shutdown
complete.
[junit] Tests run: 16, Failures: 0, Errors: 0, Time elapsed: 121.63 sec
checkfailure:
-run-test-hdfs-fault-inject-withtestcaseonly:
run-test-hdfs-fault-inject:
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:777:
Tests failed!
Total time: 114 minutes 25 seconds
[FINDBUGS] Skipping publisher since build result is FAILURE
Archiving artifacts
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Recording test results
Publishing Javadoc
Recording fingerprints
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
4 tests failed.
REGRESSION: org.apache.hadoop.hdfs.TestDFSRemove.testRemove
Error Message:
All blocks should be gone. start=98304 max=102304 final=100764 expected:<98304>
but was:<100764>
Stack Trace:
junit.framework.AssertionFailedError: All blocks should be gone. start=98304
max=102304 final=100764 expected:<98304> but was:<100764>
at
org.apache.hadoop.hdfs.TestDFSRemove.__CLR2_4_3ej1cn113kh(TestDFSRemove.java:82)
at
org.apache.hadoop.hdfs.TestDFSRemove.testRemove(TestDFSRemove.java:57)
REGRESSION: org.apache.hadoop.hdfs.TestParallelRead.testParallelRead
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
REGRESSION:
org.apache.hadoop.hdfs.TestReplaceDatanodeOnFailure.testReplaceDatanodeOnFailure
Error Message:
Failed to add a datanode: nodes.length != original.length + 1,
nodes=[127.0.0.1:60615, 127.0.0.1:52064], original=[127.0.0.1:60615,
127.0.0.1:52064]
Stack Trace:
java.io.IOException: Failed to add a datanode: nodes.length != original.length
+ 1, nodes=[127.0.0.1:60615, 127.0.0.1:52064], original=[127.0.0.1:60615,
127.0.0.1:52064]
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.findNewDatanode(DFSOutputStream.java:767)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.addDatanode2ExistingPipeline(DFSOutputStream.java:823)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.setupPipelineForAppendOrRecovery(DFSOutputStream.java:919)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.processDatanodeError(DFSOutputStream.java:730)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.run(DFSOutputStream.java:416)
FAILED:
org.apache.hadoop.hdfs.security.token.block.TestBlockToken.testBlockTokenRpcLeak
Error Message:
Call to localhost/127.0.0.1:47874 failed on socket timeout exception:
java.net.SocketTimeoutException: 1000 millis timeout while waiting for channel
to be ready for read. ch : java.nio.channels.SocketChannel[connected
local=/127.0.0.1:54293 remote=localhost/127.0.0.1:47874]
Stack Trace:
java.net.SocketTimeoutException: Call to localhost/127.0.0.1:47874 failed on
socket timeout exception: java.net.SocketTimeoutException: 1000 millis timeout
while waiting for channel to be ready for read. ch :
java.nio.channels.SocketChannel[connected local=/127.0.0.1:54293
remote=localhost/127.0.0.1:47874]
at org.apache.hadoop.ipc.Client.wrapException(Client.java:1085)
at org.apache.hadoop.ipc.Client.call(Client.java:1057)
at
org.apache.hadoop.ipc.WritableRpcEngine$Invoker.invoke(WritableRpcEngine.java:193)
at $Proxy7.getReplicaVisibleLength(Unknown Source)
at
org.apache.hadoop.hdfs.security.token.block.TestBlockToken.__CLR2_4_313r7v311rh(TestBlockToken.java:298)
at
org.apache.hadoop.hdfs.security.token.block.TestBlockToken.testBlockTokenRpcLeak(TestBlockToken.java:262)
Caused by: java.net.SocketTimeoutException: 1000 millis timeout while waiting
for channel to be ready for read. ch :
java.nio.channels.SocketChannel[connected local=/127.0.0.1:54293
remote=localhost/127.0.0.1:47874]
at
org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:164)
at
org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:159)
at
org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:132)
at java.io.DataInputStream.read(DataInputStream.java:132)
at
org.apache.hadoop.security.SaslInputStream.read(SaslInputStream.java:243)
at java.io.FilterInputStream.read(FilterInputStream.java:116)
at
org.apache.hadoop.ipc.Client$Connection$PingInputStream.read(Client.java:369)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
at java.io.BufferedInputStream.read(BufferedInputStream.java:237)
at java.io.DataInputStream.readInt(DataInputStream.java:370)
at
org.apache.hadoop.ipc.Client$Connection.receiveResponse(Client.java:786)
at org.apache.hadoop.ipc.Client$Connection.run(Client.java:724)
