See <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/468/changes>
Changes: [gkesavan] HADOOP-7007: Update the hudson-test-patch ant target. Contributed by Giridharan Kesavan. [gkesavan] HADOOP-7007: Update the hudson-test-patch ant target. Contributed by Giridharan Kesavan. [nigel] HADOOP-7005: Update test-patch.sh to remove callback to Hudson master. Contributed by nigel. ------------------------------------------ [...truncated 689187 lines...] [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at java.io.DataOutputStream.writeLong(DataOutputStream.java:207) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:542) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] 2010-10-26 14:54:39,072 WARN datanode.DataNode (DataNode.java:checkDiskError(828)) - checkDiskError: exception: [junit] java.io.IOException: Connection reset by peer [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at java.io.DataOutputStream.writeLong(DataOutputStream.java:207) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:542) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] 2010-10-26 14:54:39,074 INFO datanode.DataNode (BlockReceiver.java:run(955)) - PacketResponder blk_-3200216660841758636_1001 2 Exception java.io.IOException: Connection reset by peer [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at java.io.DataOutputStream.writeLong(DataOutputStream.java:207) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:542) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] [junit] 2010-10-26 14:54:39,074 INFO datanode.DataNode (BlockReceiver.java:run(971)) - PacketResponder 2 for block blk_-3200216660841758636_1001 terminating [junit] 2010-10-26 14:54:39,075 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:52042, storageID=DS-1150598151-127.0.1.1-52042-1288104868905, infoPort=37934, ipcPort=53310) [junit] 2010-10-26 14:54:39,075 WARN datanode.DataNode (BlockReceiver.java:run(948)) - IOException in BlockReceiver.run(): [junit] java.io.IOException: Connection reset by peer [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:105) [junit] at java.io.DataOutputStream.writeShort(DataOutputStream.java:150) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:543) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] 2010-10-26 14:54:39,076 WARN datanode.DataNode (DataNode.java:checkDiskError(828)) - checkDiskError: exception: [junit] java.io.IOException: Connection reset by peer [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:105) [junit] at java.io.DataOutputStream.writeShort(DataOutputStream.java:150) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:543) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] 2010-10-26 14:54:39,076 INFO datanode.DataNode (BlockReceiver.java:run(955)) - PacketResponder blk_-3200216660841758636_1001 1 Exception java.io.IOException: Connection reset by peer [junit] at sun.nio.ch.FileDispatcher.write0(Native Method) [junit] at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29) [junit] at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104) [junit] at sun.nio.ch.IOUtil.write(IOUtil.java:75) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:60) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:151) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:112) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:105) [junit] at java.io.DataOutputStream.writeShort(DataOutputStream.java:150) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:543) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody0(BlockReceiver.java:931) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.write_aroundBody1$advice(BlockReceiver.java:160) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver$PacketResponder.run(BlockReceiver.java:931) [junit] at java.lang.Thread.run(Thread.java:619) [junit] [junit] 2010-10-26 14:54:39,076 INFO datanode.DataNode (BlockReceiver.java:run(971)) - PacketResponder 1 for block blk_-3200216660841758636_1001 terminating [junit] 2010-10-26 14:54:39,075 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:52042, storageID=DS-1150598151-127.0.1.1-52042-1288104868905, infoPort=37934, ipcPort=53310) [junit] 2010-10-26 14:54:39,077 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:44602, storageID=DS-610067579-127.0.1.1-44602-1288104868380, infoPort=42123, ipcPort=38023) [junit] 2010-10-26 14:54:39,076 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$afterReturning$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$1$8f59fdd7(51)) - FI: receiverOp WRITE_BLOCK, datanode=127.0.0.1:52042 [junit] 2010-10-26 14:54:39,078 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:44602, storageID=DS-610067579-127.0.1.1-44602-1288104868380, infoPort=42123, ipcPort=38023) [junit] 2010-10-26 14:54:39,078 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$before$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$3$3251489(73)) - FI: receiverOpWriteBlock [junit] 2010-10-26 14:54:39,079 INFO datanode.DataNode (DataXceiver.java:opWriteBlock(231)) - Receiving block blk_-3200216660841758636_1001 src: /127.0.0.1:47690 dest: /127.0.0.1:52042 [junit] 2010-10-26 14:54:39,079 INFO datanode.DataNode (FSDataset.java:recoverClose(1246)) - Recover failed close blk_-3200216660841758636_1001 [junit] 2010-10-26 14:54:39,080 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$afterReturning$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$1$8f59fdd7(51)) - FI: receiverOp WRITE_BLOCK, datanode=127.0.0.1:44602 [junit] 2010-10-26 14:54:39,080 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$before$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$3$3251489(73)) - FI: receiverOpWriteBlock [junit] 2010-10-26 14:54:39,080 INFO datanode.DataNode (DataXceiver.java:opWriteBlock(231)) - Receiving block blk_-3200216660841758636_1001 src: /127.0.0.1:40770 dest: /127.0.0.1:44602 [junit] 2010-10-26 14:54:39,081 INFO datanode.DataNode (FSDataset.java:recoverClose(1246)) - Recover failed close blk_-3200216660841758636_1001 [junit] 2010-10-26 14:54:39,081 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$afterReturning$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$2$d4f6605f(61)) - FI: statusRead SUCCESS, datanode=127.0.0.1:52042 [junit] 2010-10-26 14:54:39,082 INFO datanode.DataNode (DataXceiver.java:opWriteBlock(380)) - Received block blk_-3200216660841758636_1002 src: /127.0.0.1:40770 dest: /127.0.0.1:44602 of size 1 [junit] 2010-10-26 14:54:39,082 INFO datanode.DataNode (DataXceiver.java:opWriteBlock(380)) - Received block blk_-3200216660841758636_1002 src: /127.0.0.1:47690 dest: /127.0.0.1:52042 of size 1 [junit] 2010-10-26 14:54:39,083 INFO hdfs.StateChange (BlockManager.java:addStoredBlock(1126)) - BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:44602 is added to blk_-3200216660841758636_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[127.0.0.1:52042|RBW], ReplicaUnderConstruction[127.0.0.1:44602|RBW], ReplicaUnderConstruction[127.0.0.1:50651|RBW]]} size 0 [junit] 2010-10-26 14:54:39,084 INFO namenode.FSNamesystem (FSNamesystem.java:updatePipeline(4553)) - updatePipeline(block=blk_-3200216660841758636_1001, newGenerationStamp=1002, newLength=1, newNodes=[127.0.0.1:52042, 127.0.0.1:44602], clientName=DFSClient_-1910110805) [junit] 2010-10-26 14:54:39,086 INFO namenode.FSNamesystem (FSNamesystem.java:updatePipeline(4595)) - updatePipeline(blk_-3200216660841758636_1001) successfully to blk_-3200216660841758636_1002 [junit] 2010-10-26 14:54:39,086 INFO hdfs.StateChange (BlockManager.java:addStoredBlock(1126)) - BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:52042 is added to blk_-3200216660841758636_1002{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[127.0.0.1:52042|RBW], ReplicaUnderConstruction[127.0.0.1:44602|RBW]]} size 1 [junit] 2010-10-26 14:54:39,089 INFO hdfs.StateChange (FSNamesystem.java:completeFileInternal(1713)) - DIR* NameSystem.completeFile: file /pipeline_Fi_38/foo is closed by DFSClient_-1910110805 [junit] 2010-10-26 14:54:39,091 INFO FSNamesystem.audit (FSNamesystem.java:logAuditEvent(148)) - ugi=hudson ip=/127.0.0.1 cmd=open src=/pipeline_Fi_38/foo dst=null perm=null [junit] 2010-10-26 14:54:39,093 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$afterReturning$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$1$8f59fdd7(51)) - FI: receiverOp READ_BLOCK, datanode=127.0.0.1:44602 [junit] Shutting down the Mini HDFS Cluster [junit] 2010-10-26 14:54:39,094 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772)) - Shutting down DataNode 2 [junit] 2010-10-26 14:54:39,094 INFO DataNode.clienttrace (BlockSender.java:sendBlock(490)) - src: /127.0.0.1:44602, dest: /127.0.0.1:40771, bytes: 5, op: HDFS_READ, cliID: DFSClient_-1910110805, offset: 0, srvID: DS-610067579-127.0.1.1-44602-1288104868380, blockid: blk_-3200216660841758636_1002, duration: 264115 [junit] 2010-10-26 14:54:39,095 INFO datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$afterReturning$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$2$d4f6605f(61)) - FI: statusRead CHECKSUM_OK, datanode=127.0.0.1:44602 [junit] 2010-10-26 14:54:39,196 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 53310 [junit] 2010-10-26 14:54:39,197 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 53310: exiting [junit] 2010-10-26 14:54:39,197 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 53310 [junit] 2010-10-26 14:54:39,197 WARN datanode.DataNode (DataXceiverServer.java:run(140)) - DatanodeRegistration(127.0.0.1:52042, storageID=DS-1150598151-127.0.1.1-52042-1288104868905, infoPort=37934, ipcPort=53310):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:133) [junit] at java.lang.Thread.run(Thread.java:619) [junit] [junit] 2010-10-26 14:54:39,197 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 1 [junit] 2010-10-26 14:54:39,197 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2010-10-26 14:54:39,198 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(621)) - Exiting DataBlockScanner thread. [junit] 2010-10-26 14:54:39,199 INFO datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:52042, storageID=DS-1150598151-127.0.1.1-52042-1288104868905, infoPort=37934, ipcPort=53310):Finishing DataNode in: FSDataset{dirpath='<https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build-fi/test/data/dfs/data/data5/current/finalized,/grid/0/hudson/hudson-slave/workspace/Hadoop-Hdfs-trunk/trunk/build-fi/test/data/dfs/data/data6/current/finalized'}> [junit] 2010-10-26 14:54:39,199 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 53310 [junit] 2010-10-26 14:54:39,199 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2010-10-26 14:54:39,199 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2010-10-26 14:54:39,199 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2010-10-26 14:54:39,200 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2010-10-26 14:54:39,200 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772)) - Shutting down DataNode 1 [junit] 2010-10-26 14:54:39,202 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 56210 [junit] 2010-10-26 14:54:39,202 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 56210: exiting [junit] 2010-10-26 14:54:39,203 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 56210 [junit] 2010-10-26 14:54:39,203 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2010-10-26 14:54:39,203 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:50651, storageID=DS-1047562687-127.0.1.1-50651-1288104868651, infoPort=40209, ipcPort=56210) [junit] 2010-10-26 14:54:39,203 INFO datanode.BlockReceiverAspects (BlockReceiverAspects.aj:ajc$after$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$9$725950a6(220)) - FI: blockFileClose, datanode=DatanodeRegistration(127.0.0.1:50651, storageID=DS-1047562687-127.0.1.1-50651-1288104868651, infoPort=40209, ipcPort=56210) [junit] 2010-10-26 14:54:39,203 INFO datanode.DataNode (BlockReceiver.java:run(886)) - PacketResponder blk_-3200216660841758636_1001 0 : Thread is interrupted. [junit] 2010-10-26 14:54:39,203 WARN datanode.DataNode (DataXceiverServer.java:run(140)) - DatanodeRegistration(127.0.0.1:50651, storageID=DS-1047562687-127.0.1.1-50651-1288104868651, infoPort=40209, ipcPort=56210):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:133) [junit] at java.lang.Thread.run(Thread.java:619) [junit] [junit] 2010-10-26 14:54:39,203 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 3 [junit] 2010-10-26 14:54:39,204 INFO datanode.DataNode (BlockReceiver.java:run(971)) - PacketResponder 0 for block blk_-3200216660841758636_1001 terminating [junit] 2010-10-26 14:54:39,204 ERROR datanode.DataNode (DataXceiver.java:run(116)) - DatanodeRegistration(127.0.0.1:50651, storageID=DS-1047562687-127.0.1.1-50651-1288104868651, infoPort=40209, ipcPort=56210):DataXceiver [junit] java.lang.RuntimeException: java.lang.InterruptedException: sleep interrupted [junit] at org.apache.hadoop.fi.FiTestUtil.sleep(FiTestUtil.java:82) [junit] at org.apache.hadoop.fi.DataTransferTestUtil$SleepAction.run(DataTransferTestUtil.java:346) [junit] at org.apache.hadoop.fi.DataTransferTestUtil$SleepAction.run(DataTransferTestUtil.java:1) [junit] at org.apache.hadoop.fi.FiTestUtil$ActionContainer.run(FiTestUtil.java:116) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiverAspects.ajc$before$org_apache_hadoop_hdfs_server_datanode_BlockReceiverAspects$7$b9c2bffe(BlockReceiverAspects.aj:193) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver.receivePacket(BlockReceiver.java:437) [junit] at org.apache.hadoop.hdfs.server.datanode.BlockReceiver.receiveBlock(BlockReceiver.java:625) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiver.opWriteBlock(DataXceiver.java:363) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$Receiver.opWriteBlock(DataTransferProtocol.java:389) [junit] at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$Receiver.processOp(DataTransferProtocol.java:331) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiver.run(DataXceiver.java:114) [junit] at java.lang.Thread.run(Thread.java:619) [junit] Caused by: java.lang.InterruptedException: sleep interrupted [junit] at java.lang.Thread.sleep(Native Method) [junit] at org.apache.hadoop.fi.FiTestUtil.sleep(FiTestUtil.java:80) [junit] ... 11 more [junit] 2010-10-26 14:54:39,206 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2010-10-26 14:54:39,207 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(621)) - Exiting DataBlockScanner thread. [junit] 2010-10-26 14:54:39,207 INFO datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:50651, storageID=DS-1047562687-127.0.1.1-50651-1288104868651, infoPort=40209, ipcPort=56210):Finishing DataNode in: FSDataset{dirpath='<https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/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] 2010-10-26 14:54:39,207 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 56210 [junit] 2010-10-26 14:54:39,207 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2010-10-26 14:54:39,208 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2010-10-26 14:54:39,208 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2010-10-26 14:54:39,208 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2010-10-26 14:54:39,208 INFO hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772)) - Shutting down DataNode 0 [junit] 2010-10-26 14:54:39,310 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 38023 [junit] 2010-10-26 14:54:39,310 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 38023: exiting [junit] 2010-10-26 14:54:39,311 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 38023 [junit] 2010-10-26 14:54:39,311 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2010-10-26 14:54:39,311 WARN datanode.DataNode (DataXceiverServer.java:run(140)) - DatanodeRegistration(127.0.0.1:44602, storageID=DS-610067579-127.0.1.1-44602-1288104868380, infoPort=42123, ipcPort=38023):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:133) [junit] at java.lang.Thread.run(Thread.java:619) [junit] [junit] 2010-10-26 14:54:39,311 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 1 [junit] 2010-10-26 14:54:39,404 INFO datanode.DataBlockScanner (DataBlockScanner.java:run(621)) - Exiting DataBlockScanner thread. [junit] 2010-10-26 14:54:39,412 INFO datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:44602, storageID=DS-610067579-127.0.1.1-44602-1288104868380, infoPort=42123, ipcPort=38023):Finishing DataNode in: FSDataset{dirpath='<https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/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] 2010-10-26 14:54:39,412 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 38023 [junit] 2010-10-26 14:54:39,412 INFO datanode.DataNode (DataNode.java:shutdown(768)) - Waiting for threadgroup to exit, active threads is 0 [junit] 2010-10-26 14:54:39,413 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133)) - Shutting down all async disk service threads... [junit] 2010-10-26 14:54:39,413 INFO datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142)) - All async disk service threads have been shut down. [junit] 2010-10-26 14:54:39,413 WARN datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130)) - AsyncDiskService has already shut down. [junit] 2010-10-26 14:54:39,515 WARN namenode.FSNamesystem (FSNamesystem.java:run(2818)) - ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 2010-10-26 14:54:39,515 WARN namenode.DecommissionManager (DecommissionManager.java:run(70)) - Monitor interrupted: java.lang.InterruptedException: sleep interrupted [junit] 2010-10-26 14:54:39,516 INFO namenode.FSNamesystem (FSEditLog.java:printStatistics(1122)) - Number of transactions: 6 Total time for transactions(ms): 3Number of transactions batched in Syncs: 0 Number of syncs: 3 SyncTimes(ms): 9 4 [junit] 2010-10-26 14:54:39,517 INFO ipc.Server (Server.java:stop(1601)) - Stopping server on 38112 [junit] 2010-10-26 14:54:39,517 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 7 on 38112: exiting [junit] 2010-10-26 14:54:39,517 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 4 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 1 on 38112: exiting [junit] 2010-10-26 14:54:39,517 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 3 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 2 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 6 on 38112: exiting [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 88.556 sec [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(475)) - Stopping IPC Server listener on 38112 [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 9 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 8 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(675)) - Stopping IPC Server Responder [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 0 on 38112: exiting [junit] 2010-10-26 14:54:39,518 INFO ipc.Server (Server.java:run(1444)) - IPC Server handler 5 on 38112: exiting checkfailure: [touch] Creating <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build-fi/test/testsfailed> BUILD FAILED <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:706: The following error occurred while executing this line: <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:473: The following error occurred while executing this line: <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/src/test/aop/build/aop.xml>:230: The following error occurred while executing this line: <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:664: The following error occurred while executing this line: <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:621: The following error occurred while executing this line: <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:689: Tests failed! Total time: 201 minutes 4 seconds Publishing Javadoc Archiving artifacts Recording test results Recording fingerprints Publishing Clover coverage report... No Clover report will be published due to a Build Failure