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 05:13:11 UTC
Build failed in Jenkins: HBase-1.2-IT » IntegrationTestImportTsv,latest1.7,Hadoop #327
See <https://builds.apache.org/job/HBase-1.2-IT/it.test=IntegrationTestImportTsv,jdk=latest1.7,label=Hadoop/327/changes>
Changes:
[eclark] HBASE-14922 Delayed flush doesn't work causing flush storms.
[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 5135 lines...]
SUREFIRE-859: [GC 1536482K->139362K(1912832K), 0.0359480 secs]
SUREFIRE-859: [GC 1536610K->139186K(1912832K), 0.0141090 secs]
SUREFIRE-859: [GC 1536434K->139186K(1912832K), 0.0196810 secs]
SUREFIRE-859: [GC 1536434K->139298K(1912832K), 0.0132840 secs]
SUREFIRE-859: [GC 1536546K->139338K(1912832K), 0.0146060 secs]
SUREFIRE-859: [GC 1536586K->139362K(1912832K), 0.0139680 secs]
SUREFIRE-859: [GC 1536610K->139354K(1912832K), 0.0108930 secs]
SUREFIRE-859: [GC 1536602K->139322K(1912832K), 0.0130870 secs]
SUREFIRE-859: [GC 1536570K->139354K(1912832K), 0.0128710 secs]
SUREFIRE-859: [GC 1536602K->139354K(1912832K), 0.0160890 secs]
SUREFIRE-859: [GC 1536602K->139418K(1912832K), 0.0181130 secs]
SUREFIRE-859: [GC 1536666K->139322K(1912832K), 0.0218610 secs]
SUREFIRE-859: [GC 1536570K->139386K(1912832K), 0.0140820 secs]
SUREFIRE-859: [GC 1536634K->139418K(1912832K), 0.0159860 secs]
SUREFIRE-859: [GC 1536666K->139418K(1912832K), 0.0147670 secs]
SUREFIRE-859: [GC 1536666K->139386K(1912832K), 0.0103070 secs]
SUREFIRE-859: [GC 1536634K->139418K(1912832K), 0.0118450 secs]
SUREFIRE-859: [GC 1536666K->139450K(1912832K), 0.0149420 secs]
SUREFIRE-859: [GC 1536698K->139370K(1912832K), 0.0148010 secs]
SUREFIRE-859: [GC 1536618K->139402K(1912832K), 0.0153660 secs]
SUREFIRE-859: [GC 1536650K->139402K(1912832K), 0.0117840 secs]
2015-12-05 03:45:13\2C808 ERROR [asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_614277] server.NIOServerCnxnFactory$1(44): Thread Thread[asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_614277\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 1536762K->139458K(1912832K), 0.0170250 secs]
2015-12-05 03:45:14\2C049 ERROR [asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_615064] server.NIOServerCnxnFactory$1(44): Thread Thread[asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_615064\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 1536730K->139514K(1912832K), 0.0266300 secs]
SUREFIRE-859: [GC 1536762K->139546K(1912832K), 0.0129990 secs]
SUREFIRE-859: [GC 1536794K->139578K(1912832K), 0.0225520 secs]
SUREFIRE-859: [GC 1536826K->139514K(1912832K), 0.0164560 secs]
SUREFIRE-859: [GC 1536762K->139506K(1912832K), 0.0222710 secs]
SUREFIRE-859: [GC 1536754K->139506K(1912832K), 0.0217500 secs]
SUREFIRE-859: [GC 1536754K->139538K(1912832K), 0.0133950 secs]
SUREFIRE-859: [GC 1536786K->139506K(1912832K), 0.0206160 secs]
SUREFIRE-859: [GC 1536754K->139594K(1912832K), 0.0150690 secs]
SUREFIRE-859: [GC 1536842K->139610K(1912832K), 0.0112370 secs]
SUREFIRE-859: [GC 1536858K->139514K(1912832K), 0.0263770 secs]
SUREFIRE-859: [GC 1536762K->139546K(1912832K), 0.0143230 secs]
SUREFIRE-859: [GC 1536794K->139650K(1912832K), 0.0164750 secs]
SUREFIRE-859: [GC 1536898K->139714K(1912832K), 0.0209310 secs]
SUREFIRE-859: [GC 1536962K->139674K(1912832K), 0.0131860 secs]
SUREFIRE-859: [GC 1536922K->139674K(1912832K), 0.0193370 secs]
SUREFIRE-859: [GC 1536922K->139666K(1912832K), 0.0177300 secs]
SUREFIRE-859: [GC 1536914K->139698K(1912832K), 0.0147430 secs]
2015-12-05 03:45:15\2C308 ERROR [asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_618947] server.NIOServerCnxnFactory$1(44): Thread Thread[asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_618947\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 1536914K->139666K(1912832K), 0.0148380 secs]
SUREFIRE-859: [GC 1536914K->139634K(1912832K), 0.0168000 secs]
SUREFIRE-859: [GC 1536882K->139762K(1912832K), 0.0384150 secs]
SUREFIRE-859: [GC 1537010K->139722K(1912832K), 0.0151600 secs]
SUREFIRE-859: [GC 1536970K->139690K(1912832K), 0.0139320 secs]
SUREFIRE-859: [GC 1536938K->139722K(1912832K), 0.0238810 secs]
SUREFIRE-859: [GC 1536970K->139738K(1912832K), 0.0168790 secs]
SUREFIRE-859: [GC 1536986K->139786K(1912832K), 0.0200250 secs]
SUREFIRE-859: [GC 1537034K->139754K(1912832K), 0.0291430 secs]
SUREFIRE-859: [GC 1537002K->139762K(1912832K), 0.0143920 secs]
SUREFIRE-859: [GC 1537010K->139858K(1912832K), 0.0157220 secs]
SUREFIRE-859: [GC 1537106K->139994K(1912832K), 0.0225070 secs]
SUREFIRE-859: [GC 1537242K->139882K(1912832K), 0.0122910 secs]
SUREFIRE-859: [GC 1537130K->139794K(1912832K), 0.0173510 secs]
SUREFIRE-859: [GC 1537042K->139890K(1912832K), 0.0167910 secs]
SUREFIRE-859: [GC 1537138K->139938K(1912832K), 0.0132790 secs]
SUREFIRE-859: [GC 1537186K->139978K(1912832K), 0.0307950 secs]
SUREFIRE-859: [GC 1537226K->139882K(1912832K), 0.0215500 secs]
SUREFIRE-859: [GC 1537130K->139930K(1912832K), 0.0103080 secs]
SUREFIRE-859: [GC 1537178K->140050K(1912832K), 0.0157190 secs]
SUREFIRE-859: [GC 1537298K->140125K(1912832K), 0.0166490 secs]
2015-12-05 03:45:17\2C340 ERROR [asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_626100] server.NIOServerCnxnFactory$1(44): Thread Thread[asf903.gq1.ygridcore.net\2C58570\2C1449286920003_ChoreService_626100\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 1537445K->140069K(1912832K), 0.0156320 secs]
SUREFIRE-859: [GC 1537317K->140133K(1912832K), 0.0123740 secs]
SUREFIRE-859: [GC 1537381K->140133K(1912832K), 0.0130400 secs]
SUREFIRE-859: [GC 1537381K->140149K(1912832K), 0.0157510 secs]
SUREFIRE-859: [GC 1537397K->140197K(1912832K), 0.0102660 secs]
SUREFIRE-859: [GC 1537445K->140085K(1912832K), 0.0114670 secs]
SUREFIRE-859: [GC 1537333K->140149K(1912832K), 0.0128770 secs]
SUREFIRE-859: [GC 1537397K->140141K(1912832K), 0.0205120 secs]
SUREFIRE-859: [GC 1537389K->140109K(1912832K), 0.0416400 secs]
SUREFIRE-859: [GC 1537357K->140269K(1912832K), 0.0407260 secs]
SUREFIRE-859: [GC 1537517K->140317K(1912832K), 0.0148170 secs]
SUREFIRE-859: [GC 1537565K->140301K(1912832K), 0.0323670 secs]
SUREFIRE-859: [GC 1537549K->140205K(1912832K), 0.0123310 secs]
SUREFIRE-859: [GC 1537453K->140293K(1912832K), 0.0130740 secs]
SUREFIRE-859: [GC 1537541K->140277K(1912832K), 0.0149000 secs]
SUREFIRE-859: [GC 1537525K->140381K(1912832K), 0.0151300 secs]
SUREFIRE-859: [GC 1537629K->140357K(1912832K), 0.0232320 secs]
SUREFIRE-859: [GC 1537605K->140357K(1912832K), 0.0282810 secs]
SUREFIRE-859: [GC 1537605K->140421K(1912832K), 0.0191370 secs]
SUREFIRE-859: [GC 1537669K->140421K(1912832K), 0.0123360 secs]
SUREFIRE-859: [GC 1537669K->140397K(1912832K), 0.0376630 secs]
SUREFIRE-859: [GC 1537645K->140445K(1912832K), 0.0258390 secs]
SUREFIRE-859: [GC 1537693K->140493K(1912832K), 0.0133100 secs]
SUREFIRE-859: [GC 1537741K->140453K(1912832K), 0.0194440 secs]
SUREFIRE-859: [GC 1537701K->140485K(1912832K), 0.0217930 secs]
SUREFIRE-859: [GC 1537733K->140421K(1912832K), 0.0231190 secs]
SUREFIRE-859: [GC 1537669K->140429K(1912832K), 0.0117590 secs]
SUREFIRE-859: [GC 1537677K->140429K(1912832K), 0.0164280 secs]
SUREFIRE-859: [GC 1537677K->140429K(1912832K), 0.0236920 secs]
SUREFIRE-859: [GC 1537677K->140517K(1912832K), 0.0171800 secs]
SUREFIRE-859: [GC 1537765K->140581K(1912832K), 0.0168330 secs]
SUREFIRE-859: [GC 1537829K->140501K(1912832K), 0.0232980 secs]
SUREFIRE-859: [GC 1537749K->140501K(1912832K), 0.0202140 secs]
SUREFIRE-859: [GC 1537749K->140469K(1912832K), 0.0113920 secs]
SUREFIRE-859: [GC 1537717K->140469K(1912832K), 0.0134860 secs]
SUREFIRE-859: [GC 1537717K->140533K(1912832K), 0.0129250 secs]
SUREFIRE-859: [GC 1537781K->140741K(1912832K), 0.0132790 secs]
SUREFIRE-859: [GC 1537989K->141188K(1912832K), 0.0129120 secs]
Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 207.254 sec <<< FAILURE! - in org.apache.hadoop.hbase.mapreduce.IntegrationTestImportTsv
org.apache.hadoop.hbase.mapreduce.IntegrationTestImportTsv Time elapsed: 207.253 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:1021)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:981)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:853)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:835)
at org.apache.hadoop.hbase.HBaseTestingUtility.startMiniCluster(HBaseTestingUtility.java:822)
at org.apache.hadoop.hbase.IntegrationTestingUtility.initializeCluster(IntegrationTestingUtility.java:78)
at org.apache.hadoop.hbase.mapreduce.IntegrationTestImportTsv.provisionCluster(IntegrationTestImportTsv.java:113)
Results :
Tests in error:
IntegrationTestImportTsv.provisionCluster:113 » IO Shutting down
Tests run: 1, Failures: 0, Errors: 1, 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.2-IT/it.test=IntegrationTestImportTsv,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 [6.798s]
[INFO] Apache HBase - Checkstyle ......................... SUCCESS [1.024s]
[INFO] Apache HBase - Resource Bundle .................... SUCCESS [0.357s]
[INFO] Apache HBase - Annotations ........................ SUCCESS [1.556s]
[INFO] Apache HBase - Protocol ........................... SUCCESS [19.014s]
[INFO] Apache HBase - Common ............................. SUCCESS [13.774s]
[INFO] Apache HBase - Procedure .......................... SUCCESS [1.958s]
[INFO] Apache HBase - Client ............................. SUCCESS [7.665s]
[INFO] Apache HBase - Hadoop Compatibility ............... SUCCESS [0.737s]
[INFO] Apache HBase - Hadoop Two Compatibility ........... SUCCESS [1.927s]
[INFO] Apache HBase - Prefix Tree ........................ SUCCESS [1.813s]
[INFO] Apache HBase - Server ............................. SUCCESS [39.644s]
[INFO] Apache HBase - Testing Util ....................... SUCCESS [1.756s]
[INFO] Apache HBase - Thrift ............................. SUCCESS [7.512s]
[INFO] Apache HBase - Rest ............................... SUCCESS [3.476s]
[INFO] Apache HBase - Shell .............................. SUCCESS [1.458s]
[INFO] Apache HBase - Integration Tests .................. FAILURE [26:56.296s]
[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: 28:49.678s
[INFO] Finished at: Sat Dec 05 04:08:46 UTC 2015
[INFO] Final Memory: 139M/2252M
[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.2-IT/it.test=IntegrationTestImportTsv,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/hudson7000774790685321407.sh
+ pwd
<https://builds.apache.org/job/HBase-1.2-IT/it.test=IntegrationTestImportTsv,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.2-IT » IntegrationTestImportTsv,latest1.7,Hadoop #328
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/HBase-1.2-IT/it.test=IntegrationTestImportTsv,jdk=latest1.7,label=Hadoop/328/changes>