Return-Path: X-Original-To: archive-asf-public-internal@cust-asf2.ponee.io Delivered-To: archive-asf-public-internal@cust-asf2.ponee.io Received: from cust-asf.ponee.io (cust-asf.ponee.io [163.172.22.183]) by cust-asf2.ponee.io (Postfix) with ESMTP id 68362200CAA for ; Sat, 3 Jun 2017 02:24:13 +0200 (CEST) Received: by cust-asf.ponee.io (Postfix) id 66889160BDD; Sat, 3 Jun 2017 00:24:13 +0000 (UTC) Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by cust-asf.ponee.io (Postfix) with SMTP id AD547160BD2 for ; Sat, 3 Jun 2017 02:24:12 +0200 (CEST) Received: (qmail 76713 invoked by uid 500); 3 Jun 2017 00:24:06 -0000 Mailing-List: contact issues-help@hbase.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Delivered-To: mailing list issues@hbase.apache.org Received: (qmail 76692 invoked by uid 99); 3 Jun 2017 00:24:06 -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; Sat, 03 Jun 2017 00:24:06 +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 558F8C0CA4 for ; Sat, 3 Jun 2017 00:24:06 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd1-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -99.202 X-Spam-Level: X-Spam-Status: No, score=-99.202 tagged_above=-999 required=6.31 tests=[KAM_ASCII_DIVIDERS=0.8, RP_MATCHES_RCVD=-0.001, SPF_PASS=-0.001, 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 xc7CrQZocYIp for ; Sat, 3 Jun 2017 00:24:05 +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 0C44F5F5B9 for ; Sat, 3 Jun 2017 00:24:05 +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 55A0CE02C8 for ; Sat, 3 Jun 2017 00:24:04 +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 1450720DF5 for ; Sat, 3 Jun 2017 00:24:04 +0000 (UTC) Date: Sat, 3 Jun 2017 00:24:04 +0000 (UTC) From: "stack (JIRA)" To: issues@hbase.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Updated] (HBASE-18152) [AMv2] Corrupt Procedure WAL file; procedure data stored out of order MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 archived-at: Sat, 03 Jun 2017 00:24:13 -0000 [ https://issues.apache.org/jira/browse/HBASE-18152?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ] stack updated HBASE-18152: -------------------------- Attachment: HBASE-17537.master.002.patch Patch was too stringent. Was reporting the below as NOT increasing when it is: {code} 2017-06-02 17:17:53,113 WARN [ve0524:16000.masterManager] wal.ProcedureWALFormatReader: NOT INCREASING! current=class_name: "org.apache.hadoop.hbase.master.procedure.ServerCrashProcedure" proc_id: 21 submitted_time: 1496449031443 owner: "stack" state: WAITING stack_id: 0 stack_id: 1 stack_id: 2 stack_id: 3 last_update: 1496449035902 state_data: "\n\b\001\b\003\b\005\b\b\bdR\n%\n\031ve0524.halxg.cloudera.com\020\200}\030\344\371\256\332\306+\032%\b\215\341\225\331\306+\022\022\n\005hbase\022\tnamespace\032\000\"\000(\0000\0008\000(\0000\001" , candidate=class_name: "org.apache.hadoop.hbase.master.procedure.ServerCrashProcedure" proc_id: 21 submitted_time: 1496449031443 owner: "stack" state: RUNNABLE stack_id: 0 stack_id: 1 stack_id: 2 stack_id: 3 last_update: 1496449036513 state_data: "\n\b\001\b\003\b\005\b\b\bdR\n%\n\031ve0524.halxg.cloudera.com\020\200}\030\344\371\256\332\306+\032%\b\215\341\225\331\306+\022\022\n\005hbase\022\tnamespace\032\000\"\000(\0000\0008\000(\0000\001" {code} ... notice the timestamps. > [AMv2] Corrupt Procedure WAL file; procedure data stored out of order > --------------------------------------------------------------------- > > Key: HBASE-18152 > URL: https://issues.apache.org/jira/browse/HBASE-18152 > Project: HBase > Issue Type: Bug > Components: Region Assignment > Affects Versions: 2.0.0 > Reporter: stack > Assignee: stack > Priority: Critical > Fix For: 2.0.0 > > Attachments: HBASE-17537.master.002.patch, HBASE-18152.master.001.patch, pv2-00000000000000000047.log, reading_bad_wal.patch > > > I've seen corruption from time-to-time testing. Its rare enough. Often we can get over it but sometimes we can't. It took me a while to capture an instance of corruption. Turns out we are write to the WAL out-of-order which undoes a basic tenet; that WAL content is ordered in line w/ execution. > Below I'll post a corrupt WAL. > Looking at the write-side, there is a lot going on. I'm not clear on how we could write out of order. Will try and get more insight. Meantime parking this issue here to fill data into. -- This message was sent by Atlassian JIRA (v6.3.15#6346)