See <https://builds.apache.org/job/HBase-1.1/346/changes>
Changes:
[stack] HBASE-13187 Add ITBLL that exercises per CF flush
------------------------------------------
[...truncated 2651 lines...]
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:24)
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.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)
testMetaRebuild(org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildBase)
Time elapsed: 356.28 sec <<< ERROR!
java.lang.NullPointerException: null
at
org.apache.hadoop.hbase.util.hbck.OfflineMetaRebuildTestCore.tearDownAfter(OfflineMetaRebuildTestCore.java:121)
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.RunAfters.evaluate(RunAfters.java:33)
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)
Running org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy
Running org.apache.hadoop.hbase.util.TestDefaultEnvironmentEdge
Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 1.914 sec <<<
FAILURE! - in org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy
org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy Time elapsed: 1.914 sec
<<< ERROR!
java.io.IOException: Shutting down
at
org.apache.hadoop.hbase.util.JVMClusterUtil.startup(JVMClusterUtil.java:225)
at
org.apache.hadoop.hbase.LocalHBaseCluster.startup(LocalHBaseCluster.java:445)
at
org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:225)
at
org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:94)
at
org.apache.hadoop.hbase.HBaseTestingUtility.startMiniHBaseCluster(HBaseTestingUtility.java:995)
at
org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:955)
at
org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:829)
at
org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:823)
at
org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:767)
at
org.apache.hadoop.hbase.util.TestCoprocessorScanPolicy.setUpBeforeClass(TestCoprocessorScanPolicy.java:87)
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.942 sec - in
org.apache.hadoop.hbase.util.TestDefaultEnvironmentEdge
Running org.apache.hadoop.hbase.util.TestFSHDFSUtils
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.937 sec - in
org.apache.hadoop.hbase.util.TestFSHDFSUtils
Running org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 81.702 sec - in
org.apache.hadoop.hbase.TestMetaTableAccessorNoCluster
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 468.555 sec -
in org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildOverlap
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 392.548 sec -
in org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildHole
Running org.apache.hadoop.hbase.migration.TestUpgradeTo96
Running org.apache.hadoop.hbase.TestNamespace
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.592 sec - in
org.apache.hadoop.hbase.migration.TestUpgradeTo96
Running org.apache.hadoop.hbase.TestInfoServers
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.818 sec - in
org.apache.hadoop.hbase.TestInfoServers
Running org.apache.hadoop.hbase.migration.TestNamespaceUpgrade
Tests run: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 10.013 sec - in
org.apache.hadoop.hbase.TestNamespace
Running org.apache.hadoop.hbase.TestMetaTableAccessor
Tests run: 5, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 879.942 sec <<<
FAILURE! - in org.apache.hadoop.hbase.util.TestMiniClusterLoadEncoded
loadTest[0](org.apache.hadoop.hbase.util.TestMiniClusterLoadEncoded) Time
elapsed: 757.034 sec <<< ERROR!
java.lang.Exception: test timed out after 180000 milliseconds
at java.lang.Thread.sleep(Native Method)
at
org.apache.hadoop.hbase.util.Threads.sleepWithoutInterrupt(Threads.java:164)
at
org.apache.hadoop.hbase.util.MultiThreadedAction.waitForFinish(MultiThreadedAction.java:267)
at
org.apache.hadoop.hbase.util.MultiThreadedWriter.waitForFinish(MultiThreadedWriter.java:179)
at
org.apache.hadoop.hbase.util.TestMiniClusterLoadParallel.loadTest(TestMiniClusterLoadParallel.java:51)
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.FailOnTimeout$StatementThread.run(FailOnTimeout.java:74)
Killed
Killed
Results :
Failed tests:
TestIOFencing.testFencingAroundCompactionAfterWALSync:239->doTest:295 Timed
out waiting for the region to flush
TestRegionObserverInterface.testLegacyRecovery:685->verifyMethodResult:751
Result of
org.apache.hadoop.hbase.coprocessor.SimpleRegionObserver$Legacy.getCtPreWALRestore
is expected to be 1, while we get 0
TestRegionObserverInterface.testRecovery:635->verifyMethodResult:751 Result
of org.apache.hadoop.hbase.coprocessor.SimpleRegionObserver.getCtPreWALRestore
is expected to be 1, while we get 0
TestEnableTableHandler.testEnableTableWithNoRegionServers:110 expected:<2>
but was:<1>
Tests in error:
TestLoadIncrementalHFilesUseSecurityEndPoint>TestLoadIncrementalHFiles.testSimpleLoad:103->TestLoadIncrementalHFiles.runTest:207->TestLoadIncrementalHFiles.runTest:221->TestLoadIncrementalHFiles.runTest:230->TestLoadIncrementalHFiles.runTest:244->Object.wait:-2
?
TestMultiSlaveReplication.testMultiSlaveReplication:130 ? test timed out
afte...
TestReplicationDisableInactivePeer.testDisableInactivePeer:51 ? Replication
Un...
org.apache.hadoop.hbase.replication.TestReplicationKillSlaveRS.org.apache.hadoop.hbase.replication.TestReplicationKillSlaveRS
Run 1: TestReplicationKillSlaveRS>TestReplicationBase.setUpBeforeClass:129 ?
IO Shutt...
Run 2: TestReplicationKillSlaveRS>TestReplicationBase.tearDownAfterClass:158
? NullPointer
org.apache.hadoop.hbase.replication.TestReplicationSmallTests.org.apache.hadoop.hbase.replication.TestReplicationSmallTests
Run 1: TestReplicationSmallTests>TestReplicationBase.setUpBeforeClass:128 ?
IO Shutti...
Run 2: TestReplicationSmallTests>TestReplicationBase.tearDownAfterClass:158 ?
NullPointer
TestReplicationSyncUpTool.testSyncUpTool:173->mimicSyncUpAfterPut:386->Object.wait:503->Object.wait:-2
?
TestReplicationWithTags.setUpBeforeClass:137 ? IO Shutting down
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationForFlushAndCompaction:314
? RetriesExhaustedWithDetails
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationIgnoresDroppedTables:335->testRegionReplicaReplicationIgnoresDisabledTables:348
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationPeerIsCreated:121
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationPeerIsCreatedForModifyTable:151
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationWith10Replicas:259->testRegionReplicaReplication:178
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationWith2Replicas:249->testRegionReplicaReplication:178
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaReplicationWith3Replicas:254->testRegionReplicaReplication:178
? RetriesExhausted
TestRegionReplicaReplicationEndpoint.testRegionReplicaWithoutMemstoreReplication:269
? RetriesExhausted
TestCellACLs.testCellPermissions:144->SecureTestUtil.verifyAllowed:177->SecureTestUtil.verifyAllowed:161
? RetriesExhaustedWithDetails
TestCoprocessorScanPolicy.setUpBeforeClass:87 ? IO Shutting down
TestHBaseFsckEncryption.setUp:84 ? IO Shutting down
TestMergeTable.testMergeTable:101->createRegion:145 ? test timed out after
30...
TestMiniClusterLoadEncoded>TestMiniClusterLoadParallel.loadTest:51 ? test
tim...
TestRegionSplitter.setup:62 ? IO Shutting down
org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildBase.testMetaRebuild(org.apache.hadoop.hbase.util.hbck.TestOfflineMetaRebuildBase)
Run 1: TestOfflineMetaRebuildBase>OfflineMetaRebuildTestCore.setUpBefore:97 ?
IO Shut...
Run 2:
TestOfflineMetaRebuildBase>OfflineMetaRebuildTestCore.tearDownAfter:121 ?
NullPointer
Tests run: 2080, Failures: 4, Errors: 22, Skipped: 17
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] HBase ............................................. SUCCESS [2.908s]
[INFO] HBase - Checkstyle ................................ SUCCESS [0.705s]
[INFO] HBase - Annotations ............................... SUCCESS [0.799s]
[INFO] HBase - Common .................................... SUCCESS [1:17.735s]
[INFO] HBase - Protocol .................................. SUCCESS [8.234s]
[INFO] HBase - Client .................................... SUCCESS [1:17.458s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.114s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [7.797s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [9.414s]
[INFO] HBase - Server .................................... FAILURE
[2:52:36.951s]
[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] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 2:55:50.693s
[INFO] Finished at: Wed Apr 01 20:27:41 UTC 2015
[INFO] Final Memory: 55M/861M
[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
/x1/jenkins/jenkins-slave/workspace/HBase-1.1/hbase-server &&
/x1/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
/x1/jenkins/jenkins-slave/workspace/HBase-1.1/hbase-server/target/surefire/surefirebooter6042899448748996243.jar
/x1/jenkins/jenkins-slave/workspace/HBase-1.1/hbase-server/target/surefire/surefire4796004718673022434tmp
/x1/jenkins/jenkins-slave/workspace/HBase-1.1/hbase-server/target/surefire/surefire_12006897770739357744837tmp
[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/hudson1342714749492501057.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 #343
Archived 1904 artifacts
Archive block size is 32768
Received 27 blocks and 469990855 bytes
Compression is 0.2%
Took 3 min 26 sec
Recording test results
Updating HBASE-13187
