See <https://builds.apache.org/job/HBase-TRUNK/6282/changes>
Changes: [stack] HBASE-13198 Remove HConnectionManager (Mikhail Antonov) [stack] HBASE-13274 Fix misplaced deprecation in Delete#addXYZ (Mikhail Antonov) ------------------------------------------ [...truncated 2040 lines...] Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.578 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 26.092 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 28.445 sec - in org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 92.471 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock Running org.apache.hadoop.hbase.TestClusterBootOrder Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 61.002 sec - in org.apache.hadoop.hbase.io.encoding.TestChangingEncoding Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 26.824 sec - in org.apache.hadoop.hbase.TestClusterBootOrder Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 123.216 sec - in org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 225.022 sec - in org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders Tests run: 216, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 363.876 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite Results : Failed tests: TestIOFencing.testFencingAroundCompactionAfterWALSync:239->doTest:336 After compaction, does not exist: hdfs://localhost:46850/user/jenkins/test-data/cd09c5d9-b4fa-45c2-ab19-67dac3809d9e/data/default/tabletest/7623f7bb85ff6557eebe1468b5748624/family/57a21a09389e49919e71f8ea5d70770a Tests run: 2341, Failures: 1, Errors: 0, Skipped: 18 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] HBase ............................................. SUCCESS [3.953s] [INFO] HBase - Checkstyle ................................ SUCCESS [1.278s] [INFO] HBase - Annotations ............................... SUCCESS [1.407s] [INFO] HBase - Protocol .................................. SUCCESS [17.660s] [INFO] HBase - Common .................................... SUCCESS [1:29.910s] [INFO] HBase - Client .................................... SUCCESS [1:19.624s] [INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.180s] [INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [6.733s] [INFO] HBase - Prefix Tree ............................... SUCCESS [9.147s] [INFO] HBase - Server .................................... FAILURE [1:11:55.777s] [INFO] HBase - Testing Util .............................. SKIPPED [INFO] HBase - Thrift .................................... SKIPPED [INFO] HBase - Shell ..................................... SKIPPED [INFO] HBase - Integration Tests ......................... SKIPPED [INFO] HBase - Examples .................................. SKIPPED [INFO] HBase - Rest ...................................... SKIPPED [INFO] HBase - Assembly .................................. SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 1:15:34.496s [INFO] Finished at: Fri Mar 20 18:21:12 UTC 2015 [INFO] Final Memory: 95M/643M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18: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/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-TRUNK/ws/hbase-server/target/surefire/surefirebooter8825870257962411738.jar> <https://builds.apache.org/job/HBase-TRUNK/ws/hbase-server/target/surefire/surefire2541281028421738064tmp> <https://builds.apache.org/job/HBase-TRUNK/ws/hbase-server/target/surefire/surefire_9206385521719665525536tmp> [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 [FINDBUGS] Skipping publisher since build result is 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/hudson8925140294360661303.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 ++ grep surefirebooter ++ jps ++ 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.security.authentication.util.TestRandomSignerSecretProvider.testGetAndRollSecrets(TestRandomSignerSecretProvider.java:58)' + jps + grep surefirebooter + cut -d ' ' -f 1 + xargs -n 1 jstack 2015-03-20 18:21:24 Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.55-b03 mixed mode): "Attach Listener" daemon prio=10 tid=0x00007eff20001000 nid=0x172d waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "pool-1-thread-1" prio=10 tid=0x00007eff2c7b1800 nid=0x1394 waiting on condition [0x00007eff1d890000] java.lang.Thread.State: TIMED_WAITING (parking) at sun.misc.Unsafe.park(Native Method) - parking to wait for <0x00000007ab5a27c0> (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:745) "Service Thread" daemon prio=10 tid=0x00007eff2c29a000 nid=0x138a runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread1" daemon prio=10 tid=0x00007eff2c28e800 nid=0x1389 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread0" daemon prio=10 tid=0x00007eff2c28b800 nid=0x1388 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Signal Dispatcher" daemon prio=10 tid=0x00007eff2c281800 nid=0x1387 runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Finalizer" daemon prio=10 tid=0x00007eff2c26b000 nid=0x1386 in Object.wait() [0x00007eff1e9e8000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007aaa85568> (a java.lang.ref.ReferenceQueue$Lock) at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) - locked <0x00000007aaa85568> (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=0x00007eff2c267000 nid=0x1385 in Object.wait() [0x00007eff1eae9000] java.lang.Thread.State: WAITING (on object monitor) at java.lang.Object.wait(Native Method) - waiting on <0x00000007aaa850f0> (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 <0x00000007aaa850f0> (a java.lang.ref.Reference$Lock) "main" prio=10 tid=0x00007eff2c00a000 nid=0x1375 waiting on condition [0x00007eff31f3b000] java.lang.Thread.State: TIMED_WAITING (sleeping) at java.lang.Thread.sleep(Native Method) at org.apache.hadoop.security.authentication.util.TestRandomSignerSecretProvider.testGetAndRollSecrets(TestRandomSignerSecretProvider.java:58) 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.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=0x00007eff2c264800 nid=0x1384 runnable "GC task thread#0 (ParallelGC)" prio=10 tid=0x00007eff2c020000 nid=0x1377 runnable "GC task thread#1 (ParallelGC)" prio=10 tid=0x00007eff2c022000 nid=0x1378 runnable "GC task thread#2 (ParallelGC)" prio=10 tid=0x00007eff2c024000 nid=0x1379 runnable "GC task thread#3 (ParallelGC)" prio=10 tid=0x00007eff2c025800 nid=0x137a runnable "GC task thread#4 (ParallelGC)" prio=10 tid=0x00007eff2c027800 nid=0x137b runnable "GC task thread#5 (ParallelGC)" prio=10 tid=0x00007eff2c029800 nid=0x137c runnable "GC task thread#6 (ParallelGC)" prio=10 tid=0x00007eff2c02b000 nid=0x137d runnable "GC task thread#7 (ParallelGC)" prio=10 tid=0x00007eff2c02d000 nid=0x137e runnable "GC task thread#8 (ParallelGC)" prio=10 tid=0x00007eff2c02f000 nid=0x137f runnable "GC task thread#9 (ParallelGC)" prio=10 tid=0x00007eff2c030800 nid=0x1380 runnable "GC task thread#10 (ParallelGC)" prio=10 tid=0x00007eff2c032800 nid=0x1381 runnable "GC task thread#11 (ParallelGC)" prio=10 tid=0x00007eff2c034800 nid=0x1382 runnable "GC task thread#12 (ParallelGC)" prio=10 tid=0x00007eff2c036800 nid=0x1383 runnable "VM Periodic Task Thread" prio=10 tid=0x00007eff2c2a4800 nid=0x138b waiting on condition JNI global references: 161 + 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.security.authentication.util.TestRandomSignerSecretProvider.testGetAndRollSecrets(TestRandomSignerSecretProvider.java:58)' + 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 #6280 Archived 1881 artifacts Archive block size is 32768 Received 31 blocks and 415586923 bytes Compression is 0.2% Took 2 min 34 sec Recording test results Updating HBASE-13198 Updating HBASE-13274
