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 06:02:18 UTC

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

See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestBigLinkedList,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 2462 lines...]
SUREFIRE-859: [GC 1528123K->130835K(1912832K), 0.0150280 secs]
SUREFIRE-859: [GC 1528083K->130843K(1912832K), 0.0239370 secs]
SUREFIRE-859: [GC 1528091K->131027K(1912832K), 0.0144190 secs]
SUREFIRE-859: [GC 1528275K->131051K(1912832K), 0.0147100 secs]
SUREFIRE-859: [GC 1528299K->131011K(1912832K), 0.0163210 secs]
SUREFIRE-859: [GC 1528259K->131075K(1912832K), 0.0167880 secs]
SUREFIRE-859: [GC 1528323K->131115K(1912832K), 0.0172140 secs]
SUREFIRE-859: [GC 1528363K->131067K(1912832K), 0.0340710 secs]
2015-12-05 04:29:18\2C430 ERROR [asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_496075] server.NIOServerCnxnFactory$1(44): Thread Thread[asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_496075\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 1528499K->131347K(1912832K), 0.0265180 secs]
SUREFIRE-859: [GC 1528595K->131291K(1912832K), 0.0135330 secs]
SUREFIRE-859: [GC 1528539K->131243K(1912832K), 0.0452960 secs]
SUREFIRE-859: [GC 1528491K->131435K(1912832K), 0.0186070 secs]
SUREFIRE-859: [GC 1528683K->131451K(1912832K), 0.0158150 secs]
SUREFIRE-859: [GC 1528699K->131371K(1912832K), 0.0225680 secs]
SUREFIRE-859: [GC 1528619K->131435K(1912832K), 0.0243340 secs]
SUREFIRE-859: [GC 1528683K->131467K(1912832K), 0.0326670 secs]
SUREFIRE-859: [GC 1528715K->131467K(1912832K), 0.0423140 secs]
SUREFIRE-859: [GC 1528715K->131483K(1912832K), 0.0298670 secs]
SUREFIRE-859: [GC 1528731K->131667K(1912832K), 0.0412800 secs]
SUREFIRE-859: [GC 1528915K->131667K(1912832K), 0.0166080 secs]
SUREFIRE-859: [GC 1528915K->131683K(1912832K), 0.0252940 secs]
SUREFIRE-859: [GC 1528931K->131691K(1912832K), 0.0207120 secs]
SUREFIRE-859: [GC 1528939K->131691K(1912832K), 0.0140760 secs]
SUREFIRE-859: [GC 1528939K->131771K(1912832K), 0.0246200 secs]
SUREFIRE-859: [GC 1529019K->131819K(1912832K), 0.0134040 secs]
SUREFIRE-859: [GC 1529067K->132046K(1912832K), 0.0153550 secs]
SUREFIRE-859: [GC 1529294K->132014K(1912832K), 0.0206350 secs]
SUREFIRE-859: [GC 1529262K->132094K(1912832K), 0.0255490 secs]
SUREFIRE-859: [GC 1529342K->132150K(1912832K), 0.0260330 secs]
SUREFIRE-859: [GC 1529398K->132294K(1912832K), 0.0389280 secs]
SUREFIRE-859: [GC 1529542K->132286K(1912832K), 0.0266590 secs]
SUREFIRE-859: [GC 1529534K->132238K(1912832K), 0.0163610 secs]
SUREFIRE-859: [GC 1529486K->132302K(1912832K), 0.0163620 secs]
SUREFIRE-859: [GC 1529550K->132414K(1912832K), 0.0497760 secs]
SUREFIRE-859: [GC 1529662K->132390K(1912832K), 0.0166340 secs]
SUREFIRE-859: [GC 1529638K->132518K(1912832K), 0.0203660 secs]
SUREFIRE-859: [GC 1529766K->132750K(1912832K), 0.0145110 secs]
SUREFIRE-859: [GC 1529998K->132686K(1912832K), 0.0292130 secs]
SUREFIRE-859: [GC 1529934K->132542K(1912832K), 0.0222690 secs]
SUREFIRE-859: [GC 1529790K->132598K(1912832K), 0.0193680 secs]
SUREFIRE-859: [GC 1529846K->132758K(1912832K), 0.0266030 secs]
SUREFIRE-859: [GC 1530006K->132662K(1912832K), 0.0169720 secs]
SUREFIRE-859: [GC 1529910K->132910K(1912832K), 0.0153680 secs]
SUREFIRE-859: [GC 1530158K->132942K(1912832K), 0.0159820 secs]
SUREFIRE-859: [GC 1530190K->133174K(1912832K), 0.0158480 secs]
SUREFIRE-859: [GC 1530422K->133238K(1911808K), 0.0172010 secs]
SUREFIRE-859: [GC 1529462K->133174K(1912320K), 0.0141810 secs]
SUREFIRE-859: [GC 1529398K->133270K(1912320K), 0.0141650 secs]
SUREFIRE-859: [GC 1529494K->133134K(1912320K), 0.0209570 secs]
SUREFIRE-859: [GC 1529358K->133358K(1912320K), 0.0198160 secs]
SUREFIRE-859: [GC 1529582K->133342K(1912320K), 0.0152260 secs]
SUREFIRE-859: [GC 1529566K->133278K(1912320K), 0.0248320 secs]
SUREFIRE-859: [GC 1529502K->133518K(1912320K), 0.0149450 secs]
SUREFIRE-859: [GC 1529742K->133534K(1911808K), 0.0469650 secs]
2015-12-05 04:29:45\2C070 ERROR [asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_610572] server.NIOServerCnxnFactory$1(44): Thread Thread[asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_610572\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 1530465K->133809K(1912320K), 0.0238650 secs]
SUREFIRE-859: [GC 1530033K->133713K(1912320K), 0.0188470 secs]
SUREFIRE-859: [GC 1529937K->133881K(1911808K), 0.0194400 secs]
SUREFIRE-859: [GC 1530105K->133929K(1912320K), 0.0143110 secs]
SUREFIRE-859: [GC 1530665K->133913K(1912832K), 0.0163020 secs]
SUREFIRE-859: [GC 1531161K->134057K(1912832K), 0.0164060 secs]
SUREFIRE-859: [GC 1531305K->134177K(1912832K), 0.0321810 secs]
SUREFIRE-859: [GC 1531425K->134009K(1912832K), 0.0262600 secs]
SUREFIRE-859: [GC 1531257K->134137K(1912832K), 0.0285600 secs]
SUREFIRE-859: [GC 1531385K->134217K(1912832K), 0.0180070 secs]
SUREFIRE-859: [GC 1531465K->134201K(1912832K), 0.0493000 secs]
SUREFIRE-859: [GC 1531449K->134409K(1912832K), 0.0137830 secs]
SUREFIRE-859: [GC 1531657K->134417K(1912832K), 0.0275630 secs]
SUREFIRE-859: [GC 1531665K->134449K(1912832K), 0.0276830 secs]
SUREFIRE-859: [GC 1531697K->134465K(1912832K), 0.0144320 secs]
SUREFIRE-859: [GC 1531713K->134609K(1912832K), 0.0179960 secs]
2015-12-05 04:30:00\2C762 ERROR [asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_679143] server.NIOServerCnxnFactory$1(44): Thread Thread[asf906.gq1.ygridcore.net\2C42221\2C1449289636019_ChoreService_679143\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 1531825K->134697K(1912832K), 0.0134600 secs]
SUREFIRE-859: [GC 1531945K->134761K(1912832K), 0.0135360 secs]
SUREFIRE-859: [GC 1532009K->134641K(1912832K), 0.0262950 secs]
SUREFIRE-859: [GC 1531889K->134793K(1912832K), 0.0138430 secs]
SUREFIRE-859: [GC 1532041K->134873K(1912832K), 0.0161300 secs]
SUREFIRE-859: [GC 1532121K->134849K(1912832K), 0.0209930 secs]
SUREFIRE-859: [GC 1532097K->134937K(1912832K), 0.0192350 secs]
SUREFIRE-859: [GC 1532185K->134905K(1912832K), 0.0176760 secs]
SUREFIRE-859: [GC 1532153K->135105K(1912832K), 0.0168470 secs]
SUREFIRE-859: [GC 1532353K->135089K(1912832K), 0.0361240 secs]
SUREFIRE-859: [GC 1532337K->135265K(1912832K), 0.0145870 secs]
SUREFIRE-859: [GC 1532513K->135265K(1912832K), 0.0203000 secs]
SUREFIRE-859: [GC 1532513K->135401K(1912832K), 0.0160780 secs]
SUREFIRE-859: [GC 1532649K->135425K(1912832K), 0.0276680 secs]
SUREFIRE-859: [GC 1532673K->135529K(1912832K), 0.0178220 secs]
SUREFIRE-859: [GC 1532777K->135473K(1912832K), 0.0224330 secs]
SUREFIRE-859: [GC 1532721K->135537K(1912832K), 0.0193690 secs]
SUREFIRE-859: [GC 1532785K->135569K(1912832K), 0.0638800 secs]
SUREFIRE-859: [GC 1532817K->135641K(1912832K), 0.0160420 secs]
SUREFIRE-859: [GC 1532889K->135705K(1912832K), 0.0167010 secs]
SUREFIRE-859: [GC 1532953K->135809K(1912832K), 0.0125910 secs]
SUREFIRE-859: [GC 1533057K->135937K(1912832K), 0.0132310 secs]
SUREFIRE-859: [GC 1533185K->135913K(1912832K), 0.0130670 secs]
SUREFIRE-859: [GC 1533161K->135961K(1912832K), 0.0226800 secs]
SUREFIRE-859: [GC 1533209K->135985K(1912832K), 0.0268290 secs]
SUREFIRE-859: [GC 1533233K->136017K(1912832K), 0.0322580 secs]
SUREFIRE-859: [GC 1533265K->136177K(1912832K), 0.0137530 secs]
SUREFIRE-859: [GC 1533425K->136097K(1912832K), 0.0159110 secs]
SUREFIRE-859: [GC 1533345K->136337K(1912832K), 0.0283430 secs]
SUREFIRE-859: [GC 1533585K->136313K(1912832K), 0.0171150 secs]
Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 208.108 sec <<< FAILURE! - in org.apache.hadoop.hbase.test.IntegrationTestBigLinkedList
testContinuousIngest(org.apache.hadoop.hbase.test.IntegrationTestBigLinkedList)  Time elapsed: 207.968 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.test.IntegrationTestBigLinkedList.setUpCluster(IntegrationTestBigLinkedList.java:1550)


