You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@hbase.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2013/08/18 11:44:56 UTC

Build failed in Jenkins: hbase-0.95 #463

See <https://builds.apache.org/job/hbase-0.95/463/changes>

Changes:

[jeffreyz] HBASE-9257: TestAsyncProcess#testFailAndSuccess fails sometime due to a race condition

------------------------------------------
[...truncated 8325 lines...]
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:1408)

"IPC Server handler 1 on 34039" daemon prio=10 tid=0x73af6400 nid=0x35fc waiting on condition [0x72fcb000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x7eb0a768> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:156)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:1408)

"IPC Server handler 0 on 34039" daemon prio=10 tid=0x73af8c00 nid=0x35fb waiting on condition [0x7301c000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x7eb0a768> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:156)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:1408)

"IPC Server listener on 34039" daemon prio=10 tid=0x73af3c00 nid=0x35fa runnable [0x7306d000]
   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 <0x7eb0ac70> (a sun.nio.ch.Util$2)
	- locked <0x7eb0ac60> (a java.util.Collections$UnmodifiableSet)
	- locked <0x7eb0aa60> (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=0x73967400 nid=0x35f9 runnable [0x730be000]
   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 <0x7eb0b5d8> (a sun.nio.ch.Util$2)
	- locked <0x7eb0b5c8> (a java.util.Collections$UnmodifiableSet)
	- locked <0x7eb0b3e0> (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=0x746cac00 nid=0x35f8 in Object.wait() [0x7310f000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7f1ee0c8> (a java.util.TaskQueue)
	at java.util.TimerThread.mainLoop(Timer.java:509)
	- locked <0x7f1ee0c8> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:462)

"10163824@qtp-4815108-1 - Acceptor0 SelectChannelConnector@localhost:50944" prio=10 tid=0x73a4cc00 nid=0x35f7 runnable [0x73160000]
   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 <0x7f1e9988> (a sun.nio.ch.Util$2)
	- locked <0x7f1e9978> (a java.util.Collections$UnmodifiableSet)
	- locked <0x7f1e8748> (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)

"19161779@qtp-4815108-0" prio=10 tid=0x7396d400 nid=0x35f6 in Object.wait() [0x731b1000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7eb09770> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
	- locked <0x7eb09770> (a org.mortbay.thread.QueuedThreadPool$PoolThread)

"pool-2-thread-1" prio=10 tid=0x73707c00 nid=0x35f5 runnable [0x73202000]
   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 <0x7eb098d0> (a sun.nio.ch.Util$2)
	- locked <0x7eb098e0> (a java.util.Collections$UnmodifiableSet)
	- locked <0x7eb09890> (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 <0x7eb098f0> (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@1dcc2a3" daemon prio=10 tid=0x73cfc400 nid=0x35f4 waiting on condition [0x73253000]
   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@1579a30" daemon prio=10 tid=0x7399b800 nid=0x35f3 waiting on condition [0x732a4000]
   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@d5c0f9" daemon prio=10 tid=0x7371c400 nid=0x35f2 waiting on condition [0x732f5000]
   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@9fa8f" daemon prio=10 tid=0x739ae400 nid=0x35f1 waiting on condition [0x7477d000]
   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@19a37a" daemon prio=10 tid=0x73a66400 nid=0x35f0 waiting on condition [0x75172000]
   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=0x73d96400 nid=0x35ed in Object.wait() [0x73e8a000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x82b14b78> (a java.lang.Thread)
	at java.lang.Thread.join(Thread.java:1186)
	- locked <0x82b14b78> (a java.lang.Thread)
	at java.lang.Thread.join(Thread.java:1239)
	at org.apache.hadoop.mapred.MiniMRCluster.shutdown(MiniMRCluster.java:745)
	at org.apache.hadoop.hbase.HBaseTestingUtility.shutdownMiniMapReduceCluster(HBaseTestingUtility.java:1979)
	at org.apache.hadoop.hbase.mapreduce.TestTableMapReduce.afterClass(TestTableMapReduce.java:79)
	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.RunAfters.evaluate(RunAfters.java:33)
	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=0x74807000 nid=0x35eb runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread1" daemon prio=10 tid=0x74805400 nid=0x35ea waiting on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" daemon prio=10 tid=0x74803400 nid=0x35e9 waiting on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" daemon prio=10 tid=0x74802400 nid=0x35e8 runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=10 tid=0xf67ef400 nid=0x35e7 in Object.wait() [0x75b7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7eb247c8> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
	- locked <0x7eb247c8> (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=0xf67edc00 nid=0x35e6 in Object.wait() [0x74de4000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7eb09b40> (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 <0x7eb09b40> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6705800 nid=0x35dc waiting on condition [0xf68c2000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x7eb24a48> (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=0xf67ea000 nid=0x35e5 runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0xf670cc00 nid=0x35dd runnable 

"GC task thread#1 (ParallelGC)" prio=10 tid=0xf670e000 nid=0x35de runnable 

"GC task thread#2 (ParallelGC)" prio=10 tid=0xf670f800 nid=0x35df runnable 

"GC task thread#3 (ParallelGC)" prio=10 tid=0xf6710c00 nid=0x35e0 runnable 

"GC task thread#4 (ParallelGC)" prio=10 tid=0xf6712400 nid=0x35e1 runnable 

"GC task thread#5 (ParallelGC)" prio=10 tid=0xf6713800 nid=0x35e2 runnable 

"GC task thread#6 (ParallelGC)" prio=10 tid=0xf6715000 nid=0x35e3 runnable 

"GC task thread#7 (ParallelGC)" prio=10 tid=0xf6716400 nid=0x35e4 runnable 

"VM Periodic Task Thread" prio=10 tid=0x74811000 nid=0x35ec waiting on condition 

JNI global references: 1114

+ 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.mapreduce.TestLoadIncrementalHFilesSplitRecovery.testBulkLoadPhaseFailure(TestLoadIncrementalHFilesSplitRecovery.java:265)'
+ BAD=1
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs kill -9
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Recording test results
Updating HBASE-9257

Jenkins build is back to normal : hbase-0.95 #464

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/hbase-0.95/464/changes>