Return-Path: Delivered-To: apmail-hadoop-hbase-user-archive@minotaur.apache.org Received: (qmail 35327 invoked from network); 3 Feb 2010 17:49:51 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.3) by minotaur.apache.org with SMTP; 3 Feb 2010 17:49:51 -0000 Received: (qmail 96497 invoked by uid 500); 3 Feb 2010 17:49:50 -0000 Delivered-To: apmail-hadoop-hbase-user-archive@hadoop.apache.org Received: (qmail 96461 invoked by uid 500); 3 Feb 2010 17:49:50 -0000 Mailing-List: contact hbase-user-help@hadoop.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: hbase-user@hadoop.apache.org Delivered-To: mailing list hbase-user@hadoop.apache.org Received: (qmail 96446 invoked by uid 99); 3 Feb 2010 17:49:50 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 03 Feb 2010 17:49:50 +0000 X-ASF-Spam-Status: No, hits=3.7 required=10.0 tests=HTML_MESSAGE,NORMAL_HTTP_TO_IP,SPF_PASS,WEIRD_PORT X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: domain of jdcryans@gmail.com designates 209.85.210.197 as permitted sender) Received: from [209.85.210.197] (HELO mail-yx0-f197.google.com) (209.85.210.197) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 03 Feb 2010 17:49:40 +0000 Received: by yxe35 with SMTP id 35so1532293yxe.2 for ; Wed, 03 Feb 2010 09:49:19 -0800 (PST) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=gamma; h=domainkey-signature:mime-version:sender:received:in-reply-to :references:date:x-google-sender-auth:message-id:subject:from:to :content-type; bh=BhapqEi5PcHPO3Cbznn7R7e70Y+q3gXhsupt5LKS83E=; b=QwAFGR+I/bYnEKf1TwGKuubC+JPbQHlYYRWzQuxtbH0ReC1herOgp8SOgU2xwwvVCq 9W0pPnrsWG+vZAFILp3PxIXa23NGpQIJnbnwWnlDi9ASVn9J4dyNaC+/ofpQ78fPOupD 4wu1TlIDN5Eeh412QCIRARIhAEUOB2pRM9f1E= DomainKey-Signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=mime-version:sender:in-reply-to:references:date :x-google-sender-auth:message-id:subject:from:to:content-type; b=QvuD5wIju2R7qAnvpqyY2Z1JL5q+AKFzgM2rPQyXmF58d+23B4bv5zINwfiZEJXX+n Bg1J/pDxUjt34xZgFuhDWoDrba+UX526HHvWZ0Att/TN2rbBJnoFu47MBxHeZrsXyHpw 3U6TfWAIYWFDTpZx+xK/ErdTP4+0NaDP6XLNU= MIME-Version: 1.0 Sender: jdcryans@gmail.com Received: by 10.91.174.2 with SMTP id b2mr184864agp.51.1265219356689; Wed, 03 Feb 2010 09:49:16 -0800 (PST) In-Reply-To: <27433209.post@talk.nabble.com> References: <27433209.post@talk.nabble.com> Date: Wed, 3 Feb 2010 09:49:16 -0800 X-Google-Sender-Auth: a77ba5d76a2250ca Message-ID: <31a243e71002030949m69d81cefkda3944dfe1f97e73@mail.gmail.com> Subject: Re: Exception trace in client log ... From: Jean-Daniel Cryans To: hbase-user@hadoop.apache.org Content-Type: multipart/alternative; boundary=001485f07d3e518698047eb5d6a4 --001485f07d3e518698047eb5d6a4 Content-Type: text/plain; charset=ISO-8859-1 Content-Transfer-Encoding: quoted-printable The WARNs at the end are just telling you that it tried to close the sessio= n but it was already closed. The rest is just general Zookeeper info. J-D On Wed, Feb 3, 2010 at 1:00 AM, zward3x wrote: > > Hi, > > i'm runing hbase (0.20.3) in non distributed mode. I can access hbase vi= a > hbase shell (create, put, get, scan it looks ok). But when i'm accessing > from client (jruby calling hbase api) i'm geting stack trace but only at > the > end of my program. I looks that everithing is done - i can see scan or pu= t > results but at the end i'm geting stack trace. Also it seems that i'm not > getting ERROR log but WARN. (Note that same code works fine on version > 0.20.1) > > Here is client log: > > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:zookeeper.version=3D3.2.2-888565, built on 12/08/2009 21:51 G= MT > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:host.name=3D192.168.0.2 > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:java.version=3D1.6.0_15 > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:java.vendor=3DApple Inc. > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > > environment:java.home=3D/System/Library/Frameworks/JavaVM.framework/Versi= ons/1.6.0/Home > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:java.class.path=3D/Applications/NetBeans/NetBeans > > 6.8.app/Contents/Resources/NetBeans/ruby2/jruby-1.4.0/lib/jruby.jar:/Appl= ications/NetBeans/NetBeans > > 6.8.app/Contents/Resources/NetBeans/ruby2/jruby-1.4.0/lib/profile.jar:/us= r/lib/hbase-0.20.3/lib/AgileJSON-2009-03-30.jar:/usr/lib/hbase-0.20.3/lib/c= ommons-cli-2.0-SNAPSHOT.jar:/usr/lib/hbase-0.20.3/lib/commons-el-from-jetty= -5.1.4.jar:/usr/lib/hbase-0.20.3/lib/commons-httpclient-3.0.1.jar:/usr/lib/= hbase-0.20.3/lib/commons-logging-1.0.4.jar:/usr/lib/hbase-0.20.3/lib/common= s-logging-api-1.0.4.jar:/usr/lib/hbase-0.20.3/lib/commons-math-1.1.jar:/usr= /lib/hbase-0.20.3/lib/hadoop-0.20.1-hdfs127-core.jar:/usr/lib/hbase-0.20.3/= lib/hadoop-0.20.1-test.jar:/usr/lib/hbase-0.20.3/lib/jasper-compiler-5.5.12= .jar:/usr/lib/hbase-0.20.3/lib/jasper-runtime-5.5.12.jar:/usr/lib/hbase-0.2= 0.3/lib/jetty-6.1.14.jar:/usr/lib/hbase-0.20.3/lib/jetty-util-6.1.14.jar:/u= sr/lib/hbase-0.20.3/lib/jruby-complete-1.2.0.jar:/usr/lib/hbase-0.20.3/lib/= json.jar:/usr/lib/hbase-0.20.3/lib/junit-3.8.1.jar:/usr/lib/hbase-0.20.3/li= b/libthrift-r771587.jar:/usr/lib/hbase-0.20.3/lib/log4j-1.2.15.jar:/usr/lib= /hbase-0.20.3/lib/lucene-core-2.2.0.jar:/usr/lib/hbase-0.20.3/lib/servlet-a= pi-2.5-6.1.14.jar:/usr/lib/hbase-0.20.3/lib/xmlenc-0.52.jar:/usr/lib/hbase-= 0.20.3/lib/zookeeper-3.2.2.jar:/usr/lib/hbase-0.20.3/hbase-0.20.3.jar:/usr/= lib/hbase-0.20.3/conf > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > > environment:java.library.path=3D.:/Library/Java/Extensions:/System/Librar= y/Java/Extensions:/usr/lib/java > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > > environment:java.io.tmpdir=3D/var/folders/bZ/bZ9NjEt6EEOL8obSel2K0E+++TI/= -Tmp-/ > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:java.compiler=3D > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client environment:os.name=3D= Mac > OS X > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:os.arch=3Dx86_64 > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:os.version=3D10.6 > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:user.name=3Dzaharije > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:user.home=3D/Users/zaharije > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Client > environment:user.dir=3D/Users/zaharije/NetBeansProjects/RailsApplication1 > 10/02/03 09:46:25 INFO zookeeper.ZooKeeper: Initiating client connection, > connectString=3Dlocalhost:2181 sessionTimeout=3D60000 > > watcher=3Dorg.apache.hadoop.hbase.client.HConnectionManager$ClientZKWatch= er@21e3cc77 > 10/02/03 09:46:25 INFO zookeeper.ClientCnxn: > zookeeper.disableAutoWatchReset > is false > 10/02/03 09:46:25 INFO zookeeper.ClientCnxn: Attempting connection to > server > localhost/fe80:0:0:0:0:0:0:1%1:2181 > 10/02/03 09:46:25 INFO zookeeper.ClientCnxn: Priming connection to > java.nio.channels.SocketChannel[connected local=3D/fe80:0:0:0:0:0:0:1%1:6= 0781 > remote=3Dlocalhost/fe80:0:0:0:0:0:0:1%1:2181] > 10/02/03 09:46:25 INFO zookeeper.ClientCnxn: Server connection successful > 10/02/03 09:46:26 INFO zookeeper.ZooKeeper: Closing session: > 0x1269300e1560002 > 10/02/03 09:46:26 INFO zookeeper.ClientCnxn: Closing ClientCnxn for > session: > 0x1269300e1560002 > 10/02/03 09:46:26 INFO zookeeper.ClientCnxn: Exception while closing send > thread for session 0x1269300e1560002 : Read error rc =3D -1 > java.nio.DirectByteBuffer[pos=3D0 lim=3D4 cap=3D4] > 10/02/03 09:46:26 WARN zookeeper.ClientCnxn: Ignoring exception during > shutdown input > java.net.SocketException: Socket is not connected > at sun.nio.ch.SocketChannelImpl.shutdown(Native Method) > at > sun.nio.ch.SocketChannelImpl.shutdownInput(SocketChannelImpl.java:640) > at sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:360) > at > org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:999) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:984) > 10/02/03 09:46:26 INFO zookeeper.ClientCnxn: Disconnecting ClientCnxn for > session: 0x1269300e1560002 > 10/02/03 09:46:26 INFO zookeeper.ZooKeeper: Session: 0x1269300e1560002 > closed > 10/02/03 09:46:26 INFO zookeeper.ClientCnxn: EventThread shut down > > > -------------------------------------------------------------------------= ------------------- > > And here is logs from hbase (zookeper log): > > Wed Feb 3 09:44:50 CET 2010 Starting zookeeper on hari-mac.local > ulimit -n 256 > 2010-02-03 09:44:53,349 INFO > org.apache.zookeeper.server.ZooKeeperServerMain: Starting server > 2010-02-03 09:44:53,359 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:zookeeper.version=3D3.2.2-888565, built on 12/08/2009 > 21:51 > GMT > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:host.name=3D192.168.0.2 > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:java.version=3D1.6.0_15 > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:java.vendor=3DApple Inc. > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server > > environment:java.home=3D/System/Library/Frameworks/JavaVM.framework/Versi= ons/1.6.0/Home > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server > > environment:java.class.path=3D/usr/lib/hbase-0.20.3/conf:/Library/Java/Ho= me/lib/tools.jar:/usr/lib/hbase-0.20.3/bin/..:/usr/lib/hbase-0.20.3/bin/../= hbase-0.20.3-test.jar:/usr/lib/hbase-0.20.3/bin/../hbase-0.20.3.jar:/usr/li= b/hbase-0.20.3/bin/../lib/AgileJSON-2009-03-30.jar:/usr/lib/hbase-0.20.3/bi= n/../lib/commons-cli-2.0-SNAPSHOT.jar:/usr/lib/hbase-0.20.3/bin/../lib/comm= ons-el-from-jetty-5.1.4.jar:/usr/lib/hbase-0.20.3/bin/../lib/commons-httpcl= ient-3.0.1.jar:/usr/lib/hbase-0.20.3/bin/../lib/commons-logging-1.0.4.jar:/= usr/lib/hbase-0.20.3/bin/../lib/commons-logging-api-1.0.4.jar:/usr/lib/hbas= e-0.20.3/bin/../lib/commons-math-1.1.jar:/usr/lib/hbase-0.20.3/bin/../lib/h= adoop-0.20.1-hdfs127-core.jar:/usr/lib/hbase-0.20.3/bin/../lib/hadoop-0.20.= 1-test.jar:/usr/lib/hbase-0.20.3/bin/../lib/jasper-compiler-5.5.12.jar:/usr= /lib/hbase-0.20.3/bin/../lib/jasper-runtime-5.5.12.jar:/usr/lib/hbase-0.20.= 3/bin/../lib/jetty-6.1.14.jar:/usr/lib/hbase-0.20.3/bin/../lib/jetty-util-6= .1.14.jar:/usr/lib/hbase-0.20.3/bin/../lib/jruby-complete-1.2.0.jar:/usr/li= b/hbase-0.20.3/bin/../lib/json.jar:/usr/lib/hbase-0.20.3/bin/../lib/junit-3= .8.1.jar:/usr/lib/hbase-0.20.3/bin/../lib/libthrift-r771587.jar:/usr/lib/hb= ase-0.20.3/bin/../lib/log4j-1.2.15.jar:/usr/lib/hbase-0.20.3/bin/../lib/luc= ene-core-2.2.0.jar:/usr/lib/hbase-0.20.3/bin/../lib/servlet-api-2.5-6.1.14.= jar:/usr/lib/hbase-0.20.3/bin/../lib/xmlenc-0.52.jar:/usr/lib/hbase-0.20.3/= bin/../lib/zookeeper-3.2.2.jar:/usr/lib/hbase-0.20.3/bin/../lib/jsp-2.1/jsp= -2.1.jar:/usr/lib/hbase-0.20.3/bin/../lib/jsp-2.1/jsp-api-2.1.jar > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server > > environment:java.library.path=3D/usr/lib/hbase-0.20.3/bin/../lib/native/M= ac_OS_X-x86_64-64 > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server > > environment:java.io.tmpdir=3D/var/folders/bZ/bZ9NjEt6EEOL8obSel2K0E+++TI/= -Tmp-/ > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:java.compiler=3D > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:os.name=3DMac OS X > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:os.arch=3Dx86_64 > 2010-02-03 09:44:53,360 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:os.version=3D10.6 > 2010-02-03 09:44:53,361 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:user.name=3Dzaharije > 2010-02-03 09:44:53,361 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:user.home=3D/Users/zaharije > 2010-02-03 09:44:53,361 INFO org.apache.zookeeper.server.ZooKeeperServer: > Server environment:user.dir=3D/usr/lib/hbase-0.20.3 > 2010-02-03 09:44:53,418 INFO > org.apache.zookeeper.server.persistence.FileSnap: Reading snapshot > /tmp/hbase-zaharije/zookeeper/version-2/snapshot.fd > 2010-02-03 09:44:53,458 INFO > org.apache.zookeeper.server.persistence.FileTxnSnapLog: Snapshotting: 119 > 2010-02-03 09:44:53,857 INFO org.apache.zookeeper.server.NIOServerCnxn: > Connected to /fe80:0:0:0:0:0:0:1%1:60769 lastZxid 0 > 2010-02-03 09:44:53,859 INFO org.apache.zookeeper.server.NIOServerCnxn: > Creating new session 0x1269300e1560000 > 2010-02-03 09:44:53,890 INFO org.apache.zookeeper.server.NIOServerCnxn: > Finished init of 0x1269300e1560000 valid:true > 2010-02-03 09:44:53,905 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560000 type:create cxid:0x4 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:44:53,910 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560000 type:create cxid:0x6 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:44:53,961 INFO org.apache.zookeeper.server.NIOServerCnxn: > Connected to /0:0:0:0:0:0:0:1%0:60771 lastZxid 0 > 2010-02-03 09:44:53,961 INFO org.apache.zookeeper.server.NIOServerCnxn: > Creating new session 0x1269300e1560001 > 2010-02-03 09:44:53,962 INFO org.apache.zookeeper.server.NIOServerCnxn: > Finished init of 0x1269300e1560001 valid:true > 2010-02-03 09:44:54,777 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560001 type:create cxid:0x3 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:44:55,099 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560001 type:create cxid:0x6 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:44:56,104 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560000 type:create cxid:0xe > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:44:56,108 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560000 type:create cxid:0x10 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:46:25,767 INFO org.apache.zookeeper.server.NIOServerCnxn: > Connected to /fe80:0:0:0:0:0:0:1%1:60781 lastZxid 0 > 2010-02-03 09:46:25,768 INFO org.apache.zookeeper.server.NIOServerCnxn: > Creating new session 0x1269300e1560002 > 2010-02-03 09:46:25,769 INFO org.apache.zookeeper.server.NIOServerCnxn: > Finished init of 0x1269300e1560002 valid:true > 2010-02-03 09:46:25,882 WARN > org.apache.zookeeper.server.PrepRequestProcessor: Got exception when > processing sessionid:0x1269300e1560002 type:create cxid:0x2 > zxid:0xfffffffffffffffe txntype:unknown n/a > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists > at > > org.apache.zookeeper.server.PrepRequestProcessor.pRequest(PrepRequestProc= essor.java:245) > at > > org.apache.zookeeper.server.PrepRequestProcessor.run(PrepRequestProcessor= .java:114) > 2010-02-03 09:46:26,014 INFO > org.apache.zookeeper.server.PrepRequestProcessor: Processed session > termination request for id: 0x1269300e1560002 > 2010-02-03 09:46:26,015 INFO org.apache.zookeeper.server.NIOServerCnxn: > closing session:0x1269300e1560002 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=3D/fe80:0:0:0:0:0:0:1%1:2= 181 > remote=3D/fe80:0:0:0:0:0:0:1%1:60781] > > > -------------------------------------------------------------------------= ------------------- > > Here is hbase master's log: > > Wed Feb 3 09:44:51 CET 2010 Starting master on hari-mac.local > ulimit -n 256 > 2010-02-03 09:44:52,103 INFO org.apache.hadoop.hbase.master.HMaster: > vmName=3DJava HotSpot(TM) 64-Bit Server VM, vmVendor=3DApple Inc., > vmVersion=3D14.1-b02-90 > 2010-02-03 09:44:52,104 INFO org.apache.hadoop.hbase.master.HMaster: > vmInputArguments=3D[-Xmx1000m, -XX:+HeapDumpOnOutOfMemoryError, > -XX:+UseConcMarkSweepGC, -XX:+CMSIncrementalMode, > -Dhbase.log.dir=3D/usr/lib/hbase-0.20.3/logs, > -Dhbase.log.file=3Dhbase-zaharije-master-hari-mac.local.log, > -Dhbase.home.dir=3D/usr/lib/hbase-0.20.3, -Dhbase.id.str=3Dzaharije, > -Dhbase.root.logger=3DINFO,DRFA, > -Djava.library.path=3D/usr/lib/hbase-0.20.3/lib/native/Mac_OS_X-x86_64-64= ] > 2010-02-03 09:44:52,164 INFO org.apache.hadoop.hbase.master.HMaster: My > address is 192.168.0.2:60000 > 2010-02-03 09:44:52,366 INFO org.apache.hadoop.hbase.ipc.HBaseRpcMetrics: > Initializing RPC Metrics with hostName=3DHMaster, port=3D60000 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:zookeeper.version=3D3.2.2-888565, built on 12/08/2009 21:51 G= MT > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:host.name=3D192.168.0.2 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:java.version=3D1.6.0_15 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:java.vendor=3DApple Inc. > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > > environment:java.home=3D/System/Library/Frameworks/JavaVM.framework/Versi= ons/1.6.0/Home > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > > environment:java.class.path=3D/usr/lib/hbase-0.20.3/conf:/Library/Java/Ho= me/lib/tools.jar:/usr/lib/hbase-0.20.3:/usr/lib/hbase-0.20.3/hbase-0.20.3-t= est.jar:/usr/lib/hbase-0.20.3/hbase-0.20.3.jar:/usr/lib/hbase-0.20.3/lib/Ag= ileJSON-2009-03-30.jar:/usr/lib/hbase-0.20.3/lib/commons-cli-2.0-SNAPSHOT.j= ar:/usr/lib/hbase-0.20.3/lib/commons-el-from-jetty-5.1.4.jar:/usr/lib/hbase= -0.20.3/lib/commons-httpclient-3.0.1.jar:/usr/lib/hbase-0.20.3/lib/commons-= logging-1.0.4.jar:/usr/lib/hbase-0.20.3/lib/commons-logging-api-1.0.4.jar:/= usr/lib/hbase-0.20.3/lib/commons-math-1.1.jar:/usr/lib/hbase-0.20.3/lib/had= oop-0.20.1-hdfs127-core.jar:/usr/lib/hbase-0.20.3/lib/hadoop-0.20.1-test.ja= r:/usr/lib/hbase-0.20.3/lib/jasper-compiler-5.5.12.jar:/usr/lib/hbase-0.20.= 3/lib/jasper-runtime-5.5.12.jar:/usr/lib/hbase-0.20.3/lib/jetty-6.1.14.jar:= /usr/lib/hbase-0.20.3/lib/jetty-util-6.1.14.jar:/usr/lib/hbase-0.20.3/lib/j= ruby-complete-1.2.0.jar:/usr/lib/hbase-0.20.3/lib/json.jar:/usr/lib/hbase-0= .20.3/lib/junit-3.8.1.jar:/usr/lib/hbase-0.20.3/lib/libthrift-r771587.jar:/= usr/lib/hbase-0.20.3/lib/log4j-1.2.15.jar:/usr/lib/hbase-0.20.3/lib/lucene-= core-2.2.0.jar:/usr/lib/hbase-0.20.3/lib/servlet-api-2.5-6.1.14.jar:/usr/li= b/hbase-0.20.3/lib/xmlenc-0.52.jar:/usr/lib/hbase-0.20.3/lib/zookeeper-3.2.= 2.jar:/usr/lib/hbase-0.20.3/lib/jsp-2.1/jsp-2.1.jar:/usr/lib/hbase-0.20.3/l= ib/jsp-2.1/jsp-api-2.1.jar > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > > environment:java.library.path=3D/usr/lib/hbase-0.20.3/lib/native/Mac_OS_X= -x86_64-64 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > > environment:java.io.tmpdir=3D/var/folders/bZ/bZ9NjEt6EEOL8obSel2K0E+++TI/= -Tmp-/ > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:java.compiler=3D > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:os.name=3DMac OS X > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:os.arch=3Dx86_64 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:os.version=3D10.6 > 2010-02-03 09:44:52,454 INFO org.apache.zookeeper.ZooKeeper: Client > environment:user.name=3Dzaharije > 2010-02-03 09:44:52,455 INFO org.apache.zookeeper.ZooKeeper: Client > environment:user.home=3D/Users/zaharije > 2010-02-03 09:44:52,455 INFO org.apache.zookeeper.ZooKeeper: Client > environment:user.dir=3D/usr/lib/hbase-0.20.3/logs > 2010-02-03 09:44:52,456 INFO org.apache.zookeeper.ZooKeeper: Initiating > client connection, connectString=3Dlocalhost:2181 sessionTimeout=3D60000 > watcher=3DThread[Thread-1,5,main] > 2010-02-03 09:44:52,460 INFO org.apache.zookeeper.ClientCnxn: > zookeeper.disableAutoWatchReset is false > 2010-02-03 09:44:52,473 INFO org.apache.zookeeper.ClientCnxn: Attempting > connection to server localhost/0:0:0:0:0:0:0:1:2181 > 2010-02-03 09:44:52,477 WARN org.apache.zookeeper.ClientCnxn: Exception > closing session 0x0 to sun.nio.ch.SelectionKeyImpl@286e4365 > java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) > at > sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:574) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:933) > 2010-02-03 09:44:52,479 WARN org.apache.zookeeper.ClientCnxn: Ignoring > exception during shutdown input > java.nio.channels.ClosedChannelException > at > sun.nio.ch.SocketChannelImpl.shutdownInput(SocketChannelImpl.java:638) > at sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:360) > at > org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:999) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:970) > 2010-02-03 09:44:52,479 WARN org.apache.zookeeper.ClientCnxn: Ignoring > exception during shutdown output > java.nio.channels.ClosedChannelException > at > sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:649) > at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) > at > org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1004) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:970) > 2010-02-03 09:44:52,495 INFO org.apache.hadoop.hbase.master.RegionManager= : > -ROOT- region unset (but not set to be reassigned) > 2010-02-03 09:44:52,500 INFO org.apache.hadoop.hbase.master.RegionManager= : > ROOT inserted into regionsInTransition > 2010-02-03 09:44:52,601 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Failed to read: > org.apache.zookeeper.KeeperException$ConnectionLossException: > KeeperErrorCode =3D ConnectionLoss for /hbase/master > 2010-02-03 09:44:53,044 INFO org.apache.zookeeper.ClientCnxn: Attempting > connection to server localhost/127.0.0.1:2181 > 2010-02-03 09:44:53,045 WARN org.apache.zookeeper.ClientCnxn: Exception > closing session 0x0 to sun.nio.ch.SelectionKeyImpl@3a747fa2 > java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) > at > sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:574) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:933) > 2010-02-03 09:44:53,046 WARN org.apache.zookeeper.ClientCnxn: Ignoring > exception during shutdown input > java.nio.channels.ClosedChannelException > at > sun.nio.ch.SocketChannelImpl.shutdownInput(SocketChannelImpl.java:638) > at sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:360) > at > org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:999) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:970) > 2010-02-03 09:44:53,046 WARN org.apache.zookeeper.ClientCnxn: Ignoring > exception during shutdown output > java.nio.channels.ClosedChannelException > at > sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:649) > at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) > at > org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1004) > at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:970) > 2010-02-03 09:44:53,157 WARN > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Failed to create /hba= se > -- check quorum servers, currently=3Dlocalhost:2181 > org.apache.zookeeper.KeeperException$ConnectionLossException: > KeeperErrorCode =3D ConnectionLoss for /hbase > at > org.apache.zookeeper.KeeperException.create(KeeperException.java:90) > at > org.apache.zookeeper.KeeperException.create(KeeperException.java:42) > at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:608) > at > > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureExists(ZooKeeper= Wrapper.java:405) > at > > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.ensureParentExists(Zoo= KeeperWrapper.java:428) > at > > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper.writeMasterAddress(Zoo= KeeperWrapper.java:516) > at > > org.apache.hadoop.hbase.master.HMaster.writeAddressToZooKeeper(HMaster.ja= va:263) > at org.apache.hadoop.hbase.master.HMaster.(HMaster.java:245) > at > org.apache.hadoop.hbase.LocalHBaseCluster.(LocalHBaseCluster.java:9= 4) > at > org.apache.hadoop.hbase.LocalHBaseCluster.(LocalHBaseCluster.java:7= 8) > at org.apache.hadoop.hbase.master.HMaster.doMain(HMaster.java:1237= ) > at org.apache.hadoop.hbase.master.HMaster.main(HMaster.java:1282) > 2010-02-03 09:44:53,846 INFO org.apache.zookeeper.ClientCnxn: Attempting > connection to server localhost/fe80:0:0:0:0:0:0:1%1:2181 > 2010-02-03 09:44:53,847 INFO org.apache.zookeeper.ClientCnxn: Priming > connection to java.nio.channels.SocketChannel[connected > local=3D/fe80:0:0:0:0:0:0:1%1:60769 > remote=3Dlocalhost/fe80:0:0:0:0:0:0:1%1:2181] > 2010-02-03 09:44:53,849 INFO org.apache.zookeeper.ClientCnxn: Server > connection successful > 2010-02-03 09:44:53,898 DEBUG org.apache.hadoop.hbase.master.HMaster: Got > event None with path null > 2010-02-03 09:44:53,899 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Failed to read: > org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode =3D > NoNode for /hbase/master > 2010-02-03 09:44:53,909 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Wrote master address > 192.168.0.2:60000 to ZooKeeper > 2010-02-03 09:44:53,912 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: State node wrote in > ZooKeeper > 2010-02-03 09:44:53,920 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Read ZNode > /hbase/master > got 192.168.0.2:60000 > 2010-02-03 09:44:53,920 INFO org.apache.hadoop.hbase.master.HMaster: > HMaster > initialized on 192.168.0.2:60000 > 2010-02-03 09:44:53,942 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: My address is > 192.168.0.2:0 > 2010-02-03 09:44:53,945 INFO org.apache.hadoop.hbase.ipc.HBaseRpcMetrics: > Initializing RPC Metrics with hostName=3DHRegionServer, port=3D60770 > 2010-02-03 09:44:53,948 INFO > org.apache.hadoop.hbase.regionserver.MemStoreFlusher: > globalMemStoreLimit=3D397.9m, globalMemStoreLimitLowMark=3D348.2m, > maxHeap=3D994.8m > 2010-02-03 09:44:53,950 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Runs every 10000000ms > 2010-02-03 09:44:53,952 INFO org.apache.zookeeper.ZooKeeper: Initiating > client connection, connectString=3Dlocalhost:2181 sessionTimeout=3D60000 > watcher=3Dorg.apache.hadoop.hbase.regionserver.HRegionServer@48ff4cf > 2010-02-03 09:44:53,952 INFO org.apache.zookeeper.ClientCnxn: Attempting > connection to server localhost/0:0:0:0:0:0:0:1:2181 > 2010-02-03 09:44:53,960 INFO org.apache.zookeeper.ClientCnxn: Priming > connection to java.nio.channels.SocketChannel[connected > local=3D/0:0:0:0:0:0:0:1%0:60771 remote=3Dlocalhost/0:0:0:0:0:0:0:1:2181] > 2010-02-03 09:44:53,960 INFO org.apache.zookeeper.ClientCnxn: Server > connection successful > 2010-02-03 09:44:53,963 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Got ZooKeeper event, > state: SyncConnected, type: None, path: null > 2010-02-03 09:44:53,964 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Set watcher on master > address ZNode /hbase/master > 2010-02-03 09:44:54,016 DEBUG org.apache.hadoop.hbase.master.HMaster: > Checking cluster state... > 2010-02-03 09:44:54,017 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Read ZNode > /hbase/root-region-server got 192.168.0.2:60604 > 2010-02-03 09:44:54,017 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Read ZNode > /hbase/master > got 192.168.0.2:60000 > 2010-02-03 09:44:54,017 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Telling master at > 192.168.0.2:60000 that we are up > 2010-02-03 09:44:54,022 DEBUG org.apache.hadoop.hbase.master.HMaster: Thi= s > is a fresh start, proceeding with normal startup > 2010-02-03 09:44:54,022 DEBUG org.apache.hadoop.hbase.master.HMaster: No > log > files to split, proceeding... > 2010-02-03 09:44:54,025 INFO org.apache.hadoop.metrics.jvm.JvmMetrics: > Initializing JVM Metrics with processName=3DMaster, sessionId=3DHMaster > 2010-02-03 09:44:54,026 INFO > org.apache.hadoop.hbase.master.metrics.MasterMetrics: Initialized > 2010-02-03 09:44:54,188 INFO org.apache.hadoop.http.HttpServer: Port > returned by webServer.getConnectors()[0].getLocalPort() before open() is > -1. > Opening the listener on 60010 > 2010-02-03 09:44:54,188 INFO org.apache.hadoop.http.HttpServer: > listener.getLocalPort() returned 60010 > webServer.getConnectors()[0].getLocalPort() returned 60010 > 2010-02-03 09:44:54,188 INFO org.apache.hadoop.http.HttpServer: Jetty bou= nd > to port 60010 > 2010-02-03 09:44:54,755 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > Responder: starting > 2010-02-03 09:44:54,756 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > listener on 60000: starting > 2010-02-03 09:44:54,760 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 0 on 60000: starting > 2010-02-03 09:44:54,764 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 1 on 60000: starting > 2010-02-03 09:44:54,764 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 2 on 60000: starting > 2010-02-03 09:44:54,764 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 3 on 60000: starting > 2010-02-03 09:44:54,764 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 4 on 60000: starting > 2010-02-03 09:44:54,765 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 5 on 60000: starting > 2010-02-03 09:44:54,765 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 6 on 60000: starting > 2010-02-03 09:44:54,765 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 7 on 60000: starting > 2010-02-03 09:44:54,765 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 8 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 9 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 24 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 23 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 22 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 21 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 20 on 60000: starting > 2010-02-03 09:44:54,773 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 19 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 18 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 17 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 16 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 15 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 14 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 13 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 12 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 11 on 60000: starting > 2010-02-03 09:44:54,774 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 10 on 60000: starting > 2010-02-03 09:44:54,774 DEBUG org.apache.hadoop.hbase.master.HMaster: > Started service threads > 2010-02-03 09:44:54,775 DEBUG > org.apache.hadoop.hbase.regionserver.HRegionServer: sending initial serve= r > load: requests=3D0, regions=3D0, usedHeap=3D31, maxHeap=3D994 > 2010-02-03 09:44:54,780 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Created ZNode > /hbase/rs/1265186694776 with data 192.168.0.2:60770 > 2010-02-03 09:44:54,782 INFO org.apache.hadoop.hbase.master.ServerManager= : > Received start message from: 192.168.0.2,60770,1265186694776 > 2010-02-03 09:44:54,786 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Updated ZNode > /hbase/rs/1265186694776 with data 192.168.0.2:60770 > 2010-02-03 09:44:54,793 DEBUG > org.apache.hadoop.hbase.regionserver.HRegionServer: Config from master: > hbase.regionserver.address=3D192.168.0.2 > 2010-02-03 09:44:54,793 DEBUG > org.apache.hadoop.hbase.regionserver.HRegionServer: Config from master: > fs.default.name=3Dfile:/tmp/hbase-zaharije/hbase > 2010-02-03 09:44:54,793 DEBUG > org.apache.hadoop.hbase.regionserver.HRegionServer: Config from master: > hbase.rootdir=3Dfile:/tmp/hbase-zaharije/hbase > 2010-02-03 09:44:54,793 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Master passed us > address > to use. Was=3D192.168.0.2:60770, Now=3D192.168.0.2 > 2010-02-03 09:44:54,797 DEBUG > org.apache.hadoop.hbase.regionserver.HRegionServer: Log dir > file:/tmp/hbase-zaharije/hbase/.logs/192.168.0.2,60770,1265186694776 > 2010-02-03 09:44:54,798 INFO org.apache.hadoop.hbase.regionserver.HLog: > HLog > configuration: blocksize=3D33554432, rollsize=3D31876710, enabled=3Dtrue, > flushlogentries=3D100, optionallogflushinternal=3D10000ms > 2010-02-03 09:44:54,839 INFO org.apache.hadoop.hbase.regionserver.HLog: N= ew > hlog > /tmp/hbase-zaharije/hbase/.logs/192.168.0.2 > ,60770,1265186694776/hlog.dat.1265186694798 > 2010-02-03 09:44:54,841 INFO org.apache.hadoop.metrics.jvm.JvmMetrics: > Cannot initialize JVM Metrics with processName=3DRegionServer, > sessionId=3DRegionServer:0 - already initialized > 2010-02-03 09:44:54,843 INFO > org.apache.hadoop.hbase.regionserver.metrics.RegionServerMetrics: > Initialized > 2010-02-03 09:44:54,870 INFO org.apache.hadoop.http.HttpServer: Port > returned by webServer.getConnectors()[0].getLocalPort() before open() is > -1. > Opening the listener on 60030 > 2010-02-03 09:44:54,870 INFO org.apache.hadoop.http.HttpServer: > listener.getLocalPort() returned 60030 > webServer.getConnectors()[0].getLocalPort() returned 60030 > 2010-02-03 09:44:54,870 INFO org.apache.hadoop.http.HttpServer: Jetty bou= nd > to port 60030 > 2010-02-03 09:44:55,070 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > Responder: starting > 2010-02-03 09:44:55,071 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > listener on 60770: starting > 2010-02-03 09:44:55,071 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 0 on 60770: starting > 2010-02-03 09:44:55,071 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 1 on 60770: starting > 2010-02-03 09:44:55,072 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 2 on 60770: starting > 2010-02-03 09:44:55,072 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 3 on 60770: starting > 2010-02-03 09:44:55,072 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 4 on 60770: starting > 2010-02-03 09:44:55,072 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 5 on 60770: starting > 2010-02-03 09:44:55,073 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 6 on 60770: starting > 2010-02-03 09:44:55,073 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 7 on 60770: starting > 2010-02-03 09:44:55,073 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 8 on 60770: starting > 2010-02-03 09:44:55,073 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 9 on 60770: starting > 2010-02-03 09:44:55,074 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 10 on 60770: starting > 2010-02-03 09:44:55,074 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 11 on 60770: starting > 2010-02-03 09:44:55,074 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 12 on 60770: starting > 2010-02-03 09:44:55,074 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 13 on 60770: starting > 2010-02-03 09:44:55,074 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 14 on 60770: starting > 2010-02-03 09:44:55,075 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 15 on 60770: starting > 2010-02-03 09:44:55,075 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 16 on 60770: starting > 2010-02-03 09:44:55,075 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 17 on 60770: starting > 2010-02-03 09:44:55,076 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 18 on 60770: starting > 2010-02-03 09:44:55,077 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 19 on 60770: starting > 2010-02-03 09:44:55,077 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 20 on 60770: starting > 2010-02-03 09:44:55,077 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 21 on 60770: starting > 2010-02-03 09:44:55,078 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 22 on 60770: starting > 2010-02-03 09:44:55,078 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 23 on 60770: starting > 2010-02-03 09:44:55,078 INFO org.apache.hadoop.ipc.HBaseServer: IPC Serve= r > handler 24 on 60770: starting > 2010-02-03 09:44:55,078 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: HRegionServer started > at: 192.168.0.2:60770 > 2010-02-03 09:44:55,080 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Read ZNode > /hbase/root-region-server got 192.168.0.2:60604 > 2010-02-03 09:44:55,085 INFO > org.apache.hadoop.hbase.regionserver.StoreFile: > Allocating LruBlockCache with maximum size 199.0m > 2010-02-03 09:44:55,096 INFO org.apache.hadoop.hbase.master.RegionManager= : > Assigning region -ROOT-,,0 to 192.168.0.2,60770,1265186694776 > 2010-02-03 09:44:55,098 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_OPEN: > -ROOT-,,0 > 2010-02-03 09:44:55,102 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: > MSG_REGION_OPEN: > -ROOT-,,0 > 2010-02-03 09:44:55,107 DEBUG org.apache.hadoop.hbase.regionserver.HRegio= n: > Opening region -ROOT-,,0, encoded=3D70236052 > 2010-02-03 09:44:55,131 DEBUG org.apache.hadoop.hbase.regionserver.Store: > loaded /tmp/hbase-zaharije/hbase/-ROOT-/70236052/info/4121684240873727880= , > isReference=3Dfalse, sequence id=3D2, length=3D841, majorCompaction=3Dfal= se > 2010-02-03 09:44:55,141 DEBUG org.apache.hadoop.hbase.regionserver.Store: > loaded /tmp/hbase-zaharije/hbase/-ROOT-/70236052/info/8103669253369757722= , > isReference=3Dfalse, sequence id=3D10, length=3D460, majorCompaction=3Dfa= lse > 2010-02-03 09:44:55,142 INFO org.apache.hadoop.hbase.regionserver.HRegion= : > region -ROOT-,,0/70236052 available; sequence id is 11 > 2010-02-03 09:44:56,102 INFO org.apache.hadoop.hbase.master.ServerManager= : > Processing MSG_REPORT_OPEN: -ROOT-,,0 from 192.168.0.2,60770,126518669477= 6; > 1 of 1 > 2010-02-03 09:44:56,107 WARN > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Failed to create out = of > safe mode in ZooKeeper: > org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode= =3D > NodeExists for /hbase/safe-mode > 2010-02-03 09:44:56,107 INFO > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: Node exists; just mov= e > on > 2010-02-03 09:44:56,107 INFO org.apache.hadoop.hbase.master.RegionManager= : > exiting safe mode > 2010-02-03 09:44:56,111 DEBUG > org.apache.hadoop.hbase.zookeeper.ZooKeeperWrapper: SetData of ZNode > /hbase/root-region-server with 192.168.0.2:60770 > 2010-02-03 09:44:56,112 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:44:56,166 DEBUG org.apache.hadoop.hbase.master.BaseScanner: > Current assignment of .META.,,1 is not valid; > serverAddress=3D192.168.0.2:60604, startCode=3D1265185588724 unknown. > 2010-02-03 09:44:56,167 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:44:57,116 INFO org.apache.hadoop.hbase.master.RegionManager= : > Assigning region .META.,,1 to 192.168.0.2,60770,1265186694776 > 2010-02-03 09:44:57,117 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_OPEN: > .META.,,1 > 2010-02-03 09:44:57,117 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: > MSG_REGION_OPEN: > .META.,,1 > 2010-02-03 09:44:57,117 DEBUG org.apache.hadoop.hbase.regionserver.HRegio= n: > Opening region .META.,,1, encoded=3D1028785192 > 2010-02-03 09:44:57,122 DEBUG org.apache.hadoop.hbase.regionserver.Store: > loaded > /tmp/hbase-zaharije/hbase/.META./1028785192/info/7248722017355517707, > isReference=3Dfalse, sequence id=3D9, length=3D978, majorCompaction=3Dfal= se > 2010-02-03 09:44:57,122 INFO org.apache.hadoop.hbase.regionserver.HRegion= : > region .META.,,1/1028785192 available; sequence id is 10 > 2010-02-03 09:44:58,120 INFO org.apache.hadoop.hbase.master.ServerManager= : > Processing MSG_REPORT_PROCESS_OPEN: .META.,,1 from > 192.168.0.2,60770,1265186694776; 1 of 2 > 2010-02-03 09:44:58,121 INFO org.apache.hadoop.hbase.master.ServerManager= : > Processing MSG_REPORT_OPEN: .META.,,1 from 192.168.0.2,60770,126518669477= 6; > 2 of 2 > 2010-02-03 09:44:58,124 DEBUG org.apache.hadoop.hbase.master.HMaster: > Processing todo: PendingOpenOperation from 192.168.0.2,60770,126518669477= 6 > 2010-02-03 09:44:58,124 INFO > org.apache.hadoop.hbase.master.RegionServerOperation: .META.,,1 open on > 192.168.0.2:60770 > 2010-02-03 09:44:58,127 INFO > org.apache.hadoop.hbase.master.RegionServerOperation: Updated row .META.,= ,1 > in region -ROOT-,,0 with startcode=3D1265186694776, server=3D192.168.0.2:= 60770 > 2010-02-03 09:44:58,128 DEBUG > org.apache.hadoop.hbase.master.RegionServerOperation: Adding to > onlineMetaRegions: {server: 192.168.0.2:60770, regionname: .META.,,1, > startKey: <>} > 2010-02-03 09:45:52,488 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 2.0 > 2010-02-03 09:45:54,027 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:45:54,029 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:45:54,049 DEBUG org.apache.hadoop.hbase.master.BaseScanner: > Current assignment of test,,1265185608929 is not valid; > serverAddress=3D192.168.0.2:60604, startCode=3D1265185588724 unknown. > 2010-02-03 09:45:54,050 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:45:54,050 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:45:54,051 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:45:54,320 INFO org.apache.hadoop.hbase.master.RegionManager= : > Assigning region test,,1265185608929 to 192.168.0.2,60770,1265186694776 > 2010-02-03 09:45:54,321 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: MSG_REGION_OPEN: > test,,1265185608929 > 2010-02-03 09:45:54,321 INFO > org.apache.hadoop.hbase.regionserver.HRegionServer: Worker: > MSG_REGION_OPEN: > test,,1265185608929 > 2010-02-03 09:45:54,322 DEBUG org.apache.hadoop.hbase.regionserver.HRegio= n: > Opening region test,,1265185608929, encoded=3D956999107 > 2010-02-03 09:45:54,325 INFO org.apache.hadoop.hbase.regionserver.HRegion= : > region test,,1265185608929/956999107 available; sequence id is 0 > 2010-02-03 09:45:55,093 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D8, Hit=3D6, Miss=3D2, Evictions= =3D0, > Evicted=3D0, Ratios: Hit Ratio=3D75.0%, Miss Ratio=3D25.0%, Evicted/Run= =3DNaN > 2010-02-03 09:45:55,325 INFO org.apache.hadoop.hbase.master.ServerManager= : > Processing MSG_REPORT_PROCESS_OPEN: test,,1265185608929 from > 192.168.0.2,60770,1265186694776; 1 of 2 > 2010-02-03 09:45:55,325 INFO org.apache.hadoop.hbase.master.ServerManager= : > Processing MSG_REPORT_OPEN: test,,1265185608929 from > 192.168.0.2,60770,1265186694776; 2 of 2 > 2010-02-03 09:45:55,326 DEBUG org.apache.hadoop.hbase.master.HMaster: > Processing todo: PendingOpenOperation from 192.168.0.2,60770,126518669477= 6 > 2010-02-03 09:45:55,326 INFO > org.apache.hadoop.hbase.master.RegionServerOperation: test,,1265185608929 > open on 192.168.0.2:60770 > 2010-02-03 09:45:55,327 INFO > org.apache.hadoop.hbase.master.RegionServerOperation: Updated row > test,,1265185608929 in region .META.,,1 with startcode=3D1265186694776, > server=3D192.168.0.2:60770 > 2010-02-03 09:46:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:46:54,027 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:46:54,030 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:46:54,040 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:46:54,040 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:46:54,040 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:46:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D16, Hit=3D14, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D87.5%, Miss Ratio=3D12.5%, Evicted/Run= =3DNaN > 2010-02-03 09:47:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:47:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:47:54,030 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:47:54,043 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:47:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:47:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:47:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D20, Hit=3D18, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D89.99999761581421%, Miss > Ratio=3D10.000000149011612%, Evicted/Run=3DNaN > 2010-02-03 09:48:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:48:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:48:54,030 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:48:54,057 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:48:54,057 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:48:54,057 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:48:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D24, Hit=3D22, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D91.66666865348816%, Miss > Ratio=3D8.33333358168602%, Evicted/Run=3DNaN > 2010-02-03 09:49:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:49:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:49:54,032 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:49:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:49:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:49:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:49:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D28, Hit=3D26, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D92.85714030265808%, Miss > Ratio=3D7.14285746216774%, Evicted/Run=3DNaN > 2010-02-03 09:50:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:50:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:50:54,031 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:50:54,037 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:50:54,037 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:50:54,037 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:50:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D32, Hit=3D30, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D93.75%, Miss Ratio=3D6.25%, Evicted/Run= =3DNaN > 2010-02-03 09:51:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:51:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:51:54,031 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:51:54,040 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:51:54,041 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:51:54,041 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:51:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D36, Hit=3D34, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D94.44444179534912%, Miss > Ratio=3D5.55555559694767%, Evicted/Run=3DNaN > 2010-02-03 09:52:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:52:54,028 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:52:54,032 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:52:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:52:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:52:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:52:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D40, Hit=3D38, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D94.9999988079071%, Miss > Ratio=3D5.000000074505806%, Evicted/Run=3DNaN > 2010-02-03 09:53:52,487 INFO org.apache.hadoop.hbase.master.ServerManager= : > 1 > region servers, 0 dead, average load 3.0 > 2010-02-03 09:53:54,029 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: -ROOT-,,0, startKey: <>} > 2010-02-03 09:53:54,033 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scanning meta region {server: 192.168.0.2:60770= , > regionname: .META.,,1, startKey: <>} > 2010-02-03 09:53:54,043 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.rootScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: -ROOT-,,0, startKey: <>} complete > 2010-02-03 09:53:54,043 INFO org.apache.hadoop.hbase.master.BaseScanner: > RegionManager.metaScanner scan of 1 row(s) of meta region {server: > 192.168.0.2:60770, regionname: .META.,,1, startKey: <>} complete > 2010-02-03 09:53:54,044 INFO org.apache.hadoop.hbase.master.BaseScanner: > All > 1 .META. region(s) scanned > 2010-02-03 09:53:55,092 DEBUG > org.apache.hadoop.hbase.io.hfile.LruBlockCache: Cache Stats: Sizes: > Total=3D1.6344376MB (1713832), Free=3D197.32806MB (206913480), Max=3D198.= 96251MB > (208627312), Counts: Blocks=3D2, Access=3D44, Hit=3D42, Miss=3D2, Evictio= ns=3D0, > Evicted=3D0, Ratios: Hit Ratio=3D95.45454382896423%, Miss > Ratio=3D4.545454680919647%, Evicted/Run=3DNaN > > > -- > View this message in context: > http://old.nabble.com/Exception-trace-in-client-log-...-tp27433209p274332= 09.html > Sent from the HBase User mailing list archive at Nabble.com. > > --001485f07d3e518698047eb5d6a4--