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/11/24 00:45:54 UTC

Build failed in Jenkins: HBase-1.1-JDK7 #1603

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

Changes:

[matteo.bertozzi] HBASE-14843 TestWALProcedureStore.testLoad is flakey

[matteo.bertozzi] HBASE-14843 TestWALProcedureStore.testLoad is flakey (addendum)

------------------------------------------
[...truncated 2059 lines...]
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.615 sec - in org.apache.hadoop.hbase.master.TestActiveMasterManager
Running org.apache.hadoop.hbase.master.TestRestartCluster
Running org.apache.hadoop.hbase.master.TestRegionPlacement2
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.069 sec - in org.apache.hadoop.hbase.master.TestRegionPlacement2
Running org.apache.hadoop.hbase.master.TestMasterTransitions
Tests run: 3, Failures: 0, Errors: 0, Skipped: 3, Time elapsed: 0.002 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: 44.973 sec - in org.apache.hadoop.hbase.master.TestRestartCluster
Tests run: 21, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 116.722 sec - in org.apache.hadoop.hbase.master.TestAssignmentManagerOnCluster
Running org.apache.hadoop.hbase.master.handler.TestTableDescriptorModification
Running org.apache.hadoop.hbase.master.handler.TestTableDeleteFamilyHandler
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.528 sec - in org.apache.hadoop.hbase.master.handler.TestTableDeleteFamilyHandler
Running org.apache.hadoop.hbase.master.handler.TestEnableTableHandler
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 83.484 sec - in org.apache.hadoop.hbase.master.TestTableLockManager
Running org.apache.hadoop.hbase.master.handler.TestCreateTableHandler
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 37.38 sec - in org.apache.hadoop.hbase.master.handler.TestTableDescriptorModification
Running org.apache.hadoop.hbase.master.TestGetLastFlushedSequenceId
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.164 sec - in org.apache.hadoop.hbase.master.TestGetLastFlushedSequenceId
Running org.apache.hadoop.hbase.master.TestRollingRestart
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.92 sec - in org.apache.hadoop.hbase.master.handler.TestCreateTableHandler
Running org.apache.hadoop.hbase.master.TestProcedureConf
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.911 sec - in org.apache.hadoop.hbase.master.TestRollingRestart
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.813 sec - in org.apache.hadoop.hbase.master.TestProcedureConf
Running org.apache.hadoop.hbase.master.TestSplitLogManager
Running org.apache.hadoop.hbase.master.TestHMasterRPCException
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.986 sec - in org.apache.hadoop.hbase.master.TestHMasterRPCException
Running org.apache.hadoop.hbase.master.TestMaster
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.11 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.515 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: 10.741 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.375 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: 2.571 sec - in org.apache.hadoop.hbase.master.TestZKBasedOpenCloseRegion
Tests run: 3, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 121.146 sec <<< FAILURE! - in org.apache.hadoop.hbase.master.handler.TestEnableTableHandler
testEnableTableWithNoRegionServers(org.apache.hadoop.hbase.master.handler.TestEnableTableHandler)  Time elapsed: 92.642 sec  <<< FAILURE!
junit.framework.AssertionFailedError: Waiting timed out after [60,000] msec table enabled in zk,
	at junit.framework.Assert.fail(Assert.java:57)
	at org.apache.hadoop.hbase.Waiter.waitFor(Waiter.java:209)
	at org.apache.hadoop.hbase.Waiter.waitFor(Waiter.java:161)
	at org.apache.hadoop.hbase.HBaseTestingUtility.waitFor(HBaseTestingUtility.java:3942)
	at org.apache.hadoop.hbase.HBaseTestingUtility.waitUntilAllRegionsAssigned(HBaseTestingUtility.java:3396)
	at org.apache.hadoop.hbase.HBaseTestingUtility.waitUntilAllRegionsAssigned(HBaseTestingUtility.java:3347)
	at org.apache.hadoop.hbase.master.handler.TestEnableTableHandler.testEnableTableWithNoRegionServers(TestEnableTableHandler.java:107)

