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 2014/02/26 07:14:50 UTC

Build failed in Jenkins: HBase-0.98-on-Hadoop-1.1 #173

See <https://builds.apache.org/job/HBase-0.98-on-Hadoop-1.1/173/changes>

Changes:

[mbertozzi] HBASE-10608 Acquire the FS Delegation Token for Secure ExportSnapshot

[jmhsieh] HBASE-10436 restore regionserver lists removed from hbase 0.96.0 jmx

------------------------------------------
[...truncated 4669 lines...]
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 113.099 sec
Running org.apache.hadoop.hbase.TestZooKeeper
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 148.857 sec

Results :

Failed tests:   testExportFileSystemState(org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot): expected:<0> but was:<1>
  testConsecutiveExports(org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot): expected:<0> but was:<1>
  testSnapshotWithRefsExportFileSystemState(org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot): expected:<0> but was:<1>
  testExportRetry(org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot): expected:<0> but was:<1>

Tests run: 1830, Failures: 4, Errors: 0, Skipped: 25

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [21.671s]
[INFO] HBase - Common .................................... SUCCESS [25.850s]
[INFO] HBase - Protocol .................................. SUCCESS [20.097s]
[INFO] HBase - Client .................................... SUCCESS [38.996s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [5.627s]
[INFO] HBase - Hadoop One Compatibility .................. SUCCESS [1.774s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [4.370s]
[INFO] HBase - Server .................................... FAILURE [3:30:09.150s]
[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: 3:32:08.341s
[INFO] Finished at: Wed Feb 26 06:13:03 UTC 2014
[INFO] Final Memory: 37M/510M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.12-TRUNK-HBASE-2:test (secondPartTestsExecution) on project hbase-server: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/HBase-0.98-on-Hadoop-1.1/ws/0.98-hadoop1.1/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-0.98-on-Hadoop-1.1] $ /bin/bash -xe /tmp/hudson3770836508870647772.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 jdbm.btree.TestSnapshotBTree.testRemoveInsert(TestSnapshotBTree.java:479)'
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs -n 1 jstack
2014-02-26 06:13:16
Full thread dump Java HotSpot(TM) Server VM (23.25-b01 mixed mode):

"Attach Listener" daemon prio=10 tid=0xaac06000 nid=0x754e waiting on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Thread-13" prio=10 tid=0xab1e8800 nid=0x71b1 waiting on condition [0xaa87d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.readOnlyActions(TestSnapshotBTree.java:518)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.run(TestSnapshotBTree.java:586)

"Thread-12" prio=10 tid=0xaa502000 nid=0x71a2 waiting on condition [0xae67d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.readOnlyActions(TestSnapshotBTree.java:518)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.run(TestSnapshotBTree.java:586)

"Thread-11" prio=10 tid=0xaa503800 nid=0x7188 waiting on condition [0xaad7d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.readOnlyActions(TestSnapshotBTree.java:518)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.run(TestSnapshotBTree.java:586)

"Thread-10" prio=10 tid=0xaa7ff000 nid=0x712a waiting on condition [0xab27d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.readOnlyActions(TestSnapshotBTree.java:518)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.run(TestSnapshotBTree.java:586)

"Thread-14" prio=10 tid=0xaa7fe000 nid=0x7116 waiting on condition [0xae47d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.readWriteActions(TestSnapshotBTree.java:552)
	at jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread.run(TestSnapshotBTree.java:590)

"Service Thread" daemon prio=10 tid=0xab1d8400 nid=0x5f5d runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

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

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

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

"Finalizer" daemon prio=10 tid=0xab198000 nid=0x5f59 in Object.wait() [0xaef7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xb3b7edd0> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0xb3b7edd0> (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=0xab196400 nid=0x5f58 in Object.wait() [0xaf165000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xb3b4ffa0> (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 <0xb3b4ffa0> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6706800 nid=0x5f4e in Object.wait() [0xf68bf000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xea7aa070> (a jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread)
	at java.lang.Thread.join(Thread.java:1260)
	- locked <0xea7aa070> (a jdbm.btree.TestSnapshotBTree$RemoveInsertTestThread)
	at java.lang.Thread.join(Thread.java:1334)
	at jdbm.btree.TestSnapshotBTree.testRemoveInsert(TestSnapshotBTree.java:479)
	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.rules.ExternalResource$1.evaluate(ExternalResource.java:48)
	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.runners.ParentRunner.run(ParentRunner.java:309)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:113)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

"VM Thread" prio=10 tid=0xab190c00 nid=0x5f57 runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0xf6710800 nid=0x5f4f runnable 

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

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

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

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

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

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

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

"VM Periodic Task Thread" prio=10 tid=0xab1e2400 nid=0x5f5e waiting on condition 

JNI global references: 195

+ 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 jdbm.btree.TestSnapshotBTree.testRemoveInsert(TestSnapshotBTree.java:479)'
+ BAD=1
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs kill -9
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Recording test results
Updating HBASE-10436
Updating HBASE-10608