You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@hbase.apache.org by Apache Hudson Server <hu...@hudson.zones.apache.org> on 2009/12/31 19:46:14 UTC
Build failed in Hudson: HBase-Patch #1054
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1054/changes>
Changes:
[apurtell] HBASE-2083 [EC2] HDFS DataNode no longer required on master; require 0.20.3-dev (for now) in hbase-ec2-env.sh
[apurtell] HBASE-2083 [EC2] HDFS DataNode no longer required on master
------------------------------------------
[...truncated 118974 lines...]
[junit] Original url ftp://one.two.three/index.html, Transformed url r:ftp://three.two.one/index.html
[junit] Original url filename, Transformed url filename
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.086 sec
[junit] Running org.apache.hadoop.hbase.util.TestMergeTool
[junit] 2009-12-31 18:50:55,462 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 18:50:55,464 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:55,465 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 18:50:55,465 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:55,466 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 18:50:55,466 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:55,466 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 18:50:55,467 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:55,606 WARN [main] conf.Configuration(326): slave.host.name is deprecated. Instead, use mapreduce.tasktracker.host.name
[junit] 2009-12-31 18:50:56,159 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 18:50:56,160 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:56,161 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 18:50:56,161 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:56,162 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 18:50:56,163 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:56,164 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 18:50:56,164 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 18:50:56.211::INFO: Logging to STDERR via org.mortbay.log.StdErrLog
[junit] 2009-12-31 18:50:56.265::INFO: jetty-6.1.14
[junit] 2009-12-31 18:50:56.331::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/hdfs> to /tmp/Jetty_localhost_42416_hdfs____vh0bt1/webapp
[junit] 2009-12-31 18:50:56.728::INFO: Started SelectChannelConnector@localhost:42416
[junit] Starting DataNode 0 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2>
[junit] 2009-12-31 18:50:57.269::INFO: jetty-6.1.14
[junit] 2009-12-31 18:50:57.274::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_47733_datanode____hw26aj/webapp
[junit] 2009-12-31 18:50:57.427::INFO: Started SelectChannelConnector@localhost:47733
[junit] Starting DataNode 1 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4>
[junit] 2009-12-31 18:50:57.906::INFO: jetty-6.1.14
[junit] 2009-12-31 18:50:57.911::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_47524_datanode____.sgqq85/webapp
[junit] 2009-12-31 18:50:58.042::INFO: Started SelectChannelConnector@localhost:47524
[junit] 2009-12-31 18:50:58,110 WARN [main] conf.Configuration(326): mapred.task.id is deprecated. Instead, use mapreduce.task.attempt.id
[junit] 2009-12-31 18:50:58,434 DEBUG [main] util.FSUtils(213): Created version file at hdfs://localhost:46381/user/hudson set its version at:7
[junit] 2009-12-31 18:50:58,472 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:58,518 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:58,518 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:58,519 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:58,519 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:58,549 INFO [main] wal.HLog(352): New hlog /user/hudson/-ROOT-/70236052/.logs/hlog.dat.1262285458472
[junit] 2009-12-31 18:50:58,552 DEBUG [main] regionserver.HRegion(265): Opening region -ROOT-,,0, encoded=70236052
[junit] 2009-12-31 18:50:58,604 INFO [main] regionserver.HRegion(343): region -ROOT-,,0/70236052 available; sequence id is 0
[junit] 2009-12-31 18:50:58,623 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:58,659 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:58,659 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:58,660 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:58,660 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:58,669 INFO [main] wal.HLog(352): New hlog /user/hudson/.META./1028785192/.logs/hlog.dat.1262285458624
[junit] 2009-12-31 18:50:58,670 DEBUG [main] regionserver.HRegion(265): Opening region .META.,,1, encoded=1028785192
[junit] 2009-12-31 18:50:58,723 INFO [main] regionserver.HRegion(343): region .META.,,1/1028785192 available; sequence id is 0
[junit] 2009-12-31 18:50:58,745 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:58,779 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:58,779 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:58,780 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:58,780 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:58,791 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/519805377/.logs/hlog.dat.1262285458745
[junit] 2009-12-31 18:50:58,792 DEBUG [main] regionserver.HRegion(265): Opening region TestMergeTool,row_0200,1262285455260, encoded=519805377
[junit] 2009-12-31 18:50:58,832 INFO [main] regionserver.HRegion(343): region TestMergeTool,row_0200,1262285455260/519805377 available; sequence id is 0
[junit] 2009-12-31 18:50:58,854 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:58,878 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:58,879 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:58,879 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:58,879 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:58,891 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/264421680/.logs/hlog.dat.1262285458855
[junit] 2009-12-31 18:50:58,891 DEBUG [main] regionserver.HRegion(265): Opening region TestMergeTool,row_0250,1262285455261, encoded=264421680
[junit] 2009-12-31 18:50:58,931 INFO [main] regionserver.HRegion(343): region TestMergeTool,row_0250,1262285455261/264421680 available; sequence id is 0
[junit] 2009-12-31 18:50:58,951 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:58,976 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:58,976 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:58,976 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:58,977 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:58,988 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1186237651/.logs/hlog.dat.1262285458952
[junit] 2009-12-31 18:50:58,988 DEBUG [main] regionserver.HRegion(265): Opening region TestMergeTool,row_0100,1262285455261, encoded=1186237651
[junit] 2009-12-31 18:50:59,159 INFO [main] regionserver.HRegion(343): region TestMergeTool,row_0100,1262285455261/1186237651 available; sequence id is 0
[junit] 2009-12-31 18:50:59,195 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:59,218 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:59,219 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:59,219 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:59,219 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:59,231 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/329103839/.logs/hlog.dat.1262285459195
[junit] 2009-12-31 18:50:59,232 DEBUG [main] regionserver.HRegion(265): Opening region TestMergeTool,row_0500,1262285455261, encoded=329103839
[junit] 2009-12-31 18:50:59,318 INFO [main] regionserver.HRegion(343): region TestMergeTool,row_0500,1262285455261/329103839 available; sequence id is 0
[junit] 2009-12-31 18:50:59,355 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:50:59,383 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:50:59,384 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:50:59,384 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:50:59,385 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:50:59,395 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/601601528/.logs/hlog.dat.1262285459355
[junit] 2009-12-31 18:50:59,395 DEBUG [main] regionserver.HRegion(265): Opening region TestMergeTool,,1262285455261, encoded=601601528
[junit] 2009-12-31 18:50:59,494 INFO [main] regionserver.HRegion(343): region TestMergeTool,,1262285455261/601601528 available; sequence id is 0
[junit] 2009-12-31 18:50:59,496 DEBUG [main] regionserver.HRegion(454): Closing .META.,,1: compactions & flushes disabled
[junit] 2009-12-31 18:50:59,496 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on .META.,,1
[junit] 2009-12-31 18:50:59,496 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region .META.,,1
[junit] 2009-12-31 18:50:59,497 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region .META.,,1. Current region memstore size 2.2k
[junit] 2009-12-31 18:50:59,540 INFO [main] regionserver.StoreFile(241): Allocating LruBlockCache with maximum size 98.6m
[junit] 2009-12-31 18:50:59,558 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/.META./1028785192/info/7200970069437118205, entries=5, sequenceid=6, memsize=2.2k, filesize=2.2k to .META.,,1
[junit] 2009-12-31 18:50:59,559 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~2.2k for region .META.,,1 in 63ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 18:50:59,559 DEBUG [main] regionserver.Store(482): closed historian
[junit] 2009-12-31 18:50:59,560 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 18:50:59,560 INFO [main] regionserver.HRegion(490): Closed .META.,,1
[junit] 2009-12-31 18:50:59,560 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:50:59,560 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:50:59,561 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/.META./1028785192/.logs
[junit] 2009-12-31 18:50:59,594 DEBUG [main] regionserver.HRegion(454): Closing -ROOT-,,0: compactions & flushes disabled
[junit] 2009-12-31 18:50:59,594 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on -ROOT-,,0
[junit] 2009-12-31 18:50:59,594 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region -ROOT-,,0
[junit] 2009-12-31 18:50:59,594 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region -ROOT-,,0. Current region memstore size 544
[junit] 2009-12-31 18:50:59,687 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/-ROOT-/70236052/info/5535136091345077811, entries=1, sequenceid=2, memsize=544, filesize=809 to -ROOT-,,0
[junit] 2009-12-31 18:50:59,688 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~544 for region -ROOT-,,0 in 94ms, sequence id=2, compaction requested=false
[junit] 2009-12-31 18:50:59,688 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 18:50:59,688 INFO [main] regionserver.HRegion(490): Closed -ROOT-,,0
[junit] 2009-12-31 18:50:59,689 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:50:59,689 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:50:59,689 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/-ROOT-/70236052/.logs
[junit] 2009-12-31 18:51:00,761 DEBUG [main] regionserver.HRegion(454): Closing TestMergeTool,row_0200,1262285455260: compactions & flushes disabled
[junit] 2009-12-31 18:51:00,761 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0200,1262285455260
[junit] 2009-12-31 18:51:00,761 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region TestMergeTool,row_0200,1262285455260
[junit] 2009-12-31 18:51:00,762 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region TestMergeTool,row_0200,1262285455260. Current region memstore size 256
[junit] 2009-12-31 18:51:02,074 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/TestMergeTool/519805377/contents/3270481128251840426, entries=2, sequenceid=3, memsize=256, filesize=425 to TestMergeTool,row_0200,1262285455260
[junit] 2009-12-31 18:51:02,075 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~256 for region TestMergeTool,row_0200,1262285455260 in 1313ms, sequence id=3, compaction requested=false
[junit] 2009-12-31 18:51:02,075 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 18:51:02,076 INFO [main] regionserver.HRegion(490): Closed TestMergeTool,row_0200,1262285455260
[junit] 2009-12-31 18:51:02,076 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:02,076 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:02,076 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/TestMergeTool/519805377/.logs
[junit] 2009-12-31 18:51:02,109 DEBUG [main] regionserver.HRegion(454): Closing TestMergeTool,row_0250,1262285455261: compactions & flushes disabled
[junit] 2009-12-31 18:51:02,109 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0250,1262285455261
[junit] 2009-12-31 18:51:02,109 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region TestMergeTool,row_0250,1262285455261
[junit] 2009-12-31 18:51:02,109 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region TestMergeTool,row_0250,1262285455261. Current region memstore size 376
[junit] 2009-12-31 18:51:03,221 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/TestMergeTool/264421680/contents/6364339050493181113, entries=3, sequenceid=4, memsize=376, filesize=469 to TestMergeTool,row_0250,1262285455261
[junit] 2009-12-31 18:51:03,221 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~376 for region TestMergeTool,row_0250,1262285455261 in 1112ms, sequence id=4, compaction requested=false
[junit] 2009-12-31 18:51:03,222 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 18:51:03,222 INFO [main] regionserver.HRegion(490): Closed TestMergeTool,row_0250,1262285455261
[junit] 2009-12-31 18:51:03,222 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:03,222 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:03,223 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/TestMergeTool/264421680/.logs
[junit] 2009-12-31 18:51:03,253 DEBUG [main] regionserver.HRegion(454): Closing TestMergeTool,row_0100,1262285455261: compactions & flushes disabled
[junit] 2009-12-31 18:51:03,253 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0100,1262285455261
[junit] 2009-12-31 18:51:03,253 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region TestMergeTool,row_0100,1262285455261
[junit] 2009-12-31 18:51:03,254 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region TestMergeTool,row_0100,1262285455261. Current region memstore size 256
[junit] 2009-12-31 18:51:03,298 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/TestMergeTool/1186237651/contents/8607717290983340531, entries=2, sequenceid=5, memsize=256, filesize=425 to TestMergeTool,row_0100,1262285455261
[junit] 2009-12-31 18:51:03,298 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~256 for region TestMergeTool,row_0100,1262285455261 in 44ms, sequence id=5, compaction requested=false
[junit] 2009-12-31 18:51:03,299 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 18:51:03,299 INFO [main] regionserver.HRegion(490): Closed TestMergeTool,row_0100,1262285455261
[junit] 2009-12-31 18:51:03,299 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:03,299 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:03,300 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/TestMergeTool/1186237651/.logs
[junit] 2009-12-31 18:51:03,334 DEBUG [main] regionserver.HRegion(454): Closing TestMergeTool,row_0500,1262285455261: compactions & flushes disabled
[junit] 2009-12-31 18:51:03,335 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0500,1262285455261
[junit] 2009-12-31 18:51:03,335 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region TestMergeTool,row_0500,1262285455261
[junit] 2009-12-31 18:51:03,335 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region TestMergeTool,row_0500,1262285455261. Current region memstore size 256
[junit] 2009-12-31 18:51:03,381 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/TestMergeTool/329103839/contents/7424119396839854546, entries=2, sequenceid=6, memsize=256, filesize=425 to TestMergeTool,row_0500,1262285455261
[junit] 2009-12-31 18:51:03,382 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~256 for region TestMergeTool,row_0500,1262285455261 in 47ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 18:51:03,382 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 18:51:03,382 INFO [main] regionserver.HRegion(490): Closed TestMergeTool,row_0500,1262285455261
[junit] 2009-12-31 18:51:03,383 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:03,383 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:03,383 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/TestMergeTool/329103839/.logs
[junit] 2009-12-31 18:51:03,418 DEBUG [main] regionserver.HRegion(454): Closing TestMergeTool,,1262285455261: compactions & flushes disabled
[junit] 2009-12-31 18:51:03,418 DEBUG [main] regionserver.HRegion(471): Updates disabled for region, no outstanding scanners on TestMergeTool,,1262285455261
[junit] 2009-12-31 18:51:03,419 DEBUG [main] regionserver.HRegion(478): No more row locks outstanding on region TestMergeTool,,1262285455261
[junit] 2009-12-31 18:51:03,419 DEBUG [main] regionserver.HRegion(895): Started memstore flush for region TestMergeTool,,1262285455261. Current region memstore size 256
[junit] 2009-12-31 18:51:03,505 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:46381/user/hudson/TestMergeTool/601601528/contents/4273622605781880821, entries=2, sequenceid=7, memsize=256, filesize=425 to TestMergeTool,,1262285455261
[junit] 2009-12-31 18:51:03,505 DEBUG [main] regionserver.HRegion(971): Finished memstore flush of ~256 for region TestMergeTool,,1262285455261 in 86ms, sequence id=7, compaction requested=false
[junit] 2009-12-31 18:51:03,506 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 18:51:03,506 INFO [main] regionserver.HRegion(490): Closed TestMergeTool,,1262285455261
[junit] 2009-12-31 18:51:03,506 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:03,507 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:03,507 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:46381/user/hudson/TestMergeTool/601601528/.logs
[junit] 2009-12-31 18:51:04,572 INFO [main] util.TestMergeTool(248): Creating log /tmp/.logs_1262285464572
[junit] 2009-12-31 18:51:04,588 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 18:51:04,608 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:51:04,608 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:51:04,608 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:51:04,609 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:51:04,620 INFO [main] wal.HLog(352): New hlog /tmp/.logs_1262285464572/hlog.dat.1262285464588
[junit] 2009-12-31 18:51:04,623 INFO [main] util.TestMergeTool(173): merging regions 0 and 1
[junit] 2009-12-31 18:51:04,630 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 18:51:04,630 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 18:51:04,631 INFO [main] util.Merge(82): Verifying that file system is available...
[junit] 2009-12-31 18:51:04,648 INFO [main] util.Merge(91): Verifying that HBase is not running...
[junit] 2009-12-31 18:51:04,670 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 18:51:04,670 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 18:51:04,671 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 18:51:04,671 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 18:51:04,922 DEBUG [main] zookeeper.ZooKeeperWrapper(392): Read ZNode /hbase/master got 67.195.138.9:60000
[junit] 2009-12-31 18:51:04,946 FATAL [main] util.Merge(94): HBase cluster must be off-line.
[junit] 2009-12-31 18:51:04,946 DEBUG [main.logSyncer] wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 18:51:04,946 INFO [main.logSyncer] wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 18:51:04,946 DEBUG [main] wal.HLog(564): closing hlog writer in /tmp/.logs_1262285464572
[junit] 2009-12-31 18:51:06,035 INFO [main] hbase.HBaseTestCase(627): Shutting down Mini DFS
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 1
[junit] 2009-12-31 18:51:06,138 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@1681ea] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:37419, storageID=DS-2056769545-67.195.138.9-37419-1262285458046, infoPort=47524, ipcPort=50863):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] Shutting down DataNode 0
[junit] 2009-12-31 18:51:06,242 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@940f82] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:40574, storageID=DS-870427145-67.195.138.9-40574-1262285457433, infoPort=47733, ipcPort=51766):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2009-12-31 18:51:06,345 WARN [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@1a6684f] namenode.FSNamesystem$ReplicationMonitor(2326): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 18:51:06,345 WARN [org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor@17ec9f7] namenode.DecommissionManager$Monitor(67): Monitor interrupted: java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 18:51:06,359 INFO [main] hbase.HBaseTestCase(638): Shutting down FileSystem
[junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 11.277 sec
[junit] 2009-12-31 18:51:06,756 DEBUG [HCM.shutdownHook] zookeeper.ZooKeeperWrapper(632): Closed connection with ZooKeeper
[junit] Test org.apache.hadoop.hbase.util.TestMergeTool FAILED
[junit] Running org.apache.hadoop.hbase.util.TestRootPath
[junit] 2009-12-31 18:51:07,093 INFO [main] util.TestRootPath(60): Got expected exception when checking invalid path:
[junit] java.io.IOException: Root directory does not have a scheme
[junit] at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSUtils.java:228)
[junit] at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(TestRootPath.java:56)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at junit.framework.TestCase.runTest(TestCase.java:168)
[junit] at junit.framework.TestCase.runBare(TestCase.java:134)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:766)
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.078 sec
BUILD FAILED
<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml>:504: Tests failed!
Total time: 28 minutes 55 seconds
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Hudson build is back to normal: HBase-Patch #1062
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1062/changes>
Build failed in Hudson: HBase-Patch #1061
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1061/changes>
Changes:
[stack] HBASE-2089 HBaseConfiguration() ctor. deprecated
[stack] HBASE-2090 findbugs issues
[stack] HBASE-2021 Add compaction details to master UI
------------------------------------------
[...truncated 124737 lines...]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:11:33 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:11:34 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:11:34 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39978 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:11:34 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:12:15 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/05 08:12:34 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@c2ccac
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:12:35 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:12:35 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47184 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:12:35 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:13:35 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@fb7efa
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:13:35 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:13:37 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:13:37 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47223 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:13:37 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:14:37 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@10a5314
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:14:39 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:14:39 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47256 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:14:39 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:15:39 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@d767dc
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:15:39 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:15:40 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:15:40 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47276 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:15:40 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:16:40 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@4b9101
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:16:41 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:16:41 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47292 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:16:41 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:17:15 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/05 08:17:41 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@e00321
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:17:41 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:17:43 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:17:43 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59299 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:17:43 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:18:43 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1fc7299
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:18:45 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:18:45 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59320 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:18:45 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:19:45 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@13d3f62
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:19:45 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:19:46 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:19:46 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59336 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:19:46 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:20:46 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1f16e6e
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:20:48 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:20:48 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59356 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:20:48 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:21:48 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@18b70fb
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:21:48 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:194)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:64)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:56)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 08:21:49 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:21:49 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59378 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:21:49 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 08:22:15 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/05 08:22:49 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1ac4f3e
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 08:22:50 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 08:22:50 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56088 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 08:22:50 INFO zookeeper.ClientCnxn: Server connection successful
Build timed out. Aborting
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 10/01/05 08:23:05 DEBUG hdfs.DFSClient: Wait for lease checker to terminate
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1060
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1060/changes>
Changes:
[stack] HBASE-1996 Configure scanner buffer in bytes instead of number of rows
------------------------------------------
[...truncated 123496 lines...]
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:12:05 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:12:07 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:12:07 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47786 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:12:07 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:13:07 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@908f05
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:13:08 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:13:08 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54509 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:13:08 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:14:08 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@640f1a
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:14:08 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:14:10 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:14:10 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54516 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:14:10 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:15:10 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@3457f1
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:15:12 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:15:12 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54524 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:15:12 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:15:51 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/05 01:16:12 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@d9c921
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:16:12 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:16:13 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:16:13 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54531 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:16:13 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:17:13 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@15ea69f
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:17:15 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:17:15 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54540 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:17:15 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:18:15 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1fee2db
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:18:15 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:18:16 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:18:16 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:43578 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:18:16 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:19:16 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@d8f317
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:19:18 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:19:18 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:43585 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:19:18 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:20:18 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@a40787
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:20:18 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:20:19 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:20:19 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:43593 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:20:19 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:20:51 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/05 01:21:19 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@a46637
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:21:21 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:21:21 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:43601 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:21:21 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:22:21 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@5bc8c9
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:22:21 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/05 01:22:23 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:22:23 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:49996 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:22:23 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/05 01:23:23 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1b030d8
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/05 01:23:24 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/05 01:23:24 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:50004 remote=localhost/127.0.0.1:21810]
[junit] 10/01/05 01:23:24 INFO zookeeper.ClientCnxn: Server connection successful
Build timed out. Aborting
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 10/01/05 01:23:35 DEBUG hdfs.DFSClient: Wait for lease checker to terminate
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1059
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1059/changes>
Changes:
[stack] HBASE-2068 MetricsRate is missing registry parameter
------------------------------------------
[...truncated 125054 lines...]
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:11:07 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:11:07 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:35537 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:11:07 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:12:07 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1d1358f
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:12:07 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:12:08 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:12:08 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:35545 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:12:08 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:13:08 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1fe8714
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:13:09 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:13:09 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47998 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:13:09 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:14:09 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@5795ce
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:14:09 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:14:11 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:14:11 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48005 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:14:11 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:15:11 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@966110
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:15:12 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:15:12 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48012 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:15:12 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:15:49 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/04 23:16:12 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@97263f
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:16:12 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:16:13 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:16:13 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48020 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:16:13 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:17:13 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1e3d80c
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:17:14 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:17:14 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48027 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:17:14 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:18:14 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@12a585c
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:18:15 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:18:16 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:18:16 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59546 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:18:16 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:19:16 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@9e53ed
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:19:17 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:19:17 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59554 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:19:17 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:20:17 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@123b9c1
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:20:17 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:20:19 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:20:19 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59562 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:20:19 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:20:49 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/04 23:21:19 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@ea5d87
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:21:21 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:21:21 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59570 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:21:21 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 23:22:21 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1bf011e
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 23:22:21 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 23:22:22 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 23:22:22 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:58277 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 23:22:22 INFO zookeeper.ClientCnxn: Server connection successful
Build timed out. Aborting
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 10/01/04 23:22:55 DEBUG hdfs.DFSClient: Wait for lease checker to terminate
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1058
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1058/changes>
Changes:
[stack] HBASE-2086 Job(configuration,String) deprecated
------------------------------------------
[...truncated 123919 lines...]
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:10:24 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:10:24 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:49736 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:10:24 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:11:22 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/04 03:11:24 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@11dfada
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:11:25 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:11:25 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:49743 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:11:25 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:12:25 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1cfe174
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:12:25 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:12:26 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:12:26 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38527 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:12:26 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:13:26 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@c2480b
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:13:28 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:13:28 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38536 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:13:28 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:14:28 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@db81f3
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:14:28 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:14:29 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:14:29 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38544 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:14:29 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:15:29 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@340c9c
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:15:31 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:15:31 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38553 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:15:31 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:16:22 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/04 03:16:31 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1a5ba75
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:16:31 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:16:32 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:16:32 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38560 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:16:32 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:17:32 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@c0267a
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:17:34 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:17:34 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39456 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:17:34 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:18:34 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1c8dfe6
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:18:34 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:18:35 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:18:35 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39469 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:18:35 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:19:35 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@f536e8
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:19:37 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:19:37 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39478 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:19:37 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:20:37 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@149453c
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:20:37 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/04 03:20:39 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:20:39 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39485 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:20:39 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/04 03:21:22 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/04 03:21:39 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1a17727
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/04 03:21:40 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/04 03:21:40 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:39495 remote=localhost/127.0.0.1:21810]
[junit] 10/01/04 03:21:40 INFO zookeeper.ClientCnxn: Server connection successful
Build timed out. Aborting
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 10/01/04 03:22:35 DEBUG hdfs.DFSClient: Wait for lease checker to terminate
[junit] 10/01/04 03:22:35 DEBUG hdfs.DFSClient: LeaseChecker@DFSClient[clientName=DFSClient_671053609, ugi=hudson,hudson]: java.lang.Throwable: for testing
[junit] at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.toString(DFSClient.java:1261)
[junit] at java.lang.String.valueOf(String.java:2827)
[junit] at java.lang.StringBuilder.append(StringBuilder.java:115)
[junit] at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.run(DFSClient.java:1250)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit] is interrupted.
[junit] java.lang.InterruptedException: sleep interrupted
[junit] at java.lang.Thread.sleep(Native Method)
[junit] at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.run(DFSClient.java:1247)
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1057
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1057/changes>
Changes:
[stack] HBASE-2052 Upper bound of outstanding WALs can be overrun
------------------------------------------
[...truncated 124769 lines...]
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:10:56 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:10:56 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:58904 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:10:56 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:11:56 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@10a5314
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:11:56 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:11:57 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:11:57 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:58911 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:11:57 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:12:57 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1e3d24a
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:12:59 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:12:59 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47573 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:12:59 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:13:59 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@f0f6ac
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:13:59 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:14:00 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:14:00 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47581 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:14:00 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:15:00 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@fb7ac7
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:15:02 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:15:02 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47589 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:15:02 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:15:34 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/03 06:16:02 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@14ac54
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:16:02 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:16:03 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:16:03 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47596 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:16:03 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:17:03 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1178281
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:17:05 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:17:05 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:47604 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:17:05 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:18:05 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@15651df
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:18:05 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:18:07 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:18:07 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:36309 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:18:07 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:19:07 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@d704f0
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:19:08 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:19:08 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:36316 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:19:08 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:20:08 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@1847a42
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:20:08 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:20:10 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:20:10 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:36325 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:20:10 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:20:34 DEBUG namenode.FSNamesystem: PendingReplicationMonitor checking Q
[junit] 10/01/03 06:21:10 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@183c3a1
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:21:12 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:21:12 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:36333 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:21:12 INFO zookeeper.ClientCnxn: Server connection successful
[junit] 10/01/03 06:22:12 WARN zookeeper.ClientCnxn: Exception closing session 0x0 to sun.nio.ch.SelectionKeyImpl@151e135
[junit] java.io.IOException: TIMED OUT
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:906)
[junit] 10/01/03 06:22:12 WARN zookeeper.ZooKeeperWrapper: Failed to create /hbase -- check quorum servers, currently=localhost:21810
[junit] org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /hbase
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:90)
[junit] at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit] at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeperWrapper.java:399)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(ZooKeeperWrapper.java:422)
[junit] at org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(ZooKeeperWrapper.java:510)
[junit] at org.apache.hadoop.hbase.master.ZKMasterAddressWatcher.writeAddressToZooKeeper(ZKMasterAddressWatcher.java:111)
[junit] at org.apache.hadoop.hbase.master.HMaster.<init>(HMaster.java:191)
[junit] at org.apache.hadoop.hbase.LocalHBaseCluster.<init>(LocalHBaseCluster.java:93)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.init(MiniHBaseCluster.java:63)
[junit] at org.apache.hadoop.hbase.MiniHBaseCluster.<init>(MiniHBaseCluster.java:55)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startHBase(MiniClusterTestCase.java:130)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.startMiniCluster(MiniClusterTestCase.java:193)
[junit] at org.apache.hadoop.hbase.stargate.MiniClusterTestCase.setUp(MiniClusterTestCase.java:229)
[junit] at junit.framework.TestCase.runBare(TestCase.java:132)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:743)
[junit] 10/01/03 06:22:13 INFO zookeeper.ClientCnxn: Attempting connection to server localhost/127.0.0.1:21810
[junit] 10/01/03 06:22:13 INFO zookeeper.ClientCnxn: Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:36342 remote=localhost/127.0.0.1:21810]
[junit] 10/01/03 06:22:13 INFO zookeeper.ClientCnxn: Server connection successful
Build timed out. Aborting
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 10/01/03 06:22:33 DEBUG hdfs.DFSClient: Wait for lease checker to terminate
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1056
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1056/changes>
Changes:
[stack] HBASE-2085 StringBuffer -> StringBuilder - conversion of references as necessary
------------------------------------------
[...truncated 120436 lines...]
[junit] 2009-12-31 23:50:16,193 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 23:50:16,193 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 23:50:16,330 WARN [main] conf.Configuration(326): slave.host.name is deprecated. Instead, use mapreduce.tasktracker.host.name
[junit] 2009-12-31 23:50:16,886 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 23:50:16,887 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 23:50:16,887 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 23:50:16,888 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 23:50:16,889 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 23:50:16,889 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 23:50:16,889 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 23:50:16,890 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 23:50:16.936::INFO: Logging to STDERR via org.mortbay.log.StdErrLog
[junit] 2009-12-31 23:50:17.026::INFO: jetty-6.1.14
[junit] 2009-12-31 23:50:17.054::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/hdfs> to /tmp/Jetty_localhost_49762_hdfs____.ag9cjs/webapp
[junit] 2009-12-31 23:50:17.446::INFO: Started SelectChannelConnector@localhost:49762
[junit] Starting DataNode 0 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2>
[junit] 2009-12-31 23:50:17.971::INFO: jetty-6.1.14
[junit] 2009-12-31 23:50:17.976::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_47267_datanode____.9789ah/webapp
[junit] 2009-12-31 23:50:18.135::INFO: Started SelectChannelConnector@localhost:47267
[junit] Starting DataNode 1 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4>
[junit] 2009-12-31 23:50:18.669::INFO: jetty-6.1.14
[junit] 2009-12-31 23:50:18.675::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_41027_datanode____p1e85b/webapp
[junit] 2009-12-31 23:50:18.807::INFO: Started SelectChannelConnector@localhost:41027
[junit] 2009-12-31 23:50:18,879 WARN [main] conf.Configuration(326): mapred.task.id is deprecated. Instead, use mapreduce.task.attempt.id
[junit] fs=DFS[DFSClient[clientName=DFSClient_1717527278, ugi=hudson,hudson]]
[junit] 2009-12-31 23:50:19,063 DEBUG [main] util.FSUtils(213): Created version file at hdfs://localhost:54543/user/hudson set its version at:7
[junit] 2009-12-31 23:50:19,111 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:19,132 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:19,133 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:19,133 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:19,134 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:19,135 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:19,167 INFO [main] wal.HLog(352): New hlog /user/hudson/-ROOT-/70236052/.logs/hlog.dat.1262303419112
[junit] 2009-12-31 23:50:19,170 DEBUG [main] regionserver.HRegion(266): Opening region -ROOT-,,0, encoded=70236052
[junit] 2009-12-31 23:50:19,239 INFO [main] regionserver.HRegion(344): region -ROOT-,,0/70236052 available; sequence id is 0
[junit] 2009-12-31 23:50:19,270 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:19,287 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:19,288 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:19,288 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:19,289 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:19,290 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:19,298 INFO [main] wal.HLog(352): New hlog /user/hudson/.META./1028785192/.logs/hlog.dat.1262303419271
[junit] 2009-12-31 23:50:19,299 DEBUG [main] regionserver.HRegion(266): Opening region .META.,,1, encoded=1028785192
[junit] 2009-12-31 23:50:20,409 INFO [main] regionserver.HRegion(344): region .META.,,1/1028785192 available; sequence id is 0
[junit] 2009-12-31 23:50:20,440 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:20,456 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:20,457 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:20,458 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:20,458 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:20,459 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:20,469 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/2128253054/.logs/hlog.dat.1262303420441
[junit] 2009-12-31 23:50:20,470 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0200,1262303415966, encoded=2128253054
[junit] 2009-12-31 23:50:20,564 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0200,1262303415966/2128253054 available; sequence id is 0
[junit] 2009-12-31 23:50:20,595 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:20,611 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:20,612 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:20,613 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:20,614 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:20,614 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:20,624 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/204993210/.logs/hlog.dat.1262303420596
[junit] 2009-12-31 23:50:20,625 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0250,1262303415966, encoded=204993210
[junit] 2009-12-31 23:50:20,683 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0250,1262303415966/204993210 available; sequence id is 0
[junit] 2009-12-31 23:50:20,715 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:20,730 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:20,731 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:20,732 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:20,732 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:20,733 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:20,744 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/336973094/.logs/hlog.dat.1262303420715
[junit] 2009-12-31 23:50:20,745 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0100,1262303415966, encoded=336973094
[junit] 2009-12-31 23:50:20,947 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0100,1262303415966/336973094 available; sequence id is 0
[junit] 2009-12-31 23:50:20,979 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:20,990 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:20,990 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:20,991 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:20,991 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:20,992 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:21,011 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1467193547/.logs/hlog.dat.1262303420979
[junit] 2009-12-31 23:50:21,012 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0500,1262303415966, encoded=1467193547
[junit] 2009-12-31 23:50:21,071 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0500,1262303415966/1467193547 available; sequence id is 0
[junit] 2009-12-31 23:50:21,158 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:21,169 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:21,169 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:21,170 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:21,170 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:21,171 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:21,191 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1773357388/.logs/hlog.dat.1262303421159
[junit] 2009-12-31 23:50:21,191 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,,1262303415966, encoded=1773357388
[junit] 2009-12-31 23:50:21,254 INFO [main] regionserver.HRegion(344): region TestMergeTool,,1262303415966/1773357388 available; sequence id is 0
[junit] 2009-12-31 23:50:21,256 DEBUG [main] regionserver.HRegion(455): Closing .META.,,1: compactions & flushes disabled
[junit] 2009-12-31 23:50:21,256 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on .META.,,1
[junit] 2009-12-31 23:50:21,256 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region .META.,,1
[junit] 2009-12-31 23:50:21,257 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region .META.,,1. Current region memstore size 2.2k
[junit] 2009-12-31 23:50:22,352 INFO [main] regionserver.StoreFile(241): Allocating LruBlockCache with maximum size 98.6m
[junit] 2009-12-31 23:50:22,371 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/.META./1028785192/info/7245132711919005431, entries=5, sequenceid=6, memsize=2.2k, filesize=2.2k to .META.,,1
[junit] 2009-12-31 23:50:22,372 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~2.2k for region .META.,,1 in 1116ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 23:50:22,372 DEBUG [main] regionserver.Store(482): closed historian
[junit] 2009-12-31 23:50:22,373 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 23:50:22,373 INFO [main] regionserver.HRegion(491): Closed .META.,,1
[junit] 2009-12-31 23:50:22,373 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:22,374 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:22,374 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/.META./1028785192/.logs
[junit] 2009-12-31 23:50:22,410 DEBUG [main] regionserver.HRegion(455): Closing -ROOT-,,0: compactions & flushes disabled
[junit] 2009-12-31 23:50:22,410 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on -ROOT-,,0
[junit] 2009-12-31 23:50:22,410 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region -ROOT-,,0
[junit] 2009-12-31 23:50:22,411 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region -ROOT-,,0. Current region memstore size 544
[junit] 2009-12-31 23:50:22,466 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/-ROOT-/70236052/info/7891399691675102546, entries=1, sequenceid=2, memsize=544, filesize=809 to -ROOT-,,0
[junit] 2009-12-31 23:50:22,467 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~544 for region -ROOT-,,0 in 56ms, sequence id=2, compaction requested=false
[junit] 2009-12-31 23:50:22,467 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 23:50:22,468 INFO [main] regionserver.HRegion(491): Closed -ROOT-,,0
[junit] 2009-12-31 23:50:22,468 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:22,468 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:22,468 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/-ROOT-/70236052/.logs
[junit] 2009-12-31 23:50:22,648 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0200,1262303415966: compactions & flushes disabled
[junit] 2009-12-31 23:50:22,649 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0200,1262303415966
[junit] 2009-12-31 23:50:22,649 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0200,1262303415966
[junit] 2009-12-31 23:50:22,649 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0200,1262303415966. Current region memstore size 256
[junit] 2009-12-31 23:50:22,701 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/TestMergeTool/2128253054/contents/1615765643760603361, entries=2, sequenceid=3, memsize=256, filesize=425 to TestMergeTool,row_0200,1262303415966
[junit] 2009-12-31 23:50:22,702 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~256 for region TestMergeTool,row_0200,1262303415966 in 53ms, sequence id=3, compaction requested=false
[junit] 2009-12-31 23:50:22,702 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 23:50:22,702 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0200,1262303415966
[junit] 2009-12-31 23:50:22,703 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:22,703 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:22,703 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/TestMergeTool/2128253054/.logs
[junit] 2009-12-31 23:50:22,749 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0250,1262303415966: compactions & flushes disabled
[junit] 2009-12-31 23:50:22,750 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0250,1262303415966
[junit] 2009-12-31 23:50:22,750 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0250,1262303415966
[junit] 2009-12-31 23:50:22,759 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0250,1262303415966. Current region memstore size 376
[junit] 2009-12-31 23:50:22,813 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/TestMergeTool/204993210/contents/163225908231840503, entries=3, sequenceid=4, memsize=376, filesize=469 to TestMergeTool,row_0250,1262303415966
[junit] 2009-12-31 23:50:22,813 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~376 for region TestMergeTool,row_0250,1262303415966 in 54ms, sequence id=4, compaction requested=false
[junit] 2009-12-31 23:50:22,814 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 23:50:22,814 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0250,1262303415966
[junit] 2009-12-31 23:50:22,814 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:22,815 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:22,815 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/TestMergeTool/204993210/.logs
[junit] 2009-12-31 23:50:22,861 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0100,1262303415966: compactions & flushes disabled
[junit] 2009-12-31 23:50:22,861 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0100,1262303415966
[junit] 2009-12-31 23:50:22,861 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0100,1262303415966
[junit] 2009-12-31 23:50:22,862 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0100,1262303415966. Current region memstore size 256
[junit] 2009-12-31 23:50:22,920 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/TestMergeTool/336973094/contents/3497765215445117051, entries=2, sequenceid=5, memsize=256, filesize=425 to TestMergeTool,row_0100,1262303415966
[junit] 2009-12-31 23:50:22,921 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~256 for region TestMergeTool,row_0100,1262303415966 in 59ms, sequence id=5, compaction requested=false
[junit] 2009-12-31 23:50:22,921 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 23:50:22,921 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0100,1262303415966
[junit] 2009-12-31 23:50:22,921 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:22,922 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:22,922 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/TestMergeTool/336973094/.logs
[junit] 2009-12-31 23:50:22,965 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0500,1262303415966: compactions & flushes disabled
[junit] 2009-12-31 23:50:22,965 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0500,1262303415966
[junit] 2009-12-31 23:50:22,965 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0500,1262303415966
[junit] 2009-12-31 23:50:22,966 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0500,1262303415966. Current region memstore size 384
[junit] 2009-12-31 23:50:23,016 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/TestMergeTool/1467193547/contents/5726544975273768741, entries=3, sequenceid=6, memsize=384, filesize=471 to TestMergeTool,row_0500,1262303415966
[junit] 2009-12-31 23:50:23,016 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~384 for region TestMergeTool,row_0500,1262303415966 in 50ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 23:50:23,017 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 23:50:23,017 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0500,1262303415966
[junit] 2009-12-31 23:50:23,017 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:23,017 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:23,018 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/TestMergeTool/1467193547/.logs
[junit] 2009-12-31 23:50:23,069 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,,1262303415966: compactions & flushes disabled
[junit] 2009-12-31 23:50:23,069 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,,1262303415966
[junit] 2009-12-31 23:50:23,069 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,,1262303415966
[junit] 2009-12-31 23:50:23,069 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,,1262303415966. Current region memstore size 256
[junit] 2009-12-31 23:50:23,119 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:54543/user/hudson/TestMergeTool/1773357388/contents/6695332702588674341, entries=2, sequenceid=7, memsize=256, filesize=425 to TestMergeTool,,1262303415966
[junit] 2009-12-31 23:50:23,120 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~256 for region TestMergeTool,,1262303415966 in 51ms, sequence id=7, compaction requested=false
[junit] 2009-12-31 23:50:23,120 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 23:50:23,120 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,,1262303415966
[junit] 2009-12-31 23:50:23,121 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:23,121 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:23,121 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:54543/user/hudson/TestMergeTool/1773357388/.logs
[junit] 2009-12-31 23:50:23,167 INFO [main] util.TestMergeTool(250): Creating log /tmp/.logs_1262303423167
[junit] 2009-12-31 23:50:23,183 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 23:50:23,193 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:23,193 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:23,194 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:23,194 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:23,194 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 23:50:23,219 INFO [main] wal.HLog(352): New hlog /tmp/.logs_1262303423167/hlog.dat.1262303423184
[junit] 2009-12-31 23:50:23,222 INFO [main] util.TestMergeTool(174): merging regions 0 and 1
[junit] fs2=hdfs://localhost:54543
[junit] 2009-12-31 23:50:23,228 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 23:50:23,228 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 23:50:23,229 INFO [main] util.Merge(81): Verifying that file system is available...
[junit] 2009-12-31 23:50:23,230 INFO [main] util.Merge(90): Verifying that HBase is not running...
[junit] 2009-12-31 23:50:23,245 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 23:50:23,246 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 23:50:23,246 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 23:50:23,246 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 23:50:23,398 DEBUG [main] zookeeper.ZooKeeperWrapper(392): Read ZNode /hbase/master got 67.195.138.9:60000
[junit] 2009-12-31 23:50:23,422 FATAL [main] util.Merge(93): HBase cluster must be off-line.
[junit] 2009-12-31 23:50:23,422 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 23:50:23,423 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 23:50:23,423 DEBUG [main] wal.HLog(564): closing hlog writer in /tmp/.logs_1262303423167
[junit] 2009-12-31 23:50:23,498 INFO [main] hbase.HBaseTestCase(627): Shutting down Mini DFS
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 1
[junit] 2009-12-31 23:50:23,601 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@687ea9] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:38816, storageID=DS-485769301-67.195.138.9-38816-1262303418811, infoPort=41027, ipcPort=48476):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] Shutting down DataNode 0
[junit] 2009-12-31 23:50:23,705 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@5a2eaa] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:59876, storageID=DS-427832690-67.195.138.9-59876-1262303418140, infoPort=47267, ipcPort=52993):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2009-12-31 23:50:23,835 WARN [org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor@1e1be92] namenode.DecommissionManager$Monitor(67): Monitor interrupted: java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 23:50:23,836 WARN [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@1bc16f0] namenode.FSNamesystem$ReplicationMonitor(2326): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 23:50:23,865 INFO [main] hbase.HBaseTestCase(638): Shutting down FileSystem
[junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 8.075 sec
[junit] 2009-12-31 23:50:24,259 DEBUG [HCM.shutdownHook] zookeeper.ZooKeeperWrapper(632): Closed connection with ZooKeeper
[junit] Test org.apache.hadoop.hbase.util.TestMergeTool FAILED
[junit] Running org.apache.hadoop.hbase.util.TestRootPath
[junit] 2009-12-31 23:50:24,633 INFO [main] util.TestRootPath(60): Got expected exception when checking invalid path:
[junit] java.io.IOException: Root directory does not have a scheme
[junit] at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSUtils.java:228)
[junit] at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(TestRootPath.java:56)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at junit.framework.TestCase.runTest(TestCase.java:168)
[junit] at junit.framework.TestCase.runBare(TestCase.java:134)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:766)
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.081 sec
BUILD FAILED
<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml>:504: Tests failed!
Total time: 28 minutes 7 seconds
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure
Build failed in Hudson: HBase-Patch #1055
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1055/changes>
Changes:
[apurtell] HBASE-2084 [EC2] JAVA_HOME handling broken
[apurtell] increase region server heap size to 2000m default
[stack] HBASE-2036 Use Configuration instead of HBaseConfiguration
------------------------------------------
[...truncated 123830 lines...]
[junit] 2009-12-31 21:49:25,873 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 21:49:25,873 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 21:49:26,013 WARN [main] conf.Configuration(326): slave.host.name is deprecated. Instead, use mapreduce.tasktracker.host.name
[junit] 2009-12-31 21:49:26,568 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 21:49:26,569 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 21:49:26,569 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 21:49:26,570 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 21:49:26,571 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name1>
[junit] 2009-12-31 21:49:26,572 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 21:49:26,572 WARN [main] namenode.FSNamesystem(348): Scheme is undefined for <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/name2>
[junit] 2009-12-31 21:49:26,572 WARN [main] namenode.FSNamesystem(349): Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 21:49:26.639::INFO: Logging to STDERR via org.mortbay.log.StdErrLog
[junit] 2009-12-31 21:49:26.691::INFO: jetty-6.1.14
[junit] 2009-12-31 21:49:26.761::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/hdfs> to /tmp/Jetty_localhost_47223_hdfs____.p30h52/webapp
[junit] 2009-12-31 21:49:27.270::INFO: Started SelectChannelConnector@localhost:47223
[junit] Starting DataNode 0 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data1,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data2>
[junit] 2009-12-31 21:49:27.770::INFO: jetty-6.1.14
[junit] 2009-12-31 21:49:27.776::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_57821_datanode____c8lh4s/webapp
[junit] 2009-12-31 21:49:27.940::INFO: Started SelectChannelConnector@localhost:57821
[junit] Starting DataNode 1 with dfs.data.dir: <http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build/test/data/dfs/data/data3,/home/hudson/hudson-slave/workspace/HBase-Patch/trunk/build/test/data/dfs/data/data4>
[junit] 2009-12-31 21:49:28.404::INFO: jetty-6.1.14
[junit] 2009-12-31 21:49:28.409::INFO: Extract jar:<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/lib/hadoop-hdfs-0.21.0-dev-r836012.jar!/webapps/datanode> to /tmp/Jetty_localhost_58486_datanode____.saroiy/webapp
[junit] 2009-12-31 21:49:28.536::INFO: Started SelectChannelConnector@localhost:58486
[junit] 2009-12-31 21:49:28,619 WARN [main] conf.Configuration(326): mapred.task.id is deprecated. Instead, use mapreduce.task.attempt.id
[junit] fs=DFS[DFSClient[clientName=DFSClient_1079168929, ugi=hudson,hudson]]
[junit] 2009-12-31 21:49:28,807 DEBUG [main] util.FSUtils(213): Created version file at hdfs://localhost:48781/user/hudson set its version at:7
[junit] 2009-12-31 21:49:28,843 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:28,863 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:28,863 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:28,864 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:28,864 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:28,865 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:28,894 INFO [main] wal.HLog(352): New hlog /user/hudson/-ROOT-/70236052/.logs/hlog.dat.1262296168843
[junit] 2009-12-31 21:49:28,896 DEBUG [main] regionserver.HRegion(266): Opening region -ROOT-,,0, encoded=70236052
[junit] 2009-12-31 21:49:28,951 INFO [main] regionserver.HRegion(344): region -ROOT-,,0/70236052 available; sequence id is 0
[junit] 2009-12-31 21:49:28,974 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:28,992 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:28,992 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:28,993 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:28,993 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:28,994 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,002 INFO [main] wal.HLog(352): New hlog /user/hudson/.META./1028785192/.logs/hlog.dat.1262296168974
[junit] 2009-12-31 21:49:29,003 DEBUG [main] regionserver.HRegion(266): Opening region .META.,,1, encoded=1028785192
[junit] 2009-12-31 21:49:29,057 INFO [main] regionserver.HRegion(344): region .META.,,1/1028785192 available; sequence id is 0
[junit] 2009-12-31 21:49:29,077 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:29,093 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:29,094 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:29,094 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:29,095 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:29,095 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,106 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1426858884/.logs/hlog.dat.1262296169078
[junit] 2009-12-31 21:49:29,106 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0200,1262296165673, encoded=1426858884
[junit] 2009-12-31 21:49:29,145 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0200,1262296165673/1426858884 available; sequence id is 0
[junit] 2009-12-31 21:49:29,165 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:29,181 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:29,181 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:29,182 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:29,182 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:29,183 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,198 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1300191893/.logs/hlog.dat.1262296169165
[junit] 2009-12-31 21:49:29,199 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0250,1262296165674, encoded=1300191893
[junit] 2009-12-31 21:49:29,237 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0250,1262296165674/1300191893 available; sequence id is 0
[junit] 2009-12-31 21:49:29,256 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:29,272 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:29,272 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:29,273 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:29,273 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:29,274 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,285 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/1473006481/.logs/hlog.dat.1262296169257
[junit] 2009-12-31 21:49:29,285 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0100,1262296165674, encoded=1473006481
[junit] 2009-12-31 21:49:29,420 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0100,1262296165674/1473006481 available; sequence id is 0
[junit] 2009-12-31 21:49:29,456 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:29,467 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:29,467 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:29,467 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:29,468 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:29,468 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,476 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/741810422/.logs/hlog.dat.1262296169456
[junit] 2009-12-31 21:49:29,476 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,row_0500,1262296165674, encoded=741810422
[junit] 2009-12-31 21:49:29,547 INFO [main] regionserver.HRegion(344): region TestMergeTool,row_0500,1262296165674/741810422 available; sequence id is 0
[junit] 2009-12-31 21:49:29,579 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:29,590 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:29,590 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:29,590 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:29,591 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:29,591 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:29,599 INFO [main] wal.HLog(352): New hlog /user/hudson/TestMergeTool/537076701/.logs/hlog.dat.1262296169579
[junit] 2009-12-31 21:49:29,600 DEBUG [main] regionserver.HRegion(266): Opening region TestMergeTool,,1262296165674, encoded=537076701
[junit] 2009-12-31 21:49:29,663 INFO [main] regionserver.HRegion(344): region TestMergeTool,,1262296165674/537076701 available; sequence id is 0
[junit] 2009-12-31 21:49:29,665 DEBUG [main] regionserver.HRegion(455): Closing .META.,,1: compactions & flushes disabled
[junit] 2009-12-31 21:49:29,665 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on .META.,,1
[junit] 2009-12-31 21:49:29,665 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region .META.,,1
[junit] 2009-12-31 21:49:29,666 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region .META.,,1. Current region memstore size 2.2k
[junit] 2009-12-31 21:49:29,788 INFO [main] regionserver.StoreFile(241): Allocating LruBlockCache with maximum size 98.6m
[junit] 2009-12-31 21:49:29,806 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/.META./1028785192/info/5792011100566435481, entries=5, sequenceid=6, memsize=2.2k, filesize=2.2k to .META.,,1
[junit] 2009-12-31 21:49:29,806 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~2.2k for region .META.,,1 in 141ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 21:49:29,807 DEBUG [main] regionserver.Store(482): closed historian
[junit] 2009-12-31 21:49:29,807 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 21:49:29,807 INFO [main] regionserver.HRegion(491): Closed .META.,,1
[junit] 2009-12-31 21:49:29,808 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:29,808 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:29,808 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/.META./1028785192/.logs
[junit] 2009-12-31 21:49:30,888 DEBUG [main] regionserver.HRegion(455): Closing -ROOT-,,0: compactions & flushes disabled
[junit] 2009-12-31 21:49:30,889 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on -ROOT-,,0
[junit] 2009-12-31 21:49:30,889 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region -ROOT-,,0
[junit] 2009-12-31 21:49:30,889 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region -ROOT-,,0. Current region memstore size 544
[junit] 2009-12-31 21:49:30,957 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/-ROOT-/70236052/info/1373420627075787595, entries=1, sequenceid=2, memsize=544, filesize=809 to -ROOT-,,0
[junit] 2009-12-31 21:49:30,957 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~544 for region -ROOT-,,0 in 68ms, sequence id=2, compaction requested=false
[junit] 2009-12-31 21:49:30,958 DEBUG [main] regionserver.Store(482): closed info
[junit] 2009-12-31 21:49:30,958 INFO [main] regionserver.HRegion(491): Closed -ROOT-,,0
[junit] 2009-12-31 21:49:30,958 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:30,958 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:30,959 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/-ROOT-/70236052/.logs
[junit] 2009-12-31 21:49:32,014 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0200,1262296165673: compactions & flushes disabled
[junit] 2009-12-31 21:49:32,014 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0200,1262296165673
[junit] 2009-12-31 21:49:32,015 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0200,1262296165673
[junit] 2009-12-31 21:49:32,015 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0200,1262296165673. Current region memstore size 256
[junit] 2009-12-31 21:49:32,199 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/TestMergeTool/1426858884/contents/772025260913997483, entries=2, sequenceid=3, memsize=256, filesize=425 to TestMergeTool,row_0200,1262296165673
[junit] 2009-12-31 21:49:32,199 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~256 for region TestMergeTool,row_0200,1262296165673 in 184ms, sequence id=3, compaction requested=false
[junit] 2009-12-31 21:49:32,200 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 21:49:32,200 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0200,1262296165673
[junit] 2009-12-31 21:49:32,201 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:32,201 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:32,201 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/TestMergeTool/1426858884/.logs
[junit] 2009-12-31 21:49:32,235 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0250,1262296165674: compactions & flushes disabled
[junit] 2009-12-31 21:49:32,235 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0250,1262296165674
[junit] 2009-12-31 21:49:32,235 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0250,1262296165674
[junit] 2009-12-31 21:49:32,235 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0250,1262296165674. Current region memstore size 376
[junit] 2009-12-31 21:49:32,277 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/TestMergeTool/1300191893/contents/8590966930996355414, entries=3, sequenceid=4, memsize=376, filesize=469 to TestMergeTool,row_0250,1262296165674
[junit] 2009-12-31 21:49:32,278 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~376 for region TestMergeTool,row_0250,1262296165674 in 43ms, sequence id=4, compaction requested=false
[junit] 2009-12-31 21:49:32,278 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 21:49:32,279 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0250,1262296165674
[junit] 2009-12-31 21:49:32,279 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:32,279 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:32,280 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/TestMergeTool/1300191893/.logs
[junit] 2009-12-31 21:49:33,358 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0100,1262296165674: compactions & flushes disabled
[junit] 2009-12-31 21:49:33,358 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0100,1262296165674
[junit] 2009-12-31 21:49:33,359 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0100,1262296165674
[junit] 2009-12-31 21:49:33,359 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0100,1262296165674. Current region memstore size 384
[junit] 2009-12-31 21:49:33,401 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/TestMergeTool/1473006481/contents/3760940148277035060, entries=3, sequenceid=5, memsize=384, filesize=471 to TestMergeTool,row_0100,1262296165674
[junit] 2009-12-31 21:49:33,401 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~384 for region TestMergeTool,row_0100,1262296165674 in 42ms, sequence id=5, compaction requested=false
[junit] 2009-12-31 21:49:33,402 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 21:49:33,402 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0100,1262296165674
[junit] 2009-12-31 21:49:33,402 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:33,403 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:33,403 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/TestMergeTool/1473006481/.logs
[junit] 2009-12-31 21:49:33,434 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,row_0500,1262296165674: compactions & flushes disabled
[junit] 2009-12-31 21:49:33,434 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,row_0500,1262296165674
[junit] 2009-12-31 21:49:33,434 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,row_0500,1262296165674
[junit] 2009-12-31 21:49:33,434 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,row_0500,1262296165674. Current region memstore size 384
[junit] 2009-12-31 21:49:33,475 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/TestMergeTool/741810422/contents/4392598328220521400, entries=3, sequenceid=6, memsize=384, filesize=471 to TestMergeTool,row_0500,1262296165674
[junit] 2009-12-31 21:49:33,475 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~384 for region TestMergeTool,row_0500,1262296165674 in 41ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 21:49:33,476 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 21:49:33,476 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,row_0500,1262296165674
[junit] 2009-12-31 21:49:33,476 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:33,477 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:33,477 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/TestMergeTool/741810422/.logs
[junit] 2009-12-31 21:49:33,505 DEBUG [main] regionserver.HRegion(455): Closing TestMergeTool,,1262296165674: compactions & flushes disabled
[junit] 2009-12-31 21:49:33,506 DEBUG [main] regionserver.HRegion(472): Updates disabled for region, no outstanding scanners on TestMergeTool,,1262296165674
[junit] 2009-12-31 21:49:33,506 DEBUG [main] regionserver.HRegion(479): No more row locks outstanding on region TestMergeTool,,1262296165674
[junit] 2009-12-31 21:49:33,506 DEBUG [main] regionserver.HRegion(896): Started memstore flush for region TestMergeTool,,1262296165674. Current region memstore size 384
[junit] 2009-12-31 21:49:33,547 DEBUG [main] regionserver.Store(564): Added hdfs://localhost:48781/user/hudson/TestMergeTool/537076701/contents/3330272730114305268, entries=3, sequenceid=7, memsize=384, filesize=471 to TestMergeTool,,1262296165674
[junit] 2009-12-31 21:49:33,547 DEBUG [main] regionserver.HRegion(972): Finished memstore flush of ~384 for region TestMergeTool,,1262296165674 in 41ms, sequence id=7, compaction requested=false
[junit] 2009-12-31 21:49:33,547 DEBUG [main] regionserver.Store(482): closed contents
[junit] 2009-12-31 21:49:33,548 INFO [main] regionserver.HRegion(491): Closed TestMergeTool,,1262296165674
[junit] 2009-12-31 21:49:33,548 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:33,549 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:33,549 DEBUG [main] wal.HLog(564): closing hlog writer in hdfs://localhost:48781/user/hudson/TestMergeTool/537076701/.logs
[junit] 2009-12-31 21:49:33,576 INFO [main] util.TestMergeTool(250): Creating log /tmp/.logs_1262296173576
[junit] 2009-12-31 21:49:33,590 INFO [main] wal.HLog(274): HLog configuration: blocksize=67108864, rollsize=63753420, enabled=true, flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 21:49:33,600 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:33,601 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:33,601 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:33,602 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:33,602 WARN [main] hbase.HBaseConfiguration(59): instantinating HBaseConfiguration() is deprecated. Please use HBaseConfiguration#create(conf) to construct a plain Configuration
[junit] 2009-12-31 21:49:33,612 INFO [main] wal.HLog(352): New hlog /tmp/.logs_1262296173576/hlog.dat.1262296173591
[junit] 2009-12-31 21:49:33,615 INFO [main] util.TestMergeTool(174): merging regions 0 and 1
[junit] fs2=hdfs://localhost:48781
[junit] 2009-12-31 21:49:33,622 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 21:49:33,623 WARN [main] conf.Configuration(616): mapred.used.genericoptionsparser is deprecated. Instead, use mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 21:49:33,623 INFO [main] util.Merge(81): Verifying that file system is available...
[junit] 2009-12-31 21:49:33,625 INFO [main] util.Merge(90): Verifying that HBase is not running...
[junit] 2009-12-31 21:49:33,640 WARN [main] conf.Configuration(616): fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 21:49:33,640 WARN [main] conf.Configuration(616): fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 21:49:33,641 WARN [main] conf.Configuration(616): fs.checkpoint.edits.dir is deprecated. Instead, use dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 21:49:33,641 WARN [main] conf.Configuration(616): fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 21:49:33,790 DEBUG [main] zookeeper.ZooKeeperWrapper(392): Read ZNode /hbase/master got 67.195.138.9:60000
[junit] 2009-12-31 21:49:33,814 FATAL [main] util.Merge(93): HBase cluster must be off-line.
[junit] 2009-12-31 21:49:33,814 DEBUG [main.logSyncer] wal.HLog$LogSyncer(734): main.logSyncerinterrupted while waiting for sync requests
[junit] 2009-12-31 21:49:33,815 INFO [main.logSyncer] wal.HLog$LogSyncer(738): main.logSyncer exiting
[junit] 2009-12-31 21:49:33,815 DEBUG [main] wal.HLog(564): closing hlog writer in /tmp/.logs_1262296173576
[junit] 2009-12-31 21:49:33,853 INFO [main] hbase.HBaseTestCase(627): Shutting down Mini DFS
[junit] Shutting down the Mini HDFS Cluster
[junit] Shutting down DataNode 1
[junit] 2009-12-31 21:49:33,957 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@1c8fb4b] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:52857, storageID=DS-1217547157-67.195.138.9-52857-1262296168539, infoPort=58486, ipcPort=38593):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] Shutting down DataNode 0
[junit] 2009-12-31 21:49:34,061 WARN [org.apache.hadoop.hdfs.server.datanode.DataXceiverServer@1250ff2] datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:34901, storageID=DS-512490309-67.195.138.9-34901-1262296167946, infoPort=57821, ipcPort=38374):DataXceiveServer: java.nio.channels.AsynchronousCloseException
[junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
[junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:152)
[junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
[junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:133)
[junit] at java.lang.Thread.run(Thread.java:619)
[junit]
[junit] 2009-12-31 21:49:34,196 WARN [org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor@112e7f7] namenode.DecommissionManager$Monitor(67): Monitor interrupted: java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 21:49:34,197 WARN [org.apache.hadoop.hdfs.server.namenode.FSNamesystem$ReplicationMonitor@92dcdb] namenode.FSNamesystem$ReplicationMonitor(2326): ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 21:49:34,210 INFO [main] hbase.HBaseTestCase(638): Shutting down FileSystem
[junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 8.713 sec
[junit] 2009-12-31 21:49:34,607 DEBUG [HCM.shutdownHook] zookeeper.ZooKeeperWrapper(632): Closed connection with ZooKeeper
[junit] Test org.apache.hadoop.hbase.util.TestMergeTool FAILED
[junit] Running org.apache.hadoop.hbase.util.TestRootPath
[junit] 2009-12-31 21:49:34,990 INFO [main] util.TestRootPath(60): Got expected exception when checking invalid path:
[junit] java.io.IOException: Root directory does not have a scheme
[junit] at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSUtils.java:228)
[junit] at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(TestRootPath.java:56)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit] at java.lang.reflect.Method.invoke(Method.java:597)
[junit] at junit.framework.TestCase.runTest(TestCase.java:168)
[junit] at junit.framework.TestCase.runBare(TestCase.java:134)
[junit] at junit.framework.TestResult$1.protect(TestResult.java:110)
[junit] at junit.framework.TestResult.runProtected(TestResult.java:128)
[junit] at junit.framework.TestResult.run(TestResult.java:113)
[junit] at junit.framework.TestCase.run(TestCase.java:124)
[junit] at junit.framework.TestSuite.runTest(TestSuite.java:232)
[junit] at junit.framework.TestSuite.run(TestSuite.java:227)
[junit] at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83)
[junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
[junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:766)
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.077 sec
BUILD FAILED
<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml>:504: Tests failed!
Total time: 27 minutes 21 seconds
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Archiving artifacts
Recording test results
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure