You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@zookeeper.apache.org by "Rakesh R (JIRA)" <ji...@apache.org> on 2014/03/13 19:11:45 UTC

[jira] [Updated] (ZOOKEEPER-1862) ServerCnxnTest.testServerCnxnExpiry is intermittently failing

     [ https://issues.apache.org/jira/browse/ZOOKEEPER-1862?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Rakesh R updated ZOOKEEPER-1862:
--------------------------------

    Component/s: tests

> ServerCnxnTest.testServerCnxnExpiry is intermittently failing
> -------------------------------------------------------------
>
>                 Key: ZOOKEEPER-1862
>                 URL: https://issues.apache.org/jira/browse/ZOOKEEPER-1862
>             Project: ZooKeeper
>          Issue Type: Bug
>          Components: tests
>    Affects Versions: 3.5.0
>            Reporter: Rakesh R
>            Assignee: Rakesh R
>             Fix For: 3.5.0
>
>         Attachments: ZOOKEEPER-1862.patch
>
>
> ServerCnxnTest#testServerCnxnExpiry test case is failing in the trunk build with the following exception
> {code}
>     [junit] 2014-01-11 10:13:07,696 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:63930
>     [junit] 2014-01-11 10:13:09,000 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:63930 (no session established for client)
>     [junit] 2014-01-11 10:13:10,697 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@62] - TEST METHOD FAILED testServerCnxnExpiry
>     [junit] java.net.SocketException: Software caused connection abort: recv failed
>     [junit] 	at java.net.SocketInputStream.socketRead0(Native Method)
>     [junit] 	at java.net.SocketInputStream.read(SocketInputStream.java:150)
>     [junit] 	at java.net.SocketInputStream.read(SocketInputStream.java:121)
>     [junit] 	at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:283)
>     [junit] 	at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:325)
>     [junit] 	at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:177)
>     [junit] 	at java.io.InputStreamReader.read(InputStreamReader.java:184)
>     [junit] 	at java.io.BufferedReader.fill(BufferedReader.java:154)
>     [junit] 	at java.io.BufferedReader.readLine(BufferedReader.java:317)
>     [junit] 	at java.io.BufferedReader.readLine(BufferedReader.java:382)
>     [junit] 	at org.apache.zookeeper.test.ServerCnxnTest.send4LetterWord(ServerCnxnTest.java:105)
>     [junit] 	at org.apache.zookeeper.test.ServerCnxnTest.sendRequest(ServerCnxnTest.java:77)
>     [junit] 	at org.apache.zookeeper.test.ServerCnxnTest.testServerCnxnExpiry(ServerCnxnTest.java:64)
>     [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>     [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>     [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>     [junit] 	at java.lang.reflect.Method.invoke(Method.java:601)
>     [junit] 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
>     [junit] 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>     [junit] 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
>     [junit] 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>     [junit] 	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
>     [junit] 	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>     [junit] 	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
>     [junit] 	at org.junit.rules.TestWatchman$1.evaluate(TestWatchman.java:52)
>     [junit] 	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>     [junit] 	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:69)
>     [junit] 	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:48)
>     [junit] 	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>     [junit] 	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>     [junit] 	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>     [junit] 	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>     [junit] 	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>     [junit] 	at org.junit.runners.ParentRunner.run(ParentRunner.java:292)
>     [junit] 	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
>     [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:518)
>     [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1052)
>     [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:906)
>     {code}
> When analyzing the possible cause of the failure is:
>  During connection expiry server will close the socket channel connection. After the socket closure, when the client tries to read a line of text will throw java.net.SocketException.
>  In the failure scenario the testcase has established a socket connection and entering into the sleep. In the meantime the server side expiration would happen and closing the socket channel. Assume after the socket closure the testcase is trying to read the text using the previously established socket and is resulting in SocketException. There is a race between the reading the socket in the client side and socket closure in server side.
> {code}
> NIOServerCnxn#closeSock is closing the socket channel.
>  sock.socket().shutdownOutput();
>  sock.socket().shutdownInput();
>  sock.socket().close();
>  sock.close();
> {code}



--
This message was sent by Atlassian JIRA
(v6.2#6252)