hbase-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Hudson Server <hud...@hudson.zones.apache.org>
Subject Build failed in Hudson: HBase-Patch #227
Date Sat, 19 Jul 2008 20:59:51 GMT
See http://hudson.zones.apache.org/hudson/job/HBase-Patch/227/changes

Changes:

[jimk] HBASE-679 Regionserver addresses are still not right in the new tables page

Passed all regression tests and PerformanceEvaluation running with multiple region servers.
table.jsp now displays the correct information

HRegionInfo:
- removed getTableNameFromRegionName and parseMetaRegionRow we have the information in the
meta table, just use it.

HServerInfo:
- I had originally made some changes here but removed them. The only remaining changes are
javadoc

MetaScanner:
- build region name using ZEROES instead of NINES. When you scan you need a row name that
sorts before the first row rather than after the last row.
- scan using COLUMN_FAMILY_ARRAY instead of COL_REGIONINFO_ARRAY. This way you also get the
server name and start code
- change api for MetaScannerVisitor so that processRow only gets the RowResult. If you have
the RowResult you have everything you need.

HConnectionManager:
- change listTables' MetaScannerVisitor to conform to new processRow api

HTable:
- change getStartKeys' MetaScannerVisitor to conform to new processRow api
- getRegionsInfo: use new processRow api, and get the server address out of the RowResult,
rather than relying on the one that is cached in HConnectionManager

ScannerCallable:
- make constructor public, add javadoc

HMaster
- change createTable to get the HRegionInfo out of the RowResult and compare table name from
HRegionInfo with that in the HRegionInfo of the table being created, instead of parsing the
table name out of the row

TestHTable
- modify test's MetaScannerVisitor to conform to the new processRow api

TestHRegionInfo
- remove testParse as parse method no longer exists

table.jsp
- change catch of IOException to catch Exception and print stack trace. At least you'll be
able to see why the server crashes if it does.

------------------------------------------
[...truncated 31256 lines...]
    [junit] 	at org.apache.hadoop.dfs.DataNode$DataXceiver.run(DataNode.java:968)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2008-07-19 20:59:43,358 ERROR [org.apache.hadoop.dfs.DataNode$DataXceiver@1ae0436]
dfs.DataNode$DataXceiver(999): 127.0.0.1:59541:DataXceiver: java.io.IOException: Broken pipe
    [junit] 	at sun.nio.ch.FileDispatcher.write0(Native Method)
    [junit] 	at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:29)
    [junit] 	at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:104)
    [junit] 	at sun.nio.ch.IOUtil.write(IOUtil.java:75)
    [junit] 	at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:334)
    [junit] 	at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:53)
    [junit] 	at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:140)
    [junit] 	at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:144)
    [junit] 	at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:105)
    [junit] 	at java.io.BufferedOutputStream.write(BufferedOutputStream.java:105)
    [junit] 	at java.io.DataOutputStream.write(DataOutputStream.java:90)
    [junit] 	at org.apache.hadoop.dfs.DataNode$BlockSender.sendChunks(DataNode.java:1774)
    [junit] 	at org.apache.hadoop.dfs.DataNode$BlockSender.sendBlock(DataNode.java:1813)
    [junit] 	at org.apache.hadoop.dfs.DataNode$DataXceiver.readBlock(DataNode.java:1039)
    [junit] 	at org.apache.hadoop.dfs.DataNode$DataXceiver.run(DataNode.java:968)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] 2008-07-19 20:59:43,434 INFO  [main] util.TestMigrate(174): Iterated over 9000
rows.
    [junit] 2008-07-19 20:59:43,568 INFO  [main] util.TestMigrate(174): Iterated over 10000
rows.
    [junit] 2008-07-19 20:59:43,697 INFO  [main] util.TestMigrate(174): Iterated over 11000
rows.
    [junit] 2008-07-19 20:59:43,824 INFO  [main] util.TestMigrate(174): Iterated over 12000
rows.
    [junit] 2008-07-19 20:59:44,010 DEBUG [IPC Server handler 4 on 60000] master.ServerManager(570):
Total Load: 5, Num Servers: 1, Avg Load: 5.0
    [junit] 2008-07-19 20:59:44,028 INFO  [main] util.TestMigrate(174): Iterated over 13000
