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 2015/05/17 06:48:17 UTC

Build failed in Jenkins: HBase-1.1 #490

See <https://builds.apache.org/job/HBase-1.1/490/changes>

Changes:

[apurtell] HBASE-13647 Default value for hbase.client.operation.timeout is too high

------------------------------------------
[...truncated 2118 lines...]
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 65.47 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDefaultVisLabelService
Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 55.379 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithCustomVisLabService
Running org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Running org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.708 sec - in org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 69.472 sec - in org.apache.hadoop.hbase.security.access.TestAccessController2
Tests run: 37, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 170.97 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDeletes
Running org.apache.hadoop.hbase.security.access.TestCellACLs
Running org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Running org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 45.12 sec - in org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.456 sec - in org.apache.hadoop.hbase.security.access.TestCellACLs
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.561 sec - in org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Running org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Running org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.327 sec - in org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Running org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Running org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.727 sec - in org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.719 sec - in org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Running org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.726 sec - in org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Running org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.433 sec - in org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Running org.apache.hadoop.hbase.TestMetaTableLocator
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.317 sec - in org.apache.hadoop.hbase.TestMetaTableLocator
Running org.apache.hadoop.hbase.TestZooKeeper
Running org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 92.936 sec - in org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.338 sec - in org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Running org.apache.hadoop.hbase.TestHBaseTestingUtility
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.245 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 88.974 sec - in org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Running org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 82.919 sec - in org.apache.hadoop.hbase.TestHBaseTestingUtility
Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Killed
Killed
Killed
Killed
Killed
Running org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Running org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Running org.apache.hadoop.hbase.TestInfoServers
Running org.apache.hadoop.hbase.quotas.TestQuotaAdmin
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.618 sec - in org.apache.hadoop.hbase.TestInfoServers
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.195 sec - in org.apache.hadoop.hbase.quotas.TestQuotaAdmin
Running org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Running org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.91 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.002 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Running org.apache.hadoop.hbase.procedure.TestZKProcedure
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.804 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedure
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Running org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.091 sec - in org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.214 sec - in org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.242 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.811 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 48.749 sec - in org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Running org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.391 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 88.969 sec - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 93.407 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 63.919 sec - in org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.666 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Running org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 37.493 sec - in org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Running org.apache.hadoop.hbase.io.TestFileLink
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.341 sec - in org.apache.hadoop.hbase.io.TestFileLink
Running org.apache.hadoop.hbase.wal.TestWALFactory
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.193 sec - in org.apache.hadoop.hbase.wal.TestWALFactory
Running org.apache.hadoop.hbase.wal.TestWALFiltering
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 136.714 sec - in org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Running org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.76 sec - in org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Running org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.684 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 29.318 sec - in org.apache.hadoop.hbase.wal.TestWALFiltering
Running org.apache.hadoop.hbase.wal.TestSecureWAL
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.81 sec - in org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestWALSplit
Running org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.018 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Running org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.437 sec - in org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Running org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 246.226 sec - in org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.307 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Running org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.194 sec - in org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.054 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Running org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.386 sec - in org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Running org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.034 sec - in org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Running org.apache.hadoop.hbase.zookeeper.TestZKMulti
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.297 sec - in org.apache.hadoop.hbase.zookeeper.TestZKMulti
Running org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.547 sec - in org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Running org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.367 sec - in org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Running org.apache.hadoop.hbase.TestIOFencing
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 247.647 sec - in org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Running org.apache.hadoop.hbase.constraint.TestConstraint
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 30.324 sec - in org.apache.hadoop.hbase.constraint.TestConstraint
Running org.apache.hadoop.hbase.TestMovedRegionsCleaner
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 189.91 sec - in org.apache.hadoop.hbase.wal.TestWALSplit
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.924 sec - in org.apache.hadoop.hbase.TestMovedRegionsCleaner
Running org.apache.hadoop.hbase.backup.example.TestZooKeeperTableArchiveClient
Running org.apache.hadoop.hbase.backup.TestHFileArchiving
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.566 sec - in org.apache.hadoop.hbase.backup.example.TestZooKeeperTableArchiveClient
Tests run: 216, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 445.125 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Running org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Running org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.055 sec - in org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Running org.apache.hadoop.hbase.ipc.TestDelayedRpc
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.043 sec - in org.apache.hadoop.hbase.ipc.TestDelayedRpc
Running org.apache.hadoop.hbase.ipc.TestHBaseClient
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.411 sec - in org.apache.hadoop.hbase.ipc.TestHBaseClient
Running org.apache.hadoop.hbase.TestNamespace
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 196.578 sec - in org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 33.971 sec - in org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 65.988 sec - in org.apache.hadoop.hbase.backup.TestHFileArchiving
Tests run: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 43.108 sec - in org.apache.hadoop.hbase.TestNamespace
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 227.444 sec - in org.apache.hadoop.hbase.TestIOFencing

