Return-Path: Delivered-To: apmail-hadoop-hbase-dev-archive@minotaur.apache.org Received: (qmail 40260 invoked from network); 24 Mar 2009 03:05:07 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.3) by minotaur.apache.org with SMTP; 24 Mar 2009 03:05:07 -0000 Received: (qmail 55202 invoked by uid 500); 24 Mar 2009 03:05:06 -0000 Delivered-To: apmail-hadoop-hbase-dev-archive@hadoop.apache.org Received: (qmail 55135 invoked by uid 500); 24 Mar 2009 03:05:06 -0000 Mailing-List: contact hbase-dev-help@hadoop.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: hbase-dev@hadoop.apache.org Delivered-To: mailing list hbase-dev@hadoop.apache.org Received: (qmail 55125 invoked by uid 99); 24 Mar 2009 03:05:06 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 24 Mar 2009 03:05:06 +0000 X-ASF-Spam-Status: No, hits=-2000.0 required=10.0 tests=ALL_TRUSTED X-Spam-Check-By: apache.org Received: from [140.211.11.106] (HELO hudson.zones.apache.org) (140.211.11.106) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 24 Mar 2009 03:05:05 +0000 Received: from hudson.zones.apache.org (localhost [127.0.0.1]) by hudson.zones.apache.org (8.13.8+Sun/8.13.8) with ESMTP id n2O34hOW024636 for ; Mon, 23 Mar 2009 23:04:44 -0400 (EDT) Date: Tue, 24 Mar 2009 03:04:42 +0000 (UTC) From: Apache Hudson Server To: hbase-dev@hadoop.apache.org Message-ID: <18054677.1141237863883215.JavaMail.hudson@hudson.zones.apache.org> In-Reply-To: <19402470.1131237849031670.JavaMail.hudson@hudson.zones.apache.org> References: <19402470.1131237849031670.JavaMail.hudson@hudson.zones.apache.org> Subject: Build failed in Hudson: HBase-Patch #543 MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: quoted-printable X-Virus-Checked: Checked by ClamAV on apache.org See http://hudson.zones.apache.org/hudson/job/HBase-Patch/543/changes Changes: [stack] HBASE-1283 thrift's package descrpition needs to update for start/s= top procedure ------------------------------------------ [...truncated 24315 lines...] [junit] 2009-03-24 03:16:47,021 DEBUG [main] util.Merge(308): Removing = region: REGION =3D> {NAME =3D> 'TestMergeTool,row_0100,1237864606556', STAR= TKEY =3D> 'row_0100', ENDKEY =3D> 'row_0400', ENCODED =3D> 1316539015, TABL= E =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'fal= se', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', VERSIO= NS =3D> '3', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '-= 1', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'= }], INDEXES =3D> []}} from .META.,,1 [junit] 2009-03-24 03:16:47,023 DEBUG [main] util.Merge(308): Removing = region: REGION =3D> {NAME =3D> 'TestMergeTool,row_0500,1237864603755', STAR= TKEY =3D> 'row_0500', ENDKEY =3D> 'row_0600', ENCODED =3D> 547738600, TABLE= =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'fals= e', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', VERSION= S =3D> '3', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '-1= ', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}= ], INDEXES =3D> []}} from .META.,,1 [junit] 2009-03-24 03:16:47,027 INFO [main] util.Merge(244): Adding RE= GION =3D> {NAME =3D> 'TestMergeTool,row_0100,1237864606964', STARTKEY =3D> = 'row_0100', ENDKEY =3D> 'row_0600', ENCODED =3D> 1435425508, TABLE =3D> {{N= AME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMIL= IES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', VERSIONS =3D> '3= ', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKS= IZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXE= S =3D> []}} to REGION =3D> {NAME =3D> '.META.,,1', STARTKEY =3D> '', ENDKEY= =3D> '', ENCODED =3D> 1028785192, TABLE =3D> {{NAME =3D> '.META.', IS_ROOT= =3D> 'false', IS_META =3D> 'true', FAMILIES =3D> [{NAME =3D> 'info', BLOOM= FILTER =3D> 'false', VERSIONS =3D> '10', COMPRESSION =3D> 'NONE', LENGTH = =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'fa= lse', BLOCKCACHE =3D> 'true'}, {NAME =3D> 'historian', BLOOMFILTER =3D> 'fa= lse', VERSIONS =3D> '2147483647', COMPRESSION =3D> 'NONE', LENGTH =3D> '214= 7483647', TTL =3D> '604800', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'false',= BLOCKCACHE =3D> 'false'}], INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,028 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,row_0100,1237864606964: compactions & flushes disabl= ed=20 [junit] 2009-03-24 03:16:47,028 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,row_= 0100,1237864606964 [junit] 2009-03-24 03:16:47,028 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,row_0100,12378646069= 64 [junit] 2009-03-24 03:16:47,029 DEBUG [main] regionserver.Store(434): c= losed 1435425508/contents [junit] 2009-03-24 03:16:47,029 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,row_0100,1237864606964 [junit] 2009-03-24 03:16:47,029 DEBUG [main] regionserver.HRegion(385):= Closing -ROOT-,,0: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,029 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on -ROOT-,,0 [junit] 2009-03-24 03:16:47,029 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region -ROOT-,,0 [junit] 2009-03-24 03:16:47,030 DEBUG [main] regionserver.Store(434): c= losed 70236052/info [junit] 2009-03-24 03:16:47,030 INFO [main] regionserver.HRegion(434):= Closed -ROOT-,,0 [junit] 2009-03-24 03:16:47,030 DEBUG [main] regionserver.HRegion(385):= Closing .META.,,1: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,030 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on .META.,,1 [junit] 2009-03-24 03:16:47,030 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region .META.,,1 [junit] 2009-03-24 03:16:47,030 DEBUG [main] regionserver.HRegion(826):= Started memcache flush for region .META.,,1. Current region memcache size = 968.0 [junit] 2009-03-24 03:16:47,044 DEBUG [main] regionserver.Store(516): A= dded hdfs://localhost:33187/user/hudson/.META./1028785192/info/470793826220= 5082035, entries=3D3, sequenceid=3D17, memsize=3D968.0, filesize=3D968.0 to= .META.,,1 [junit] 2009-03-24 03:16:47,044 DEBUG [main] regionserver.HRegion(903):= Finished memcache flush of ~968.0 for region .META.,,1 in 14ms, sequence i= d=3D17, compaction requested=3Dtrue [junit] 2009-03-24 03:16:47,044 DEBUG [main] regionserver.Store(434): c= losed 1028785192/historian [junit] 2009-03-24 03:16:47,045 DEBUG [main] regionserver.Store(434): c= losed 1028785192/info [junit] 2009-03-24 03:16:47,045 INFO [main] regionserver.HRegion(434):= Closed .META.,,1 [junit] 2009-03-24 03:16:47,052 INFO [main] regionserver.HLog(273): Cl= osed hdfs://localhost:33187/user/hudson/log_1237864606821/hlog.dat.0, entri= es=3D4. New log writer: /user/hudson/log_1237864606821/hlog.dat.12378646070= 50 [junit] 2009-03-24 03:16:47,052 DEBUG [main] regionserver.HLog(280): La= st sequence written is empty. Deleting all old hlogs [junit] 2009-03-24 03:16:47,052 INFO [main] regionserver.HLog(391): re= moving old log file /user/hudson/log_1237864606821/hlog.dat.0 whose highest= sequence/edit id is 17 [junit] 2009-03-24 03:16:47,053 DEBUG [main] regionserver.HLog(427): cl= osing log writer in hdfs://localhost:33187/user/hudson/log_1237864606821 [junit] 2009-03-24 03:16:47,058 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> 'TestMergeTool,row_0100,1237864606= 964', STARTKEY =3D> 'row_0100', ENDKEY =3D> 'row_0600', ENCODED =3D> 143542= 5508, TABLE =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META= =3D> 'false', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'fals= e', VERSIONS =3D> '3', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', T= TL =3D> '-1', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE = =3D> 'false'}], INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,059 DEBUG [main] regionserver.HRegion(237):= Opening region TestMergeTool,row_0100,1237864606964/1435425508 [junit] 2009-03-24 03:16:47,064 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/1435425508/contents/1416867873645456759, i= sReference=3Dfalse, sequence id=3D5, length=3D804, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,064 DEBUG [main] regionserver.Store(213): L= oaded 1 file(s) in Store 1435425508/contents, max sequence id 5 [junit] 2009-03-24 03:16:47,065 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region TestMergeTool,row_0100,1237864606964 is 6 [junit] 2009-03-24 03:16:47,066 INFO [main] regionserver.HRegion(314):= region TestMergeTool,row_0100,1237864606964/1435425508 available [junit] 2009-03-24 03:16:47,066 DEBUG [main] regionserver.HLog(217): ch= anging sequence number from 5 to 6 [junit] 2009-03-24 03:16:47,080 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,row_0100,1237864606964: compactions & flushes disabl= ed=20 [junit] 2009-03-24 03:16:47,080 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,row_= 0100,1237864606964 [junit] 2009-03-24 03:16:47,080 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,row_0100,12378646069= 64 [junit] 2009-03-24 03:16:47,080 DEBUG [main] regionserver.Store(434): c= losed 1435425508/contents [junit] 2009-03-24 03:16:47,081 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,row_0100,1237864606964 [junit] 2009-03-24 03:16:47,081 INFO [main] util.TestMergeTool(169): V= erified merging regions 0+1+2 and 3 [junit] 2009-03-24 03:16:47,081 INFO [main] util.TestMergeTool(156): m= erging regions 0+1+2+3 and 4 [junit] 2009-03-24 03:16:47,081 INFO [main] util.Merge(80): Verifying = that file system is available... [junit] 2009-03-24 03:16:47,082 INFO [main] util.Merge(89): Verifying = that HBase is not running... [junit] 2009-03-24 03:16:47,206 INFO [main] util.Merge(190): Merging r= egions TestMergeTool,row_0100,1237864606964 and TestMergeTool,,123786460375= 5 in table TestMergeTool [junit] 2009-03-24 03:16:47,210 INFO [main] regionserver.HLog(273): Ne= w log writer: /user/hudson/log_1237864607207/hlog.dat.1237864607208 [junit] 2009-03-24 03:16:47,210 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> '-ROOT-,,0', STARTKEY =3D> '', END= KEY =3D> '', ENCODED =3D> 70236052, TABLE =3D> {{NAME =3D> '-ROOT-', IS_ROO= T =3D> 'true', IS_META =3D> 'true', FAMILIES =3D> [{NAME =3D> 'info', BLOOM= FILTER =3D> 'false', COMPRESSION =3D> 'NONE', VERSIONS =3D> '10', LENGTH = =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'fa= lse', BLOCKCACHE =3D> 'true'}], INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,210 DEBUG [main] regionserver.HRegion(237):= Opening region -ROOT-,,0/70236052 [junit] 2009-03-24 03:16:47,216 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/-ROOT-/70236052/info/5499745103574564460, isReference=3D= false, sequence id=3D1, length=3D856, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,216 DEBUG [main] regionserver.Store(213): L= oaded 1 file(s) in Store 70236052/info, max sequence id 1 [junit] 2009-03-24 03:16:47,217 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region -ROOT-,,0 is 2 [junit] 2009-03-24 03:16:47,218 INFO [main] regionserver.HRegion(314):= region -ROOT-,,0/70236052 available [junit] 2009-03-24 03:16:47,218 DEBUG [main] regionserver.HLog(217): ch= anging sequence number from 0 to 2 [junit] 2009-03-24 03:16:47,218 INFO [main] regionserver.HRegion(701):= starting compaction on region -ROOT-,,0 [junit] 2009-03-24 03:16:47,220 INFO [main] regionserver.HRegion(716):= compaction completed on region -ROOT-,,0 in 0sec [junit] 2009-03-24 03:16:47,222 INFO [main] util.Merge(204): Found met= a for region1 .META.,,1, meta for region2 .META.,,1 [junit] 2009-03-24 03:16:47,222 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> '.META.,,1', STARTKEY =3D> '', END= KEY =3D> '', ENCODED =3D> 1028785192, TABLE =3D> {{NAME =3D> '.META.', IS_R= OOT =3D> 'false', IS_META =3D> 'true', FAMILIES =3D> [{NAME =3D> 'info', BL= OOMFILTER =3D> 'false', VERSIONS =3D> '10', COMPRESSION =3D> 'NONE', LENGTH= =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'f= alse', BLOCKCACHE =3D> 'true'}, {NAME =3D> 'historian', BLOOMFILTER =3D> 'f= alse', VERSIONS =3D> '2147483647', COMPRESSION =3D> 'NONE', LENGTH =3D> '21= 47483647', TTL =3D> '604800', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'false'= , BLOCKCACHE =3D> 'false'}], INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,223 DEBUG [main] regionserver.HRegion(237):= Opening region .META.,,1/1028785192 [junit] 2009-03-24 03:16:47,228 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/.META./1028785192/info/4707938262205082035, isReference= =3Dfalse, sequence id=3D17, length=3D968, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,232 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/.META./1028785192/info/6031205252373249676, isReference= =3Dfalse, sequence id=3D5, length=3D2330, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,235 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/.META./1028785192/info/6838516380475536243, isReference= =3Dfalse, sequence id=3D13, length=3D1531, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,236 DEBUG [main] regionserver.Store(213): L= oaded 3 file(s) in Store 1028785192/info, max sequence id 17 [junit] 2009-03-24 03:16:47,238 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region .META.,,1 is 18 [junit] 2009-03-24 03:16:47,239 INFO [main] regionserver.HRegion(314):= region .META.,,1/1028785192 available [junit] 2009-03-24 03:16:47,240 DEBUG [main] regionserver.HLog(217): ch= anging sequence number from 2 to 18 [junit] 2009-03-24 03:16:47,240 INFO [main] regionserver.HRegion(701):= starting compaction on region .META.,,1 [junit] 2009-03-24 03:16:47,241 DEBUG [main] regionserver.Store(619): 1= 028785192/historian: no store files to compact [junit] 2009-03-24 03:16:47,244 DEBUG [main] regionserver.Store(683): C= ompaction size of 1028785192/info: 4.7k; Skipped 0 file(s), size: 0 [junit] 2009-03-24 03:16:47,248 DEBUG [main] regionserver.Store(692): S= tarted compaction of 3 file(s) into /user/hudson/.META./1028785192/info/69= 20583197911259649 [junit] 2009-03-24 03:16:47,276 DEBUG [main] regionserver.Store(707): C= ompleted compaction of 1028785192/info store size is 3.9k [junit] 2009-03-24 03:16:47,277 INFO [main] regionserver.HRegion(716):= compaction completed on region .META.,,1 in 0sec [junit] 2009-03-24 03:16:47,280 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> 'TestMergeTool,row_0100,1237864606= 964', STARTKEY =3D> 'row_0100', ENDKEY =3D> 'row_0600', ENCODED =3D> 143542= 5508, TABLE =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META= =3D> 'false', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'fals= e', COMPRESSION =3D> 'NONE', VERSIONS =3D> '3', LENGTH =3D> '2147483647', T= TL =3D> '-1', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE = =3D> 'false'}], INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,280 DEBUG [main] regionserver.HRegion(237):= Opening region TestMergeTool,row_0100,1237864606964/1435425508 [junit] 2009-03-24 03:16:47,285 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/1435425508/contents/1416867873645456759, i= sReference=3Dfalse, sequence id=3D5, length=3D804, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,285 DEBUG [main] regionserver.Store(213): L= oaded 1 file(s) in Store 1435425508/contents, max sequence id 5 [junit] 2009-03-24 03:16:47,286 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region TestMergeTool,row_0100,1237864606964 is 6 [junit] 2009-03-24 03:16:47,287 INFO [main] regionserver.HRegion(314):= region TestMergeTool,row_0100,1237864606964/1435425508 available [junit] 2009-03-24 03:16:47,288 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> 'TestMergeTool,,1237864603755', ST= ARTKEY =3D> '', ENDKEY =3D> '', ENCODED =3D> 155812872, TABLE =3D> {{NAME = =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMILIES = =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', VERSIONS =3D> '3', C= OMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE = =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXES = =3D> []}} [junit] 2009-03-24 03:16:47,288 DEBUG [main] regionserver.HRegion(237):= Opening region TestMergeTool,,1237864603755/155812872 [junit] 2009-03-24 03:16:47,293 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/155812872/contents/367152735698946245, isR= eference=3Dfalse, sequence id=3D6, length=3D462, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,293 DEBUG [main] regionserver.Store(213): L= oaded 1 file(s) in Store 155812872/contents, max sequence id 6 [junit] 2009-03-24 03:16:47,294 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region TestMergeTool,,1237864603755 is 7 [junit] 2009-03-24 03:16:47,295 INFO [main] regionserver.HRegion(314):= region TestMergeTool,,1237864603755/155812872 available [junit] 2009-03-24 03:16:47,295 INFO [main] regionserver.HRegion(701):= starting major compaction on region TestMergeTool,row_0100,1237864606964 [junit] 2009-03-24 03:16:47,300 DEBUG [main] regionserver.Store(692): S= tarted compaction of 1 file(s) into /user/hudson/TestMergeTool/1435425508/= contents/1836683848639654805 [junit] 2009-03-24 03:16:47,326 DEBUG [main] regionserver.Store(707): C= ompleted major compaction of 1435425508/contents store size is 804.0 [junit] 2009-03-24 03:16:47,327 INFO [main] regionserver.HRegion(716):= compaction completed on region TestMergeTool,row_0100,1237864606964 in 0se= c [junit] 2009-03-24 03:16:47,327 DEBUG [main] regionserver.HRegion(2440)= : Files for region: TestMergeTool,row_0100,1237864606964 [junit] 2009-03-24 03:16:47,328 DEBUG [main] regionserver.HRegion(2585)= : d hdfs://localhost:33187/user/hudson/TestMergeTool/1435425508/contents [junit] 2009-03-24 03:16:47,329 DEBUG [main] regionserver.HRegion(2588)= : f hdfs://localhost:33187/user/hudson/TestMergeTool/1435425508/contents/71= 41017865677193178 size=3D804 [junit] 2009-03-24 03:16:47,329 INFO [main] regionserver.HRegion(701):= starting major compaction on region TestMergeTool,,1237864603755 [junit] 2009-03-24 03:16:47,333 DEBUG [main] regionserver.Store(692): S= tarted compaction of 1 file(s) into /user/hudson/TestMergeTool/155812872/c= ontents/4901707005894566563 [junit] 2009-03-24 03:16:47,346 DEBUG [main] regionserver.Store(707): C= ompleted major compaction of 155812872/contents store size is 462.0 [junit] 2009-03-24 03:16:47,346 INFO [main] regionserver.HRegion(716):= compaction completed on region TestMergeTool,,1237864603755 in 0sec [junit] 2009-03-24 03:16:47,347 DEBUG [main] regionserver.HRegion(2445)= : Files for region: TestMergeTool,,1237864603755 [junit] 2009-03-24 03:16:47,347 DEBUG [main] regionserver.HRegion(2585)= : d hdfs://localhost:33187/user/hudson/TestMergeTool/155812872/contents [junit] 2009-03-24 03:16:47,348 DEBUG [main] regionserver.HRegion(2588)= : f hdfs://localhost:33187/user/hudson/TestMergeTool/155812872/contents/823= 7751868448056817 size=3D462 [junit] 2009-03-24 03:16:47,348 INFO [main] regionserver.HRegion(2466)= : Creating new region REGION =3D> {NAME =3D> 'TestMergeTool,,1237864607348'= , STARTKEY =3D> '', ENDKEY =3D> '', ENCODED =3D> 26680852, TABLE =3D> {{NAM= E =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMILIE= S =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', COMPRESSION =3D> '= NONE', VERSIONS =3D> '3', LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKSIZ= E =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXES = =3D> []}} [junit] 2009-03-24 03:16:47,350 INFO [main] regionserver.HRegion(2475)= : starting merge of regions: TestMergeTool,row_0100,1237864606964 and TestM= ergeTool,,1237864603755 into new region REGION =3D> {NAME =3D> 'TestMergeTo= ol,,1237864607348', STARTKEY =3D> '', ENDKEY =3D> '', ENCODED =3D> 26680852= , TABLE =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D= > 'false', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', = COMPRESSION =3D> 'NONE', VERSIONS =3D> '3', LENGTH =3D> '2147483647', TTL = =3D> '-1', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> = 'false'}], INDEXES =3D> []}} with start key <> and end key <> [junit] 2009-03-24 03:16:47,350 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,row_0100,1237864606964: compactions & flushes disabl= ed=20 [junit] 2009-03-24 03:16:47,350 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,row_= 0100,1237864606964 [junit] 2009-03-24 03:16:47,351 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,row_0100,12378646069= 64 [junit] 2009-03-24 03:16:47,351 DEBUG [main] regionserver.Store(434): c= losed 1435425508/contents [junit] 2009-03-24 03:16:47,351 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,row_0100,1237864606964 [junit] 2009-03-24 03:16:47,351 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,,1237864603755: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,351 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,,123= 7864603755 [junit] 2009-03-24 03:16:47,352 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,,1237864603755 [junit] 2009-03-24 03:16:47,352 DEBUG [main] regionserver.Store(434): c= losed 155812872/contents [junit] 2009-03-24 03:16:47,352 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,,1237864603755 [junit] 2009-03-24 03:16:47,361 DEBUG [main] regionserver.HRegion(2510)= : Files for new region [junit] 2009-03-24 03:16:47,362 DEBUG [main] regionserver.HRegion(2585)= : d hdfs://localhost:33187/user/hudson/TestMergeTool/26680852/contents [junit] 2009-03-24 03:16:47,363 DEBUG [main] regionserver.HRegion(2588)= : f hdfs://localhost:33187/user/hudson/TestMergeTool/26680852/contents/4648= 446966968187351 size=3D462 [junit] 2009-03-24 03:16:47,363 DEBUG [main] regionserver.HRegion(2588)= : f hdfs://localhost:33187/user/hudson/TestMergeTool/26680852/contents/5554= 799567041358642 size=3D804 [junit] 2009-03-24 03:16:47,364 DEBUG [main] regionserver.HRegion(237):= Opening region TestMergeTool,,1237864607348/26680852 [junit] 2009-03-24 03:16:47,368 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/26680852/contents/4648446966968187351, isR= eference=3Dfalse, sequence id=3D6, length=3D462, majorCompaction=3Dtrue [junit] 2009-03-24 03:16:47,372 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/26680852/contents/5554799567041358642, isR= eference=3Dfalse, sequence id=3D5, length=3D804, majorCompaction=3Dtrue [junit] 2009-03-24 03:16:47,372 DEBUG [main] regionserver.Store(213): L= oaded 2 file(s) in Store 26680852/contents, max sequence id 6 [junit] 2009-03-24 03:16:47,373 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region TestMergeTool,,1237864607348 is 7 [junit] 2009-03-24 03:16:47,375 INFO [main] regionserver.HRegion(314):= region TestMergeTool,,1237864607348/26680852 available [junit] 2009-03-24 03:16:47,375 INFO [main] regionserver.HRegion(701):= starting compaction on region TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,377 DEBUG [main] regionserver.Store(683): C= ompaction size of 26680852/contents: 1.2k; Skipped 0 file(s), size: 0 [junit] 2009-03-24 03:16:47,399 DEBUG [main] regionserver.Store(692): S= tarted compaction of 2 file(s) into /user/hudson/TestMergeTool/26680852/co= ntents/8826737439084969013 [junit] 2009-03-24 03:16:47,413 DEBUG [main] regionserver.Store(707): C= ompleted compaction of 26680852/contents store size is 933.0 [junit] 2009-03-24 03:16:47,414 INFO [main] regionserver.HRegion(716):= compaction completed on region TestMergeTool,,1237864607348 in 0sec [junit] 2009-03-24 03:16:47,414 DEBUG [main] regionserver.HRegion(2517)= : Files for new region [junit] 2009-03-24 03:16:47,415 DEBUG [main] regionserver.HRegion(2585)= : d hdfs://localhost:33187/user/hudson/TestMergeTool/26680852/contents [junit] 2009-03-24 03:16:47,416 DEBUG [main] regionserver.HRegion(2588)= : f hdfs://localhost:33187/user/hudson/TestMergeTool/26680852/contents/7398= 226564963201306 size=3D933 [junit] 2009-03-24 03:16:47,416 DEBUG [main] regionserver.HRegion(2318)= : DELETING region hdfs://localhost:33187/user/hudson/TestMergeTool/14354255= 08 [junit] 2009-03-24 03:16:47,417 DEBUG [main] regionserver.HRegion(2318)= : DELETING region hdfs://localhost:33187/user/hudson/TestMergeTool/15581287= 2 [junit] 2009-03-24 03:16:47,418 INFO [main] regionserver.HRegion(2523)= : merge completed. New region is TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,418 DEBUG [main] util.Merge(308): Removing = region: REGION =3D> {NAME =3D> 'TestMergeTool,row_0100,1237864606964', STAR= TKEY =3D> 'row_0100', ENDKEY =3D> 'row_0600', ENCODED =3D> 1435425508, TABL= E =3D> {{NAME =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'fal= se', FAMILIES =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', COMPRE= SSION =3D> 'NONE', VERSIONS =3D> '3', LENGTH =3D> '2147483647', TTL =3D> '-= 1', BLOCKSIZE =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'= }], INDEXES =3D> []}} from .META.,,1 [junit] 2009-03-24 03:16:47,419 DEBUG [main] util.Merge(308): Removing = region: REGION =3D> {NAME =3D> 'TestMergeTool,,1237864603755', STARTKEY =3D= > '', ENDKEY =3D> '', ENCODED =3D> 155812872, TABLE =3D> {{NAME =3D> 'TestM= ergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMILIES =3D> [{NAME= =3D> 'contents', BLOOMFILTER =3D> 'false', VERSIONS =3D> '3', COMPRESSION = =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE =3D> '65536= ', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXES =3D> []}} fro= m .META.,,1 [junit] 2009-03-24 03:16:47,422 INFO [main] util.Merge(244): Adding RE= GION =3D> {NAME =3D> 'TestMergeTool,,1237864607348', STARTKEY =3D> '', ENDK= EY =3D> '', ENCODED =3D> 26680852, TABLE =3D> {{NAME =3D> 'TestMergeTool', = IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMILIES =3D> [{NAME =3D> 'cont= ents', BLOOMFILTER =3D> 'false', COMPRESSION =3D> 'NONE', VERSIONS =3D> '3'= , LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE =3D> '65536', IN_MEMOR= Y =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXES =3D> []}} to REGION =3D>= {NAME =3D> '.META.,,1', STARTKEY =3D> '', ENDKEY =3D> '', ENCODED =3D> 102= 8785192, TABLE =3D> {{NAME =3D> '.META.', IS_ROOT =3D> 'false', IS_META =3D= > 'true', FAMILIES =3D> [{NAME =3D> 'info', BLOOMFILTER =3D> 'false', VERSI= ONS =3D> '10', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> = '-1', BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'true'= }, {NAME =3D> 'historian', BLOOMFILTER =3D> 'false', VERSIONS =3D> '2147483= 647', COMPRESSION =3D> 'NONE', LENGTH =3D> '2147483647', TTL =3D> '604800',= BLOCKSIZE =3D> '8192', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], = INDEXES =3D> []}} [junit] 2009-03-24 03:16:47,423 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,,1237864607348: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,423 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,,123= 7864607348 [junit] 2009-03-24 03:16:47,423 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,423 DEBUG [main] regionserver.Store(434): c= losed 26680852/contents [junit] 2009-03-24 03:16:47,424 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,424 DEBUG [main] regionserver.HRegion(385):= Closing -ROOT-,,0: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,424 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on -ROOT-,,0 [junit] 2009-03-24 03:16:47,424 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region -ROOT-,,0 [junit] 2009-03-24 03:16:47,424 DEBUG [main] regionserver.Store(434): c= losed 70236052/info [junit] 2009-03-24 03:16:47,424 INFO [main] regionserver.HRegion(434):= Closed -ROOT-,,0 [junit] 2009-03-24 03:16:47,425 DEBUG [main] regionserver.HRegion(385):= Closing .META.,,1: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,425 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on .META.,,1 [junit] 2009-03-24 03:16:47,425 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region .META.,,1 [junit] 2009-03-24 03:16:47,425 DEBUG [main] regionserver.HRegion(826):= Started memcache flush for region .META.,,1. Current region memcache size = 928.0 [junit] 2009-03-24 03:16:47,437 DEBUG [main] regionserver.Store(516): A= dded hdfs://localhost:33187/user/hudson/.META./1028785192/info/286573750634= 9265425, entries=3D3, sequenceid=3D21, memsize=3D928.0, filesize=3D920.0 to= .META.,,1 [junit] 2009-03-24 03:16:47,438 DEBUG [main] regionserver.HRegion(903):= Finished memcache flush of ~928.0 for region .META.,,1 in 13ms, sequence i= d=3D21, compaction requested=3Dtrue [junit] 2009-03-24 03:16:47,438 DEBUG [main] regionserver.Store(434): c= losed 1028785192/historian [junit] 2009-03-24 03:16:47,438 DEBUG [main] regionserver.Store(434): c= losed 1028785192/info [junit] 2009-03-24 03:16:47,438 INFO [main] regionserver.HRegion(434):= Closed .META.,,1 [junit] 2009-03-24 03:16:47,453 INFO [main] regionserver.HLog(273): Cl= osed hdfs://localhost:33187/user/hudson/log_1237864607207/hlog.dat.0, entri= es=3D4. New log writer: /user/hudson/log_1237864607207/hlog.dat.12378646074= 51 [junit] 2009-03-24 03:16:47,453 DEBUG [main] regionserver.HLog(280): La= st sequence written is empty. Deleting all old hlogs [junit] 2009-03-24 03:16:47,453 INFO [main] regionserver.HLog(391): re= moving old log file /user/hudson/log_1237864607207/hlog.dat.0 whose highest= sequence/edit id is 21 [junit] 2009-03-24 03:16:47,454 DEBUG [main] regionserver.HLog(427): cl= osing log writer in hdfs://localhost:33187/user/hudson/log_1237864607207 [junit] 2009-03-24 03:16:47,460 DEBUG [main] regionserver.HRegion(2200)= : Opening region: REGION =3D> {NAME =3D> 'TestMergeTool,,1237864607348', ST= ARTKEY =3D> '', ENDKEY =3D> '', ENCODED =3D> 26680852, TABLE =3D> {{NAME = =3D> 'TestMergeTool', IS_ROOT =3D> 'false', IS_META =3D> 'false', FAMILIES = =3D> [{NAME =3D> 'contents', BLOOMFILTER =3D> 'false', COMPRESSION =3D> 'NO= NE', VERSIONS =3D> '3', LENGTH =3D> '2147483647', TTL =3D> '-1', BLOCKSIZE = =3D> '65536', IN_MEMORY =3D> 'false', BLOCKCACHE =3D> 'false'}], INDEXES = =3D> []}} [junit] 2009-03-24 03:16:47,461 DEBUG [main] regionserver.HRegion(237):= Opening region TestMergeTool,,1237864607348/26680852 [junit] 2009-03-24 03:16:47,465 DEBUG [main] regionserver.Store(383): l= oaded /user/hudson/TestMergeTool/26680852/contents/7398226564963201306, isR= eference=3Dfalse, sequence id=3D6, length=3D933, majorCompaction=3Dfalse [junit] 2009-03-24 03:16:47,465 DEBUG [main] regionserver.Store(213): L= oaded 1 file(s) in Store 26680852/contents, max sequence id 6 [junit] 2009-03-24 03:16:47,466 DEBUG [main] regionserver.HRegion(297):= Next sequence id for region TestMergeTool,,1237864607348 is 7 [junit] 2009-03-24 03:16:47,467 INFO [main] regionserver.HRegion(314):= region TestMergeTool,,1237864607348/26680852 available [junit] 2009-03-24 03:16:47,468 DEBUG [main] regionserver.HLog(217): ch= anging sequence number from 6 to 7 [junit] 2009-03-24 03:16:47,487 DEBUG [main] regionserver.HRegion(385):= Closing TestMergeTool,,1237864607348: compactions & flushes disabled=20 [junit] 2009-03-24 03:16:47,487 DEBUG [main] regionserver.HRegion(415):= Updates disabled for region, no outstanding scanners on TestMergeTool,,123= 7864607348 [junit] 2009-03-24 03:16:47,488 DEBUG [main] regionserver.HRegion(422):= No more row locks outstanding on region TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,488 DEBUG [main] regionserver.Store(434): c= losed 26680852/contents [junit] 2009-03-24 03:16:47,488 INFO [main] regionserver.HRegion(434):= Closed TestMergeTool,,1237864607348 [junit] 2009-03-24 03:16:47,488 INFO [main] util.TestMergeTool(169): V= erified merging regions 0+1+2+3 and 4 [junit] 2009-03-24 03:16:47,488 DEBUG [main] regionserver.HLog(427): cl= osing log writer in /tmp/log_1237864605792 [junit] 2009-03-24 03:16:47,494 INFO [main] hbase.HBaseTestCase(587): = Shutting down FileSystem [junit] 2009-03-24 03:16:47,494 INFO [main] hbase.HBaseTestCase(594): = Shutting down Mini DFS=20 [junit] Shutting down the Mini HDFS Cluster [junit] Shutting down DataNode 1 [junit] 2009-03-24 03:16:47,495 INFO [Acceptor ServerSocket[addr=3Dloc= alhost/127.0.0.1,port=3D0,localport=3D34784]] util.ThreadedServer$Acceptor(= 656): Stopping Acceptor ServerSocket[addr=3Dlocalhost/127.0.0.1,port=3D0,lo= calport=3D34784] [junit] 2009-03-24 03:16:47,496 INFO [main] http.SocketListener(212): = Stopped SocketListener on 127.0.0.1:34784 [junit] 2009-03-24 03:16:47,497 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@179d854 [junit] 2009-03-24 03:16:47,565 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/static,/static] [junit] 2009-03-24 03:16:47,566 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@98350a [junit] 2009-03-24 03:16:47,624 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/,/] [junit] 2009-03-24 03:16:47,624 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.Server@205756 [junit] 2009-03-24 03:16:47,625 WARN [org.apache.hadoop.hdfs.server.da= tanode.DataXceiverServer@6c5482] datanode.DataXceiverServer(134): DatanodeR= egistration(127.0.0.1:45841, storageID=3DDS-2115082498-67.195.138.9-45841-1= 237864605316, infoPort=3D34784, ipcPort=3D37596):DataXceiveServer: java.nio= .channels.AsynchronousCloseException [junit] =09at java.nio.channels.spi.AbstractInterruptibleChannel.end(Ab= stractInterruptibleChannel.java:185) [junit] =09at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketCha= nnelImpl.java:152) [junit] =09at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor= .java:84) [junit] =09at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.= run(DataXceiverServer.java:129) [junit] =09at java.lang.Thread.run(Thread.java:619) [junit]=20 [junit] Shutting down DataNode 0 [junit] 2009-03-24 03:16:48,626 INFO [Acceptor ServerSocket[addr=3Dloc= alhost/127.0.0.1,port=3D0,localport=3D43547]] util.ThreadedServer$Acceptor(= 656): Stopping Acceptor ServerSocket[addr=3Dlocalhost/127.0.0.1,port=3D0,lo= calport=3D43547] [junit] 2009-03-24 03:16:48,626 INFO [main] http.SocketListener(212): = Stopped SocketListener on 127.0.0.1:43547 [junit] 2009-03-24 03:16:48,627 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@5b675e [junit] 2009-03-24 03:16:48,697 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/static,/static] [junit] 2009-03-24 03:16:48,698 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@e90943 [junit] 2009-03-24 03:16:48,750 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/,/] [junit] 2009-03-24 03:16:48,750 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.Server@104fc23 [junit] 2009-03-24 03:16:48,752 WARN [org.apache.hadoop.hdfs.server.da= tanode.DataXceiverServer@4eeaaf] datanode.DataXceiverServer(134): DatanodeR= egistration(127.0.0.1:50187, storageID=3DDS-1983811236-67.195.138.9-50187-1= 237864605082, infoPort=3D43547, ipcPort=3D38616):DataXceiveServer: java.nio= .channels.AsynchronousCloseException [junit] =09at java.nio.channels.spi.AbstractInterruptibleChannel.end(Ab= stractInterruptibleChannel.java:185) [junit] =09at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketCha= nnelImpl.java:152) [junit] =09at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor= .java:84) [junit] =09at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.= run(DataXceiverServer.java:129) [junit] =09at java.lang.Thread.run(Thread.java:619) [junit]=20 [junit] 2009-03-24 03:16:49,852 INFO [Acceptor ServerSocket[addr=3Dloc= alhost/127.0.0.1,port=3D0,localport=3D57925]] util.ThreadedServer$Acceptor(= 656): Stopping Acceptor ServerSocket[addr=3Dlocalhost/127.0.0.1,port=3D0,lo= calport=3D57925] [junit] 2009-03-24 03:16:49,852 INFO [main] http.SocketListener(212): = Stopped SocketListener on 127.0.0.1:57925 [junit] 2009-03-24 03:16:49,854 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@2ab653 [junit] 2009-03-24 03:16:49,904 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/static,/static] [junit] 2009-03-24 03:16:49,907 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.servlet.WebApplicationHandler@3f96ee [junit] 2009-03-24 03:16:49,955 INFO [main] util.Container(156): Stopp= ed WebApplicationContext[/,/] [junit] 2009-03-24 03:16:49,955 INFO [main] util.Container(156): Stopp= ed org.mortbay.jetty.Server@1402d5a [junit] 2009-03-24 03:16:49,955 WARN [org.apache.hadoop.hdfs.server.na= menode.FSNamesystem$ReplicationMonitor@b02928] namenode.FSNamesystem$Replic= ationMonitor(2300): ReplicationMonitor thread received InterruptedException= .java.lang.InterruptedException: sleep interrupted [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 6.306 sec [junit] Running org.apache.hadoop.hbase.util.TestRootPath [junit] 2009-03-24 03:16:50,333 INFO [main] util.TestRootPath(60): Got= expected exception when checking invalid path: [junit] java.io.IOException: Root directory does not contain a scheme [junit] =09at org.apache.hadoop.hbase.util.FSUtils.validateRootPath(FSU= tils.java:199) [junit] =09at org.apache.hadoop.hbase.util.TestRootPath.testRootPath(Te= stRootPath.java:56) [junit] =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Metho= d) [junit] =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodA= ccessorImpl.java:39) [junit] =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(Delegatin= gMethodAccessorImpl.java:25) [junit] =09at java.lang.reflect.Method.invoke(Method.java:597) [junit] =09at junit.framework.TestCase.runTest(TestCase.java:154) [junit] =09at junit.framework.TestCase.runBare(TestCase.java:127) [junit] =09at junit.framework.TestResult$1.protect(TestResult.java:106) [junit] =09at junit.framework.TestResult.runProtected(TestResult.java:1= 24) [junit] =09at junit.framework.TestResult.run(TestResult.java:109) [junit] =09at junit.framework.TestCase.run(TestCase.java:118) [junit] =09at junit.framework.TestSuite.runTest(TestSuite.java:208) [junit] =09at junit.framework.TestSuite.run(TestSuite.java:203) [junit] =09at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRun= ner.run(JUnitTestRunner.java:421) [junit] =09at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRun= ner.launch(JUnitTestRunner.java:912) [junit] =09at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRun= ner.main(JUnitTestRunner.java:766) [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.087 sec [junit] Running org.onelab.test.TestFilter [junit] 2009-03-24 03:16:50,717 INFO [main] test.TestFilter(244): Chec= king for false negatives [junit] 2009-03-24 03:16:50,721 INFO [main] test.TestFilter(255): Chec= king for false positives [junit] 2009-03-24 03:16:50,722 INFO [main] test.TestFilter(262): Succ= ess! [junit] 2009-03-24 03:16:50,723 INFO [main] test.TestFilter(226): Chec= king serialization/deserialization [junit] 2009-03-24 03:16:50,724 INFO [main] test.TestFilter(244): Chec= king for false negatives [junit] 2009-03-24 03:16:50,727 INFO [main] test.TestFilter(255): Chec= king for false positives [junit] 2009-03-24 03:16:50,728 INFO [main] test.TestFilter(262): Succ= ess! [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.087 sec BUILD FAILED http://hudson.zones.apache.org/hudson/job/HBase-Patch/ws/trunk/build.xml :4= 58: Tests failed! Total time: 26 minutes 13 seconds [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results Publishing Clover coverage report...