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 2017/08/19 01:53:48 UTC

Build failed in Jenkins: HBase-1.4 » JDK_1_7,Hadoop&&!H13 #871

See <https://builds.apache.org/job/HBase-1.4/jdk=JDK_1_7,label=Hadoop&&!H13/871/display/redirect?page=changes>

Changes:

[stack] HBASE-14498 Master stuck in infinite loop when all Zookeeper servers are

------------------------------------------
[...truncated 2.38 MB...]
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTable(HBaseAdmin.java:676)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTable(HBaseAdmin.java:609)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.setupTable(TestLoadIncrementalHFilesSplitRecovery.java:136)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.testGroupOrSplitFailure(TestLoadIncrementalHFilesSplitRecovery.java:462)
	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:50)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.ExpectException.evaluate(ExpectException.java:19)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.lang.Thread.run(Thread.java:745)

testGroupOrSplitPresplit(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)  Time elapsed: 119.995 sec  <<< ERROR!
org.junit.runners.model.TestTimedOutException: test timed out after 120000 milliseconds
	at java.lang.Object.wait(Native Method)
	at org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:186)
	at org.apache.hadoop.hbase.client.HBaseAdmin.executeCallable(HBaseAdmin.java:4444)
	at org.apache.hadoop.hbase.client.HBaseAdmin.executeCallable(HBaseAdmin.java:4436)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTableAsyncV2(HBaseAdmin.java:755)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTable(HBaseAdmin.java:676)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTable(HBaseAdmin.java:609)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.setupTable(TestLoadIncrementalHFilesSplitRecovery.java:136)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.testGroupOrSplitPresplit(TestLoadIncrementalHFilesSplitRecovery.java:389)
	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:50)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.lang.Thread.run(Thread.java:745)

testSplitTmpFileCleanUp(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)  Time elapsed: 120.019 sec  <<< ERROR!
org.junit.runners.model.TestTimedOutException: test timed out after 120000 milliseconds
	at java.lang.Object.wait(Native Method)
	at org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:186)
	at org.apache.hadoop.hbase.client.HBaseAdmin.executeCallable(HBaseAdmin.java:4444)
	at org.apache.hadoop.hbase.client.HBaseAdmin.executeCallable(HBaseAdmin.java:4436)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTableAsyncV2(HBaseAdmin.java:755)
	at org.apache.hadoop.hbase.client.HBaseAdmin.createTable(HBaseAdmin.java:676)
	at org.apache.hadoop.hbase.HBaseTestingUtility.createTable(HBaseTestingUtility.java:1516)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.setupTableWithSplitkeys(TestLoadIncrementalHFilesSplitRecovery.java:159)
	at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery.testSplitTmpFileCleanUp(TestLoadIncrementalHFilesSplitRecovery.java:431)
	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:50)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.lang.Thread.run(Thread.java:745)

Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 642.683 sec - in org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery

Results :

Tests in error: 
  TestCoprocessorEndpoint.setupBeforeClass:100 » SocketTimeout callTimeout=5000,...
  TestScannerCursor.setUpBeforeClass:93->createTestTable:99 » TableExists TestSc...
Flaked tests: 
org.apache.hadoop.hbase.TestZooKeeper.testMasterSessionExpired(org.apache.hadoop.hbase.TestZooKeeper)
  Run 1: TestZooKeeper.testMasterSessionExpired:227->testSanity:258->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.client.TestReplicasClient.testCancelOfMultiGet(org.apache.hadoop.hbase.client.TestReplicasClient)
  Run 1: TestReplicasClient.testCancelOfMultiGet:585 null
  Run 2: PASS

