Return-Path: Delivered-To: apmail-lucene-hadoop-dev-archive@locus.apache.org Received: (qmail 59721 invoked from network); 18 Aug 2007 11:46:27 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.2) by minotaur.apache.org with SMTP; 18 Aug 2007 11:46:27 -0000 Received: (qmail 4063 invoked by uid 500); 18 Aug 2007 11:46:23 -0000 Delivered-To: apmail-lucene-hadoop-dev-archive@lucene.apache.org Received: (qmail 4034 invoked by uid 500); 18 Aug 2007 11:46:23 -0000 Mailing-List: contact hadoop-dev-help@lucene.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: hadoop-dev@lucene.apache.org Delivered-To: mailing list hadoop-dev@lucene.apache.org Received: (qmail 4025 invoked by uid 99); 18 Aug 2007 11:46:23 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Sat, 18 Aug 2007 04:46:23 -0700 X-ASF-Spam-Status: No, hits=-97.3 required=10.0 tests=ALL_TRUSTED,DNS_FROM_DOB,RCVD_IN_DOB,WEIRD_PORT X-Spam-Check-By: apache.org Received: from [140.211.11.75] (HELO lucene.zones.apache.org) (140.211.11.75) by apache.org (qpsmtpd/0.29) with ESMTP; Sat, 18 Aug 2007 11:46:46 +0000 Received: from lucene.zones.apache.org (localhost [127.0.0.1]) by lucene.zones.apache.org (8.13.7+Sun/8.13.7) with ESMTP id l7IBjwTr019939 for ; Sat, 18 Aug 2007 11:45:58 GMT Date: Sat, 18 Aug 2007 11:45:57 +0000 (GMT+00:00) From: hudson@lucene.zones.apache.org To: hadoop-dev@lucene.apache.org Message-ID: <28629883.01187437558172.JavaMail.hudson@lucene.zones.apache.org> Subject: Build failed in Hudson: Hadoop-Nightly #207 MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: 7bit X-Virus-Checked: Checked by ClamAV on apache.org See http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/207/changes ------------------------------------------ [...truncated 38846 lines...] [junit] 07/08/18 11:43:39 INFO dfs.DataNode: Served block blk_-9201950809870625404 to /127.0.0.1 [junit] 07/08/18 11:43:39 INFO dfs.DataNode: Served block blk_1246071561207854290 to /127.0.0.1 [junit] 07/08/18 11:43:39 INFO dfs.DataNode: Served block blk_-8274688063616867065 to /127.0.0.1 [junit] 07/08/18 11:43:39 INFO hbase.HRegion: region -ROOT-,,0 available [junit] 07/08/18 11:43:39 INFO hbase.HMaster: 140.211.11.75:60711 serving -ROOT-,,0 [junit] 07/08/18 11:43:39 INFO hbase.HMaster: HMaster.rootScanner scanning meta region -ROOT-,,0 on 140.211.11.75:60711 [junit] 07/08/18 11:43:40 INFO dfs.DataNode: Served block blk_1246071561207854290 to /127.0.0.1 [junit] 07/08/18 11:43:40 INFO dfs.DataNode: Served block blk_-8274688063616867065 to /127.0.0.1 [junit] 07/08/18 11:43:40 INFO hbase.HMaster: HMaster.rootScanner scan of meta region -ROOT-,,0 complete [junit] 07/08/18 11:43:40 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50010 to delete blk_4874851074554895978 blk_-3866781872538194099 [junit] 07/08/18 11:43:40 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50011 to delete blk_4874851074554895978 blk_-3866781872538194099 [junit] 07/08/18 11:43:41 INFO hbase.HMaster: assigning region .META.,,1 to server 140.211.11.75:60711 [junit] 07/08/18 11:43:41 INFO hbase.HRegionServer: MSG_REGION_OPEN : regionname: .META.,,1, startKey: <>, tableDesc: {name: .META., families: {info:=(info:, max versions: 1, compression: none, in memory: false, max value length: 2147483647, bloom filter: none)}} [junit] 07/08/18 11:43:41 INFO hbase.HRegion: region .META.,,1 available [junit] 07/08/18 11:43:42 INFO hbase.HMaster: 140.211.11.75:60711 serving .META.,,1 [junit] 07/08/18 11:43:42 INFO dfs.DataNode: Deleting block blk_4874851074554895978 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data2/current/blk_4874851074554895978 [junit] 07/08/18 11:43:42 INFO dfs.DataNode: Deleting block blk_-3866781872538194099 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data1/current/blk_-3866781872538194099 [junit] 07/08/18 11:43:42 INFO hbase.HMaster: .META.,,1 open on 140.211.11.75:60711 [junit] 07/08/18 11:43:42 INFO hbase.HMaster: updating row .META.,,1 in table -ROOT-,,0 [junit] 07/08/18 11:43:42 INFO hbase.HMaster: HMaster.metaScanner scanning meta region .META.,,1 on 140.211.11.75:60711 [junit] 07/08/18 11:43:42 INFO hbase.HMaster: HMaster.metaScanner scan of meta region .META.,,1 complete [junit] 07/08/18 11:43:42 INFO dfs.DataNode: Deleting block blk_4874851074554895978 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data4/current/blk_4874851074554895978 [junit] 07/08/18 11:43:42 INFO dfs.DataNode: Deleting block blk_-3866781872538194099 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data3/current/blk_-3866781872538194099 [junit] 07/08/18 11:43:43 INFO hbase.HRegion: region test,,4361458168060528831 available [junit] 07/08/18 11:43:43 INFO hbase.HStore: closed test,,4361458168060528831/contents [junit] 07/08/18 11:43:43 INFO hbase.HRegion: closed test,,4361458168060528831 [junit] 07/08/18 11:43:43 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_test,,4361458168060528831/log/hlog.dat.000. blk_-6504473935291661857 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:43 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-6504473935291661857 [junit] 07/08/18 11:43:43 INFO dfs.DataNode: Received block blk_-6504473935291661857 from /127.0.0.1 [junit] 07/08/18 11:43:43 INFO dfs.DataNode: Received block blk_-6504473935291661857 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:43 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-6504473935291661857 [junit] 07/08/18 11:43:44 INFO dfs.StateChange: BLOCK* NameSystem.delete: blk_-6504473935291661857 is added to invalidSet of 127.0.0.1:50010 [junit] 07/08/18 11:43:44 INFO dfs.StateChange: BLOCK* NameSystem.delete: blk_-6504473935291661857 is added to invalidSet of 127.0.0.1:50011 [junit] 07/08/18 11:43:44 INFO hbase.HMaster: created table test [junit] 07/08/18 11:43:44 INFO dfs.DataNode: Served block blk_1246071561207854290 to /127.0.0.1 [junit] 07/08/18 11:43:44 INFO dfs.DataNode: Served block blk_-8274688063616867065 to /127.0.0.1 [junit] 07/08/18 11:43:44 INFO hbase.HMaster: assigning region test,,4361458168060528831 to server 140.211.11.75:60711 [junit] 07/08/18 11:43:44 INFO hbase.HRegionServer: MSG_REGION_OPEN : regionname: test,,4361458168060528831, startKey: <>, tableDesc: {name: test, families: {contents:=(contents:, max versions: 3, compression: none, in memory: false, max value length: 2147483647, bloom filter: none)}} [junit] 07/08/18 11:43:44 INFO hbase.HRegion: region test,,4361458168060528831 available [junit] 07/08/18 11:43:45 INFO hbase.HMaster: 140.211.11.75:60711 serving test,,4361458168060528831 [junit] 07/08/18 11:43:45 INFO hbase.HMaster: test,,4361458168060528831 open on 140.211.11.75:60711 [junit] 07/08/18 11:43:45 INFO hbase.HMaster: updating row test,,4361458168060528831 in table .META.,,1 [junit] 07/08/18 11:43:46 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50010 to delete blk_-6504473935291661857 [junit] 07/08/18 11:43:46 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50011 to delete blk_-6504473935291661857 [junit] 07/08/18 11:43:48 INFO dfs.DataNode: Deleting block blk_-6504473935291661857 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data2/current/blk_-6504473935291661857 [junit] 07/08/18 11:43:48 INFO dfs.DataNode: Deleting block blk_-6504473935291661857 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data4/current/blk_-6504473935291661857 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_-ROOT-,,0/info/mapfiles/4135995958018356033/data. blk_-8769655321457322352 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-8769655321457322352 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-8769655321457322352 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-8769655321457322352 from /127.0.0.1 and mirrored to /127.0.0.1:50010 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-8769655321457322352 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_-ROOT-,,0/info/mapfiles/4135995958018356033/index. blk_7893783824749888091 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_7893783824749888091 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_7893783824749888091 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_7893783824749888091 from /127.0.0.1 and mirrored to /127.0.0.1:50010 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_7893783824749888091 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_-ROOT-,,0/info/info/4135995958018356033. blk_-7616814298622210801 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-7616814298622210801 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-7616814298622210801 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-7616814298622210801 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-7616814298622210801 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Served block blk_-8769655321457322352 to /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Served block blk_7893783824749888091 to /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_.META.,,1/info/mapfiles/39215388577935865/data. blk_4194275213814198736 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_4194275213814198736 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_4194275213814198736 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_4194275213814198736 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_4194275213814198736 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_.META.,,1/info/mapfiles/39215388577935865/index. blk_7166113622139948976 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_7166113622139948976 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_7166113622139948976 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_7166113622139948976 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_7166113622139948976 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_.META.,,1/info/info/39215388577935865. blk_-8040465389516779893 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-8040465389516779893 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-8040465389516779893 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-8040465389516779893 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-8040465389516779893 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Served block blk_4194275213814198736 to /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Served block blk_7166113622139948976 to /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_test,,4361458168060528831/contents/mapfiles/8209279384168607082/data. blk_-5436730921086813052 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-5436730921086813052 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-5436730921086813052 from /127.0.0.1 [junit] 07/08/18 11:43:49 INFO dfs.DataNode: Received block blk_-5436730921086813052 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-5436730921086813052 [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_test,,4361458168060528831/contents/mapfiles/8209279384168607082/index. blk_2192124120974328541 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:49 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_2192124120974328541 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Received block blk_2192124120974328541 from /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Received block blk_2192124120974328541 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:50 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_2192124120974328541 [junit] 07/08/18 11:43:50 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/hregion_test,,4361458168060528831/contents/info/8209279384168607082. blk_7430629777995552004 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:50 INFO hbase.HMaster: HMaster.rootScanner scanning meta region -ROOT-,,0 on 140.211.11.75:60711 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_1246071561207854290 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_7430629777995552004 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-8274688063616867065 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Received block blk_7430629777995552004 from /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Received block blk_7430629777995552004 from /127.0.0.1 and mirrored to /127.0.0.1:50011 [junit] 07/08/18 11:43:50 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_7430629777995552004 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-8769655321457322352 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO hbase.HMaster: HMaster.rootScanner scan of meta region -ROOT-,,0 complete [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_7893783824749888091 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_2192124120974328541 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_2192124120974328541 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_2192124120974328541 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_-5436730921086813052 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO dfs.DataNode: Served block blk_2192124120974328541 to /127.0.0.1 [junit] 07/08/18 11:43:50 INFO hbase.MiniHBaseCluster: Shutting down HBase Cluster [junit] 07/08/18 11:43:51 INFO hbase.HMaster: Waiting on following regionserver(s) to go down (or region server lease expiration, whichever happens first): [address: 140.211.11.75:60711, startcode: -3116696188329032915, load: (requests: 1 regions: 3)] [junit] 07/08/18 11:43:51 INFO hbase.Leases: closing leases [junit] 07/08/18 11:43:51 INFO hbase.Leases: leases closed [junit] 07/08/18 11:43:51 INFO ipc.Server: Stopping server on 60711 [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 1 on 60711: exiting [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 0 on 60711: exiting [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 4 on 60711: exiting [junit] 07/08/18 11:43:51 INFO hbase.HRegionServer: splitOrCompactChecker exiting [junit] 07/08/18 11:43:51 INFO hbase.HStore: closed -ROOT-,,0/info [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 2 on 60711: exiting [junit] 07/08/18 11:43:51 INFO hbase.HRegionServer: logRoller exiting [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 3 on 60711: exiting [junit] 07/08/18 11:43:51 INFO hbase.HRegion: closed -ROOT-,,0 [junit] 07/08/18 11:43:51 INFO hbase.HRegionServer: cacheFlusher exiting [junit] 07/08/18 11:43:51 INFO hbase.HStore: closed .META.,,1/info [junit] 07/08/18 11:43:51 INFO hbase.HRegion: closed .META.,,1 [junit] 07/08/18 11:43:51 INFO hbase.HStore: closed test,,4361458168060528831/contents [junit] 07/08/18 11:43:51 INFO hbase.HRegion: closed test,,4361458168060528831 [junit] 07/08/18 11:43:51 INFO ipc.Server: Stopping IPC Server listener on 60711 [junit] 07/08/18 11:43:51 INFO dfs.StateChange: BLOCK* NameSystem.allocateBlock: /hbase/log_140.211.11.75_60711/hlog.dat.000. blk_-7490610423611639043 is created and added to pendingCreates and pendingCreateBlocks [junit] 07/08/18 11:43:51 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50011 is added to blk_-7490610423611639043 [junit] 07/08/18 11:43:51 INFO dfs.DataNode: Received block blk_-7490610423611639043 from /127.0.0.1 [junit] 07/08/18 11:43:51 INFO dfs.DataNode: Received block blk_-7490610423611639043 from /127.0.0.1 and mirrored to /127.0.0.1:50010 [junit] 07/08/18 11:43:51 INFO dfs.StateChange: BLOCK* NameSystem.addStoredBlock: blockMap updated: 127.0.0.1:50010 is added to blk_-7490610423611639043 [junit] 07/08/18 11:43:51 INFO dfs.StateChange: BLOCK* NameSystem.delete: blk_-7490610423611639043 is added to invalidSet of 127.0.0.1:50011 [junit] 07/08/18 11:43:51 INFO dfs.StateChange: BLOCK* NameSystem.delete: blk_-7490610423611639043 is added to invalidSet of 127.0.0.1:50010 [junit] 07/08/18 11:43:51 INFO hbase.HRegionServer: telling master that region server is shutting down at: 140.211.11.75:60711 [junit] 07/08/18 11:43:51 INFO hbase.HMaster: Cancelling lease for 140.211.11.75:60711 [junit] 07/08/18 11:43:51 INFO hbase.HMaster: Region server 140.211.11.75:60711: MSG_REPORT_EXITING [junit] 07/08/18 11:43:51 INFO ipc.Server: Stopping server on 60710 [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 1 on 60710: exiting [junit] 07/08/18 11:43:51 INFO hbase.Leases: closing leases [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 0 on 60710: exiting [junit] 07/08/18 11:43:51 INFO ipc.Server: Stopping IPC Server listener on 60710 [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 4 on 60710: exiting [junit] 07/08/18 11:43:51 INFO hbase.Leases: leases closed [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 2 on 60710: exiting [junit] 07/08/18 11:43:51 INFO hbase.HMaster: MetaScanner exiting [junit] 07/08/18 11:43:51 INFO ipc.Server: IPC Server handler 3 on 60710: exiting [junit] 07/08/18 11:43:51 INFO hbase.HMaster: RootScanner exiting [junit] 07/08/18 11:43:51 INFO hbase.HMaster: HMaster main thread exiting [junit] 07/08/18 11:43:52 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50010 to delete blk_-7490610423611639043 [junit] 07/08/18 11:43:52 INFO dfs.StateChange: BLOCK* NameSystem.blockToInvalidate: ask 127.0.0.1:50011 to delete blk_-7490610423611639043 [junit] 07/08/18 11:43:52 INFO hbase.HRegionServer: worker thread exiting [junit] 07/08/18 11:43:54 INFO dfs.DataNode: Deleting block blk_-7490610423611639043 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data2/current/blk_-7490610423611639043 [junit] 07/08/18 11:43:55 INFO dfs.DataNode: Deleting block blk_-7490610423611639043 file http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data4/current/blk_-7490610423611639043 [junit] 07/08/18 11:44:51 WARN hbase.HRegionServer: [junit] java.net.SocketTimeoutException: timed out waiting for rpc response [junit] at org.apache.hadoop.ipc.Client.call(Client.java:472) [junit] at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:165) [junit] at $Proxy6.regionServerReport(Unknown Source) [junit] at org.apache.hadoop.hbase.HRegionServer.run(HRegionServer.java:771) [junit] at java.lang.Thread.run(Thread.java:595) [junit] at org.apache.hadoop.hbase.MiniHBaseCluster$RegionServerThread.run(MiniHBaseCluster.java:179) [junit] 07/08/18 11:44:51 INFO hbase.HRegionServer: stopping server at: 140.211.11.75:60711 [junit] 07/08/18 11:44:51 INFO hbase.HRegionServer: HRegionServer stopped at: 140.211.11.75:60711 [junit] 07/08/18 11:44:51 INFO hbase.HRegionServer: main thread exiting [junit] 07/08/18 11:44:51 INFO hbase.MiniHBaseCluster: Shutdown HMaster 1 region server(s) [junit] 07/08/18 11:44:52 INFO hbase.MiniHBaseCluster: Shutting down Mini DFS cluster [junit] Shutting down the Mini HDFS Cluster [junit] Shutting down DataNode 1 [junit] 07/08/18 11:44:52 INFO util.ThreadedServer: Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=60696] [junit] 07/08/18 11:44:52 INFO http.SocketListener: Stopped SocketListener on 0.0.0.0:60696 [junit] 07/08/18 11:44:52 INFO util.Container: Stopped org.mortbay.jetty.servlet.WebApplicationHandler@17aece8 [junit] 07/08/18 11:44:52 INFO util.Container: Stopped WebApplicationContext[/,/] [junit] 07/08/18 11:44:52 INFO util.Container: Stopped HttpContext[/logs,/logs] [junit] 07/08/18 11:44:52 INFO util.Container: Stopped HttpContext[/static,/static] [junit] 07/08/18 11:44:52 INFO util.Container: Stopped org.mortbay.jetty.Server@1815338 [junit] 07/08/18 11:44:52 INFO dfs.DataNode: Exiting DataXceiveServer due to java.net.SocketException: Socket closed [junit] 07/08/18 11:44:52 INFO dfs.DataNode: Finishing DataNode in: FSDataset{dirpath='http://lucene.zones.apache.org:8080/hudson/job/Hadoop-Nightly/ws/trunk/build/contrib/hbase/test/data/dfs/data/data3/current,/export/home/hudson/hudson/jobs/Hadoop-Nightly/workspace/trunk/build/contrib/hbase/test/data/dfs/data/data4/current'} [junit] Shutting down DataNode 0 [junit] 07/08/18 11:44:52 INFO util.ThreadedServer: Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=60695] [junit] 07/08/18 11:44:52 INFO http.SocketListener: Stopped SocketListener on 0.0.0.0:60695 [junit] 07/08/18 11:44:52 INFO util.Container: Stopped org.mortbay.jetty.servlet.WebApplicationHandler@31f2a7 [junit] 07/08/18 11:44:52 INFO util.Container: Stopped WebApplicationContext[/,/] [junit] 07/08/18 11:44:52 INFO util.Container: Stopped HttpContext[/logs,/logs] [junit] 07/08/18 11:44:53 INFO util.Container: Stopped HttpContext[/static,/static] [junit] 07/08/18 11:44:53 INFO util.Container: Stopped org.mortbay.jetty.Server@15e2075 [junit] 07/08/18 11:44:53 INFO dfs.DataNode: Exiting DataXceiveServer due to java.net.SocketException: Socket closed [junit] 07/08/18 11:44:53 WARN fs.FSNamesystem: PendingReplicationMonitor thread received exception. java.lang.InterruptedException: sleep interrupted [junit] 07/08/18 11:44:53 INFO util.ThreadedServer: Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=60693] [junit] 07/08/18 11:44:53 INFO http.SocketListener: Stopped SocketListener on 0.0.0.0:60693 [junit] 07/08/18 11:44:53 INFO util.Container: Stopped org.mortbay.jetty.servlet.WebApplicationHandler@e753 [junit] 07/08/18 11:44:53 INFO util.Container: Stopped WebApplicationContext[/,/] [junit] 07/08/18 11:44:53 INFO util.Container: Stopped HttpContext[/logs,/logs] [junit] 07/08/18 11:44:53 INFO util.Container: Stopped HttpContext[/static,/static] [junit] 07/08/18 11:44:53 INFO util.Container: Stopped org.mortbay.jetty.Server@181ed9e [junit] 07/08/18 11:44:53 INFO ipc.Server: Stopping server on 60686 [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 3 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 7 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 2 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 9 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 8 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 6 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 4 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 0 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 1 on 60686: exiting [junit] 07/08/18 11:44:53 INFO ipc.Server: IPC Server handler 5 on 60686: exiting [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 79.931 sec [junit] Running org.apache.hadoop.hbase.TestToString [junit] regionname: hank,,-1, startKey: <>, tableDesc: {name: hank, families: {hankfamily:=(hankfamily:, max versions: 3, compression: none, in memory: false, max value length: 2147483647, bloom filter: none), hankotherfamily:=(hankotherfamily:, max versions: 10, compression: block, in memory: true, max value length: 1000, bloom filter: none)}} [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.372 sec [junit] Running org.apache.hadoop.hbase.filter.TestPageRowFilter [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.241 sec [junit] Running org.apache.hadoop.hbase.filter.TestRegExpRowFilter [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.323 sec [junit] Running org.apache.hadoop.hbase.filter.TestRowFilterSet [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.543 sec [junit] Running org.apache.hadoop.hbase.filter.TestStopRowFilter [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.049 sec [junit] Running org.apache.hadoop.hbase.filter.TestWhileMatchRowFilter [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.245 sec [junit] Running org.apache.hadoop.hbase.shell.TestHBaseShell [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.416 sec [junit] Running org.apache.hadoop.hbase.util.TestKeying [junit] Original url http://abc:bcd@www.example.com/index.html?query=something#middle, Transformed url r:http://abc:bcd@com.example.www/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.102 sec [junit] Running org.onelab.test.TestFilter [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.426 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 :204: Tests failed! Total time: 35 minutes 43 seconds Recording fingerprints Publishing Javadoc Recording test results