Results :

Tests in error: 
  IntegrationTestBigLinkedList>IntegrationTestBase.setUp:133->setUpCluster:1550 » IO

Tests run: 1, Failures: 0, Errors: 1, 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=IntegrationTestBigLinkedList,jdk=latest1.7,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.311s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [0.842s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.418s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.402s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [19.146s]
[INFO] Apache HBase - Common ............................. SUCCESS [11.947s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1.963s]
[INFO] Apache HBase - Client ............................. SUCCESS [8.077s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [0.368s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [1.733s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [1.713s]
[INFO] Apache HBase - Server ............................. SUCCESS [38.949s]
[INFO] Apache HBase - Testing Util ....................... SUCCESS [1.777s]
[INFO] Apache HBase - Thrift ............................. SUCCESS [7.593s]
[INFO] Apache HBase - Rest ............................... SUCCESS [3.196s]
[INFO] Apache HBase - Shell .............................. SUCCESS [1.198s]
[INFO] Apache HBase - Integration Tests .................. FAILURE [29:43.041s]
[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: 31:28.872s
[INFO] Finished at: Sat Dec 05 04:56:48 UTC 2015
[INFO] Final Memory: 182M/4174M
[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=IntegrationTestBigLinkedList,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/hudson8572355902271374357.sh
+ pwd
<https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestBigLinkedList,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
++ wc -l
++ grep -e -Dhbase.test
+ 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

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

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.3-IT/it.test=IntegrationTestBigLinkedList,jdk=latest1.7,label=Hadoop/358/changes>