rows.
    [junit] 2008-07-19 20:59:44,141 INFO  [main] util.TestMigrate(174): Iterated over 14000
rows.
    [junit] 2008-07-19 20:59:44,297 INFO  [main] util.TestMigrate(174): Iterated over 15000
rows.
    [junit] 2008-07-19 20:59:44,395 INFO  [main] util.TestMigrate(174): Iterated over 16000
rows.
    [junit] 2008-07-19 20:59:44,471 DEBUG [RegionServer:0.cacheFlusher] regionserver.HStore(636):
Added /user/hudson/hbase/.META./1028785192/historian/mapfiles/7196617386948605394 with 9 entries,
sequence id 35200, data size 897.0, file size 1.1k
    [junit] 2008-07-19 20:59:44,498 INFO  [main] util.TestMigrate(174): Iterated over 17000
rows.
    [junit] 2008-07-19 20:59:44,581 DEBUG [main] client.HTable$ClientScanner(1261): Advancing
forward from region REGION => {NAME => 'TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468',
STARTKEY => 'mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|', ENDKEY => '', ENCODED =>
1971203659, TABLE => {{NAME => 'TestUpgrade', IS_ROOT => 'false', IS_META => 'false',
FAMILIES => [{NAME => 'column_a', BLOOMFILTER => 'false', VERSIONS => '2147483647',
COMPRESSION => 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY => 'false',
BLOCKCACHE => 'false'}, {NAME => 'column_b', BLOOMFILTER => 'false', VERSIONS =>
'2147483647', COMPRESSION => 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY
=> 'false', BLOCKCACHE => 'false'}]}}
    [junit] 2008-07-19 20:59:44,582 DEBUG [main] hbase.LocalHBaseCluster(253): Shutting down
HBase Cluster
    [junit] 2008-07-19 20:59:44,582 INFO  [main] master.HMaster(582): Cluster shutdown requested.
Starting to quiesce servers
    [junit] 2008-07-19 20:59:45,018 INFO  [RegionServer:0] regionserver.HRegionServer(332):
MSG_REGIONSERVER_QUIESCE
    [junit] 2008-07-19 20:59:45,019 INFO  [RegionServer:0.worker] regionserver.HRegionServer$Worker(808):
MSG_REGIONSERVER_QUIESCE
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegionServer(979):
closing region TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegion(566):
Compactions and cache flushes disabled for region TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegion(581):
Updates and scanners disabled for region TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegion(596):
No more active scanners for region TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegion(602):
No more row locks outstanding on region TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,020 DEBUG [RegionServer:0.worker] regionserver.HRegion(1003):
Started memcache flush for region TestUpgrade,,1199736362468. Current region memcache size
0.0
    [junit] 2008-07-19 20:59:45,038 DEBUG [RegionServer:0.cacheFlusher] regionserver.HStore(636):
Added /user/hudson/hbase/.META./1028785192/info/mapfiles/5040505316266387170 with 6 entries,
sequence id 35200, data size 430.0, file size 624.0
    [junit] 2008-07-19 20:59:45,038 DEBUG [RegionServer:0.cacheFlusher] regionserver.HRegion(1075):
Finished memcache flush for region .META.,,1 in 1701ms, sequence id=35200, compaction requested=true
    [junit] 2008-07-19 20:59:45,039 DEBUG [RegionServer:0.cacheFlusher] regionserver.CompactSplitThread(119):
Compaction requested for region: .META.,,1
    [junit] 2008-07-19 20:59:45,039 DEBUG [RegionServer:0.worker] regionserver.HRegion(1075):
Finished memcache flush for region TestUpgrade,,1199736362468 in 19ms, sequence id=35201,
compaction requested=false
    [junit] 2008-07-19 20:59:45,039 INFO  [RegionServer:0.compactor] regionserver.HRegion(882):
starting compaction on region .META.,,1
    [junit] 2008-07-19 20:59:45,040 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 341377241/column_b
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 341377241/column_a
    [junit] 2008-07-19 20:59:45,043 INFO  [RegionServer:0.worker] regionserver.HRegion(615):
closed TestUpgrade,,1199736362468
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegionServer(979):
closing region TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(566):
Compactions and cache flushes disabled for region TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(581):
Updates and scanners disabled for region TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(596):
No more active scanners for region TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(602):
No more row locks outstanding on region TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(1003):
Started memcache flush for region TestUpgrade,,1199736332093. Current region memcache size
0.0
    [junit] 2008-07-19 20:59:45,043 DEBUG [RegionServer:0.worker] regionserver.HRegion(1075):
Finished memcache flush for region TestUpgrade,,1199736332093 in 0ms, sequence id=35202, compaction
requested=false
    [junit] 2008-07-19 20:59:45,045 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 1396626490/column_b
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 1396626490/column_a
    [junit] 2008-07-19 20:59:45,046 INFO  [RegionServer:0.worker] regionserver.HRegion(615):
closed TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HRegionServer(979):
closing region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HRegion(566):
Compactions and cache flushes disabled for region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HRegion(581):
Updates and scanners disabled for region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HRegion(596):
No more active scanners for region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,046 DEBUG [RegionServer:0.worker] regionserver.HRegion(602):
No more row locks outstanding on region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,047 DEBUG [RegionServer:0.worker] regionserver.HRegion(1003):
Started memcache flush for region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468.
Current region memcache size 0.0
    [junit] 2008-07-19 20:59:45,048 DEBUG [RegionServer:0.worker] regionserver.HRegion(1075):
Finished memcache flush for region TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
in 1ms, sequence id=35203, compaction requested=false
    [junit] 2008-07-19 20:59:45,050 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 1971203659/column_b
    [junit] 2008-07-19 20:59:45,051 DEBUG [RegionServer:0.worker] regionserver.HStore(535):
closed 1971203659/column_a
    [junit] 2008-07-19 20:59:45,051 INFO  [RegionServer:0.worker] regionserver.HRegion(615):
closed TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468
    [junit] 2008-07-19 20:59:45,087 DEBUG [RegionServer:0.compactor] regionserver.HStore(780):
started compaction of 3 files into /user/hudson/hbase/.META./compaction.dir/1028785192/info/mapfiles/8623175031624719667
    [junit] 2008-07-19 20:59:45,144 WARN  [RegionServer:0.compactor] regionserver.HStore(919):
Exception closing reader for 1028785192/info
    [junit] java.io.IOException: Stream closed
    [junit] 	at org.apache.hadoop.dfs.DFSClient$DFSInputStream.close(DFSClient.java:1319)
    [junit] 	at java.io.FilterInputStream.close(FilterInputStream.java:155)
    [junit] 	at org.apache.hadoop.io.SequenceFile$Reader.close(SequenceFile.java:1581)
    [junit] 	at org.apache.hadoop.io.MapFile$Reader.close(MapFile.java:577)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.closeCompactionReaders(HStore.java:917)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compactHStoreFiles(HStore.java:910)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compact(HStore.java:787)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:887)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:847)
    [junit] 	at org.apache.hadoop.hbase.regionserver.CompactSplitThread.run(CompactSplitThread.java:84)
    [junit] 2008-07-19 20:59:45,145 WARN  [RegionServer:0.compactor] regionserver.HStore(919):
