hbase-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: HBase-1.0 #709
Date Thu, 05 Feb 2015 20:20:26 GMT
See <https://builds.apache.org/job/HBase-1.0/709/>

------------------------------------------
[...truncated 2389 lines...]
Thu Feb 05 19:48:39 UTC 2015, RpcRetryingCaller{globalStartTime=1423165209007, pause=100,
retries=35}, java.net.ConnectException: Connection refused
Thu Feb 05 19:48:59 UTC 2015, RpcRetryingCaller{globalStartTime=1423165209007, pause=100,
retries=35}, java.net.ConnectException: Connection refused
Thu Feb 05 19:49:19 UTC 2015, RpcRetryingCaller{globalStartTime=1423165209007, pause=100,
retries=35}, java.net.ConnectException: Connection refused

	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:708)
	at org.apache.hadoop.net.SocketIOWithTimeout.connect(SocketIOWithTimeout.java:206)
	at org.apache.hadoop.net.NetUtils.connect(NetUtils.java:529)
	at org.apache.hadoop.net.NetUtils.connect(NetUtils.java:493)
	at org.apache.hadoop.hbase.ipc.RpcClientImpl$Connection.setupConnection(RpcClientImpl.java:403)
	at org.apache.hadoop.hbase.ipc.RpcClientImpl$Connection.setupIOstreams(RpcClientImpl.java:709)
	at org.apache.hadoop.hbase.ipc.RpcClientImpl$Connection.writeRequest(RpcClientImpl.java:880)
	at org.apache.hadoop.hbase.ipc.RpcClientImpl$Connection.tracedWriteRequest(RpcClientImpl.java:849)
	at org.apache.hadoop.hbase.ipc.RpcClientImpl.call(RpcClientImpl.java:1173)
	at org.apache.hadoop.hbase.ipc.AbstractRpcClient.callBlockingMethod(AbstractRpcClient.java:216)
	at org.apache.hadoop.hbase.ipc.AbstractRpcClient$BlockingRpcChannelImplementation.callBlockingMethod(AbstractRpcClient.java:300)
	at org.apache.hadoop.hbase.protobuf.generated.ClientProtos$ClientService$BlockingStub.get(ClientProtos.java:31727)
	at org.apache.hadoop.hbase.client.HTable$4.call(HTable.java:873)
	at org.apache.hadoop.hbase.client.HTable$4.call(HTable.java:864)
	at org.apache.hadoop.hbase.client.RpcRetryingCaller.callWithRetries(RpcRetryingCaller.java:126)
	at org.apache.hadoop.hbase.client.HTable.get(HTable.java:881)
	at org.apache.hadoop.hbase.regionserver.wal.TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF(TestWALReplay.java:242)

Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 25.957 sec - in org.apache.hadoop.hbase.regionserver.TestClusterId
Running org.apache.hadoop.hbase.regionserver.TestSeekOptimizations
Running org.apache.hadoop.hbase.regionserver.TestRegionFavoredNodes
Running org.apache.hadoop.hbase.regionserver.TestServerCustomProtocol
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.663 sec - in org.apache.hadoop.hbase.regionserver.TestCompaction
Running org.apache.hadoop.hbase.regionserver.TestHRegion
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.945 sec - in org.apache.hadoop.hbase.regionserver.TestSeekOptimizations
Running org.apache.hadoop.hbase.regionserver.TestAtomicOperation
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 8.277 sec - in org.apache.hadoop.hbase.regionserver.TestRegionFavoredNodes
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.804 sec - in org.apache.hadoop.hbase.regionserver.TestServerCustomProtocol
Running org.apache.hadoop.hbase.regionserver.TestCompactionWithCoprocessor
Running org.apache.hadoop.hbase.regionserver.TestSplitTransactionOnCluster
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 37.029 sec - in org.apache.hadoop.hbase.regionserver.TestAtomicOperation
Running org.apache.hadoop.hbase.regionserver.TestHRegionServerBulkLoad
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 24.078 sec - in org.apache.hadoop.hbase.regionserver.TestCompactionWithCoprocessor
Running org.apache.hadoop.hbase.regionserver.TestZKLessMergeOnCluster
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.113 sec - in org.apache.hadoop.hbase.regionserver.TestZKLessMergeOnCluster
Running org.apache.hadoop.hbase.regionserver.TestRegionServerOnlineConfigChange
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.392 sec - in org.apache.hadoop.hbase.regionserver.TestRegionServerOnlineConfigChange
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 40.08 sec - in org.apache.hadoop.hbase.regionserver.TestHRegionServerBulkLoad
Running org.apache.hadoop.hbase.regionserver.TestEndToEndSplitTransaction
Running org.apache.hadoop.hbase.regionserver.TestEncryptionRandomKeying
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.711 sec - in org.apache.hadoop.hbase.regionserver.TestEncryptionRandomKeying
Tests run: 91, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 91.762 sec - in org.apache.hadoop.hbase.regionserver.TestHRegion
Running org.apache.hadoop.hbase.TestRegionRebalancing
Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.186 sec - in org.apache.hadoop.hbase.regionserver.TestEndToEndSplitTransaction
Running org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 90.451 sec - in org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
Running org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 102.984 sec - in org.apache.hadoop.hbase.io.encoding.TestChangingEncoding
Running org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.262 sec - in org.apache.hadoop.hbase.io.encoding.TestLoadAndSwitchEncodeOnDisk
Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 226.193 sec - in org.apache.hadoop.hbase.io.encoding.TestDataBlockEncoders
Running org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 23.939 sec - in org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
Running org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.59 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheConfig
Running org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.764 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileSeek
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 93.203 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlock
Running org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 35.75 sec - in org.apache.hadoop.hbase.io.hfile.TestForceCacheImportantBlocks
Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 62.614 sec - in org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
Running org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.52 sec - in org.apache.hadoop.hbase.io.hfile.TestHFileBlockIndex
Running org.apache.hadoop.hbase.io.TestFileLink
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.138 sec - in org.apache.hadoop.hbase.io.TestFileLink
Running org.apache.hadoop.hbase.security.access.TestAccessController
Running org.apache.hadoop.hbase.security.access.TestTablePermissions
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.164 sec - in org.apache.hadoop.hbase.security.access.TestTablePermissions
Running org.apache.hadoop.hbase.security.access.TestCellACLs
Tests run: 216, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 330.261 sec - in org.apache.hadoop.hbase.io.hfile.TestCacheOnWrite
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.408 sec - in org.apache.hadoop.hbase.security.access.TestCellACLs
Running org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.09 sec - in org.apache.hadoop.hbase.security.access.TestAccessControlFilter
Running org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Running org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.853 sec - in org.apache.hadoop.hbase.security.access.TestNamespaceCommands
Running org.apache.hadoop.hbase.security.access.TestAccessController2
Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 614.301 sec <<< FAILURE!
- in org.apache.hadoop.hbase.TestRegionRebalancing
testRebalanceOnRegionServerNumberChange[0](org.apache.hadoop.hbase.TestRegionRebalancing)
 Time elapsed: 309.046 sec  <<< ERROR!
