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/04/29 06:02:04 UTC
Build failed in Jenkins: HBase-1.1 #442
See <https://builds.apache.org/job/HBase-1.1/442/changes>
Changes:
[enis] HBASE-13585 HRegionFileSystem#splitStoreFile() finishes without closing the file handle in some situation (Stephen Yuan Jiang)
------------------------------------------
[...truncated 2129 lines...]
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDefaultVisLabelService
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithACL
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLablesWithGroups
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithCustomVisLabService
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.85 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLablesWithGroups
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.974 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithACL
Killed
Killed
Killed
Killed
Running org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Running org.apache.hadoop.hbase.security.access.TestCellACLs
Running org.apache.hadoop.hbase.security.access.TestAccessController
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.723 sec - in org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Running org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Running org.apache.hadoop.hbase.security.access.TestTablePermissions
Running org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.259 sec - in org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.036 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.341 sec - in org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.763 sec - in org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.671 sec - in org.apache.hadoop.hbase.security.access.TestTablePermissions
Running org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Running org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.227 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.633 sec - in org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Running org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Running org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.428 sec - in org.apache.hadoop.hbase.security.token.TestGenerateDelegationToken
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.412 sec - in org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Running org.apache.hadoop.hbase.TestMetaTableLocator
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.51 sec - in org.apache.hadoop.hbase.TestMetaTableLocator
Running org.apache.hadoop.hbase.TestZooKeeper
Running org.apache.hadoop.hbase.TestHBaseTestingUtility
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 56.919 sec - in org.apache.hadoop.hbase.security.access.TestWithDisabledAuthorization
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.192 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.203 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: 58.602 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: 78.928 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: 17.75 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: 175.063 sec - in org.apache.hadoop.hbase.TestZooKeeper
Running org.apache.hadoop.hbase.TestInfoServers
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.327 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: 6.244 sec - in org.apache.hadoop.hbase.quotas.TestQuotaAdmin
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 75.343 sec - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Running org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Running org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.561 sec - in org.apache.hadoop.hbase.quotas.TestQuotaTableUtil
Running org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.219 sec - in org.apache.hadoop.hbase.quotas.TestQuotaThrottle
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.777 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedureControllers
Running org.apache.hadoop.hbase.procedure.TestZKProcedure
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.175 sec - in org.apache.hadoop.hbase.procedure.TestZKProcedure
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 41.334 sec - in org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 343.4 sec - in org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 92.345 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.741 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.265 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Running org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Tests run: 56, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 465.281 sec - in org.apache.hadoop.hbase.security.access.TestAccessController
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.396 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: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 354.093 sec - in org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 19.74 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 63.631 sec - in org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
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: 30.404 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: 14.382 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: 15.87 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: 135.097 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: 2.217 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: 7.4 sec - in org.apache.hadoop.hbase.wal.TestDefaultWALProvider
Running org.apache.hadoop.hbase.wal.TestWALSplit
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.461 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.555 sec - in org.apache.hadoop.hbase.wal.TestSecureWAL
Running org.apache.hadoop.hbase.wal.TestDefaultWALProviderWithHLogKey
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.627 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.071 sec - in org.apache.hadoop.hbase.wal.TestBoundedRegionGroupingProvider
Running org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 216, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 409.138 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 191.145 sec - in org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 258.98 sec - in org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Running org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.144 sec - in org.apache.hadoop.hbase.zookeeper.TestZKLeaderManager
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Running org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.968 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperNodeTracker
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.252 sec - in org.apache.hadoop.hbase.zookeeper.TestRecoverableZooKeeper
Running org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Running org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.27 sec - in org.apache.hadoop.hbase.zookeeper.TestZooKeeperACL
Running org.apache.hadoop.hbase.zookeeper.TestZKMulti
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.203 sec - in org.apache.hadoop.hbase.zookeeper.TestZKTableStateManager
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.688 sec - in org.apache.hadoop.hbase.zookeeper.TestZKMulti
Running org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Running org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.615 sec - in org.apache.hadoop.hbase.zookeeper.TestHQuorumPeer
Running org.apache.hadoop.hbase.TestIOFencing
Running org.apache.hadoop.hbase.constraint.TestConstraint
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.483 sec - in org.apache.hadoop.hbase.zookeeper.lock.TestZKInterProcessReadWriteLock
Running org.apache.hadoop.hbase.TestMovedRegionsCleaner
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 22.022 sec - in org.apache.hadoop.hbase.constraint.TestConstraint
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.797 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.156 sec - in org.apache.hadoop.hbase.backup.example.TestZooKeeperTableArchiveClient
Running org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.549 sec - in org.apache.hadoop.hbase.TestHColumnDescriptorDefaultVersions
Running org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.161 sec - in org.apache.hadoop.hbase.ipc.TestProtoBufRpc
Running org.apache.hadoop.hbase.ipc.TestDelayedRpc
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 194.454 sec - in org.apache.hadoop.hbase.wal.TestWALSplit
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.297 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.405 sec - in org.apache.hadoop.hbase.ipc.TestHBaseClient
Running org.apache.hadoop.hbase.TestNamespace
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 61.075 sec - in org.apache.hadoop.hbase.backup.TestHFileArchiving
Tests run: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 24.989 sec - in org.apache.hadoop.hbase.TestNamespace
Tests run: 31, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 192.323 sec - in org.apache.hadoop.hbase.wal.TestWALSplitCompressed
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 213.508 sec - in org.apache.hadoop.hbase.TestIOFencing
Results :
Failed tests:
TestSplitLogManager.testGetPreviousRecoveryMode:661 Mode4=LOG_SPLITTING
TestEnableTableHandler.testEnableTableWithNoRegionServers:107 Waiting timed out after [60,000] msec table enabled in zk,
Tests in error:
TestJMXListener.testStart:69 » IO Failed to retrieve RMIServer stub: javax.nam...
TestSnapshotCloneIndependence.testOnlineSnapshotDeleteIndependent:182->runTestSnapshotDeleteIndependent:424 » RetriesExhausted
Tests run: 2523, Failures: 2, Errors: 2, Skipped: 18
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] HBase ............................................. SUCCESS [3.987s]
[INFO] HBase - Checkstyle ................................ SUCCESS [0.792s]
[INFO] HBase - Annotations ............................... SUCCESS [1.168s]
[INFO] HBase - Protocol .................................. SUCCESS [17.119s]
[INFO] HBase - Common .................................... SUCCESS [1:36.966s]
[INFO] HBase - Procedure ................................. SUCCESS [1:19.947s]
[INFO] HBase - Client .................................... SUCCESS [1:31.764s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [9.131s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [11.400s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [12.741s]
[INFO] HBase - Server .................................... FAILURE [1:41:11.478s]
[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: 1:46:39.099s
[INFO] Finished at: Wed Apr 29 03:58:18 UTC 2015
[INFO] Final Memory: 95M/1864M
[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/surefirebooter7725095022514022903.jar> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire7567636464836873979tmp> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire_11228673104199259070250tmp>
[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/hudson4367516618637537880.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 #437
Archived 2028 artifacts
Archive block size is 32768
Received 27 blocks and 481766259 bytes
Compression is 0.2%
Took 3 min 25 sec
Recording test results
Updating HBASE-13585
Build failed in Jenkins: HBase-1.1 #443
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.1/443/changes>
Changes:
[rajeshbabu] HBASE-13431 Allow to skip store file range check based on column family while creating reference files in HRegionFileSystem#splitStoreFile(Rajeshbabu)
------------------------------------------
[...truncated 2220 lines...]
[INFO] HBase - Shaded .................................... SKIPPED
[INFO] HBase - Shaded - Client ........................... SKIPPED
[INFO] HBase - Shaded - Server ........................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:46:21.300s
[INFO] Finished at: Wed Apr 29 06:17:51 UTC 2015
[INFO] Final Memory: 91M/969M
[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/surefirebooter2346605525894705408.jar> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire3330158348220789712tmp> <https://builds.apache.org/job/HBase-1.1/ws/hbase-server/target/surefire/surefire_11014776954972908825326tmp>
[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/hudson8800211956569939710.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'Suspicious java process found - waiting 10s to see if there are just slow to stop'
Suspicious java process found - waiting 10s to see if there are just slow to stop
+ sleep 10
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=1
+ [[ 1 != 0 ]]
+ echo 'There are 1 zombie tests, they should have been killed by surefire but survived'
There are 1 zombie tests, they should have been killed by surefire but survived
+ echo '************ BEGIN zombies jstack extract'
************ BEGIN zombies jstack extract
++ jps
++ grep surefirebooter
++ cut -d ' ' -f 1
++ xargs -n 1 jstack
++ grep .test
++ grep '\.java'
+ ZB_STACK=' at org.apache.hadoop.hbase.ResourceCheckerJUnitListener.testStarted(ResourceCheckerJUnitListener.java:179)'
+ jps
+ cut -d ' ' -f 1
+ grep surefirebooter
+ xargs -n 1 jstack
2015-04-29 06:18:04
Full thread dump Java HotSpot(TM) Server VM (23.25-b01 mixed mode):
"Attach Listener" daemon prio=10 tid=0x29d00800 nid=0x10d4 waiting on condition [0x00000000]
java.lang.Thread.State: RUNNABLE
"process reaper" daemon prio=10 tid=0x282c8400 nid=0x10d2 waiting on condition [0x29710000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0xbd46dcb0> (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=0x2a1f7800 nid=0x107e runnable [0x00000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" daemon prio=10 tid=0x2a1f5c00 nid=0x107d runnable [0x00000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" daemon prio=10 tid=0x2a1f3c00 nid=0x107c waiting on condition [0x00000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" daemon prio=10 tid=0x2a1f2400 nid=0x107b runnable [0x00000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" daemon prio=10 tid=0x2a1b7000 nid=0x107a in Object.wait() [0x3367d000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbd489f20> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
- locked <0xbd489f20> (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=0x2a1b5400 nid=0x1079 in Object.wait() [0x3387d000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0xbd489f40> (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 <0xbd489f40> (a java.lang.ref.Reference$Lock)
"main" prio=10 tid=0xf6806800 nid=0x106a runnable [0xf6966000]
java.lang.Thread.State: RUNNABLE
at sun.misc.ASCIICaseInsensitiveComparator.compare(ASCIICaseInsensitiveComparator.java:45)
at sun.misc.ASCIICaseInsensitiveComparator.compare(ASCIICaseInsensitiveComparator.java:36)
at java.util.jar.Attributes$Name.equals(Attributes.java:503)
at java.util.HashMap.getEntry(HashMap.java:448)
at java.util.HashMap.get(HashMap.java:405)
at java.util.jar.Attributes.get(Attributes.java:97)
at java.util.jar.Attributes.getValue(Attributes.java:133)
at java.net.URLClassLoader.definePackage(URLClassLoader.java:505)
at java.net.URLClassLoader.defineClass(URLClassLoader.java:420)
at java.net.URLClassLoader.access$100(URLClassLoader.java:71)
at java.net.URLClassLoader$1.run(URLClassLoader.java:361)
at java.net.URLClassLoader$1.run(URLClassLoader.java:355)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:354)
at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
- locked <0xb9cad1c0> (a java.lang.Object)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308)
at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
at org.apache.hadoop.hbase.zookeeper.ZooKeeperWatcher$1.<init>(ZooKeeperWatcher.java:120)
at org.apache.hadoop.hbase.zookeeper.ZooKeeperWatcher.<clinit>(ZooKeeperWatcher.java:118)
at sun.reflect.GeneratedSerializationConstructorAccessor3.newInstance(Unknown Source)
at java.lang.reflect.Constructor.newInstance(Constructor.java:526)
at org.objenesis.instantiator.sun.SunReflectionFactoryInstantiator.newInstance(SunReflectionFactoryInstantiator.java:45)
at org.objenesis.ObjenesisBase.newInstance(ObjenesisBase.java:73)
at org.mockito.internal.creation.jmock.ClassImposterizer.createProxy(ClassImposterizer.java:142)
at org.mockito.internal.creation.jmock.ClassImposterizer.imposterise(ClassImposterizer.java:61)
at org.mockito.internal.creation.jmock.ClassImposterizer.imposterise(ClassImposterizer.java:52)
at org.mockito.internal.creation.CglibMockMaker.createMock(CglibMockMaker.java:24)
at org.mockito.internal.util.MockUtil.createMock(MockUtil.java:32)
at org.mockito.internal.MockitoCore.mock(MockitoCore.java:59)
at org.mockito.Mockito.mock(Mockito.java:1258)
at org.mockito.Mockito.mock(Mockito.java:1135)
at org.apache.hadoop.hbase.regionserver.TestRSStatusServlet.setupBasicMocks(TestRSStatusServlet.java:82)
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.RunBefores.evaluate(RunBefores.java:24)
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 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.runner.JUnitCore.run(JUnitCore.java:160)
at org.junit.runner.JUnitCore.run(JUnitCore.java:138)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:107)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:77)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:53)
at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:144)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
"VM Thread" prio=10 tid=0x2a0f8c00 nid=0x1078 runnable
"GC task thread#0 (ParallelGC)" prio=10 tid=0xf6810c00 nid=0x106b runnable
"GC task thread#1 (ParallelGC)" prio=10 tid=0xf6812000 nid=0x106c runnable
"GC task thread#2 (ParallelGC)" prio=10 tid=0xf6813800 nid=0x106d runnable
"GC task thread#3 (ParallelGC)" prio=10 tid=0xf6815000 nid=0x106e runnable
"GC task thread#4 (ParallelGC)" prio=10 tid=0xf6816400 nid=0x106f runnable
"GC task thread#5 (ParallelGC)" prio=10 tid=0xf6817c00 nid=0x1070 runnable
"GC task thread#6 (ParallelGC)" prio=10 tid=0xf6819400 nid=0x1071 runnable
"GC task thread#7 (ParallelGC)" prio=10 tid=0xf681a800 nid=0x1072 runnable
"GC task thread#8 (ParallelGC)" prio=10 tid=0xf681c000 nid=0x1073 runnable
"GC task thread#9 (ParallelGC)" prio=10 tid=0xf681d800 nid=0x1074 runnable
"GC task thread#10 (ParallelGC)" prio=10 tid=0xf681ec00 nid=0x1075 runnable
"GC task thread#11 (ParallelGC)" prio=10 tid=0xf6820400 nid=0x1076 runnable
"GC task thread#12 (ParallelGC)" prio=10 tid=0xf6821c00 nid=0x1077 runnable
"VM Periodic Task Thread" prio=10 tid=0x2a1f9800 nid=0x107f waiting on condition
JNI global references: 183
+ 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.ResourceCheckerJUnitListener.testStarted(ResourceCheckerJUnitListener.java:179)'
+ BAD=1
+ jps
+ grep surefirebooter
+ cut -d ' ' -f 1
+ xargs kill -9
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-1.1 #437
Archived 2026 artifacts
Archive block size is 32768
Received 27 blocks and 482513676 bytes
Compression is 0.2%
Took 3 min 40 sec
Recording test results
Updating HBASE-13431