Exception closing reader for 1028785192/info
    [junit] java.io.IOException: Stream closed
    [junit] 	at org.apache.hadoop.dfs.DFSClient$DFSInputStream.close(DFSClient.java:1319)
    [junit] 	at java.io.FilterInputStream.close(FilterInputStream.java:155)
    [junit] 	at org.apache.hadoop.io.SequenceFile$Reader.close(SequenceFile.java:1581)
    [junit] 	at org.apache.hadoop.io.MapFile$Reader.close(MapFile.java:577)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.closeCompactionReaders(HStore.java:917)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compactHStoreFiles(HStore.java:910)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compact(HStore.java:787)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:887)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:847)
    [junit] 	at org.apache.hadoop.hbase.regionserver.CompactSplitThread.run(CompactSplitThread.java:84)
    [junit] 2008-07-19 20:59:45,145 WARN  [RegionServer:0.compactor] regionserver.HStore(919):
Exception closing reader for 1028785192/info
    [junit] java.io.IOException: Stream closed
    [junit] 	at org.apache.hadoop.dfs.DFSClient$DFSInputStream.close(DFSClient.java:1319)
    [junit] 	at java.io.FilterInputStream.close(FilterInputStream.java:155)
    [junit] 	at org.apache.hadoop.io.SequenceFile$Reader.close(SequenceFile.java:1581)
    [junit] 	at org.apache.hadoop.io.MapFile$Reader.close(MapFile.java:577)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.closeCompactionReaders(HStore.java:917)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compactHStoreFiles(HStore.java:910)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HStore.compact(HStore.java:787)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:887)
    [junit] 	at org.apache.hadoop.hbase.regionserver.HRegion.compactStores(HRegion.java:847)
    [junit] 	at org.apache.hadoop.hbase.regionserver.CompactSplitThread.run(CompactSplitThread.java:84)
    [junit] 2008-07-19 20:59:45,245 DEBUG [RegionServer:0.compactor] regionserver.HStore(1000):
