Return-Path: Delivered-To: apmail-hadoop-hbase-dev-archive@minotaur.apache.org Received: (qmail 68272 invoked from network); 21 Jul 2009 22:30:32 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.3) by minotaur.apache.org with SMTP; 21 Jul 2009 22:30:32 -0000 Received: (qmail 77521 invoked by uid 500); 21 Jul 2009 22:31:37 -0000 Delivered-To: apmail-hadoop-hbase-dev-archive@hadoop.apache.org Received: (qmail 77488 invoked by uid 500); 21 Jul 2009 22:31:37 -0000 Mailing-List: contact hbase-dev-help@hadoop.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: hbase-dev@hadoop.apache.org Delivered-To: mailing list hbase-dev@hadoop.apache.org Received: (qmail 77478 invoked by uid 99); 21 Jul 2009 22:31:37 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 21 Jul 2009 22:31:37 +0000 X-ASF-Spam-Status: No, hits=-1998.7 required=10.0 tests=ALL_TRUSTED,URI_HEX X-Spam-Check-By: apache.org Received: from [140.211.11.140] (HELO brutus.apache.org) (140.211.11.140) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 21 Jul 2009 22:31:35 +0000 Received: from brutus (localhost [127.0.0.1]) by brutus.apache.org (Postfix) with ESMTP id 26AA929A002E for ; Tue, 21 Jul 2009 15:31:15 -0700 (PDT) Message-ID: <1325476902.1248215475157.JavaMail.jira@brutus> Date: Tue, 21 Jul 2009 15:31:15 -0700 (PDT) From: "Haijun Cao (JIRA)" To: hbase-dev@hadoop.apache.org Subject: [jira] Created: (HBASE-1681) NSRE due to duplicate assignment to the same region server MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 X-Virus-Checked: Checked by ClamAV on apache.org NSRE due to duplicate assignment to the same region server ---------------------------------------------------------- Key: HBASE-1681 URL: https://issues.apache.org/jira/browse/HBASE-1681 Project: Hadoop HBase Issue Type: Bug Components: master Affects Versions: 0.20.0 Environment: Software * hbase trunk (0.20.0-dev, r795916) * hadoop-0.20.0 * zookeeper-3.2.0 Hardware * 3 dev servers: 8 core, 16G ram, 4x750G 7200 rpm SATA disk, RAID 0, each disk individually mounted * snv-it-lin-010: o hadoop namenode (1G) o hadoop secondary namenode (1G) o hadoop datanode (1G, max_xreciver=4096, handler=50) o hadoop job track (1G) o hadoop taks tracker (1G, max_map=1, max_red=1) o zookeeper (1G) o hbase master (2G) o hbase region server (2G) * snv-it-lin-011: o hadoop datanode (1G, max_xreciver=4096, handler=50) o hadoop taks tracker (1G, max_map=1, max_red=1) o zookeeper (1G) o hbase region server (2G, handler=50) * snv-it-lin-012: o hadoop datanode (1G, max_xreciver=4096, handler=50) o hadoop taks tracker (1G, max_map=1, max_red=1) o zookeeper (1G) o hbase region server (2G, handler=50) * jvm: 32bit Reporter: Haijun Cao Reproduce: 1. populate hbase with 100 m records: bin/hadop jar hbase-dev-test.jar --rows=1000000 sequtialWrite 100 2. populate hbase with 10 m records (random writes): bin/hadoop jar hbase-dev-test.jar --rows=1000000 randomWrite 10 3. scan 10 m records: bin/hadoop jar hbase-dev-test.jar --rows=1000000 scan 10 2 scan mapper task failed with NSRE exception for one region: org.apache.hadoop.hbase.NotServingRegionException: org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,1248204794507 at org.apache.hadoop.hbase.regionserver.HRegionServer.getRegion(HRegionServer.java:2251) at org.apache.hadoop.hbase.regionserver.HRegionServer.openScanner(HRegionServer.java:1862) at sun.reflect.GeneratedMethodAccessor6.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.apache.hadoop.hbase.ipc.HBaseRPC$Server.call(HBaseRPC.java:650) at org.apache.hadoop.hbase.ipc.HBaseServer$Handler.run(HBaseServer.java:913) Grep master log for TestTable,0001724032,1248204794507: 2009-07-21 12:33:18,275 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_SPLIT: TestTable,0001724032,1248141721258: Daughters; TestTable,0 001724032,1248204794507, TestTable,0001780000,1248204794507 from snv-it-lin-010. projectrialto.com,60020,1248115451722; 1 of 3 2009-07-21 12:33:19,169 INFO org.apache.hadoop.hbase.master.RegionManager: Assig ning region TestTable,0001724032,1248204794507 to snv-it-lin-011.projectrialto.c om,60020,1248115452051 2009-07-21 12:33:21,464 DEBUG org.apache.hadoop.hbase.master.BaseScanner: Curren t assignment of TestTable,0001724032,1248204794507 is not valid; Server '' star tCode: 0 unknown. 2009-07-21 12:33:22,207 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_PROCESS_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin- 011.projectrialto.com,60020,1248115452051; 1 of 1 2009-07-21 12:33:22,208 INFO org.apache.hadoop.hbase.master.RegionManager: Assig ning region TestTable,0001724032,1248204794507 to snv-it-lin-011.projectrialto.c om,60020,1248115452051 2009-07-21 12:33:25,245 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_PROCESS_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin- 011.projectrialto.com,60020,1248115452051; 1 of 3 2009-07-21 12:33:25,245 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_PROCESS_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin- 011.projectrialto.com,60020,1248115452051; 3 of 3 2009-07-21 12:33:28,283 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_PROCESS_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin- 011.projectrialto.com,60020,1248115452051; 1 of 7 2009-07-21 12:33:28,283 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_PROCESS_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin- 011.projectrialto.com,60020,1248115452051; 3 of 7 2009-07-21 12:33:28,283 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin-011.proj ectrialto.com,60020,1248115452051; 5 of 7 2009-07-21 12:33:28,284 INFO org.apache.hadoop.hbase.master.ServerManager: Received MSG_REPORT_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin-011.proj ectrialto.com,60020,1248115452051; 5 of 7 2009-07-21 12:33:28,284 INFO org.apache.hadoop.hbase.master.ServerManager: Recei ved MSG_REPORT_OPEN: TestTable,0001724032,1248204794507 from snv-it-lin-011.proj ectrialto.com,60020,1248115452051; 7 of 7 2009-07-21 12:33:28,284 DEBUG org.apache.hadoop.hbase.master.ServerManager: regi on server 10.10.30.105:60020 should not have opened region TestTable,0001724032, 1248204794507 2009-07-21 12:33:28,289 INFO org.apache.hadoop.hbase.master.RegionServerOperatio n: TestTable,0001724032,1248204794507 open on 10.10.30.105:60020 2009-07-21 12:33:28,289 INFO org.apache.hadoop.hbase.master.RegionServerOperatio n: updating row TestTable,0001724032,1248204794507 in region .META.,,1 with star tcode 1248115452051 and server 10.10.30.105:60020 Grep region server log for TestTable,0001724032,1248204794507: 2009-07-21 12:33:19,163 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_OPEN: TestTable,0001724032,1248204794507 2009-07-21 12:33:22,202 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_OPEN: TestTable,0001724032,1248204794507 2009-07-21 12:33:26,183 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: MSG_REGION_OPEN: TestTable,0001724032,1248204794507 2009-07-21 12:33:26,184 DEBUG org.apache.hadoop.hbase.regionserver.HRegion: Open ing region TestTable,0001724032,1248204794507, encoded=3313355 2009-07-21 12:33:26,204 INFO org.apache.hadoop.hbase.regionserver.HRegion: regio n TestTable,0001724032,1248204794507/3313355 available; sequence id is 45707088 2009-07-21 12:33:26,204 DEBUG org.apache.hadoop.hbase.regionserver.CompactSplitT hread: Compaction requested for region TestTable,0001724032,1248204794507/331335 5 because: Region has references on open 2009-07-21 12:33:26,204 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: MSG_REGION_OPEN: TestTable,0001724032,1248204794507 2009-07-21 12:33:28,278 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_CLOSE_WITHOUT_REPORT: TestTable,0001724032,1248204794507: Duplicate assignment 2009-07-21 12:33:28,279 INFO org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: MSG_REGION_CLOSE_WITHOUT_REPORT: TestTable,0001724032,1248204794507: Du plicate assignment 2009-07-21 12:33:28,279 DEBUG org.apache.hadoop.hbase.regionserver.HRegion: Clos ing TestTable,0001724032,1248204794507: compactions & flushes disabled 2009-07-21 12:33:28,279 DEBUG org.apache.hadoop.hbase.regionserver.HRegion: Upda tes disabled for region, no outstanding scanners on TestTable,0001724032,1248204 794507 2009-07-21 12:33:28,279 DEBUG org.apache.hadoop.hbase.regionserver.HRegion: No m ore row locks outstanding on region TestTable,0001724032,1248204794507 2009-07-21 12:33:28,279 INFO org.apache.hadoop.hbase.regionserver.HRegion: Close d TestTable,0001724032,1248204794507 2009-07-21 12:34:45,728 DEBUG org.apache.hadoop.hbase.regionserver.HRegion: Skip ping compaction on TestTable,0001724032,1248204794507 because closing/closed org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,12482047 94507 2009-07-21 13:24:35,902 INFO org.apache.hadoop.ipc.HBaseServer: IPC Server handl er 27 on 60020, call openScanner([B@1756ef1, startRow=0001700000, stopRow=, maxV ersions=1, timeRange=[0,9223372036854775807), families={(family=info, columns={d ata}}) from 10.10.30.105:50797: error: org.apache.hadoop.hbase.NotServingRegionE xception: TestTable,0001724032,1248204794507 org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,12482047 94507 org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,12482047 94507 2009-07-21 13:24:37,908 INFO org.apache.hadoop.ipc.HBaseServer: IPC Server handl er 19 on 60020, call openScanner([B@25b414, startRow=0001700000, stopRow=, maxVe rsions=1, timeRange=[0,9223372036854775807), families={(family=info, columns={da ta}}) from 10.10.30.105:50797: error: org.apache.hadoop.hbase.NotServingRegionEx ception: TestTable,0001724032,1248204794507 org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,12482047 94507 org.apache.hadoop.hbase.NotServingRegionException: TestTable,0001724032,12482047 94507 -- This message is automatically generated by JIRA. - You can reply to this email to add a comment to the issue online.