See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/581/
################################################################################### ########################## LAST 60 LINES OF THE CONSOLE ########################### [...truncated 653948 lines...] [junit] 2011-02-13 12:24:37,445 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-02-13 12:24:37,445 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(835)) - Shutting down DataNode 0 [junit] 2011-02-13 12:24:37,547 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 49354 [junit] 2011-02-13 12:24:37,547 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 49354: exiting [junit] 2011-02-13 12:24:37,547 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 1 [junit] 2011-02-13 12:24:37,547 WARN datanode.DataNode (DataXceiverServer.java:run(141)) - DatanodeRegistration(127.0.0.1:51501, storageID=DS-860255907-127.0.1.1-51501-1297599866704, infoPort=46020, ipcPort=49354):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:134) [junit] at java.lang.Thread.run(Thread.java:662) [junit] [junit] 2011-02-13 12:24:37,547 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2011-02-13 12:24:37,547 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 49354 [junit] 2011-02-13 12:24:37,550 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-02-13 12:24:37,550 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(622)) - Exiting DataBlockScanner thread. [junit] 2011-02-13 12:24:37,551 INFO datanode.DataNode (DataNode.java:run(1460)) - DatanodeRegistration(127.0.0.1:51501, storageID=DS-860255907-127.0.1.1-51501-1297599866704, infoPort=46020, ipcPort=49354):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-02-13 12:24:37,551 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 49354 [junit] 2011-02-13 12:24:37,551 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-02-13 12:24:37,551 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2011-02-13 12:24:37,551 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2011-02-13 12:24:37,552 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-02-13 12:24:37,653 WARN namenode.DecommissionManager (DecommissionManager.java:run(70)) - Monitor interrupted: java.lang.InterruptedException: sleep interrupted [junit] 2011-02-13 12:24:37,653 INFO namenode.FSEditLog (FSEditLog.java:printStatistics(559)) - Number of transactions: 6 Total time for transactions(ms): 0Number of transactions batched in Syncs: 0 Number of syncs: 3 SyncTimes(ms): 12 2 [junit] 2011-02-13 12:24:37,654 WARN namenode.FSNamesystem (FSNamesystem.java:run(2847)) - ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 2011-02-13 12:24:37,655 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 53844 [junit] 2011-02-13 12:24:37,655 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 1 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 2 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 5 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 4 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 3 on 53844: exiting [junit] 2011-02-13 12:24:37,657 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 9 on 53844: exiting [junit] 2011-02-13 12:24:37,657 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 8 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 53844 [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 7 on 53844: exiting [junit] 2011-02-13 12:24:37,656 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 6 on 53844: exiting [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 35.286 sec checkfailure: -run-test-hdfs-fault-inject-withtestcaseonly: run-test-hdfs-fault-inject: BUILD FAILED /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build.xml:746: Tests failed! Total time: 51 minutes 30 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) ############################## 3 tests failed. REGRESSION: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorTransferToVerySmallWrite Error Message: Too many open files Stack Trace: java.io.IOException: Too many open files at sun.nio.ch.IOUtil.initPipe(Native Method) at sun.nio.ch.EPollSelectorImpl.<init>(EPollSelectorImpl.java:49) at sun.nio.ch.EPollSelectorProvider.openSelector(EPollSelectorProvider.java:18) at java.nio.channels.Selector.open(Selector.java:209) at org.apache.hadoop.ipc.Server$Responder.<init>(Server.java:602) at org.apache.hadoop.ipc.Server.<init>(Server.java:1510) at org.apache.hadoop.ipc.RPC$Server.<init>(RPC.java:576) at org.apache.hadoop.ipc.WritableRpcEngine$Server.<init>(WritableRpcEngine.java:338) at org.apache.hadoop.ipc.WritableRpcEngine.getServer(WritableRpcEngine.java:298) at org.apache.hadoop.ipc.WritableRpcEngine.getServer(WritableRpcEngine.java:46) at org.apache.hadoop.ipc.RPC.getServer(RPC.java:550) at org.apache.hadoop.hdfs.server.datanode.DataNode.initIpcServer(DataNode.java:422) at org.apache.hadoop.hdfs.server.datanode.DataNode.startDataNode(DataNode.java:513) at org.apache.hadoop.hdfs.server.datanode.DataNode.<init>(DataNode.java:283) at org.apache.hadoop.hdfs.server.datanode.DataNode.<init>(DataNode.java:265) at org.apache.hadoop.hdfs.server.datanode.DataNode.makeInstance(DataNode.java:1576) at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:1519) at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:1486) at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:678) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:483) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:203) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:78) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:195) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.runTestUnfinishedBlockCRCError(TestFileConcurrentReader.java:315) at org.apache.hadoop.hdfs.TestFileConcurrentReader.runTestUnfinishedBlockCRCError(TestFileConcurrentReader.java:302) at org.apache.hadoop.hdfs.TestFileConcurrentReader.__CLR3_0_2u5mf5tro5(TestFileConcurrentReader.java:275) at org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorTransferToVerySmallWrite(TestFileConcurrentReader.java:274) REGRESSION: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorNormalTransfer Error Message: Cannot lock storage /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/name1. The directory is already locked. Stack Trace: java.io.IOException: Cannot lock storage /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/name1. The directory is already locked. at org.apache.hadoop.hdfs.server.common.Storage$StorageDirectory.lock(Storage.java:615) at org.apache.hadoop.hdfs.server.namenode.FSImage.formatOccurred(FSImage.java:1165) at org.apache.hadoop.hdfs.server.namenode.NNStorage.format(NNStorage.java:558) at org.apache.hadoop.hdfs.server.namenode.NNStorage.format(NNStorage.java:577) at org.apache.hadoop.hdfs.server.namenode.NameNode.format(NameNode.java:1417) at org.apache.hadoop.hdfs.server.namenode.NameNode.format(NameNode.java:211) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:470) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:203) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:78) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:195) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.setUp(TestFileConcurrentReader.java:73) REGRESSION: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorNormalTransferVerySmallWrite Error Message: Cannot lock storage /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/name1. The directory is already locked. Stack Trace: java.io.IOException: Cannot lock storage /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/name1. The directory is already locked. at org.apache.hadoop.hdfs.server.common.Storage$StorageDirectory.lock(Storage.java:615) at org.apache.hadoop.hdfs.server.namenode.FSImage.formatOccurred(FSImage.java:1165) at org.apache.hadoop.hdfs.server.namenode.NNStorage.format(NNStorage.java:558) at org.apache.hadoop.hdfs.server.namenode.NNStorage.format(NNStorage.java:577) at org.apache.hadoop.hdfs.server.namenode.NameNode.format(NameNode.java:1417) at org.apache.hadoop.hdfs.server.namenode.NameNode.format(NameNode.java:211) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:470) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:203) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:78) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:195) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.setUp(TestFileConcurrentReader.java:73)