moving /user/hudson/hbase/.META./compaction.dir/1028785192/info/mapfiles/8623175031624719667
to /user/hudson/hbase/.META./1028785192/info/mapfiles/5956727266877143341
    [junit] 2008-07-19 20:59:45,460 DEBUG [RegionServer:0.compactor] regionserver.HStore(799):
Completed compaction of 1028785192/info store size is 3.8k
    [junit] 2008-07-19 20:59:45,491 INFO  [RegionServer:0.compactor] regionserver.HRegion(896):
compaction completed on region .META.,,1 in 0sec
    [junit] 2008-07-19 20:59:45,687 INFO  [RegionManager.metaScanner] master.BaseScanner(149):
RegionManager.metaScanner scanning meta region {regionname: .META.,,1, startKey: <>,
server: 127.0.0.1:59729}
    [junit] 2008-07-19 20:59:45,695 DEBUG [RegionManager.metaScanner] master.BaseScanner(175):
RegionManager.metaScannerREGION => {NAME => 'TestUpgrade,,1199736332093', STARTKEY =>
'', ENDKEY => '', ENCODED => 1396626490, SPLIT => true, TABLE => {{NAME =>
'TestUpgrade', IS_ROOT => 'false', IS_META => 'false', FAMILIES => [{NAME => 'column_a',
BLOOMFILTER => 'false', VERSIONS => '2147483647', COMPRESSION => 'NONE', LENGTH =>
'2147483647', TTL => '-1', IN_MEMORY => 'false', BLOCKCACHE => 'false'}, {NAME =>
'column_b', BLOOMFILTER => 'false', VERSIONS => '2147483647', COMPRESSION => 'NONE',
LENGTH => '2147483647', TTL => '-1', IN_MEMORY => 'false', BLOCKCACHE => 'false'}]}}},
SERVER => '127.0.0.1:59729', STARTCODE => 1216501170450
    [junit] 2008-07-19 20:59:45,695 WARN  [RegionManager.metaScanner] master.BaseScanner(242):
Region is split but not offline: TestUpgrade,,1199736332093
    [junit] 2008-07-19 20:59:45,696 DEBUG [RegionManager.metaScanner] master.BaseScanner(175):
RegionManager.metaScannerREGION => {NAME => 'TestUpgrade,,1199736362468', STARTKEY =>
'', ENDKEY => 'mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|', ENCODED => 341377241, TABLE
=> {{NAME => 'TestUpgrade', IS_ROOT => 'false', IS_META => 'false', FAMILIES =>
[{NAME => 'column_a', BLOOMFILTER => 'false', VERSIONS => '2147483647', COMPRESSION
=> 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY => 'false', BLOCKCACHE
=> 'false'}, {NAME => 'column_b', BLOOMFILTER => 'false', VERSIONS => '2147483647',
COMPRESSION => 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY => 'false',
BLOCKCACHE => 'false'}]}}}, SERVER => '127.0.0.1:59729', STARTCODE => 1216501170450
    [junit] 2008-07-19 20:59:45,697 DEBUG [RegionManager.metaScanner] master.BaseScanner(175):
