See <https://builds.apache.org/job/HBase-TRUNK/5486/changes>
Changes: [stack] Note on bucketcache needs 0.98.6 ------------------------------------------ [...truncated 2601 lines...] [INFO] HBase ............................................. SUCCESS [2.703s] [INFO] HBase - Common .................................... SUCCESS [1:01.764s] [INFO] HBase - Protocol .................................. SUCCESS [9.041s] [INFO] HBase - Client .................................... SUCCESS [1:04.256s] [INFO] HBase - Hadoop Compatibility ...................... SUCCESS [6.966s] [INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [5.858s] [INFO] HBase - Prefix Tree ............................... SUCCESS [8.152s] [INFO] HBase - Server .................................... FAILURE [1:04:49.073s] [INFO] HBase - Testing Util .............................. SKIPPED [INFO] HBase - Thrift .................................... SKIPPED [INFO] HBase - Shell ..................................... SKIPPED [INFO] HBase - Integration Tests ......................... SKIPPED [INFO] HBase - Examples .................................. SKIPPED [INFO] HBase - Assembly .................................. SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 1:07:28.521s [INFO] Finished at: Wed Sep 10 00:01:55 UTC 2014 [INFO] Final Memory: 39M/279M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.17: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-TRUNK/ws/hbase-server> && /home/jenkins/tools/java/jdk1.7.0_25-32/jre/bin/java -enableassertions -XX:MaxDirectMemorySize=1G -Xmx1900m -XX:MaxPermSize=256m -Djava.security.egd=file:/dev/./urandom -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -jar <https://builds.apache.org/job/HBase-TRUNK/ws/hbase-server/target/surefire/surefirebooter6716333906539142212.jar> <https://builds.apache.org/job/HBase-TRUNK/ws/hbase-server/target/surefire/surefire5793454477797041637tmp> <https://builds.apache.org/job/HBase-TRUNK/ws/hbase-server/target/surefire/surefire_6545662164777360867205tmp> [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-TRUNK] $ /bin/bash -xe /tmp/hudson6328886916948216754.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.util.TestThreads.testSleepWithoutInterrupt(TestThreads.java:63)' + jps + grep surefirebooter + cut -d ' ' -f 1 + xargs -n 1 jstack 2014-09-10 00:02:07 Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.51-b03 mixed mode): "Attach Listener" daemon prio=10 tid=0x00007f6e64001000 nid=0x31cf waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Thread-1" prio=10 tid=0x00007f6e4c001800 nid=0x317f waiting on condition [0x00007f6ea7bdf000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.hbase.util.Threads.sleepWithoutInterrupt(Threads.java:161) at org.apache.hadoop.hbase.util.TestThreads$1.run(TestThreads.java:46) at java.lang.Thread.run(Thread.java:744) "Thread-0" prio=10 tid=0x00007f6ec86ec800 nid=0x317e in Object.wait() [0x00007f6ec01a2000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007d997dae0> (a java.lang.Thread) at java.lang.Thread.join(Thread.java:1280) - locked <0x00000007d997dae0> (a java.lang.Thread) at java.lang.Thread.join(Thread.java:1354) at org.apache.hadoop.hbase.util.TestThreads.testSleepWithoutInterrupt(TestThreads.java:67) 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.FailOnTimeout$StatementThread.run(FailOnTimeout.java:74) "process reaper" daemon prio=10 tid=0x00007f6ec86e9800 nid=0x317d waiting on condition [0x00007f6ec01dc000] java.lang.Thread.State: TIMED_WAITING (parking) at sun.misc.Unsafe.park(Native Method) - parking to wait for <0x00000007d9413728> (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=0x00007f6ec8290000 nid=0x315d runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread1" daemon prio=10 tid=0x00007f6ec828e000 nid=0x315c waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread0" daemon prio=10 tid=0x00007f6ec828b000 nid=0x315b waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Signal Dispatcher" daemon prio=10 tid=0x00007f6ec8280800 nid=0x315a runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Finalizer" daemon prio=10 tid=0x00007f6ec826b000 nid=0x3159 in Object.wait() [0x00007f6ec0c25000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007d8685568> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) - locked <0x00000007d8685568> (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=0x00007f6ec8267000 nid=0x3158 in Object.wait() [0x00007f6ec0d26000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007d86850f0> (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 <0x00000007d86850f0> (a java.lang.ref.Reference$Lock) "main" prio=10 tid=0x00007f6ec800a800 nid=0x3149 in Object.wait() [0x00007f6ecf1e8000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007d9457c30> (a org.junit.internal.runners.statements.FailOnTimeout$StatementThread) at java.lang.Thread.join(Thread.java:1288) - locked <0x00000007d9457c30> (a org.junit.internal.runners.statements.FailOnTimeout$StatementThread) at org.junit.internal.runners.statements.FailOnTimeout.evaluateStatement(FailOnTimeout.java:26) at org.junit.internal.runners.statements.FailOnTimeout.evaluate(FailOnTimeout.java:17) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) at org.junit.runners.ParentRunner.run(ParentRunner.java:309) at org.junit.runners.Suite.runChild(Suite.java:127) at org.junit.runners.Suite.runChild(Suite.java:26) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) at 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.junit.runner.JUnitCore.run(JUnitCore.java:160) at org.junit.runner.JUnitCore.run(JUnitCore.java:138) at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:113) at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:85) at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:54) at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:134) 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=0x00007f6ec8264800 nid=0x3157 runnable "GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f6ec8020800 nid=0x314a runnable "GC task thread#1 (ParallelGC)" prio=10 tid=0x00007f6ec8022000 nid=0x314b runnable "GC task thread#2 (ParallelGC)" prio=10 tid=0x00007f6ec8024000 nid=0x314c runnable "GC task thread#3 (ParallelGC)" prio=10 tid=0x00007f6ec8026000 nid=0x314d runnable "GC task thread#4 (ParallelGC)" prio=10 tid=0x00007f6ec8027800 nid=0x314e runnable "GC task thread#5 (ParallelGC)" prio=10 tid=0x00007f6ec8029800 nid=0x314f runnable "GC task thread#6 (ParallelGC)" prio=10 tid=0x00007f6ec802b800 nid=0x3150 runnable "GC task thread#7 (ParallelGC)" prio=10 tid=0x00007f6ec802d800 nid=0x3151 runnable "GC task thread#8 (ParallelGC)" prio=10 tid=0x00007f6ec802f000 nid=0x3152 runnable "GC task thread#9 (ParallelGC)" prio=10 tid=0x00007f6ec8031000 nid=0x3153 runnable "GC task thread#10 (ParallelGC)" prio=10 tid=0x00007f6ec8033000 nid=0x3154 runnable "GC task thread#11 (ParallelGC)" prio=10 tid=0x00007f6ec8034800 nid=0x3155 runnable "GC task thread#12 (ParallelGC)" prio=10 tid=0x00007f6ec8036800 nid=0x3156 runnable "VM Periodic Task Thread" prio=10 tid=0x00007f6ec82a3000 nid=0x315e waiting on condition JNI global references: 251 + 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.util.TestThreads.testSleepWithoutInterrupt(TestThreads.java:63)' + 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-TRUNK #5469 Archived 1763 artifacts Archive block size is 32768 Received 77 blocks and 454031534 bytes Compression is 0.6% Took 2 min 26 sec Recording test results
