hbase-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Stack <st...@duboce.net>
Subject Re: Build failed in Jenkins: HBase-1.1 #141
Date Thu, 05 Feb 2015 18:25:16 GMT
This is looking like HBASE-12958 given recent history. Doing another build
to see.  Will revert if fails same way again.
St.Ack

On Thu, Feb 5, 2015 at 1:32 AM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:

> See <https://builds.apache.org/job/HBase-1.1/141/changes>
>
> Changes:
>
> [stack] HBASE-12958 SSH doing hbase:meta get but hbase:meta not assigned
>
> ------------------------------------------
> [...truncated 2538 lines...]
> Running org.apache.hadoop.hbase.master.TestMasterTransitions
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 3, Time elapsed: 1.954 sec
> - in org.apache.hadoop.hbase.master.TestMasterTransitions
> Running org.apache.hadoop.hbase.master.TestTableLockManager
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 35.662 sec
> - in org.apache.hadoop.hbase.master.TestRestartCluster
> Running
> org.apache.hadoop.hbase.master.handler.TestTableDescriptorModification
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.597 sec
> - in org.apache.hadoop.hbase.master.handler.TestTableDescriptorModification
> Running org.apache.hadoop.hbase.master.handler.TestTableDeleteFamilyHandler
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.708 sec
> - in org.apache.hadoop.hbase.master.handler.TestTableDeleteFamilyHandler
> Running org.apache.hadoop.hbase.master.handler.TestCreateTableHandler
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.145 sec
> - in org.apache.hadoop.hbase.master.handler.TestCreateTableHandler
> Running org.apache.hadoop.hbase.master.TestGetLastFlushedSequenceId
> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 78.351 sec
> - in org.apache.hadoop.hbase.master.TestTableLockManager
> Running org.apache.hadoop.hbase.master.TestRollingRestart
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.594 sec
> - in org.apache.hadoop.hbase.master.TestGetLastFlushedSequenceId
> Running org.apache.hadoop.hbase.master.TestHMasterRPCException
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.404 sec
> - in org.apache.hadoop.hbase.master.TestHMasterRPCException
> Running org.apache.hadoop.hbase.master.TestSplitLogManager
> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 14.122 sec
> <<< FAILURE! - in org.apache.hadoop.hbase.master.TestRollingRestart
> testBasicRollingRestart(org.apache.hadoop.hbase.master.TestRollingRestart)
> Time elapsed: 14.051 sec  <<< FAILURE!
> java.lang.AssertionError: expected:<22> but was:<15>
>         at org.junit.Assert.fail(Assert.java:88)
>         at org.junit.Assert.failNotEquals(Assert.java:743)
>         at org.junit.Assert.assertEquals(Assert.java:118)
>         at org.junit.Assert.assertEquals(Assert.java:555)
>         at org.junit.Assert.assertEquals(Assert.java:542)
>         at
> org.apache.hadoop.hbase.master.TestRollingRestart.assertRegionsAssigned(TestRollingRestart.java:252)
>         at
> org.apache.hadoop.hbase.master.TestRollingRestart.testBasicRollingRestart(TestRollingRestart.java:176)
>
> Running org.apache.hadoop.hbase.master.TestMaster
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.748 sec
> - in org.apache.hadoop.hbase.master.TestMaster
> Running org.apache.hadoop.hbase.master.TestClusterStatusPublisher
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.408 sec
> - in org.apache.hadoop.hbase.master.TestClusterStatusPublisher
> Running org.apache.hadoop.hbase.master.TestGetInfoPort
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 8.9 sec -
> in org.apache.hadoop.hbase.master.TestGetInfoPort
> Running org.apache.hadoop.hbase.master.TestDeadServer
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.293 sec
> - in org.apache.hadoop.hbase.master.TestDeadServer
> Running org.apache.hadoop.hbase.master.TestZKBasedOpenCloseRegion
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.981 sec
> - in org.apache.hadoop.hbase.master.TestZKBasedOpenCloseRegion
> Running org.apache.hadoop.hbase.master.TestAssignmentManager
> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.301 sec
> - in org.apache.hadoop.hbase.master.TestAssignmentManager
> Running org.apache.hadoop.hbase.master.TestMasterStatusServlet
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.394 sec
> - in org.apache.hadoop.hbase.master.TestMasterStatusServlet
> Running org.apache.hadoop.hbase.master.cleaner.TestSnapshotFromMaster
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.861 sec
> - in org.apache.hadoop.hbase.master.cleaner.TestSnapshotFromMaster
> Running org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
> Running org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.943 sec
> - in org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.178 sec
> - in org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
> Running org.apache.hadoop.hbase.master.TestZKLessAMOnCluster
> Running org.apache.hadoop.hbase.master.TestMasterMetrics
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.294 sec
> - in org.apache.hadoop.hbase.master.TestMasterMetrics
> Running org.apache.hadoop.hbase.master.TestDistributedLogSplitting
> Tests run: 15, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 133.664
> sec <<< FAILURE! - in org.apache.hadoop.hbase.master.TestSplitLogManager
> testGetPreviousRecoveryMode(org.apache.hadoop.hbase.master.TestSplitLogManager)
> Time elapsed: 0.127 sec  <<< FAILURE!
> java.lang.AssertionError: Mode4=LOG_SPLITTING
>         at org.junit.Assert.fail(Assert.java:88)
>         at org.junit.Assert.assertTrue(Assert.java:41)
>         at
> org.apache.hadoop.hbase.master.TestSplitLogManager.testGetPreviousRecoveryMode(TestSplitLogManager.java:661)
>
> Running
> org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
> Tests run: 21, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 333.607
> sec <<< FAILURE! - in
> org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster
> testSSHWaitForServerToAssignRegion(org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster)
> Time elapsed: 300.056 sec  <<< ERROR!
> java.lang.Exception: test timed out after 300000 milliseconds
>         at java.lang.Thread.sleep(Native Method)
>         at java.lang.Thread.sleep(Thread.java:340)
>         at java.util.concurrent.TimeUnit.sleep(TimeUnit.java:360)
>         at
> org.apache.hadoop.hbase.util.RetryCounter.sleepUntilNextRetry(RetryCounter.java:156)
>         at
> org.apache.hadoop.hbase.HBaseTestingUtility.getRSForFirstRegionInTable(HBaseTestingUtility.java:2298)
>         at
> org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion(TestAssignmentManagerOnCluster.java:1102)
>
> Running org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.677 sec
> - in org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.229 sec
> - in org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
> Running org.apache.hadoop.hbase.master.TestRegionPlacement
> Running org.apache.hadoop.hbase.master.TestAssignmentListener
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.748 sec
> - in org.apache.hadoop.hbase.master.TestAssignmentListener
> Running org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.006 sec
> - in org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.828 sec
> - in org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
> Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
> Tests run: 21, Failures: 1, Errors: 1, Skipped: 0, Time elapsed: 333.023
> sec <<< FAILURE! - in org.apache.hadoop.hbase.master.TestZKLessAMOnCluster
> testSSHWaitForServerToAssignRegion(org.apache.hadoop.hbase.master.TestZKLessAMOnCluster)
> Time elapsed: 300.051 sec  <<< ERROR!
> java.lang.Exception: test timed out after 300000 milliseconds
>         at java.lang.Thread.sleep(Native Method)
>         at java.lang.Thread.sleep(Thread.java:340)
>         at java.util.concurrent.TimeUnit.sleep(TimeUnit.java:360)
>         at
> org.apache.hadoop.hbase.util.RetryCounter.sleepUntilNextRetry(RetryCounter.java:156)
>         at
> org.apache.hadoop.hbase.HBaseTestingUtility.getRSForFirstRegionInTable(HBaseTestingUtility.java:2298)
>         at
> org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion(TestAssignmentManagerOnCluster.java:1102)
>         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)
>
> testRestartMetaRegionServer(org.apache.hadoop.hbase.master.TestZKLessAMOnCluster)
> Time elapsed: 0.622 sec  <<< FAILURE!
> java.lang.AssertionError: Meta should be assigned on a different server.
> Actual: pomona.apache.org,48967,1423127431183
>         at org.junit.Assert.fail(Assert.java:88)
>         at org.junit.Assert.failEquals(Assert.java:185)
>         at org.junit.Assert.assertNotEquals(Assert.java:161)
>         at
> org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster.testRestartMetaRegionServer(TestAssignmentManagerOnCluster.java:175)
>         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)
>
> Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 554.725
> sec - in org.apache.hadoop.hbase.master.balancer.TestStochasticLoadBalancer
> Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.219 sec
> - in org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
> Running org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
> Running org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 40.772 sec
> - in org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 54.052 sec
> - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
> Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 287.956
> sec - in org.apache.hadoop.hbase.snapshot.TestExportSnapshot
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 292.931
> sec - in org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
>
> Results :
>
> Failed tests:
>   TestIOFencing.testFencingAroundCompaction:226->doTest:312 Waiting timed
> out after [60,000] msec
>   TestIOFencing.testFencingAroundCompactionAfterWALSync:238->doTest:312
> Waiting timed out after [60,000] msec
>   TestMetaWithReplicas.testShutdownOfReplicaHolder:371 null
>
> TestRollingRestart.testBasicRollingRestart:176->assertRegionsAssigned:252
> expected:<22> but was:<15>
>   TestSplitLogManager.testGetPreviousRecoveryMode:661 Mode4=LOG_SPLITTING
>
> TestZKLessAMOnCluster>TestAssignmentManagerOnCluster.testRestartMetaRegionServer:175
> Meta should be assigned on a different server. Actual: pomona.apache.org
> ,48967,1423127431183
>
> TestZKLessSplitOnCluster>TestSplitTransactionOnCluster.testFailedSplit:1327
> null
>
> Tests in error:
>   TestFullLogReconstruction.testReconstruction:106 » Runtime
> org.apache.hadoop.h...
>
> TestRegionRebalancing.testRebalanceOnRegionServerNumberChange:136->assertRegionsAreBalanced:171->waitForAllRegionsAssigned:242
> »
>
> TestRegionRebalancing.testRebalanceOnRegionServerNumberChange:136->assertRegionsAreBalanced:171->waitForAllRegionsAssigned:242
> »
>
> TestHTableMultiplexerFlushCache.testOnRegionChange:112->checkExistence:77 »
> RetriesExhausted
>   TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion:1102
> »  test...
>
> TestZKLessAMOnCluster>TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion:1102
> »
>
> TestHRegionOnCluster.testDataCorrectnessReplayingRecoveredEdits:130->putDataAndVerify:143->Object.wait:-2
> »
>
> TestPerColumnFamilyFlush.testLogReplay:403->verifyEdit:113->Object.wait:-2
> »  ...
>
> TestPerColumnFamilyFlush.testLogReplayWithDistributedReplay:421->testLogReplay:403->verifyEdit:113->Object.wait:-2
> »
>
> TestZKLessSplitOnCluster>TestSplitTransactionOnCluster.testSSHCleanupDaugtherRegionsOfAbortedSplit:1372
> »
>
> TestSecureWALReplay>TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:245
> » RetriesExhausted
>   TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:245 »
> RetriesExhausted
>
> TestWALReplayCompressed>TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:245
> » RetriesExhausted
>
> TestReplicationChangingPeerRegionservers.testChangingNumberOfPeerRegionServers:104->doPutTest:130
> » RetriesExhausted
>   TestReplicationKillSlaveRS.killOneSlaveRS » RetriesExhausted Failed
> after atte...
>
>
> Tests run: 2243, Failures: 7, Errors: 15, Skipped: 18
>
> [INFO]
> ------------------------------------------------------------------------
> [INFO] Reactor Summary:
> [INFO]
> [INFO] HBase ............................................. SUCCESS [4.948s]
> [INFO] HBase - Checkstyle ................................ SUCCESS [0.886s]
> [INFO] HBase - Annotations ............................... SUCCESS [0.924s]
> [INFO] HBase - Common .................................... SUCCESS
> [1:16.725s]
> [INFO] HBase - Protocol .................................. SUCCESS [9.164s]
> [INFO] HBase - Client .................................... SUCCESS
> [1:17.778s]
> [INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.146s]
> [INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [6.523s]
> [INFO] HBase - Prefix Tree ............................... SUCCESS [8.435s]
> [INFO] HBase - Server .................................... FAILURE
> [1:51:53.355s]
> [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: 1:55:06.803s
> [INFO] Finished at: Thu Feb 05 09:26:40 UTC 2015
> [INFO] Final Memory: 55M/445M
> [INFO]
> ------------------------------------------------------------------------
> [ERROR] Failed to execute goal
> org.apache.maven.plugins:maven-surefire-plugin:2.18:test
> (secondPartTestsExecution) on project hbase-server: There was a timeout or
> other error in the fork -> [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/hudson5713937617711597096.sh
> ++ jps
> ++ grep surefirebooter
> ++ wc -l
> + ZOMBIE_TESTS_COUNT=7
> + [[ 7 != 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=0
> + [[ 0 != 0 ]]
> + echo 'We'\''re ok: there is no zombie test, but some tests took some
> time to stop'
> We're ok: there is no zombie test, but some tests took some time to stop
> POST BUILD TASK : SUCCESS
> END OF POST BUILD TASK : 0
> Archiving artifacts
> Sending artifact delta relative to HBase-1.1 #140
> Archived 1846 artifacts
> Archive block size is 32768
> Received 27 blocks and 1232417146 bytes
> Compression is 0.1%
> Took 4 min 52 sec
> Recording test results
> Updating HBASE-12958
>

Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message