See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/267/changes
Changes:
[ddas] HADOOP-2001. Make the job priority updates and job kills synchronized
on the JobTracker. Deadlock was seen in the JobTracker because of the lack of
this synchronization. Contributed by Arun C Murthy
[acmurthy] HADOOP-1874. Move task-outputs' promotion/discard to a separate
thread distinct from the main heartbeat-processing thread. The main upside
being that we do not lock-up the JobTracker during HDFS operations, which
otherwise may lead to lost tasktrackers if the NameNode is unresponsive.
Contributed by Devaraj Das.
[omalley] HADOOP-1992. Fix the performance degradation in sort validation.
Contributed
by Arun.
[dhruba] HADOOP-1875. Non-existant directories or read-only directories are
filtered from dfs.client.buffer.dir. (Hairong Kuang via dhruba)
[dhruba] HADOOP-1942. Increase the concurrency of transaction logging to
edits log. Reduce the number of syncs by double-buffering the changes
to the transaction log. (Dhruba Borthakur)
[stack] HADOOP-2017 TestRegionServerAbort failure in patch build #903 and
nightly #266
------------------------------------------
[...truncated 42866 lines...]
[junit] 2007-10-10 12:21:00,235 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-10 12:21:00,235 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region .META.,,1
[junit] 2007-10-10 12:21:00,235 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 0.0
[junit] 2007-10-10 12:21:00,236 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:00,236 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-10 12:21:00,237 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-10 12:21:00,237 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region testCreateDeleteTableDblQuote,,-3999632731893738424
[junit] 2007-10-10 12:21:00,238 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testCreateDeleteTableDblQuote,,-3999632731893738424.
Size 0.0
[junit] 2007-10-10 12:21:00,238 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:00,238 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTableDblQuote,,-3999632731893738424/testCreateDeleteTable
[junit] 2007-10-10 12:21:00,239 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTableDblQuote,,-3999632731893738424
[junit] 2007-10-10 12:21:00,239 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region testCreateDeleteTableSglQuote,,3584904610866828715
[junit] 2007-10-10 12:21:00,239 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testCreateDeleteTableSglQuote,,3584904610866828715.
Size 0.0
[junit] 2007-10-10 12:21:00,241 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:00,242 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTableSglQuote,,3584904610866828715/testCreateDeleteTable
[junit] 2007-10-10 12:21:00,242 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTableSglQuote,,3584904610866828715
[junit] 2007-10-10 12:21:00,243 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-8864071117606536362
[junit] 2007-10-10 12:21:00,243 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-8864071117606536362. Size
0.0
[junit] 2007-10-10 12:21:00,244 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:00,244 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-8864071117606536362/testCreateDeleteTableDblQuote
[junit] 2007-10-10 12:21:00,245 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTabletestCreateDeleteTableDblQuote,,-8864071117606536362
[junit] 2007-10-10 12:21:00,245 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region
testCreateDeleteTabletestCreateDeleteTableSglQuote,,-1676251005364876413
[junit] 2007-10-10 12:21:00,246 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region
testCreateDeleteTabletestCreateDeleteTableSglQuote,,-1676251005364876413. Size
0.0
[junit] 2007-10-10 12:21:00,247 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:00,247 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testCreateDeleteTabletestCreateDeleteTableSglQuote,,-1676251005364876413/testCreateDeleteTableSglQuote
[junit] 2007-10-10 12:21:00,248 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testCreateDeleteTabletestCreateDeleteTableSglQuote,,-1676251005364876413
[junit] 2007-10-10 12:21:00,249 DEBUG [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/log_140.211.11.75_5451730604468588328_62133
[junit] 2007-10-10 12:21:00,290 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:619): stopping
server at: 140.211.11.75:62133
[junit] 2007-10-10 12:21:00,464 INFO [regionserver/0.0.0.0:62133.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:924):
worker thread exiting
[junit] 2007-10-10 12:21:00,465 INFO [regionserver/0.0.0.0:62133]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:624):
regionserver/0.0.0.0:62133 exiting
[junit] 2007-10-10 12:21:01,058 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-10-10 12:21:01,231 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:02,241 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:02,994 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-10-10 12:21:03,251 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:04,261 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:05,271 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:06,281 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:62133, startcode:
5451730604468588328, load: (requests: 0 regions: 6)]
[junit] 2007-10-10 12:21:06,541 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:334):
HMaster.leaseChecker lease expired 1439804138/1439804138
[junit] 2007-10-10 12:21:06,542 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2964):
140.211.11.75:62133 lease expired
[junit] 2007-10-10 12:21:06,543 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-10-10 12:21:06,546 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] Exception in thread "HMaster.leaseChecker"
java.lang.NoClassDefFoundError:
org/apache/hadoop/hbase/HMaster$PendingServerShutdown
[junit] at
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2987)
[junit] at org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:336)
[junit] at
org.apache.hadoop.hbase.Leases$LeaseMonitor.chore(Leases.java:227)
[junit] at org.apache.hadoop.hbase.Chore.run(Chore.java:58)
[junit] 2007-10-10 12:21:06,547 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:123): HMaster closed leases
[junit] 2007-10-10 12:21:06,548 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1138): HMaster main thread
exiting
[junit] 2007-10-10 12:21:06,548 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:405):
Shutdown HMaster 1 region server(s)
[junit] 2007-10-10 12:21:06,549 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:420):
Shutting down Mini DFS cluster
[junit] 2007-10-10 12:21:07,240 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-10 12:21:07,560 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:424):
Shutting down FileSystem
[junit] 2007-10-10 12:21:09,767 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:862): Root region dir:
/hbase/hregion_-ROOT-,,0
[junit] 2007-10-10 12:21:10,092 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:871): bootstrap: creating
ROOT and first META regions
[junit] 2007-10-10 12:21:10,127 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-10 12:21:10,145 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting -ROOT-,,0/info
(no reconstruction log)
[junit] 2007-10-10 12:21:10,149 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore -ROOT-,,0/info is -1
[junit] 2007-10-10 12:21:10,151 DEBUG [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region -ROOT-,,0 is 0
[junit] 2007-10-10 12:21:10,153 INFO [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region -ROOT-,,0
available
[junit] 2007-10-10 12:21:10,176 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-10 12:21:10,185 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting .META.,,1/info
(no reconstruction log)
[junit] 2007-10-10 12:21:10,188 DEBUG [main]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore .META.,,1/info is -1
[junit] 2007-10-10 12:21:10,190 DEBUG [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region .META.,,1 is 0
[junit] 2007-10-10 12:21:10,192 INFO [main]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region .META.,,1
available
[junit] 2007-10-10 12:21:10,196 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region -ROOT-,,0. Size 86.0
[junit] 2007-10-10 12:21:10,197 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-10 12:21:10,347 DEBUG [main]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
-ROOT-,,0/info/1523693700648861729 with sequence id 1 and size 210.0
[junit] 2007-10-10 12:21:10,348 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region -ROOT-,,0 in 153ms
[junit] 2007-10-10 12:21:10,348 DEBUG [main]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed -ROOT-,,0/info
[junit] 2007-10-10 12:21:10,349 INFO [main]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-10 12:21:10,349 DEBUG [main]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_-ROOT-,,0/log
[junit] 2007-10-10 12:21:10,402 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 0.0
[junit] 2007-10-10 12:21:10,403 DEBUG [main]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:10,405 DEBUG [main]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-10 12:21:10,406 INFO [main]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-10 12:21:10,406 DEBUG [main]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_.META.,,1/log
[junit] 2007-10-10 12:21:10,454 INFO [main]
org.apache.hadoop.hbase.HMaster.<init>(HMaster.java:959): HMaster initialized
on 0.0.0.0:60000
[junit] 2007-10-10 12:21:10,456 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.startRegionServers(MiniHBaseCluster.java:239):
Starting HRegionServers
[junit] 2007-10-10 12:21:10,456 INFO [Master:0.0.0.0:60000]
org.apache.hadoop.hbase.MiniHBaseCluster$MasterThread.run(MiniHBaseCluster.java:165):
Starting Master:0.0.0.0:60000
[junit] 2007-10-10 12:21:10,467 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.MiniHBaseCluster$RegionServerThread.run(MiniHBaseCluster.java:185):
Starting regionserver/0.0.0.0:63376
[junit] 2007-10-10 12:21:10,467 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.reportForDuty(HRegionServer.java:786):
Telling master we are up
[junit] 2007-10-10 12:21:10,469 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.regionServerStartup(HMaster.java:1220):
received start message from: 140.211.11.75:63376
[junit] 2007-10-10 12:21:10,473 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.reportForDuty(HRegionServer.java:797):
Done telling master we are up
[junit] 2007-10-10 12:21:10,474 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.init(HRegionServer.java:637): Config from
master: fs.default.name=localhost:63324
[junit] 2007-10-10 12:21:10,474 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.init(HRegionServer.java:637): Config from
master: hbase.rootdir=/hbase
[junit] 2007-10-10 12:21:10,475 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.setupHLog(HRegionServer.java:657): Root
dir: /hbase
[junit] 2007-10-10 12:21:10,476 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.setupHLog(HRegionServer.java:662): Log
dir /hbase/log_140.211.11.75_-6252965621241603958_63376
[junit] 2007-10-10 12:21:10,478 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: create table testInsertSelectDelete (testInsertSelectDelete);
[junit] 2007-10-10 12:21:10,480 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:10,584 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/log_140.211.11.75_-6252965621241603958_63376/hlog.dat.000
[junit] 2007-10-10 12:21:10,587 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.startServiceThreads(HRegionServer.java:719):
HRegionServer started at: 140.211.11.75:63376
[junit] 2007-10-10 12:21:10,594 INFO [IPC Server handler 0 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1731):
assigning region -ROOT-,,0 to the only server 140.211.11.75:63376
[junit] 2007-10-10 12:21:10,597 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:879):
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-10 12:21:10,604 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting -ROOT-,,0/info
(no reconstruction log)
[junit] 2007-10-10 12:21:10,618 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore -ROOT-,,0/info is 1
[junit] 2007-10-10 12:21:10,649 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region -ROOT-,,0 is 2
[junit] 2007-10-10 12:21:10,652 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region -ROOT-,,0
available
[junit] 2007-10-10 12:21:10,652 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HLog.setSequenceNumber(HLog.java:229): changing
sequence number from 0 to 2
[junit] 2007-10-10 12:21:11,602 INFO [IPC Server handler 3 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1476):
140.211.11.75:63376 serving -ROOT-,,0
[junit] 2007-10-10 12:21:11,604 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:207):
HMaster.rootScanner scanning meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:63376}
[junit] 2007-10-10 12:21:11,632 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:238):
HMaster.rootScanner scanner: -6998314833887301689 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-10 12:21:11,633 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:435):
Checking .META.,,1 is assigned
[junit] 2007-10-10 12:21:11,634 DEBUG [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.checkAssigned(HMaster.java:442):
Current assignment of .META.,,1 is no good
[junit] 2007-10-10 12:21:11,636 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:284):
HMaster.rootScanner scan of meta region regionname: -ROOT-,,0, startKey: <>,
server: 140.211.11.75:63376} complete
[junit] 2007-10-10 12:21:12,612 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1731):
assigning region .META.,,1 to the only server 140.211.11.75:63376
[junit] 2007-10-10 12:21:12,614 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:879):
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-10 12:21:12,620 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting .META.,,1/info
(no reconstruction log)
[junit] 2007-10-10 12:21:12,624 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore .META.,,1/info is -1
[junit] 2007-10-10 12:21:12,625 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region .META.,,1 is 0
[junit] 2007-10-10 12:21:12,628 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region .META.,,1
available
[junit] 2007-10-10 12:21:13,622 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1476):
140.211.11.75:63376 serving .META.,,1
[junit] 2007-10-10 12:21:13,623 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1058): Main processing loop:
PendingOpenOperation from 140.211.11.75:63376
[junit] 2007-10-10 12:21:13,624 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2280):
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}}} open on 140.211.11.75:63376
[junit] 2007-10-10 12:21:13,624 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2323):
updating row .META.,,1 in table -ROOT-,,0 with startcode -6252965621241603958
and server 140.211.11.75:63376
[junit] 2007-10-10 12:21:13,628 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2341):
Adding regionname: .META.,,1, startKey: <>, server: 140.211.11.75:63376} to
regions to scan
[junit] 2007-10-10 12:21:13,628 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:207):
HMaster.metaScanner scanning meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:63376}
[junit] 2007-10-10 12:21:13,632 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.HMaster$BaseScanner.scanRegion(HMaster.java:284):
HMaster.metaScanner scan of meta region regionname: .META.,,1, startKey: <>,
server: 140.211.11.75:63376} complete
[junit] 2007-10-10 12:21:14,539 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HLog.rollWriter(HLog.java:293): new log writer created
at /hbase/hregion_testInsertSelectDelete,,6859626970752495586/log/hlog.dat.000
[junit] 2007-10-10 12:21:14,650 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting
testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete (no
reconstruction log)
[junit] 2007-10-10 12:21:14,653 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete is -1
[junit] 2007-10-10 12:21:14,655 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region testInsertSelectDelete,,6859626970752495586 is 0
[junit] 2007-10-10 12:21:14,665 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region
testInsertSelectDelete,,6859626970752495586 available
[junit] 2007-10-10 12:21:14,667 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testInsertSelectDelete,,6859626970752495586. Size 0.0
[junit] 2007-10-10 12:21:14,668 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:855): Finished
memcache flush; empty snapshot
[junit] 2007-10-10 12:21:14,669 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete
[junit] 2007-10-10 12:21:14,670 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testInsertSelectDelete,,6859626970752495586
[junit] 2007-10-10 12:21:14,671 DEBUG [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/hregion_testInsertSelectDelete,,6859626970752495586/log
[junit] 2007-10-10 12:21:14,690 INFO [IPC Server handler 4 on 60000]
org.apache.hadoop.hbase.HMaster.createTable(HMaster.java:2408): created table
testInsertSelectDelete
[junit] 2007-10-10 12:21:14,691 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.getTableServers(HConnectionManager.java:298):
No servers for testInsertSelectDelete. Doing a find...
[junit] 2007-10-10 12:21:14,764 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:682):
Found 1 region(s) for .META. at address: 140.211.11.75:63376, 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-10 12:21:14,769 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:732):
no server address for regionname: testInsertSelectDelete,,6859626970752495586,
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-10 12:21:14,771 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:768):
Sleeping. Table testInsertSelectDelete not currently being served.
[junit] 2007-10-10 12:21:15,642 INFO [IPC Server handler 2 on 60000]
org.apache.hadoop.hbase.HMaster.assignRegionsToOneServer(HMaster.java:1731):
assigning region testInsertSelectDelete,,6859626970752495586 to the only server
140.211.11.75:63376
[junit] 2007-10-10 12:21:15,643 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:879):
MSG_REGION_OPEN : regionname: testInsertSelectDelete,,6859626970752495586,
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-10 12:21:15,656 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:180): starting
testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete (no
reconstruction log)
[junit] 2007-10-10 12:21:15,659 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HStore.<init>(HStore.java:216): maximum sequence id for
hstore testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete is -1
[junit] 2007-10-10 12:21:15,662 DEBUG [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:283): maximum sequence id
for region testInsertSelectDelete,,6859626970752495586 is 0
[junit] 2007-10-10 12:21:15,672 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegion.<init>(HRegion.java:309): region
testInsertSelectDelete,,6859626970752495586 available
[junit] 2007-10-10 12:21:16,652 INFO [IPC Server handler 1 on 60000]
org.apache.hadoop.hbase.HMaster.processMsgs(HMaster.java:1476):
140.211.11.75:63376 serving testInsertSelectDelete,,6859626970752495586
[junit] 2007-10-10 12:21:16,653 DEBUG [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1058): Main processing loop:
PendingOpenOperation from 140.211.11.75:63376
[junit] 2007-10-10 12:21:16,653 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2280):
regionname: testInsertSelectDelete,,6859626970752495586, startKey: <>,
tableDesc: {name: testInsertSelectDelete, families:
{testInsertSelectDelete:={name: testInsertSelectDelete, max versions: 3,
compression: NONE, in memory: false, max length: 2147483647, bloom filter:
none}}} open on 140.211.11.75:63376
[junit] 2007-10-10 12:21:16,654 INFO [HMaster]
org.apache.hadoop.hbase.HMaster$PendingOpenReport.process(HMaster.java:2323):
updating row testInsertSelectDelete,,6859626970752495586 in table .META.,,1
with startcode -6252965621241603958 and server 140.211.11.75:63376
[junit] 2007-10-10 12:21:19,780 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:777):
Wake. Retry finding table testInsertSelectDelete
[junit] 2007-10-10 12:21:19,788 DEBUG [main]
org.apache.hadoop.hbase.HConnectionManager$TableServers.scanOneMetaRegion(HConnectionManager.java:682):
Found 1 region(s) for testInsertSelectDelete at address: 140.211.11.75:63376,
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-10 12:21:19,791 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT: Creating table... Please wait.
[junit] 2007-10-10 12:21:19,900 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ('testInsertSelectDelete') where row='testInsertSelectDelete';
[junit] 2007-10-10 12:21:19,906 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:19,924 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT:
[junit] 2007-10-10 12:21:19,932 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ('testInsertSelectDelete') where row="testInsertSelectDelete";
[junit] 2007-10-10 12:21:19,933 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:19,937 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT:
[junit] 2007-10-10 12:21:19,938 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: insert into testInsertSelectDelete (testInsertSelectDelete)
values ("testInsertSelectDelete") where row="testInsertSelectDelete";
[junit] 2007-10-10 12:21:19,939 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:19,943 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT:
[junit] 2007-10-10 12:21:19,944 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: select "testInsertSelectDelete" from "testInsertSelectDelete"
where row="testInsertSelectDelete";
[junit] 2007-10-10 12:21:19,945 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:19,988 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT:
[junit] 2007-10-10 12:21:19,989 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.runCommand(TestHBaseShell.java:161):
Running command: delete "testInsertSelectDelete:" from
"testInsertSelectDelete" where row="testInsertSelectDelete";
[junit] 2007-10-10 12:21:19,991 DEBUG [main]
org.apache.hadoop.hbase.shell.TableFormatterFactory.<init>(TableFormatterFactory.java:65):
Table formatter class:
org.apache.hadoop.hbase.shell.formatter.AsciiTableFormatter
[junit] 2007-10-10 12:21:19,996 INFO [main]
org.apache.hadoop.hbase.shell.TestHBaseShell.dumpStdout(TestHBaseShell.java:172):
STDOUT:
[junit] 2007-10-10 12:21:19,998 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:376):
Shutting down HBase Cluster
[junit] 2007-10-10 12:21:20,702 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:508): Got
regionserver stop message
[junit] 2007-10-10 12:21:20,703 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.Leases.close(Leases.java:109):
regionserver/0.0.0.0:63376 closing leases
[junit] 2007-10-10 12:21:20,703 INFO
[regionserver/0.0.0.0:63376.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62):
regionserver/0.0.0.0:63376.leaseChecker exiting
[junit] 2007-10-10 12:21:20,704 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.Leases.close(Leases.java:123):
regionserver/0.0.0.0:63376 closed leases
[junit] 2007-10-10 12:21:20,704 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region -ROOT-,,0
[junit] 2007-10-10 12:21:20,705 INFO
[regionserver/0.0.0.0:63376.logRoller]
org.apache.hadoop.hbase.Chore.run(Chore.java:62):
regionserver/0.0.0.0:63376.logRoller exiting
[junit] 2007-10-10 12:21:20,705 INFO
[regionserver/0.0.0.0:63376.splitOrCompactChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62):
regionserver/0.0.0.0:63376.splitOrCompactChecker exiting
[junit] 2007-10-10 12:21:20,706 INFO
[regionserver/0.0.0.0:63376.cacheFlusher]
org.apache.hadoop.hbase.Chore.run(Chore.java:62):
regionserver/0.0.0.0:63376.cacheFlusher exiting
[junit] 2007-10-10 12:21:20,705 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region -ROOT-,,0. Size 92.0
[junit] 2007-10-10 12:21:20,707 DEBUG [regionserver/0.0.0.0:63376]
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-10 12:21:20,720 INFO [regionserver/0.0.0.0:63376.worker]
org.apache.hadoop.hbase.HRegionServer$Worker.run(HRegionServer.java:924):
worker thread exiting
[junit] 2007-10-10 12:21:20,730 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:21,264 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
-ROOT-,,0/info/4750395860066671554 with sequence id 11 and size 230.0
[junit] 2007-10-10 12:21:21,269 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region -ROOT-,,0 in 564ms
[junit] 2007-10-10 12:21:21,270 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed -ROOT-,,0/info
[junit] 2007-10-10 12:21:21,270 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed -ROOT-,,0
[junit] 2007-10-10 12:21:21,271 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region .META.,,1
[junit] 2007-10-10 12:21:21,271 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region .META.,,1. Size 348.0
[junit] 2007-10-10 12:21:21,272 DEBUG [regionserver/0.0.0.0:63376]
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-10 12:21:21,504 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
.META.,,1/info/8562578322183638294 with sequence id 12 and size 500.0
[junit] 2007-10-10 12:21:21,505 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region .META.,,1 in 234ms
[junit] 2007-10-10 12:21:21,506 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed .META.,,1/info
[junit] 2007-10-10 12:21:21,507 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed .META.,,1
[junit] 2007-10-10 12:21:21,507 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.closeAllRegions(HRegionServer.java:975):
closing region testInsertSelectDelete,,6859626970752495586
[junit] 2007-10-10 12:21:21,508 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:837): Started
memcache flush for region testInsertSelectDelete,,6859626970752495586. Size
294.0
[junit] 2007-10-10 12:21:21,508 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:866):
Snapshotted memcache for region testInsertSelectDelete,,6859626970752495586
with sequence id 13 and entries 3
[junit] 2007-10-10 12:21:21,615 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.flushCacheHelper(HStore.java:502): Added
testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete/2060482481093010491
with sequence id 13 and size 371.0
[junit] 2007-10-10 12:21:21,616 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.internalFlushcache(HRegion.java:909): Finished
memcache flush for region testInsertSelectDelete,,6859626970752495586 in 108ms
[junit] 2007-10-10 12:21:21,617 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HStore.close(HStore.java:417): closed
testInsertSelectDelete,,6859626970752495586/testInsertSelectDelete
[junit] 2007-10-10 12:21:21,618 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegion.close(HRegion.java:392): closed
testInsertSelectDelete,,6859626970752495586
[junit] 2007-10-10 12:21:21,618 DEBUG [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HLog.close(HLog.java:350): closing log writer in
/hbase/log_140.211.11.75_-6252965621241603958_63376
[junit] 2007-10-10 12:21:21,641 INFO [HMaster.rootScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.rootScanner exiting
[junit] 2007-10-10 12:21:21,643 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:619): stopping
server at: 140.211.11.75:63376
[junit] 2007-10-10 12:21:21,644 INFO [regionserver/0.0.0.0:63376]
org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:624):
regionserver/0.0.0.0:63376 exiting
[junit] 2007-10-10 12:21:21,740 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:22,750 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:23,692 INFO [HMaster.metaScanner]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.metaScanner exiting
[junit] 2007-10-10 12:21:23,760 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:24,782 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:25,790 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:26,800 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:27,810 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.letRegionServersShutdown(HMaster.java:1198):
Waiting on following regionserver(s) to go down (or region server lease
expiration, whichever happens first): [address: 140.211.11.75:63376, startcode:
-6252965621241603958, load: (requests: 0 regions: 3)]
[junit] 2007-10-10 12:21:28,550 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:334):
HMaster.leaseChecker lease expired 1439835978/1439835978
[junit] 2007-10-10 12:21:28,551 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2964):
140.211.11.75:63376 lease expired
[junit] 2007-10-10 12:21:28,553 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:109): HMaster closing leases
[junit] 2007-10-10 12:21:28,556 INFO [HMaster.leaseChecker]
org.apache.hadoop.hbase.Chore.run(Chore.java:62): HMaster.leaseChecker exiting
[junit] Exception in thread "HMaster.leaseChecker"
java.lang.NoClassDefFoundError:
org/apache/hadoop/hbase/HMaster$PendingServerShutdown
[junit] at
org.apache.hadoop.hbase.HMaster$ServerExpirer.leaseExpired(HMaster.java:2987)
[junit] at org.apache.hadoop.hbase.Leases$Lease.expired(Leases.java:336)
[junit] at
org.apache.hadoop.hbase.Leases$LeaseMonitor.chore(Leases.java:227)
[junit] at org.apache.hadoop.hbase.Chore.run(Chore.java:58)
[junit] 2007-10-10 12:21:28,559 INFO [HMaster]
org.apache.hadoop.hbase.Leases.close(Leases.java:123): HMaster closed leases
[junit] 2007-10-10 12:21:28,590 INFO [HMaster]
org.apache.hadoop.hbase.HMaster.run(HMaster.java:1138): HMaster main thread
exiting
[junit] 2007-10-10 12:21:28,592 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:405):
Shutdown HMaster 1 region server(s)
[junit] 2007-10-10 12:21:28,593 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:420):
Shutting down Mini DFS cluster
[junit] 2007-10-10 12:21:29,568 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-10 12:21:30,097 INFO [main]
org.apache.hadoop.hbase.MiniHBaseCluster.shutdown(MiniHBaseCluster.java:424):
Shutting down FileSystem
[junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 91.883 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.11 sec
[junit] Running org.onelab.test.TestFilter
[junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.691 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/build-contrib.xml
:205: Tests failed!
Total time: 66 minutes 50 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Updating HADOOP-1874
Updating HADOOP-1992
Updating HADOOP-2001
Updating HADOOP-1942
Updating HADOOP-1875
Updating HADOOP-2017
