hadoop-hdfs-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Hudson Server <hud...@hudson.apache.org>
Subject Build failed in Hudson: Hadoop-Hdfs-trunk #469
Date Wed, 27 Oct 2010 15:29:38 GMT
See <https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/469/>

------------------------------------------
[...truncated 733476 lines...]
    [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-27 15:29:53,500 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-27 15:29:53,502 INFO  datanode.DataNode (BlockReceiver.java:run(955))
- PacketResponder blk_-243544281360926144_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-27 15:29:53,503 INFO  datanode.DataNode (BlockReceiver.java:run(971))
- PacketResponder 2 for block blk_-243544281360926144_1001 terminating
    [junit] 2010-10-27 15:29:53,503 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:49098, storageID=DS-1073259287-127.0.1.1-49098-1288193383435,
infoPort=52401, ipcPort=35550)
    [junit] 2010-10-27 15:29:53,503 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:49098
    [junit] 2010-10-27 15:29:53,503 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$Status.write(DataTransferProtocol.java:120)
    [junit] 	at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:545)
    [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-27 15:29:53,504 INFO  datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$before$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$3$3251489(73))
- FI: receiverOpWriteBlock
    [junit] 2010-10-27 15:29:53,504 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:49098, storageID=DS-1073259287-127.0.1.1-49098-1288193383435,
infoPort=52401, ipcPort=35550)
    [junit] 2010-10-27 15:29:53,505 INFO  datanode.DataNode (DataXceiver.java:opWriteBlock(231))
- Receiving block blk_-243544281360926144_1001 src: /127.0.0.1:43967 dest: /127.0.0.1:49098
    [junit] 2010-10-27 15:29:53,504 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$Status.write(DataTransferProtocol.java:120)
    [junit] 	at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:545)
    [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-27 15:29:53,505 INFO  datanode.DataNode (FSDataset.java:recoverClose(1246))
- Recover failed close blk_-243544281360926144_1001
    [junit] 2010-10-27 15:29:53,506 INFO  datanode.DataNode (BlockReceiver.java:run(955))
- PacketResponder blk_-243544281360926144_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$Status.write(DataTransferProtocol.java:120)
    [junit] 	at org.apache.hadoop.hdfs.protocol.DataTransferProtocol$PipelineAck.write(DataTransferProtocol.java:545)
    [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-27 15:29:53,506 INFO  datanode.DataNode (BlockReceiver.java:run(971))
- PacketResponder 1 for block blk_-243544281360926144_1001 terminating
    [junit] 2010-10-27 15:29:53,506 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:40332, storageID=DS-1891322547-127.0.1.1-40332-1288193382910,
infoPort=52737, ipcPort=46068)
    [junit] 2010-10-27 15:29:53,507 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:40332, storageID=DS-1891322547-127.0.1.1-40332-1288193382910,
infoPort=52737, ipcPort=46068)
    [junit] 2010-10-27 15:29:53,507 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:40332
    [junit] 2010-10-27 15:29:53,509 INFO  datanode.DataTransferProtocolAspects (DataTransferProtocolAspects.aj:ajc$before$org_apache_hadoop_hdfs_server_datanode_DataTransferProtocolAspects$3$3251489(73))
- FI: receiverOpWriteBlock
    [junit] 2010-10-27 15:29:53,509 INFO  datanode.DataNode (DataXceiver.java:opWriteBlock(231))
- Receiving block blk_-243544281360926144_1001 src: /127.0.0.1:45284 dest: /127.0.0.1:40332
    [junit] 2010-10-27 15:29:53,509 INFO  datanode.DataNode (FSDataset.java:recoverClose(1246))
- Recover failed close blk_-243544281360926144_1001
    [junit] 2010-10-27 15:29:53,509 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:49098
    [junit] 2010-10-27 15:29:53,510 INFO  datanode.DataNode (DataXceiver.java:opWriteBlock(380))
- Received block blk_-243544281360926144_1002 src: /127.0.0.1:45284 dest: /127.0.0.1:40332
of size 1
    [junit] 2010-10-27 15:29:53,511 INFO  datanode.DataNode (DataXceiver.java:opWriteBlock(380))
- Received block blk_-243544281360926144_1002 src: /127.0.0.1:43967 dest: /127.0.0.1:49098
of size 1
    [junit] 2010-10-27 15:29:53,511 INFO  hdfs.StateChange (BlockManager.java:addStoredBlock(1126))
- BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:40332 is added to blk_-243544281360926144_1001{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[127.0.0.1:49098|RBW], ReplicaUnderConstruction[127.0.0.1:40332|RBW],
ReplicaUnderConstruction[127.0.0.1:59861|RBW]]} size 0
    [junit] 2010-10-27 15:29:53,512 INFO  namenode.FSNamesystem (FSNamesystem.java:updatePipeline(4553))