Running org.apache.hadoop.hbase.master.TestAssignmentManager
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 132.448 sec - in org.apache.hadoop.hbase.master.handler.TestEnableTableHandler
Running org.apache.hadoop.hbase.master.TestMasterStatusServlet
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.593 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: 29.663 sec - in org.apache.hadoop.hbase.master.cleaner.TestSnapshotFromMaster
Running org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.968 sec - in org.apache.hadoop.hbase.master.cleaner.TestHFileCleaner
Running org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 69.569 sec - in org.apache.hadoop.hbase.master.TestAssignmentManager
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.57 sec - in org.apache.hadoop.hbase.master.cleaner.TestLogsCleaner
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 134.946 sec - in org.apache.hadoop.hbase.master.TestSplitLogManager
Running org.apache.hadoop.hbase.master.TestDistributedLogSplitting
Running org.apache.hadoop.hbase.master.TestMasterMetrics
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.258 sec - in org.apache.hadoop.hbase.master.TestMasterMetrics
Running org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
Running org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.411 sec - in org.apache.hadoop.hbase.master.TestMasterRestartAfterDisablingTable
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.572 sec - in org.apache.hadoop.hbase.master.TestMasterOperationsForRegionReplicas
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: 8.668 sec - in org.apache.hadoop.hbase.master.TestAssignmentListener
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.542 sec - in org.apache.hadoop.hbase.master.TestRegionPlacement
Running org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.571 sec - in org.apache.hadoop.hbase.master.TestMasterMetricsWrapper
Running org.apache.hadoop.hbase.master.TestMasterPriorityRpc
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.909 sec - in org.apache.hadoop.hbase.master.TestMasterPriorityRpc
Tests run: 8, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 312.862 sec <<< FAILURE! - in org.apache.hadoop.hbase.master.procedure.TestMasterFailoverWithProcedures
testWalRecoverLease(org.apache.hadoop.hbase.master.procedure.TestMasterFailoverWithProcedures)  Time elapsed: 64.536 sec  <<< ERROR!
org.junit.runners.model.TestTimedOutException: test timed out after 60000 milliseconds
	at java.lang.Throwable.getStackTraceElement(Native Method)
	at java.lang.Throwable.getOurStackTrace(Throwable.java:827)
	at java.lang.Throwable.getStackTrace(Throwable.java:816)
	at sun.reflect.GeneratedMethodAccessor2.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.log4j.spi.LocationInfo.<init>(LocationInfo.java:139)
	at org.apache.log4j.spi.LoggingEvent.getLocationInformation(LoggingEvent.java:253)
	at org.apache.log4j.helpers.PatternParser$ClassNamePatternConverter.getFullyQualifiedName(PatternParser.java:555)
	at org.apache.log4j.helpers.PatternParser$NamedPatternConverter.convert(PatternParser.java:528)
	at org.apache.log4j.helpers.PatternConverter.format(PatternConverter.java:65)
	at org.apache.log4j.PatternLayout.format(PatternLayout.java:506)
	at org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:310)
	at org.apache.log4j.WriterAppender.append(WriterAppender.java:162)
	at org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)
	at org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
	at org.apache.log4j.Category.callAppenders(Category.java:206)
	at org.apache.log4j.Category.forcedLog(Category.java:391)
	at org.apache.log4j.Category.log(Category.java:856)
	at org.apache.commons.logging.impl.Log4JLogger.warn(Log4JLogger.java:197)
	at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.initTrackerFromOldLogs(WALProcedureStore.java:938)
	at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.initOldLogs(WALProcedureStore.java:926)
	at org.apache.hadoop.hbase.procedure2.store.wal.WALProcedureStore.recoverLease(WALProcedureStore.java:264)
	at org.apache.hadoop.hbase.master.procedure.TestMasterFailoverWithProcedures.testWalRecoverLease(TestMasterFailoverWithProcedures.java:135)

Running org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.582 sec - in org.apache.hadoop.hbase.snapshot.TestSnapshotClientRetries
Running org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 40.847 sec - in org.apache.hadoop.hbase.master.snapshot.TestSnapshotFileCache
Running org.apache.hadoop.hbase.snapshot.TestSnapshotDescriptionUtils
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.285 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: 82.584 sec - in org.apache.hadoop.hbase.snapshot.TestFlushSnapshotFromClient
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 79.243 sec - in org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient
Running org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot
Tests run: 18, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 230.176 sec - in org.apache.hadoop.hbase.master.TestDistributedLogSplitting
Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 565.363 sec - in org.apache.hadoop.hbase.master.balancer.TestStochasticLoadBalancer
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 336.965 sec - in org.apache.hadoop.hbase.snapshot.TestExportSnapshot
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 328.668 sec - in org.apache.hadoop.hbase.snapshot.TestSecureExportSnapshot

