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/07/15 21:27:31 UTC

Build failed in Jenkins: HBase-TRUNK #5306

See <https://builds.apache.org/job/HBase-TRUNK/5306/changes>

Changes:

[ramkrishna] HBASE-10930 Change Filters and GetClosestRowBeforeTracker to work with

[stack] HBASE-11517 TestReplicaWithCluster turns zombie -- ADDS TIMEOUTS SO CAN DEBUG ZOMBIE

[ramkrishna] HBASE-11489 ClassNotFoundException while running IT tests in trunk using

------------------------------------------
[...truncated 1741 lines...]
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.423 sec
Running org.apache.hadoop.hbase.master.TestDistributedLogSplitting
Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 144.544 sec
Running org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 41.904 sec
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.204 sec
Running org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 48.055 sec
Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 298.122 sec
Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 291.16 sec

Results :

Tests in error: 
  testCreateDeleteTable(org.apache.hadoop.hbase.client.TestReplicaWithCluster): test timed out after 30000 milliseconds
  testChangeTable(org.apache.hadoop.hbase.client.TestReplicaWithCluster): test timed out after 30000 milliseconds

Tests run: 2072, Failures: 0, Errors: 2, Skipped: 21

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [2.548s]
[INFO] HBase - Common .................................... SUCCESS [37.456s]
[INFO] HBase - Protocol .................................. SUCCESS [8.813s]
[INFO] HBase - Client .................................... SUCCESS [54.667s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [5.327s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [1.627s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [3.481s]
[INFO] HBase - Server .................................... FAILURE [1:59:10.745s]
[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: 2:01:05.425s
[INFO] Finished at: Tue Jul 15 19:22:16 UTC 2014
[INFO] Final Memory: 39M/781M
[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-TRUNK/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-TRUNK] $ /bin/bash -xe /tmp/hudson773173488591816601.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
++ wc -l
++ grep surefirebooter
+ 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
++ grep .test
++ xargs -n 1 jstack
++ grep '\.java'
+ ZB_STACK='	at org.apache.axis2.jaxws.framework.StartServer.testStartServer(StartServer.java:42)'
+ jps
+ grep surefirebooter
+ xargs -n 1 jstack
+ cut -d ' ' -f 1
2014-07-15 19:22:31
Full thread dump Java HotSpot(TM) Server VM (20.45-b01 mixed mode):

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

"Low Memory Detector" daemon prio=10 tid=0xcd868400 nid=0xd2c runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

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

"C2 CompilerThread0" daemon prio=10 tid=0xcd864800 nid=0xd2a runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

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

"Finalizer" daemon prio=10 tid=0xcd855400 nid=0xd28 in Object.wait() [0xcf17d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xe8ba1150> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
	- locked <0xe8ba1150> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134)
	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:171)

"Reference Handler" daemon prio=10 tid=0xcd853c00 nid=0xd27 in Object.wait() [0xcf370000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xe8ba1050> (a java.lang.ref.Reference$Lock)
	at java.lang.Object.wait(Object.java:485)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)
	- locked <0xe8ba1050> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6705c00 nid=0xd08 runnable [0xf694f000]
   java.lang.Thread.State: RUNNABLE
	at java.util.zip.Inflater.inflateBytes(Native Method)
	at java.util.zip.Inflater.inflate(Inflater.java:238)
	- locked <0xeb5930a0> (a java.util.zip.ZStreamRef)
	at java.util.zip.InflaterInputStream.read(InflaterInputStream.java:135)
	at java.util.zip.ZipInputStream.read(ZipInputStream.java:154)
	at java.util.zip.ZipInputStream.closeEntry(ZipInputStream.java:100)
	at java.util.zip.ZipInputStream.getNextEntry(ZipInputStream.java:78)
	at org.apache.axis2.deployment.util.Utils.getURLsForAllJars(Utils.java:179)
	at org.apache.axis2.deployment.util.Utils.createClassLoader(Utils.java:813)
	at org.apache.axis2.jaxws.framework.JAXWSDeployer.deploy(JAXWSDeployer.java:145)
	at org.apache.axis2.deployment.repository.util.DeploymentFileData.deploy(DeploymentFileData.java:144)
	at org.apache.axis2.deployment.DeploymentEngine.doDeploy(DeploymentEngine.java:585)
	- locked <0xe92bcd68> (a org.apache.axis2.deployment.FileSystemConfigurator)
	at org.apache.axis2.deployment.repository.util.WSInfoList.update(WSInfoList.java:164)
	- locked <0xe92bcd68> (a org.apache.axis2.deployment.FileSystemConfigurator)
	at org.apache.axis2.deployment.RepositoryListener.update(RepositoryListener.java:377)
	at org.apache.axis2.deployment.RepositoryListener.checkServices(RepositoryListener.java:254)
	at org.apache.axis2.deployment.DeploymentEngine.loadServices(DeploymentEngine.java:136)
	at org.apache.axis2.deployment.FileSystemConfigurator.loadServices(FileSystemConfigurator.java:147)
	at org.apache.axis2.context.ConfigurationContextFactory.createConfigurationContext(ConfigurationContextFactory.java:95)
	at org.apache.axis2.context.ConfigurationContextFactory.createConfigurationContextFromFileSystem(ConfigurationContextFactory.java:210)
	at org.apache.axis2.jaxws.utility.SimpleServer.init(SimpleServer.java:58)
	at org.apache.axis2.jaxws.utility.SimpleServer.start(SimpleServer.java:68)
	at org.apache.axis2.jaxws.framework.StartServer.testStartServer(StartServer.java:42)
	at org.apache.axis2.jaxws.framework.AbstractTestCase$2.setUp(AbstractTestCase.java:64)
	at junit.extensions.TestSetup$1.protect(TestSetup.java:22)
	at junit.framework.TestResult.runProtected(TestResult.java:128)
	at junit.extensions.TestSetup.run(TestSetup.java:27)
	at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:81)
	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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray2(ReflectionUtils.java:208)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:158)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:95)

"VM Thread" prio=10 tid=0xcd850400 nid=0xd23 runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0xf670d400 nid=0xd16 runnable 

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

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

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

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

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

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

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

"GC task thread#8 (ParallelGC)" prio=10 tid=0xf6718400 nid=0xd1e runnable 

"GC task thread#9 (ParallelGC)" prio=10 tid=0xf6719800 nid=0xd1f runnable 

"GC task thread#10 (ParallelGC)" prio=10 tid=0xf671b000 nid=0xd20 runnable 

"GC task thread#11 (ParallelGC)" prio=10 tid=0xf671c400 nid=0xd21 runnable 

"GC task thread#12 (ParallelGC)" prio=10 tid=0xf671dc00 nid=0xd22 runnable 

"VM Periodic Task Thread" prio=10 tid=0xcd86a400 nid=0xd2d waiting on condition 

JNI global references: 1135

