[ 
https://issues.apache.org/jira/browse/HDFS-733?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12773347#action_12773347
 ] 

Konstantin Shvachko commented on HDFS-733:
------------------------------------------

Looks like Hudson did not change his opinion on this.
Looking at the log. Seems that replication has actually already happened by the 
time the tests starts waiting for the temporary replica.

{code}
2009-11-03 23:15:26,213 INFO  hdfs.StateChange 
(BlockManager.java:computeReplicationWorkForBlock(857)) - BLOCK* ask 
127.0.0.1:60191 to replicate blk_3759837087059880694_1001 to datanode(s) 
127.0.0.1:47781
2009-11-03 23:15:26,427 INFO  datanode.DataNode 
(DataNode.java:transferBlock(1072)) - DatanodeRegistration(127.0.0.1:60191, 
storageID=DS-681753498-127.0.1.1-60191-1257290123417, infoPort=54109, 
ipcPort=41992) Starting thread to transfer block blk_3759837087059880694_1001 
to 127.0.0.1:47781 
2009-11-03 23:15:26,431 INFO  datanode.DataNode 
(DataXceiver.java:opWriteBlock(224)) - Receiving block 
blk_3759837087059880694_1001 src: /127.0.0.1:38882 dest: /127.0.0.1:47781
2009-11-03 23:15:26,450 INFO  datanode.DataNode (DataNode.java:run(1265)) - 
DatanodeRegistration(127.0.0.1:60191, 
storageID=DS-681753498-127.0.1.1-60191-1257290123417, infoPort=54109, 
ipcPort=41992):Transmitted block blk_3759837087059880694_1001 to 
/127.0.0.1:47781
2009-11-03 23:15:26,458 DEBUG datanode.DataNode 
(BlockReceiver.java:receivePacket(443)) - Receiving one packet for block 
blk_3759837087059880694_1001 of length 0 seqno 3 offsetInBlock 3072000 
lastPacketInBlock true
2009-11-03 23:15:26,458 DEBUG datanode.DataNode 
(BlockReceiver.java:receivePacket(476)) - Receiving an empty packet or the end 
of the block blk_3759837087059880694_1001
2009-11-03 23:15:26,458 DEBUG datanode.DataNode (FSDataset.java:addBlock(136)) 
- addBlock: Moved 
/grid/0/hudson/hudson-slave/workspace/Hdfs-Patch-h5.grid.sp2.yahoo.net/trunk/build/test/data/dfs/data/data3/tmp/blk_3759837087059880694_1001.meta
 to 
/grid/0/hudson/hudson-slave/workspace/Hdfs-Patch-h5.grid.sp2.yahoo.net/trunk/build/test/data/dfs/data/data3/current/finalized/blk_3759837087059880694_1001.meta
2009-11-03 23:15:26,459 DEBUG datanode.DataNode (FSDataset.java:addBlock(137)) 
- addBlock: Moved 
/grid/0/hudson/hudson-slave/workspace/Hdfs-Patch-h5.grid.sp2.yahoo.net/trunk/build/test/data/dfs/data/data3/tmp/blk_3759837087059880694
 to 
/grid/0/hudson/hudson-slave/workspace/Hdfs-Patch-h5.grid.sp2.yahoo.net/trunk/build/test/data/dfs/data/data3/current/finalized/blk_3759837087059880694
2009-11-03 23:15:26,459 INFO  datanode.DataNode 
(DataXceiver.java:opWriteBlock(369)) - Received block 
blk_3759837087059880694_1001 src: /127.0.0.1:38882 dest: /127.0.0.1:47781 of 
size 3072000

2009-11-03 23:15:26,461 DEBUG hdfs.StateChange 
(FSNamesystem.java:blockReceived(2848)) - BLOCK* NameSystem.blockReceived: 
blk_3759837087059880694_1001 is received from 127.0.0.1:47781
2009-11-03 23:15:26,461 DEBUG namenode.FSNamesystem 
(PendingReplicationBlocks.java:remove(87)) - Removing pending replication for 
blockblk_3759837087059880694_1001
2009-11-03 23:15:26,461 DEBUG namenode.FSNamesystem 
(DatanodeDescriptor.java:processReportedBlock(466)) - Reported block 
blk_3759837087059880694_1001 on 127.0.0.1:47781 size 3072000 replicaState = 
FINALIZED
2009-11-03 23:15:26,462 INFO  hdfs.StateChange 
(BlockManager.java:addStoredBlock(1102)) - BLOCK* NameSystem.addStoredBlock: 
blockMap updated: 127.0.0.1:47781 is added to blk_3759837087059880694_1001 size 
3072000
{code}

And then you start waiting in the test:
{code}
2009-11-03 23:15:26,471 DEBUG datanode.TestBlockReport 
(TestBlockReport.java:prepareSecondReplica(600)) - Replica state before the 
loop 0
2009-11-03 23:15:26,571 DEBUG datanode.TestBlockReport 
(TestBlockReport.java:prepareSecondReplica(605)) - Keep waiting for 
blk_3759837087059880694 is in state 0
2009-11-03 23:15:26,671 DEBUG datanode.TestBlockReport 
(TestBlockReport.java:prepareSecondReplica(605)) - Keep waiting for 
blk_3759837087059880694 is in state 0
2009-11-03 23:15:26,772 DEBUG datanode.TestBlockReport 
(TestBlockReport.java:prepareSecondReplica(605)) - Keep waiting for 
blk_3759837087059880694 is in state 0
2009-11-03 23:15:26,872 DEBUG datanode.TestBlockReport 
(TestBlockReport.java:prepareSecondReplica(605)) - Keep waiting for 
blk_3759837087059880694 is in state 0
{code}

So waiting longer does not help.

> TestBlockReport fails intermittently
> ------------------------------------
>
>                 Key: HDFS-733
>                 URL: https://issues.apache.org/jira/browse/HDFS-733
>             Project: Hadoop HDFS
>          Issue Type: Bug
>    Affects Versions: 0.21.0
>            Reporter: Suresh Srinivas
>            Assignee: Konstantin Boudnik
>             Fix For: 0.21.0, 0.22.0
>
>         Attachments: HDFS-733.patch
>
>
> Details at 
> http://hudson.zones.apache.org/hudson/job/Hdfs-Patch-h2.grid.sp2.yahoo.net/58/testReport/

-- 
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.

Reply via email to