- updatePipeline(block=blk_-243544281360926144_1001, newGenerationStamp=1002, newLength=1,
newNodes=[127.0.0.1:49098, 127.0.0.1:40332], clientName=DFSClient_-1642891333)
    [junit] 2010-10-27 15:29:53,514 INFO  namenode.FSNamesystem (FSNamesystem.java:updatePipeline(4595))
- updatePipeline(blk_-243544281360926144_1001) successfully to blk_-243544281360926144_1002
    [junit] 2010-10-27 15:29:53,514 INFO  hdfs.StateChange (BlockManager.java:addStoredBlock(1126))
- BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:49098 is added to blk_-243544281360926144_1002{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[127.0.0.1:49098|RBW], ReplicaUnderConstruction[127.0.0.1:40332|RBW]]}
size 1
    [junit] 2010-10-27 15:29:53,517 INFO  hdfs.StateChange (FSNamesystem.java:completeFileInternal(1713))
- DIR* NameSystem.completeFile: file /pipeline_Fi_38/foo is closed by DFSClient_-1642891333
    [junit] 2010-10-27 15:29:53,520 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-27 15:29:53,522 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:49098
    [junit] Shutting down the Mini HDFS Cluster
    [junit] 2010-10-27 15:29:53,523 INFO  hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772))
- Shutting down DataNode 2
    [junit] 2010-10-27 15:29:53,523 INFO  DataNode.clienttrace (BlockSender.java:sendBlock(490))
- src: /127.0.0.1:49098, dest: /127.0.0.1:43969, bytes: 5, op: HDFS_READ, cliID: DFSClient_-1642891333,
offset: 0, srvID: DS-1073259287-127.0.1.1-49098-1288193383435, blockid: blk_-243544281360926144_1002,
duration: 276445
    [junit] 2010-10-27 15:29:53,524 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:49098
    [junit] 2010-10-27 15:29:53,625 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 35550
    [junit] 2010-10-27 15:29:53,625 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 0 on 35550: exiting
    [junit] 2010-10-27 15:29:53,625 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC
Server listener on 35550
    [junit] 2010-10-27 15:29:53,626 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 1
    [junit] 2010-10-27 15:29:53,625 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC
Server Responder
    [junit] 2010-10-27 15:29:53,626 WARN  datanode.DataNode (DataXceiverServer.java:run(140))
- DatanodeRegistration(127.0.0.1:49098, storageID=DS-1073259287-127.0.1.1-49098-1288193383435,
infoPort=52401, ipcPort=35550):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-27 15:29:53,628 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,629 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(621))
- Exiting DataBlockScanner thread.
    [junit] 2010-10-27 15:29:53,629 INFO  datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:49098,
storageID=DS-1073259287-127.0.1.1-49098-1288193383435, infoPort=52401, ipcPort=35550):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-27 15:29:53,629 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 35550
    [junit] 2010-10-27 15:29:53,629 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,630 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133))
- Shutting down all async disk service threads...
    [junit] 2010-10-27 15:29:53,630 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142))
- All async disk service threads have been shut down.
    [junit] 2010-10-27 15:29:53,630 WARN  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130))
- AsyncDiskService has already shut down.
    [junit] 2010-10-27 15:29:53,631 INFO  hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772))
- Shutting down DataNode 1
    [junit] 2010-10-27 15:29:53,732 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 60169
    [junit] 2010-10-27 15:29:53,733 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 0 on 60169: exiting
    [junit] 2010-10-27 15:29:53,733 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC
Server Responder
    [junit] 2010-10-27 15:29:53,733 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC
Server listener on 60169
    [junit] 2010-10-27 15:29:53,734 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 3
    [junit] 2010-10-27 15:29:53,734 INFO  datanode.DataNode (BlockReceiver.java:run(886))
- PacketResponder blk_-243544281360926144_1001 0 : Thread is interrupted.
    [junit] 2010-10-27 15:29:53,733 WARN  datanode.DataNode (DataXceiverServer.java:run(140))
- DatanodeRegistration(127.0.0.1:59861, storageID=DS-1693914179-127.0.1.1-59861-1288193383175,
infoPort=35785, ipcPort=60169):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-27 15:29:53,734 INFO  datanode.DataNode (BlockReceiver.java:run(971))
- PacketResponder 0 for block blk_-243544281360926144_1001 terminating
    [junit] 2010-10-27 15:29:53,734 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:59861, storageID=DS-1693914179-127.0.1.1-59861-1288193383175,
infoPort=35785, ipcPort=60169)
    [junit] 2010-10-27 15:29:53,735 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:59861, storageID=DS-1693914179-127.0.1.1-59861-1288193383175,
