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
selectchannelconnec...@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
selectchannelconnec...@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
selectchannelconnec...@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.dataxceiverser...@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.dataxceiverser...@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$moni...@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$replicationmoni...@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