RegionManager.metaScannerREGION => {NAME => 'TestUpgrade,mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|,1199736362468',
STARTKEY => 'mwu~`@#$%^&*()-_+=:;',.<>/?[]{}|', ENDKEY => '', ENCODED =>
1971203659, TABLE => {{NAME => 'TestUpgrade', IS_ROOT => 'false', IS_META => 'false',
FAMILIES => [{NAME => 'column_a', BLOOMFILTER => 'false', VERSIONS => '2147483647',
COMPRESSION => 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY => 'false',
BLOCKCACHE => 'false'}, {NAME => 'column_b', BLOOMFILTER => 'false', VERSIONS =>
'2147483647', COMPRESSION => 'NONE', LENGTH => '2147483647', TTL => '-1', IN_MEMORY
=> 'false', BLOCKCACHE => 'false'}]}}}, SERVER => '127.0.0.1:59729', STARTCODE =>
1216501170450
    [junit] 2008-07-19 20:59:45,697 WARN  [RegionManager.metaScanner] master.MetaScanner(75):
Scan one META region: {regionname: .META.,,1, startKey: <>, server: 127.0.0.1:59729}
    [junit] A record version mismatch occured. Expecting v0, found v32
    [junit] 	at org.apache.hadoop.io.VersionedWritable.readFields(VersionedWritable.java:46)
    [junit] 	at org.apache.hadoop.hbase.HRegionInfo.readFields(HRegionInfo.java:368)
    [junit] 	at org.apache.hadoop.hbase.util.Writables.getWritable(Writables.java:84)
    [junit] 	at org.apache.hadoop.hbase.util.Writables.getHRegionInfo(Writables.java:98)
    [junit] 	at org.apache.hadoop.hbase.util.Writables.getHRegionInfo(Writables.java:122)
    [junit] 	at org.apache.hadoop.hbase.master.BaseScanner.hasReferences(BaseScanner.java:304)
    [junit] 	at org.apache.hadoop.hbase.master.BaseScanner.cleanupSplits(BaseScanner.java:265)
    [junit] 	at org.apache.hadoop.hbase.master.BaseScanner.scanRegion(BaseScanner.java:226)
    [junit] 	at org.apache.hadoop.hbase.master.MetaScanner.scanOneMetaRegion(MetaScanner.java:69)
    [junit] 	at org.apache.hadoop.hbase.master.MetaScanner.maintenanceScan(MetaScanner.java:124)
    [junit] 	at org.apache.hadoop.hbase.master.BaseScanner.chore(BaseScanner.java:139)
    [junit] 	at org.apache.hadoop.hbase.Chore.run(Chore.java:63)
    [junit] 2008-07-19 20:59:45,698 INFO  [RegionManager.metaScanner] master.MetaScanner(138):
all meta regions scanned
    [junit] 2008-07-19 20:59:46,028 INFO  [IPC Server handler 0 on 60000] master.ServerManager(165):
Region server 127.0.0.1:59729 quiesced
    [junit] 2008-07-19 20:59:46,029 INFO  [IPC Server handler 0 on 60000] master.ServerManager(174):
All user tables quiesced. Proceeding with shutdown
    [junit] 2008-07-19 20:59:46,029 DEBUG [IPC Server handler 0 on 60000] master.RegionManager(453):
telling root scanner to stop
    [junit] 2008-07-19 20:59:46,029 DEBUG [IPC Server handler 0 on 60000] master.RegionManager(457):
telling meta scanner to stop
    [junit] 2008-07-19 20:59:46,030 INFO  [RegionManager.rootScanner] hbase.Chore(74): RegionManager.rootScanner
exiting
    [junit] 2008-07-19 20:59:46,030 DEBUG [IPC Server handler 0 on 60000] master.RegionManager(461):
meta and root scanners notified
    [junit] 2008-07-19 20:59:46,030 INFO  [RegionManager.metaScanner] hbase.Chore(74): RegionManager.metaScanner
exiting
    [junit] 2008-07-19 20:59:46,031 INFO  [RegionServer:0] regionserver.HRegionServer(332):
MSG_REGIONSERVER_STOP
    [junit] 2008-07-19 20:59:46,031 DEBUG [RegionServer:0] hbase.RegionHistorian(316): Offlined
    [junit] 2008-07-19 20:59:46,032 DEBUG [RegionServer:0] regionserver.HRegionServer(945):
