See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/237/changes
Changes: [stack] HADOOP-1888 NullPointerException in HMemcacheScanner ------------------------------------------ [...truncated 35378 lines...] [junit] 07/09/15 10:01:08 DEBUG hbase.HRegion: Snapshotted memcache for region -ROOT-,,0 with sequence id 22 and entries 2 [junit] 07/09/15 10:01:08 INFO hbase.HRegionServer: worker thread exiting [junit] 07/09/15 10:01:09 DEBUG hbase.HStore: Added -ROOT-,,0/info/1755394711264440622 with sequence id 22 and size 230.0 [junit] 07/09/15 10:01:09 DEBUG hbase.HRegion: Finished memcache flush for region -ROOT-,,0 in 640ms [junit] 07/09/15 10:01:09 DEBUG hbase.HStore: closed -ROOT-,,0/info [junit] 07/09/15 10:01:09 INFO hbase.HRegion: closed -ROOT-,,0 [junit] 07/09/15 10:01:09 DEBUG hbase.HRegionServer: closing region .META.,,1 [junit] 07/09/15 10:01:09 DEBUG hbase.HRegion: Started memcache flush for region .META.,,1. Size 2.3k [junit] 07/09/15 10:01:09 DEBUG hbase.HRegion: Snapshotted memcache for region .META.,,1 with sequence id 23 and entries 18 [junit] 07/09/15 10:01:09 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:36933, startcode: 2675276097869692373, load: (requests: 0 regions: 6)] [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: Added .META.,,1/info/5417924417889770580 with sequence id 23 and size 2.7k [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Finished memcache flush for region .META.,,1 in 467ms [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: closed .META.,,1/info [junit] 07/09/15 10:01:10 INFO hbase.HRegion: closed .META.,,1 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegionServer: closing region testCreateDeleteTableDblQuote,,3649428624773351629 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Started memcache flush for region testCreateDeleteTableDblQuote,,3649428624773351629. Size 0.0 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: closed testCreateDeleteTableDblQuote,,3649428624773351629/testCreateDeleteTable [junit] 07/09/15 10:01:10 INFO hbase.HRegion: closed testCreateDeleteTableDblQuote,,3649428624773351629 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegionServer: closing region testCreateDeleteTableSglQuote,,6428579265680550569 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Started memcache flush for region testCreateDeleteTableSglQuote,,6428579265680550569. Size 0.0 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: closed testCreateDeleteTableSglQuote,,6428579265680550569/testCreateDeleteTable [junit] 07/09/15 10:01:10 INFO hbase.HRegion: closed testCreateDeleteTableSglQuote,,6428579265680550569 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegionServer: closing region testCreateDeleteTabletestCreateDeleteTableDblQuote,,-871440376270905159 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Started memcache flush for region testCreateDeleteTabletestCreateDeleteTableDblQuote,,-871440376270905159. Size 0.0 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: closed testCreateDeleteTabletestCreateDeleteTableDblQuote,,-871440376270905159/testCreateDeleteTableDblQuote [junit] 07/09/15 10:01:10 INFO hbase.HRegion: closed testCreateDeleteTabletestCreateDeleteTableDblQuote,,-871440376270905159 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegionServer: closing region testCreateDeleteTabletestCreateDeleteTableSglQuote,,2037717666475740737 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Started memcache flush for region testCreateDeleteTabletestCreateDeleteTableSglQuote,,2037717666475740737. Size 0.0 [junit] 07/09/15 10:01:10 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:10 DEBUG hbase.HStore: closed testCreateDeleteTabletestCreateDeleteTableSglQuote,,2037717666475740737/testCreateDeleteTableSglQuote [junit] 07/09/15 10:01:10 INFO hbase.HRegion: closed testCreateDeleteTabletestCreateDeleteTableSglQuote,,2037717666475740737 [junit] 07/09/15 10:01:10 DEBUG hbase.HLog: closing log writer in /hbase/log_140.211.11.75_36933 [junit] 07/09/15 10:01:10 INFO hbase.HRegionServer: stopping server at: 140.211.11.75:36933 [junit] 07/09/15 10:01:10 INFO hbase.HRegionServer: HRegionServer stopped at: 140.211.11.75:36933 [junit] 07/09/15 10:01:10 INFO hbase.HRegionServer: main thread exiting [junit] 07/09/15 10:01:10 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:36933, startcode: 2675276097869692373, load: (requests: 0 regions: 6)] [junit] 07/09/15 10:01:11 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:36933, startcode: 2675276097869692373, load: (requests: 0 regions: 6)] [junit] 07/09/15 10:01:12 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:36933, startcode: 2675276097869692373, load: (requests: 0 regions: 6)] [junit] 07/09/15 10:01:13 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:36933, startcode: 2675276097869692373, load: (requests: 0 regions: 6)] [junit] 07/09/15 10:01:14 INFO hbase.Leases: Lease expired 1437160427/1437160427 [junit] 07/09/15 10:01:14 INFO hbase.HMaster: 140.211.11.75:36933 lease expired [junit] 07/09/15 10:01:14 INFO hbase.Leases: closing leases [junit] 07/09/15 10:01:14 WARN hbase.HMaster: MsgQueue.put was interrupted (If we are exiting, this msg can be ignored [junit] 07/09/15 10:01:14 INFO hbase.HMaster: MetaScanner exiting [junit] 07/09/15 10:01:14 INFO hbase.HMaster: RootScanner exiting [junit] 07/09/15 10:01:17 INFO hbase.Leases: leases closed [junit] 07/09/15 10:01:17 INFO hbase.HMaster: HMaster main thread exiting [junit] 07/09/15 10:01:17 INFO hbase.MiniHBaseCluster: Shutdown HMaster 1 region server(s) [junit] 07/09/15 10:01:17 INFO hbase.MiniHBaseCluster: Shutting down Mini DFS cluster [junit] 07/09/15 10:01:18 WARN dfs.DataNode: java.io.IOException: java.lang.InterruptedException [junit] at org.apache.hadoop.fs.Command.run(Command.java:40) [junit] at org.apache.hadoop.fs.DU.getUsed(DU.java:56) [junit] at org.apache.hadoop.dfs.FSDataset$FSVolume.getDfsUsed(FSDataset.java:299) [junit] at org.apache.hadoop.dfs.FSDataset$FSVolume.getAvailable(FSDataset.java:307) [junit] at org.apache.hadoop.dfs.FSDataset$FSVolumeSet.getRemaining(FSDataset.java:412) [junit] at org.apache.hadoop.dfs.FSDataset.getRemaining(FSDataset.java:505) [junit] at org.apache.hadoop.dfs.DataNode.offerService(DataNode.java:485) [junit] at org.apache.hadoop.dfs.DataNode.run(DataNode.java:1310) [junit] at java.lang.Thread.run(Thread.java:595) [junit] 07/09/15 10:01:18 WARN fs.FSNamesystem: PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep interrupted [junit] 07/09/15 10:01:19 INFO hbase.MiniHBaseCluster: Shutting down FileSystem [junit] 07/09/15 10:01:21 INFO hbase.HMaster: Root region dir: /hbase/hregion_-ROOT-,,0 [junit] 07/09/15 10:01:21 INFO hbase.HMaster: bootstrap: creating ROOT and first META regions [junit] 07/09/15 10:01:21 DEBUG hbase.HLog: new log writer created at /hbase/hregion_-ROOT-,,0/log/hlog.dat.000 [junit] 07/09/15 10:01:21 DEBUG hbase.HStore: starting -ROOT-,,0/info (no reconstruction log) [junit] 07/09/15 10:01:21 DEBUG hbase.HStore: maximum sequence id for hstore -ROOT-,,0/info is -1 [junit] 07/09/15 10:01:21 DEBUG hbase.HRegion: maximum sequence id for region -ROOT-,,0 is 0 [junit] 07/09/15 10:01:21 INFO hbase.HRegion: region -ROOT-,,0 available [junit] 07/09/15 10:01:21 DEBUG hbase.HLog: new log writer created at /hbase/hregion_.META.,,1/log/hlog.dat.000 [junit] 07/09/15 10:01:21 DEBUG hbase.HStore: starting .META.,,1/info (no reconstruction log) [junit] 07/09/15 10:01:21 DEBUG hbase.HStore: maximum sequence id for hstore .META.,,1/info is -1 [junit] 07/09/15 10:01:21 DEBUG hbase.HRegion: maximum sequence id for region .META.,,1 is 0 [junit] 07/09/15 10:01:21 INFO hbase.HRegion: region .META.,,1 available [junit] 07/09/15 10:01:21 DEBUG hbase.HRegion: Started memcache flush for region -ROOT-,,0. Size 86.0 [junit] 07/09/15 10:01:21 DEBUG hbase.HRegion: Snapshotted memcache for region -ROOT-,,0 with sequence id 1 and entries 1 [junit] 07/09/15 10:01:22 DEBUG hbase.HStore: Added -ROOT-,,0/info/7329227049009233748 with sequence id 1 and size 210.0 [junit] 07/09/15 10:01:22 DEBUG hbase.HRegion: Finished memcache flush for region -ROOT-,,0 in 815ms [junit] 07/09/15 10:01:22 DEBUG hbase.HStore: closed -ROOT-,,0/info [junit] 07/09/15 10:01:22 INFO hbase.HRegion: closed -ROOT-,,0 [junit] 07/09/15 10:01:22 DEBUG hbase.HLog: closing log writer in /hbase/hregion_-ROOT-,,0/log [junit] 07/09/15 10:01:22 DEBUG hbase.HRegion: Started memcache flush for region .META.,,1. Size 0.0 [junit] 07/09/15 10:01:22 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:22 DEBUG hbase.HStore: closed .META.,,1/info [junit] 07/09/15 10:01:22 INFO hbase.HRegion: closed .META.,,1 [junit] 07/09/15 10:01:22 DEBUG hbase.HLog: closing log writer in /hbase/hregion_.META.,,1/log [junit] 07/09/15 10:01:22 INFO hbase.HMaster: HMaster initialized on 127.0.0.1:37027 [junit] 07/09/15 10:01:22 INFO hbase.MiniHBaseCluster: Starting HRegionServers [junit] 07/09/15 10:01:22 INFO hbase.MiniHBaseCluster: Starting Master:127.0.0.1:37027 [junit] 07/09/15 10:01:23 DEBUG hbase.HRegionServer: Log dir /hbase/log_140.211.11.75_37028 [junit] 07/09/15 10:01:23 DEBUG hbase.HLog: new log writer created at /hbase/log_140.211.11.75_37028/hlog.dat.000 [junit] 07/09/15 10:01:23 INFO hbase.MiniHBaseCluster: Starting RegionServer:0 [junit] 07/09/15 10:01:23 INFO hbase.HRegionServer: HRegionServer started at: 140.211.11.75:37028 [junit] 07/09/15 10:01:23 DEBUG hbase.HRegionServer: Telling master we are up [junit] 07/09/15 10:01:23 INFO hbase.HMaster: received start message from: 140.211.11.75:37028 [junit] 07/09/15 10:01:23 DEBUG hbase.HRegionServer: Done telling master we are up [junit] 07/09/15 10:01:23 INFO hbase.HMaster: assigning region -ROOT-,,0 to the only server 140.211.11.75:37028 [junit] 07/09/15 10:01:23 INFO shell.TestHBaseShell: Running command: create table testInsertSelectDelete (testInsertSelectDelete); [junit] 07/09/15 10:01:23 INFO hbase.HRegionServer: 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] 07/09/15 10:01:23 DEBUG hbase.HStore: starting -ROOT-,,0/info (no reconstruction log) [junit] 07/09/15 10:01:23 DEBUG hbase.HStore: maximum sequence id for hstore -ROOT-,,0/info is 1 [junit] 07/09/15 10:01:23 DEBUG hbase.HRegion: maximum sequence id for region -ROOT-,,0 is 2 [junit] 07/09/15 10:01:23 INFO hbase.HRegion: region -ROOT-,,0 available [junit] 07/09/15 10:01:23 DEBUG hbase.HLog: changing sequence number from 0 to 2 [junit] 07/09/15 10:01:24 INFO hbase.HMaster: 140.211.11.75:37028 serving -ROOT-,,0 [junit] 07/09/15 10:01:24 INFO hbase.HMaster: HMaster.rootScanner scanning meta region -ROOT-,,0 on 140.211.11.75:37028 [junit] 07/09/15 10:01:24 DEBUG hbase.HMaster: HMaster.rootScanner scanner: 6526102965897833710 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] 07/09/15 10:01:24 INFO hbase.HMaster: HMaster.rootScanner scan of meta region -ROOT-,,0 complete [junit] 07/09/15 10:01:25 INFO hbase.HMaster: assigning region .META.,,1 to the only server 140.211.11.75:37028 [junit] 07/09/15 10:01:25 INFO hbase.HRegionServer: 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] 07/09/15 10:01:25 DEBUG hbase.HStore: starting .META.,,1/info (no reconstruction log) [junit] 07/09/15 10:01:25 DEBUG hbase.HStore: maximum sequence id for hstore .META.,,1/info is -1 [junit] 07/09/15 10:01:25 DEBUG hbase.HRegion: maximum sequence id for region .META.,,1 is 0 [junit] 07/09/15 10:01:25 INFO hbase.HRegion: region .META.,,1 available [junit] 07/09/15 10:01:26 INFO hbase.HMaster: 140.211.11.75:37028 serving .META.,,1 [junit] 07/09/15 10:01:26 DEBUG hbase.HMaster: Main processing loop: PendingOpenOperation from 140.211.11.75:37028 [junit] 07/09/15 10:01:26 INFO hbase.HMaster: .META.,,1 open on 140.211.11.75:37028 [junit] 07/09/15 10:01:26 INFO hbase.HMaster: updating row .META.,,1 in table -ROOT-,,0 with startcode -3196008925655207140 and server 140.211.11.75:37028 [junit] 07/09/15 10:01:26 INFO hbase.HMaster: HMaster.metaScanner scanning meta region .META.,,1 on 140.211.11.75:37028 [junit] 07/09/15 10:01:26 INFO hbase.HMaster: HMaster.metaScanner scan of meta region .META.,,1 complete [junit] 07/09/15 10:01:27 DEBUG hbase.HLog: new log writer created at /hbase/hregion_testInsertSelectDelete,,2684738361515986256/log/hlog.dat.000 [junit] 07/09/15 10:01:27 DEBUG hbase.HStore: starting testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete (no reconstruction log) [junit] 07/09/15 10:01:27 DEBUG hbase.HStore: maximum sequence id for hstore testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete is -1 [junit] 07/09/15 10:01:27 DEBUG hbase.HRegion: maximum sequence id for region testInsertSelectDelete,,2684738361515986256 is 0 [junit] 07/09/15 10:01:27 INFO hbase.HRegion: region testInsertSelectDelete,,2684738361515986256 available [junit] 07/09/15 10:01:27 DEBUG hbase.HRegion: Started memcache flush for region testInsertSelectDelete,,2684738361515986256. Size 0.0 [junit] 07/09/15 10:01:27 DEBUG hbase.HRegion: Finished memcache flush; empty snapshot [junit] 07/09/15 10:01:27 DEBUG hbase.HStore: closed testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete [junit] 07/09/15 10:01:27 INFO hbase.HRegion: closed testInsertSelectDelete,,2684738361515986256 [junit] 07/09/15 10:01:27 DEBUG hbase.HLog: closing log writer in /hbase/hregion_testInsertSelectDelete,,2684738361515986256/log [junit] 07/09/15 10:01:27 INFO hbase.HMaster: created table testInsertSelectDelete [junit] 07/09/15 10:01:27 DEBUG hbase.HConnectionManager$TableServers: No servers for testInsertSelectDelete. Doing a find... [junit] 07/09/15 10:01:27 DEBUG hbase.HConnectionManager$TableServers: Found 1 region(s) for .META. at address: 140.211.11.75:37028, 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] 07/09/15 10:01:27 DEBUG hbase.HConnectionManager$TableServers: no server address for regionname: testInsertSelectDelete,,2684738361515986256, startKey: <>, tableDesc: {name: testInsertSelectDelete, families: {testInsertSelectDelete:={name: testInsertSelectDelete, max versions: 3, compression: NONE, in memory: false, max length: 2147483647, bloom filter: none}}} [junit] 07/09/15 10:01:27 DEBUG hbase.HConnectionManager$TableServers: Sleeping. Table testInsertSelectDelete not currently being served. [junit] 07/09/15 10:01:28 INFO hbase.HMaster: assigning region testInsertSelectDelete,,2684738361515986256 to the only server 140.211.11.75:37028 [junit] 07/09/15 10:01:28 INFO hbase.HRegionServer: MSG_REGION_OPEN : regionname: testInsertSelectDelete,,2684738361515986256, startKey: <>, tableDesc: {name: testInsertSelectDelete, families: {testInsertSelectDelete:={name: testInsertSelectDelete, max versions: 3, compression: NONE, in memory: false, max length: 2147483647, bloom filter: none}}} [junit] 07/09/15 10:01:28 DEBUG hbase.HStore: starting testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete (no reconstruction log) [junit] 07/09/15 10:01:28 DEBUG hbase.HStore: maximum sequence id for hstore testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete is -1 [junit] 07/09/15 10:01:28 DEBUG hbase.HRegion: maximum sequence id for region testInsertSelectDelete,,2684738361515986256 is 0 [junit] 07/09/15 10:01:28 INFO hbase.HRegion: region testInsertSelectDelete,,2684738361515986256 available [junit] 07/09/15 10:01:29 INFO hbase.HMaster: 140.211.11.75:37028 serving testInsertSelectDelete,,2684738361515986256 [junit] 07/09/15 10:01:29 DEBUG hbase.HMaster: Main processing loop: PendingOpenOperation from 140.211.11.75:37028 [junit] 07/09/15 10:01:29 INFO hbase.HMaster: testInsertSelectDelete,,2684738361515986256 open on 140.211.11.75:37028 [junit] 07/09/15 10:01:29 INFO hbase.HMaster: updating row testInsertSelectDelete,,2684738361515986256 in table .META.,,1 with startcode -3196008925655207140 and server 140.211.11.75:37028 [junit] 07/09/15 10:01:32 DEBUG hbase.HConnectionManager$TableServers: Wake. Retry finding table testInsertSelectDelete [junit] 07/09/15 10:01:32 DEBUG hbase.HConnectionManager$TableServers: Found 1 region(s) for testInsertSelectDelete at address: 140.211.11.75:37028, 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] 07/09/15 10:01:32 INFO shell.TestHBaseShell: STDOUT: Creating table... Please wait. [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: Running command: insert into testInsertSelectDelete (testInsertSelectDelete) values ('testInsertSelectDelete') where row='testInsertSelectDelete'; [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: STDOUT: [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: Running command: insert into testInsertSelectDelete (testInsertSelectDelete) values ('testInsertSelectDelete') where row="testInsertSelectDelete"; [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: STDOUT: [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: Running command: insert into testInsertSelectDelete (testInsertSelectDelete) values ("testInsertSelectDelete") where row="testInsertSelectDelete"; [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: STDOUT: [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: Running command: select "testInsertSelectDelete" from "testInsertSelectDelete" where row="testInsertSelectDelete"; [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: STDOUT: [junit] 07/09/15 10:01:32 INFO shell.TestHBaseShell: Running command: delete "testInsertSelectDelete:" from "testInsertSelectDelete" where row="testInsertSelectDelete"; [junit] 07/09/15 10:01:33 INFO shell.TestHBaseShell: STDOUT: [junit] 07/09/15 10:01:33 INFO hbase.MiniHBaseCluster: Shutting down HBase Cluster [junit] 07/09/15 10:01:33 DEBUG hbase.HRegionServer: Got regionserver stop message [junit] 07/09/15 10:01:33 INFO hbase.Leases: closing leases [junit] 07/09/15 10:01:33 INFO hbase.Leases: leases closed [junit] 07/09/15 10:01:33 DEBUG hbase.HRegionServer: closing region -ROOT-,,0 [junit] 07/09/15 10:01:33 INFO hbase.HRegionServer: splitOrCompactChecker exiting [junit] 07/09/15 10:01:33 INFO hbase.HRegionServer: cacheFlusher exiting [junit] 07/09/15 10:01:33 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:33 INFO hbase.HRegionServer: worker thread exiting [junit] 07/09/15 10:01:33 DEBUG hbase.HRegion: Started memcache flush for region -ROOT-,,0. Size 92.0 [junit] 07/09/15 10:01:33 INFO hbase.HRegionServer: logRoller exiting [junit] 07/09/15 10:01:33 DEBUG hbase.HRegion: Snapshotted memcache for region -ROOT-,,0 with sequence id 11 and entries 2 [junit] 07/09/15 10:01:34 INFO hbase.HMaster: RootScanner exiting [junit] 07/09/15 10:01:34 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:34 DEBUG hbase.HStore: Added -ROOT-,,0/info/204801895559375656 with sequence id 11 and size 230.0 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Finished memcache flush for region -ROOT-,,0 in 1170ms [junit] 07/09/15 10:01:34 DEBUG hbase.HStore: closed -ROOT-,,0/info [junit] 07/09/15 10:01:34 INFO hbase.HRegion: closed -ROOT-,,0 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegionServer: closing region .META.,,1 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Started memcache flush for region .META.,,1. Size 348.0 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Snapshotted memcache for region .META.,,1 with sequence id 12 and entries 3 [junit] 07/09/15 10:01:34 DEBUG hbase.HStore: Added .META.,,1/info/2445838070270486835 with sequence id 12 and size 500.0 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Finished memcache flush for region .META.,,1 in 452ms [junit] 07/09/15 10:01:34 DEBUG hbase.HStore: closed .META.,,1/info [junit] 07/09/15 10:01:34 INFO hbase.HRegion: closed .META.,,1 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegionServer: closing region testInsertSelectDelete,,2684738361515986256 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Started memcache flush for region testInsertSelectDelete,,2684738361515986256. Size 294.0 [junit] 07/09/15 10:01:34 DEBUG hbase.HRegion: Snapshotted memcache for region testInsertSelectDelete,,2684738361515986256 with sequence id 13 and entries 3 [junit] 07/09/15 10:01:35 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:35 DEBUG hbase.HStore: Added testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete/3648321428372451359 with sequence id 13 and size 371.0 [junit] 07/09/15 10:01:35 DEBUG hbase.HRegion: Finished memcache flush for region testInsertSelectDelete,,2684738361515986256 in 621ms [junit] 07/09/15 10:01:35 DEBUG hbase.HStore: closed testInsertSelectDelete,,2684738361515986256/testInsertSelectDelete [junit] 07/09/15 10:01:35 INFO hbase.HRegion: closed testInsertSelectDelete,,2684738361515986256 [junit] 07/09/15 10:01:35 DEBUG hbase.HLog: closing log writer in /hbase/log_140.211.11.75_37028 [junit] 07/09/15 10:01:35 INFO hbase.HRegionServer: stopping server at: 140.211.11.75:37028 [junit] 07/09/15 10:01:35 INFO hbase.HRegionServer: HRegionServer stopped at: 140.211.11.75:37028 [junit] 07/09/15 10:01:35 INFO hbase.HRegionServer: main thread exiting [junit] 07/09/15 10:01:36 INFO hbase.HMaster: all meta regions scanned [junit] 07/09/15 10:01:36 INFO hbase.HMaster: MetaScanner exiting [junit] 07/09/15 10:01:36 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:37 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:38 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:39 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:40 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:37028, startcode: -3196008925655207140, load: (requests: 0 regions: 3)] [junit] 07/09/15 10:01:40 INFO hbase.Leases: Lease expired 1437181543/1437181543 [junit] 07/09/15 10:01:40 INFO hbase.HMaster: 140.211.11.75:37028 lease expired [junit] 07/09/15 10:01:40 INFO hbase.Leases: closing leases [junit] 07/09/15 10:01:40 INFO hbase.Leases: leases closed [junit] 07/09/15 10:01:40 INFO hbase.HMaster: HMaster main thread exiting [junit] 07/09/15 10:01:40 INFO hbase.MiniHBaseCluster: Shutdown HMaster 1 region server(s) [junit] 07/09/15 10:01:40 INFO hbase.MiniHBaseCluster: Shutting down Mini DFS cluster [junit] 07/09/15 10:01:42 WARN dfs.DataNode: java.io.IOException: java.lang.InterruptedException [junit] at org.apache.hadoop.fs.Command.run(Command.java:40) [junit] at org.apache.hadoop.fs.DU.getUsed(DU.java:56) [junit] at org.apache.hadoop.dfs.FSDataset$FSVolume.getDfsUsed(FSDataset.java:299) [junit] at org.apache.hadoop.dfs.FSDataset$FSVolumeSet.getDfsUsed(FSDataset.java:396) [junit] at org.apache.hadoop.dfs.FSDataset.getDfsUsed(FSDataset.java:491) [junit] at org.apache.hadoop.dfs.DataNode.offerService(DataNode.java:485) [junit] at org.apache.hadoop.dfs.DataNode.run(DataNode.java:1310) [junit] at java.lang.Thread.run(Thread.java:595) [junit] 07/09/15 10:01:42 WARN fs.FSNamesystem: PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep interrupted [junit] 07/09/15 10:01:42 INFO hbase.MiniHBaseCluster: Shutting down FileSystem [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 76.989 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.097 sec [junit] Running org.onelab.test.TestFilter [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.433 sec BUILD FAILED http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build.xml :505: 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 :101: 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: 581 minutes 47 seconds Recording fingerprints Publishing Javadoc Recording test results Updating HADOOP-1888