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/12/05 07:16:41 UTC
Build failed in Jenkins: HBase-1.3-IT » IntegrationTestAcidGuarantees,latest1.8,Hadoop #357
See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.8,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 4253 lines...]
SUREFIRE-859: [GC (Allocation Failure) 1659193K->262425K(1825280K), 0.0335659 secs]
2015-12-05 04:37:18\2C750 ERROR [asf906.gq1.ygridcore.net\2C36086\2C1449290042864_ChoreService_899354] server.NIOServerCnxnFactory$1(44): Thread Thread[asf906.gq1.ygridcore.net\2C36086\2C1449290042864_ChoreService_899354\2C5\2Cmain] died\0Ajava.lang.IllegalArgumentException: bound must be greater than origin\0A\09at java.util.concurrent.ThreadLocalRandom.nextLong(ThreadLocalRandom.java:430)\0A\09at org.apache.hadoop.hbase.JitterScheduledThreadPoolExecutorImpl$JitteredRunnableScheduledFuture.getDelay(JitterScheduledThreadPoolExecutorImpl.java:84)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1083)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)\0A\09at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)\0A\09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)\0A\09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)\0A\09at java.lang.Thread.run(Thread.java:745)\0A
SUREFIRE-859: [GC (Allocation Failure) 1659185K->262593K(1825280K), 0.0041268 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659329K->262649K(1825280K), 0.0062511 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659385K->262537K(1825280K), 0.0079172 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659273K->262481K(1825280K), 0.0060344 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659217K->262649K(1825280K), 0.0050663 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659385K->262609K(1825280K), 0.0092462 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659345K->262577K(1825280K), 0.0052250 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659313K->262609K(1825280K), 0.0058110 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659345K->262657K(1825280K), 0.0054263 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659393K->262641K(1825280K), 0.0053219 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659377K->262641K(1825280K), 0.0068555 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659377K->262609K(1825280K), 0.0206108 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659345K->262705K(1825280K), 0.0049008 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659441K->262649K(1825280K), 0.0051011 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659385K->262873K(1825280K), 0.0041879 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659609K->262809K(1825280K), 0.0057956 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659545K->262881K(1825280K), 0.0054441 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659617K->262905K(1825280K), 0.0050150 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659641K->262841K(1825280K), 0.0043738 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659577K->262841K(1825280K), 0.0047693 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659577K->262841K(1825280K), 0.0100308 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659577K->262889K(1825280K), 0.0107032 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659625K->262809K(1825280K), 0.0068487 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659545K->262841K(1825280K), 0.0051480 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659577K->262841K(1825280K), 0.0042660 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659577K->262889K(1825280K), 0.0053504 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659625K->262953K(1825280K), 0.0049229 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659689K->262921K(1825280K), 0.0165922 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659657K->262953K(1825280K), 0.0042296 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659689K->262929K(1825280K), 0.0066771 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659665K->262993K(1825280K), 0.0137207 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659729K->263209K(1825280K), 0.0041412 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659945K->263193K(1825280K), 0.0053834 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659929K->263185K(1825280K), 0.0045948 secs]
SUREFIRE-859: [GC (Allocation Failure) 1659921K->263281K(1825280K), 0.0047962 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660017K->263265K(1825280K), 0.0060245 secs]
2015-12-05 04:37:22\2C277 ERROR [asf906.gq1.ygridcore.net\2C36086\2C1449290042864_ChoreService_915445] server.NIOServerCnxnFactory$1(44): Thread Thread[asf906.gq1.ygridcore.net\2C36086\2C1449290042864_ChoreService_915445\2C5\2Cmain] died\0Ajava.lang.IllegalArgumentException: bound must be greater than origin\0A\09at java.util.concurrent.ThreadLocalRandom.nextLong(ThreadLocalRandom.java:430)\0A\09at org.apache.hadoop.hbase.JitterScheduledThreadPoolExecutorImpl$JitteredRunnableScheduledFuture.getDelay(JitterScheduledThreadPoolExecutorImpl.java:84)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1083)\0A\09at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)\0A\09at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)\0A\09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)\0A\09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)\0A\09at java.lang.Thread.run(Thread.java:745)\0A
SUREFIRE-859: [GC (Allocation Failure) 1660009K->263265K(1825280K), 0.0047969 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660001K->263385K(1825280K), 0.0054511 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660121K->263305K(1825280K), 0.0068993 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660041K->263385K(1825280K), 0.0066497 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660121K->263433K(1825280K), 0.0068905 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660169K->263449K(1825280K), 0.0052309 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660185K->263537K(1825280K), 0.0086787 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660273K->263569K(1825280K), 0.0055734 secs]
SUREFIRE-859: [GC (Allocation Failure) 1660305K->263801K(1825280K), 0.0584576 secs]
Tests run: 3, Failures: 0, Errors: 3, Skipped: 0, Time elapsed: 611.491 sec <<< FAILURE! - in org.apache.hadoop.hbase.IntegrationTestAcidGuarantees
testMixedAtomicity(org.apache.hadoop.hbase.IntegrationTestAcidGuarantees) Time elapsed: 207.753 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.897 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.724 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 UTF-8, 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.8,label=Hadoop/ws/hbase-it/target/failsafe-reports>
[WARNING] File encoding has not been set, using platform encoding UTF-8, 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.723s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [1.029s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.271s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.296s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [16.833s]
[INFO] Apache HBase - Common ............................. SUCCESS [10.154s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1.948s]
[INFO] Apache HBase - Client ............................. SUCCESS [7.495s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [0.453s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [1.580s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [1.491s]
[INFO] Apache HBase - Server ............................. SUCCESS [39.913s]
[INFO] Apache HBase - Testing Util ....................... SUCCESS [1.519s]
[INFO] Apache HBase - Thrift ............................. SUCCESS [8.501s]
[INFO] Apache HBase - Rest ............................... SUCCESS [3.366s]
[INFO] Apache HBase - Shell .............................. SUCCESS [1.198s]
[INFO] Apache HBase - Integration Tests .................. FAILURE [1:35:22.582s]
[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:37:05.017s
[INFO] Finished at: Sat Dec 05 06:02:29 UTC 2015
[INFO] Final Memory: 170M/3143M
[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.8,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/hudson5764759314329468546.sh
+ pwd
<https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.8,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.8,Hadoop #358
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestAcidGuarantees,jdk=latest1.8,label=Hadoop/358/changes>