Return-Path: X-Original-To: apmail-hbase-issues-archive@www.apache.org Delivered-To: apmail-hbase-issues-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 3FBBA17CAD for ; Thu, 30 Oct 2014 17:48:35 +0000 (UTC) Received: (qmail 55930 invoked by uid 500); 30 Oct 2014 17:48:35 -0000 Delivered-To: apmail-hbase-issues-archive@hbase.apache.org Received: (qmail 55886 invoked by uid 500); 30 Oct 2014 17:48:35 -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 55873 invoked by uid 99); 30 Oct 2014 17:48:35 -0000 Received: from arcas.apache.org (HELO arcas.apache.org) (140.211.11.28) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 30 Oct 2014 17:48:35 +0000 Date: Thu, 30 Oct 2014 17:48:34 +0000 (UTC) From: "Esteban Gutierrez (JIRA)" To: issues@hbase.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Updated] (HBASE-12380) TestRegionServerNoMaster#testMultipleOpen is flaky after HBASE-11760 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/HBASE-12380?page=3Dcom.atlassi= an.jira.plugin.system.issuetabpanels:all-tabpanel ] Esteban Gutierrez updated HBASE-12380: -------------------------------------- Status: Patch Available (was: Open) Thanks [~jxiang]! > TestRegionServerNoMaster#testMultipleOpen is flaky after HBASE-11760 > -------------------------------------------------------------------- > > Key: HBASE-12380 > URL: https://issues.apache.org/jira/browse/HBASE-12380 > Project: HBase > Issue Type: Bug > Components: test > Affects Versions: 2.0.0 > Reporter: Esteban Gutierrez > Attachments: HBASE-12380.v0.patch > > > Noticed this while trying to fix faulty test while working on a fix for H= BASE-12219: > {code} > Tests in error: > TestRegionServerNoMaster.testMultipleOpen:237 =C2=BB Service java.io.IO= Exception: R... > TestRegionServerNoMaster.testCloseByRegionServer:211->closeRegionNoZK:2= 01 =C2=BB Service > {code} > Initially I thought the problem was on my patch for HBASE-12219 but I not= iced that the issue was occurring on the 7th attempt to open the region. Ho= wever I was able to reproduce the same problem in the master branch after i= ncreasing the number of requests in testMultipleOpen(): > {code} > 2014-10-29 15:03:45,043 INFO [Thread-216] regionserver.RSRpcServices(133= 4): Receiving OPEN for the region:TestRegionServerNoMaster,,1414620223682.0= 25198143197ea68803e49819eae27ca., which we are already trying to OPEN - ign= oring this new request for this region. > Submitting openRegion attempt: 16 <=3D=3D=3D=3D > 2014-10-29 15:03:45,044 INFO [Thread-216] regionserver.RSRpcServices(131= 1): Open TestRegionServerNoMaster,,1414620223682.025198143197ea68803e49819e= ae27ca. > 2014-10-29 15:03:45,044 INFO [PostOpenDeployTasks:025198143197ea68803e49= 819eae27ca] hbase.MetaTableAccessor(1307): Updated row TestRegionServerNoMa= ster,,1414620223682.025198143197ea68803e49819eae27ca. with server=3D192.168= .1.105,63082,1414620220789 > Submitting openRegion attempt: 17 <=3D=3D=3D=3D > 2014-10-29 15:03:45,046 ERROR [RS_OPEN_REGION-192.168.1.105:63082-2] hand= ler.OpenRegionHandler(88): Region 025198143197ea68803e49819eae27ca was alre= ady online when we started processing the opening. Marking this new attempt= as failed > 2014-10-29 15:03:45,047 FATAL [Thread-216] regionserver.HRegionServer(193= 1): ABORTING region server 192.168.1.105,63082,1414620220789: Received OPEN= for the region:TestRegionServerNoMaster,,1414620223682.025198143197ea68803= e49819eae27ca., which is already online > 2014-10-29 15:03:45,047 FATAL [Thread-216] regionserver.HRegionServer(193= 7): RegionServer abort: loaded coprocessors are: [org.apache.hadoop.hbase.c= oprocessor.MultiRowMutationEndpoint] > 2014-10-29 15:03:45,054 WARN [Thread-216] regionserver.HRegionServer(195= 5): Unable to report fatal error to master > com.google.protobuf.ServiceException: java.io.IOException: Call to /192.1= 68.1.105:63079 failed on local exception: java.io.IOException: Connection t= o /192.168.1.105:63079 is closing. Call id=3D4, waitTime=3D2 > at org.apache.hadoop.hbase.ipc.RpcClient.callBlockingMethod(RpcCl= ient.java:1707) > at org.apache.hadoop.hbase.ipc.RpcClient$BlockingRpcChannelImplem= entation.callBlockingMethod(RpcClient.java:1757) > at org.apache.hadoop.hbase.protobuf.generated.RegionServerStatusP= rotos$RegionServerStatusService$BlockingStub.reportRSFatalError(RegionServe= rStatusProtos.java:8301) > at org.apache.hadoop.hbase.regionserver.HRegionServer.abort(HRegi= onServer.java:1952) > at org.apache.hadoop.hbase.MiniHBaseCluster$MiniHBaseClusterRegio= nServer.abortRegionServer(MiniHBaseCluster.java:174) > at org.apache.hadoop.hbase.MiniHBaseCluster$MiniHBaseClusterRegio= nServer.access$100(MiniHBaseCluster.java:108) > at org.apache.hadoop.hbase.MiniHBaseCluster$MiniHBaseClusterRegio= nServer$2.run(MiniHBaseCluster.java:167) > at java.security.AccessController.doPrivileged(Native Method) > at javax.security.auth.Subject.doAs(Subject.java:356) > at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroup= Information.java:1528) > at org.apache.hadoop.hbase.security.User$SecureHadoopUser.runAs(U= ser.java:277) > at org.apache.hadoop.hbase.MiniHBaseCluster$MiniHBaseClusterRegio= nServer.abort(MiniHBaseCluster.java:165) > at org.apache.hadoop.hbase.regionserver.HRegionServer.abort(HRegi= onServer.java:1964) > at org.apache.hadoop.hbase.regionserver.RSRpcServices.openRegion(= RSRpcServices.java:1308) > at org.apache.hadoop.hbase.regionserver.TestRegionServerNoMaster.= testMultipleOpen(TestRegionServerNoMaster.java:237) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccess= orImpl.java:57) > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMeth= odAccessorImpl.java:43) > at java.lang.reflect.Method.invoke(Method.java:606) > at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(Fr= ameworkMethod.java:47) > at org.junit.internal.runners.model.ReflectiveCallable.run(Reflec= tiveCallable.java:12) > at org.junit.runners.model.FrameworkMethod.invokeExplosively(Fram= eworkMethod.java:44) > at org.junit.internal.runners.statements.InvokeMethod.evaluate(In= vokeMethod.java:17) > at org.junit.internal.runners.statements.FailOnTimeout$StatementT= hread.run(FailOnTimeout.java:74) > Caused by: java.io.IOException: Call to /192.168.1.105:63079 failed on lo= cal exception: java.io.IOException: Connection to /192.168.1.105:63079 is c= losing. Call id=3D4, waitTime=3D2 > at org.apache.hadoop.hbase.ipc.RpcClient.wrapException(RpcClient.= java:1563) > at org.apache.hadoop.hbase.ipc.RpcClient.call(RpcClient.java:1534= ) > at org.apache.hadoop.hbase.ipc.RpcClient.callBlockingMethod(RpcCl= ient.java:1692) > ... 23 more > Caused by: java.io.IOException: Connection to /192.168.1.105:63079 is clo= sing. Call id=3D4, waitTime=3D2 > at org.apache.hadoop.hbase.ipc.RpcClient$Connection.cleanupCalls(= RpcClient.java:1257) > at org.apache.hadoop.hbase.ipc.RpcClient$Connection.close(RpcClie= nt.java:1063) > at org.apache.hadoop.hbase.ipc.RpcClient$Connection.run(RpcClient= .java:791) > {code} -- This message was sent by Atlassian JIRA (v6.3.4#6332)