You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@phoenix.apache.org by Krishna <re...@gmail.com> on 2014/09/09 23:37:14 UTC
sqlline hangs
Hi,
I've installed Phoenix 3.1.0 on Amazon EMR but the command "./sqlline.py
localhost" just hangs with following output. Any thoughts on what I'm
missing?
Here is related info:
*Phoenix 3.1.0*
*HBase 0.94.18*
*Amazon Hadoop 2.4.0*
*Phoenix core:*
/home/hadoop/.versions/hbase-0.94.18/lib/phoenix-core-3.1.0.jar
*Phoenix client:*
/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/phoenix-3.1.0-client-hadoop2.jar
*hbase-site.xml:*
/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/hbase-site.xml
*$> ./sqlline.py localhost*
Setting property: [isolation, TRANSACTION_READ_COMMITTED]
issuing: !connect jdbc:phoenix:localhost none none
org.apache.phoenix.jdbc.PhoenixDriver
Connecting to jdbc:phoenix:localhost
14/09/09 21:24:17 WARN conf.Configuration: dfs.df.interval is deprecated.
Instead, use fs.df.interval
14/09/09 21:24:17 WARN conf.Configuration: hadoop.native.lib is deprecated.
Instead, use io.native.lib.available
14/09/09 21:24:17 WARN conf.Configuration: fs.default.name is deprecated.
Instead, use fs.defaultFS
14/09/09 21:24:17 WARN conf.Configuration: topology.script.number.args is
deprecated. Instead, use net.topology.script.number.args
14/09/09 21:24:17 WARN conf.Configuration: dfs.umaskmode is deprecated.
Instead, use fs.permissions.umask-mode
14/09/09 21:24:17 WARN conf.Configuration:
topology.node.switch.mapping.impl is deprecated. Instead, use
net.topology.node.switch.mapping.impl
14/09/09 21:24:18 WARN conf.Configuration: fs.default.name is deprecated.
Instead, use fs.defaultFS
14/09/09 21:24:18 DEBUG zookeeper.ZKUtil: hconnection opening connection to
ZooKeeper with ensemble (localhost:2181)
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:host.name
=ip-172-31-43-176.us-west-2.compute.internal
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.version=1.7.0_65
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.vendor=Oracle Corporation
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.home=/usr/java/jdk1.7.0_65/jre
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.class.path=.:/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/../phoenix-3.1.0-client-hadoop2.jar
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.library.path=/home/hadoop/lib/native:/usr/lib64:/usr/local/cuda/lib64:/usr/local/cuda/lib::/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.io.tmpdir=/tmp
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:java.compiler=<NA>
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:os.name=Linux
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:os.arch=amd64
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:os.version=3.4.76-65.111.amzn1.x86_64
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:user.name
=hadoop
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:user.home=/home/hadoop
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
environment:user.dir=/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin
14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Initiating client connection,
connectString=localhost:2181 sessionTimeout=180000 watcher=hconnection
14/09/09 21:24:18 DEBUG zookeeper.ClientCnxn:
zookeeper.disableAutoWatchReset is false
14/09/09 21:24:18 INFO zookeeper.RecoverableZooKeeper: The identifier of
this process is 1412@ip-172-31-43-176.us-west-2.compute.internal
14/09/09 21:24:18 INFO zookeeper.ClientCnxn: Opening socket connection to
server localhost/127.0.0.1:2181. Will not attempt to authenticate using
SASL (unknown error)
14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Socket connection established
to localhost/127.0.0.1:2181, initiating session
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Session establishment request
sent on localhost/127.0.0.1:2181
14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Session establishment complete
on server localhost/127.0.0.1:2181, sessionid = 0x1485c2742cf0026,
negotiated timeout = 180000
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 1,3 replyHeader:: 1,203,0 request::
'/hbase/hbaseid,F response::
s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 2,4 replyHeader:: 2,203,0 request::
'/hbase/hbaseid,F response::
#ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c63326534333830622d303230352d343838662d383832352d616561336564366237643231,s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
Retrieved 36 byte(s) of data from znode /hbase/hbaseid;
data=c2e4380b-0205-488f-8825-aea3e...
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 3,3 replyHeader:: 3,203,0 request::
'/hbase/master,T response::
s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026 Set
watcher on existing znode /hbase/master
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 4,4 replyHeader:: 4,203,0 request::
'/hbase/master,T response::
#ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c0069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303030302c31343130323935343239373035,s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
Retrieved 65 byte(s) of data from znode /hbase/master and set watcher;
\x00\x00ip-172-31-43-176.us-w...
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 5,3 replyHeader:: 5,203,0 request::
'/hbase/root-region-server,T response::
s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026 Set
watcher on existing znode /hbase/root-region-server
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 6,4 replyHeader:: 6,203,0 request::
'/hbase/root-region-server,T response::
#ffffffff00030323431324069702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c69702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303032302c31343130323935333539323439,s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
Retrieved 63 byte(s) of data from znode /hbase/root-region-server and set
watcher; ip-172-31-43-131.us-west-2.co...
14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
finished:false header:: 7,3 replyHeader:: 7,203,0 request:: '/hbase,F
response:: s{18,18,1410295430285,1410295430285,0,12,0,0,0,12,65}
Re: sqlline hangs
Posted by Vikas Agarwal <vi...@infoobjects.com>.
We faced similar issue. You can try fix mentioned in
http://mail-archives.apache.org/mod_mbox/phoenix-user/201409.mbox/browser.
On Wed, Sep 10, 2014 at 10:02 AM, Krishna <re...@gmail.com> wrote:
> I am having same issue with "psql" too. It appears Phoenix is unable to
> launch. What logs can I check to debug the issue? Are there any Phoenix
> specific logs created?
>
> Thanks.
>
>
> On Tuesday, September 9, 2014, Krishna <re...@gmail.com> wrote:
>
>> Hi,
>>
>> I've installed Phoenix 3.1.0 on Amazon EMR but the command "./sqlline.py
>> localhost" just hangs with following output. Any thoughts on what I'm
>> missing?
>>
>> Here is related info:
>> *Phoenix 3.1.0*
>> *HBase 0.94.18*
>> *Amazon Hadoop 2.4.0*
>>
>> *Phoenix core:*
>> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix-core-3.1.0.jar
>> *Phoenix client:*
>> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/phoenix-3.1.0-client-hadoop2.jar
>> *hbase-site.xml:*
>> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/hbase-site.xml
>>
>>
>> *$> ./sqlline.py localhost*
>>
>> Setting property: [isolation, TRANSACTION_READ_COMMITTED]
>> issuing: !connect jdbc:phoenix:localhost none none
>> org.apache.phoenix.jdbc.PhoenixDriver
>> Connecting to jdbc:phoenix:localhost
>> 14/09/09 21:24:17 WARN conf.Configuration: dfs.df.interval is deprecated.
>> Instead, use fs.df.interval
>> 14/09/09 21:24:17 WARN conf.Configuration: hadoop.native.lib is
>> deprecated. Instead, use io.native.lib.available
>> 14/09/09 21:24:17 WARN conf.Configuration: fs.default.name is
>> deprecated. Instead, use fs.defaultFS
>> 14/09/09 21:24:17 WARN conf.Configuration: topology.script.number.args is
>> deprecated. Instead, use net.topology.script.number.args
>> 14/09/09 21:24:17 WARN conf.Configuration: dfs.umaskmode is deprecated.
>> Instead, use fs.permissions.umask-mode
>> 14/09/09 21:24:17 WARN conf.Configuration:
>> topology.node.switch.mapping.impl is deprecated. Instead, use
>> net.topology.node.switch.mapping.impl
>> 14/09/09 21:24:18 WARN conf.Configuration: fs.default.name is
>> deprecated. Instead, use fs.defaultFS
>> 14/09/09 21:24:18 DEBUG zookeeper.ZKUtil: hconnection opening connection
>> to ZooKeeper with ensemble (localhost:2181)
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:host.name
>> =ip-172-31-43-176.us-west-2.compute.internal
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.version=1.7.0_65
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.vendor=Oracle Corporation
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.home=/usr/java/jdk1.7.0_65/jre
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.class.path=.:/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/../phoenix-3.1.0-client-hadoop2.jar
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.library.path=/home/hadoop/lib/native:/usr/lib64:/usr/local/cuda/lib64:/usr/local/cuda/lib::/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.io.tmpdir=/tmp
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:java.compiler=<NA>
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:os.name
>> =Linux
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:os.arch=amd64
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:os.version=3.4.76-65.111.amzn1.x86_64
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:user.name
>> =hadoop
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:user.home=/home/hadoop
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
>> environment:user.dir=/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin
>> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Initiating client connection,
>> connectString=localhost:2181 sessionTimeout=180000 watcher=hconnection
>> 14/09/09 21:24:18 DEBUG zookeeper.ClientCnxn:
>> zookeeper.disableAutoWatchReset is false
>> 14/09/09 21:24:18 INFO zookeeper.RecoverableZooKeeper: The identifier of
>> this process is 1412@ip-172-31-43-176.us-west-2.compute.internal
>> 14/09/09 21:24:18 INFO zookeeper.ClientCnxn: Opening socket connection to
>> server localhost/127.0.0.1:2181. Will not attempt to authenticate using
>> SASL (unknown error)
>> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Socket connection
>> established to localhost/127.0.0.1:2181, initiating session
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Session establishment
>> request sent on localhost/127.0.0.1:2181
>> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Session establishment
>> complete on server localhost/127.0.0.1:2181, sessionid =
>> 0x1485c2742cf0026, negotiated timeout = 180000
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 1,3 replyHeader:: 1,203,0 request::
>> '/hbase/hbaseid,F response::
>> s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 2,4 replyHeader:: 2,203,0 request::
>> '/hbase/hbaseid,F response::
>> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c63326534333830622d303230352d343838662d383832352d616561336564366237643231,s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
>> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
>> Retrieved 36 byte(s) of data from znode /hbase/hbaseid;
>> data=c2e4380b-0205-488f-8825-aea3e...
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 3,3 replyHeader:: 3,203,0 request::
>> '/hbase/master,T response::
>> s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
>> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
>> Set watcher on existing znode /hbase/master
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 4,4 replyHeader:: 4,203,0 request::
>> '/hbase/master,T response::
>> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c0069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303030302c31343130323935343239373035,s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
>> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
>> Retrieved 65 byte(s) of data from znode /hbase/master and set watcher;
>> \x00\x00ip-172-31-43-176.us-w...
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 5,3 replyHeader:: 5,203,0 request::
>> '/hbase/root-region-server,T response::
>> s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
>> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
>> Set watcher on existing znode /hbase/root-region-server
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 6,4 replyHeader:: 6,203,0 request::
>> '/hbase/root-region-server,T response::
>> #ffffffff00030323431324069702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c69702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303032302c31343130323935333539323439,s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
>> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
>> Retrieved 63 byte(s) of data from znode /hbase/root-region-server and set
>> watcher; ip-172-31-43-131.us-west-2.co...
>> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
>> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
>> finished:false header:: 7,3 replyHeader:: 7,203,0 request:: '/hbase,F
>> response:: s{18,18,1410295430285,1410295430285,0,12,0,0,0,12,65}
>>
>>
--
Regards,
Vikas Agarwal
91 – 9928301411
InfoObjects, Inc.
Execution Matters
http://www.infoobjects.com
2041 Mission College Boulevard, #280
Santa Clara, CA 95054
+1 (408) 988-2000 Work
+1 (408) 716-2726 Fax
Re: sqlline hangs
Posted by Krishna <re...@gmail.com>.
I am having same issue with "psql" too. It appears Phoenix is unable to
launch. What logs can I check to debug the issue? Are there any Phoenix
specific logs created?
Thanks.
On Tuesday, September 9, 2014, Krishna <re...@gmail.com> wrote:
> Hi,
>
> I've installed Phoenix 3.1.0 on Amazon EMR but the command "./sqlline.py
> localhost" just hangs with following output. Any thoughts on what I'm
> missing?
>
> Here is related info:
> *Phoenix 3.1.0*
> *HBase 0.94.18*
> *Amazon Hadoop 2.4.0*
>
> *Phoenix core:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix-core-3.1.0.jar
> *Phoenix client:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/phoenix-3.1.0-client-hadoop2.jar
> *hbase-site.xml:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/hbase-site.xml
>
>
> *$> ./sqlline.py localhost*
>
> Setting property: [isolation, TRANSACTION_READ_COMMITTED]
> issuing: !connect jdbc:phoenix:localhost none none
> org.apache.phoenix.jdbc.PhoenixDriver
> Connecting to jdbc:phoenix:localhost
> 14/09/09 21:24:17 WARN conf.Configuration: dfs.df.interval is deprecated.
> Instead, use fs.df.interval
> 14/09/09 21:24:17 WARN conf.Configuration: hadoop.native.lib is
> deprecated. Instead, use io.native.lib.available
> 14/09/09 21:24:17 WARN conf.Configuration: fs.default.name is deprecated.
> Instead, use fs.defaultFS
> 14/09/09 21:24:17 WARN conf.Configuration: topology.script.number.args is
> deprecated. Instead, use net.topology.script.number.args
> 14/09/09 21:24:17 WARN conf.Configuration: dfs.umaskmode is deprecated.
> Instead, use fs.permissions.umask-mode
> 14/09/09 21:24:17 WARN conf.Configuration:
> topology.node.switch.mapping.impl is deprecated. Instead, use
> net.topology.node.switch.mapping.impl
> 14/09/09 21:24:18 WARN conf.Configuration: fs.default.name is deprecated.
> Instead, use fs.defaultFS
> 14/09/09 21:24:18 DEBUG zookeeper.ZKUtil: hconnection opening connection
> to ZooKeeper with ensemble (localhost:2181)
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:host.name
> =ip-172-31-43-176.us-west-2.compute.internal
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.version=1.7.0_65
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.vendor=Oracle Corporation
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.home=/usr/java/jdk1.7.0_65/jre
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.class.path=.:/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/../phoenix-3.1.0-client-hadoop2.jar
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.library.path=/home/hadoop/lib/native:/usr/lib64:/usr/local/cuda/lib64:/usr/local/cuda/lib::/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.io.tmpdir=/tmp
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.compiler=<NA>
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:os.name
> =Linux
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:os.arch=amd64
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:os.version=3.4.76-65.111.amzn1.x86_64
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:user.name
> =hadoop
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:user.home=/home/hadoop
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:user.dir=/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Initiating client connection,
> connectString=localhost:2181 sessionTimeout=180000 watcher=hconnection
> 14/09/09 21:24:18 DEBUG zookeeper.ClientCnxn:
> zookeeper.disableAutoWatchReset is false
> 14/09/09 21:24:18 INFO zookeeper.RecoverableZooKeeper: The identifier of
> this process is 1412@ip-172-31-43-176.us-west-2.compute.internal
> 14/09/09 21:24:18 INFO zookeeper.ClientCnxn: Opening socket connection to
> server localhost/127.0.0.1:2181. Will not attempt to authenticate using
> SASL (unknown error)
> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Socket connection established
> to localhost/127.0.0.1:2181, initiating session
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Session establishment
> request sent on localhost/127.0.0.1:2181
> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Session establishment
> complete on server localhost/127.0.0.1:2181, sessionid =
> 0x1485c2742cf0026, negotiated timeout = 180000
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 1,3 replyHeader:: 1,203,0 request::
> '/hbase/hbaseid,F response::
> s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 2,4 replyHeader:: 2,203,0 request::
> '/hbase/hbaseid,F response::
> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c63326534333830622d303230352d343838662d383832352d616561336564366237643231,s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 36 byte(s) of data from znode /hbase/hbaseid;
> data=c2e4380b-0205-488f-8825-aea3e...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 3,3 replyHeader:: 3,203,0 request::
> '/hbase/master,T response::
> s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Set watcher on existing znode /hbase/master
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 4,4 replyHeader:: 4,203,0 request::
> '/hbase/master,T response::
> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c0069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303030302c31343130323935343239373035,s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 65 byte(s) of data from znode /hbase/master and set watcher;
> \x00\x00ip-172-31-43-176.us-w...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 5,3 replyHeader:: 5,203,0 request::
> '/hbase/root-region-server,T response::
> s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Set watcher on existing znode /hbase/root-region-server
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 6,4 replyHeader:: 6,203,0 request::
> '/hbase/root-region-server,T response::
> #ffffffff00030323431324069702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c69702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303032302c31343130323935333539323439,s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 63 byte(s) of data from znode /hbase/root-region-server and set
> watcher; ip-172-31-43-131.us-west-2.co...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 7,3 replyHeader:: 7,203,0 request:: '/hbase,F
> response:: s{18,18,1410295430285,1410295430285,0,12,0,0,0,12,65}
>
>
Re: sqlline hangs
Posted by Krishna <re...@gmail.com>.
This issue is resolved by running sqlline using hadoop1 client, earlier I
was using hadoop2 client. Its not clear why this is so - any clarification
from experts will be great.
On Tue, Sep 9, 2014 at 2:37 PM, Krishna <re...@gmail.com> wrote:
> Hi,
>
> I've installed Phoenix 3.1.0 on Amazon EMR but the command "./sqlline.py
> localhost" just hangs with following output. Any thoughts on what I'm
> missing?
>
> Here is related info:
> *Phoenix 3.1.0*
> *HBase 0.94.18*
> *Amazon Hadoop 2.4.0*
>
> *Phoenix core:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix-core-3.1.0.jar
> *Phoenix client:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/phoenix-3.1.0-client-hadoop2.jar
> *hbase-site.xml:*
> /home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/hbase-site.xml
>
>
> *$> ./sqlline.py localhost*
>
> Setting property: [isolation, TRANSACTION_READ_COMMITTED]
> issuing: !connect jdbc:phoenix:localhost none none
> org.apache.phoenix.jdbc.PhoenixDriver
> Connecting to jdbc:phoenix:localhost
> 14/09/09 21:24:17 WARN conf.Configuration: dfs.df.interval is deprecated.
> Instead, use fs.df.interval
> 14/09/09 21:24:17 WARN conf.Configuration: hadoop.native.lib is
> deprecated. Instead, use io.native.lib.available
> 14/09/09 21:24:17 WARN conf.Configuration: fs.default.name is deprecated.
> Instead, use fs.defaultFS
> 14/09/09 21:24:17 WARN conf.Configuration: topology.script.number.args is
> deprecated. Instead, use net.topology.script.number.args
> 14/09/09 21:24:17 WARN conf.Configuration: dfs.umaskmode is deprecated.
> Instead, use fs.permissions.umask-mode
> 14/09/09 21:24:17 WARN conf.Configuration:
> topology.node.switch.mapping.impl is deprecated. Instead, use
> net.topology.node.switch.mapping.impl
> 14/09/09 21:24:18 WARN conf.Configuration: fs.default.name is deprecated.
> Instead, use fs.defaultFS
> 14/09/09 21:24:18 DEBUG zookeeper.ZKUtil: hconnection opening connection
> to ZooKeeper with ensemble (localhost:2181)
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:host.name
> =ip-172-31-43-176.us-west-2.compute.internal
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.version=1.7.0_65
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.vendor=Oracle Corporation
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.home=/usr/java/jdk1.7.0_65/jre
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.class.path=.:/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin/../phoenix-3.1.0-client-hadoop2.jar
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.library.path=/home/hadoop/lib/native:/usr/lib64:/usr/local/cuda/lib64:/usr/local/cuda/lib::/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.io.tmpdir=/tmp
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:java.compiler=<NA>
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:os.name
> =Linux
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:os.arch=amd64
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:os.version=3.4.76-65.111.amzn1.x86_64
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client environment:user.name
> =hadoop
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:user.home=/home/hadoop
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Client
> environment:user.dir=/home/hadoop/.versions/hbase-0.94.18/lib/phoenix/bin
> 14/09/09 21:24:18 INFO zookeeper.ZooKeeper: Initiating client connection,
> connectString=localhost:2181 sessionTimeout=180000 watcher=hconnection
> 14/09/09 21:24:18 DEBUG zookeeper.ClientCnxn:
> zookeeper.disableAutoWatchReset is false
> 14/09/09 21:24:18 INFO zookeeper.RecoverableZooKeeper: The identifier of
> this process is 1412@ip-172-31-43-176.us-west-2.compute.internal
> 14/09/09 21:24:18 INFO zookeeper.ClientCnxn: Opening socket connection to
> server localhost/127.0.0.1:2181. Will not attempt to authenticate using
> SASL (unknown error)
> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Socket connection established
> to localhost/127.0.0.1:2181, initiating session
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Session establishment
> request sent on localhost/127.0.0.1:2181
> 14/09/09 21:24:19 INFO zookeeper.ClientCnxn: Session establishment
> complete on server localhost/127.0.0.1:2181, sessionid =
> 0x1485c2742cf0026, negotiated timeout = 180000
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 1,3 replyHeader:: 1,203,0 request::
> '/hbase/hbaseid,F response::
> s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 2,4 replyHeader:: 2,203,0 request::
> '/hbase/hbaseid,F response::
> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c63326534333830622d303230352d343838662d383832352d616561336564366237643231,s{43,43,1410295441753,1410295441753,0,0,0,0,89,0,43}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 36 byte(s) of data from znode /hbase/hbaseid;
> data=c2e4380b-0205-488f-8825-aea3e...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 3,3 replyHeader:: 3,203,0 request::
> '/hbase/master,T response::
> s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Set watcher on existing znode /hbase/master
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 4,4 replyHeader:: 4,203,0 request::
> '/hbase/master,T response::
> #ffffffff00030333838344069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c0069702d3137322d33312d34332d3137362e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303030302c31343130323935343239373035,s{38,38,1410295432736,1410295432736,0,0,0,92425116055437323,118,0,38}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 65 byte(s) of data from znode /hbase/master and set watcher;
> \x00\x00ip-172-31-43-176.us-w...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 5,3 replyHeader:: 5,203,0 request::
> '/hbase/root-region-server,T response::
> s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Set watcher on existing znode /hbase/root-region-server
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 6,4 replyHeader:: 6,203,0 request::
> '/hbase/root-region-server,T response::
> #ffffffff00030323431324069702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c69702d3137322d33312d34332d3133312e75732d776573742d322e636f6d707574652e696e7465726e616c2c36303032302c31343130323935333539323439,s{65,65,1410295448792,1410295448792,0,0,0,0,116,0,65}
> 14/09/09 21:24:19 DEBUG zookeeper.ZKUtil: hconnection-0x1485c2742cf0026
> Retrieved 63 byte(s) of data from znode /hbase/root-region-server and set
> watcher; ip-172-31-43-131.us-west-2.co...
> 14/09/09 21:24:19 DEBUG zookeeper.ClientCnxn: Reading reply
> sessionid:0x1485c2742cf0026, packet:: clientPath:null serverPath:null
> finished:false header:: 7,3 replyHeader:: 7,203,0 request:: '/hbase,F
> response:: s{18,18,1410295430285,1410295430285,0,12,0,0,0,12,65}
>
>