hbase-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: HBase-1.0 #95
Date Tue, 12 Aug 2014 13:21:41 GMT
See <https://builds.apache.org/job/HBase-1.0/95/changes>

Changes:

[nkeywal] HBASE-11718 Remove some logs in RpcClient.java

[nkeywal] HBASE-11719 Remove some unused paths in AsyncClient

------------------------------------------
[...truncated 1792 lines...]
[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-1.0/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.0] $ /bin/bash -xe /tmp/hudson4940325358172344093.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
++ cut -d ' ' -f 1
++ grep surefirebooter
++ grep '\.java'
++ grep .test
++ xargs -n 1 jstack
+ ZB_STACK='	at org.apache.blur.lucene.warmup.IndexWarmupTest.testIndexWarmupBitSet(IndexWarmupTest.java:90)'
+ jps
+ grep surefirebooter
+ xargs -n 1 jstack
+ cut -d ' ' -f 1
2014-08-12 13:18:17
Full thread dump Java HotSpot(TM) Server VM (23.25-b01 mixed mode):

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

"Lucene Merge Thread #1" daemon prio=10 tid=0xa9fbf800 nid=0x290 in Object.wait() [0xab97d000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at org.apache.lucene.index.MergePolicy$OneMerge.checkAborted(MergePolicy.java:211)
	- locked <0xc323b200> (a org.apache.lucene.index.MergePolicy$OneMerge)
	at org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:3614)
	at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:3313)
	at org.apache.lucene.index.ConcurrentMergeScheduler.doMerge(ConcurrentMergeScheduler.java:401)
	at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:478)

"Lucene Merge Thread #0" daemon prio=10 tid=0xa9fbec00 nid=0x7eaf in Object.wait() [0xf1d7d000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at org.apache.blur.lucene.warmup.SlowAccessDirectory$SlowAccessIndexInput.delay(SlowAccessDirectory.java:48)
	- locked <0xc100b308> (a org.apache.blur.lucene.warmup.SlowAccessDirectory$SlowAccessIndexInput)
	at org.apache.blur.lucene.warmup.SlowAccessDirectory$SlowAccessIndexInput.readInternal(SlowAccessDirectory.java:72)
	at org.apache.lucene.store.BufferedIndexInput.refill(BufferedIndexInput.java:272)
	at org.apache.lucene.store.BufferedIndexInput.readByte(BufferedIndexInput.java:51)
	at org.apache.blur.lucene.warmup.TraceableIndexInput.readByte(TraceableIndexInput.java:62)
	at org.apache.lucene.store.DataInput.readVInt(DataInput.java:108)
	at org.apache.lucene.codecs.BlockTreeTermsReader$FieldReader$SegmentTermsEnum$Frame.loadBlock(BlockTreeTermsReader.java:2357)
	at org.apache.lucene.codecs.BlockTreeTermsReader$FieldReader$SegmentTermsEnum.next(BlockTreeTermsReader.java:2148)
	at org.apache.lucene.index.MultiTermsEnum.pushTop(MultiTermsEnum.java:292)
	at org.apache.lucene.index.MultiTermsEnum.next(MultiTermsEnum.java:318)
	at org.apache.lucene.codecs.TermsConsumer.merge(TermsConsumer.java:156)
	at org.apache.lucene.codecs.FieldsConsumer.merge(FieldsConsumer.java:72)
	at org.apache.lucene.index.SegmentMerger.mergeTerms(SegmentMerger.java:365)
	at org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:98)
	at org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:3709)
	at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:3313)
	at org.apache.lucene.index.ConcurrentMergeScheduler.doMerge(ConcurrentMergeScheduler.java:401)
	at org.apache.lucene.index.ConcurrentMergeScheduler$MergeThread.run(ConcurrentMergeScheduler.java:478)

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

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

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

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

