See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/261/changes
Changes:
[jimk] HADOOP-1937 When the master times out a region server's lease, it is too
aggressive in reclaiming the server's log.
[jimk] HADOOP-1996 TestHStoreFile fails on windows if run multiple times
[dhruba] HADOOP-1961. The -get option to dfs-shell works when a single filename
is specified. (Raghu Angadi via dhruba)
[dhruba] HADOOP-1955. The Namenode tries to not pick the same source Datanode
for
a replication request if the earlier replication request for the same
block and that source Datanode had failed.
(Raghu Angadi via dhruba)
[jimk] HADOOP-1990 Regression test instability affects nightly and patch builds
[dhruba] HADOOP-1695. The SecondaryNamenode waits for the Primary NameNode to
start up. (Dhruba Borthakur)
------------------------------------------
[...truncated 59976 lines...]
[junit] 2007-10-05 11:30:37,785 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:682):
Found 1 region(s) for testCreateDeleteTabletestCreateDeleteTableSglQuote at
address: 140.211.11.75:39992, regioninfo: regionname: .META.,,1, startKey: <>,
tableDesc: {name: .META., families: {info:={name: info, max versions: 1,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}}
[junit] 2007-10-05 11:30:37,786 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT: Creating table... Please wait.
[junit] 2007-10-05 11:30:37,855 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:378):
Shutting down HBase Cluster
[junit] 2007-10-05 11:30:37,946 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:37,947 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:500): Got
regionserver stop message
[junit] 2007-10-05 11:30:37,948 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.Leases.close(Leases.java:108): closing leases
[junit] 2007-10-05 11:30:37,948 INFO
[regionserver/0.0.0.0:39992.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:39992.leaseChecker exiting
[junit] 2007-10-05 11:30:37,949 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.Leases.close(Leases.java:122): leases closed
[junit] 2007-10-05 11:30:37,950 INFO
[regionserver/0.0.0.0:39992.cacheFlusher]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:39992.cacheFlusher exiting
[junit] 2007-10-05 11:30:37,950 INFO
[regionserver/0.0.0.0:39992.logRoller]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:39992.logRoller exiting
[junit] 2007-10-05 11:30:37,950 INFO
[regionserver/0.0.0.0:39992.splitOrCompactChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:39992.splitOrCompactChecker exiting
[junit] 2007-10-05 11:30:37,950 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region -ROOT-,,0
[junit] 2007-10-05 11:30:37,951 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region -ROOT-,,0. Size 0.0
[junit] 2007-10-05 11:30:37,951 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:37,952 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed -ROOT-,,0/info
[junit] 2007-10-05 11:30:37,952 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-05 11:30:37,952 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region .META.,,1
[junit] 2007-10-05 11:30:37,952 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 495.0
[junit] 2007-10-05 11:30:37,953 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region .META.,,1 with sequence id 25 and entries 3
[junit] 2007-10-05 11:30:37,956 INFO [regionserver/0.0.0.0:39992.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:900):
worker thread exiting
[junit] 2007-10-05 11:30:38,100 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
.META.,,1/info/1720356644213400184 with sequence id 25 and size 647.0
[junit] 2007-10-05 11:30:38,102 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region .META.,,1 in 150ms
[junit] 2007-10-05 11:30:38,104 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-05 11:30:38,104 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-05 11:30:38,105 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region testCreateDeleteTableDblQuote,,4459822762824882820
[junit] 2007-10-05 11:30:38,106 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testCreateDeleteTableDblQuote,,4459822762824882820.
Size 0.0
[junit] 2007-10-05 11:30:38,106 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:38,107 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTableDblQuote,,4459822762824882820/testCreateDeleteTable
[junit] 2007-10-05 11:30:38,107 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTableDblQuote,,4459822762824882820
[junit] 2007-10-05 11:30:38,108 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region testCreateDeleteTableSglQuote,,9006873593224297814
[junit] 2007-10-05 11:30:38,108 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testCreateDeleteTableSglQuote,,9006873593224297814.
Size 0.0
[junit] 2007-10-05 11:30:38,109 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:38,110 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTableSglQuote,,9006873593224297814/testCreateDeleteTable
[junit] 2007-10-05 11:30:38,110 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTableSglQuote,,9006873593224297814
[junit] 2007-10-05 11:30:38,111 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-2575868122839351486
[junit] 2007-10-05 11:30:38,111 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-2575868122839351486. Size
0.0
[junit] 2007-10-05 11:30:38,112 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:38,112 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-2575868122839351486/testCreateDeleteTableDblQuote
[junit] 2007-10-05 11:30:38,113 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-2575868122839351486
[junit] 2007-10-05 11:30:38,113 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region
testCreateDeleteTabletestCreateDeleteTableSglQuote,,9072363895610496931
[junit] 2007-10-05 11:30:38,114 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region
testCreateDeleteTabletestCreateDeleteTableSglQuote,,9072363895610496931. Size
0.0
[junit] 2007-10-05 11:30:38,115 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:38,115 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTabletestCreateDeleteTableSglQuote,,9072363895610496931/testCreateDeleteTableSglQuote
[junit] 2007-10-05 11:30:38,116 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTabletestCreateDeleteTableSglQuote,,9072363895610496931
[junit] 2007-10-05 11:30:38,116 DEBUG [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/log_140.211.11.75_-6538302908718404060_39992
[junit] 2007-10-05 11:30:38,131 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:603): stopping
server at: 140.211.11.75:39992
[junit] 2007-10-05 11:30:38,132 INFO [regionserver/0.0.0.0:39992]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:608):
regionserver/0.0.0.0:39992 exiting
[junit] 2007-10-05 11:30:38,956 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:39,966 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:40,976 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:41,986 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:42,996 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:44,006 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:44,666 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.rootScanner exiting
[junit] 2007-10-05 11:30:45,016 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:39992, startcode:
-6538302908718404060, load: (requests: 7 regions: 6)]
[junit] 2007-10-05 11:30:45,356 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:333): Lease expired
1437249985/1437249985
[junit] 2007-10-05 11:30:45,356 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2904):
140.211.11.75:39992 lease expired
[junit] 2007-10-05 11:30:45,357 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.metaScanner exiting
[junit] 2007-10-05 11:30:45,358 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:108): closing leases
[junit] 2007-10-05 11:30:45,361 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.leaseChecker exiting
[junit] 2007-10-05 11:30:45,370 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:122): leases closed
[junit] 2007-10-05 11:30:45,371 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1060): HMaster main thread
exiting
[junit] 2007-10-05 11:30:45,374 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:407):
Shutdown HMaster 1 region server(s)
[junit] 2007-10-05 11:30:45,375 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:422):
Shutting down Mini DFS cluster
[junit] 2007-10-05 11:30:45,995 WARN [EMAIL PROTECTED]
org.apache.hadoop.dfs.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:186):
PendingReplicationMonitor thread received exception.
java.lang.InterruptedException: sleep interrupted
[junit] 2007-10-05 11:30:46,292 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:426):
Shutting down FileSystem
[junit] 2007-10-05 11:30:47,896 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:825): Root region dir:
/hbase/hregion_-ROOT-,,0
[junit] 2007-10-05 11:30:47,899 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:834): bootstrap: creating
ROOT and first META regions
[junit] 2007-10-05 11:30:48,381 INFO [main]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/hregion_-ROOT-,,0/log/hlog.dat.000
[junit] 2007-10-05 11:30:48,391 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting -ROOT-,,0/info
(no reconstruction log)
[junit] 2007-10-05 11:30:48,394 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore -ROOT-,,0/info is -1
[junit] 2007-10-05 11:30:48,396 DEBUG [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region -ROOT-,,0 is 0
[junit] 2007-10-05 11:30:48,399 INFO [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region -ROOT-,,0
available
[junit] 2007-10-05 11:30:48,409 INFO [main]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/hregion_.META.,,1/log/hlog.dat.000
[junit] 2007-10-05 11:30:48,415 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting .META.,,1/info
(no reconstruction log)
[junit] 2007-10-05 11:30:48,418 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore .META.,,1/info is -1
[junit] 2007-10-05 11:30:48,419 DEBUG [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region .META.,,1 is 0
[junit] 2007-10-05 11:30:48,421 INFO [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region .META.,,1
available
[junit] 2007-10-05 11:30:48,423 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region -ROOT-,,0. Size 86.0
[junit] 2007-10-05 11:30:48,424 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region -ROOT-,,0 with sequence id 1 and entries 1
[junit] 2007-10-05 11:30:48,566 DEBUG [main]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
-ROOT-,,0/info/5969370746578684025 with sequence id 1 and size 210.0
[junit] 2007-10-05 11:30:48,567 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region -ROOT-,,0 in 145ms
[junit] 2007-10-05 11:30:48,568 DEBUG [main]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed -ROOT-,,0/info
[junit] 2007-10-05 11:30:48,568 INFO [main]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-05 11:30:48,569 DEBUG [main]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_-ROOT-,,0/log
[junit] 2007-10-05 11:30:48,581 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 0.0
[junit] 2007-10-05 11:30:48,582 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:48,582 DEBUG [main]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-05 11:30:48,582 INFO [main]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-05 11:30:48,583 DEBUG [main]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_.META.,,1/log
[junit] 2007-10-05 11:30:48,637 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:939): HMaster initialized
on 0.0.0.0:60000
[junit] 2007-10-05 11:30:48,638 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.startRegionServers(MiniHBaseCluster.java:241):
Starting HRegionServers
[junit] 2007-10-05 11:30:48,638 INFO [Master:0.0.0.0:60000]
org.apache.hadoop.hbase.MiniHBaseCluster$MasterThread.run(MiniHBaseCluster.java:166):
Starting Master:0.0.0.0:60000
[junit] 2007-10-05 11:30:48,644 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.MiniHBaseCluster$RegionServerThread.run(MiniHBaseCluster.java:187):
Starting regionserver/0.0.0.0:40209
[junit] 2007-10-05 11:30:48,645 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.reportForDuty(HRegionServer.java:762):
Telling master we are up
[junit] 2007-10-05 11:30:48,645 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerStartup(HMaster.java:1134):
received start message from: 140.211.11.75:40209
[junit] 2007-10-05 11:30:48,647 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: create table testInsertSelectDelete (testInsertSelectDelete);
[junit] 2007-10-05 11:30:48,648 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.reportForDuty(HRegionServer.java:773):
Done telling master we are up
[junit] 2007-10-05 11:30:48,648 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.init(HRegionServer.java:621): Config from
master: fs.default.name=localhost:40192
[junit] 2007-10-05 11:30:48,648 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.init(HRegionServer.java:621): Config from
master: hbase.rootdir=/hbase
[junit] 2007-10-05 11:30:48,649 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.setupHLog(HRegionServer.java:641): Root
dir: /hbase
[junit] 2007-10-05 11:30:48,650 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.setupHLog(HRegionServer.java:646): Log
dir /hbase/log_140.211.11.75_-4109799512811070913_40209
[junit] 2007-10-05 11:30:48,657 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/log_140.211.11.75_-4109799512811070913_40209/hlog.dat.000
[junit] 2007-10-05 11:30:48,659 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.startServiceThreads(HRegionServer.java:695):
HRegionServer started at: 140.211.11.75:40209
[junit] 2007-10-05 11:30:48,660 INFO [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1652):
assigning region -ROOT-,,0 to the only server 140.211.11.75:40209
[junit] 2007-10-05 11:30:48,662 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:855):
MSG_REGION_OPEN : regionname: -ROOT-,,0, startKey: <>, tableDesc: {name:
-ROOT-, families: {info:={name: info, max versions: 1, compression: NONE, in
memory: false, max length: 2147483647, bloom filter: none}}}
[junit] 2007-10-05 11:30:48,666 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting -ROOT-,,0/info
(no reconstruction log)
[junit] 2007-10-05 11:30:48,681 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore -ROOT-,,0/info is 1
[junit] 2007-10-05 11:30:48,703 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region -ROOT-,,0 is 2
[junit] 2007-10-05 11:30:48,710 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region -ROOT-,,0
available
[junit] 2007-10-05 11:30:48,711 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HLog.setSequenceNumber(HLog.java:229): changing
sequence number from 0 to 2
[junit] 2007-10-05 11:30:49,667 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1394):
140.211.11.75:40209 serving -ROOT-,,0
[junit] 2007-10-05 11:30:49,668 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:202):
HMaster.rootScanner scanning meta region -ROOT-,,0 on 140.211.11.75:40209
[junit] 2007-10-05 11:30:49,689 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:233):
HMaster.rootScanner scanner: 4995046280027971710 regioninfo: {regionname:
.META.,,1, startKey: <>, tableDesc: {name: .META., families: {info:={name:
info, max versions: 1, compression: NONE, in memory: false, max length:
2147483647, bloom filter: none}}}}, server: , startCode: -1
[junit] 2007-10-05 11:30:49,691 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:279):
HMaster.rootScanner scan of meta region -ROOT-,,0 complete
[junit] 2007-10-05 11:30:50,677 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1652):
assigning region .META.,,1 to the only server 140.211.11.75:40209
[junit] 2007-10-05 11:30:50,679 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:855):
MSG_REGION_OPEN : regionname: .META.,,1, startKey: <>, tableDesc: {name:
.META., families: {info:={name: info, max versions: 1, compression: NONE, in
memory: false, max length: 2147483647, bloom filter: none}}}
[junit] 2007-10-05 11:30:50,683 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting .META.,,1/info
(no reconstruction log)
[junit] 2007-10-05 11:30:50,685 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore .META.,,1/info is -1
[junit] 2007-10-05 11:30:50,686 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region .META.,,1 is 0
[junit] 2007-10-05 11:30:50,688 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region .META.,,1
available
[junit] 2007-10-05 11:30:51,687 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1394):
140.211.11.75:40209 serving .META.,,1
[junit] 2007-10-05 11:30:51,688 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:987): Main processing loop:
PendingOpenOperation from 140.211.11.75:40209
[junit] 2007-10-05 11:30:51,689 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2209):
.META.,,1 open on 140.211.11.75:40209
[junit] 2007-10-05 11:30:51,689 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2256):
updating row .META.,,1 in table -ROOT-,,0 with startcode -4109799512811070913
and server 140.211.11.75:40209
[junit] 2007-10-05 11:30:51,692 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:202):
HMaster.metaScanner scanning meta region .META.,,1 on 140.211.11.75:40209
[junit] 2007-10-05 11:30:51,695 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:279):
HMaster.metaScanner scan of meta region .META.,,1 complete
[junit] 2007-10-05 11:30:52,700 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/hregion_testInsertSelectDelete,,-3735390541718127237/log/hlog.dat.000
[junit] 2007-10-05 11:30:52,708 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting
testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete (no
reconstruction log)
[junit] 2007-10-05 11:30:52,710 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete is -1
[junit] 2007-10-05 11:30:52,711 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region testInsertSelectDelete,,-3735390541718127237 is 0
[junit] 2007-10-05 11:30:52,712 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region
testInsertSelectDelete,,-3735390541718127237 available
[junit] 2007-10-05 11:30:52,714 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testInsertSelectDelete,,-3735390541718127237. Size 0.0
[junit] 2007-10-05 11:30:52,714 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-05 11:30:52,714 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete
[junit] 2007-10-05 11:30:52,714 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testInsertSelectDelete,,-3735390541718127237
[junit] 2007-10-05 11:30:52,715 DEBUG [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_testInsertSelectDelete,,-3735390541718127237/log
[junit] 2007-10-05 11:30:52,727 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2348): created table
testInsertSelectDelete
[junit] 2007-10-05 11:30:52,728 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:298):
No servers for testInsertSelectDelete. Doing a find...
[junit] 2007-10-05 11:30:52,750 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:682):
Found 1 region(s) for .META. at address: 140.211.11.75:40209, regioninfo:
regionname: -ROOT-,,0, startKey: <>, tableDesc: {name: -ROOT-, families:
{info:={name: info, max versions: 1, compression: NONE, in memory: false, max
length: 2147483647, bloom filter: none}}}
[junit] 2007-10-05 11:30:52,767 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732):
no server address for regionname:
testInsertSelectDelete,,-3735390541718127237, startKey: <>, tableDesc: {name:
testInsertSelectDelete, families: {testInsertSelectDelete:={name:
testInsertSelectDelete, max versions: 3, compression: NONE, in memory: false,
max length: 2147483647, bloom filter: none}}}
[junit] 2007-10-05 11:30:52,769 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:768):
Sleeping. Table testInsertSelectDelete not currently being served.
[junit] 2007-10-05 11:30:53,707 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1652):
assigning region testInsertSelectDelete,,-3735390541718127237 to the only
server 140.211.11.75:40209
[junit] 2007-10-05 11:30:53,708 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:855):
MSG_REGION_OPEN : regionname: testInsertSelectDelete,,-3735390541718127237,
startKey: <>, tableDesc: {name: testInsertSelectDelete, families:
{testInsertSelectDelete:={name: testInsertSelectDelete, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}}
[junit] 2007-10-05 11:30:53,711 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting
testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete (no
reconstruction log)
[junit] 2007-10-05 11:30:53,713 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete is -1
[junit] 2007-10-05 11:30:53,714 DEBUG [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region testInsertSelectDelete,,-3735390541718127237 is 0
[junit] 2007-10-05 11:30:53,716 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region
testInsertSelectDelete,,-3735390541718127237 available
[junit] 2007-10-05 11:30:54,717 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1394):
140.211.11.75:40209 serving testInsertSelectDelete,,-3735390541718127237
[junit] 2007-10-05 11:30:54,718 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:987): Main processing loop:
PendingOpenOperation from 140.211.11.75:40209
[junit] 2007-10-05 11:30:54,718 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2209):
testInsertSelectDelete,,-3735390541718127237 open on 140.211.11.75:40209
[junit] 2007-10-05 11:30:54,718 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2256):
updating row testInsertSelectDelete,,-3735390541718127237 in table .META.,,1
with startcode -4109799512811070913 and server 140.211.11.75:40209
[junit] 2007-10-05 11:30:57,776 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:777):
Wake. Retry finding table testInsertSelectDelete
[junit] 2007-10-05 11:30:57,781 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:682):
Found 1 region(s) for testInsertSelectDelete at address: 140.211.11.75:40209,
regioninfo: regionname: .META.,,1, startKey: <>, tableDesc: {name: .META.,
families: {info:={name: info, max versions: 1, compression: NONE, in memory:
false, max length: 2147483647, bloom filter: none}}}
[junit] 2007-10-05 11:30:57,782 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT: Creating table... Please wait.
[junit] 2007-10-05 11:30:57,789 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ('testInsertSelectDelete') where row='testInsertSelectDelete';
[junit] 2007-10-05 11:30:57,822 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT:
[junit] 2007-10-05 11:30:57,822 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ('testInsertSelectDelete') where row="testInsertSelectDelete";
[junit] 2007-10-05 11:30:57,824 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT:
[junit] 2007-10-05 11:30:57,825 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ("testInsertSelectDelete") where row="testInsertSelectDelete";
[junit] 2007-10-05 11:30:57,827 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT:
[junit] 2007-10-05 11:30:57,827 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: select "testInsertSelectDelete" from "testInsertSelectDelete"
where row="testInsertSelectDelete";
[junit] 2007-10-05 11:30:57,832 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT:
[junit] 2007-10-05 11:30:57,832 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:159):
Running command: delete "testInsertSelectDelete:" from
"testInsertSelectDelete" where row="testInsertSelectDelete";
[junit] 2007-10-05 11:30:57,834 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:168):
STDOUT:
[junit] 2007-10-05 11:30:57,835 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:378):
Shutting down HBase Cluster
[junit] 2007-10-05 11:30:58,756 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:30:58,757 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:500): Got
regionserver stop message
[junit] 2007-10-05 11:30:58,758 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.Leases.close(Leases.java:108): closing leases
[junit] 2007-10-05 11:30:58,758 INFO
[regionserver/0.0.0.0:40209.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:40209.leaseChecker exiting
[junit] 2007-10-05 11:30:58,758 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.Leases.close(Leases.java:122): leases closed
[junit] 2007-10-05 11:30:58,760 INFO
[regionserver/0.0.0.0:40209.logRoller]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:40209.logRoller exiting
[junit] 2007-10-05 11:30:58,760 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region -ROOT-,,0
[junit] 2007-10-05 11:30:58,760 INFO
[regionserver/0.0.0.0:40209.cacheFlusher]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:40209.cacheFlusher exiting
[junit] 2007-10-05 11:30:58,760 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region -ROOT-,,0. Size 92.0
[junit] 2007-10-05 11:30:58,761 INFO
[regionserver/0.0.0.0:40209.splitOrCompactChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63):
regionserver/0.0.0.0:40209.splitOrCompactChecker exiting
[junit] 2007-10-05 11:30:58,761 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region -ROOT-,,0 with sequence id 11 and entries 2
[junit] 2007-10-05 11:30:58,766 INFO [regionserver/0.0.0.0:40209.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:900):
worker thread exiting
[junit] 2007-10-05 11:30:58,869 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
-ROOT-,,0/info/3507939496638754603 with sequence id 11 and size 230.0
[junit] 2007-10-05 11:30:58,870 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region -ROOT-,,0 in 110ms
[junit] 2007-10-05 11:30:58,870 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed -ROOT-,,0/info
[junit] 2007-10-05 11:30:58,870 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-05 11:30:58,870 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region .META.,,1
[junit] 2007-10-05 11:30:58,871 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 352.0
[junit] 2007-10-05 11:30:58,871 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region .META.,,1 with sequence id 12 and entries 3
[junit] 2007-10-05 11:30:58,938 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
.META.,,1/info/5062423191989134577 with sequence id 12 and size 504.0
[junit] 2007-10-05 11:30:58,939 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region .META.,,1 in 68ms
[junit] 2007-10-05 11:30:58,939 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-05 11:30:58,939 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-05 11:30:58,940 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:951):
closing region testInsertSelectDelete,,-3735390541718127237
[junit] 2007-10-05 11:30:58,940 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testInsertSelectDelete,,-3735390541718127237. Size
294.0
[junit] 2007-10-05 11:30:58,940 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region testInsertSelectDelete,,-3735390541718127237
with sequence id 13 and entries 3
[junit] 2007-10-05 11:30:59,026 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete/7276176606933569356
with sequence id 13 and size 371.0
[junit] 2007-10-05 11:30:59,027 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region testInsertSelectDelete,,-3735390541718127237 in 87ms
[junit] 2007-10-05 11:30:59,028 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testInsertSelectDelete,,-3735390541718127237/testInsertSelectDelete
[junit] 2007-10-05 11:30:59,028 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testInsertSelectDelete,,-3735390541718127237
[junit] 2007-10-05 11:30:59,028 DEBUG [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/log_140.211.11.75_-4109799512811070913_40209
[junit] 2007-10-05 11:30:59,047 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:603): stopping
server at: 140.211.11.75:40209
[junit] 2007-10-05 11:30:59,047 INFO [regionserver/0.0.0.0:40209]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:608):
regionserver/0.0.0.0:40209 exiting
[junit] 2007-10-05 11:30:59,696 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.rootScanner exiting
[junit] 2007-10-05 11:30:59,766 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:00,776 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:01,696 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.metaScanner exiting
[junit] 2007-10-05 11:31:01,786 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:02,796 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:03,806 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:04,816 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:05,826 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1112):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:40209, startcode:
-4109799512811070913, load: (requests: 0 regions: 3)]
[junit] 2007-10-05 11:31:06,696 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:333): Lease expired
1437898388/1437898388
[junit] 2007-10-05 11:31:06,696 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2904):
140.211.11.75:40209 lease expired
[junit] 2007-10-05 11:31:06,697 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:108): closing leases
[junit] 2007-10-05 11:31:06,697 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:63): HMaster.leaseChecker exiting
[junit] 2007-10-05 11:31:06,698 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:122): leases closed
[junit] 2007-10-05 11:31:06,698 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1060): HMaster main thread
exiting
[junit] 2007-10-05 11:31:06,698 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:407):
Shutdown HMaster 1 region server(s)
[junit] 2007-10-05 11:31:06,699 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:422):
Shutting down Mini DFS cluster
[junit] 2007-10-05 11:31:07,379 WARN [EMAIL PROTECTED]
org.apache.hadoop.dfs.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:186):
PendingReplicationMonitor thread received exception.
java.lang.InterruptedException: sleep interrupted
[junit] 2007-10-05 11:31:07,705 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:426):
Shutting down FileSystem
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 69.581 sec
[junit] Running org.apache.hadoop.hbase.util.TestKeying
[junit] Original url http://abc:[EMAIL
PROTECTED]/index.html?query=something#middle, Transformed url
r:http://abc:[EMAIL PROTECTED]/index.html?query=something#middle
[junit] Original url file:///usr/bin/java, Transformed url
file:///usr/bin/java
[junit] Original url dns:www.powerset.com, Transformed url
dns:www.powerset.com
[junit] Original url dns://dns.powerset.com/www.powerset.com, Transformed
url r:dns://com.powerset.dns/www.powerset.com
[junit] Original url http://one.two.three/index.html, Transformed url
r:http://three.two.one/index.html
[junit] Original url https://one.two.three:9443/index.html, Transformed url
r:https://three.two.one:9443/index.html
[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.051 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.339 sec
BUILD FAILED
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml
:510: The following error occurred while executing this line:
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/src/contrib/build.xml
:23: The following error occurred while executing this line:
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/src/contrib/hbase/build.xml
:102: The following error occurred while executing this line:
http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/src/contrib/build-contrib.xml
:205: Tests failed!
Total time: 74 minutes 49 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-1937
Updating HADOOP-1996
Updating HADOOP-1955
Updating HADOOP-1961
Updating HADOOP-1990
Updating HADOOP-1695