closing region .META.,,1
    [junit] 2008-07-19 20:59:46,033 DEBUG [RegionServer:0] regionserver.HRegion(566): Compactions
and cache flushes disabled for region .META.,,1
    [junit] 2008-07-19 20:59:46,033 DEBUG [RegionServer:0] regionserver.HRegion(581): Updates
and scanners disabled for region .META.,,1
    [junit] 2008-07-19 20:59:46,033 DEBUG [RegionServer:0] regionserver.HRegion(596): No more
active scanners for region .META.,,1
    [junit] 2008-07-19 20:59:46,033 DEBUG [RegionServer:0] regionserver.HRegion(602): No more
row locks outstanding on region .META.,,1
    [junit] 2008-07-19 20:59:46,033 DEBUG [RegionServer:0] regionserver.HRegion(1003): Started
memcache flush for region .META.,,1. Current region memcache size 0.0
    [junit] 2008-07-19 20:59:46,034 INFO  [RegionServer:0.logRoller] regionserver.LogRoller(93):
LogRoller exiting.
    [junit] 2008-07-19 20:59:46,037 INFO  [RegionServer:0.cacheFlusher] regionserver.Flusher(109):
RegionServer:0.cacheFlusher exiting
    [junit] 2008-07-19 20:59:46,037 DEBUG [RegionServer:0] regionserver.HRegion(1075): Finished
memcache flush for region .META.,,1 in 4ms, sequence id=35204, compaction requested=false
    [junit] 2008-07-19 20:59:46,034 INFO  [RegionServer:0.compactor] regionserver.CompactSplitThread(112):
RegionServer:0.compactor exiting
    [junit] 2008-07-19 20:59:46,039 DEBUG [RegionServer:0] regionserver.HStore(535): closed
1028785192/historian
    [junit] 2008-07-19 20:59:46,040 DEBUG [RegionServer:0] regionserver.HStore(535): closed
1028785192/info
    [junit] 2008-07-19 20:59:46,040 INFO  [RegionServer:0] regionserver.HRegion(615): closed
.META.,,1
    [junit] 2008-07-19 20:59:46,040 DEBUG [RegionServer:0] regionserver.HRegionServer(945):
closing region -ROOT-,,0
    [junit] 2008-07-19 20:59:46,040 DEBUG [RegionServer:0] regionserver.HRegion(566): Compactions
and cache flushes disabled for region -ROOT-,,0
    [junit] 2008-07-19 20:59:46,041 DEBUG [RegionServer:0] regionserver.HRegion(581): Updates
and scanners disabled for region -ROOT-,,0
    [junit] 2008-07-19 20:59:46,041 DEBUG [RegionServer:0] regionserver.HRegion(596): No more
active scanners for region -ROOT-,,0
    [junit] 2008-07-19 20:59:46,041 DEBUG [RegionServer:0] regionserver.HRegion(602): No more
row locks outstanding on region -ROOT-,,0
    [junit] 2008-07-19 20:59:46,041 DEBUG [RegionServer:0] regionserver.HRegion(1003): Started
memcache flush for region -ROOT-,,0. Current region memcache size 0.0
    [junit] 2008-07-19 20:59:46,041 DEBUG [RegionServer:0] regionserver.HRegion(1075): Finished
memcache flush for region -ROOT-,,0 in 0ms, sequence id=35205, compaction requested=false
    [junit] 2008-07-19 20:59:46,042 DEBUG [RegionServer:0] regionserver.HStore(535): closed
70236052/info
    [junit] 2008-07-19 20:59:46,042 INFO  [RegionServer:0] regionserver.HRegion(615): closed
-ROOT-,,0
    [junit] 2008-07-19 20:59:46,042 DEBUG [RegionServer:0] regionserver.HLog(337): closing
log writer in hdfs://localhost:59537/user/hudson/hbase/log_127.0.0.1_1216501170450_59729
    [junit] 2008-07-19 20:59:46,057 INFO  [RegionServer:0.worker] regionserver.HRegionServer$Worker(862):
worker thread exiting
    [junit] 2008-07-19 20:59:46,090 INFO  [RegionServer:0] regionserver.HRegionServer(477):