+ 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.axis2.jaxws.framework.StartServer.testStartServer(StartServer.java:42)'
+ 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 #5301
Archived 1740 artifacts
Archive block size is 32768
Received 83 blocks and 627220823 bytes
Compression is 0.4%
Took 2 min 53 sec
Recording test results
Updating HBASE-11517
Updating HBASE-11489
Updating HBASE-10930

Jenkins build is back to normal : HBase-TRUNK #5315

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5315/changes>


Build failed in Jenkins: HBase-TRUNK #5314

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5314/changes>

Changes:

[stack] HBASE-2251 PE defaults to 1k rows - uncommon use case, and easy to hit benchmarks -- Add zipf distribution of cell values

[stack] HBASE-11517 TestReplicaWithCluster turns zombie (Mikhail Antonov)

[stack] HBASE-11517 TestReplicaWithCluster turns zombie (Mikhail Antonov) -- REVERT

------------------------------------------
Started by an SCM change
Building remotely on H3 (Mapreduce Hadoop Zookeeper Hdfs) in workspace <https://builds.apache.org/job/HBase-TRUNK/ws/>
Cloning the remote Git repository
Cloning repository https://git-wip-us.apache.org/repos/asf/hbase.git
 > git init <https://builds.apache.org/job/HBase-TRUNK/ws/>
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/hbase.git
 > git --version
 > git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/hbase.git +refs/heads/*:refs/remotes/origin/*
 > git config remote.origin.url https://git-wip-us.apache.org/repos/asf/hbase.git
 > git config remote.origin.fetch +refs/heads/*:refs/remotes/origin/*
 > git config remote.origin.url https://git-wip-us.apache.org/repos/asf/hbase.git
Cleaning workspace
 > git rev-parse --verify HEAD
No valid HEAD. Skipping the resetting
 > git clean -fdx
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/hbase.git
 > git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/hbase.git +refs/heads/*:refs/remotes/origin/*
 > git rev-parse origin/master^{commit}
Checking out Revision 782b1456f240ad2fc95555b0f464e6a7e0c1e685 (origin/master)
 > git config core.sparsecheckout
 > git checkout -f 782b1456f240ad2fc95555b0f464e6a7e0c1e685
 > git rev-list 8603da0d0db35adee5ba9af1565aeef1f5ca53f0
[HBase-TRUNK] $ /bin/bash -xe /tmp/hudson8010177777455949147.sh
+ which java
/usr/bin/java
+ java -version
java version "1.6.0_45"
Java(TM) SE Runtime Environment (build 1.6.0_45-b06)
Java HotSpot(TM) 64-Bit Server VM (build 20.45-b01, mixed mode)
+ ulimit -a
core file size          (blocks, -c) 0
data seg size           (kbytes, -d) unlimited
scheduling priority             (-e) 0
file size               (blocks, -f) unlimited
pending signals                 (-i) 386178
max locked memory       (kbytes, -l) 64
max memory size         (kbytes, -m) unlimited
open files                      (-n) 4096
pipe size            (512 bytes, -p) 8
POSIX message queues     (bytes, -q) 819200
real-time priority              (-r) 0
stack size              (kbytes, -s) 8192
cpu time               (seconds, -t) unlimited
max user processes              (-u) 386178
virtual memory          (kbytes, -v) unlimited
file locks                      (-x) unlimited
+ rm -rf /tmp/hbase-jenkins/hbase
Unpacking http://archive.apache.org/dist/maven/binaries/apache-maven-3.0.3-bin.zip to /home/jenkins/jenkins-slave/tools/hudson.tasks.Maven_MavenInstallation/Maven_3.0.3 on H3
[HBase-TRUNK] $ /home/jenkins/jenkins-slave/tools/hudson.tasks.Maven_MavenInstallation/Maven_3.0.3/bin/mvn -PrunAllTests -Dmaven.test.redirectTestOutputToFile=true install -Dsurefire.secondPartThreadCount=2 -Dit.test=noItTest
Error: JAVA_HOME is not defined correctly.
  We cannot execute /home/hudson/tools/java/latest1.7/bin/java
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-TRUNK] $ /bin/bash -xe /tmp/hudson5232728635177802744.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #5301
Archived 14 artifacts
Archive block size is 32768
Received 7 blocks and 83384 bytes
Compression is 73.3%
Took 26 sec
Recording test results
Updating HBASE-2251
Updating HBASE-11517

Build failed in Jenkins: HBase-TRUNK #5313

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5313/changes>

Changes:

[anoopsamjohn] HBASE-10398 HBase book updates for Replication after HBASE-10322. (Misty)

[stack] HBASE-11521 Modify pom.xml to copy the images/ and css/ directories to the right location for the Ref Guide to see them correctly AMENDMENT

------------------------------------------
[...truncated 1899 lines...]
	at java.lang.Thread.run(Thread.java:724)

"pool-356-thread-1" prio=10 tid=0xa6646800 nid=0x19b2 waiting on condition [0xae275000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0xdeddb140> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2176)
	at org.apache.giraph.zk.PredicateLock.waitMsecs(PredicateLock.java:112)
	at org.apache.giraph.zk.PredicateLock.waitForever(PredicateLock.java:138)
	at org.apache.giraph.bsp.BspService.<init>(BspService.java:390)
	at org.apache.giraph.master.BspServiceMaster.<init>(BspServiceMaster.java:201)
	at org.apache.giraph.graph.GraphTaskManager.instantiateBspService(GraphTaskManager.java:570)
	at org.apache.giraph.graph.GraphTaskManager.setup(GraphTaskManager.java:238)
	at org.apache.giraph.graph.GraphMapper.setup(GraphMapper.java:61)
	at org.apache.giraph.graph.GraphMapper.run(GraphMapper.java:91)
	at org.apache.hadoop.mapred.MapTask.runNewMapper(MapTask.java:764)
	at org.apache.hadoop.mapred.MapTask.run(MapTask.java:364)
	at org.apache.hadoop.mapred.LocalJobRunner$Job$MapTaskRunnable.run(LocalJobRunner.java:223)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
	at java.util.concurrent.FutureTask.run(FutureTask.java:166)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:724)

"Thread-78" prio=10 tid=0xa91ab800 nid=0x19b1 waiting on condition [0xa7569000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0xded90a70> (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.ThreadPoolExecutor.awaitTermination(ThreadPoolExecutor.java:1468)
	at org.apache.hadoop.mapred.LocalJobRunner$Job.run(LocalJobRunner.java:341)

"ProcessThread(sid:0 cport:-1):" prio=10 tid=0xa7f01400 nid=0x19b0 waiting on condition [0xa7276000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0xde96e950> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor.java:120)

"SyncThread:0" prio=10 tid=0xa7f10400 nid=0x19af runnable [0xa7cad000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.FileDispatcherImpl.force0(Native Method)
	at sun.nio.ch.FileDispatcherImpl.force(FileDispatcherImpl.java:75)
	at sun.nio.ch.FileChannelImpl.force(FileChannelImpl.java:363)
	at org.apache.zookeeper.server.persistence.FileTxnLog.commit(FileTxnLog.java:316)
	- locked <0xde967a68> (a org.apache.zookeeper.server.persistence.FileTxnLog)
	at org.apache.zookeeper.server.persistence.FileTxnSnapLog.commit(FileTxnSnapLog.java:322)
	at org.apache.zookeeper.server.ZKDatabase.commit(ZKDatabase.java:491)
	at org.apache.zookeeper.server.SyncRequestProcessor.flush(SyncRequestProcessor.java:164)
	at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:101)

"SessionTracker" prio=10 tid=0xa7f3f800 nid=0x19ae in Object.wait() [0xae07d000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xde96e168> (a org.apache.zookeeper.server.SessionTrackerImpl)
	at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:146)
	- locked <0xde96e168> (a org.apache.zookeeper.server.SessionTrackerImpl)

"NIOServerCxn.Factory:0.0.0.0/0.0.0.0:22182" daemon prio=10 tid=0xa7f40400 nid=0x19ad runnable [0xa745c000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
	at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:228)
	at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:81)
	at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
	- locked <0xde9689e0> (a sun.nio.ch.Util$2)
	- locked <0xde9689d0> (a java.util.Collections$UnmodifiableSet)
	- locked <0xde9687d0> (a sun.nio.ch.EPollSelectorImpl)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:178)
	at java.lang.Thread.run(Thread.java:724)

"pool-355-thread-1" prio=10 tid=0xa91ad000 nid=0x19ac in Object.wait() [0xa6e5c000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xde968c70> (a java.lang.Thread)
	at java.lang.Thread.join(Thread.java:1260)
	- locked <0xde968c70> (a java.lang.Thread)
	at java.lang.Thread.join(Thread.java:1334)
	at org.apache.zookeeper.server.NIOServerCnxnFactory.join(NIOServerCnxnFactory.java:302)
	at org.apache.zookeeper.server.ZooKeeperServerMain.runFromConfig(ZooKeeperServerMain.java:113)
	at org.apache.giraph.utils.InternalVertexRunner$1.run(InternalVertexRunner.java:105)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:724)

"globalEventExecutor-1-130" prio=10 tid=0xa80ccc00 nid=0x1994 waiting on condition [0xa74ad000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0xb3e520b8> (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.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
	at io.netty.util.concurrent.GlobalEventExecutor.takeTask(GlobalEventExecutor.java:90)
	at io.netty.util.concurrent.GlobalEventExecutor$TaskRunner.run(GlobalEventExecutor.java:334)
	at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:137)
	at java.lang.Thread.run(Thread.java:724)

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

"SessionTracker" prio=10 tid=0xa7f07000 nid=0x188e in Object.wait() [0xa8d69000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xdfb00088> (a org.apache.zookeeper.server.SessionTrackerImpl)
	at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:146)
	- locked <0xdfb00088> (a org.apache.zookeeper.server.SessionTrackerImpl)

"process reaper" daemon prio=10 tid=0xa8613000 nid=0x7b90 waiting on condition [0xae224000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0xb3e4eb80> (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:724)

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

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

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

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

"Finalizer" daemon prio=10 tid=0xaa8b7c00 nid=0x7adc in Object.wait() [0xaec7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xb3e0ef48> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0xb3e0ef48> (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=0xaa8b6000 nid=0x7ad9 in Object.wait() [0xaee7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0xb3e15f40> (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 <0xb3e15f40> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6706400 nid=0x7ab7 waiting on condition [0xf68d9000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.giraph.utils.CounterUtils.waitAndGetCounterNameFromGroup(CounterUtils.java:49)
	at org.apache.giraph.job.HaltApplicationUtils.printHaltInfo(HaltApplicationUtils.java:43)
	at org.apache.giraph.job.GiraphJob.run(GiraphJob.java:254)
	at org.apache.giraph.utils.InternalVertexRunner.runZooKeeperAndJob(InternalVertexRunner.java:112)
	at org.apache.giraph.utils.InternalVertexRunner.run(InternalVertexRunner.java:234)
	at org.apache.giraph.utils.InternalVertexRunner.run(InternalVertexRunner.java:148)
	at org.apache.giraph.utils.InternalVertexRunner.run(InternalVertexRunner.java:84)
	at org.apache.giraph.examples.BrachaTouegDeadlockComputationTest.testEmptyGraph(BrachaTouegDeadlockComputationTest.java:53)
	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.RunBefores.evaluate(RunBefores.java:26)
	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.JUnit4TestSet.execute(JUnit4TestSet.java:59)
	at org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.executeTestSet(AbstractDirectoryTestSuite.java:120)
	at org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.execute(AbstractDirectoryTestSuite.java:103)
	at org.apache.maven.surefire.Surefire.run(Surefire.java:169)
	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.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:350)
	at org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:1021)

"VM Thread" prio=10 tid=0xaa8b0400 nid=0x7ad4 runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0xf6710400 nid=0x7aba runnable 

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

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

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

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

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

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

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

"GC task thread#8 (ParallelGC)" prio=10 tid=0xf671bc00 nid=0x7ac4 runnable 

"GC task thread#9 (ParallelGC)" prio=10 tid=0xf671d000 nid=0x7ac5 runnable 

"GC task thread#10 (ParallelGC)" prio=10 tid=0xf671e800 nid=0x7ac7 runnable 

"GC task thread#11 (ParallelGC)" prio=10 tid=0xf6720000 nid=0x7ac8 runnable 

"GC task thread#12 (ParallelGC)" prio=10 tid=0xf6721800 nid=0x7ac9 runnable 

"VM Periodic Task Thread" prio=10 tid=0xaa8f9800 nid=0x7afc waiting on condition 

JNI global references: 299

+ 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.giraph.examples.BrachaTouegDeadlockComputationTest.testThreeNodesAllNodesFreeGraph(BrachaTouegDeadlockComputationTest.java:94)'
+ 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 #5301
Archived 1740 artifacts
Archive block size is 32768
Received 77 blocks and 629285073 bytes
Compression is 0.4%
Took 2 min 50 sec
Recording test results
Updating HBASE-10322
Updating HBASE-11521
Updating HBASE-10398

Build failed in Jenkins: HBase-TRUNK #5312

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5312/changes>

Changes:

[stack] HBASE-11523 JSON serialization of PE Options is broke

------------------------------------------
[...truncated 1968 lines...]
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.hadoop.hbase.regionserver.wal.FSHLog$SyncRunner.run(FSHLog.java:1267)
	at java.lang.Thread.run(Thread.java:744)

"sync.3" prio=10 tid=0x00007f1814005000 nid=0x315d waiting on condition [0x00007f1878d0d000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66aa640> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.hadoop.hbase.regionserver.wal.FSHLog$SyncRunner.run(FSHLog.java:1267)
	at java.lang.Thread.run(Thread.java:744)

"sync.2" prio=10 tid=0x00007f1814007000 nid=0x315c waiting on condition [0x00007f1878b0b000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66aa918> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.hadoop.hbase.regionserver.wal.FSHLog$SyncRunner.run(FSHLog.java:1267)
	at java.lang.Thread.run(Thread.java:744)

"sync.1" prio=10 tid=0x00007f1814009000 nid=0x315b waiting on condition [0x00007f1879010000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66aabf0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.hadoop.hbase.regionserver.wal.FSHLog$SyncRunner.run(FSHLog.java:1267)
	at java.lang.Thread.run(Thread.java:744)

"sync.0" prio=10 tid=0x00007f1814003000 nid=0x315a waiting on condition [0x00007f1878808000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66d5ca0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at org.apache.hadoop.hbase.regionserver.wal.FSHLog$SyncRunner.run(FSHLog.java:1267)
	at java.lang.Thread.run(Thread.java:744)

"pool-1-thread-1.append-pool45-t1" prio=10 tid=0x00007f1834491800 nid=0x3159 waiting on condition [0x00007f1878f0f000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66ab010> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
	at com.lmax.disruptor.BlockingWaitStrategy.waitFor(BlockingWaitStrategy.java:45)
	at com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:55)
	at com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:123)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:744)

"pool-1-thread-1-MemStoreChunkPool Statistics" daemon prio=10 tid=0x00007f1834555800 nid=0x3149 waiting on condition [0x00007f1878606000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007f66d60c0> (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:744)

"Timer for 'HBase' metrics system" daemon prio=10 tid=0x00007f18346f9000 nid=0x1de8 in Object.wait() [0x00007f1879414000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x000000078deb6b00> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"pool-1-thread-1" prio=10 tid=0x00007f18a8ecf800 nid=0x1b0a waiting on condition [0x00007f1879818000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hbase.regionserver.TestHeapMemoryManager.testWhenClusterIsWriteHeavy(TestHeapMemoryManager.java:118)
	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.junit.runners.Suite.runChild(Suite.java:127)
	at org.junit.runners.Suite.runChild(Suite.java:26)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:744)

"LruBlockCacheStatsExecutor" daemon prio=10 tid=0x00007f18a8be5800 nid=0x1a40 waiting on condition [0x00007f187991a000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007894431a0> (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:744)

"main.LruBlockCache.EvictionThread" daemon prio=10 tid=0x00007f18a8be5000 nid=0x1a3f in Object.wait() [0x00007f1879a1b000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x000000078944b180> (a org.apache.hadoop.hbase.io.hfile.LruBlockCache$EvictionThread)
	at java.lang.Object.wait(Object.java:503)
	at org.apache.hadoop.hbase.io.hfile.LruBlockCache$EvictionThread.run(LruBlockCache.java:717)
	- locked <0x000000078944b180> (a org.apache.hadoop.hbase.io.hfile.LruBlockCache$EvictionThread)
	at java.lang.Thread.run(Thread.java:744)

"process reaper" daemon prio=10 tid=0x00007f18a8bd6800 nid=0x1a37 waiting on condition [0x00007f1879a54000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x000000078944b200> (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:744)

"Service Thread" daemon prio=10 tid=0x00007f18a8290000 nid=0x16a8 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread1" daemon prio=10 tid=0x00007f18a828e000 nid=0x16a7 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" daemon prio=10 tid=0x00007f18a828b000 nid=0x16a6 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" daemon prio=10 tid=0x00007f18a8280800 nid=0x16a5 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=10 tid=0x00007f18a826b000 nid=0x16a3 in Object.wait() [0x00007f187a8e7000]
   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 <0x000000078944b488> (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=0x00007f18a8267000 nid=0x169f in Object.wait() [0x00007f187a9e8000]
   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 <0x000000078944b520> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0x00007f18a800a800 nid=0x1679 waiting on condition [0x00007f18b0fd8000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007898bffe8> (a java.util.concurrent.FutureTask)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:425)
	at java.util.concurrent.FutureTask.get(FutureTask.java:187)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.waitForCompletion(AsynchronousRunner.java:73)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.finished(AsynchronousRunner.java:58)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:242)
	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.junit.runner.JUnitCore.run(JUnitCore.java:160)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:138)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:61)
	at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:137)
	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:188)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:166)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:101)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74)

"VM Thread" prio=10 tid=0x00007f18a8264800 nid=0x169e runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f18a8020800 nid=0x167a runnable 

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

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

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

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

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

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

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

"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007f18a802f000 nid=0x1682 runnable 

"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007f18a8031000 nid=0x1683 runnable 

"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007f18a8033000 nid=0x1684 runnable 

"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007f18a8034800 nid=0x1685 runnable 

"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007f18a8036800 nid=0x1687 runnable 

"VM Periodic Task Thread" prio=10 tid=0x00007f18a829b000 nid=0x16ae waiting on condition 

JNI global references: 210

+ 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.hbase.regionserver.TestHeapMemoryManager.testWhenCombinedHeapSizesFromTunerGoesOutSideMaxLimit(TestHeapMemoryManager.java:244)'
+ 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 #5301
Archived 1734 artifacts
Archive block size is 32768
Received 77 blocks and 622046037 bytes
Compression is 0.4%
Took 3 min 9 sec
Recording test results
Updating HBASE-11523

Build failed in Jenkins: HBase-TRUNK #5311

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5311/changes>

Changes:

[stack] HBASE-11520 Simplify offheap cache config by removing the confusing "hbase.bucketcache.percentage.in.combinedcache"

[stack] Add a upgrading to 1.0 section to the upgrade part of the book; talk about HBASE-11520 removing hbase.bucketcache.percentage.in.combinedcache

------------------------------------------
Started by an SCM change
Building remotely on H0 (Hadoop Tez) in workspace <https://builds.apache.org/job/HBase-TRUNK/ws/>
 > git rev-parse --is-inside-work-tree
Fetching changes from the remote Git repository
 > git config remote.origin.url https://git-wip-us.apache.org/repos/asf/hbase.git
Cleaning workspace
 > git rev-parse --verify HEAD
Resetting working tree
 > git reset --hard
 > git clean -fdx
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/hbase.git
 > git --version
 > git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/hbase.git +refs/heads/*:refs/remotes/origin/*
 > git rev-parse origin/master^{commit}
Checking out Revision a99b71da5774500af5d72b47dcfd7a7cf2a9eb00 (origin/master)
 > git config core.sparsecheckout
 > git checkout -f a99b71da5774500af5d72b47dcfd7a7cf2a9eb00
 > git rev-list 58982e2027228676a059dff845b14ed5b4f2bb9f
[HBase-TRUNK] $ /bin/bash -xe /tmp/hudson6048726530829896390.sh
+ which java
/usr/bin/java
+ java -version
java version "1.6.0_45"
Java(TM) SE Runtime Environment (build 1.6.0_45-b06)
Java HotSpot(TM) 64-Bit Server VM (build 20.45-b01, mixed mode)
+ ulimit -a
core file size          (blocks, -c) 0
data seg size           (kbytes, -d) unlimited
scheduling priority             (-e) 0
file size               (blocks, -f) unlimited
pending signals                 (-i) 386178
max locked memory       (kbytes, -l) 64
max memory size         (kbytes, -m) unlimited
open files                      (-n) 4096
pipe size            (512 bytes, -p) 8
POSIX message queues     (bytes, -q) 819200
real-time priority              (-r) 0
stack size              (kbytes, -s) 8192
cpu time               (seconds, -t) unlimited
max user processes              (-u) 386178
virtual memory          (kbytes, -v) unlimited
file locks                      (-x) unlimited
+ rm -rf /tmp/hbase-jenkins/hbase
Unpacking http://archive.apache.org/dist/maven/binaries/apache-maven-3.0.3-bin.zip to /home/jenkins/jenkins-slave/tools/hudson.tasks.Maven_MavenInstallation/Maven_3.0.3 on H0
[HBase-TRUNK] $ /home/jenkins/jenkins-slave/tools/hudson.tasks.Maven_MavenInstallation/Maven_3.0.3/bin/mvn -PrunAllTests -Dmaven.test.redirectTestOutputToFile=true install -Dsurefire.secondPartThreadCount=2 -Dit.test=noItTest
Error: JAVA_HOME is not defined correctly.
  We cannot execute /home/hudson/tools/java/latest1.7/bin/java
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-TRUNK] $ /bin/bash -xe /tmp/hudson2312433379255669415.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #5301
Archived 14 artifacts
Archive block size is 32768
Received 7 blocks and 83384 bytes
Compression is 73.3%
Took 10 sec
Recording test results
Updating HBASE-11520

Build failed in Jenkins: HBase-TRUNK #5310

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5310/changes>

Changes:

[stack] HBASE-11521 Modify pom.xml to copy the images/ and css/ directories to the right location for the Ref Guide to see them correctly (Misty Stanley-Jones)

------------------------------------------
[...truncated 10117 lines...]
"org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@13b2835" daemon prio=10 tid=0x60e74800 nid=0x1dd7 waiting on condition [0x6105c000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor.run(BlockManager.java:3336)
	at java.lang.Thread.run(Thread.java:724)

"org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor@cccdf4" daemon prio=10 tid=0x60e73000 nid=0x1dd6 waiting on condition [0x610ad000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor.run(HeartbeatManager.java:307)
	at java.lang.Thread.run(Thread.java:724)

"org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor@17dd166" daemon prio=10 tid=0x60e72400 nid=0x1dd5 waiting on condition [0x610fe000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor.run(DecommissionManager.java:76)
	at java.lang.Thread.run(Thread.java:724)

"org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@129bf61" daemon prio=10 tid=0x60e71000 nid=0x1dd4 waiting on condition [0x61e5c000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:221)
	at java.lang.Thread.run(Thread.java:724)

"org.apache.hadoop.util.JvmPauseMonitor$Monitor@a38bac" daemon prio=10 tid=0x60e6bc00 nid=0x1dce waiting on condition [0x61efe000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.util.JvmPauseMonitor$Monitor.run(JvmPauseMonitor.java:161)
	at java.lang.Thread.run(Thread.java:724)

"IPC Server idle connection scanner for port 58451" daemon prio=10 tid=0x60e55400 nid=0x1dcd in Object.wait() [0x62d5c000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x805cd978> (a java.util.TaskQueue)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x805cd978> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"Socket Reader #1 for port 58451" prio=10 tid=0x60e3a800 nid=0x1dcc runnable [0x62dad000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
	at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:228)
	at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:81)
	at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
	- locked <0x805cfb30> (a sun.nio.ch.Util$2)
	- locked <0x805cfb20> (a java.util.Collections$UnmodifiableSet)
	- locked <0x805cf210> (a sun.nio.ch.EPollSelectorImpl)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
	at org.apache.hadoop.ipc.Server$Listener$Reader.doRunLoop(Server.java:616)
	- locked <0x805dce48> (a org.apache.hadoop.ipc.Server$Listener$Reader)
	at org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:595)

"Timer-0" daemon prio=10 tid=0x62665800 nid=0x1dcb in Object.wait() [0x62dfe000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7fd262c0> (a java.util.TaskQueue)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x7fd262c0> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"16123961@qtp-20311844-1 - Acceptor0 SelectChannelConnector@localhost:52881" daemon prio=10 tid=0x6264a000 nid=0x1dca runnable [0x6427d000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
	at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:228)
	at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:81)
	at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
	- locked <0x7fd2a320> (a sun.nio.ch.Util$2)
	- locked <0x7fd2a330> (a java.util.Collections$UnmodifiableSet)
	- locked <0x7fd2a2e0> (a sun.nio.ch.EPollSelectorImpl)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at org.mortbay.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:498)
	at org.mortbay.io.nio.SelectorManager.doSelect(SelectorManager.java:192)
	at org.mortbay.jetty.nio.SelectChannelConnector.accept(SelectChannelConnector.java:124)
	at org.mortbay.jetty.AbstractConnector$Acceptor.run(AbstractConnector.java:708)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:582)

"6713954@qtp-20311844-0" daemon prio=10 tid=0x62649800 nid=0x1dc9 in Object.wait() [0x6447d000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7fd1eec8> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
	- locked <0x7fd1eec8> (a org.mortbay.thread.QueuedThreadPool$PoolThread)

"Timer for 'NameNode' metrics system" daemon prio=10 tid=0x60cf7000 nid=0x1dc8 in Object.wait() [0x64e52000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7fd2a5b0> (a java.util.TaskQueue)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x7fd2a5b0> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"process reaper" daemon prio=10 tid=0x62b0b000 nid=0x1db6 runnable [0x6ac24000]
   java.lang.Thread.State: RUNNABLE
	at java.lang.UNIXProcess.waitForProcessExit(Native Method)
	at java.lang.UNIXProcess.access$200(UNIXProcess.java:54)
	at java.lang.UNIXProcess$3.run(UNIXProcess.java:174)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:724)

"pool-1-thread-1" prio=10 tid=0x63620000 nid=0x1d91 waiting on condition [0x6aa7d000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.mapreduce.Job.monitorAndPrintJob(Job.java:1348)
	at org.apache.hadoop.mapreduce.Job.waitForCompletion(Job.java:1306)
	at org.apache.hadoop.hbase.mapreduce.TestTableMapReduce.runTestOnTable(TestTableMapReduce.java:120)
	at org.apache.hadoop.hbase.mapreduce.TestTableMapReduceBase.testCombiner(TestTableMapReduceBase.java:104)
	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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.junit.runners.Suite.runChild(Suite.java:127)
	at org.junit.runners.Suite.runChild(Suite.java:26)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
	at java.util.concurrent.FutureTask.run(FutureTask.java:166)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:724)

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

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

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

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

"Finalizer" daemon prio=10 tid=0x64cb7000 nid=0x1d76 in Object.wait() [0x6be7d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7caa6808> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0x7caa6808> (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=0x64cb5400 nid=0x1d75 in Object.wait() [0x6c07d000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x7ca9d6b0> (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 <0x7ca9d6b0> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0xf6706800 nid=0x1d64 waiting on condition [0xf68d4000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x7caa6af8> (a java.util.concurrent.FutureTask$Sync)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:834)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:994)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1303)
	at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:248)
	at java.util.concurrent.FutureTask.get(FutureTask.java:111)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.waitForCompletion(AsynchronousRunner.java:73)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.finished(AsynchronousRunner.java:58)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:242)
	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.junit.runner.JUnitCore.run(JUnitCore.java:160)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:138)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:61)
	at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:137)
	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:188)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:166)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:101)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74)

"VM Thread" prio=10 tid=0x64bf8800 nid=0x1d73 runnable 

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

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

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

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

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

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

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

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

"GC task thread#8 (ParallelGC)" prio=10 tid=0xf671c000 nid=0x1d6d runnable 

"GC task thread#9 (ParallelGC)" prio=10 tid=0xf671d800 nid=0x1d6e runnable 

"GC task thread#10 (ParallelGC)" prio=10 tid=0xf671ec00 nid=0x1d6f runnable 

"GC task thread#11 (ParallelGC)" prio=10 tid=0xf6720400 nid=0x1d70 runnable 

"GC task thread#12 (ParallelGC)" prio=10 tid=0xf6721c00 nid=0x1d71 runnable 

"VM Periodic Task Thread" prio=10 tid=0x64cf9000 nid=0x1d7d waiting on condition 

JNI global references: 519

+ echo '************ END  zombies jstack extract'
************ END  zombies jstack extract
+ JIRA_COMMENT='

     {color:red}-1 core zombie tests{color}.  There are 2 zombie test(s): 	at org.apache.hadoop.hbase.mapreduce.TestTableMapReduceBase.testCombiner(TestTableMapReduceBase.java:104)'
+ BAD=1
+ jps
+ grep surefirebooter
+ xargs kill -9
+ cut -d ' ' -f 1
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #5301
Archived 1740 artifacts
Archive block size is 32768
Received 76 blocks and 628835052 bytes
Compression is 0.4%
Took 3 min 0 sec
Recording test results
Updating HBASE-11521

Build failed in Jenkins: HBase-TRUNK #5309

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5309/changes>

Changes:

[enis] HBASE-11511 Write flush events to WAL (ADDENDUM to fix flaky test)

------------------------------------------
[...truncated 1597 lines...]
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.488 sec
Running org.apache.hadoop.hbase.regionserver.TestCacheOnWriteInSchema
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.605 sec
Running org.apache.hadoop.hbase.regionserver.TestJoinedScanners
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.987 sec
Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.054 sec
Running org.apache.hadoop.hbase.regionserver.TestStore
Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.504 sec
Running org.apache.hadoop.hbase.regionserver.TestBlocksRead
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.537 sec
Running org.apache.hadoop.hbase.regionserver.handler.TestOpenRegionHandler
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.322 sec
Running org.apache.hadoop.hbase.regionserver.handler.TestCloseRegionHandler
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.299 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestHLogSplitCompressed
Tests run: 33, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 59.497 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestLogRollPeriod
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 58.287 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestSecureHLog
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.066 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestHLogFiltering
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.066 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestSecureWALReplay
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 55.002 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestHLog
Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.907 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestHLogSplit
Tests run: 33, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 58.571 sec
Running org.apache.hadoop.hbase.TestAcidGuarantees
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 600.986 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestReadOldRootAndMetaEdits
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.609 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestLogRollAbort
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.386 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestWALReplayCompressed
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 53.614 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestWALReplay
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.489 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestDurability
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.211 sec
Running org.apache.hadoop.hbase.regionserver.wal.TestLogRolling
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 213.924 sec
Running org.apache.hadoop.hbase.regionserver.TestMajorCompaction
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 48.194 sec
Running org.apache.hadoop.hbase.regionserver.TestParallelPut
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 137.695 sec
Running org.apache.hadoop.hbase.regionserver.TestEncryptionKeyRotation
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.075 sec
Running org.apache.hadoop.hbase.regionserver.TestZKLessSplitOnCluster
Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 35.937 sec
Running org.apache.hadoop.hbase.regionserver.TestRegionReplicas
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 128.827 sec
Running org.apache.hadoop.hbase.regionserver.TestCompactionState
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.666 sec
Running org.apache.hadoop.hbase.regionserver.TestFSErrorsExposed
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 51.398 sec
Running org.apache.hadoop.hbase.regionserver.TestHRegionBusyWait
Tests run: 78, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 120.182 sec
Running org.apache.hadoop.hbase.regionserver.TestRegionServerMetrics
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.495 sec
Running org.apache.hadoop.hbase.regionserver.TestGetClosestAtOrBefore
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.093 sec
Running org.apache.hadoop.hbase.regionserver.TestDefaultMemStore
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 47.969 sec
Running org.apache.hadoop.hbase.regionserver.TestReversibleScanners
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.053 sec
Running org.apache.hadoop.hbase.regionserver.TestRSKilledWhenInitializing
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.49 sec
Running org.apache.hadoop.hbase.regionserver.TestRegionServerNoMaster
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.962 sec
Running org.apache.hadoop.hbase.regionserver.TestClusterId
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.508 sec
Running org.apache.hadoop.hbase.regionserver.TestCompaction
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.78 sec
Running org.apache.hadoop.hbase.regionserver.TestRegionFavoredNodes
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.648 sec
Running org.apache.hadoop.hbase.regionserver.TestSeekOptimizations
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.543 sec
Running org.apache.hadoop.hbase.regionserver.TestServerCustomProtocol
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.048 sec
Running org.apache.hadoop.hbase.regionserver.TestAtomicOperation
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 41.421 sec
Running org.apache.hadoop.hbase.regionserver.TestSplitTransactionOnCluster
Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 43.827 sec
Running org.apache.hadoop.hbase.regionserver.TestCompactionWithCoprocessor
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.327 sec
Running org.apache.hadoop.hbase.regionserver.TestHRegion
Tests run: 77, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 119.567 sec
Running org.apache.hadoop.hbase.regionserver.TestZKLessMergeOnCluster
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.536 sec
Running org.apache.hadoop.hbase.regionserver.TestEncryptionRandomKeying
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.839 sec
Running org.apache.hadoop.hbase.regionserver.TestHRegionServerBulkLoad
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 40.617 sec
Running org.apache.hadoop.hbase.regionserver.TestEndToEndSplitTransaction
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.945 sec
Running org.apache.hadoop.hbase.TestRegionRebalancing
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.376 sec
Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 121.404 sec
Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 55.427 sec
Running org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.746 sec
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.951 sec
Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 232.948 sec
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.194 sec
Running org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 36, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 78.579 sec
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.14 sec
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 93.499 sec
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.794 sec
Running org.apache.hadoop.hbase.io.TestFileLink
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.54 sec
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 62.996 sec
Running org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.092 sec
Running org.apache.hadoop.hbase.security.access.TestCellACLs
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.955 sec
Running org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.267 sec
Running org.apache.hadoop.hbase.security.access.TestAccessController
Tests run: 44, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 85.155 sec
Running org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.052 sec
Running org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.222 sec
Running org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.903 sec
Running org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.958 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabels
Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.299 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDeletes
Tests run: 37, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 46.618 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDistributedLogReplay
Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.011 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithSLGStack
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.581 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsOpWithDifferentUsersNoACL
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.593 sec
Running org.apache.hadoop.hbase.security.visibility.TestEnforcingScanLabelGenerator
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.977 sec
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithACL
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.253 sec
Running org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.493 sec
Running org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.829 sec

Results :

Tests in error: 
  testCreateDeleteTable(org.apache.hadoop.hbase.client.TestReplicaWithCluster): test timed out after 30000 milliseconds
  testChangeTable(org.apache.hadoop.hbase.client.TestReplicaWithCluster): test timed out after 30000 milliseconds

Tests run: 2076, Failures: 0, Errors: 2, Skipped: 21

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [2.654s]
[INFO] HBase - Common .................................... SUCCESS [30.854s]
[INFO] HBase - Protocol .................................. SUCCESS [9.153s]
[INFO] HBase - Client .................................... SUCCESS [54.288s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [5.311s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [1.616s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [3.363s]
[INFO] HBase - Server .................................... FAILURE [2:01:55.219s]
[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: 2:03:43.256s
[INFO] Finished at: Wed Jul 16 04:08:33 UTC 2014
[INFO] Final Memory: 39M/786M
[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-TRUNK/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-TRUNK] $ /bin/bash -xe /tmp/hudson6543487436150764860.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #5301
Archived 1740 artifacts
Archive block size is 32768
Received 76 blocks and 625893839 bytes
Compression is 0.4%
Took 2 min 44 sec
Recording test results
Updating HBASE-11511

Build failed in Jenkins: HBase-TRUNK #5308

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5308/changes>

Changes:

[enis] HBASE-11511 Write flush events to WAL

[enis] HBASE-11502 Fixed typo in image name (timeline_consistency.png)

------------------------------------------
[...truncated 39031 lines...]
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at org.apache.hadoop.ipc.Server$Responder.doRunLoop(Server.java:835)
	at org.apache.hadoop.ipc.Server$Responder.run(Server.java:818)

"org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@636130e" daemon prio=10 tid=0x00007ff3ec8ec000 nid=0x4e32 waiting on condition [0x00007ff41b7e2000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor.run(BlockManager.java:3336)
	at java.lang.Thread.run(Thread.java:744)

"org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor@481cff51" daemon prio=10 tid=0x00007ff3ec8e9800 nid=0x4e31 waiting on condition [0x00007ff41b8e3000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor.run(HeartbeatManager.java:307)
	at java.lang.Thread.run(Thread.java:744)

"org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor@77a0c73f" daemon prio=10 tid=0x00007ff3ec8e8000 nid=0x4e2e waiting on condition [0x00007ff41b9e4000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor.run(DecommissionManager.java:76)
	at java.lang.Thread.run(Thread.java:744)

"org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@1cc08870" daemon prio=10 tid=0x00007ff3ec8e7000 nid=0x4e2c waiting on condition [0x00007ff41bae5000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:221)
	at java.lang.Thread.run(Thread.java:744)

"org.apache.hadoop.util.JvmPauseMonitor$Monitor@56c3560b" daemon prio=10 tid=0x00007ff3ec8cc000 nid=0x4e10 waiting on condition [0x00007ff41bce7000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.util.JvmPauseMonitor$Monitor.run(JvmPauseMonitor.java:161)
	at java.lang.Thread.run(Thread.java:744)

"IPC Server idle connection scanner for port 41712" daemon prio=10 tid=0x00007ff3ec8c7800 nid=0x4d30 in Object.wait() [0x00007ff41bde8000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x00000007fc4da4e8> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"Socket Reader #1 for port 41712" prio=10 tid=0x00007ff3ec8c6000 nid=0x4d2e runnable [0x00007ff4400ff000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
	at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
	at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
	at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
	- locked <0x00000007fc4d8208> (a sun.nio.ch.Util$2)
	- locked <0x00000007fc4d81f8> (a java.util.Collections$UnmodifiableSet)
	- locked <0x00000007fc4d63b0> (a sun.nio.ch.EPollSelectorImpl)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
	at org.apache.hadoop.ipc.Server$Listener$Reader.doRunLoop(Server.java:616)
	- locked <0x00000007fc4ec5a8> (a org.apache.hadoop.ipc.Server$Listener$Reader)
	at org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:595)

"Timer-0" daemon prio=10 tid=0x00007ff3ec6b1000 nid=0x4aeb in Object.wait() [0x00007ff4404c7000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x00000007fb6255d0> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"58256679@qtp-203955838-1 - Acceptor0 SelectChannelConnector@localhost:38572" daemon prio=10 tid=0x00007ff3ec6a6000 nid=0x49c2 runnable [0x00007ff4405c8000]
   java.lang.Thread.State: RUNNABLE
	at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
	at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
	at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
	at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
	- locked <0x00000007fbf57d10> (a sun.nio.ch.Util$2)
	- locked <0x00000007fbf57d00> (a java.util.Collections$UnmodifiableSet)
	- locked <0x00000007fbf57b58> (a sun.nio.ch.EPollSelectorImpl)
	at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
	at org.mortbay.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:498)
	at org.mortbay.io.nio.SelectorManager.doSelect(SelectorManager.java:192)
	at org.mortbay.jetty.nio.SelectChannelConnector.accept(SelectChannelConnector.java:124)
	at org.mortbay.jetty.AbstractConnector$Acceptor.run(AbstractConnector.java:708)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:582)

"704023257@qtp-203955838-0" daemon prio=10 tid=0x00007ff3ec6a5800 nid=0x49bf in Object.wait() [0x00007ff440af9000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x000000078eb3b2d0> (a org.mortbay.thread.QueuedThreadPool$PoolThread)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:626)
	- locked <0x000000078eb3b2d0> (a org.mortbay.thread.QueuedThreadPool$PoolThread)

"Timer for 'NameNode' metrics system" daemon prio=10 tid=0x00007ff3ec62d800 nid=0x4970 in Object.wait() [0x00007ff4408ca000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x00000007fbf577a0> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"process reaper" daemon prio=10 tid=0x00007ff3ec20b000 nid=0x4745 waiting on condition [0x00007ff440903000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007fa43d998> (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:744)

"pool-1-thread-1" prio=10 tid=0x00007ff454640800 nid=0x448d in Object.wait() [0x00007ff440e22000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.lang.Thread.join(Thread.java:1288)
	- locked <0x00000007e01da388> (a org.junit.internal.runners.statements.FailOnTimeout$StatementThread)
	at org.junit.internal.runners.statements.FailOnTimeout.evaluateStatement(FailOnTimeout.java:26)
	at org.junit.internal.runners.statements.FailOnTimeout.evaluate(FailOnTimeout.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.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.junit.runners.Suite.runChild(Suite.java:127)
	at org.junit.runners.Suite.runChild(Suite.java:26)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:744)

"Service Thread" daemon prio=10 tid=0x00007ff45428f000 nid=0x43a7 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread1" daemon prio=10 tid=0x00007ff45428c800 nid=0x43a6 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" daemon prio=10 tid=0x00007ff454289800 nid=0x43a5 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" daemon prio=10 tid=0x00007ff45427f800 nid=0x43a4 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=10 tid=0x00007ff45426a000 nid=0x439a in Object.wait() [0x00007ff441ad9000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x00000007fa3d3e20> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0x00000007fa3d3e20> (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=0x00007ff454266000 nid=0x4397 in Object.wait() [0x00007ff441bda000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x00000007fd4810f8> (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 <0x00000007fd4810f8> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0x00007ff454009000 nid=0x437c waiting on condition [0x00007ff45bb58000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x000000078b712220> (a java.util.concurrent.FutureTask)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:425)
	at java.util.concurrent.FutureTask.get(FutureTask.java:187)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.waitForCompletion(AsynchronousRunner.java:73)
	at org.apache.maven.surefire.junitcore.AsynchronousRunner.finished(AsynchronousRunner.java:58)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:242)
	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.junit.runner.JUnitCore.run(JUnitCore.java:160)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:138)
	at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:61)
	at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:137)
	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:188)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:166)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:101)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74)

"VM Thread" prio=10 tid=0x00007ff454263800 nid=0x438f runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007ff45401f000 nid=0x437e runnable 

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

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

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

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

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

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

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

"GC task thread#8 (ParallelGC)" prio=10 tid=0x00007ff45402e000 nid=0x4386 runnable 

"GC task thread#9 (ParallelGC)" prio=10 tid=0x00007ff454030000 nid=0x4387 runnable 

"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007ff454031800 nid=0x4388 runnable 

"GC task thread#11 (ParallelGC)" prio=10 tid=0x00007ff454033800 nid=0x4389 runnable 

"GC task thread#12 (ParallelGC)" prio=10 tid=0x00007ff454035800 nid=0x438a runnable 

"VM Periodic Task Thread" prio=10 tid=0x00007ff454299800 nid=0x43a9 waiting on condition 

JNI global references: 278

+ echo '************ END  zombies jstack extract'
************ END  zombies jstack extract
+ JIRA_COMMENT='

     {color:red}-1 core zombie tests{color}.  There are 6 zombie test(s): 	at org.apache.hadoop.hbase.snapshot.TestExportSnapshot.testExportFileSystemState(TestExportSnapshot.java:291)
	at org.apache.hadoop.hbase.snapshot.TestExportSnapshot.testExportFileSystemState(TestExportSnapshot.java:265)
	at org.apache.hadoop.hbase.snapshot.TestExportSnapshot.testExportFileSystemStateWithSkipTmp(TestExportSnapshot.java:204)
	at org.apache.hadoop.hbase.client.TestRestoreSnapshotFromClient.testRestoreSnapshot(TestRestoreSnapshotFromClient.java:152)
	at org.apache.hadoop.hbase.regionserver.TestHRegion.testFlushCacheWhileScanning(TestHRegion.java:3395)
	at org.apache.hadoop.hbase.snapshot.TestExportSnapshot.testExportFailure(TestExportSnapshot.java:320)
	at org.apache.hadoop.hbase.client.TestReplicaWithCluster.testCreateDeleteTable(TestReplicaWithCluster.java:138)'
+ 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 #5301
Archived 1731 artifacts
Archive block size is 32768
Received 76 blocks and 614723137 bytes
Compression is 0.4%
Took 3 min 8 sec
Recording test results
Updating HBASE-11502
Updating HBASE-11511

Build failed in Jenkins: HBase-TRUNK #5307

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-TRUNK/5307/>

------------------------------------------
Started by user stack
Building remotely on H0 (Hadoop Tez) in workspace <https://builds.apache.org/job/HBase-TRUNK/ws/>
Cloning the remote Git repository
Cloning repository https://git-wip-us.apache.org/repos/asf/hbase.git
 > git init <https://builds.apache.org/job/HBase-TRUNK/ws/>
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/hbase.git
 > git --version
 > git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/hbase.git +refs/heads/*:refs/remotes/origin/*
 > git config remote.origin.url https://git-wip-us.apache.org/repos/asf/hbase.git
 > git config remote.origin.fetch +refs/heads/*:refs/remotes/origin/*
 > git config remote.origin.url https://git-wip-us.apache.org/repos/asf/hbase.git
Cleaning workspace
 > git rev-parse --verify HEAD
No valid HEAD. Skipping the resetting
 > git clean -fdx
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/hbase.git
 > git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/hbase.git +refs/heads/*:refs/remotes/origin/*
 > git rev-parse origin/master^{commit}
Checking out Revision fe50c6d366092baf2232b8649b63dd714e4064b8 (origin/master)
 > git config core.sparsecheckout
 > git checkout -f fe50c6d366092baf2232b8649b63dd714e4064b8
 > git rev-list fe50c6d366092baf2232b8649b63dd714e4064b8
[HBase-TRUNK] $ /bin/bash -xe /tmp/hudson6192180412662434202.sh
+ which java
/usr/bin/java
+ java -version
java version "1.6.0_45"
Java(TM) SE Runtime Environment (build 1.6.0_45-b06)
Java HotSpot(TM) 64-Bit Server VM (build 20.45-b01, mixed mode)
+ ulimit -a
core file size          (blocks, -c) 0
data seg size           (kbytes, -d) unlimited
scheduling priority             (-e) 0
file size               (blocks, -f) unlimited
pending signals                 (-i) 386178
max locked memory       (kbytes, -l) 64
max memory size         (kbytes, -m) unlimited
open files                      (-n) 4096
pipe size            (512 bytes, -p) 8
POSIX message queues     (bytes, -q) 819200
real-time priority              (-r) 0
stack size              (kbytes, -s) 8192
cpu time               (seconds, -t) unlimited
max user processes              (-u) 386178
virtual memory          (kbytes, -v) unlimited
file locks                      (-x) unlimited
+ rm -rf /tmp/hbase-jenkins/hbase
+ ls /home/hudson/tools
ls: cannot access /home/hudson/tools: No such file or directory
Build step 'Execute shell' 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-TRUNK] $ /bin/bash -xe /tmp/hudson5444444533183811995.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=0
+ [[ 0 != 0 ]]
+ echo 'We'\''re ok: there is no zombie test'
We're ok: there is no zombie test
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #5301
Archived 14 artifacts
Archive block size is 32768
Received 7 blocks and 83384 bytes
Compression is 73.3%
Took 21 sec
Recording test results