java.lang.Exception: test timed out after 300000 milliseconds
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hbase.TestRegionRebalancing.waitForAllRegionsAssigned(TestRegionRebalancing.java:244)
	at org.apache.hadoop.hbase.TestRegionRebalancing.assertRegionsAreBalanced(TestRegionRebalancing.java:173)
	at org.apache.hadoop.hbase.TestRegionRebalancing.testRebalanceOnRegionServerNumberChange(TestRegionRebalancing.java:138)

testRebalanceOnRegionServerNumberChange[1](org.apache.hadoop.hbase.TestRegionRebalancing)
 Time elapsed: 305.189 sec  <<< ERROR!
java.lang.Exception: test timed out after 300000 milliseconds
	at java.lang.Thread.sleep(Native Method)
	at org.apache.hadoop.hbase.TestRegionRebalancing.waitForAllRegionsAssigned(TestRegionRebalancing.java:244)
	at org.apache.hadoop.hbase.TestRegionRebalancing.assertRegionsAreBalanced(TestRegionRebalancing.java:173)
	at org.apache.hadoop.hbase.TestRegionRebalancing.testRebalanceOnRegionServerNumberChange(TestRegionRebalancing.java:138)

Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.609 sec - in org.apache.hadoop.hbase.security.access.TestAccessController2
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 26.823 sec - in org.apache.hadoop.hbase.security.access.TestCellACLWithMultipleVersions
Running org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Running org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLablesWithGroups
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.581 sec - in org.apache.hadoop.hbase.security.access.TestZKPermissionsWatcher
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.579 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLablesWithGroups
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.248 sec - in org.apache.hadoop.hbase.security.access.TestScanEarlyTermination
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDeletes
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDefaultVisLabelService
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithCustomVisLabService
Tests run: 37, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 50.548 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDeletes
Running org.apache.hadoop.hbase.security.visibility.TestDefaultScanLabelGeneratorStack
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.465 sec - in org.apache.hadoop.hbase.security.visibility.TestDefaultScanLabelGeneratorStack
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityWithCheckAuths
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.597 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityWithCheckAuths
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithDistributedLogReplay
Tests run: 55, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 248.003 sec - in org.apache.hadoop.hbase.security.access.TestAccessController
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsOpWithDifferentUsersNoACL
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.593 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsOpWithDifferentUsersNoACL
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithSLGStack
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.794 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithSLGStack
Running org.apache.hadoop.hbase.security.visibility.TestEnforcingScanLabelGenerator
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.87 sec - in org.apache.hadoop.hbase.security.visibility.TestEnforcingScanLabelGenerator
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsReplication
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 17.501 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsReplication
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelReplicationWithExpAsString
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.722 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelReplicationWithExpAsString
Running org.apache.hadoop.hbase.security.token.TestZKSecretWatcher
Running org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithACL
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 7.076 sec - in org.apache.hadoop.hbase.security.visibility.TestVisibilityLabelsWithACL
Running org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.478 sec - in org.apache.hadoop.hbase.security.token.TestTokenAuthentication
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.239 sec - in org.apache.hadoop.hbase.security.token.TestZKSecretWatcher

