See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/640/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 722627 lines...]
[junit]
[junit] 2011-04-17 12:35:04,371 INFO datanode.DataNode
(DataNode.java:shutdown(791)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2011-04-17 12:35:04,371 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(624)) - Exiting DataBlockScanner thread.
[junit] 2011-04-17 12:35:04,371 INFO datanode.DataNode
(DataNode.java:run(1497)) - DatanodeRegistration(127.0.0.1:53934,
storageID=DS-1753167764-127.0.1.1-53934-1303043703615, infoPort=45352,
ipcPort=33069):Finishing DataNode in:
FSDataset{dirpath='/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data3/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data4/current/finalized'}
[junit] 2011-04-17 12:35:04,372 INFO ipc.Server (Server.java:stop(1626)) -
Stopping server on 33069
[junit] 2011-04-17 12:35:04,372 INFO datanode.DataNode
(DataNode.java:shutdown(791)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2011-04-17 12:35:04,372 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk
service threads...
[junit] 2011-04-17 12:35:04,372 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads
have been shut down.
[junit] 2011-04-17 12:35:04,372 WARN datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already
shut down.
[junit] 2011-04-17 12:35:04,373 INFO hdfs.MiniDFSCluster
(MiniDFSCluster.java:shutdownDataNodes(835)) - Shutting down DataNode 0
[junit] 2011-04-17 12:35:04,473 INFO ipc.Server (Server.java:stop(1626)) -
Stopping server on 46160
[junit] 2011-04-17 12:35:04,474 INFO ipc.Server (Server.java:run(1459)) -
IPC Server handler 0 on 46160: exiting
[junit] 2011-04-17 12:35:04,474 INFO ipc.Server (Server.java:run(487)) -
Stopping IPC Server listener on 46160
[junit] 2011-04-17 12:35:04,474 INFO ipc.Server (Server.java:run(691)) -
Stopping IPC Server Responder
[junit] 2011-04-17 12:35:04,474 WARN datanode.DataNode
(DataXceiverServer.java:run(142)) - DatanodeRegistration(127.0.0.1:45883,
storageID=DS-899432502-127.0.1.1-45883-1303043703453, infoPort=52177,
ipcPort=46160):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at
java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
[junit] at
sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at
org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:135)
[junit] at java.lang.Thread.run(Thread.java:662)
[junit]
[junit] 2011-04-17 12:35:04,474 INFO datanode.DataNode
(DataNode.java:shutdown(791)) - Waiting for threadgroup to exit, active threads
is 1
[junit] 2011-04-17 12:35:04,474 INFO datanode.DataBlockScanner
(DataBlockScanner.java:run(624)) - Exiting DataBlockScanner thread.
[junit] 2011-04-17 12:35:04,575 INFO datanode.DataNode
(DataNode.java:run(1497)) - DatanodeRegistration(127.0.0.1:45883,
storageID=DS-899432502-127.0.1.1-45883-1303043703453, infoPort=52177,
ipcPort=46160):Finishing DataNode in:
FSDataset{dirpath='/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data1/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data2/current/finalized'}
[junit] 2011-04-17 12:35:04,575 INFO ipc.Server (Server.java:stop(1626)) -
Stopping server on 46160
[junit] 2011-04-17 12:35:04,575 INFO datanode.DataNode
(DataNode.java:shutdown(791)) - Waiting for threadgroup to exit, active threads
is 0
[junit] 2011-04-17 12:35:04,575 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk
service threads...
[junit] 2011-04-17 12:35:04,575 INFO datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads
have been shut down.
[junit] 2011-04-17 12:35:04,575 WARN datanode.FSDatasetAsyncDiskService
(FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already
shut down.
[junit] 2011-04-17 12:35:04,676 WARN namenode.DecommissionManager
(DecommissionManager.java:run(70)) - Monitor interrupted:
java.lang.InterruptedException: sleep interrupted
[junit] 2011-04-17 12:35:04,676 WARN namenode.FSNamesystem
(FSNamesystem.java:run(2896)) - ReplicationMonitor thread received
InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2011-04-17 12:35:04,676 INFO namenode.FSEditLog
(FSEditLog.java:printStatistics(573)) - Number of transactions: 6 Total time
for transactions(ms): 0Number of transactions batched in Syncs: 0 Number of
syncs: 3 SyncTimes(ms): 5 3
[junit] 2011-04-17 12:35:04,678 INFO ipc.Server (Server.java:stop(1626)) -
Stopping server on 40108
[junit] 2011-04-17 12:35:04,678 INFO ipc.Server (Server.java:run(1459)) -
IPC Server handler 0 on 40108: exiting
[junit] 2011-04-17 12:35:04,678 INFO ipc.Server (Server.java:run(487)) -
Stopping IPC Server listener on 40108
[junit] 2011-04-17 12:35:04,678 INFO ipc.Server (Server.java:run(691)) -
Stopping IPC Server Responder
[junit] Tests run: 16, Failures: 0, Errors: 0, Time elapsed: 99.107 sec
checkfailure:
[touch] Creating
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/testsfailed
BUILD FAILED
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:747:
The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:505:
The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/src/test/aop/build/aop.xml:230:
The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:688:
The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:662:
The following error occurred while executing this line:
/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:730:
Tests failed!
Total time: 61 minutes 40 seconds
[FINDBUGS] Skipping publisher since build result is FAILURE
Publishing Javadoc
Archiving artifacts
Recording test results
Recording fingerprints
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
1 tests failed.
REGRESSION:
org.apache.hadoop.hdfs.server.datanode.TestFiDataTransferProtocol2.pipeline_Fi_18
Error Message:
Failed to add a datanode: nodes.length != original.length + 1,
nodes=[127.0.0.1:54748], original=[127.0.0.1:54748]
Stack Trace:
java.io.IOException: Failed to add a datanode: nodes.length != original.length
+ 1, nodes=[127.0.0.1:54748], original=[127.0.0.1:54748]
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.findNewDatanode(DFSOutputStream.java:768)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.addDatanode2ExistingPipeline(DFSOutputStream.java:824)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.setupPipelineForAppendOrRecovery(DFSOutputStream.java:918)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.processDatanodeError(DFSOutputStream.java:731)
at
org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.run(DFSOutputStream.java:415)
