Build failed in Jenkins: HBase-1.3-IT » IntegrationTestAcidGuarantees,latest1.7,Hadoop #357

[Apache Jenkins Server <je...@builds.apache.org>]

See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.7,label=Hadoop/357/changes>

Changes:

[eclark] HBASE-14922 Delayed flush doesn't work causing flush storms. -- ADD

[apurtell] HBASE-14923 VerifyReplication should not mask the exception during

[apurtell] HBASE-14930 check_compatibility.sh needs smarter exit codes

------------------------------------------
[...truncated 2916 lines...]
SUREFIRE-859: [GC 1670918K->274726K(1912320K), 0.0104080 secs]
2015-12-05 04:36:59\2C348 ERROR [asf901.gq1.ygridcore.net\2C47350\2C1449290096055_ChoreService_649179] server.NIOServerCnxnFactory$1(44): Thread Thread[asf901.gq1.ygridcore.net\2C47350\2C1449290096055_ChoreService_649179\2C5\2Cmain] died\0Ajava.lang.IllegalArgumentException\0A\09at java.util.concurrent.ThreadLocalRandom.nextLong(ThreadLocalRandom.java:190)\0A\09at org.apache.hadoop.hbase.JitterScheduledThreadPoolExecutorImpl$JitteredRunnableScheduledFuture.getDelay(JitterScheduledThreadPoolExecutorImpl.java:84)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1081)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807)\0A\09at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)\0A\09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)\0A\09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)\0A\09at java.lang.Thread.run(Thread.java:745)\0A
SUREFIRE-859: [GC 1671094K->274798K(1912320K), 0.0109190 secs]
SUREFIRE-859: [GC 1671534K->274902K(1912832K), 0.0094900 secs]
SUREFIRE-859: [GC 1672150K->274894K(1912832K), 0.0144260 secs]
SUREFIRE-859: [GC 1672142K->274926K(1912832K), 0.0107540 secs]
SUREFIRE-859: [GC 1672174K->275134K(1912832K), 0.0092370 secs]
SUREFIRE-859: [GC 1672382K->275038K(1912832K), 0.0094550 secs]
SUREFIRE-859: [GC 1672286K->275110K(1912832K), 0.0110840 secs]
SUREFIRE-859: [GC 1672358K->275198K(1912832K), 0.0090240 secs]
SUREFIRE-859: [GC 1672446K->275422K(1912832K), 0.0111010 secs]
SUREFIRE-859: [GC 1672670K->275510K(1911808K), 0.0104020 secs]
SUREFIRE-859: [GC 1671734K->275510K(1912320K), 0.0239860 secs]
SUREFIRE-859: [GC 1671734K->275694K(1912320K), 0.0242750 secs]
SUREFIRE-859: [GC 1671918K->275374K(1912320K), 0.0145700 secs]
SUREFIRE-859: [GC 1671598K->276014K(1912320K), 0.0139180 secs]
SUREFIRE-859: [GC 1672238K->275806K(1912320K), 0.0229590 secs]
SUREFIRE-859: [GC 1672030K->276190K(1911296K), 0.0099310 secs]
SUREFIRE-859: [GC 1671390K->276518K(1911808K), 0.0116920 secs]
SUREFIRE-859: [GC 1671718K->276262K(1850368K), 0.0115580 secs]
SUREFIRE-859: [GC 1610534K->275734K(1792000K), 0.0168770 secs]
SUREFIRE-859: [GC 1552135K->276718K(1737728K), 0.0105490 secs]
SUREFIRE-859: [GC 1497832K->275782K(1684480K), 0.0216420 secs]
SUREFIRE-859: [GC 1444678K->275670K(1634816K), 0.0116020 secs]
SUREFIRE-859: [GC 1394902K->275686K(1588224K), 0.0100730 secs]
SUREFIRE-859: [GC 1347302K->276126K(1542656K), 0.0117880 secs]
SUREFIRE-859: [GC 1302667K->275769K(1499136K), 0.0134890 secs]
SUREFIRE-859: [GC 1259321K->275889K(1458176K), 0.0124470 secs]
SUREFIRE-859: [GC 1218481K->276753K(1420288K), 0.0094070 secs]
SUREFIRE-859: [GC 1180433K->276713K(1382912K), 0.0169700 secs]
SUREFIRE-859: [GC 1143529K->276321K(1348608K), 0.0135120 secs]
SUREFIRE-859: [GC 1107793K->277297K(1314816K), 0.0090320 secs]
SUREFIRE-859: [GC 1075505K->277345K(1283072K), 0.0113910 secs]
SUREFIRE-859: [GC 1043800K->276985K(1252864K), 0.0112260 secs]
SUREFIRE-859: [GC 1013241K->276681K(1399808K), 0.0494560 secs]
SUREFIRE-859: [GC 1160393K->276993K(1363968K), 0.0091440 secs]
SUREFIRE-859: [GC 1124859K->278009K(1330688K), 0.0104720 secs]
SUREFIRE-859: [GC 1091577K->277617K(1297408K), 0.0135800 secs]
SUREFIRE-859: [GC 1058417K->276921K(1265664K), 0.0093580 secs]
SUREFIRE-859: [GC 1026477K->276817K(1235968K), 0.0154420 secs]
SUREFIRE-859: [GC 996689K->278025K(1208832K), 0.0086760 secs]
SUREFIRE-859: [GC 969723K->277697K(1181696K), 0.0101870 secs]
SUREFIRE-859: [GC 942778K->277521K(1156096K), 0.0091950 secs]
SUREFIRE-859: [GC 917000K->277321K(1131520K), 0.0142540 secs]
SUREFIRE-859: [GC 892745K->278137K(1109504K), 0.0115820 secs]
SUREFIRE-859: [GC 870516K->278161K(1087488K), 0.0129770 secs]
SUREFIRE-859: [GC 848529K->277969K(1065984K), 0.0111840 secs]
SUREFIRE-859: [GC 827338K->276721K(1044992K), 0.0149190 secs]
Tests run: 3, Failures: 0, Errors: 3, Skipped: 0, Time elapsed: 610.452 sec <<< FAILURE! - in org.apache.hadoop.hbase.IntegrationTestAcidGuarantees
testMixedAtomicity(org.apache.hadoop.hbase.IntegrationTestAcidGuarantees)  Time elapsed: 207.319 sec  <<< ERROR!
java.io.IOException: Shutting down
	at org.apache.hadoop.hbase.util.JVMClusterUtil.startup(JVMClusterUtil.java:225)
	at org.apache.hadoop.hbase.LocalHBaseCluster.startup(LocalHBaseCluster.java:447)
	at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:225)
	at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:94)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniHBaseCluster(HBaseTestingUtility.java:1056)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:1016)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:888)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:870)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:857)
	at org.apache.hadoop.hbase.IntegrationTestingUtility.initializeCluster(IntegrationTestingUtility.java:78)
	at org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.setUpCluster(IntegrationTestAcidGuarantees.java:66)