infoPort=35785, ipcPort=60169)
    [junit] 2010-10-27 15:29:53,735 ERROR datanode.DataNode (DataXceiver.java:run(116)) -
DatanodeRegistration(127.0.0.1:59861, storageID=DS-1693914179-127.0.1.1-59861-1288193383175,
infoPort=35785, ipcPort=60169):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-27 15:29:53,736 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,736 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(621))
- Exiting DataBlockScanner thread.
    [junit] 2010-10-27 15:29:53,737 INFO  datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:59861,
storageID=DS-1693914179-127.0.1.1-59861-1288193383175, infoPort=35785, ipcPort=60169):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-27 15:29:53,737 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 60169
    [junit] 2010-10-27 15:29:53,737 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,738 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133))
- Shutting down all async disk service threads...
    [junit] 2010-10-27 15:29:53,738 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142))
- All async disk service threads have been shut down.
    [junit] 2010-10-27 15:29:53,738 WARN  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130))
- AsyncDiskService has already shut down.
    [junit] 2010-10-27 15:29:53,738 INFO  hdfs.MiniDFSCluster (MiniDFSCluster.java:shutdownDataNodes(772))
- Shutting down DataNode 0
    [junit] 2010-10-27 15:29:53,840 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 46068
    [junit] 2010-10-27 15:29:53,840 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 0 on 46068: exiting
    [junit] 2010-10-27 15:29:53,840 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC
Server listener on 46068
    [junit] 2010-10-27 15:29:53,841 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 1
    [junit] 2010-10-27 15:29:53,841 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC
Server Responder
    [junit] 2010-10-27 15:29:53,841 WARN  datanode.DataNode (DataXceiverServer.java:run(140))
- DatanodeRegistration(127.0.0.1:40332, storageID=DS-1891322547-127.0.1.1-40332-1288193382910,
infoPort=52737, ipcPort=46068):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-27 15:29:53,843 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,933 INFO  datanode.DataBlockScanner (DataBlockScanner.java:run(621))
- Exiting DataBlockScanner thread.
    [junit] 2010-10-27 15:29:53,944 INFO  datanode.DataNode (DataNode.java:run(1443)) - DatanodeRegistration(127.0.0.1:40332,
storageID=DS-1891322547-127.0.1.1-40332-1288193382910, infoPort=52737, ipcPort=46068):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-27 15:29:53,944 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 46068
    [junit] 2010-10-27 15:29:53,944 INFO  datanode.DataNode (DataNode.java:shutdown(768))
- Waiting for threadgroup to exit, active threads is 0
    [junit] 2010-10-27 15:29:53,944 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(133))
- Shutting down all async disk service threads...
    [junit] 2010-10-27 15:29:53,944 INFO  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(142))
- All async disk service threads have been shut down.
    [junit] 2010-10-27 15:29:53,945 WARN  datanode.FSDatasetAsyncDiskService (FSDatasetAsyncDiskService.java:shutdown(130))
- AsyncDiskService has already shut down.
    [junit] 2010-10-27 15:29:54,047 WARN  namenode.FSNamesystem (FSNamesystem.java:run(2818))
- ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException:
sleep interrupted
    [junit] 2010-10-27 15:29:54,047 INFO  namenode.FSNamesystem (FSEditLog.java:printStatistics(1122))
- Number of transactions: 6 Total time for transactions(ms): 1Number of transactions batched
in Syncs: 0 Number of syncs: 3 SyncTimes(ms): 6 3 
    [junit] 2010-10-27 15:29:54,047 WARN  namenode.DecommissionManager (DecommissionManager.java:run(70))
- Monitor interrupted: java.lang.InterruptedException: sleep interrupted
    [junit] 2010-10-27 15:29:54,048 INFO  ipc.Server (Server.java:stop(1601)) - Stopping server
on 54019
    [junit] 2010-10-27 15:29:54,048 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 0 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(475)) - Stopping IPC
Server listener on 54019
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 2 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 3 on 54019: exiting
    [junit] 2010-10-27 15:29:54,048 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 1 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 6 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 4 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 9 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 5 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 7 on 54019: exiting
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(675)) - Stopping IPC
Server Responder
    [junit] 2010-10-27 15:29:54,049 INFO  ipc.Server (Server.java:run(1444)) - IPC Server
handler 8 on 54019: exiting
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 46.499 sec

checkfailure:

run-test-hdfs-all-withtestcaseonly:

run-test-hdfs:

BUILD FAILED
<https://hudson.apache.org/hudson/job/Hadoop-Hdfs-trunk/ws/trunk/build.xml>:708: Tests
failed!

Total time: 236 minutes 18 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


Mime
View raw message