"Surrogate Locker Thread (Concurrent GC)" daemon prio=10 tid=0xab16b000 nid=0x7c18 waiting
on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=10 tid=0xab130800 nid=0x7c17 in Object.wait() [0xf2f7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0xc3164860> (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=0xab12e800 nid=0x7c16 in Object.wait() [0xf317d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.lang.Object.wait(Object.java:503)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133)
	- locked <0xc3160b98> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6706800 nid=0x7c02 runnable [0xf689a000]
   java.lang.Thread.State: RUNNABLE
	at org.apache.lucene.index.FreqProxTermsWriterPerField.flush(FreqProxTermsWriterPerField.java:541)
	at org.apache.lucene.index.FreqProxTermsWriter.flush(FreqProxTermsWriter.java:85)
	at org.apache.lucene.index.TermsHash.flush(TermsHash.java:116)
	at org.apache.lucene.index.DocInverter.flush(DocInverter.java:53)
	at org.apache.lucene.index.DocFieldProcessor.flush(DocFieldProcessor.java:81)
	at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:493)
	at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:422)
	at org.apache.lucene.index.DocumentsWriter.postUpdate(DocumentsWriter.java:316)
	at org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:389)
	at org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1485)
	at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1160)
	at org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1141)
	at org.apache.blur.lucene.warmup.IndexWarmupTest.addDocs(IndexWarmupTest.java:149)
	at org.apache.blur.lucene.warmup.IndexWarmupTest.populate(IndexWarmupTest.java:143)
	at org.apache.blur.lucene.warmup.IndexWarmupTest.getIndexReader(IndexWarmupTest.java:131)
	at org.apache.blur.lucene.warmup.IndexWarmupTest.testIndexWarmupBitSet(IndexWarmupTest.java:90)
	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:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:69)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:48)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:292)
	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:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

"VM Thread" prio=10 tid=0xab129000 nid=0x7c15 runnable 

"Gang worker#0 (Parallel GC Threads)" prio=10 tid=0xf670d800 nid=0x7c03 runnable 

"Gang worker#1 (Parallel GC Threads)" prio=10 tid=0xf670f000 nid=0x7c04 runnable 

"Gang worker#2 (Parallel GC Threads)" prio=10 tid=0xf6710800 nid=0x7c05 runnable 

"Gang worker#3 (Parallel GC Threads)" prio=10 tid=0xf6711c00 nid=0x7c06 runnable 

"Gang worker#4 (Parallel GC Threads)" prio=10 tid=0xf6713400 nid=0x7c07 runnable 

"Gang worker#5 (Parallel GC Threads)" prio=10 tid=0xf6714c00 nid=0x7c08 runnable 

"Gang worker#6 (Parallel GC Threads)" prio=10 tid=0xf6716000 nid=0x7c09 runnable 

"Gang worker#7 (Parallel GC Threads)" prio=10 tid=0xf6717800 nid=0x7c0a runnable 

"Gang worker#8 (Parallel GC Threads)" prio=10 tid=0xf6719000 nid=0x7c0b runnable 

"Gang worker#9 (Parallel GC Threads)" prio=10 tid=0xf671a400 nid=0x7c0c runnable 

"Gang worker#10 (Parallel GC Threads)" prio=10 tid=0xf671bc00 nid=0x7c0d runnable 

"Gang worker#11 (Parallel GC Threads)" prio=10 tid=0xf671d400 nid=0x7c0e runnable 

"Gang worker#12 (Parallel GC Threads)" prio=10 tid=0xf671e800 nid=0x7c0f runnable 

"Concurrent Mark-Sweep GC Thread" prio=10 tid=0xab3a0400 nid=0x7c14 runnable 
"Gang worker#0 (Parallel CMS Threads)" prio=10 tid=0xad7c1c00 nid=0x7c10 runnable 

"Gang worker#1 (Parallel CMS Threads)" prio=10 tid=0xad7c3400 nid=0x7c11 runnable 

"Gang worker#2 (Parallel CMS Threads)" prio=10 tid=0xad7c4800 nid=0x7c12 runnable 

"Gang worker#3 (Parallel CMS Threads)" prio=10 tid=0xad7c6000 nid=0x7c13 runnable 

"VM Periodic Task Thread" prio=10 tid=0xab173c00 nid=0x7c1d waiting on condition 

JNI global references: 228

+ 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.blur.lucene.warmup.IndexWarmupTest.testIndexWarmupBitSet(IndexWarmupTest.java:90)'
+ 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.0 #88
Archived 1754 artifacts
Archive block size is 32768
Received 70 blocks and 672432492 bytes
Compression is 0.3%
Took 3 min 32 sec
Recording test results
Updating HBASE-11718
Updating HBASE-11719

Mime
View raw message