Results :

Tests in error: 
  TestMasterFailoverWithProcedures.testWalRecoverLease:135 ยป TestTimedOut test t...
Flaked tests: 
org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence.testOnlineSnapshotDeleteIndependent(org.apache.hadoop.hbase.client.TestSnapshotCloneIndependence)
  Run 1: TestSnapshotCloneIndependence.testOnlineSnapshotDeleteIndependent:182->runTestSnapshotDeleteIndependent:425 expected:<17576> but was:<14046>
  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: 2456, Failures: 0, Errors: 1, Skipped: 21, Flakes: 2

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Apache HBase ...................................... SUCCESS [5.835s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [1.045s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.253s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.083s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [13.119s]
[INFO] Apache HBase - Common ............................. SUCCESS [1:30.261s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [2:48.439s]
[INFO] Apache HBase - Client ............................. SUCCESS [1:26.187s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [7.376s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [6.861s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [9.629s]
[INFO] Apache HBase - Server ............................. FAILURE [1:33:51.938s]
[INFO] Apache HBase - Testing Util ....................... SKIPPED
[INFO] Apache HBase - Thrift ............................. SKIPPED
[INFO] Apache HBase - Rest ............................... SKIPPED
[INFO] Apache HBase - Shell .............................. SKIPPED
[INFO] Apache HBase - Integration Tests .................. SKIPPED
[INFO] Apache HBase - Examples ........................... SKIPPED
[INFO] Apache HBase - Assembly ........................... SKIPPED
[INFO] Apache HBase - Shaded ............................. SKIPPED
[INFO] Apache HBase - Shaded - Client .................... SKIPPED
[INFO] Apache HBase - Shaded - Server .................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:40:24.159s
[INFO] Finished at: Mon Nov 23 23:42:59 UTC 2015
[INFO] Final Memory: 53M/583M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (secondPartTestsExecution) on project hbase-server: ExecutionException: java.lang.RuntimeException: java.lang.RuntimeException: org.apache.maven.surefire.report.ReporterException: When writing xml report stdout/stderr: /tmp/stderr3895383927402470496deferred (No such file or directory) -> [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  : # Post-build task script. TODO: Check this in and have all builds reference check-in.
pwd && ls
# NOTE!!!! The below code has been copied and pasted from ./dev-tools/run-test.sh
# Do not change here without syncing there and vice-versa.
ZOMBIE_TESTS_COUNT=`jps -v | grep surefirebooter | grep -e '-Dhbase.test' | wc -l`
if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
 echo "Suspicious java process found - waiting 30s to see if there are just slow to stop"
 sleep 30
 ZOMBIE_TESTS_COUNT=`jps -v | grep surefirebooter | grep -e '-Dhbase.test' | wc -l`
 if [[ $ZOMBIE_TESTS_COUNT != 0 ]] ; then
   echo " {color:red}There appear to be $ZOMBIE_TESTS_COUNT zombie tests{color}, they should have been killed by surefire but survived"
   jps -v | grep surefirebooter | grep -e '-Dhbase.test'
   jps -v | grep surefirebooter | grep -e '-Dhbase.test' | cut -d ' ' -f 1 | xargs -n 1 jstack
   # Exit with error
   exit 1
 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-JDK7] $ /bin/bash -xe /tmp/hudson498907378295764251.sh
+ pwd
<https://builds.apache.org/job/HBase-1.1-JDK7/ws/>
+ ls
bin
CHANGES.txt
conf
dev-support
hbase-annotations
hbase-assembly
hbase-checkstyle
hbase-client
hbase-common
hbase-examples
hbase-hadoop2-compat
hbase-hadoop-compat
hbase-it
hbase-native-client
hbase-prefix-tree
hbase-procedure
hbase-protocol
hbase-resource-bundle
hbase-rest
hbase-server
hbase-shaded
hbase-shell
hbase-testing-util
hbase-thrift
LICENSE.txt
NOTICE.txt
pom.xml
README.txt
src
target
++ jps -v
++ grep surefirebooter
++ grep -e -Dhbase.test
++ 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
Recording test results
Updating HBASE-14843

Jenkins build is back to normal : HBase-1.1-JDK7 #1604

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