hbase-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Jimmy Xiang (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (HBASE-11906) Meta data loss with distributed log replay
Date Thu, 11 Sep 2014 18:00:35 GMT

    [ https://issues.apache.org/jira/browse/HBASE-11906?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14130413#comment-14130413
] 

Jimmy Xiang commented on HBASE-11906:
-------------------------------------

In my log, I found lots of edits with the same replay seq id:
{noformat}
2014-09-10 17:09:04,414 INFO  [B.defaultRpcServer.handler=28,queue=1,port=20020] regionserver.RSRpcServices:
Meta replay seq id=11, edit type=PUT,mutation={"totalColumns":1,"families":{"info":[{"timestamp":1410393186242,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x00\\x0B"],"value":"PBUF\\x08\\xC2\\xB7\\xF0\\x8F\\x86)\\x12'\\x0A\\x07default\\x12\\x1CIntegrationTestBigLinkedList\\x1A\\x08\\x04\\xA7\\x90Jy\\x04\\xA7\\x90\"\\x08\\x09O
\\x94\\xF2\\x09O (\\x000\\x008\\x00","qualifier":"regioninfo","vlen":78}]},"row":"IntegrationTestBigLinkedList,\\x04\\xA7\\x90Jy\\x04\\xA7\\x90,1410393185218.92709681028d2a976810a36f6c6bc558."}
2014-09-10 17:09:04,416 INFO  [B.defaultRpcServer.handler=28,queue=1,port=20020] regionserver.RSRpcServices:
Meta replay seq id=11, edit type=PUT,mutation={"totalColumns":1,"families":{"info":[{"timestamp":1410393186242,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x00\\x0B"],"value":"PBUF\\x08\\xC2\\xB7\\xF0\\x8F\\x86)\\x12'\\x0A\\x07default\\x12\\x1CIntegrationTestBigLinkedList\\x1A\\x00\"\\x08\\x04\\xA7\\x90Jy\\x04\\xA7\\x90(\\x000\\x008\\x00","qualifier":"regioninfo","vlen":70}]},"row":"IntegrationTestBigLinkedList,,1410393185218.69c946031b6eaa2b16b14cbc83ef57a3."}
2014-09-10 17:09:04,419 INFO  [B.defaultRpcServer.handler=28,queue=1,port=20020] regionserver.RSRpcServices:
Meta replay seq id=11, edit type=PUT,mutation={"totalColumns":1,"families":{"info":[{"timestamp":1410393186242,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x00\\x0B"],"value":"PBUF\\x08\\xC2\\xB7\\xF0\\x8F\\x86)\\x12'\\x0A\\x07default\\x12\\x1CIntegrationTestBigLinkedList\\x1A\\x08\\x17E\\xD1t]\\x17E\\xD0\"\\x08\\x1B\\xEDa\\xBE\\xD6\\x1B\\xED`(\\x000\\x008\\x00","qualifier":"regioninfo","vlen":78}]},"row":"IntegrationTestBigLinkedList,\\x17E\\xD1t]\\x17E\\xD0,1410393185218.35686221ee2ba55488a62a894ce26c48."}
{noformat}
Is this something I need to worry about?

> Meta data loss with distributed log replay
> ------------------------------------------
>
>                 Key: HBASE-11906
>                 URL: https://issues.apache.org/jira/browse/HBASE-11906
>             Project: HBase
>          Issue Type: Bug
>    Affects Versions: 0.99.0, 2.0.0
>            Reporter: Jimmy Xiang
>            Assignee: Jeffrey Zhong
>         Attachments: HBASE-11906.patch, debugging.patch, meta-data-loss-2.log, meta-data-loss-with-dlr.log
>
>
> In the attached log, you can see, before log replaying, the region is open on e1205:
> {noformat}
> A3. 2014-09-05 16:38:46,705 INFO  [B.defaultRpcServer.handler=5,queue=2,port=20020] master.RegionStateStore:
Updating row IntegrationTestBigLinkedList,\x90Jy\x04\xA7\x90Jp,1409959495482.cbb0d736ebfabcf4a07e5a7b395fcdf7.
with state=OPEN&openSeqNum=40118237&server=e1205.halxg.cloudera.com,20020,1409960280431
> {noformat}
> After the log replay, we got from meta the region is open on e1209
> {noformat}
> A4. 2014-09-05 16:41:12,257 INFO  [ActiveMasterManager] master.AssignmentManager: Loading
from meta: {cbb0d736ebfabcf4a07e5a7b395fcdf7 state=OPEN, ts=1409960472257, server=e1209.halxg.cloudera.com,20020,1409959391651}
> {noformat}
> The replayed edits show the log does have the edit expected:
> {noformat}
> 2014-09-05 16:41:11,862 INFO  [B.defaultRpcServer.handler=18,queue=0,port=20020] regionserver.RSRpcServices:
Meta replay edit type=PUT,mutation={"totalColumns":4,"families":{"info":[{"timestamp":1409960326705,"tag":["3:\\x00\\x00\\x00\\x00\\x02bad"],"value":"e1205.halxg.cloudera.com:20020","qualifier":"server","vlen":30},{"timestamp":1409960326705,"tag":["3:\\x00\\x00\\x00\\x00\\x02bad"],"value":"\\x00\\x00\\x01HH.\\x81o","qualifier":"serverstartcode","vlen":8},{"timestamp":1409960326705,"tag":["3:\\x00\\x00\\x00\\x00\\x02bad"],"value":"\\x00\\x00\\x00\\x00\\x02d'\\xDD","qualifier":"seqnumDuringOpen","vlen":8},{"timestamp":1409960326706,"tag":["3:\\x00\\x00\\x00\\x00\\x02bad"],"value":"OPEN","qualifier":"state","vlen":4}]},"row":"IntegrationTestBigLinkedList,\\x90Jy\\x04\\xA7\\x90Jp,1409959495482.cbb0d736ebfabcf4a07e5a7b395fcdf7."}
> {noformat}
> Why we picked up a wrong value with an older time stamp?
> {noformat}
> 2014-09-05 16:41:11,063 INFO  [B.defaultRpcServer.handler=9,queue=0,port=20020] regionserver.RSRpcServices:
Meta replay edit type=PUT,mutation={"totalColumns":4,"families":{"info":[{"timestamp":1409959994634,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x09\\x99"],"value":"e1209.halxg.cloudera.com:20020","qualifier":"server","vlen":30},{"timestamp":1409959994634,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x09\\x99"],"value":"\\x00\\x00\\x01HH
\\xF1\\xA3","qualifier":"serverstartcode","vlen":8},{"timestamp":1409959994634,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x09\\x99"],"value":"\\x00\\x00\\x00\\x00\\x00\\x01\\xB7\\xAB","qualifier":"seqnumDuringOpen","vlen":8},{"timestamp":1409959994634,"tag":["3:\\x00\\x00\\x00\\x00\\x00\\x00\\x09\\x99"],"value":"OPEN","qualifier":"state","vlen":4}]},"row":"IntegrationTestBigLinkedList,\\x90Jy\\x04\\xA7\\x90Jp,1409959495482.cbb0d736ebfabcf4a07e5a7b395fcdf7."}
> {noformat}



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Mime
View raw message