testGetAtomicity(org.apache.hadoop.hbase.IntegrationTestAcidGuarantees)  Time elapsed: 201.552 sec  <<< ERROR!
java.io.IOException: Shutting down
	at org.apache.hadoop.hbase.util.JVMClusterUtil.startup(JVMClusterUtil.java:225)
	at org.apache.hadoop.hbase.LocalHBaseCluster.startup(LocalHBaseCluster.java:447)
	at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:225)
	at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:94)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniHBaseCluster(HBaseTestingUtility.java:1056)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:1016)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:888)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:870)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:857)
	at org.apache.hadoop.hbase.IntegrationTestingUtility.initializeCluster(IntegrationTestingUtility.java:78)
	at org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.setUpCluster(IntegrationTestAcidGuarantees.java:66)

testScanAtomicity(org.apache.hadoop.hbase.IntegrationTestAcidGuarantees)  Time elapsed: 201.466 sec  <<< ERROR!
java.io.IOException: Shutting down
	at org.apache.hadoop.hbase.util.JVMClusterUtil.startup(JVMClusterUtil.java:225)
	at org.apache.hadoop.hbase.LocalHBaseCluster.startup(LocalHBaseCluster.java:447)
	at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:225)
	at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:94)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniHBaseCluster(HBaseTestingUtility.java:1056)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:1016)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:888)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:870)
	at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:857)
	at org.apache.hadoop.hbase.IntegrationTestingUtility.initializeCluster(IntegrationTestingUtility.java:78)
	at org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.setUpCluster(IntegrationTestAcidGuarantees.java:66)


Results :

Tests in error: 
  IntegrationTestAcidGuarantees>IntegrationTestBase.setUp:133->setUpCluster:66 » IO
  IntegrationTestAcidGuarantees>IntegrationTestBase.setUp:133->setUpCluster:66 » IO
  IntegrationTestAcidGuarantees>IntegrationTestBase.setUp:133->setUpCluster:66 » IO

Tests run: 3, Failures: 0, Errors: 3, Skipped: 0