telling master that region server is shutting down at: 127.0.0.1:59729
    [junit] 2008-07-19 20:59:46,090 INFO  [IPC Server handler 3 on 60000] master.ServerManager(524):
Cancelling lease for 127.0.0.1:59729
    [junit] 2008-07-19 20:59:46,090 INFO  [IPC Server handler 3 on 60000] master.ServerManager(242):
Region server 127.0.0.1:59729: MSG_REPORT_EXITING -- lease cancelled
    [junit] 2008-07-19 20:59:46,091 INFO  [RegionServer:0] regionserver.HRegionServer(484):
stopping server at: 127.0.0.1:59729
    [junit] 2008-07-19 20:59:46,091 INFO  [RegionServer:0] regionserver.HRegionServer(488):
RegionServer:0 exiting
    [junit] 2008-07-19 20:59:46,987 DEBUG [HMaster] master.RegionManager(453): telling root
scanner to stop
    [junit] 2008-07-19 20:59:46,987 DEBUG [HMaster] master.RegionManager(457): telling meta
scanner to stop
    [junit] 2008-07-19 20:59:46,987 DEBUG [HMaster] master.RegionManager(461): meta and root
scanners notified
    [junit] 2008-07-19 20:59:46,987 DEBUG [HMaster] hbase.RegionHistorian(316): Offlined
    [junit] 2008-07-19 20:59:46,991 INFO  [HMaster] hbase.Leases(115): HMaster closing leases
    [junit] 2008-07-19 20:59:46,991 INFO  [HMaster] hbase.Leases(122): HMaster closed leases
    [junit] 2008-07-19 20:59:46,991 INFO  [HMaster] master.HMaster(385): HMaster main thread
exiting
    [junit] 2008-07-19 20:59:47,027 INFO  [RegionServer:0.leaseChecker] hbase.Leases(115):
RegionServer:0.leaseChecker closing leases
    [junit] 2008-07-19 20:59:47,027 INFO  [RegionServer:0.leaseChecker] hbase.Leases(122):
RegionServer:0.leaseChecker closed leases
    [junit] 2008-07-19 20:59:47,097 INFO  [main] hbase.LocalHBaseCluster(282): Shutdown HMaster
1 region server(s)
    [junit] 2008-07-19 20:59:47,097 INFO  [main] hbase.HBaseTestCase(614): Shutting down FileSystem
    [junit] 2008-07-19 20:59:47,767 INFO  [main] hbase.HBaseTestCase(621): Shutting down Mini
DFS 
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 1
    [junit] 2008-07-19 20:59:47,768 INFO  [Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=59544]]
util.ThreadedServer$Acceptor(656): Stopping Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=59544]
    [junit] 2008-07-19 20:59:47,771 INFO  [main] http.SocketListener(212): Stopped SocketListener
on 127.0.0.1:59544
    [junit] 2008-07-19 20:59:47,890 INFO  [main] util.Container(156): Stopped HttpContext[/static,/static]
    [junit] 2008-07-19 20:59:47,891 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.servlet.WebApplicationHandler@940f82
    [junit] 2008-07-19 20:59:47,971 INFO  [main] util.Container(156): Stopped WebApplicationContext[/,/]
    [junit] 2008-07-19 20:59:47,971 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.Server@d8ca48
    [junit] 2008-07-19 20:59:48,887 INFO  [ServerManager.leaseChecker] hbase.Leases(115):
ServerManager.leaseChecker closing leases
    [junit] 2008-07-19 20:59:48,887 INFO  [ServerManager.leaseChecker] hbase.Leases(122):
ServerManager.leaseChecker closed leases
    [junit] Shutting down DataNode 0
    [junit] 2008-07-19 20:59:48,977 INFO  [Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=59542]]
util.ThreadedServer$Acceptor(656): Stopping Acceptor ServerSocket[addr=localhost/127.0.0.1,port=0,localport=59542]
    [junit] 2008-07-19 20:59:48,978 INFO  [main] http.SocketListener(212): Stopped SocketListener
