You are viewing a plain text version of this content. The canonical link for it is here.
Posted to solr-user@lucene.apache.org by Jack Park <ja...@topicquests.org> on 2013/10/25 03:24:09 UTC

First test cloud error question...

Background: all testing done on a Win7 platform. This is my first
migration from a single Solr server to a simple cloud. Everything is
configured exactly as specified in the wiki.

I created a simple 3-node client, all localhost with different server
URLs, and a lone external zookeeper.  The online admin shows they are
all up.

I then start an agent which sends in documents to "bootstrap" the
index. That's when issues start.  A clip from the log shows this:
First, I create a SolrDocument with this JSON data:

DEBUG 2013-10-24 18:00:09,143 [main] - SolrCloudClient.mapToDocument-
{"locator":"EssayNodeType","smallIcon":"\/images\/cogwheel.png","subOf":["NodeType"],"details":["The
TopicQuests NodeTypes typology essay
type."],"isPrivate":"false","creatorId":"SystemUser","label":["Essay
Type"],"largeIcon":"\/images\/cogwheel_sm.png","lastEditDate":Thu Oct
24 18:00:09 PDT 2013,"createdDate":Thu Oct 24 18:00:09 PDT 2013}

Then, send it in from SolrJ which has a CloudSolrServer initialized
with localhost:2181 and an instance of LBHttpSolrServer initialized
with http://localhost:8983/solr/

That trace follows

INFO  2013-10-24 18:00:09,145 [main] - Initiating client connection,
connectString=localhost:2181 sessionTimeout=10000
watcher=org.apache.solr.common.cloud.ConnectionManager@8888e6c
INFO  2013-10-24 18:00:09,148 [main] - Waiting for client to connect
to ZooKeeper
INFO  2013-10-24 18:00:09,150 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
- Opening socket connection to server
0:0:0:0:0:0:0:1/0:0:0:0:0:0:0:1:2181. Will not attempt to authenticate
using SASL (Unable to locate a login configuration)
ERROR 2013-10-24 18:00:09,151 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
- Unable to open socket to 0:0:0:0:0:0:0:1/0:0:0:0:0:0:0:1:2181
WARN  2013-10-24 18:00:09,151 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
- Session 0x0 for server null, unexpected error, closing socket
connection and attempting reconnect
java.net.SocketException: Address family not supported by protocol
family: connect
at sun.nio.ch.Net.connect(Native Method)
at sun.nio.ch.SocketChannelImpl.connect(Unknown Source)
at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:266)

I can watch the Zookeeper console running; it's mostly complaining
about too many connections from /127.0.0.1 ; I am seeing the errors in
the agent's log file.

Following that trace in the log is this:

INFO  2013-10-24 18:00:09,447 [main-SendThread(127.0.0.1:2181)] -
Opening socket connection to server 127.0.0.1/127.0.0.1:2181. Will not
attempt to authenticate using SASL (Unable to locate a login
configuration)
INFO  2013-10-24 18:00:09,448 [main-SendThread(127.0.0.1:2181)] -
Socket connection established to 127.0.0.1/127.0.0.1:2181, initiating
session
DEBUG 2013-10-24 18:00:09,449 [main-SendThread(127.0.0.1:2181)] -
Session establishment request sent on 127.0.0.1/127.0.0.1:2181
DEBUG 2013-10-24 18:00:09,449 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
INFO  2013-10-24 18:00:09,501 [main-SendThread(127.0.0.1:2181)] -
Session establishment complete on server 127.0.0.1/127.0.0.1:2181,
sessionid = 0x141ece7e6160017, negotiated timeout = 10000
INFO  2013-10-24 18:00:09,501 [main-EventThread] - Watcher
org.apache.solr.common.cloud.ConnectionManager@42bad8a8
name:ZooKeeperConnection Watcher:localhost:2181 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
INFO  2013-10-24 18:00:09,502 [main] - Client is connected to ZooKeeper
DEBUG 2013-10-24 18:00:09,502 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,502 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,503 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,503 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,504 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,504 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,505 [main-SendThread(127.0.0.1:2181)] -
Could not retrieve login configuration: java.lang.SecurityException:
Unable to locate a login configuration
DEBUG 2013-10-24 18:00:09,506 [main-SendThread(127.0.0.1:2181)] -
Reading reply sessionid:0x141ece7e6160017, packet:: clientPath:null
serverPath:null finished:false header:: 1,3  replyHeader:: 1,541,0
request:: '/clusterstate.json,F  response::
s{20,522,1382659358606,1382660557980,19,0,0,0,1072,0,20}


There seem to be several issues:
address family not supported
Unable to locate a login configuration

Does any of that ring any bells?

Many thanks in advance
Jack

Re: First test cloud error question...

Posted by Jack Park <ja...@topicquests.org>.
Focus turned to the issue of " Unable to open socket to
0:0:0:0:0:0:0:1/0:0:0:0:0:0:0:1:2181"

That's apparently been problematic for others as well. It might be at root here.
I believe I am able to prove zookeeper is running by asking its
status, which reports at least something.

I moved the entire SolrCloud installation over to an Ubuntu box.
There, I see a new problem: zookeeper doesn't appear to be running,
even though it says "STARTED" after booting, but gives no further
console messages and returns to the command line as if it ended. If I
ask zkServer status, it says "probably not running".