Results :

Failed tests: 
  TestIOFencing.testFencingAroundCompaction:222->doTest:308 Waiting timed out after [60,000]
msec
  TestIOFencing.testFencingAroundCompactionAfterWALSync:234->doTest:308 Waiting timed out
after [60,000] msec
  TestRollingRestart.testBasicRollingRestart:173->assertRegionsAssigned:249 expected:<22>
but was:<11>

Tests in error: 
  TestRegionRebalancing.testRebalanceOnRegionServerNumberChange:138->assertRegionsAreBalanced:173->waitForAllRegionsAssigned:244
» 
  TestRegionRebalancing.testRebalanceOnRegionServerNumberChange:138->assertRegionsAreBalanced:173->waitForAllRegionsAssigned:244
» 
  TestHTableMultiplexerFlushCache.testOnRegionChange:112->checkExistence:77 » RetriesExhausted
  TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion:1102 »  test...
  TestZKLessAMOnCluster>TestAssignmentManagerOnCluster.testSSHWaitForServerToAssignRegion:1102
» 
  TestHRegionOnCluster.testDataCorrectnessReplayingRecoveredEdits:130->putDataAndVerify:143->Object.wait:-2
» 
  TestSecureWALReplay>TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:242 » RetriesExhausted
  TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:242 » RetriesExhausted
  TestWALReplayCompressed>TestWALReplay.testReplayEditsAfterRegionMovedWithMultiCF:242
» RetriesExhausted
  TestReplicationChangingPeerRegionservers.testChangingNumberOfPeerRegionServers:104->doPutTest:130
» RetriesExhausted
  TestReplicationKillSlaveRS.killOneSlaveRS » RetriesExhausted Failed after atte...


Tests run: 2173, Failures: 3, Errors: 11, Skipped: 18

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] HBase ............................................. SUCCESS [4.644s]
[INFO] HBase - Checkstyle ................................ SUCCESS [0.912s]
[INFO] HBase - Annotations ............................... SUCCESS [0.897s]
[INFO] HBase - Common .................................... SUCCESS [58.052s]
[INFO] HBase - Protocol .................................. SUCCESS [9.156s]
[INFO] HBase - Client .................................... SUCCESS [1:14.715s]
[INFO] HBase - Hadoop Compatibility ...................... SUCCESS [7.023s]
[INFO] HBase - Hadoop Two Compatibility .................. SUCCESS [6.498s]
[INFO] HBase - Prefix Tree ............................... SUCCESS [8.264s]
[INFO] HBase - Server .................................... FAILURE [1:51:57.419s]
[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:54:48.434s
[INFO] Finished at: Thu Feb 05 20:18:17 UTC 2015
[INFO] Final Memory: 56M/459M
[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.0] $ /bin/bash -xe /tmp/hudson3647771489695324088.sh
++ jps
++ grep surefirebooter
++ wc -l
+ ZOMBIE_TESTS_COUNT=6
+ [[ 6 != 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.0 #707
Archived 1829 artifacts
Archive block size is 32768
Received 27 blocks and 403600033 bytes
Compression is 0.2%
Took 1 min 58 sec
Recording test results

Mime
View raw message