on 127.0.0.1:59542
    [junit] 2008-07-19 20:59:49,054 INFO  [main] util.Container(156): Stopped HttpContext[/static,/static]
    [junit] 2008-07-19 20:59:49,055 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.servlet.WebApplicationHandler@569c60
    [junit] 2008-07-19 20:59:49,131 INFO  [main] util.Container(156): Stopped WebApplicationContext[/,/]
    [junit] 2008-07-19 20:59:49,132 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.Server@17779e3
    [junit] 2008-07-19 20:59:49,238 INFO  [main] http.SocketListener(212): Stopped SocketListener
on 0.0.0.0:59538
    [junit] 2008-07-19 20:59:49,321 INFO  [main] util.Container(156): Stopped HttpContext[/static,/static]
    [junit] 2008-07-19 20:59:49,322 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.servlet.WebApplicationHandler@cf710e
    [junit] 2008-07-19 20:59:49,396 INFO  [main] util.Container(156): Stopped WebApplicationContext[/,/]
    [junit] 2008-07-19 20:59:49,397 INFO  [main] util.Container(156): Stopped org.mortbay.jetty.Server@995a79
    [junit] 2008-07-19 20:59:49,397 ERROR [org.apache.hadoop.dfs.FSNamesystem$ResolutionMonitor@1ad98ef]
dfs.FSNamesystem$ResolutionMonitor(1950): java.lang.InterruptedException
    [junit] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:1899)
    [junit] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1934)
    [junit] 	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:358)
    [junit] 	at org.apache.hadoop.dfs.FSNamesystem$ResolutionMonitor.run(FSNamesystem.java:1927)
    [junit] 	at java.lang.Thread.run(Thread.java:619)
    [junit] 
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 42.939 sec
    [junit] 2008-07-19 20:59:49,441 INFO  [Thread-416] regionserver.HRegionServer$ShutdownThread(185):
Starting shutdown thread.
    [junit] 2008-07-19 20:59:49,441 INFO  [Thread-416] regionserver.HRegionServer$ShutdownThread(190):
Shutdown thread complete
    [junit] Running org.apache.hadoop.hbase.util.TestRootPath
    [junit] 2008-07-19 20:59:49,966 INFO  [main] util.TestRootPath(60): Got expected exception
when checking invalid path:
    [junit] java.io.IOException: Root directory does not contain a scheme
    [junit] 	at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSUtils.java:160)
    [junit] 	at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(TestRootPath.java:56)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:597)
    [junit] 	at junit.framework.TestCase.runTest(TestCase.java:154)
    [junit] 	at junit.framework.TestCase.runBare(TestCase.java:127)
    [junit] 	at junit.framework.TestResult$1.protect(TestResult.java:106)
    [junit] 	at junit.framework.TestResult.runProtected(TestResult.java:124)
    [junit] 	at junit.framework.TestResult.run(TestResult.java:109)
    [junit] 	at junit.framework.TestCase.run(TestCase.java:118)
    [junit] 	at junit.framework.TestSuite.runTest(TestSuite.java:208)
    [junit] 	at junit.framework.TestSuite.run(TestSuite.java:203)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:421)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:912)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:766)
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.059 sec
    [junit] Running org.onelab.test.TestFilter
    [junit] 2008-07-19 20:59:50,444 INFO  [main] test.TestFilter(242): Checking for false
negatives
    [junit] 2008-07-19 20:59:50,451 INFO  [main] test.TestFilter(253): Checking for false
positives
    [junit] 2008-07-19 20:59:50,451 INFO  [main] test.TestFilter(260): Success!
    [junit] 2008-07-19 20:59:50,452 INFO  [main] test.TestFilter(224): Checking serialization/deserialization
    [junit] 2008-07-19 20:59:50,454 INFO  [main] test.TestFilter(242): Checking for false
negatives
    [junit] 2008-07-19 20:59:50,456 INFO  [main] test.TestFilter(253): Checking for false
positives
    [junit] 2008-07-19 20:59:50,457 INFO  [main] test.TestFilter(260): Success!
    [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.07 sec

BUILD FAILED
/zonestorage/hudson/home/hudson/hudson/jobs/HBase-Patch/workspace/trunk/build.xml:389: Tests
failed!

Total time: 42 minutes 33 seconds
Recording test results


Mime
View raw message