From hdfs-issues-return-214834-archive-asf-public=cust-asf.ponee.io@hadoop.apache.org Wed Mar 28 13:26:05 2018 Return-Path: X-Original-To: archive-asf-public@cust-asf.ponee.io Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by mx-eu-01.ponee.io (Postfix) with SMTP id ECE60180652 for ; Wed, 28 Mar 2018 13:26:04 +0200 (CEST) Received: (qmail 63089 invoked by uid 500); 28 Mar 2018 11:26:03 -0000 Mailing-List: contact hdfs-issues-help@hadoop.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Delivered-To: mailing list hdfs-issues@hadoop.apache.org Received: (qmail 63078 invoked by uid 99); 28 Mar 2018 11:26:03 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd1-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 28 Mar 2018 11:26:03 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd1-us-west.apache.org (ASF Mail Server at spamd1-us-west.apache.org) with ESMTP id 701A8C73B7 for ; Wed, 28 Mar 2018 11:26:03 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd1-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -107.011 X-Spam-Level: X-Spam-Status: No, score=-107.011 tagged_above=-999 required=6.31 tests=[ENV_AND_HDR_SPF_MATCH=-0.5, KAM_ASCII_DIVIDERS=0.8, RCVD_IN_DNSWL_MED=-2.3, SPF_PASS=-0.001, T_RP_MATCHES_RCVD=-0.01, URIBL_DBL_SPAM=2.5, USER_IN_DEF_SPF_WL=-7.5, USER_IN_WHITELIST=-100] autolearn=disabled Received: from mx1-lw-eu.apache.org ([10.40.0.8]) by localhost (spamd1-us-west.apache.org [10.40.0.7]) (amavisd-new, port 10024) with ESMTP id pyPXQDczuW-U for ; Wed, 28 Mar 2018 11:26:02 +0000 (UTC) Received: from mailrelay1-us-west.apache.org (mailrelay1-us-west.apache.org [209.188.14.139]) by mx1-lw-eu.apache.org (ASF Mail Server at mx1-lw-eu.apache.org) with ESMTP id CAC6A5FB5B for ; Wed, 28 Mar 2018 11:26:01 +0000 (UTC) Received: from jira-lw-us.apache.org (unknown [207.244.88.139]) by mailrelay1-us-west.apache.org (ASF Mail Server at mailrelay1-us-west.apache.org) with ESMTP id E84D4E09A4 for ; Wed, 28 Mar 2018 11:26:00 +0000 (UTC) Received: from jira-lw-us.apache.org (localhost [127.0.0.1]) by jira-lw-us.apache.org (ASF Mail Server at jira-lw-us.apache.org) with ESMTP id 3A002255DE for ; Wed, 28 Mar 2018 11:26:00 +0000 (UTC) Date: Wed, 28 Mar 2018 11:26:00 +0000 (UTC) From: "Zephyr Guo (JIRA)" To: hdfs-issues@hadoop.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Commented] (HDFS-13243) Get CorruptBlock because of calling close and sync in same time MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 [ https://issues.apache.org/jira/browse/HDFS-13243?page=3Dcom.atlassian= .jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=3D1641= 7198#comment-16417198 ]=20 Zephyr Guo commented on HDFS-13243: ----------------------------------- Rebase patch-v3, attach v4. > Get CorruptBlock because of calling close and sync in same time > --------------------------------------------------------------- > > Key: HDFS-13243 > URL: https://issues.apache.org/jira/browse/HDFS-13243 > Project: Hadoop HDFS > Issue Type: Bug > Components: namenode > Affects Versions: 2.7.2, 3.2.0 > Reporter: Zephyr Guo > Assignee: Zephyr Guo > Priority: Critical > Attachments: HDFS-13243-v1.patch, HDFS-13243-v2.patch, HDFS-13243= -v3.patch, HDFS-13243-v4.patch > > > HDFS File might get broken because of corrupt block(s) that could be prod= uced by calling close and sync in the same time. > When calling close was not successful, UCBlock status would change to COM= MITTED, and if a sync request gets popped from queue and processed, sync op= eration would change the last block length. > After that, DataNode would report all received block to NameNode, and wil= l check Block length of all COMMITTED Blocks. But the block length was alre= ady different between recorded in NameNode memory and reported by DataNode,= and consequently, the last block is marked as corruptted because of incons= istent length. > =C2=A0 > {panel:title=3DLog in my hdfs} > 2018-03-05 04:05:39,261 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* a= llocate blk_1085498930_11758129\{UCState=3DUNDER_CONSTRUCTION, truncateBloc= k=3Dnull, primaryNodeIndex=3D-1, replicas=3D[ReplicaUC[[DISK]DS-32c7e479-38= 45-4a44-adf1-831edec7506b:NORMAL:10.0.0.219:50010|RBW], ReplicaUC[[DISK]DS-= a9a5d653-c049-463d-8e4a-d1f0dc14409c:NORMAL:10.0.0.220:50010|RBW], ReplicaU= C[[DISK]DS-f2b7c04a-b724-4c69-abbf-d2e416f70706:NORMAL:10.0.0.218:50010|RBW= ]]} for /hbase/WALs/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com,16020,1= 519845790686/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com%2C16020%2C1519= 845790686.default.1520193926515 > 2018-03-05 04:05:39,760 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* f= sync: /hbase/WALs/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com,16020,151= 9845790686/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com%2C16020%2C151984= 5790686.default.1520193926515 for DFSClient_NONMAPREDUCE_1077513762_1 > 2018-03-05 04:05:39,761 INFO org.apache.hadoop.hdfs.server.namenode.FSNam= esystem: BLOCK* blk_1085498930_11758129\{UCState=3DCOMMITTED, truncateBlock= =3Dnull, primaryNodeIndex=3D-1, replicas=3D[ReplicaUC[[DISK]DS-32c7e479-384= 5-4a44-adf1-831edec7506b:NORMAL:10.0.0.219:50010|RBW], ReplicaUC[[DISK]DS-a= 9a5d653-c049-463d-8e4a-d1f0dc14409c:NORMAL:10.0.0.220:50010|RBW], ReplicaUC= [[DISK]DS-f2b7c04a-b724-4c69-abbf-d2e416f70706:NORMAL:10.0.0.218:50010|RBW]= ]} is not COMPLETE (ucState =3D COMMITTED, replication# =3D 0 < minimum =3D= 2) in file /hbase/WALs/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com,160= 20,1519845790686/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com%2C16020%2C= 1519845790686.default.1520193926515 > 2018-03-05 04:05:39,761 INFO BlockStateChange: BLOCK* addStoredBlock: blo= ckMap updated: 10.0.0.220:50010 is added to blk_1085498930_11758129\{UCStat= e=3DCOMMITTED, truncateBlock=3Dnull, primaryNodeIndex=3D-1, replicas=3D[Rep= licaUC[[DISK]DS-32c7e479-3845-4a44-adf1-831edec7506b:NORMAL:10.0.0.219:5001= 0|RBW], ReplicaUC[[DISK]DS-a9a5d653-c049-463d-8e4a-d1f0dc14409c:NORMAL:10.0= .0.220:50010|RBW], ReplicaUC[[DISK]DS-f2b7c04a-b724-4c69-abbf-d2e416f70706:= NORMAL:10.0.0.218:50010|RBW]]} size 2054413 > 2018-03-05 04:05:39,761 INFO BlockStateChange: BLOCK NameSystem.addToCorr= uptReplicasMap: blk_1085498930 added as corrupt on 10.0.0.219:50010 by hb-j= 5e517al6xib80rkb-006.hbase.rds.aliyuncs.com/10.0.0.219 because block is COM= MITTED and reported length 2054413 does not match length in block map 14123= 2 > 2018-03-05 04:05:39,762 INFO BlockStateChange: BLOCK NameSystem.addToCorr= uptReplicasMap: blk_1085498930 added as corrupt on 10.0.0.218:50010 by hb-j= 5e517al6xib80rkb-004.hbase.rds.aliyuncs.com/10.0.0.218 because block is COM= MITTED and reported length 2054413 does not match length in block map 14123= 2 > 2018-03-05 04:05:40,162 INFO org.apache.hadoop.hdfs.server.namenode.FSNam= esystem: BLOCK* blk_1085498930_11758129\{UCState=3DCOMMITTED, truncateBlock= =3Dnull, primaryNodeIndex=3D-1, replicas=3D[ReplicaUC[[DISK]DS-32c7e479-384= 5-4a44-adf1-831edec7506b:NORMAL:10.0.0.219:50010|RBW], ReplicaUC[[DISK]DS-a= 9a5d653-c049-463d-8e4a-d1f0dc14409c:NORMAL:10.0.0.220:50010|RBW], ReplicaUC= [[DISK]DS-f2b7c04a-b724-4c69-abbf-d2e416f70706:NORMAL:10.0.0.218:50010|RBW]= ]} is not COMPLETE (ucState =3D COMMITTED, replication# =3D 3 >=3D minimum = =3D 2) in file /hbase/WALs/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com,= 16020,1519845790686/hb-j5e517al6xib80rkb-006.hbase.rds.aliyuncs.com%2C16020= %2C1519845790686.default.1520193926515 > {panel} -- This message was sent by Atlassian JIRA (v7.6.3#76005) --------------------------------------------------------------------- To unsubscribe, e-mail: hdfs-issues-unsubscribe@hadoop.apache.org For additional commands, e-mail: hdfs-issues-help@hadoop.apache.org