See <http://hudson.zones.apache.org/hudson/job/HBase-Patch/1053/changes>
Changes:
[apurtell] HBASE-2080 [EC2] Support multivolume local instance storage
[apurtell] HBASE-2082 TableInputFormat is ignoring input scan's stop row setting
[apurtell] HBASE-1956 Export HDFS read and write latency as a metric
[jdcryans] HBASE-2081 Set the retries higher in shell since client pause is
lower
[jdcryans] HBASE-2025 0.20.2 accessed from older client throws
UndeclaredThrowableException; frustrates rolling upgrade
[jdcryans] HBASE-2068 MetricsRate is missing "registry" parameter (Lars George
via JD)
HBASE-2078 Add JMX settings as commented out lines to hbase-env.sh
(Lars George via JD)
------------------------------------------
[...truncated 123079 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.081 sec
[junit] Running org.apache.hadoop.hbase.util.TestMergeTool
[junit] 2009-12-31 13:44:35,890 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 13:44:35,892 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:35,893 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 13:44:35,893 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:35,894 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 13:44:35,894 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:35,894 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 13:44:35,895 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:36,032 WARN [main] conf.Configuration(326):
slave.host.name is deprecated. Instead, use mapreduce.tasktracker.host.name
[junit] 2009-12-31 13:44:36,514 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 13:44:36,515 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:36,515 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 13:44:36,515 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:36,516 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 13:44:36,516 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:36,517 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 13:44:36,517 WARN [main] namenode.FSNamesystem(349):
Please check your file system configuration in hdfs-site.xml
[junit] 2009-12-31 13:44:36.563::INFO: Logging to STDERR via
org.mortbay.log.StdErrLog
[junit] 2009-12-31 13:44:36.615::INFO: jetty-6.1.14
[junit] 2009-12-31 13:44:36.683::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_37804_hdfs____.8u96gu/webapp
[junit] 2009-12-31 13:44:37.078::INFO: Started
selectchannelconnec...@localhost:37804
[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 13:44:37.616::INFO: jetty-6.1.14
[junit] 2009-12-31 13:44:37.621::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_43884_datanode____txsam4/webapp
[junit] 2009-12-31 13:44:37.775::INFO: Started
selectchannelconnec...@localhost:43884
[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 13:44:38.267::INFO: jetty-6.1.14
[junit] 2009-12-31 13:44:38.272::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_44157_datanode____.fww3q/webapp
[junit] 2009-12-31 13:44:38.403::INFO: Started
selectchannelconnec...@localhost:44157
[junit] 2009-12-31 13:44:38,512 WARN [main] conf.Configuration(326):
mapred.task.id is deprecated. Instead, use mapreduce.task.attempt.id
[junit] 2009-12-31 13:44:38,703 DEBUG [main] util.FSUtils(213): Created
version file at hdfs://localhost:42669/user/hudson set its version at:7
[junit] 2009-12-31 13:44:38,739 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:38,784 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:38,785 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:38,785 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:38,786 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:38,818 INFO [main] wal.HLog(352): New hlog
/user/hudson/-ROOT-/70236052/.logs/hlog.dat.1262267078739
[junit] 2009-12-31 13:44:38,820 DEBUG [main] regionserver.HRegion(265):
Opening region -ROOT-,,0, encoded=70236052
[junit] 2009-12-31 13:44:38,871 INFO [main] regionserver.HRegion(343):
region -ROOT-,,0/70236052 available; sequence id is 0
[junit] 2009-12-31 13:44:38,893 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:38,929 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:38,929 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:38,930 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:38,930 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:38,941 INFO [main] wal.HLog(352): New hlog
/user/hudson/.META./1028785192/.logs/hlog.dat.1262267078893
[junit] 2009-12-31 13:44:38,942 DEBUG [main] regionserver.HRegion(265):
Opening region .META.,,1, encoded=1028785192
[junit] 2009-12-31 13:44:38,994 INFO [main] regionserver.HRegion(343):
region .META.,,1/1028785192 available; sequence id is 0
[junit] 2009-12-31 13:44:39,016 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:39,052 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:39,052 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:39,053 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:39,053 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:39,065 INFO [main] wal.HLog(352): New hlog
/user/hudson/TestMergeTool/1270240438/.logs/hlog.dat.1262267079017
[junit] 2009-12-31 13:44:39,065 DEBUG [main] regionserver.HRegion(265):
Opening region TestMergeTool,row_0200,1262267075680, encoded=1270240438
[junit] 2009-12-31 13:44:39,105 INFO [main] regionserver.HRegion(343):
region TestMergeTool,row_0200,1262267075680/1270240438 available; sequence id
is 0
[junit] 2009-12-31 13:44:39,128 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:39,152 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:39,152 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:39,153 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:39,153 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:39,164 INFO [main] wal.HLog(352): New hlog
/user/hudson/TestMergeTool/1540669092/.logs/hlog.dat.1262267079128
[junit] 2009-12-31 13:44:39,165 DEBUG [main] regionserver.HRegion(265):
Opening region TestMergeTool,row_0250,1262267075680, encoded=1540669092
[junit] 2009-12-31 13:44:39,205 INFO [main] regionserver.HRegion(343):
region TestMergeTool,row_0250,1262267075680/1540669092 available; sequence id
is 0
[junit] 2009-12-31 13:44:39,225 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:39,248 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:39,248 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:39,249 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:39,249 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:39,280 INFO [main] wal.HLog(352): New hlog
/user/hudson/TestMergeTool/2041281298/.logs/hlog.dat.1262267079225
[junit] 2009-12-31 13:44:39,281 DEBUG [main] regionserver.HRegion(265):
Opening region TestMergeTool,row_0100,1262267075680, encoded=2041281298
[junit] 2009-12-31 13:44:39,435 INFO [main] regionserver.HRegion(343):
region TestMergeTool,row_0100,1262267075680/2041281298 available; sequence id
is 0
[junit] 2009-12-31 13:44:39,468 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:39,498 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:39,498 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:39,498 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:39,499 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:39,508 INFO [main] wal.HLog(352): New hlog
/user/hudson/TestMergeTool/535040507/.logs/hlog.dat.1262267079468
[junit] 2009-12-31 13:44:39,509 DEBUG [main] regionserver.HRegion(265):
Opening region TestMergeTool,row_0500,1262267075680, encoded=535040507
[junit] 2009-12-31 13:44:39,568 INFO [main] regionserver.HRegion(343):
region TestMergeTool,row_0500,1262267075680/535040507 available; sequence id is 0
[junit] 2009-12-31 13:44:39,596 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:39,617 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:39,617 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:39,617 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:39,618 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:39,627 INFO [main] wal.HLog(352): New hlog
/user/hudson/TestMergeTool/1867269697/.logs/hlog.dat.1262267079596
[junit] 2009-12-31 13:44:39,627 DEBUG [main] regionserver.HRegion(265):
Opening region TestMergeTool,,1262267075680, encoded=1867269697
[junit] 2009-12-31 13:44:39,683 INFO [main] regionserver.HRegion(343):
region TestMergeTool,,1262267075680/1867269697 available; sequence id is 0
[junit] 2009-12-31 13:44:39,685 DEBUG [main] regionserver.HRegion(454):
Closing .META.,,1: compactions & flushes disabled
[junit] 2009-12-31 13:44:39,686 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on .META.,,1
[junit] 2009-12-31 13:44:39,686 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region .META.,,1
[junit] 2009-12-31 13:44:39,687 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region .META.,,1. Current region memstore size 2.2k
[junit] 2009-12-31 13:44:39,768 INFO [main] regionserver.StoreFile(241):
Allocating LruBlockCache with maximum size 98.6m
[junit] 2009-12-31 13:44:39,785 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/.META./1028785192/info/2712813052816593126,
entries=5, sequenceid=6, memsize=2.2k, filesize=2.2k to .META.,,1
[junit] 2009-12-31 13:44:39,786 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~2.2k for region .META.,,1 in 100ms, sequence id=6,
compaction requested=false
[junit] 2009-12-31 13:44:39,786 DEBUG [main] regionserver.Store(482):
closed historian
[junit] 2009-12-31 13:44:39,787 DEBUG [main] regionserver.Store(482):
closed info
[junit] 2009-12-31 13:44:39,787 INFO [main] regionserver.HRegion(490):
Closed .META.,,1
[junit] 2009-12-31 13:44:39,787 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:39,787 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:39,788 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/.META./1028785192/.logs
[junit] 2009-12-31 13:44:39,815 DEBUG [main] regionserver.HRegion(454):
Closing -ROOT-,,0: compactions & flushes disabled
[junit] 2009-12-31 13:44:39,815 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on -ROOT-,,0
[junit] 2009-12-31 13:44:39,815 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region -ROOT-,,0
[junit] 2009-12-31 13:44:39,816 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region -ROOT-,,0. Current region memstore size 544
[junit] 2009-12-31 13:44:39,859 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/-ROOT-/70236052/info/8250125117013337257,
entries=1, sequenceid=2, memsize=544, filesize=809 to -ROOT-,,0
[junit] 2009-12-31 13:44:39,860 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~544 for region -ROOT-,,0 in 44ms, sequence id=2,
compaction requested=false
[junit] 2009-12-31 13:44:39,860 DEBUG [main] regionserver.Store(482):
closed info
[junit] 2009-12-31 13:44:39,861 INFO [main] regionserver.HRegion(490):
Closed -ROOT-,,0
[junit] 2009-12-31 13:44:39,861 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:39,861 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:39,861 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/-ROOT-/70236052/.logs
[junit] 2009-12-31 13:44:39,897 DEBUG [main] regionserver.HRegion(454):
Closing TestMergeTool,row_0200,1262267075680: compactions & flushes disabled
[junit] 2009-12-31 13:44:39,898 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on
TestMergeTool,row_0200,1262267075680
[junit] 2009-12-31 13:44:39,898 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region TestMergeTool,row_0200,1262267075680
[junit] 2009-12-31 13:44:39,898 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region TestMergeTool,row_0200,1262267075680. Current
region memstore size 256
[junit] 2009-12-31 13:44:39,935 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/TestMergeTool/1270240438/contents/3183427156257719929,
entries=2, sequenceid=3, memsize=256, filesize=425 to
TestMergeTool,row_0200,1262267075680
[junit] 2009-12-31 13:44:39,935 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~256 for region TestMergeTool,row_0200,1262267075680
in 37ms, sequence id=3, compaction requested=false
[junit] 2009-12-31 13:44:39,936 DEBUG [main] regionserver.Store(482):
closed contents
[junit] 2009-12-31 13:44:39,959 INFO [main] regionserver.HRegion(490):
Closed TestMergeTool,row_0200,1262267075680
[junit] 2009-12-31 13:44:39,959 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:39,959 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:39,960 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/TestMergeTool/1270240438/.logs
[junit] 2009-12-31 13:44:39,987 DEBUG [main] regionserver.HRegion(454):
Closing TestMergeTool,row_0250,1262267075680: compactions & flushes disabled
[junit] 2009-12-31 13:44:39,987 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on
TestMergeTool,row_0250,1262267075680
[junit] 2009-12-31 13:44:39,987 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region TestMergeTool,row_0250,1262267075680
[junit] 2009-12-31 13:44:39,988 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region TestMergeTool,row_0250,1262267075680. Current
region memstore size 376
[junit] 2009-12-31 13:44:40,030 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/TestMergeTool/1540669092/contents/1242228509982145143,
entries=3, sequenceid=4, memsize=376, filesize=469 to
TestMergeTool,row_0250,1262267075680
[junit] 2009-12-31 13:44:40,031 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~376 for region TestMergeTool,row_0250,1262267075680
in 43ms, sequence id=4, compaction requested=false
[junit] 2009-12-31 13:44:40,031 DEBUG [main] regionserver.Store(482):
closed contents
[junit] 2009-12-31 13:44:40,032 INFO [main] regionserver.HRegion(490):
Closed TestMergeTool,row_0250,1262267075680
[junit] 2009-12-31 13:44:40,032 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:40,032 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:40,032 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/TestMergeTool/1540669092/.logs
[junit] 2009-12-31 13:44:40,184 DEBUG [main] regionserver.HRegion(454):
Closing TestMergeTool,row_0100,1262267075680: compactions & flushes disabled
[junit] 2009-12-31 13:44:40,185 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on
TestMergeTool,row_0100,1262267075680
[junit] 2009-12-31 13:44:40,185 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region TestMergeTool,row_0100,1262267075680
[junit] 2009-12-31 13:44:40,185 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region TestMergeTool,row_0100,1262267075680. Current
region memstore size 384
[junit] 2009-12-31 13:44:40,221 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/TestMergeTool/2041281298/contents/7942374329589073499,
entries=3, sequenceid=5, memsize=384, filesize=471 to
TestMergeTool,row_0100,1262267075680
[junit] 2009-12-31 13:44:40,221 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~384 for region TestMergeTool,row_0100,1262267075680
in 36ms, sequence id=5, compaction requested=false
[junit] 2009-12-31 13:44:40,221 DEBUG [main] regionserver.Store(482):
closed contents
[junit] 2009-12-31 13:44:40,222 INFO [main] regionserver.HRegion(490):
Closed TestMergeTool,row_0100,1262267075680
[junit] 2009-12-31 13:44:40,222 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:40,222 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:40,222 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/TestMergeTool/2041281298/.logs
[junit] 2009-12-31 13:44:40,250 DEBUG [main] regionserver.HRegion(454):
Closing TestMergeTool,row_0500,1262267075680: compactions & flushes disabled
[junit] 2009-12-31 13:44:40,251 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on
TestMergeTool,row_0500,1262267075680
[junit] 2009-12-31 13:44:40,251 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region TestMergeTool,row_0500,1262267075680
[junit] 2009-12-31 13:44:40,251 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region TestMergeTool,row_0500,1262267075680. Current
region memstore size 384
[junit] 2009-12-31 13:44:40,293 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/TestMergeTool/535040507/contents/3739799488334279184,
entries=3, sequenceid=6, memsize=384, filesize=471 to
TestMergeTool,row_0500,1262267075680
[junit] 2009-12-31 13:44:40,294 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~384 for region TestMergeTool,row_0500,1262267075680
in 43ms, sequence id=6, compaction requested=false
[junit] 2009-12-31 13:44:40,294 DEBUG [main] regionserver.Store(482):
closed contents
[junit] 2009-12-31 13:44:40,295 INFO [main] regionserver.HRegion(490):
Closed TestMergeTool,row_0500,1262267075680
[junit] 2009-12-31 13:44:40,295 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:40,295 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:40,295 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/TestMergeTool/535040507/.logs
[junit] 2009-12-31 13:44:40,322 DEBUG [main] regionserver.HRegion(454):
Closing TestMergeTool,,1262267075680: compactions & flushes disabled
[junit] 2009-12-31 13:44:40,322 DEBUG [main] regionserver.HRegion(471):
Updates disabled for region, no outstanding scanners on
TestMergeTool,,1262267075680
[junit] 2009-12-31 13:44:40,323 DEBUG [main] regionserver.HRegion(478): No
more row locks outstanding on region TestMergeTool,,1262267075680
[junit] 2009-12-31 13:44:40,323 DEBUG [main] regionserver.HRegion(895):
Started memstore flush for region TestMergeTool,,1262267075680. Current region
memstore size 384
[junit] 2009-12-31 13:44:40,365 DEBUG [main] regionserver.Store(564): Added
hdfs://localhost:42669/user/hudson/TestMergeTool/1867269697/contents/7193899195548456231,
entries=3, sequenceid=7, memsize=384, filesize=471 to
TestMergeTool,,1262267075680
[junit] 2009-12-31 13:44:40,366 DEBUG [main] regionserver.HRegion(971):
Finished memstore flush of ~384 for region TestMergeTool,,1262267075680 in
43ms, sequence id=7, compaction requested=false
[junit] 2009-12-31 13:44:40,366 DEBUG [main] regionserver.Store(482):
closed contents
[junit] 2009-12-31 13:44:40,366 INFO [main] regionserver.HRegion(490):
Closed TestMergeTool,,1262267075680
[junit] 2009-12-31 13:44:40,366 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:40,367 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:40,367 DEBUG [main] wal.HLog(564): closing hlog
writer in hdfs://localhost:42669/user/hudson/TestMergeTool/1867269697/.logs
[junit] 2009-12-31 13:44:40,397 INFO [main] util.TestMergeTool(248):
Creating log /tmp/.logs_1262267080397
[junit] 2009-12-31 13:44:40,413 INFO [main] wal.HLog(274): HLog
configuration: blocksize=67108864, rollsize=63753420, enabled=true,
flushlogentries=1, optionallogflushinternal=1000ms
[junit] 2009-12-31 13:44:40,432 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:40,433 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:40,433 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:40,434 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:40,444 INFO [main] wal.HLog(352): New hlog
/tmp/.logs_1262267080397/hlog.dat.1262267080413
[junit] 2009-12-31 13:44:40,447 INFO [main] util.TestMergeTool(173):
merging regions 0 and 1
[junit] 2009-12-31 13:44:40,453 WARN [main] conf.Configuration(616):
mapred.used.genericoptionsparser is deprecated. Instead, use
mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 13:44:40,454 WARN [main] conf.Configuration(616):
mapred.used.genericoptionsparser is deprecated. Instead, use
mapreduce.client.genericoptionsparser.used
[junit] 2009-12-31 13:44:40,454 INFO [main] util.Merge(82): Verifying that
file system is available...
[junit] 2009-12-31 13:44:40,455 INFO [main] util.Merge(91): Verifying that
HBase is not running...
[junit] 2009-12-31 13:44:40,479 WARN [main] conf.Configuration(616):
fs.checkpoint.size is deprecated. Instead, use dfs.namenode.checkpoint.size
[junit] 2009-12-31 13:44:40,479 WARN [main] conf.Configuration(616):
fs.checkpoint.dir is deprecated. Instead, use dfs.namenode.checkpoint.dir
[junit] 2009-12-31 13:44:40,479 WARN [main] conf.Configuration(616):
fs.checkpoint.edits.dir is deprecated. Instead, use
dfs.namenode.checkpoint.edits.dir
[junit] 2009-12-31 13:44:40,486 WARN [main] conf.Configuration(616):
fs.checkpoint.period is deprecated. Instead, use dfs.namenode.checkpoint.period
[junit] 2009-12-31 13:44:40,642 DEBUG [main]
zookeeper.ZooKeeperWrapper(392): Read ZNode /hbase/master got 67.195.138.9:60000
[junit] 2009-12-31 13:44:40,666 FATAL [main] util.Merge(94): HBase cluster
must be off-line.
[junit] 2009-12-31 13:44:40,667 DEBUG [main.logSyncer]
wal.HLog$LogSyncer(733): main.logSyncerinterrupted while waiting for sync
requests
[junit] 2009-12-31 13:44:40,667 INFO [main.logSyncer]
wal.HLog$LogSyncer(737): main.logSyncer exiting
[junit] 2009-12-31 13:44:40,667 DEBUG [main] wal.HLog(564): closing hlog
writer in /tmp/.logs_1262267080397
[junit] 2009-12-31 13:44:40,700 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 13:44:40,803 WARN
[org.apache.hadoop.hdfs.server.datanode.dataxceiverser...@a68fd8]
datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:34263,
storageID=DS-1205332108-67.195.138.9-34263-1262267078407, infoPort=44157,
ipcPort=45668):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 13:44:40,907 WARN
[org.apache.hadoop.hdfs.server.datanode.dataxceiverser...@864e43]
datanode.DataXceiverServer(140): DatanodeRegistration(127.0.0.1:49885,
storageID=DS-554594906-67.195.138.9-49885-1262267077780, infoPort=43884,
ipcPort=54668):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 13:44:41,043 WARN
[org.apache.hadoop.hdfs.server.namenode.decommissionmanager$moni...@3a1ec6]
namenode.DecommissionManager$Monitor(67): Monitor interrupted:
java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 13:44:41,044 WARN
[org.apache.hadoop.hdfs.server.namenode.fsnamesystem$replicationmoni...@5eb489]
namenode.FSNamesystem$ReplicationMonitor(2326): ReplicationMonitor thread
received InterruptedException.java.lang.InterruptedException: sleep interrupted
[junit] 2009-12-31 13:44:41,054 INFO [main] hbase.HBaseTestCase(638):
Shutting down FileSystem
[junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 5.552 sec
[junit] 2009-12-31 13:44:41,369 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 13:44:41,738 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.079 sec
BUILD FAILED
<http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml>:504:
Tests failed!
Total time: 28 minutes 27 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
