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/14 17:43:19 UTC
Build failed in Jenkins: HBase-1.1 #659
See <https://builds.apache.org/job/HBase-1.1/659/changes>
Changes:
[tedyu] HBASE-14380 Correct data gets skipped along with bad data in importTsv bulk load thru TsvImporterTextMapper (Bhupendra Kumar Jain)
------------------------------------------
[...truncated 2365 lines...]
[INFO] Apache HBase - Protocol ........................... SUCCESS [12.925s]
[INFO] Apache HBase - Common ............................. SUCCESS [1:24.118s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1:11.825s]
[INFO] Apache HBase - Client ............................. SUCCESS [1:22.445s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [7.300s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [6.570s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [9.143s]
[INFO] Apache HBase - Server ............................. FAILURE [1:29:24.811s]
[INFO] Apache HBase - Testing Util ....................... SKIPPED
[INFO] Apache HBase - Thrift ............................. SKIPPED
[INFO] Apache HBase - Rest ............................... SKIPPED
[INFO] Apache HBase - Shell .............................. SKIPPED
[INFO] Apache HBase - Integration Tests .................. SKIPPED
[INFO] Apache HBase - Examples ........................... SKIPPED
[INFO] Apache HBase - Assembly ........................... SKIPPED
[INFO] Apache HBase - Shaded ............................. SKIPPED
[INFO] Apache HBase - Shaded - Client .................... SKIPPED
[INFO] Apache HBase - Shaded - Server .................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:34:09.715s
[INFO] Finished at: Mon Sep 14 15:38:27 UTC 2015
[INFO] Final Memory: 91M/643M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18:test (secondPartTestsExecution) on project hbase-server: There are test failures.
[ERROR]
[ERROR] Please refer to <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire-reports> for the individual test results.
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :hbase-server
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script : ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
#It seems sometimes the tests are not dying immediately. Let's give them 10s
echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
sleep 10
ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
echo "************ BEGIN zombies jstack extract"
ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
echo "************ END zombies jstack extract"
JIRA_COMMENT="$JIRA_COMMENT
{color:red}-1 core zombie tests{color}. There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
BAD=1
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
else
echo "We're ok: there is no zombie test, but some tests took some time to stop"
fi
else
echo "We're ok: there is no zombie test"
fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson520659263331706248.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'Suspicious java process found - waiting 10s to see if there are just slow to stop'
Suspicious java process found - waiting 10s to see if there are just slow to stop
+ sleep 10
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'There are 1 zombie tests, they should have been killed by surefire but survived'
There are 1 zombie tests, they should have been killed by surefire but survived
+ echo '************ BEGIN zombies jstack extract'
************ BEGIN zombies jstack extract
++ jps
++ grep surefirebooter
++ grep .test
++ grep '\.java'
++ cut -d ' ' -f 1
++ xargs -n 1 jstack
+ ZB_STACK=' at org.apache.hadoop.io.compress.TestCodec.testGzipLongOverflow(TestCodec.java:814)'
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs -n 1 jstack
2015-09-14 15:38:40
Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.55-b03 mixed mode):
"Attach Listener" daemon prio=10 tid=0x00007f65fc001800 nid=0x796b waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"org.apache.hadoop.fs.FileSystem$Statistics$StatisticsDataReferenceCleaner" daemon prio=10 tid=0x00007f6608cd2000 nid=0x791c in Object.wait() [0x00007f65fadf5000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007b76b0068> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007b76b0068> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
at org.apache.hadoop.fs.FileSystem$Statistics$StatisticsDataReferenceCleaner.run(FileSystem.java:3116)
at java.lang.Thread.run(Thread.java:745)
"process reaper" daemon prio=10 tid=0x00007f6608b1a000 nid=0x78f6 waiting on condition [0x00007f65fae2e000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007b76a0ad8> (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:745)
"Service Thread" daemon prio=10 tid=0x00007f6608292000 nid=0x78f3 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x00007f660828e800 nid=0x78f2 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x00007f660828b800 nid=0x78f1 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x00007f6608281800 nid=0x78f0 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x00007f660826b000 nid=0x78ef in Object.wait() [0x00007f66005b7000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007b76b0748> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007b76b0748> (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=0x00007f6608267000 nid=0x78ee in Object.wait() [0x00007f66006b8000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007b76b07e0> (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 <0x00000007b76b07e0> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007f660800a000 nid=0x78de runnable [0x00007f660fa28000]
java.lang.Thread.State: RUNNABLE
at java.util.zip.Deflater.deflateBytes(Native Method)
at java.util.zip.Deflater.deflate(Deflater.java:430)
- locked <0x00000007af27b7c8> (a java.util.zip.ZStreamRef)
at java.util.zip.Deflater.deflate(Deflater.java:352)
at java.util.zip.DeflaterOutputStream.deflate(DeflaterOutputStream.java:251)
at java.util.zip.DeflaterOutputStream.write(DeflaterOutputStream.java:211)
at java.util.zip.GZIPOutputStream.write(GZIPOutputStream.java:146)
- locked <0x00000007af27b338> (a java.util.zip.GZIPOutputStream)
at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
at sun.nio.cs.StreamEncoder.implWrite(StreamEncoder.java:282)
at sun.nio.cs.StreamEncoder.write(StreamEncoder.java:125)
- locked <0x00000007af27b318> (a java.io.OutputStreamWriter)
at java.io.OutputStreamWriter.write(OutputStreamWriter.java:207)
at java.io.BufferedWriter.write(BufferedWriter.java:188)
- locked <0x00000007af27b318> (a java.io.OutputStreamWriter)
at java.io.Writer.write(Writer.java:127)
at org.apache.hadoop.io.compress.TestCodec.testGzipLongOverflow(TestCodec.java:814)
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: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.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
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.runners.ParentRunner.run(ParentRunner.java:309)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
"VM Thread" prio=10 tid=0x00007f6608264800 nid=0x78ed runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f6608020000 nid=0x78df runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007f6608022000 nid=0x78e0 runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007f6608024000 nid=0x78e1 runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007f6608025800 nid=0x78e2 runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007f6608027800 nid=0x78e3 runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007f6608029800 nid=0x78e4 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007f660802b000 nid=0x78e5 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007f660802d000 nid=0x78e6 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007f660802f000 nid=0x78e7 runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007f6608030800 nid=0x78e8 runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007f6608032800 nid=0x78e9 runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007f6608034800 nid=0x78ea runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007f6608036800 nid=0x78eb runnable
"VM Periodic Task Thread" prio=10 tid=0x00007f66082a4800 nid=0x78f4 waiting on condition
JNI global references: 233
+ echo '************ END zombies jstack extract'
************ END zombies jstack extract
+ JIRA_COMMENT='
{color:red}-1 core zombie tests{color}. There are 1 zombie test(s): at org.apache.hadoop.io.compress.TestCodec.testGzipLongOverflow(TestCodec.java:814)'
+ 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-1.1 #655
Archived 2091 artifacts
Archive block size is 32768
Received 42 blocks and 514424554 bytes
Compression is 0.3%
Took 2 min 44 sec
Recording test results
Updating HBASE-14380
Jenkins build is back to normal : HBase-1.1 #666
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/666/changes>
Build failed in Jenkins: HBase-1.1 #665
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/665/changes>
Changes:
[tedyu] HBASE-13250 chown of ExportSnapshot does not cover all path and files (He Liangliang)
------------------------------------------
[...truncated 2615 lines...]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007047047f8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007047047f8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)
"Reference Handler" daemon prio=10 tid=0x00007fb0f4267800 nid=0x747e in Object.wait() [0x00007fb09f610000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000704704410> (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 <0x0000000704704410> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007fb0f4009000 nid=0x746f waiting on condition [0x00007fb0fc589000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007077056d0> (a java.util.concurrent.CountDownLatch$Sync)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:834)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:994)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1303)
at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:236)
at org.apache.camel.impl.DefaultAsyncProcessorAwaitManager.await(DefaultAsyncProcessorAwaitManager.java:74)
at org.apache.camel.util.AsyncProcessorHelper.process(AsyncProcessorHelper.java:122)
at org.apache.camel.processor.UnitOfWorkProducer.process(UnitOfWorkProducer.java:68)
at org.apache.camel.impl.ProducerCache$2.doInProducer(ProducerCache.java:375)
at org.apache.camel.impl.ProducerCache$2.doInProducer(ProducerCache.java:343)
at org.apache.camel.impl.ProducerCache.doInProducer(ProducerCache.java:233)
at org.apache.camel.impl.ProducerCache.sendExchange(ProducerCache.java:343)
at org.apache.camel.impl.ProducerCache.send(ProducerCache.java:201)
at org.apache.camel.impl.DefaultProducerTemplate.send(DefaultProducerTemplate.java:128)
at org.apache.camel.impl.DefaultProducerTemplate.send(DefaultProducerTemplate.java:115)
at org.apache.camel.impl.DefaultProducerTemplate.request(DefaultProducerTemplate.java:297)
at org.apache.camel.component.jetty.jettyproducer.HttpJettyProducerRecipientListCustomThreadPoolTest.testRecipientList(HttpJettyProducerRecipientListCustomThreadPoolTest.java:40)
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: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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
"VM Thread" prio=10 tid=0x00007fb0f4263800 nid=0x747d runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007fb0f401f000 nid=0x7470 runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007fb0f4020800 nid=0x7471 runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007fb0f4022800 nid=0x7472 runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007fb0f4024800 nid=0x7473 runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007fb0f4026800 nid=0x7474 runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007fb0f4028000 nid=0x7475 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007fb0f402a000 nid=0x7476 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007fb0f402c000 nid=0x7477 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007fb0f402d800 nid=0x7478 runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007fb0f402f800 nid=0x7479 runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007fb0f4031800 nid=0x747a runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007fb0f4033800 nid=0x747b runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007fb0f4035000 nid=0x747c runnable
"VM Periodic Task Thread" prio=10 tid=0x00007fb0f42a4800 nid=0x7484 waiting on condition
JNI global references: 219
2015-09-16 22:03:23
Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.72-b04 mixed mode):
"Attach Listener" daemon prio=10 tid=0x00007fe5cc001000 nid=0x45d1 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Service Thread" daemon prio=10 tid=0x00007fe63429a000 nid=0x45a1 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x00007fe634297800 nid=0x45a0 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x00007fe634294800 nid=0x459f runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x00007fe634292800 nid=0x459e runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x00007fe634269800 nid=0x459d in Object.wait() [0x00007fe602fee000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007047047f8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007047047f8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)
"Reference Handler" daemon prio=10 tid=0x00007fe634267800 nid=0x459c in Object.wait() [0x00007fe6030ef000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000704704410> (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 <0x0000000704704410> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007fe634009000 nid=0x458d runnable [0x00007fe63c4c6000]
java.lang.Thread.State: RUNNABLE
at java.lang.AbstractStringBuilder.<init>(AbstractStringBuilder.java:64)
at java.lang.StringBuilder.<init>(StringBuilder.java:85)
at java.net.URLStreamHandler.parseURL(URLStreamHandler.java:249)
at sun.net.www.protocol.file.Handler.parseURL(Handler.java:67)
at java.net.URL.<init>(URL.java:614)
at java.net.URL.<init>(URL.java:482)
at sun.misc.URLClassPath$FileLoader.getResource(URLClassPath.java:1057)
at sun.misc.URLClassPath.getResource(URLClassPath.java:199)
at java.net.URLClassLoader$1.run(URLClassLoader.java:358)
at java.net.URLClassLoader$1.run(URLClassLoader.java:355)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:354)
at java.lang.ClassLoader.loadClass(ClassLoader.java:425)
- locked <0x00000007076d4ba8> (a java.lang.Object)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308)
at java.lang.ClassLoader.loadClass(ClassLoader.java:358)
at java.lang.Class.getDeclaredConstructors0(Native Method)
at java.lang.Class.privateGetDeclaredConstructors(Class.java:2585)
at java.lang.Class.getConstructor0(Class.java:2885)
at java.lang.Class.newInstance(Class.java:350)
at org.apache.camel.util.ObjectHelper.newInstance(ObjectHelper.java:1514)
at org.apache.camel.util.ReflectionInjector.newInstance(ReflectionInjector.java:32)
at org.apache.camel.impl.DefaultInjector.newInstance(DefaultInjector.java:45)
at org.apache.camel.impl.DefaultComponentResolver.resolveComponent(DefaultComponentResolver.java:87)
at org.apache.camel.impl.DefaultCamelContext.getComponent(DefaultCamelContext.java:389)
- locked <0x0000000706dccf80> (a java.util.HashMap)
at org.apache.camel.impl.DefaultCamelContext.getComponent(DefaultCamelContext.java:376)
at org.apache.camel.impl.DefaultCamelContext.getComponent(DefaultCamelContext.java:409)
at org.apache.camel.test.junit4.CamelTestSupport.doSetUp(CamelTestSupport.java:286)
at org.apache.camel.test.junit4.CamelTestSupport.setUp(CamelTestSupport.java:217)
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: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.RunBefores.evaluate(RunBefores.java:24)
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
"VM Thread" prio=10 tid=0x00007fe634263800 nid=0x459b runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007fe63401f000 nid=0x458e runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007fe634020800 nid=0x458f runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007fe634022800 nid=0x4590 runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007fe634024800 nid=0x4591 runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007fe634026800 nid=0x4592 runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007fe634028000 nid=0x4593 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007fe63402a000 nid=0x4594 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007fe63402c000 nid=0x4595 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007fe63402d800 nid=0x4596 runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007fe63402f800 nid=0x4597 runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007fe634031800 nid=0x4598 runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007fe634033800 nid=0x4599 runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007fe634035000 nid=0x459a runnable
"VM Periodic Task Thread" prio=10 tid=0x00007fe6342a4800 nid=0x45a2 waiting on condition
JNI global references: 194
+ 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.camel.component.jetty.jettyproducer.HttpJettyProducerRecipientListCustomThreadPoolTest.testRecipientList(HttpJettyProducerRecipientListCustomThreadPoolTest.java:40)
at org.apache.camel.test.junit4.CamelTestSupport.doStopCamelContext(CamelTestSupport.java:450)
at org.apache.camel.test.junit4.CamelTestSupport.tearDown(CamelTestSupport.java:351)'
+ 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-1.1 #655
Archived 2089 artifacts
Archive block size is 32768
Received 42 blocks and 500937350 bytes
Compression is 0.3%
Took 2 min 22 sec
Recording test results
Updating HBASE-13250
Build failed in Jenkins: HBase-1.1 #664
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/664/changes>
Changes:
[apurtell] HBASE-14400 Fix HBase RPC protection documentation
------------------------------------------
[...truncated 2183 lines...]
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.931 sec - in org.apache.hadoop.hbase.master.TestZKBasedOpenCloseRegion
Running org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.984 sec - in org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
Running org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
Running org.apache.hadoop.hbase.master.cleaner.TestSnapshotFromMaster
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.146 sec - in org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
Running org.apache.hadoop.hbase.master.TestZKLessAMOnCluster
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 29.369 sec - in org.apache.hadoop.hbase.master.cleaner.TestSnapshotFromMaster
Running org.apache.hadoop.hbase.master.TestMasterMetrics
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.356 sec - in org.apache.hadoop.hbase.master.TestMasterMetrics
Running org.apache.hadoop.hbase.master.TestDistributedLogSplitting
Tests run: 22, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 69.114 sec - in org.apache.hadoop.hbase.master.TestAssignmentManager
Running org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.452 sec - in org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
Running org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 133.855 sec - in org.apache.hadoop.hbase.master.TestSplitLogManager
Running org.apache.hadoop.hbase.master.TestRegionPlacement
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 19.134 sec - in org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
Running org.apache.hadoop.hbase.master.TestAssignmentListener
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 19.047 sec - in org.apache.hadoop.hbase.master.TestRegionPlacement
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.229 sec - in org.apache.hadoop.hbase.master.TestAssignmentListener
Running org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.587 sec - in org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
Running org.apache.hadoop.hbase.master.TestMasterPriorityRpc
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.382 sec - in org.apache.hadoop.hbase.master.TestMasterPriorityRpc
Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 34.678 sec - in org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
Running org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Tests run: 21, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 165.814 sec <<< FAILURE! - in org.apache.hadoop.hbase.master.TestZKLessAMOnCluster
testMoveRegion(org.apache.hadoop.hbase.master.TestZKLessAMOnCluster) Time elapsed: 50.062 sec <<< ERROR!
org.junit.runners.model.TestTimedOutException: test timed out after 50000 milliseconds
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hbase.client.HBaseAdmin$ProcedureFuture.waitProcedureResult(HBaseAdmin.java:4168)
at org.apache.hadoop.hbase.client.HBaseAdmin$ProcedureFuture.get(HBaseAdmin.java:4098)
at org.apache.hadoop.hbase.client.HBaseAdmin.disableTable(HBaseAdmin.java:1201)
at org.apache.hadoop.hbase.HBaseTestingUtility.deleteTable(HBaseTestingUtility.java:1877)
at org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster.testMoveRegion(TestAssignmentManagerOnCluster.java:427)
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.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.lang.Thread.run(Thread.java:744)
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.994 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 176.288 sec - in org.apache.hadoop.hbase.master.TestZKLessAMOnCluster
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.183 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Running org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Running org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 83.389 sec - in org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Tests run: 18, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 238.681 sec <<< FAILURE! - in org.apache.hadoop.hbase.master.TestDistributedLogSplitting
testDisallowWritesInRecovering(org.apache.hadoop.hbase.master.TestDistributedLogSplitting) Time elapsed: 11.169 sec <<< FAILURE!
java.lang.AssertionError: No RegionInRecoveryException. Following exceptions returned=[org.apache.hadoop.hbase.client.RetriesExhaustedException: Failed after attempts=3, exceptions:
Wed Sep 16 04:04:21 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
Wed Sep 16 04:04:21 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
Wed Sep 16 04:04:22 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
]
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.hadoop.hbase.master.TestDistributedLogSplitting.testDisallowWritesInRecovering(TestDistributedLogSplitting.java:980)
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 78.456 sec - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 497.367 sec - in org.apache.hadoop.hbase.master.balancer.TestStochasticLoadBalancer
Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 311.377 sec - in org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 303.373 sec - in org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Results :
Failed tests:
TestDistributedLogSplitting.testDisallowWritesInRecovering:980 No RegionInRecoveryException. Following exceptions returned=[org.apache.hadoop.hbase.client.RetriesExhaustedException: Failed after attempts=3, exceptions:
Wed Sep 16 04:04:21 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
Wed Sep 16 04:04:21 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
Wed Sep 16 04:04:22 UTC 2015, RpcRetryingCaller{globalStartTime=1442376261216, pause=100, retries=3}, org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: org.apache.hadoop.hbase.exceptions.RegionInRecoveryException: hbase:meta,,1.1588230740 is recovering; cannot take reads
at org.apache.hadoop.hbase.regionserver.HRegion.startRegionOperation(HRegion.java:7623)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2480)
at org.apache.hadoop.hbase.regionserver.HRegion.getScanner(HRegion.java:2475)
at org.apache.hadoop.hbase.regionserver.RSRpcServices.scan(RSRpcServices.java:2255)
at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$2.callBlockingMethod(ClientProtos.java:32205)
at org.apache.hadoop.hbase.ipc.RpcServer.call(RpcServer.java:2114)
at org.apache.hadoop.hbase.ipc.CallRunner.run(CallRunner.java:101)
at org.apache.hadoop.hbase.ipc.RpcExecutor.consumerLoop(RpcExecutor.java:130)
at org.apache.hadoop.hbase.ipc.RpcExecutor$1.run(RpcExecutor.java:107)
at java.lang.Thread.run(Thread.java:744)
]
Flaked tests:
org.apache.hadoop.hbase.master.TestZKLessAMOnCluster.testMoveRegion(org.apache.hadoop.hbase.master.TestZKLessAMOnCluster)
Run 1: TestZKLessAMOnCluster>TestAssignmentManagerOnCluster.testMoveRegion:427 ยป TestTimedOut
Run 2: PASS
org.apache.hadoop.hbase.regionserver.TestSplitTransactionOnCluster.testFailedSplit(org.apache.hadoop.hbase.regionserver.TestSplitTransactionOnCluster)
Run 1: TestSplitTransactionOnCluster.testFailedSplit:1338 null
Run 2: PASS
Tests run: 2661, Failures: 1, Errors: 0, Skipped: 20, Flakes: 2
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Apache HBase ...................................... SUCCESS [4.612s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [0.733s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.217s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [0.992s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [12.724s]
[INFO] Apache HBase - Common ............................. SUCCESS [1:24.079s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1:12.049s]
[INFO] Apache HBase - Client ............................. SUCCESS [1:22.364s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [7.249s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [6.629s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [9.292s]
[INFO] Apache HBase - Server ............................. FAILURE [1:34:49.685s]
[INFO] Apache HBase - Testing Util ....................... SKIPPED
[INFO] Apache HBase - Thrift ............................. SKIPPED
[INFO] Apache HBase - Rest ............................... SKIPPED
[INFO] Apache HBase - Shell .............................. SKIPPED
[INFO] Apache HBase - Integration Tests .................. SKIPPED
[INFO] Apache HBase - Examples ........................... SKIPPED
[INFO] Apache HBase - Assembly ........................... SKIPPED
[INFO] Apache HBase - Shaded ............................. SKIPPED
[INFO] Apache HBase - Shaded - Client .................... SKIPPED
[INFO] Apache HBase - Shaded - Server .................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:39:32.822s
[INFO] Finished at: Wed Sep 16 04:12:06 UTC 2015
[INFO] Final Memory: 90M/628M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (secondPartTestsExecution) on project hbase-server: ExecutionException: java.lang.RuntimeException: java.lang.RuntimeException: org.apache.maven.surefire.report.ReporterException: When writing xml report stdout/stderr: /tmp/stderr5599512790107458098deferred (No such file or directory) -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :hbase-server
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script : ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
#It seems sometimes the tests are not dying immediately. Let's give them 10s
echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
sleep 10
ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
echo "************ BEGIN zombies jstack extract"
ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
echo "************ END zombies jstack extract"
JIRA_COMMENT="$JIRA_COMMENT
{color:red}-1 core zombie tests{color}. There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
BAD=1
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
else
echo "We're ok: there is no zombie test, but some tests took some time to stop"
fi
else
echo "We're ok: there is no zombie test"
fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson6978429985893818071.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #655
Archived 2091 artifacts
Archive block size is 32768
Received 42 blocks and 509771918 bytes
Compression is 0.3%
Took 2 min 23 sec
Recording test results
Updating HBASE-14400
Build failed in Jenkins: HBase-1.1 #663
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/663/changes>
Changes:
[ssrungarapu] HBASE-14394 Properly close the connection after reading records from table.
------------------------------------------
[...truncated 2428 lines...]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :hbase-thrift
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script : ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
#It seems sometimes the tests are not dying immediately. Let's give them 10s
echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
sleep 10
ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
echo "************ BEGIN zombies jstack extract"
ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
echo "************ END zombies jstack extract"
JIRA_COMMENT="$JIRA_COMMENT
{color:red}-1 core zombie tests{color}. There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
BAD=1
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
else
echo "We're ok: there is no zombie test, but some tests took some time to stop"
fi
else
echo "We're ok: there is no zombie test"
fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson8212441844653624150.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'Suspicious java process found - waiting 10s to see if there are just slow to stop'
Suspicious java process found - waiting 10s to see if there are just slow to stop
+ sleep 10
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'There are 1 zombie tests, they should have been killed by surefire but survived'
There are 1 zombie tests, they should have been killed by surefire but survived
+ echo '************ BEGIN zombies jstack extract'
************ BEGIN zombies jstack extract
++ jps
++ grep surefirebooter
++ cut -d ' ' -f 1
++ xargs -n 1 jstack
++ grep .test
++ grep '\.java'
+ ZB_STACK=' at org.apache.hadoop.hbase.procedure2.TestProcedureReplayOrder.testSingleStepReplayOrder(TestProcedureReplayOrder.java:97)'
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs -n 1 jstack
2015-09-15 20:09:27
Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.51-b03 mixed mode):
"Attach Listener" daemon prio=10 tid=0x00007fcde4001000 nid=0x222a waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Time-limited test" daemon prio=10 tid=0x00007fce3c84c000 nid=0x21c5 waiting on condition [0x00007fcdf96a2000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hbase.procedure2.TestProcedureReplayOrder.testSingleStepReplayOrder(TestProcedureReplayOrder.java:97)
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.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.lang.Thread.run(Thread.java:744)
"ProcedureExecutorTimeoutThread" prio=10 tid=0x00007fce3c845000 nid=0x21c4 waiting on condition [0x00007fcdf97a4000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007c8c94dd8> (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 org.apache.hadoop.hbase.procedure2.util.TimeoutBlockingQueue.poll(TimeoutBlockingQueue.java:106)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.timeoutLoop(ProcedureExecutor.java:826)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.access$500(ProcedureExecutor.java:72)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor$3.run(ProcedureExecutor.java:485)
"ProcedureExecutor-0" prio=10 tid=0x00007fce3c843000 nid=0x21c3 waiting on condition [0x00007fce081a5000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007c8c768c0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.pushData(WALProcedureStore.java:484)
at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.update(WALProcedureStore.java:368)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.execProcedure(ProcedureExecutor.java:1089)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.execLoop(ProcedureExecutor.java:793)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.execLoop(ProcedureExecutor.java:746)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor.access$400(ProcedureExecutor.java:72)
at org.apache.hadoop.hbase.procedure2.ProcedureExecutor$2.run(ProcedureExecutor.java:476)
"WALProcedureStoreSyncThread" prio=10 tid=0x00007fce3c812800 nid=0x21be waiting on condition [0x00007fce084c7000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007c8c768a8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2176)
at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.syncLoop(WALProcedureStore.java:528)
at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.access$000(WALProcedureStore.java:65)
at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore$1.run(WALProcedureStore.java:171)
"process reaper" daemon prio=10 tid=0x00007fce3c74c000 nid=0x21a0 waiting on condition [0x00007fce08500000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007c739faf0> (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=0x00007fce3c291000 nid=0x219c runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x00007fce3c28f000 nid=0x219b waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x00007fce3c28c000 nid=0x219a waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x00007fce3c282000 nid=0x2199 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x00007fce3c26b000 nid=0x2198 in Object.wait() [0x00007fce08fdc000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007c5a85568> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007c5a85568> (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=0x00007fce3c267000 nid=0x2197 in Object.wait() [0x00007fce090dd000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007c5a850f0> (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 <0x00000007c5a850f0> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007fce3c00a800 nid=0x2184 waiting on condition [0x00007fce43aba000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007c9738278> (a java.util.concurrent.FutureTask)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:422)
at java.util.concurrent.FutureTask.get(FutureTask.java:199)
at org.junit.internal.runners.statements.FailOnTimeout.getResult(FailOnTimeout.java:141)
at org.junit.internal.runners.statements.FailOnTimeout.evaluate(FailOnTimeout.java:127)
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.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
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.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=0x00007fce3c265000 nid=0x2196 runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007fce3c020800 nid=0x2185 runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007fce3c022000 nid=0x2186 runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007fce3c024000 nid=0x2187 runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007fce3c026000 nid=0x2188 runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007fce3c027800 nid=0x2189 runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007fce3c029800 nid=0x218a runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007fce3c02b800 nid=0x218b runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007fce3c02d800 nid=0x218d runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007fce3c02f000 nid=0x218e runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007fce3c031000 nid=0x218f runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007fce3c033000 nid=0x2190 runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007fce3c034800 nid=0x2191 runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007fce3c036800 nid=0x2192 runnable
"VM Periodic Task Thread" prio=10 tid=0x00007fce3c29b800 nid=0x219d waiting on condition
JNI global references: 227
+ echo '************ END zombies jstack extract'
************ END zombies jstack extract
+ JIRA_COMMENT='
{color:red}-1 core zombie tests{color}. There are 1 zombie test(s): at org.apache.hadoop.hbase.procedure2.TestProcedureReplayOrder.testSingleStepReplayOrder(TestProcedureReplayOrder.java:97)'
+ BAD=1
+ jps
+ cut -d ' ' -f 1
+ grep surefirebooter
+ xargs kill -9
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #655
Archived 2108 artifacts
Archive block size is 32768
Received 42 blocks and 514813304 bytes
Compression is 0.3%
Took 2 min 15 sec
Recording test results
Updating HBASE-14394
Build failed in Jenkins: HBase-1.1 #662
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/662/changes>
Changes:
[stack] HBASE-14361 ReplicationSink should create Connection instances lazily
[tedyu] HBASE-14380 Correct data gets skipped along with bad data in importTsv bulk load thru TsvImporterTextMapper (Bhupendra Kumar Jain)
------------------------------------------
[...truncated 30939 lines...]
"org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@1d9ee9af" daemon prio=10 tid=0x00007f2275108000 nid=0x1666 waiting on condition [0x00007f2241a43000]
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@10e156cd" daemon prio=10 tid=0x00007f22750fe000 nid=0x1660 waiting on condition [0x00007f2241c45000]
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 41384" daemon prio=10 tid=0x00007f22750de800 nid=0x165f in Object.wait() [0x00007f2241d46000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1a401b8> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007d1a401b8> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"Socket Reader #1 for port 41384" prio=10 tid=0x00007f22750a0800 nid=0x165e runnable [0x00007f2241e47000]
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 <0x00000007d1a40310> (a sun.nio.ch.Util$2)
- locked <0x00000007d1a40320> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000007d1a402c8> (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 <0x00000007d1a40208> (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=0x00007f2274fb7800 nid=0x15fc in Object.wait() [0x00007f2241f48000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1a482f0> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007d1a482f0> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"702560322@qtp-1822687159-1 - Acceptor0 HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:36460" daemon prio=10 tid=0x00007f2274fab000 nid=0x15a4 runnable [0x00007f2242049000]
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 <0x00000007d1a48440> (a sun.nio.ch.Util$2)
- locked <0x00000007d1a48450> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000007d1a483f8> (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)
"1391678520@qtp-1822687159-0" daemon prio=10 tid=0x00007f2274fb1800 nid=0x15a2 in Object.wait() [0x00007f224214a000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1a40330> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
- locked <0x00000007d1a40330> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
"pool-2-thread-1" prio=10 tid=0x00007f2274f72800 nid=0x1570 waiting on condition [0x00007f224224b000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007d1a40408> (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=0x00007f2274e58000 nid=0x1527 in Object.wait() [0x00007f224234c000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1a40d80> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007d1a40d80> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"Attach Listener" daemon prio=10 tid=0x00007f2210001000 nid=0x14c1 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"process reaper" daemon prio=10 tid=0x00007f2274a20000 nid=0x136b waiting on condition [0x00007f2242d02000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007d1b57f90> (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=0x00007f2274291000 nid=0x1277 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x00007f227428f000 nid=0x1276 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x00007f227428c000 nid=0x1275 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x00007f2274281800 nid=0x1274 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x00007f227426b000 nid=0x1273 in Object.wait() [0x00007f226c285000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1802f48> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0x00000007d1802f48> (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=0x00007f2274267000 nid=0x1272 in Object.wait() [0x00007f226c386000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007d1802a70> (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 <0x00000007d1802a70> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0x00007f227400a800 nid=0x1260 runnable [0x00007f227acfd000]
java.lang.Thread.State: RUNNABLE
at java.io.UnixFileSystem.getBooleanAttributes0(Native Method)
at java.io.UnixFileSystem.getBooleanAttributes(UnixFileSystem.java:242)
at java.io.File.exists(File.java:813)
at sun.misc.URLClassPath$FileLoader.getResource(URLClassPath.java:1080)
at sun.misc.URLClassPath.getResource(URLClassPath.java:199)
at java.net.URLClassLoader$1.run(URLClassLoader.java:358)
at java.net.URLClassLoader$1.run(URLClassLoader.java:355)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:354)
at java.lang.ClassLoader.loadClass(ClassLoader.java:425)
- locked <0x00000007c6e899f0> (a java.lang.Object)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308)
at java.lang.ClassLoader.loadClass(ClassLoader.java:358)
at com.google.common.cache.LocalCache$AccessQueue.<init>(LocalCache.java:3780)
at com.google.common.cache.LocalCache$Segment.<init>(LocalCache.java:2165)
at com.google.common.cache.LocalCache.createSegment(LocalCache.java:1932)
at com.google.common.cache.LocalCache.<init>(LocalCache.java:300)
at com.google.common.cache.LocalCache$LocalLoadingCache.<init>(LocalCache.java:4866)
at com.google.common.cache.CacheBuilder.build(CacheBuilder.java:803)
at org.apache.hadoop.hdfs.server.datanode.DataNode.<init>(DataNode.java:439)
at org.apache.hadoop.hdfs.server.datanode.DataNode.makeInstance(DataNode.java:2373)
at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:2260)
at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:1449)
- locked <0x00000007d1b58778> (a org.apache.hadoop.hdfs.MiniDFSCluster)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:832)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:742)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniDFSCluster(HBaseTestingUtility.java:632)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:1026)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:907)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:889)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:876)
at org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScanBase.setUpBeforeClass(TestTableInputFormatScanBase.java:84)
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=0x00007f2274265000 nid=0x1271 runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f2274020800 nid=0x1262 runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0x00007f2274022000 nid=0x1263 runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0x00007f2274024000 nid=0x1264 runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0x00007f2274026000 nid=0x1265 runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0x00007f2274027800 nid=0x1266 runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0x00007f2274029800 nid=0x1267 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0x00007f227402b800 nid=0x1268 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0x00007f227402d800 nid=0x1269 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007f227402f000 nid=0x126a runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007f2274031000 nid=0x126b runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007f2274033000 nid=0x126c runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007f2274034800 nid=0x126d runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007f2274036800 nid=0x126e runnable
"VM Periodic Task Thread" prio=10 tid=0x00007f227429c000 nid=0x1278 waiting on condition
JNI global references: 154
+ 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.mapreduce.TestHFileOutputFormat.testMRIncrementalLoadWithSplit(TestHFileOutputFormat.java:384)
at org.apache.hadoop.hbase.mapreduce.TestImportExport.testWithFilter(TestImportExport.java:455)'
+ BAD=1
+ jps
+ grep surefirebooter
+ xargs kill -9
+ cut -d ' ' -f 1
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #655
Archived 1977 artifacts
Archive block size is 32768
Received 22 blocks and 462834976 bytes
Compression is 0.2%
Took 5 min 6 sec
Recording test results
Updating HBASE-14361
Updating HBASE-14380
Build failed in Jenkins: HBase-1.1 #661
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/661/changes>
Changes:
[stack] HBASE-14428 Upgrade our surefire-plugin from 2.18 to 2.18.1
------------------------------------------
[...truncated 2172 lines...]
Running org.apache.hadoop.hbase.client.TestFromClientSide
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 149.394 sec - in org.apache.hadoop.hbase.client.TestRestoreSnapshotFromClientWithRegionReplicas
Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 260.959 sec - in org.apache.hadoop.hbase.client.TestReplicasClient
Running org.apache.hadoop.hbase.client.TestSnapshotFromClientWithRegionReplicas
Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 104.148 sec - in org.apache.hadoop.hbase.client.TestAdmin2
Running org.apache.hadoop.hbase.client.TestCheckAndMutate
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.597 sec - in org.apache.hadoop.hbase.client.TestCheckAndMutate
Running org.apache.hadoop.hbase.client.TestResultSizeEstimation
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.757 sec - in org.apache.hadoop.hbase.client.TestResultSizeEstimation
Running org.apache.hadoop.hbase.client.TestSnapshotMetadata
Running org.apache.hadoop.hbase.client.TestClientOperationInterrupt
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 28.298 sec - in org.apache.hadoop.hbase.client.TestSnapshotFromClientWithRegionReplicas
Running org.apache.hadoop.hbase.client.TestFromClientSideWithCoprocessor
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 33.335 sec - in org.apache.hadoop.hbase.client.TestSnapshotMetadata
Running org.apache.hadoop.hbase.TestDrainingServer
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 54.597 sec - in org.apache.hadoop.hbase.client.TestClientOperationInterrupt
Running org.apache.hadoop.hbase.TestMetaTableAccessor
Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.867 sec - in org.apache.hadoop.hbase.TestMetaTableAccessor
Running org.apache.hadoop.hbase.TestHBaseOnOtherDfsCluster
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 61.781 sec - in org.apache.hadoop.hbase.TestDrainingServer
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.886 sec - in org.apache.hadoop.hbase.TestHBaseOnOtherDfsCluster
Running org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildBase
Running org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildOverlap
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.708 sec - in org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildOverlap
Running org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildHole
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.322 sec - in org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildBase
Running org.apache.hadoop.hbase.util.TestTableName
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.52 sec - in org.apache.hadoop.hbase.util.TestTableName
Running org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy
Tests run: 82, Failures: 0, Errors: 0, Skipped: 4, Time elapsed: 204.819 sec - in org.apache.hadoop.hbase.client.TestFromClientSide
Running org.apache.hadoop.hbase.util.TestMiniClusterLoadEncoded
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.466 sec - in org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildHole
Running org.apache.hadoop.hbase.util.TestMiniClusterLoadSequential
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.147 sec - in org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy
Running org.apache.hadoop.hbase.util.TestIdLock
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.378 sec - in org.apache.hadoop.hbase.util.TestIdLock
Running org.apache.hadoop.hbase.util.TestMergeTable
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 47.587 sec - in org.apache.hadoop.hbase.util.TestMiniClusterLoadEncoded
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.551 sec - in org.apache.hadoop.hbase.util.TestMergeTable
Running org.apache.hadoop.hbase.util.TestHBaseFsckEncryption
Running org.apache.hadoop.hbase.util.TestMiniClusterLoadParallel
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 46.722 sec - in org.apache.hadoop.hbase.util.TestMiniClusterLoadSequential
Running org.apache.hadoop.hbase.util.TestHBaseFsck
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.411 sec - in org.apache.hadoop.hbase.util.TestHBaseFsckEncryption
Running org.apache.hadoop.hbase.util.TestProcessBasedCluster
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.179 sec - in org.apache.hadoop.hbase.util.TestProcessBasedCluster
Running org.apache.hadoop.hbase.util.TestMergeTool
Tests run: 82, Failures: 0, Errors: 0, Skipped: 4, Time elapsed: 209.781 sec - in org.apache.hadoop.hbase.client.TestFromClientSideWithCoprocessor
Running org.apache.hadoop.hbase.util.TestFSTableDescriptors
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 19.724 sec - in org.apache.hadoop.hbase.util.TestMergeTool
Running org.apache.hadoop.hbase.util.TestFSHDFSUtils
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.302 sec - in org.apache.hadoop.hbase.util.TestFSTableDescriptors
Running org.apache.hadoop.hbase.util.TestConnectionCache
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 45.482 sec - in org.apache.hadoop.hbase.util.TestMiniClusterLoadParallel
Running org.apache.hadoop.hbase.util.TestFSVisitor
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.902 sec - in org.apache.hadoop.hbase.util.TestFSHDFSUtils
Running org.apache.hadoop.hbase.util.TestFSUtils
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.536 sec - in org.apache.hadoop.hbase.util.TestFSVisitor
Running org.apache.hadoop.hbase.util.TestDefaultEnvironmentEdge
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.373 sec - in org.apache.hadoop.hbase.util.TestDefaultEnvironmentEdge
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.647 sec - in org.apache.hadoop.hbase.util.TestConnectionCache
Running org.apache.hadoop.hbase.wal.TestWALFiltering
Running org.apache.hadoop.hbase.util.TestRegionSplitter
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.578 sec - in org.apache.hadoop.hbase.util.TestFSUtils
Running org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.636 sec - in org.apache.hadoop.hbase.util.TestRegionSplitter
Running org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.266 sec - in org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.776 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Running org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestWALSplit
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.421 sec - in org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.39 sec - in org.apache.hadoop.hbase.wal.TestWALFiltering
Running org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.813 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Running org.apache.hadoop.hbase.wal.TestWALFactory
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.776 sec - in org.apache.hadoop.hbase.wal.TestWALFactory
Running org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 19.437 sec - in org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Running org.apache.hadoop.hbase.namespace.TestZKLessNamespaceAuditor
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 100.844 sec - in org.apache.hadoop.hbase.namespace.TestZKLessNamespaceAuditor
Running org.apache.hadoop.hbase.namespace.TestNamespaceAuditor
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 185.738 sec - in org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 191.954 sec - in org.apache.hadoop.hbase.wal.TestWALSplit
Running org.apache.hadoop.hbase.constraint.TestConstraint
Running org.apache.hadoop.hbase.TestNamespace
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.212 sec - in org.apache.hadoop.hbase.constraint.TestConstraint
Tests run: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 25.617 sec - in org.apache.hadoop.hbase.TestNamespace
Running org.apache.hadoop.hbase.TestInfoServers
Running org.apache.hadoop.hbase.TestMetaMigrationConvertingToPB
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.888 sec - in org.apache.hadoop.hbase.TestInfoServers
Running org.apache.hadoop.hbase.TestRegionRebalancing
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.041 sec - in org.apache.hadoop.hbase.TestMetaMigrationConvertingToPB
Running org.apache.hadoop.hbase.filter.TestMultiRowRangeFilter
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.423 sec - in org.apache.hadoop.hbase.filter.TestMultiRowRangeFilter
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 103.955 sec - in org.apache.hadoop.hbase.namespace.TestNamespaceAuditor
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 38.339 sec - in org.apache.hadoop.hbase.TestRegionRebalancing
Running org.apache.hadoop.hbase.filter.TestScanRowPrefix
Running org.apache.hadoop.hbase.filter.TestFilterWrapper
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.532 sec - in org.apache.hadoop.hbase.filter.TestScanRowPrefix
Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilterEndToEnd
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.658 sec - in org.apache.hadoop.hbase.filter.TestFilterWrapper
Running org.apache.hadoop.hbase.filter.TestFuzzyRowAndColumnRangeFilter
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.145 sec - in org.apache.hadoop.hbase.filter.TestFuzzyRowAndColumnRangeFilter
Running org.apache.hadoop.hbase.filter.TestColumnRangeFilter
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.047 sec - in org.apache.hadoop.hbase.filter.TestColumnRangeFilter
Tests run: 51, Failures: 1, Errors: 0, Skipped: 1, Time elapsed: 387.62 sec <<< FAILURE! - in org.apache.hadoop.hbase.util.TestHBaseFsck
testSplitDaughtersNotInMeta(org.apache.hadoop.hbase.util.TestHBaseFsck) Time elapsed: 8.989 sec <<< FAILURE!
java.lang.AssertionError: null
at org.junit.Assert.fail(Assert.java:86)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.junit.Assert.assertNotNull(Assert.java:712)
at org.junit.Assert.assertNotNull(Assert.java:722)
at org.apache.hadoop.hbase.util.TestHBaseFsck.testSplitDaughtersNotInMeta(TestHBaseFsck.java:1772)
Running org.apache.hadoop.hbase.filter.TestFilterWithScanLimits
Running org.apache.hadoop.hbase.io.TestFileLink
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.23 sec - in org.apache.hadoop.hbase.filter.TestFilterWithScanLimits
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 402.47 sec - in org.apache.hadoop.hbase.util.TestHBaseFsck
Running org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.478 sec - in org.apache.hadoop.hbase.io.TestFileLink
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.736 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.152 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 43.889 sec - in org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 63.051 sec - in org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.769 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.121 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 30.474 sec - in org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 92.138 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Killed
Killed
Killed
Killed
Killed
Running org.apache.hadoop.hbase.TestClusterBootOrder
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.226 sec - in org.apache.hadoop.hbase.TestClusterBootOrder
Results :
Flaked tests:
org.apache.hadoop.hbase.util.TestHBaseFsck.testSplitDaughtersNotInMeta(org.apache.hadoop.hbase.util.TestHBaseFsck)
Run 1: TestHBaseFsck.testSplitDaughtersNotInMeta:1772 null
Run 2: PASS
Tests run: 2370, Failures: 0, Errors: 0, Skipped: 17, Flakes: 1
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Apache HBase ...................................... SUCCESS [5.406s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [3.404s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.496s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.397s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [17.742s]
[INFO] Apache HBase - Common ............................. SUCCESS [1:38.103s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1:13.866s]
[INFO] Apache HBase - Client ............................. SUCCESS [1:25.050s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [7.415s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [7.375s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [10.718s]
[INFO] Apache HBase - Server ............................. FAILURE [1:37:48.447s]
[INFO] Apache HBase - Testing Util ....................... SKIPPED
[INFO] Apache HBase - Thrift ............................. SKIPPED
[INFO] Apache HBase - Rest ............................... SKIPPED
[INFO] Apache HBase - Shell .............................. SKIPPED
[INFO] Apache HBase - Integration Tests .................. SKIPPED
[INFO] Apache HBase - Examples ........................... SKIPPED
[INFO] Apache HBase - Assembly ........................... SKIPPED
[INFO] Apache HBase - Shaded ............................. SKIPPED
[INFO] Apache HBase - Shaded - Client .................... SKIPPED
[INFO] Apache HBase - Shaded - Server .................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:43:01.940s
[INFO] Finished at: Tue Sep 15 05:10:12 UTC 2015
[INFO] Final Memory: 92M/623M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (secondPartTestsExecution) on project hbase-server: ExecutionException: java.lang.RuntimeException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd <https://builds.apache.org/job/HBase-1.1/ws/hbase-server> && /home/jenkins/jenkins-slave/tools/hudson.model.JDK/jdk-1.7u51/jre/bin/java -enableassertions -XX:MaxDirectMemorySize=1G -Xmx2800m -XX:MaxPermSize=256m -Djava.security.egd=file:/dev/./urandom -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -jar <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefirebooter2520992133599460362.jar> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire6917437942816118824tmp> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire_12402231963844098043447tmp>
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :hbase-server
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script : ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
#It seems sometimes the tests are not dying immediately. Let's give them 10s
echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
sleep 10
ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
echo "************ BEGIN zombies jstack extract"
ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
echo "************ END zombies jstack extract"
JIRA_COMMENT="$JIRA_COMMENT
{color:red}-1 core zombie tests{color}. There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
BAD=1
jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
else
echo "We're ok: there is no zombie test, but some tests took some time to stop"
fi
else
echo "We're ok: there is no zombie test"
fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson8426970886641339712.sh
++ jps
++ wc -l
++ grep surefirebooter
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #655
Archived 2079 artifacts
Archive block size is 32768
Received 42 blocks and 495211201 bytes
Compression is 0.3%
Took 2 min 12 sec
Recording test results
Updating HBASE-14428
Build failed in Jenkins: HBase-1.1 #660
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/660/changes>
Changes:
[tedyu] HBASE-14380 Revert due to TestImportTsv#testMROnTableWithCustomMapper failure
------------------------------------------
[...truncated 35293 lines...]
"org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor@6c45ee6e" #32 daemon prio=5 os_prio=0 tid=0x00007f12752a9000 nid=0x5118 waiting on condition [0x00007f1221219000]
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:319)
at java.lang.Thread.run(Thread.java:745)
"org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor@f74e835" #42 daemon prio=5 os_prio=0 tid=0x00007f12752a7800 nid=0x5117 waiting on condition [0x00007f122131a000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor.run(DecommissionManager.java:76)
at java.lang.Thread.run(Thread.java:745)
"org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@1c9f0a20" #41 daemon prio=5 os_prio=0 tid=0x00007f12752a5800 nid=0x5116 waiting on condition [0x00007f122141b000]
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:745)
"org.apache.hadoop.util.JvmPauseMonitor$Monitor@f27ea3" #37 daemon prio=5 os_prio=0 tid=0x00007f127529e800 nid=0x5110 waiting on condition [0x00007f122161d000]
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:745)
"IPC Server idle connection scanner for port 52875" #35 daemon prio=5 os_prio=0 tid=0x00007f127527b800 nid=0x510c in Object.wait() [0x00007f122171e000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007165f08c8> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"Socket Reader #1 for port 52875" #34 prio=5 os_prio=0 tid=0x00007f1275243800 nid=0x510b runnable [0x00007f122181f000]
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:86)
- locked <0x00000007165effc8> (a sun.nio.ch.Util$2)
- locked <0x00000007165effb8> (a java.util.Collections$UnmodifiableSet)
- locked <0x00000007165ef608> (a sun.nio.ch.EPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
at org.apache.hadoop.ipc.Server$Listener$Reader.doRunLoop(Server.java:616)
- locked <0x00000007165f18d0> (a org.apache.hadoop.ipc.Server$Listener$Reader)
at org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:595)
"Timer-0" #30 daemon prio=5 os_prio=0 tid=0x00007f1275133800 nid=0x50e4 in Object.wait() [0x00007f1221d20000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
at java.util.TimerThread.mainLoop(Timer.java:552)
- locked <0x00000007166c8850> (a java.util.TaskQueue)
at java.util.TimerThread.run(Timer.java:505)
"124734309@qtp-1783083399-1 - Acceptor0 HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:36963" #29 daemon prio=5 os_prio=0 tid=0x00007f1275121800 nid=0x5099 runnable [0x00007f1221e21000]
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:86)
- locked <0x0000000714bbe178> (a sun.nio.ch.Util$2)
- locked <0x0000000714bbe168> (a java.util.Collections$UnmodifiableSet)
- locked <0x0000000714bbdda0> (a sun.nio.ch.EPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
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)
"885002305@qtp-1783083399-0" #28 daemon prio=5 os_prio=0 tid=0x00007f1275121000 nid=0x5098 in Object.wait() [0x00007f122c1e1000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000714bbe428> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
- locked <0x0000000714bbe428> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
"process reaper" #19 daemon prio=10 os_prio=0 tid=0x00007f1274daa800 nid=0x500a waiting on condition [0x00007f122c725000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007110529b8> (a java.util.concurrent.SynchronousQueue$TransferStack)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
"Service Thread" #17 daemon prio=9 os_prio=0 tid=0x00007f12742d6800 nid=0x4f71 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread11" #16 daemon prio=9 os_prio=0 tid=0x00007f12742d1800 nid=0x4f70 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread10" #15 daemon prio=9 os_prio=0 tid=0x00007f12742cf800 nid=0x4f6f waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread9" #14 daemon prio=9 os_prio=0 tid=0x00007f12742cd800 nid=0x4f6e waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread8" #13 daemon prio=9 os_prio=0 tid=0x00007f12742cb800 nid=0x4f6d waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread7" #12 daemon prio=9 os_prio=0 tid=0x00007f12742c9800 nid=0x4f6c waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread6" #11 daemon prio=9 os_prio=0 tid=0x00007f12742c7800 nid=0x4f6b waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread5" #10 daemon prio=9 os_prio=0 tid=0x00007f12742c5000 nid=0x4f6a waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread4" #9 daemon prio=9 os_prio=0 tid=0x00007f12742bb000 nid=0x4f69 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread3" #8 daemon prio=9 os_prio=0 tid=0x00007f12742b9000 nid=0x4f68 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread2" #7 daemon prio=9 os_prio=0 tid=0x00007f12742b6800 nid=0x4f67 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" #6 daemon prio=9 os_prio=0 tid=0x00007f12742b5000 nid=0x4f66 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0x00007f12742b2000 nid=0x4f65 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0x00007f12742b0800 nid=0x4f64 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" #3 daemon prio=8 os_prio=0 tid=0x00007f1274279000 nid=0x4f63 in Object.wait() [0x00007f122eceb000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
- locked <0x0000000711033cc0> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)
"Reference Handler" #2 daemon prio=10 os_prio=0 tid=0x00007f1274276800 nid=0x4f62 in Object.wait() [0x00007f122edec000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:157)
- locked <0x000000071103c6d8> (a java.lang.ref.Reference$Lock)
"main" #1 prio=5 os_prio=0 tid=0x00007f127400a800 nid=0x4f53 waiting on condition [0x00007f127a261000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.hadoop.mapreduce.Job.monitorAndPrintJob(Job.java:1348)
at org.apache.hadoop.mapreduce.Job.waitForCompletion(Job.java:1306)
at org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScanBase.testScan(TestTableInputFormatScanBase.java:244)
at org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan2.testScanYZYToEmpty(TestTableInputFormatScan2.java:109)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
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.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
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.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: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:107)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:77)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:53)
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" os_prio=0 tid=0x00007f1274271800 nid=0x4f61 runnable
"GC task thread#0 (ParallelGC)" os_prio=0 tid=0x00007f127401f800 nid=0x4f54 runnable
"GC task thread#1 (ParallelGC)" os_prio=0 tid=0x00007f1274021800 nid=0x4f55 runnable
"GC task thread#2 (ParallelGC)" os_prio=0 tid=0x00007f1274023000 nid=0x4f56 runnable
"GC task thread#3 (ParallelGC)" os_prio=0 tid=0x00007f1274025000 nid=0x4f57 runnable
"GC task thread#4 (ParallelGC)" os_prio=0 tid=0x00007f1274026800 nid=0x4f58 runnable
"GC task thread#5 (ParallelGC)" os_prio=0 tid=0x00007f1274028800 nid=0x4f59 runnable
"GC task thread#6 (ParallelGC)" os_prio=0 tid=0x00007f127402a000 nid=0x4f5a runnable
"GC task thread#7 (ParallelGC)" os_prio=0 tid=0x00007f127402c000 nid=0x4f5b runnable
"GC task thread#8 (ParallelGC)" os_prio=0 tid=0x00007f127402d800 nid=0x4f5c runnable
"GC task thread#9 (ParallelGC)" os_prio=0 tid=0x00007f127402f800 nid=0x4f5d runnable
"GC task thread#10 (ParallelGC)" os_prio=0 tid=0x00007f1274031000 nid=0x4f5e runnable
"GC task thread#11 (ParallelGC)" os_prio=0 tid=0x00007f1274033000 nid=0x4f5f runnable
"GC task thread#12 (ParallelGC)" os_prio=0 tid=0x00007f1274034800 nid=0x4f60 runnable
"VM Periodic Task Thread" os_prio=0 tid=0x00007f12742d9800 nid=0x4f72 waiting on condition
JNI global references: 386
+ 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.mapreduce.TestHFileOutputFormat.testExcludeMinorCompaction(TestHFileOutputFormat.java:1006)
at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFiles.testRegionCrossingHFileSplit(TestLoadIncrementalHFiles.java:195)
at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFiles.testRegionCrossingHFileSplitRowBloom(TestLoadIncrementalHFiles.java:182)
at org.apache.hadoop.hbase.mapreduce.TestTableMapReduceBase.testCombiner(TestTableMapReduceBase.java:106)
at org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScanBase.testScan(TestTableInputFormatScanBase.java:244)
at org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan2.testScanYZYToEmpty(TestTableInputFormatScan2.java:109)'
+ BAD=1
+ xargs kill -9
+ grep surefirebooter
+ jps
+ cut -d ' ' -f 1
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #655
Archived 2208 artifacts
Archive block size is 32768
Received 42 blocks and 527931557 bytes
Compression is 0.3%
Took 3 min 11 sec
Recording test results
Updating HBASE-14380