See https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/541/
################################################################################### ########################## LAST 60 LINES OF THE CONSOLE ########################### [...truncated 680690 lines...] [junit] 2011-01-03 12:39:52,300 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-01-03 12:39:52,300 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(786)) - Shutting down DataNode 0 [junit] 2011-01-03 12:39:52,402 INFO ipc.Server (Server.java:stop(1611)) - Stopping server on 54394 [junit] 2011-01-03 12:39:52,403 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 54394: exiting [junit] 2011-01-03 12:39:52,404 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2011-01-03 12:39:52,404 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 54394 [junit] 2011-01-03 12:39:52,404 INFO datanode.DataNode (DataNode.java:shutdown(780)) - Waiting for threadgroup to exit, active threads is 1 [junit] 2011-01-03 12:39:52,404 WARN datanode.DataNode (DataXceiverServer.java:run(141)) - DatanodeRegistration(127.0.0.1:51305, storageID=DS-483458649-127.0.1.1-51305-1294058381583, infoPort=35823, ipcPort=54394):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-01-03 12:39:52,407 INFO datanode.DataNode (DataNode.java:shutdown(780)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-01-03 12:39:52,507 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(622)) - Exiting DataBlockScanner thread. [junit] 2011-01-03 12:39:52,508 INFO datanode.DataNode (DataNode.java:run(1454)) - DatanodeRegistration(127.0.0.1:51305, storageID=DS-483458649-127.0.1.1-51305-1294058381583, infoPort=35823, ipcPort=54394):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-01-03 12:39:52,508 INFO ipc.Server (Server.java:stop(1611)) - Stopping server on 54394 [junit] 2011-01-03 12:39:52,508 INFO datanode.DataNode (DataNode.java:shutdown(780)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2011-01-03 12:39:52,508 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2011-01-03 12:39:52,508 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2011-01-03 12:39:52,509 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2011-01-03 12:39:52,511 WARN namenode.FSNamesystem (FSNamesystem.java:run(2822)) - ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 2011-01-03 12:39:52,511 INFO namenode.FSEditLog (FSEditLog.java:printStatistics(631)) - Number of transactions: 6 Total time for transactions(ms): 1Number of transactions batched in Syncs: 0 Number of syncs: 3 SyncTimes(ms): 7 3 [junit] 2011-01-03 12:39:52,511 WARN namenode.DecommissionManager (DecommissionManager.java:run(70)) - Monitor interrupted: java.lang.InterruptedException: sleep interrupted [junit] 2011-01-03 12:39:52,513 INFO ipc.Server (Server.java:stop(1611)) - Stopping server on 53690 [junit] 2011-01-03 12:39:52,513 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 53690: exiting [junit] 2011-01-03 12:39:52,513 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 53690 [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 9 on 53690: exiting [junit] 2011-01-03 12:39:52,513 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 1 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 4 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 3 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 8 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 7 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 5 on 53690: exiting [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 6 on 53690: exiting [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 36.218 sec [junit] 2011-01-03 12:39:52,514 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 2 on 53690: exiting [junit] 2011-01-03 12:39:52,513 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder 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:735: Tests failed! Total time: 67 minutes 29 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.server.datanode.TestBlockReport.blockReport_09 Error Message: Wrong number of PendingReplication blocks expected:<2> but was:<1> Stack Trace: junit.framework.AssertionFailedError: Wrong number of PendingReplication blocks expected:<2> but was:<1> at org.apache.hadoop.hdfs.server.datanode.TestBlockReport.__CLR3_0_2fte182qis(TestBlockReport.java:457) at org.apache.hadoop.hdfs.server.datanode.TestBlockReport.blockReport_09(TestBlockReport.java:429) FAILED: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorTransferToVerySmallWrite Error Message: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data1/current/VERSION (Too many open files) Stack Trace: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/data/data1/current/VERSION (Too many open files) at java.io.RandomAccessFile.open(Native Method) at java.io.RandomAccessFile.<init>(RandomAccessFile.java:212) at org.apache.hadoop.hdfs.server.common.Storage$StorageDirectory.write(Storage.java:265) at org.apache.hadoop.hdfs.server.common.Storage$StorageDirectory.write(Storage.java:259) at org.apache.hadoop.hdfs.server.common.Storage.writeAll(Storage.java:800) at org.apache.hadoop.hdfs.server.datanode.DataNode.register(DataNode.java:708) at org.apache.hadoop.hdfs.server.datanode.DataNode.runDatanodeDaemon(DataNode.java:1464) at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:644) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:464) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:186) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:71) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:178) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.setUp(TestFileConcurrentReader.java:73) FAILED: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorNormalTransfer Error Message: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) Stack Trace: java.lang.RuntimeException: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) at org.apache.hadoop.conf.Configuration.loadResource(Configuration.java:1523) at org.apache.hadoop.conf.Configuration.loadResources(Configuration.java:1388) at org.apache.hadoop.conf.Configuration.getProps(Configuration.java:1334) at org.apache.hadoop.conf.Configuration.set(Configuration.java:577) at org.apache.hadoop.fs.FileSystem.setDefaultUri(FileSystem.java:162) at org.apache.hadoop.fs.FileSystem.setDefaultUri(FileSystem.java:170) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:430) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:186) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:71) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:178) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.setUp(TestFileConcurrentReader.java:73) Caused by: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) at java.io.FileInputStream.open(Native Method) at java.io.FileInputStream.<init>(FileInputStream.java:106) at java.io.FileInputStream.<init>(FileInputStream.java:66) at sun.net.www.protocol.file.FileURLConnection.connect(FileURLConnection.java:70) at sun.net.www.protocol.file.FileURLConnection.getInputStream(FileURLConnection.java:161) at com.sun.org.apache.xerces.internal.impl.XMLEntityManager.setupCurrentEntity(XMLEntityManager.java:653) at com.sun.org.apache.xerces.internal.impl.XMLVersionDetector.determineDocVersion(XMLVersionDetector.java:186) at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:771) at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:737) at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:107) at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:225) at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:283) at javax.xml.parsers.DocumentBuilder.parse(DocumentBuilder.java:180) at org.apache.hadoop.conf.Configuration.loadResource(Configuration.java:1437) FAILED: org.apache.hadoop.hdfs.TestFileConcurrentReader.testUnfinishedBlockCRCErrorNormalTransferVerySmallWrite Error Message: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) Stack Trace: java.lang.RuntimeException: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) at org.apache.hadoop.conf.Configuration.loadResource(Configuration.java:1523) at org.apache.hadoop.conf.Configuration.loadResources(Configuration.java:1388) at org.apache.hadoop.conf.Configuration.getProps(Configuration.java:1334) at org.apache.hadoop.conf.Configuration.set(Configuration.java:577) at org.apache.hadoop.fs.FileSystem.setDefaultUri(FileSystem.java:162) at org.apache.hadoop.fs.FileSystem.setDefaultUri(FileSystem.java:170) at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:430) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:186) at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:71) at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:178) at org.apache.hadoop.hdfs.TestFileConcurrentReader.init(TestFileConcurrentReader.java:88) at org.apache.hadoop.hdfs.TestFileConcurrentReader.setUp(TestFileConcurrentReader.java:73) Caused by: java.io.FileNotFoundException: /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/classes/hdfs-default.xml (Too many open files) at java.io.FileInputStream.open(Native Method) at java.io.FileInputStream.<init>(FileInputStream.java:106) at java.io.FileInputStream.<init>(FileInputStream.java:66) at sun.net.www.protocol.file.FileURLConnection.connect(FileURLConnection.java:70) at sun.net.www.protocol.file.FileURLConnection.getInputStream(FileURLConnection.java:161) at com.sun.org.apache.xerces.internal.impl.XMLEntityManager.setupCurrentEntity(XMLEntityManager.java:653) at com.sun.org.apache.xerces.internal.impl.XMLVersionDetector.determineDocVersion(XMLVersionDetector.java:186) at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:771) at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:737) at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:107) at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:225) at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:283) at javax.xml.parsers.DocumentBuilder.parse(DocumentBuilder.java:180) at org.apache.hadoop.conf.Configuration.loadResource(Configuration.java:1437) FAILED: org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore Error Message: Image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/secondary/current/fsimage is corrupt with MD5 checksum of 462b27937407135e43f15ebf6ead87b9 but expecting b659cdd70d61db55bd72d7758e870761 Stack Trace: java.io.IOException: Image file /grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build/test/data/dfs/secondary/current/fsimage is corrupt with MD5 checksum of 462b27937407135e43f15ebf6ead87b9 but expecting b659cdd70d61db55bd72d7758e870761 at org.apache.hadoop.hdfs.server.namenode.FSImage.loadFSImage(FSImage.java:1063) at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.doMerge(SecondaryNameNode.java:702) at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode$CheckpointStorage.access$500(SecondaryNameNode.java:600) at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doMerge(SecondaryNameNode.java:477) at org.apache.hadoop.hdfs.server.namenode.SecondaryNameNode.doCheckpoint(SecondaryNameNode.java:438) at org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.__CLR3_0_2dn2tm4tjs(TestStorageRestore.java:316) at org.apache.hadoop.hdfs.server.namenode.TestStorageRestore.testStorageRestore(TestStorageRestore.java:286)