In the data directory (/tmp/zookeeper -- same for both windoz and
nix), in nix, there is a pid file and nothing else. In the windoz
data, there is no pid file, but a /version-2 directory with what
appear to be runtime log files -- not the debug ones. Neither
installation shows a log4j log file anywhere.

I have reason to believe I followed all the instructions in the
ZooKeeper Getting Started page accurately. Still, no real cigar...

Java on windoz is 1.6.0_31; on ubuntu it is 1.7.0_40

Thanks in advance for any hints.

On Thu, Oct 24, 2013 at 6:24 PM, Jack Park <ja...@topicquests.org> wrote:
> Background: all testing done on a Win7 platform. This is my first
> migration from a single Solr server to a simple cloud. Everything is
> configured exactly as specified in the wiki.
>
> I created a simple 3-node client, all localhost with different server
> URLs, and a lone external zookeeper.  The online admin shows they are
> all up.
>
> I then start an agent which sends in documents to "bootstrap" the
> index. That's when issues start.  A clip from the log shows this:
> First, I create a SolrDocument with this JSON data:
>
> DEBUG 2013-10-24 18:00:09,143 [main] - SolrCloudClient.mapToDocument-
> {"locator":"EssayNodeType","smallIcon":"\/images\/cogwheel.png","subOf":["NodeType"],"details":["The
> TopicQuests NodeTypes typology essay
> type."],"isPrivate":"false","creatorId":"SystemUser","label":["Essay
> Type"],"largeIcon":"\/images\/cogwheel_sm.png","lastEditDate":Thu Oct
> 24 18:00:09 PDT 2013,"createdDate":Thu Oct 24 18:00:09 PDT 2013}
>
> Then, send it in from SolrJ which has a CloudSolrServer initialized
> with localhost:2181 and an instance of LBHttpSolrServer initialized
> with http://localhost:8983/solr/
>
> That trace follows
>
> INFO  2013-10-24 18:00:09,145 [main] - Initiating client connection,
> connectString=localhost:2181 sessionTimeout=10000
> watcher=org.apache.solr.common.cloud.ConnectionManager@8888e6c
> INFO  2013-10-24 18:00:09,148 [main] - Waiting for client to connect
> to ZooKeeper
> INFO  2013-10-24 18:00:09,150 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
> - Opening socket connection to server
> 0:0:0:0:0:0:0:1/0:0:0:0:0:0:0:1:2181. Will not attempt to authenticate
> using SASL (Unable to locate a login configuration)
> ERROR 2013-10-24 18:00:09,151 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
> - Unable to open socket to 0:0:0:0:0:0:0:1/0:0:0:0:0:0:0:1:2181
> WARN  2013-10-24 18:00:09,151 [main-SendThread(0:0:0:0:0:0:0:1:2181)]
> - Session 0x0 for server null, unexpected error, closing socket
> connection and attempting reconnect
> java.net.SocketException: Address family not supported by protocol
> family: connect
> at sun.nio.ch.Net.connect(Native Method)
> at sun.nio.ch.SocketChannelImpl.connect(Unknown Source)
> at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:266)
>
> I can watch the Zookeeper console running; it's mostly complaining
> about too many connections from /127.0.0.1 ; I am seeing the errors in
> the agent's log file.
>
> Following that trace in the log is this:
>
> INFO  2013-10-24 18:00:09,447 [main-SendThread(127.0.0.1:2181)] -
> Opening socket connection to server 127.0.0.1/127.0.0.1:2181. Will not
> attempt to authenticate using SASL (Unable to locate a login
> configuration)
> INFO  2013-10-24 18:00:09,448 [main-SendThread(127.0.0.1:2181)] -
> Socket connection established to 127.0.0.1/127.0.0.1:2181, initiating
> session
> DEBUG 2013-10-24 18:00:09,449 [main-SendThread(127.0.0.1:2181)] -
> Session establishment request sent on 127.0.0.1/127.0.0.1:2181
> DEBUG 2013-10-24 18:00:09,449 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> INFO  2013-10-24 18:00:09,501 [main-SendThread(127.0.0.1:2181)] -
> Session establishment complete on server 127.0.0.1/127.0.0.1:2181,
> sessionid = 0x141ece7e6160017, negotiated timeout = 10000
> INFO  2013-10-24 18:00:09,501 [main-EventThread] - Watcher
> org.apache.solr.common.cloud.ConnectionManager@42bad8a8
> name:ZooKeeperConnection Watcher:localhost:2181 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> INFO  2013-10-24 18:00:09,502 [main] - Client is connected to ZooKeeper
> DEBUG 2013-10-24 18:00:09,502 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,502 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,503 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,503 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,504 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,504 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,505 [main-SendThread(127.0.0.1:2181)] -
> Could not retrieve login configuration: java.lang.SecurityException:
> Unable to locate a login configuration
> DEBUG 2013-10-24 18:00:09,506 [main-SendThread(127.0.0.1:2181)] -
> Reading reply sessionid:0x141ece7e6160017, packet:: clientPath:null
> serverPath:null finished:false header:: 1,3  replyHeader:: 1,541,0
> request:: '/clusterstate.json,F  response::
> s{20,522,1382659358606,1382660557980,19,0,0,0,1072,0,20}
>
>
> There seem to be several issues:
> address family not supported
> Unable to locate a login configuration
>
> Does any of that ring any bells?
>
> Many thanks in advance
> Jack