Return-Path: X-Original-To: apmail-hbase-builds-archive@minotaur.apache.org Delivered-To: apmail-hbase-builds-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id E129B10461 for ; Mon, 14 Sep 2015 15:43:50 +0000 (UTC) Received: (qmail 2931 invoked by uid 500); 14 Sep 2015 15:43:35 -0000 Delivered-To: apmail-hbase-builds-archive@hbase.apache.org Received: (qmail 2907 invoked by uid 500); 14 Sep 2015 15:43:35 -0000 Mailing-List: contact builds-help@hbase.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: builds@hbase.apache.org Delivered-To: mailing list builds@hbase.apache.org Received: (qmail 2896 invoked by uid 99); 14 Sep 2015 15:43:34 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 14 Sep 2015 15:43:34 +0000 Received: from crius.apache.org (localhost [127.0.0.1]) by crius.apache.org (ASF Mail Server at crius.apache.org) with ESMTP id 349C49C0457 for ; Mon, 14 Sep 2015 15:43:26 +0000 (UTC) Date: Mon, 14 Sep 2015 15:43:19 +0000 (UTC) From: Apache Jenkins Server To: builds@hbase.apache.org Message-ID: <931509539.7724.1442245406115.JavaMail.jenkins@crius> In-Reply-To: <2062966493.7460.1442169387455.JavaMail.jenkins@crius> References: <2062966493.7460.1442169387455.JavaMail.jenkins@crius> Subject: Build failed in Jenkins: HBase-1.1 #659 MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit X-Jenkins-Job: HBase-1.1 X-Jenkins-Result: FAILURE See 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 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 -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