[HBASE-2067] Disabling a table can return too soon if one region is pending open

• Type: Sub-task
• Status: Closed
• Priority: Major
• Resolution: Duplicate
• Affects Version/s: 0.20.2
• Fix Version/s: 0.20.3, 0.90.0
• Assignee: Jean-Daniel Cryans
• Reporter: Jean-Daniel Cryans
• Created: 22/Dec/09 09:47
• Updated: 12/Oct/12 06:14
• Resolved: 28/Dec/09 18:19

Description

Still using my test I was grepping for "Duplicate assignment" and found that:

2009-12-22 01:43:31,450 DEBUG [IPC Server handler 3 on 60000] master.ChangeTableState(70): Processing unserved regions
2009-12-22 01:43:31,450 INFO  [RegionServer:2.worker] regionserver.HRegion(343): region table8,,1261474997182/1735800584 available; sequence id is 0
2009-12-22 01:43:31,451 DEBUG [IPC Server handler 3 on 60000] master.ChangeTableState(102): Removed server and startcode from row and set online=false: table8,,1261474997182
2009-12-22 01:43:31,451 DEBUG [IPC Server handler 3 on 60000] master.ChangeTableState(120): Processing regions currently being served2009-12-22 01:43:31,451 DEBUG [main] client.HConnectionManager$TableServers(776): Cache hit for row <> in tableName .META.: location server 192.168.1.103:54769, location region
 name .META.,,1
2009-12-22 01:43:31,456 DEBUG [main] client.HConnectionManager$TableServers(554): Rowscanned=1, rowsOffline=1
2009-12-22 01:43:31,456 INFO  [main] client.HBaseAdmin(414): Disabled table8
2009-12-22 01:43:31,459 DEBUG [IPC Server handler 1 on 60000] regionserver.HRegion(2003): DELETING region hdfs://localhost:54729/user/jdcryans/table8/1735800584
2009-12-22 01:43:31,461 INFO  [IPC Server handler 1 on 60000] master.HMaster(807): deleted table: table8
2009-12-22 01:43:31,464 INFO  [main] client.HBaseAdmin(302): Deleted table8
...
2009-12-22 01:43:31,541 INFO  [IPC Server handler 2 on 60000] master.ServerManager(421): Processing MSG_REPORT_PROCESS_OPEN: table8,,1261474997182 from 192.168.1.103,54771,1261
474989274; 1 of 2
2009-12-22 01:43:31,541 INFO  [IPC Server handler 2 on 60000] master.ServerManager(421): Processing MSG_REPORT_OPEN: table8,,1261474997182 from 192.168.1.103,54771,1261474989274; 2 of 2
2009-12-22 01:43:31,541 DEBUG [IPC Server handler 2 on 60000] master.ServerManager(567): region server 192.168.1.103:54771 should not have opened region table8,,1261474997182
2009-12-22 01:43:31,542 INFO  [RegionServer:2] regionserver.HRegionServer(475): MSG_REGION_CLOSE_WITHOUT_REPORT: table8,,1261474997182: Duplicate assignment
2009-12-22 01:43:31,542 INFO  [RegionServer:2.worker] regionserver.HRegionServer$Worker(1332): Worker: MSG_REGION_CLOSE_WITHOUT_REPORT: table8,,1261474997182: Duplicate assignm
ent

So the region is marked as offline while it's pending open. The thread in HCM.TableServer sees that as if the region was closed but it's not and it's reporting just a little bit after.