org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery.testGroupOrSplitFailure(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)
  Run 1: TestSecureLoadIncrementalHFilesSplitRecovery>TestLoadIncrementalHFilesSplitRecovery.testGroupOrSplitFailure:462->TestLoadIncrementalHFilesSplitRecovery.setupTable:136->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery.testGroupOrSplitPresplit(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)
  Run 1: TestSecureLoadIncrementalHFilesSplitRecovery>TestLoadIncrementalHFilesSplitRecovery.testGroupOrSplitPresplit:389->TestLoadIncrementalHFilesSplitRecovery.setupTable:136->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery.testGroupOrSplitWhenRegionHoleExistsInMeta(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)
  Run 1: TestSecureLoadIncrementalHFilesSplitRecovery>TestLoadIncrementalHFilesSplitRecovery.testGroupOrSplitWhenRegionHoleExistsInMeta:502->TestLoadIncrementalHFilesSplitRecovery.setupTableWithSplitkeys:159->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery.testSplitTmpFileCleanUp(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)
  Run 1: TestSecureLoadIncrementalHFilesSplitRecovery>TestLoadIncrementalHFilesSplitRecovery.testSplitTmpFileCleanUp:431->TestLoadIncrementalHFilesSplitRecovery.setupTableWithSplitkeys:159->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery.testSplitWhileBulkLoadPhase(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery)
  Run 1: TestSecureLoadIncrementalHFilesSplitRecovery>TestLoadIncrementalHFilesSplitRecovery.testSplitWhileBulkLoadPhase:346->TestLoadIncrementalHFilesSplitRecovery.setupTable:136->Object.wait:-2 » TestTimedOut
  Run 2: PASS

org.apache.hadoop.hbase.security.access.TestAccessControlFilter.testQualifierAccess(org.apache.hadoop.hbase.security.access.TestAccessControlFilter)
  Run 1: TestAccessControlFilter.testQualifierAccess:97->SecureTestUtil.createTable:710->SecureTestUtil.createTable:726->SecureTestUtil.createTable:739->Object.wait:-2 » TestTimedOut
  Run 2: PASS


Tests run: 2845, Failures: 0, Errors: 2, Skipped: 57, Flakes: 8

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Apache HBase ...................................... SUCCESS [1:47.433s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [16.420s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.363s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.420s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [19.418s]
[INFO] Apache HBase - Common ............................. SUCCESS [2:46.416s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [3:41.953s]
[INFO] Apache HBase - Metrics API ........................ SUCCESS [1.550s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [12.215s]
[INFO] Apache HBase - Metrics Implementation ............. SUCCESS [6.597s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [21.231s]
[INFO] Apache HBase - Client ............................. SUCCESS [2:02.739s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [11.415s]
[INFO] Apache HBase - Server ............................. FAILURE [2:00:45.328s]
[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 - External Block Cache ............... SKIPPED
[INFO] Apache HBase - Assembly ........................... SKIPPED
[INFO] Apache HBase - Shaded ............................. SKIPPED
[INFO] Apache HBase - Shaded - Client .................... SKIPPED
[INFO] Apache HBase - Shaded - Server .................... SKIPPED
[INFO] Apache HBase - Archetypes ......................... SKIPPED
[INFO] Apache HBase - Exemplar for hbase-client archetype  SKIPPED
[INFO] Apache HBase - Exemplar for hbase-shaded-client archetype  SKIPPED
[INFO] Apache HBase - Archetype builder .................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 2:13:08.564s
[INFO] Finished at: Sat Aug 19 01:48:16 UTC 2017
[INFO] Final Memory: 102M/1109M
[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: There was an error in the forked process
[ERROR] java.lang.ArrayIndexOutOfBoundsException: 1
[ERROR] at org.apache.maven.surefire.common.junit4.JUnit4ProviderUtil.generateFailingTests(JUnit4ProviderUtil.java:64)
[ERROR] at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:151)
[ERROR] at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
[ERROR] at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
[ERROR] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
[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  : # 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
Setting JDK_1_7_LATEST__HOME=/home/jenkins/tools/java/latest1.7
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
[19ccb43d] $ /bin/bash -xe /tmp/jenkins9164135358263358141.sh
+ pwd
<https://builds.apache.org/job/HBase-1.4/jdk=JDK_1_7,label=Hadoop&&!H13/ws/>
+ ls
bin
CHANGES.txt
conf
dev-support
extra_env_var
hbase-annotations
hbase-archetypes
hbase-assembly
hbase-checkstyle
hbase-client
hbase-common
hbase-examples
hbase-external-blockcache
hbase-hadoop2-compat
hbase-hadoop-compat
hbase-it
hbase-metrics
hbase-metrics-api
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
Setting JDK_1_7_LATEST__HOME=/home/jenkins/tools/java/latest1.7
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Recording test results
Setting JDK_1_7_LATEST__HOME=/home/jenkins/tools/java/latest1.7
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Setting JDK_1_7_LATEST__HOME=/home/jenkins/tools/java/latest1.7
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8

Jenkins build is back to normal : HBase-1.4 » JDK_1_7,Hadoop&&!H13 #872

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.4/jdk=JDK_1_7,label=Hadoop&&!H13/872/display/redirect?page=changes>