[WARNING] File encoding has not been set, using platform encoding ISO-8859-1, i.e. build is platform dependent! The file encoding for reports output files should be provided by the POM property ${project.reporting.outputEncoding}.
[INFO] 
[INFO] --- maven-failsafe-plugin:2.18.1:verify (verify) @ hbase-it ---
[INFO] Failsafe report directory: <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.7,label=Hadoop/ws/hbase-it/target/failsafe-reports>
[WARNING] File encoding has not been set, using platform encoding ISO-8859-1, i.e. build is platform dependent! The file encoding for reports output files should be provided by the POM property ${project.reporting.outputEncoding}.
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Apache HBase ...................................... SUCCESS [3.975s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [0.672s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.346s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.347s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [14.972s]
[INFO] Apache HBase - Common ............................. SUCCESS [10.197s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1.580s]
[INFO] Apache HBase - Client ............................. SUCCESS [6.857s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [0.653s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [1.381s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [1.399s]
[INFO] Apache HBase - Server ............................. SUCCESS [33.180s]
[INFO] Apache HBase - Testing Util ....................... SUCCESS [1.731s]
[INFO] Apache HBase - Thrift ............................. SUCCESS [5.708s]
[INFO] Apache HBase - Rest ............................... SUCCESS [2.971s]
[INFO] Apache HBase - Shell .............................. SUCCESS [1.160s]
[INFO] Apache HBase - Integration Tests .................. FAILURE [1:34:55.832s]
[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] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:36:25.998s
[INFO] Finished at: Sat Dec 05 06:02:58 UTC 2015
[INFO] Final Memory: 136M/1401M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-failsafe-plugin:2.18.1:verify (verify) on project hbase-it: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.7,label=Hadoop/ws/hbase-it/target/failsafe-reports> for the individual test results.
[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-it
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
[Hadoop] $ /bin/bash -xe /tmp/hudson1254140012633563070.sh
+ pwd
<https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.7,label=Hadoop/ws/>
+ ls
bin
CHANGES.txt
conf
dev-support
hbase-annotations
hbase-assembly
hbase-checkstyle
hbase-client
hbase-common
hbase-examples
hbase-external-blockcache
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-spark
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
ERROR: Failed to archive {hbase-it/target/failsafe-reports/failsafe-summary.xml=hbase-it/target/failsafe-reports/failsafe-summary.xml, hbase-it/target/failsafe-reports/org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.txt=hbase-it/target/failsafe-reports/org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.txt, hbase-it/target/failsafe-reports/TEST-org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.xml=hbase-it/target/failsafe-reports/TEST-org.apache.hadoop.hbase.IntegrationTestAcidGuarantees.xml, hbase-it/target/failsafe-reports/org.apache.hadoop.hbase.IntegrationTestAcidGuarantees-output.txt=hbase-it/target/failsafe-reports/org.apache.hadoop.hbase.IntegrationTestAcidGuarantees-output.txt} due to internal error; falling back to full archiving
java.lang.IllegalStateException: End of stream while reading number
	at jsync.protocol.BaseReader.readLong(BaseReader.java:40)
	at jsync.protocol.BaseReader.readInt(BaseReader.java:26)
	at jsync.protocol.ChangeStreamReader.next(ChangeStreamReader.java:54)
	at jsync.protocol.ChangeInputStream.next(ChangeInputStream.java:27)
	at jsync.protocol.ChangeInputStream.read(ChangeInputStream.java:71)
	at com.cloudbees.jenkins.plugins.jsync.archiver.MD5DigestingInputStream.read(MD5DigestingInputStream.java:39)
	at com.google.common.io.LimitInputStream.read(LimitInputStream.java:79)
	at java.io.FilterInputStream.read(FilterInputStream.java:107)
	at com.google.common.io.ByteStreams.copy(ByteStreams.java:193)
	at jsync.protocol.FileSequenceReader.read(FileSequenceReader.java:35)
	at com.cloudbees.jenkins.plugins.jsync.archiver.JSyncArtifactManager.remoteSync(JSyncArtifactManager.java:148)
	at com.cloudbees.jenkins.plugins.jsync.archiver.JSyncArtifactManager.archive(JSyncArtifactManager.java:72)
	at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:219)
	at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:74)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:776)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:723)
	at hudson.model.Build$BuildExecution.post2(Build.java:183)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:670)
	at hudson.model.Run.execute(Run.java:1763)
	at hudson.matrix.MatrixRun.run(MatrixRun.java:146)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:381)

Jenkins build is back to normal : HBase-1.3-IT » IntegrationTestAcidGuarantees,latest1.7,Hadoop #358

[Apache Jenkins Server <je...@builds.apache.org>]

See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.7,label=Hadoop/358/changes>