Re: Unusual exception
Hi Mahadev I did and it turned out to be some screw up on our end. Thanks Avinash On Tue, Oct 26, 2010 at 3:39 PM, Mahadev Konar wrote: > Hi Avinash, > Not sure if you got a response for your email. > The exception that you mention mostly means that the client already closed > the socket or shutdown. > Looks like a client is trying to connect but disconnects before the server > can respond. > > Do you have any such clients? Is this causing any issues with your > zookeeper > set up? > > Thanks > mahadev > > > On 10/13/10 2:49 PM, "Avinash Lakshman" > wrote: > > > I started seeing a bunch of these exceptions. What do these mean? > > > > 2010-10-13 14:01:33,426 - WARN [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable > to > > read additional data from client sessionid 0x0, likely client has closed > > socket > > 2010-10-13 14:01:33,426 - INFO [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > > client /10.138.34.195:55738 (no session established for client) > > 2010-10-13 14:01:33,426 - DEBUG > [CommitProcessor:1:finalrequestproces...@78] > > - Processing request:: sessionid:0x12b9d1f8b907a44 type:closeSession > > cxid:0x0 zxid:0x600193996 txntype:-11 reqpath:n/a > > 2010-10-13 14:01:33,427 - WARN [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable > to > > read additional data from client sessionid 0x12b9d1f8b907a5d, likely > client > > has closed socket > > 2010-10-13 14:01:33,427 - INFO [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > > client /10.138.34.195:55979 which had sessionid 0x12b9d1f8b907a5d > > 2010-10-13 14:01:33,427 - DEBUG [QuorumPeer:/0.0.0.0:5001 > > :commitproces...@159] - Committing request:: sessionid:0x52b90ab45bd51af > > type:createSession cxid:0x0 zxid:0x600193cf9 txntype:-10 reqpath:n/a > > 2010-10-13 14:01:33,427 - DEBUG [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@1302] - ignoring exception during > output > > shutdown > > java.net.SocketException: Transport endpoint is not connected > > at sun.nio.ch.SocketChannelImpl.shutdown(Native Method) > > at > sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:651) > > at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) > > at > > > org.apache.zookeeper.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1298) > > at > org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > > at > > > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > > 2010-10-13 14:01:33,428 - DEBUG [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@1310] - ignoring exception during > input > > shutdown > > java.net.SocketException: Transport endpoint 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.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1306) > > at > org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > > at > > > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > > 2010-10-13 14:01:33,428 - WARN [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable > to > > read additional data from client sessionid 0x0, likely client has closed > > socket > > 2010-10-13 14:01:33,428 - INFO [NIOServerCxn.Factory: > > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > > client /10.138.34.195:55731 (no session established for client) > > > >
Re: Unusual exception
Hi Avinash, Not sure if you got a response for your email. The exception that you mention mostly means that the client already closed the socket or shutdown. Looks like a client is trying to connect but disconnects before the server can respond. Do you have any such clients? Is this causing any issues with your zookeeper set up? Thanks mahadev On 10/13/10 2:49 PM, "Avinash Lakshman" wrote: > I started seeing a bunch of these exceptions. What do these mean? > > 2010-10-13 14:01:33,426 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x0, likely client has closed > socket > 2010-10-13 14:01:33,426 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55738 (no session established for client) > 2010-10-13 14:01:33,426 - DEBUG [CommitProcessor:1:finalrequestproces...@78] > - Processing request:: sessionid:0x12b9d1f8b907a44 type:closeSession > cxid:0x0 zxid:0x600193996 txntype:-11 reqpath:n/a > 2010-10-13 14:01:33,427 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x12b9d1f8b907a5d, likely client > has closed socket > 2010-10-13 14:01:33,427 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55979 which had sessionid 0x12b9d1f8b907a5d > 2010-10-13 14:01:33,427 - DEBUG [QuorumPeer:/0.0.0.0:5001 > :commitproces...@159] - Committing request:: sessionid:0x52b90ab45bd51af > type:createSession cxid:0x0 zxid:0x600193cf9 txntype:-10 reqpath:n/a > 2010-10-13 14:01:33,427 - DEBUG [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1302] - ignoring exception during output > shutdown > java.net.SocketException: Transport endpoint is not connected > at sun.nio.ch.SocketChannelImpl.shutdown(Native Method) > at sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:651) > at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) > at > org.apache.zookeeper.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1298) > at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > at > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > 2010-10-13 14:01:33,428 - DEBUG [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1310] - ignoring exception during input > shutdown > java.net.SocketException: Transport endpoint 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.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1306) > at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > at > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > 2010-10-13 14:01:33,428 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x0, likely client has closed > socket > 2010-10-13 14:01:33,428 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55731 (no session established for client) >
Re: Unusual exception
EOS means that the client closed the connection (from the point of view of the server). The server then tries to cleanup by closing the socket explicitly, in some cases that results in debug messages you see subsequent. EndOfStreamException: Unable to read additional data from client sessionid 0x0, likely client has closed socket Notice that the session id is 0 - so either this is a zk client that failed before establishing a session, or more likely it's a monitoring/4letterword command (which never est sessions). Patrick On Wed, Oct 13, 2010 at 2:49 PM, Avinash Lakshman < avinash.laksh...@gmail.com> wrote: > I started seeing a bunch of these exceptions. What do these mean? > > 2010-10-13 14:01:33,426 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x0, likely client has closed > socket > 2010-10-13 14:01:33,426 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55738 (no session established for client) > 2010-10-13 14:01:33,426 - DEBUG [CommitProcessor:1:finalrequestproces...@78 > ] > - Processing request:: sessionid:0x12b9d1f8b907a44 type:closeSession > cxid:0x0 zxid:0x600193996 txntype:-11 reqpath:n/a > 2010-10-13 14:01:33,427 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x12b9d1f8b907a5d, likely client > has closed socket > 2010-10-13 14:01:33,427 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55979 which had sessionid 0x12b9d1f8b907a5d > 2010-10-13 14:01:33,427 - DEBUG [QuorumPeer:/0.0.0.0:5001 > :commitproces...@159] - Committing request:: sessionid:0x52b90ab45bd51af > type:createSession cxid:0x0 zxid:0x600193cf9 txntype:-10 reqpath:n/a > 2010-10-13 14:01:33,427 - DEBUG [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1302] - ignoring exception during > output > shutdown > java.net.SocketException: Transport endpoint is not connected > at sun.nio.ch.SocketChannelImpl.shutdown(Native Method) > at sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:651) > at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) > at > > org.apache.zookeeper.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1298) > at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > at > > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > 2010-10-13 14:01:33,428 - DEBUG [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1310] - ignoring exception during input > shutdown > java.net.SocketException: Transport endpoint 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.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1306) > at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) > at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) > at > > org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) > 2010-10-13 14:01:33,428 - WARN [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to > read additional data from client sessionid 0x0, likely client has closed > socket > 2010-10-13 14:01:33,428 - INFO [NIOServerCxn.Factory: > 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for > client /10.138.34.195:55731 (no session established for client) >
Unusual exception
I started seeing a bunch of these exceptions. What do these mean? 2010-10-13 14:01:33,426 - WARN [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to read additional data from client sessionid 0x0, likely client has closed socket 2010-10-13 14:01:33,426 - INFO [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for client /10.138.34.195:55738 (no session established for client) 2010-10-13 14:01:33,426 - DEBUG [CommitProcessor:1:finalrequestproces...@78] - Processing request:: sessionid:0x12b9d1f8b907a44 type:closeSession cxid:0x0 zxid:0x600193996 txntype:-11 reqpath:n/a 2010-10-13 14:01:33,427 - WARN [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to read additional data from client sessionid 0x12b9d1f8b907a5d, likely client has closed socket 2010-10-13 14:01:33,427 - INFO [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for client /10.138.34.195:55979 which had sessionid 0x12b9d1f8b907a5d 2010-10-13 14:01:33,427 - DEBUG [QuorumPeer:/0.0.0.0:5001 :commitproces...@159] - Committing request:: sessionid:0x52b90ab45bd51af type:createSession cxid:0x0 zxid:0x600193cf9 txntype:-10 reqpath:n/a 2010-10-13 14:01:33,427 - DEBUG [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@1302] - ignoring exception during output shutdown java.net.SocketException: Transport endpoint is not connected at sun.nio.ch.SocketChannelImpl.shutdown(Native Method) at sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:651) at sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:368) at org.apache.zookeeper.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1298) at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) at org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) 2010-10-13 14:01:33,428 - DEBUG [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@1310] - ignoring exception during input shutdown java.net.SocketException: Transport endpoint 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.server.NIOServerCnxn.closeSock(NIOServerCnxn.java:1306) at org.apache.zookeeper.server.NIOServerCnxn.close(NIOServerCnxn.java:1263) at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:609) at org.apache.zookeeper.server.NIOServerCnxn$Factory.run(NIOServerCnxn.java:262) 2010-10-13 14:01:33,428 - WARN [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@606] - EndOfStreamException: Unable to read additional data from client sessionid 0x0, likely client has closed socket 2010-10-13 14:01:33,428 - INFO [NIOServerCxn.Factory: 0.0.0.0/0.0.0.0:5001:nioserverc...@1286] - Closed socket connection for client /10.138.34.195:55731 (no session established for client)