Return-Path: X-Original-To: apmail-hbase-builds-archive@minotaur.apache.org Delivered-To: apmail-hbase-builds-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id DB7AA11B68 for ; Tue, 24 Jun 2014 08:22:13 +0000 (UTC) Received: (qmail 93694 invoked by uid 500); 24 Jun 2014 08:22:13 -0000 Delivered-To: apmail-hbase-builds-archive@hbase.apache.org Received: (qmail 93658 invoked by uid 500); 24 Jun 2014 08:22:13 -0000 Mailing-List: contact builds-help@hbase.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: builds@hbase.apache.org Delivered-To: mailing list builds@hbase.apache.org Received: (qmail 93647 invoked by uid 99); 24 Jun 2014 08:22:13 -0000 Received: from crius.apache.org (HELO crius) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 24 Jun 2014 08:22:13 +0000 Received: from crius.apache.org (localhost [127.0.0.1]) by crius (Postfix) with ESMTP id D25A0E00175 for ; Tue, 24 Jun 2014 08:22:11 +0000 (UTC) Date: Tue, 24 Jun 2014 08:22:10 +0000 (UTC) From: Apache Jenkins Server To: builds@hbase.apache.org Message-ID: <94708805.5470.1403598130345.JavaMail.jenkins@crius> Subject: Build failed in Jenkins: HBase-0.98 #351 MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit X-Jenkins-Job: HBase-0.98 X-Jenkins-Result: FAILURE See Changes: [tedyu] HBASE-11380 HRegion lock object is not being released properly, leading to snapshot failure ------------------------------------------ [...truncated 6630 lines...] - locked <0x7ede5e88> (a java.util.Collections$UnmodifiableSet) - locked <0x7ede5c88> (a sun.nio.ch.EPollSelectorImpl) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:84) at org.apache.hadoop.ipc.Server$Listener.run(Server.java:479) "IPC Server Responder" daemon prio=10 tid=0x741e7000 nid=0x7820 runnable [0x7335c000] java.lang.Thread.State: RUNNABLE at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69) - locked <0x7eddf978> (a sun.nio.ch.Util$2) - locked <0x7eddf968> (a java.util.Collections$UnmodifiableSet) - locked <0x7eddf780> (a sun.nio.ch.EPollSelectorImpl) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80) at org.apache.hadoop.ipc.Server$Responder.run(Server.java:645) "Timer-0" daemon prio=10 tid=0x73b74400 nid=0x781f in Object.wait() [0x733ad000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x7f2d1700> (a java.util.TaskQueue) at java.util.TimerThread.mainLoop(Timer.java:509) - locked <0x7f2d1700> (a java.util.TaskQueue) at java.util.TimerThread.run(Timer.java:462) "25211438@qtp-749304-1 - Acceptor0 SelectChannelConnector@localhost:42228" prio=10 tid=0x741f6c00 nid=0x781e runnable [0x733fe000] java.lang.Thread.State: RUNNABLE at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69) - locked <0x7f3d3ef8> (a sun.nio.ch.Util$2) - locked <0x7f3d3ee8> (a java.util.Collections$UnmodifiableSet) - locked <0x7f3d3ab8> (a sun.nio.ch.EPollSelectorImpl) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80) at org.mortbay.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:498) at org.mortbay.io.nio.SelectorManager.doSelect(SelectorManager.java:192) at org.mortbay.jetty.nio.SelectChannelConnector.accept(SelectChannelConnector.java:124) at org.mortbay.jetty.AbstractConnector$Acceptor.run(AbstractConnector.java:708) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:582) "2280960@qtp-749304-0" prio=10 tid=0x747d7c00 nid=0x781d in Object.wait() [0x7355c000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x7f3d35b8> (a org.mortbay.thread.QueuedThreadPool$PoolThread) at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626) - locked <0x7f3d35b8> (a org.mortbay.thread.QueuedThreadPool$PoolThread) "pool-2-thread-1" prio=10 tid=0x741f2000 nid=0x781c runnable [0x735ad000] java.lang.Thread.State: RUNNABLE at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69) - locked <0x7ec45138> (a sun.nio.ch.Util$2) - locked <0x7ec45148> (a java.util.Collections$UnmodifiableSet) - locked <0x7ec450f8> (a sun.nio.ch.EPollSelectorImpl) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:84) at org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:373) - locked <0x7ec45158> (a org.apache.hadoop.ipc.Server$Listener$Reader) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918) at java.lang.Thread.run(Thread.java:662) "org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor@717323" daemon prio=10 tid=0x73d43400 nid=0x781b waiting on condition [0x735fe000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor.run(DecommissionManager.java:65) at java.lang.Thread.run(Thread.java:662) "org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@11410e5" daemon prio=10 tid=0x73d17800 nid=0x781a waiting on condition [0x7375c000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor.run(FSNamesystem.java:3167) at java.lang.Thread.run(Thread.java:662) "org.apache.hadoop.hdfs.server.namenode.LeaseManager$Monitor@d1329" daemon prio=10 tid=0x73ed2000 nid=0x7819 waiting on condition [0x737ad000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hdfs.server.namenode.LeaseManager$Monitor.run(LeaseManager.java:368) at java.lang.Thread.run(Thread.java:662) "org.apache.hadoop.hdfs.server.namenode.FSNamesystem$HeartbeatMonitor@157b46f" daemon prio=10 tid=0x73dd1400 nid=0x7818 waiting on condition [0x737fe000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hdfs.server.namenode.FSNamesystem$HeartbeatMonitor.run(FSNamesystem.java:3146) at java.lang.Thread.run(Thread.java:662) "org.apache.hadoop.hdfs.server.namenode.PendingReplicationBlocks$PendingReplicationMonitor@510e39" daemon prio=10 tid=0x73dd3400 nid=0x7817 waiting on condition [0x7457d000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hdfs.server.namenode.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:197) at java.lang.Thread.run(Thread.java:662) "pool-1-thread-1" prio=10 tid=0x7401d400 nid=0x7772 in Object.wait() [0x7485e000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0xcc6a7420> (a org.apache.hadoop.hbase.ipc.RpcClient$Call) at org.apache.hadoop.hbase.ipc.RpcClient.call(RpcClient.java:1448) - locked <0xcc6a7420> (a org.apache.hadoop.hbase.ipc.RpcClient$Call) at org.apache.hadoop.hbase.ipc.RpcClient.callBlockingMethod(RpcClient.java:1657) at org.apache.hadoop.hbase.ipc.RpcClient$BlockingRpcChannelImplementation.callBlockingMethod(RpcClient.java:1715) at org.apache.hadoop.hbase.protobuf.generated.MasterProtos$MasterService$BlockingStub.assignRegion(MasterProtos.java:42633) at org.apache.hadoop.hbase.client.HConnectionManager$HConnectionImplementation$5.assignRegion(HConnectionManager.java:1929) at org.apache.hadoop.hbase.client.HBaseAdmin$10.call(HBaseAdmin.java:1708) at org.apache.hadoop.hbase.client.HBaseAdmin$10.call(HBaseAdmin.java:1703) at org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:114) - locked <0xcc6a6f10> (a org.apache.hadoop.hbase.client.RpcRetryingCaller) at org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:90) - locked <0xcc6a6f10> (a org.apache.hadoop.hbase.client.RpcRetryingCaller) at org.apache.hadoop.hbase.client.HBaseAdmin.executeCallable(HBaseAdmin.java:3347) at org.apache.hadoop.hbase.client.HBaseAdmin.assign(HBaseAdmin.java:1703) at org.apache.hadoop.hbase.HBaseTestingUtility.createMultiRegions(HBaseTestingUtility.java:1994) at org.apache.hadoop.hbase.HBaseTestingUtility.createMultiRegions(HBaseTestingUtility.java:1919) at org.apache.hadoop.hbase.HBaseTestingUtility.createMultiRegions(HBaseTestingUtility.java:1865) at org.apache.hadoop.hbase.catalog.TestMetaReaderEditor.testRetrying(TestMetaReaderEditor.java:106) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.runners.ParentRunner.run(ParentRunner.java:309) at org.junit.runners.Suite.runChild(Suite.java:127) at org.junit.runners.Suite.runChild(Suite.java:26) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) at java.util.concurrent.FutureTask.run(FutureTask.java:138) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918) at java.lang.Thread.run(Thread.java:662) "Low Memory Detector" daemon prio=10 tid=0x74907000 nid=0x776c runnable [0x00000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread1" daemon prio=10 tid=0x74905400 nid=0x776b waiting on condition [0x00000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread0" daemon prio=10 tid=0x74903400 nid=0x776a waiting on condition [0x00000000] java.lang.Thread.State: RUNNABLE "Signal Dispatcher" daemon prio=10 tid=0x74902400 nid=0x7769 runnable [0x00000000] java.lang.Thread.State: RUNNABLE "Finalizer" daemon prio=10 tid=0xf68ef400 nid=0x7768 in Object.wait() [0x75d7d000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x7ecfd798> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118) - locked <0x7ecfd798> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134) at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:171) "Reference Handler" daemon prio=10 tid=0xf68edc00 nid=0x7767 in Object.wait() [0x74ee4000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x7ec610c8> (a java.lang.ref.Reference$Lock) at java.lang.Object.wait(Object.java:485) at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116) - locked <0x7ec610c8> (a java.lang.ref.Reference$Lock) "main" prio=10 tid=0xf6805800 nid=0x775c waiting on condition [0xf698f000] java.lang.Thread.State: WAITING (parking) at sun.misc.Unsafe.park(Native Method) - parking to wait for <0x7ecfd8d0> (a java.util.concurrent.FutureTask$Sync) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:156) at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:811) at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:969) at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1281) at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:218) at java.util.concurrent.FutureTask.get(FutureTask.java:83) at org.apache.maven.surefire.junitcore.AsynchronousRunner.waitForCompletion(AsynchronousRunner.java:73) at org.apache.maven.surefire.junitcore.AsynchronousRunner.finished(AsynchronousRunner.java:58) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:242) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) at org.junit.runners.ParentRunner.run(ParentRunner.java:309) at org.junit.runner.JUnitCore.run(JUnitCore.java:160) at org.junit.runner.JUnitCore.run(JUnitCore.java:138) at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:61) at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:137) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:188) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:166) at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86) at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:101) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74) "VM Thread" prio=10 tid=0xf68ea000 nid=0x7765 runnable "GC task thread#0 (ParallelGC)" prio=10 tid=0xf680cc00 nid=0x775d runnable "GC task thread#1 (ParallelGC)" prio=10 tid=0xf680e000 nid=0x775e runnable "GC task thread#2 (ParallelGC)" prio=10 tid=0xf680f800 nid=0x775f runnable "GC task thread#3 (ParallelGC)" prio=10 tid=0xf6810c00 nid=0x7760 runnable "GC task thread#4 (ParallelGC)" prio=10 tid=0xf6812400 nid=0x7761 runnable "GC task thread#5 (ParallelGC)" prio=10 tid=0xf6813800 nid=0x7762 runnable "GC task thread#6 (ParallelGC)" prio=10 tid=0xf6815000 nid=0x7763 runnable "GC task thread#7 (ParallelGC)" prio=10 tid=0xf6816400 nid=0x7764 runnable "VM Periodic Task Thread" prio=10 tid=0x74909000 nid=0x776d waiting on condition JNI global references: 926 + echo '************ END zombies jstack extract' ************ END zombies jstack extract + JIRA_COMMENT=' {color:red}-1 core zombie tests{color}. There are 2 zombie test(s): at org.apache.hadoop.hbase.catalog.TestMetaReaderEditor.testRetrying(TestMetaReaderEditor.java:106)' + BAD=1 + jps + grep surefirebooter + cut -d ' ' -f 1 + xargs kill -9 POST BUILD TASK : SUCCESS END OF POST BUILD TASK : 0 Archiving artifacts Sending artifact delta relative to HBase-0.98 #350 Archived 1624 artifacts Archive block size is 32768 Received 59 blocks and 472042310 bytes Compression is 0.4% Took 4 min 59 sec Recording test results Updating HBASE-11380