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 47104184B8 for ; Fri, 31 Jul 2015 19:21:50 +0000 (UTC) Received: (qmail 31723 invoked by uid 500); 31 Jul 2015 19:21:50 -0000 Delivered-To: apmail-hbase-builds-archive@hbase.apache.org Received: (qmail 31686 invoked by uid 500); 31 Jul 2015 19:21:50 -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 31639 invoked by uid 99); 31 Jul 2015 19:21:49 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Fri, 31 Jul 2015 19:21:49 +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 845D69C0348 for ; Fri, 31 Jul 2015 19:21:14 +0000 (UTC) Date: Fri, 31 Jul 2015 19:21:13 +0000 (UTC) From: Apache Jenkins Server To: builds@hbase.apache.org Message-ID: <918363855.5620.1438370474539.JavaMail.jenkins@crius> In-Reply-To: <1887393287.5060.1438233577537.JavaMail.jenkins@crius> References: <1887393287.5060.1438233577537.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_HBase-1.3_=C2=BB_latest1.7,Hadoop_#81?= MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable X-Jenkins-Job: latest1.7,Hadoop X-Jenkins-Result: FAILURE See Changes: [tedyu] HBASE-14168 Avoid useless retry for DoNotRetryIOException in TableR= ecordReaderImpl (zhouyingchao) ------------------------------------------ [...truncated 44109 lines...] ++ grep '\.java' + ZB_STACK=3D'=09at org.apache.hadoop.hbase.TestChoreService.testCorePoolIn= crease(TestChoreService.java:431)' + jps + grep surefirebooter + cut -d ' ' -f 1 + xargs -n 1 jstack 2015-07-31 19:19:23 Full thread dump Java HotSpot(TM) 64-Bit Server VM (25.45-b02 mixed mode): "testCorePoolIncrease_ChoreService_5" #36 daemon prio=3D5 os_prio=3D0 tid= =3D0x00007fa5c4001000 nid=3D0x122c waiting on condition [0x00007fa641379000= ] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService$ScheduledChoreSamples$SlowCh= ore.chore(TestChoreService.java:90) =09at org.apache.hadoop.hbase.ScheduledChore.run(ScheduledChore.java:185) =09at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:51= 1) =09at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= access$301(ScheduledThreadPoolExecutor.java:180) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= run(ScheduledThreadPoolExecutor.java:294) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "Attach Listener" #35 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa614001000 = nid=3D0x1211 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "testCorePoolIncrease_ChoreService_4" #34 daemon prio=3D5 os_prio=3D0 tid= =3D0x00007fa5d4006000 nid=3D0x11db waiting on condition [0x00007fa64157b000= ] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService$ScheduledChoreSamples$SlowCh= ore.chore(TestChoreService.java:90) =09at org.apache.hadoop.hbase.ScheduledChore.run(ScheduledChore.java:185) =09at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:51= 1) =09at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= access$301(ScheduledThreadPoolExecutor.java:180) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= run(ScheduledThreadPoolExecutor.java:294) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "testCorePoolIncrease_ChoreService_3" #33 daemon prio=3D5 os_prio=3D0 tid= =3D0x00007fa5cc004000 nid=3D0x11c0 waiting on condition [0x00007fa64167c000= ] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService$ScheduledChoreSamples$SlowCh= ore.chore(TestChoreService.java:90) =09at org.apache.hadoop.hbase.ScheduledChore.run(ScheduledChore.java:185) =09at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:51= 1) =09at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= access$301(ScheduledThreadPoolExecutor.java:180) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= run(ScheduledThreadPoolExecutor.java:294) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "testCorePoolIncrease_ChoreService_2" #32 daemon prio=3D5 os_prio=3D0 tid= =3D0x00007fa5cc003000 nid=3D0x11bf waiting on condition [0x00007fa64187e000= ] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService$ScheduledChoreSamples$SlowCh= ore.chore(TestChoreService.java:90) =09at org.apache.hadoop.hbase.ScheduledChore.run(ScheduledChore.java:185) =09at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:51= 1) =09at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= access$301(ScheduledThreadPoolExecutor.java:180) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= run(ScheduledThreadPoolExecutor.java:294) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "testCorePoolIncrease_ChoreService_1" #31 daemon prio=3D5 os_prio=3D0 tid= =3D0x00007fa5cc002000 nid=3D0x11be waiting on condition [0x00007fa64197f000= ] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService$ScheduledChoreSamples$SlowCh= ore.chore(TestChoreService.java:90) =09at org.apache.hadoop.hbase.ScheduledChore.run(ScheduledChore.java:185) =09at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:51= 1) =09at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= access$301(ScheduledThreadPoolExecutor.java:180) =09at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.= run(ScheduledThreadPoolExecutor.java:294) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "Thread-6" #30 prio=3D5 os_prio=3D0 tid=3D0x00007fa67c7dc000 nid=3D0x11bd w= aiting on condition [0x00007fa64177c000] java.lang.Thread.State: TIMED_WAITING (sleeping) =09at java.lang.Thread.sleep(Native Method) =09at org.apache.hadoop.hbase.TestChoreService.testCorePoolIncrease(TestCho= reService.java:438) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:62) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:43) =09at java.lang.reflect.Method.invoke(Method.java:497) =09at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(Framework= Method.java:47) =09at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCal= lable.java:12) =09at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMe= thod.java:44) =09at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMet= hod.java:17) =09at org.junit.internal.runners.statements.FailOnTimeout$StatementThread.r= un(FailOnTimeout.java:74) "process reaper" #18 daemon prio=3D10 os_prio=3D0 tid=3D0x00007fa67c7dd800 = nid=3D0x11a5 waiting on condition [0x00007fa6419b8000] java.lang.Thread.State: TIMED_WAITING (parking) =09at sun.misc.Unsafe.park(Native Method) =09- parking to wait for <0x0000000787e2d320> (a java.util.concurrent.Sync= hronousQueue$TransferStack) =09at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215= ) =09at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(Sync= hronousQueue.java:460) =09at java.util.concurrent.SynchronousQueue$TransferStack.transfer(Synchron= ousQueue.java:362) =09at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941) =09at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.ja= va:1066) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1127) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) "Service Thread" #17 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2de800 n= id=3D0x11a2 runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C1 CompilerThread11" #16 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2d1= 800 nid=3D0x11a1 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C1 CompilerThread10" #15 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2cf= 800 nid=3D0x11a0 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C1 CompilerThread9" #14 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2cd8= 00 nid=3D0x119f waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C1 CompilerThread8" #13 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2cb8= 00 nid=3D0x119e waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread7" #12 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2c98= 00 nid=3D0x119d waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread6" #11 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2c78= 00 nid=3D0x119c waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread5" #10 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2c50= 00 nid=3D0x119b waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread4" #9 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2bb00= 0 nid=3D0x119a waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread3" #8 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2b900= 0 nid=3D0x1199 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread2" #7 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2b680= 0 nid=3D0x1198 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread1" #6 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2b500= 0 nid=3D0x1197 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "C2 CompilerThread0" #5 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2b200= 0 nid=3D0x1196 waiting on condition [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Signal Dispatcher" #4 daemon prio=3D9 os_prio=3D0 tid=3D0x00007fa67c2ad800= nid=3D0x1195 runnable [0x0000000000000000] java.lang.Thread.State: RUNNABLE "Finalizer" #3 daemon prio=3D8 os_prio=3D0 tid=3D0x00007fa67c279000 nid=3D0= x1194 in Object.wait() [0x00007fa6430ef000] java.lang.Thread.State: WAITING (on object monitor) =09at java.lang.Object.wait(Native Method) =09- waiting on <0x0000000785b06f58> (a java.lang.ref.ReferenceQueue$Lock) =09at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143) =09- locked <0x0000000785b06f58> (a java.lang.ref.ReferenceQueue$Lock) =09at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164) =09at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209) "Reference Handler" #2 daemon prio=3D10 os_prio=3D0 tid=3D0x00007fa67c27680= 0 nid=3D0x1193 in Object.wait() [0x00007fa6431f0000] java.lang.Thread.State: WAITING (on object monitor) =09at java.lang.Object.wait(Native Method) =09- waiting on <0x0000000785b06998> (a java.lang.ref.Reference$Lock) =09at java.lang.Object.wait(Object.java:502) =09at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:157) =09- locked <0x0000000785b06998> (a java.lang.ref.Reference$Lock) "main" #1 prio=3D5 os_prio=3D0 tid=3D0x00007fa67c00a800 nid=3D0x1184 in Obj= ect.wait() [0x00007fa68272f000] java.lang.Thread.State: TIMED_WAITING (on object monitor) =09at java.lang.Object.wait(Native Method) =09- waiting on <0x0000000788001a68> (a org.junit.internal.runners.statemen= ts.FailOnTimeout$StatementThread) =09at java.lang.Thread.join(Thread.java:1253) =09- locked <0x0000000788001a68> (a org.junit.internal.runners.statements.F= ailOnTimeout$StatementThread) =09at org.junit.internal.runners.statements.FailOnTimeout.evaluateStatement= (FailOnTimeout.java:26) =09at org.junit.internal.runners.statements.FailOnTimeout.evaluate(FailOnTi= meout.java:17) =09at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271) =09at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRun= ner.java:70) =09at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRun= ner.java:50) =09at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) =09at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63) =09at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236) =09at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) =09at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) =09at org.junit.runners.ParentRunner.run(ParentRunner.java:309) =09at org.junit.runners.Suite.runChild(Suite.java:127) =09at org.junit.runners.Suite.runChild(Suite.java:26) =09at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238) =09at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63) =09at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236) =09at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53) =09at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229) =09at org.junit.runners.ParentRunner.run(ParentRunner.java:309) =09at org.junit.runner.JUnitCore.run(JUnitCore.java:160) =09at org.junit.runner.JUnitCore.run(JUnitCore.java:138) =09at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAnd= Run(JUnitCoreWrapper.java:107) =09at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUn= itCoreWrapper.java:77) =09at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCor= eWrapper.java:53) =09at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCor= eProvider.java:144) =09at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameCla= ssLoader(ForkedBooter.java:203) =09at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(Fork= edBooter.java:155) =09at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:= 103) "VM Thread" os_prio=3D0 tid=3D0x00007fa67c271800 nid=3D0x1192 runnable=20 "GC task thread#0 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c01f800 nid=3D= 0x1185 runnable=20 "GC task thread#1 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c021800 nid=3D= 0x1186 runnable=20 "GC task thread#2 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c023000 nid=3D= 0x1187 runnable=20 "GC task thread#3 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c025000 nid=3D= 0x1188 runnable=20 "GC task thread#4 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c026800 nid=3D= 0x1189 runnable=20 "GC task thread#5 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c028800 nid=3D= 0x118a runnable=20 "GC task thread#6 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c02a000 nid=3D= 0x118b runnable=20 "GC task thread#7 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c02c000 nid=3D= 0x118c runnable=20 "GC task thread#8 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c02d800 nid=3D= 0x118d runnable=20 "GC task thread#9 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c02f800 nid=3D= 0x118e runnable=20 "GC task thread#10 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c031000 nid= =3D0x118f runnable=20 "GC task thread#11 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c033000 nid= =3D0x1190 runnable=20 "GC task thread#12 (ParallelGC)" os_prio=3D0 tid=3D0x00007fa67c034800 nid= =3D0x1191 runnable=20 "VM Periodic Task Thread" os_prio=3D0 tid=3D0x00007fa67c2e1800 nid=3D0x11a3= waiting on condition=20 JNI global references: 376 + echo '************ END zombies jstack extract' ************ END zombies jstack extract + JIRA_COMMENT=3D' {color:red}-1 core zombie tests{color}. There are 1 zombie test(s): = =09at org.apache.hadoop.hbase.TestChoreService.testCorePoolIncrease(TestCho= reService.java:431)' + BAD=3D1 + 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.3 =C2=BB latest1.7,Hadoop #79 Archived 2116 artifacts Archive block size is 32768 Received 38 blocks and 529499717 bytes Compression is 0.2% Took 2 min 19 sec