Results :



Flaked tests: 
org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence.testOfflineSnapshotDeleteIndependent(org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence)
  Run 1: TestSnapshotCloneIndependence.testOfflineSnapshotDeleteIndependent:177->runTestSnapshotDeleteIndependent:424 » RetriesExhausted
  Run 2: PASS

org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface.testLegacyRecovery(org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface)
  Run 1: TestRegionObserverInterface.testLegacyRecovery:680->verifyMethodResult:746 Result of org.apache.hadoop.hbase.coprocessor.SimpleRegionObserver$Legacy.getCtPreWALRestore is expected to be 1, while we get 0
  Run 2: PASS

org.apache.hadoop.hbase.master.handler.TestEnableTableHandler.testEnableTableWithNoRegionServers(org.apache.hadoop.hbase.master.handler.TestEnableTableHandler)
  Run 1: TestEnableTableHandler.testEnableTableWithNoRegionServers:107 Waiting timed out after [60,000] msec table enabled in zk,
  Run 2: PASS


Tests run: 2525, Failures: 0, Errors: 0, Skipped: 18, Flakes: 3

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [3.309s]
[INFO] HBase - Checkstyle ................................ SUCCESS [0.752s]
[INFO] HBase - Annotations ............................... SUCCESS [1.293s]
[INFO] HBase - Protocol .................................. SUCCESS [12.811s]
[INFO] HBase - Common .................................... SUCCESS [1:25.337s]
[INFO] HBase - Procedure ................................. SUCCESS [1:13.834s]
[INFO] HBase - Client .................................... SUCCESS [1:23.409s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.433s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [7.019s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [10.588s]
[INFO] HBase - Server .................................... FAILURE [2:08:33.074s]
[INFO] HBase - Testing Util .............................. SKIPPED
[INFO] HBase - Thrift .................................... SKIPPED
[INFO] HBase - Rest ...................................... SKIPPED
[INFO] HBase - Shell ..................................... SKIPPED
[INFO] HBase - Integration Tests ......................... SKIPPED
[INFO] HBase - Examples .................................. SKIPPED
[INFO] HBase - Assembly .................................. SKIPPED
[INFO] HBase - Shaded .................................... SKIPPED
[INFO] HBase - Shaded - Client ........................... SKIPPED
[INFO] HBase - Shaded - Server ........................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 2:13:20.819s
[INFO] Finished at: Sun May 17 04:44:52 UTC 2015
[INFO] Final Memory: 92M/941M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18:test (secondPartTestsExecution) on project hbase-server: ExecutionException: java.lang.RuntimeException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd <https://builds.apache.org/job/HBase-1.1/ws/hbase-server> && /home/jenkins/jenkins-slave/tools/hudson.model.JDK/jdk-1.7u51/jre/bin/java -enableassertions -XX:MaxDirectMemorySize=1G -Xmx2800m -XX:MaxPermSize=256m -Djava.security.egd=file:/dev/./urandom -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -jar <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefirebooter3014832241956697780.jar> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire5817011986036771495tmp> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire_11421928720451667215604tmp>
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :hbase-server
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script  :   ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
  if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
    #It seems sometimes the tests are not dying immediately. Let's give them 10s
    echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
    sleep 10   
    ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
    if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
      echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
      echo "************ BEGIN zombies jstack extract"
      ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
      jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
      echo "************ END  zombies jstack extract"
      JIRA_COMMENT="$JIRA_COMMENT

     {color:red}-1 core zombie tests{color}.  There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
      BAD=1
      jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
    else
      echo "We're ok: there is no zombie test, but some tests took some time to stop"
    fi
  else
    echo "We're ok: there is no zombie test"
  fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson8677746249390171339.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-1.1 #489
Archived 2036 artifacts
Archive block size is 32768
Received 28 blocks and 477732622 bytes
Compression is 0.2%
Took 3 min 5 sec
Recording test results
Updating HBASE-13647

Jenkins build is back to normal : HBase-1.1 #493

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


Build failed in Jenkins: HBase-1.1 #492

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

Changes:

[ssrungarapu] HBASE-13673 WALProcedureStore procedure is chatty

[ssrungarapu] HBASE-13675 ProcedureExecutor completion report should be at DEBUG log level

------------------------------------------
[...truncated 2007 lines...]
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 58.199 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDefaultVisLabelService
Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 55.384 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithCustomVisLabService
Running org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Running org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.957 sec - in org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 66.45 sec - in org.apache.hadoop.hbase.security.access.TestAccessController2
Tests run: 37, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 168.26 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDeletes
Running org.apache.hadoop.hbase.security.access.TestCellACLs
Running org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Running org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 45.457 sec - in org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.724 sec - in org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.274 sec - in org.apache.hadoop.hbase.security.access.TestCellACLs
Running org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Running org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.334 sec - in org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Running org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Running org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.122 sec - in org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.723 sec - in org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Running org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.826 sec - in org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Running org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.261 sec - in org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Running org.apache.hadoop.hbase.TestMetaTableLocator
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.868 sec - in org.apache.hadoop.hbase.TestMetaTableLocator
Running org.apache.hadoop.hbase.TestZooKeeper
Running org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 94.03 sec - in org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Running org.apache.hadoop.hbase.TestHBaseTestingUtility
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 8.692 sec - in org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.183 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 83.157 sec - in org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Running org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 90.711 sec - in org.apache.hadoop.hbase.TestHBaseTestingUtility
Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 136.961 sec - in org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Running org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 28.015 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Running org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 239.683 sec - in org.apache.hadoop.hbase.TestZooKeeper
Running org.apache.hadoop.hbase.TestInfoServers
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.319 sec - in org.apache.hadoop.hbase.TestInfoServers
Running org.apache.hadoop.hbase.quotas.TestQuotaAdmin
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.153 sec - in org.apache.hadoop.hbase.quotas.TestQuotaAdmin
Running org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.409 sec - in org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 105.188 sec - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Running org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Running org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.15 sec - in org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Running org.apache.hadoop.hbase.procedure.TestZKProcedure
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.188 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.073 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedure
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Killed
Killed
Killed
Killed
Killed
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.757 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Running org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.404 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.634 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.066 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 64.739 sec - in org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Running org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 93.459 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.TestFileLink
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 34.993 sec - in org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.61 sec - in org.apache.hadoop.hbase.io.TestFileLink
Running org.apache.hadoop.hbase.wal.TestWALFiltering
Running org.apache.hadoop.hbase.wal.TestWALFactory
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.223 sec - in org.apache.hadoop.hbase.wal.TestWALFactory
Running org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.82 sec - in org.apache.hadoop.hbase.wal.TestWALReaderOnSecureWAL
Running org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 29.393 sec - in org.apache.hadoop.hbase.wal.TestWALFiltering
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.907 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Running org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestWALSplit
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.446 sec - in org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 143.009 sec - in org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Running org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.162 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Running org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.087 sec - in org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.284 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Running org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.2 sec - in org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.131 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Running org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.394 sec - in org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Running org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.093 sec - in org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Running org.apache.hadoop.hbase.zookeeper.TestZKMulti
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.43 sec - in org.apache.hadoop.hbase.zookeeper.TestZKMulti
Running org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.127 sec - in org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Running org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.415 sec - in org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Running org.apache.hadoop.hbase.TestIOFencing
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 256.232 sec - in org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Running org.apache.hadoop.hbase.constraint.TestConstraint
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 239.002 sec - in org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Running org.apache.hadoop.hbase.TestMovedRegionsCleaner
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.007 sec - in org.apache.hadoop.hbase.TestMovedRegionsCleaner
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 30.091 sec - in org.apache.hadoop.hbase.constraint.TestConstraint
Running org.apache.hadoop.hbase.backup.example.TestZooKeeperTableArchiveClient
Running org.apache.hadoop.hbase.backup.TestHFileArchiving
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.542 sec - in org.apache.hadoop.hbase.backup.example.TestZooKeeperTableArchiveClient
Running org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 192.764 sec - in org.apache.hadoop.hbase.wal.TestWALSplit
Running org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.012 sec - in org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Running org.apache.hadoop.hbase.ipc.TestDelayedRpc
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.017 sec - in org.apache.hadoop.hbase.ipc.TestDelayedRpc
Running org.apache.hadoop.hbase.ipc.TestHBaseClient
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.386 sec - in org.apache.hadoop.hbase.ipc.TestHBaseClient
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 189.602 sec - in org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 31.77 sec - in org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Running org.apache.hadoop.hbase.TestNamespace
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 67.284 sec - in org.apache.hadoop.hbase.backup.TestHFileArchiving
Tests run: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 38.865 sec - in org.apache.hadoop.hbase.TestNamespace
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 228.343 sec - in org.apache.hadoop.hbase.TestIOFencing

Results :



Flaked tests: 
org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence.testOfflineSnapshotDeleteIndependent(org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence)
  Run 1: TestSnapshotCloneIndependence.testOfflineSnapshotDeleteIndependent:177->runTestSnapshotDeleteIndependent:409 » 
  Run 2: PASS

org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface.testLegacyRecovery(org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface)
  Run 1: TestRegionObserverInterface.testLegacyRecovery:680->verifyMethodResult:746 Result of org.apache.hadoop.hbase.coprocessor.SimpleRegionObserver$Legacy.getCtPreWALRestore is expected to be 1, while we get 0
  Run 2: PASS

org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface.testRecovery(org.apache.hadoop.hbase.coprocessor.TestRegionObserverInterface)
  Run 1: TestRegionObserverInterface.testRecovery:630->verifyMethodResult:746 Result of org.apache.hadoop.hbase.coprocessor.SimpleRegionObserver.getCtPreWALRestore is expected to be 1, while we get 0
  Run 2: PASS


Tests run: 2326, Failures: 0, Errors: 0, Skipped: 18, Flakes: 3

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [3.588s]
[INFO] HBase - Checkstyle ................................ SUCCESS [0.798s]
[INFO] HBase - Annotations ............................... SUCCESS [1.052s]
[INFO] HBase - Protocol .................................. SUCCESS [14.482s]
[INFO] HBase - Common .................................... SUCCESS [1:25.105s]
[INFO] HBase - Procedure ................................. SUCCESS [1:12.247s]
[INFO] HBase - Client .................................... SUCCESS [1:21.776s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.212s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [6.678s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [9.413s]
[INFO] HBase - Server .................................... FAILURE [2:05:22.755s]
[INFO] HBase - Testing Util .............................. SKIPPED
[INFO] HBase - Thrift .................................... SKIPPED
[INFO] HBase - Rest ...................................... SKIPPED
[INFO] HBase - Shell ..................................... SKIPPED
[INFO] HBase - Integration Tests ......................... SKIPPED
[INFO] HBase - Examples .................................. SKIPPED
[INFO] HBase - Assembly .................................. SKIPPED
[INFO] HBase - Shaded .................................... SKIPPED
[INFO] HBase - Shaded - Client ........................... SKIPPED
[INFO] HBase - Shaded - Server ........................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 2:10:07.293s
[INFO] Finished at: Tue May 19 05:41:32 UTC 2015
[INFO] Final Memory: 92M/895M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18:test (secondPartTestsExecution) on project hbase-server: ExecutionException: java.lang.RuntimeException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd <https://builds.apache.org/job/HBase-1.1/ws/hbase-server> && /home/jenkins/jenkins-slave/tools/hudson.model.JDK/jdk-1.7u51/jre/bin/java -enableassertions -XX:MaxDirectMemorySize=1G -Xmx2800m -XX:MaxPermSize=256m -Djava.security.egd=file:/dev/./urandom -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -jar <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefirebooter3149161772139848386.jar> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire8500007710069441838tmp> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire_11421778030370180431111tmp>
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :hbase-server
Build step 'Invoke top-level Maven targets' marked build as failure
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script  :   ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
  if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
    #It seems sometimes the tests are not dying immediately. Let's give them 10s
    echo "Suspicious java process found - waiting 10s to see if there are just slow to stop"
    sleep 10   
    ZOMBIE_TESTS_COUNT=`jps | grep surefirebooter | wc -l`
    if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
      echo "There are $ZOMBIE_TESTS_COUNT zombie tests, they should have been killed by surefire but survived"
      echo "************ BEGIN zombies jstack extract"
      ZB_STACK=`jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack | grep ".test" | grep "\.java"`
      jps | grep surefirebooter | cut -d ' ' -f 1 | xargs -n 1 jstack
      echo "************ END  zombies jstack extract"
      JIRA_COMMENT="$JIRA_COMMENT

     {color:red}-1 core zombie tests{color}.  There are ${ZOMBIE_TESTS_COUNT} zombie test(s): ${ZB_STACK}"
      BAD=1
      jps | grep surefirebooter | cut -d ' ' -f 1 | xargs kill -9
    else
      echo "We're ok: there is no zombie test, but some tests took some time to stop"
    fi
  else
    echo "We're ok: there is no zombie test"
  fi
[HBase-1.1] $ /bin/bash -xe /tmp/hudson4751794411742754265.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-1.1 #489
Archived 2035 artifacts
Archive block size is 32768
Received 28 blocks and 525235288 bytes
Compression is 0.2%
Took 3 min 27 sec
Recording test results
Updating HBASE-13673
Updating HBASE-13675

Build failed in Jenkins: HBase-1.1 #491

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

Changes:

[ndimiduk] HBASE-13609 TestFastFail is still failing

------------------------------------------
[...truncated 2591 lines...]
	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.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
	at org.junit.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.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
	at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)

"VM Thread" prio=10 tid=0x00007f9034264800 nid=0x41df runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f9034020000 nid=0x41d0 runnable 

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

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

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

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

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

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

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

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

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

"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007f9034032800 nid=0x41dc runnable 

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

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

"VM Periodic Task Thread" prio=10 tid=0x00007f903429b800 nid=0x41e6 waiting on condition 

JNI global references: 220

2015-05-18 22:23:58
Full thread dump Java HotSpot(TM) 64-Bit Server VM (24.45-b08 mixed mode):

"Camel (camel-6) thread #2 - timer://foo" daemon prio=10 tid=0x00007fd5c4a99000 nid=0x4075 in Object.wait() [0x00007fd56e91a000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x000000070e5d3a10> (a java.util.TaskQueue)
	at java.util.TimerThread.mainLoop(Timer.java:552)
	- locked <0x000000070e5d3a10> (a java.util.TaskQueue)
	at java.util.TimerThread.run(Timer.java:505)

"Attach Listener" daemon prio=10 tid=0x00007fd558001000 nid=0x402f waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Restlet-213493319" daemon prio=10 tid=0x00007fd5c46c7800 nid=0x3fc7 waiting on condition [0x00007fd56e819000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000007075e0a40> (a java.util.concurrent.SynchronousQueue$TransferStack)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
	at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:458)
	at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
	at java.util.concurrent.SynchronousQueue.take(SynchronousQueue.java:925)
	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)

"RxComputationThreadPool-3" daemon prio=10 tid=0x00007fd5c4628800 nid=0x3fc5 waiting on condition [0x00007fd56ea1b000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x0000000706912dd8> (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.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1079)
	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)

"RxComputationThreadPool-2" daemon prio=10 tid=0x00007fd5c4621800 nid=0x3fc4 waiting on condition [0x00007fd56eb1c000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x0000000706911990> (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)

"RxComputationThreadPool-1" daemon prio=10 tid=0x00007fd5c4619000 nid=0x3fc3 waiting on condition [0x00007fd56ec1d000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x000000070690a0e0> (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)

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

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

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

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

"Finalizer" daemon prio=10 tid=0x00007fd5c426b000 nid=0x3fbd in Object.wait() [0x00007fd56fe18000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x0000000704705568> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
	- locked <0x0000000704705568> (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=0x00007fd5c4267000 nid=0x3fbc in Object.wait() [0x00007fd56ff19000]
   java.lang.Thread.State: WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x00000007047050f0> (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 <0x00000007047050f0> (a java.lang.ref.Reference$Lock)

"main" prio=10 tid=0x00007fd5c400a000 nid=0x3fad waiting on condition [0x00007fd5cd55f000]
   java.lang.Thread.State: TIMED_WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x000000070e584600> (a java.util.concurrent.CountDownLatch$Sync)
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326)
	at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:282)
	at org.apache.camel.component.mock.MockEndpoint.waitForCompleteLatch(MockEndpoint.java:1410)
	at org.apache.camel.component.mock.MockEndpoint.waitForCompleteLatch(MockEndpoint.java:1394)
	at org.apache.camel.component.mock.MockEndpoint.doAssertIsSatisfied(MockEndpoint.java:401)
	at org.apache.camel.component.mock.MockEndpoint.assertIsSatisfied(MockEndpoint.java:382)
	at org.apache.camel.component.mock.MockEndpoint.assertIsSatisfied(MockEndpoint.java:370)
	at org.apache.camel.rx.ToObservableAndMapTest.testConsume(ToObservableAndMapTest.java:58)
	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.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
	at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)

"VM Thread" prio=10 tid=0x00007fd5c4264800 nid=0x3fbb runnable 

"GC task thread#0 (ParallelGC)" prio=10 tid=0x00007fd5c4020000 nid=0x3fae runnable 

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

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

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

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

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

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

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

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

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

"GC task thread#10 (ParallelGC)" prio=10 tid=0x00007fd5c4032800 nid=0x3fb8 runnable 

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

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

"VM Periodic Task Thread" prio=10 tid=0x00007fd5c429b800 nid=0x3fc2 waiting on condition 

JNI global references: 211

+ 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.camel.component.jetty.jettyproducer.HttpJettyProducerRecipientListCustomThreadPoolTest.testRecipientList(HttpJettyProducerRecipientListCustomThreadPoolTest.java:40)
	at org.apache.camel.rx.CamelOperatorTest.testCamelOperator(CamelOperatorTest.java:89)'
+ 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-1.1 #489
Archived 2046 artifacts
Archive block size is 32768
Received 28 blocks and 499733266 bytes
Compression is 0.2%
Took 3 min 45 sec
Recording test results
Updating HBASE-13609