See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/576/
################################################################################### ########################## LAST 60 LINES OF THE CONSOLE ########################### [...truncated 664793 lines...] [junit] 2011-02-08 12:51:19,626 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-02-08 12:51:19,627 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(835)) - Shutting down DataNode 0 [junit] 2011-02-08 12:51:19,737 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 37251 [junit] 2011-02-08 12:51:19,737 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 37251: exiting [junit] 2011-02-08 12:51:19,738 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 1 [junit] 2011-02-08 12:51:19,738 WARN datanode.DataNode (DataXceiverServer.java:run(141)) - DatanodeRegistration(127.0.0.1:55893, storageID=DS-1346001687-127.0.1.1-55893-1297169468694, infoPort=59523, ipcPort=37251):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:152) [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:619) [junit] [junit] 2011-02-08 12:51:19,738 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 37251 [junit] 2011-02-08 12:51:19,738 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2011-02-08 12:51:19,738 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(622)) - Exiting DataBlockScanner thread. [junit] 2011-02-08 12:51:19,750 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-02-08 12:51:19,850 INFO datanode.DataNode (DataNode.java:run(1460)) - DatanodeRegistration(127.0.0.1:55893, storageID=DS-1346001687-127.0.1.1-55893-1297169468694, infoPort=59523, ipcPort=37251):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-08 12:51:19,851 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 37251 [junit] 2011-02-08 12:51:19,851 INFO datanode.DataNode (DataNode.java:shutdown(786)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-02-08 12:51:19,851 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2011-02-08 12:51:19,851 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2011-02-08 12:51:19,852 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-02-08 12:51:19,854 WARN namenode.FSNamesystem (FSNamesystem.java:run(2847)) - ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 2011-02-08 12:51:19,854 INFO namenode.FSEditLog (FSEditLog.java:printStatistics(559)) - Number of transactions: 6 Total time for transactions(ms): 1Number of transactions batched in Syncs: 0 Number of syncs: 3 SyncTimes(ms): 6 2 [junit] 2011-02-08 12:51:19,854 WARN namenode.DecommissionManager (DecommissionManager.java:run(70)) - Monitor interrupted: java.lang.InterruptedException: sleep interrupted [junit] 2011-02-08 12:51:19,855 INFO ipc.Server (Server.java:stop(1610)) - Stopping server on 38969 [junit] 2011-02-08 12:51:19,856 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 0 on 38969: exiting [junit] 2011-02-08 12:51:19,856 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 9 on 38969: exiting [junit] 2011-02-08 12:51:19,856 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 4 on 38969: exiting [junit] 2011-02-08 12:51:19,856 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 6 on 38969: exiting [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 36.68 sec [junit] 2011-02-08 12:51:19,859 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 7 on 38969: exiting [junit] 2011-02-08 12:51:19,860 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 8 on 38969: exiting [junit] 2011-02-08 12:51:19,860 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 1 on 38969: exiting [junit] 2011-02-08 12:51:19,860 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 3 on 38969: exiting [junit] 2011-02-08 12:51:19,860 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 2 on 38969: exiting [junit] 2011-02-08 12:51:19,860 INFO ipc.Server (Server.java:run(1443)) - IPC Server handler 5 on 38969: exiting [junit] 2011-02-08 12:51:19,861 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2011-02-08 12:51:19,864 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 38969 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: 76 minutes 44 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) ############################## 5 tests failed. REGRESSION: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorNormalTransfer Error Message: Too many open files Stack Trace: java.io.IOException: Too many open files at sun.nio.ch.EPollArrayWrapper.epollCreate(Native Method) at sun.nio.ch.EPollArrayWrapper.<init>(EPollArrayWrapper.java:68) at sun.nio.ch.EPollSelectorImpl.<init>(EPollSelectorImpl.java:52) at sun.nio.ch.EPollSelectorProvider.openSelector(EPollSelectorProvider.java:18) at java.nio.channels.Selector.open(Selector.java:209) at org.apache.hadoop.ipc.Server$Listener.<init>(Server.java:318) at org.apache.hadoop.ipc.Server.<init>(Server.java:1501) 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.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) REGRESSION: org.apache.hadoop.hdfs.server.balancer.TestBalancer.testBalancer1 Error Message: 127.0.0.1:44994is not an underUtilized node Stack Trace: junit.framework.AssertionFailedError: 127.0.0.1:44994is not an underUtilized node at org.apache.hadoop.hdfs.server.balancer.Balancer.initNodes(Balancer.java:1012) at org.apache.hadoop.hdfs.server.balancer.Balancer.initNodes(Balancer.java:954) at org.apache.hadoop.hdfs.server.balancer.Balancer.run(Balancer.java:1497) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.runBalancer(TestBalancer.java:247) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.testUnevenDistribution(TestBalancer.java:185) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.__CLR3_0_2cs3hxsso5(TestBalancer.java:335) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.testBalancer1(TestBalancer.java:332) REGRESSION: org.apache.hadoop.hdfs.server.balancer.TestBalancer.testBalancer2 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.server.balancer.TestBalancer.testBalancerDefaultConstructor(TestBalancer.java:353) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.__CLR3_0_2g13gq9so9(TestBalancer.java:344) at org.apache.hadoop.hdfs.server.balancer.TestBalancer.testBalancer2(TestBalancer.java:341) FAILED: org.apache.hadoop.hdfs.TestLargeBlock.testLargeBlockSize 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.