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 2015/09/27 06:09:52 UTC
Build failed in Jenkins: HBase-0.98-on-Hadoop-1.1 #1085
See <https://builds.apache.org/job/HBase-0.98-on-Hadoop-1.1/1085/changes>
Changes:
[larsh] HBASE-14489 postScannerFilterRow consumes a lot of CPU.
------------------------------------------
[...truncated 27105 lines...]
at org.apache.hadoop.ipc.Server$Responder.doRunLoop(Server.java:856)
at org.apache.hadoop.ipc.Server$Responder.run(Server.java:839)
"org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@34f913d5" daemon prio=10 tid=0x00007fa8e51da000 nid=0x2b29 waiting on condition [0x00007fa8b2c8d000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor.run(BlockManager.java:3633)
at java.lang.Thread.run(Thread.java:744)
"org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor@4c85201e" daemon prio=10 tid=0x00007fa8e51d8000 nid=0x2b28 waiting on condition [0x00007fa8b2d8e000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor.run(HeartbeatManager.java:373)
at java.lang.Thread.run(Thread.java:744)
"DecommissionMonitor-0" daemon prio=10 tid=0x00007fa8e51d0000 nid=0x2b27 waiting on condition [0x00007fa8b2e8f000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007de7e00c0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1090)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
"org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@556bb6ef" daemon prio=10 tid=0x00007fa8e51ce000 nid=0x2b23 waiting on condition [0x00007fa8b2f90000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:221)
at java.lang.Thread.run(Thread.java:744)
"org.apache.hadoop.util.JvmPauseMonitor$Monitor@5be88c45" daemon prio=10 tid=0x00007fa8e51bf800 nid=0x2b1c waiting on condition [0x00007fa8b3192000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.util.JvmPauseMonitor$Monitor.run(JvmPauseMonitor.java:180)
at java.lang.Thread.run(Thread.java:744)
"IPC Server idle connection scanner for port 51643" daemon prio=10 tid=0x00007fa8e51a0800 nid=0x2b15 in Object.wait() [0x00007fa8b3293000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007deee6b48> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007deee6b48> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"Socket Reader #1 for port 51643" prio=10 tid=0x00007fa8e5169800 nid=0x2b14 runnable [0x00007fa8b3394000]
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
- locked <0x00000007dee0dd08> (a sun.nio.ch.Util$2)
- locked <0x00000007dee0dcf8> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000007dee0cc00> (a sun.nio.ch.EPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at org.apache.hadoop.ipc.Server$Listener$Reader.doRunLoop(Server.java:629)
- locked <0x00000007dee0ee38> (a org.apache.hadoop.ipc.Server$Listener$Reader)
at org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:608)
"Timer-0" daemon prio=10 tid=0x00007fa8e5088000 nid=0x2af1 in Object.wait() [0x00007fa8b3495000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007deee7948> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007deee7948> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"246900029@qtp-762577831-1 - Acceptor0 HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:37294" daemon prio=10 tid=0x00007fa8e5075000 nid=0x2ae1 runnable [0x00007fa8b3596000]
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
- locked <0x00000007def0bf38> (a sun.nio.ch.Util$2)
- locked <0x00000007def0bf28> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000007deeed0c8> (a sun.nio.ch.EPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
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)
"1531099245@qtp-762577831-0" daemon prio=10 tid=0x00007fa8e5074000 nid=0x2ae0 in Object.wait() [0x00007fa8b3697000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007deeecbc8> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
- locked <0x00000007deeecbc8> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
"pool-2-thread-1" prio=10 tid=0x00007fa8e504d000 nid=0x2ac8 waiting on condition [0x00007fa8c01f1000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007deeec4f8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1090)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
"Timer for 'NameNode' metrics system" daemon prio=10 tid=0x00007fa8e4f38800 nid=0x2aa7 in Object.wait() [0x00007fa8b3798000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007dee04688> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007dee04688> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"process reaper" daemon prio=10 tid=0x00007fa8e4a5f000 nid=0x291e waiting on condition [0x00007fa8c022a000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007de426938> (a java.util.concurrent.SynchronousQueue$TransferStack)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
"Service Thread" daemon prio=10 tid=0x00007fa8e4291000 nid=0x27ee runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x00007fa8e428f000 nid=0x27ed waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x00007fa8e428c000 nid=0x27ec waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x00007fa8e4281800 nid=0x27eb runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x00007fa8e426b000 nid=0x27ea in Object.wait() [0x00007fa8c16d5000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007dee04db0> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007dee04db0> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:189)
"Reference Handler" daemon prio=10 tid=0x00007fa8e4267000 nid=0x27e9 in Object.wait() [0x00007fa8c17d6000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007dee04f48> (a java.lang.ref.Reference$Lock)
at java.lang.Object.wait(Object.java:503)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133)
- locked <0x00000007dee04f48> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007fa8e400a800 nid=0x27da waiting on condition [0x00007fa8ec21f000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hbase.Waiter.waitFor(Waiter.java:196)
at org.apache.hadoop.hbase.Waiter.waitFor(Waiter.java:143)
at org.apache.hadoop.hbase.HBaseTestingUtility.waitFor(HBaseTestingUtility.java:4022)
at org.apache.hadoop.hbase.HBaseTestingUtility.waitTableEnabled(HBaseTestingUtility.java:3284)
at org.apache.hadoop.hbase.HBaseTestingUtility.waitTableEnabled(HBaseTestingUtility.java:3265)
at org.apache.hadoop.hbase.security.access.TestTablePermissions.beforeClass(TestTablePermissions.java:101)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:24)
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.junit.runners.Suite.runChild(Suite.java:128)
at org.junit.runners.Suite.runChild(Suite.java:27)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:108)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:78)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:54)
at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:144)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
"VM Thread" prio=10 tid=0x00007fa8e4264800 nid=0x27e8 runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007fa8e4020800 nid=0x27db runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007fa8e4022000 nid=0x27dc runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007fa8e4024000 nid=0x27dd runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007fa8e4026000 nid=0x27de runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007fa8e4027800 nid=0x27df runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007fa8e4029800 nid=0x27e0 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007fa8e402b800 nid=0x27e1 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007fa8e402d800 nid=0x27e2 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007fa8e402f000 nid=0x27e3 runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007fa8e4031000 nid=0x27e4 runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007fa8e4033000 nid=0x27e5 runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007fa8e4034800 nid=0x27e6 runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007fa8e4036800 nid=0x27e7 runnable
"VM Periodic Task Thread" prio=10 tid=0x00007fa8e429b800 nid=0x27ef waiting on condition
JNI global references: 202
+ echo '************ END zombies jstack extract'
************ END zombies jstack extract
+ JIRA_COMMENT='
{color:red}-1 core zombie tests{color}. There are 5 zombie test(s): at org.apache.hadoop.hbase.TestAcidGuarantees.testMobMixedAtomicity(TestAcidGuarantees.java:420)
at org.apache.hadoop.hbase.ResourceCheckerJUnitListener.testStarted(ResourceCheckerJUnitListener.java:178)
at org.junit.runner.notification.SynchronizedRunListener.testStarted(SynchronizedRunListener.java:49)'
+ 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-on-Hadoop-1.1 #978
Archived 1453 artifacts
Archive block size is 32768
Received 4 blocks and 176378869 bytes
Compression is 0.1%
Took 45 sec
Recording test results
Updating HBASE-14489