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/02/21 10:18:40 UTC
Build failed in Jenkins: HBase-TRUNK #6157
See <https://builds.apache.org/job/HBase-TRUNK/6157/changes>
Changes:
[stack] HBASE-13001 NullPointer in master logs for table.jsp (Vikas Vishwakarma)
[rajeshbabu] HBASE-13054 Provide more tracing information for locking/latching events.(Rajeshbabu)
------------------------------------------
[...truncated 2183 lines...]
Running org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 28.672 sec - in org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesSplitRecovery
Running org.apache.hadoop.hbase.mapreduce.TestHFileOutputFormat2
Running org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan2
Running org.apache.hadoop.hbase.mapreduce.TestImportExport
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 304.62 sec - in org.apache.hadoop.hbase.TestIOFencing
Running org.apache.hadoop.hbase.mapreduce.TestWALRecordReader
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.275 sec - in org.apache.hadoop.hbase.mapreduce.TestWALRecordReader
Running org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFiles
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 63.156 sec - in org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFiles
Running org.apache.hadoop.hbase.mapreduce.TestRowCounter
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 435.732 sec - in org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan2
Tests run: 13, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 467.061 sec - in org.apache.hadoop.hbase.mapreduce.TestHFileOutputFormat2
Running org.apache.hadoop.hbase.mapreduce.TestMultiTableInputFormat
Running org.apache.hadoop.hbase.mapreduce.TestCopyTable
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 224.212 sec - in org.apache.hadoop.hbase.mapreduce.TestRowCounter
Running org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan1
Running org.apache.hadoop.hbase.mapreduce.TestTableInputFormat
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 133.643 sec - in org.apache.hadoop.hbase.mapreduce.TestCopyTable
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 498.656 sec - in org.apache.hadoop.hbase.mapreduce.TestImportExport
Running org.apache.hadoop.hbase.mapreduce.TestWALPlayer
Running org.apache.hadoop.hbase.mapreduce.TestImportTSVWithVisibilityLabels
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 112.466 sec - in org.apache.hadoop.hbase.mapreduce.TestTableInputFormat
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 66.53 sec - in org.apache.hadoop.hbase.mapreduce.TestWALPlayer
Running org.apache.hadoop.hbase.mapreduce.TestImportTSVWithOperationAttributes
Running org.apache.hadoop.hbase.mapreduce.TestTimeRangeMapRed
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 346.721 sec - in org.apache.hadoop.hbase.mapreduce.TestImportTSVWithOperationAttributes
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 276.134 sec - in org.apache.hadoop.hbase.mapreduce.TestTimeRangeMapRed
Running org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesUseSecurityEndPoint
Running org.apache.hadoop.hbase.mapreduce.TestMultithreadedTableMapper
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 590.784 sec - in org.apache.hadoop.hbase.mapreduce.TestTableInputFormatScan1
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 535.262 sec - in org.apache.hadoop.hbase.mapreduce.TestImportTSVWithVisibilityLabels
Running org.apache.hadoop.hbase.mapreduce.TestImportTsv
Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 109.605 sec - in org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFilesUseSecurityEndPoint
Running org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFiles
Running org.apache.hadoop.hbase.mapreduce.TestImportTSVWithTTLs
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 148.636 sec - in org.apache.hadoop.hbase.mapreduce.TestMultithreadedTableMapper
Running org.apache.hadoop.hbase.mapreduce.TestCellCounter
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 67.196 sec - in org.apache.hadoop.hbase.mapreduce.TestImportTSVWithTTLs
Tests run: 15, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 117.798 sec <<< FAILURE! - in org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFiles
testNonHfileFolderWithUnmatchedFamilyName(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFiles) Time elapsed: 0.517 sec <<< ERROR!
java.lang.OutOfMemoryError: unable to create new native thread
at java.lang.Thread.start0(Native Method)
at java.lang.Thread.start(Thread.java:693)
at io.netty.util.concurrent.SingleThreadEventExecutor.shutdownGracefully(SingleThreadEventExecutor.java:557)
at io.netty.util.concurrent.MultithreadEventExecutorGroup.shutdownGracefully(MultithreadEventExecutorGroup.java:146)
at io.netty.util.concurrent.AbstractEventExecutorGroup.shutdownGracefully(AbstractEventExecutorGroup.java:69)
at org.apache.hadoop.hbase.ipc.AsyncRpcClient.close(AsyncRpcClient.java:253)
at org.apache.hadoop.hbase.client.ConnectionManager$HConnectionImplementation.internalClose(ConnectionManager.java:2373)
at org.apache.hadoop.hbase.client.ConnectionManager$HConnectionImplementation.close(ConnectionManager.java:2386)
at org.apache.hadoop.hbase.mapreduce.LoadIncrementalHFiles.run(LoadIncrementalHFiles.java:955)
at org.apache.hadoop.hbase.mapreduce.TestLoadIncrementalHFiles.testNonHfileFolderWithUnmatchedFamilyName(TestLoadIncrementalHFiles.java:335)
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)
testRegionCrossingLoad(org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFiles) Time elapsed: 0.08 sec <<< ERROR!
org.apache.hadoop.ipc.RemoteException: File /user/jenkins/test-data/2752b307-d75e-46b2-8f6c-800d29c70c88/testRegionCrossingLoad/myfam/hfile_0 could only be replicated to 0 nodes instead of minReplication (=1). There are 1 datanode(s) running and 1 node(s) are excluded in this operation.
at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.chooseTarget(BlockManager.java:1471)
at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getAdditionalBlock(FSNamesystem.java:2791)
at org.apache.hadoop.hdfs.server.namenode.NameNodeRpcServer.addBlock(NameNodeRpcServer.java:606)
at org.apache.hadoop.hdfs.protocolPB.ClientNamenodeProtocolServerSideTranslatorPB.addBlock(ClientNamenodeProtocolServerSideTranslatorPB.java:455)
at org.apache.hadoop.hdfs.protocol.proto.ClientNamenodeProtocolProtos$ClientNamenodeProtocol$2.callBlockingMethod(ClientNamenodeProtocolProtos.java)
at org.apache.hadoop.ipc.ProtobufRpcEngine$Server$ProtoBufRpcInvoker.call(ProtobufRpcEngine.java:585)
at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:928)
at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:2013)
at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:2009)
at java.security.AccessController.doPrivileged(Native Method)
at javax.security.auth.Subject.doAs(Subject.java:415)
at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1614)
at org.apache.hadoop.ipc.Server$Handler.run(Server.java:2007)
at org.apache.hadoop.ipc.Client.call(Client.java:1411)
at org.apache.hadoop.ipc.Client.call(Client.java:1364)
at org.apache.hadoop.ipc.ProtobufRpcEngine$Invoker.invoke(ProtobufRpcEngine.java:206)
at com.sun.proxy.$Proxy20.addBlock(Unknown Source)
at sun.reflect.GeneratedMethodAccessor30.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:187)
at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:102)
at com.sun.proxy.$Proxy20.addBlock(Unknown Source)
at org.apache.hadoop.hdfs.protocolPB.ClientNamenodeProtocolTranslatorPB.addBlock(ClientNamenodeProtocolTranslatorPB.java:368)
at sun.reflect.GeneratedMethodAccessor23.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at org.apache.hadoop.hbase.fs.HFileSystem$1.invoke(HFileSystem.java:279)
at com.sun.proxy.$Proxy21.addBlock(Unknown Source)
at org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.locateFollowingBlock(DFSOutputStream.java:1449)
at org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.nextBlockOutputStream(DFSOutputStream.java:1270)
at org.apache.hadoop.hdfs.DFSOutputStream$DataStreamer.run(DFSOutputStream.java:526)
Running org.apache.hadoop.hbase.mapreduce.TestTableSnapshotInputFormat
Running org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery
Running org.apache.hadoop.hbase.mapreduce.TestTableMapReduce
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 43.526 sec - in org.apache.hadoop.hbase.mapreduce.TestSecureLoadIncrementalHFilesSplitRecovery
Running org.apache.hadoop.hbase.mapreduce.TestHFileOutputFormat
Results :
Tests in error:
TestAcidGuarantees.testGetAtomicity:342 ? OutOfMemory unable to create new nat...
TestAcidGuarantees.testMixedAtomicity:366 ? OutOfMemory unable to create new n...
TestAcidGuarantees.testScanAtomicity:352 ? OutOfMemory unable to create new na...
org.apache.hadoop.hbase.TestZooKeeper.testMasterZKSessionRecoveryFailure(org.apache.hadoop.hbase.TestZooKeeper)
Run 1: TestZooKeeper.setUp:112 ? IO Shutting down
Run 2: TestZooKeeper.after:120 NullPointer
TestMetaWithReplicas.setup:79 ? IO Shutting down
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
org.apache.hadoop.hbase.client.TestMetaWithReplicas.testHBaseFsckWithFewerMetaReplicaZnodes(org.apache.hadoop.hbase.client.TestMetaWithReplicas)
Run 1: TestMetaWithReplicas.testHBaseFsckWithFewerMetaReplicaZnodes:352 ? OutOfMemory
Run 2: TestMetaWithReplicas.tearDown:104 ? OutOfMemory unable to create new native th...
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestMetaWithReplicas.setup:79 ? IO Shutting down
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestMetaWithReplicas.setup:79 ? OutOfMemory unable to create new native thread
TestReplicationAdminWithClusters.tearDownAfterClass:60->TestReplicationBase.tearDownAfterClass:160 ? OutOfMemory
TestSecureLoadIncrementalHFiles>TestLoadIncrementalHFiles.testNonHfileFolderWithUnmatchedFamilyName:335 ? OutOfMemory
TestSecureLoadIncrementalHFiles.testRegionCrossingLoad ? Remote File /user/jen...
TestMasterFailover.testSimpleMasterFailover:191->Object.wait:-2 ? test timed ...
TestRestartCluster.testClusterRestart:89 ? IO Shutting down
org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient.testCloneSnapshot(org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient)
Run 1: TestRestoreFlushSnapshotFromClient.setup:104 ? RetriesExhausted Failed after a...
Run 2: TestRestoreFlushSnapshotFromClient.tearDown:134 ? RetriesExhausted Failed afte...
org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient.testTakeFlushSnapshot(org.apache.hadoop.hbase.snapshot.TestRestoreFlushSnapshotFromClient)
Run 1: TestRestoreFlushSnapshotFromClient.setup:104 ? RetriesExhausted Failed after a...
Run 2: TestRestoreFlushSnapshotFromClient.tearDown:134 ? RetriesExhausted Failed afte...
Tests run: 917, Failures: 0, Errors: 21, Skipped: 12
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] HBase ............................................. SUCCESS [14.246s]
[INFO] HBase - Checkstyle ................................ SUCCESS [2.538s]
[INFO] HBase - Annotations ............................... SUCCESS [1.429s]
[INFO] HBase - Protocol .................................. SUCCESS [11.858s]
[INFO] HBase - Common .................................... SUCCESS [1:28.875s]
[INFO] HBase - Client .................................... SUCCESS [1:16.882s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.406s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [7.019s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [8.211s]
[INFO] HBase - Server .................................... FAILURE [1:30:29.349s]
[INFO] HBase - Testing Util .............................. SKIPPED
[INFO] HBase - Thrift .................................... SKIPPED
[INFO] HBase - Shell ..................................... SKIPPED
[INFO] HBase - Integration Tests ......................... SKIPPED
[INFO] HBase - Examples .................................. SKIPPED
[INFO] HBase - Rest ...................................... SKIPPED
[INFO] HBase - Assembly .................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:34:08.957s
[INFO] Finished at: Sat Feb 21 09:16:11 UTC 2015
[INFO] Final Memory: 240M/493M
[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-TRUNK/hbase-server && /x1/jenkins/tools/java/jdk1.7.0_25-32/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-TRUNK/hbase-server/target/surefire/surefirebooter1492014096810860764.jar /x1/jenkins/jenkins-slave/workspace/HBase-TRUNK/hbase-server/target/surefire/surefire5790251423179887750tmp /x1/jenkins/jenkins-slave/workspace/HBase-TRUNK/hbase-server/target/surefire/surefire_6574744491682446063689tmp
[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
[FINDBUGS] Skipping publisher since build result is 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-TRUNK] $ /bin/bash -xe /tmp/hudson6620649156937682620.sh
++ wc -l
++ jps
++ grep surefirebooter
+ ZOMBIE_TESTS_COUNT=14
+ [[ 14 != 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=8
+ [[ 8 != 0 ]]
+ echo 'There are 8 zombie tests, they should have been killed by surefire but survived'
There are 8 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=
POST BUILD TASK : FAILURE
END OF POST BUILD TASK : 0
Archiving artifacts
Sending artifact delta relative to HBase-TRUNK #6110
Archived 1368 artifacts
Archive block size is 32768
Received 7 blocks and 238241710 bytes
Compression is 0.1%
Took 1 min 32 sec
Recording test results
Updating HBASE-13001
Updating HBASE-13054