Myrna van Lunteren created DERBY-6019:
-----------------------------------------
Summary: hang after connect reset error in
(emb)replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878
Key: DERBY-6019
URL: https://issues.apache.org/jira/browse/DERBY-6019
Project: Derby
Issue Type: Bug
Affects Versions: 10.10.0.0
Environment: windows XP with ibm 1.5 SR 15
Reporter: Myrna van Lunteren
I saw a hang in the test
(emb)replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878
against trunk:
10.10.0.0 alpha - (1423738), with the following stack trace:
(emb)replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878
java.net.SocketException: Connection reset
at java.net.SocketInputStream.read(SocketInputStream.java:197)
at java.net.SocketInputStream.read(SocketInputStream.java:116)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.fillReplyBuffer(Unknown
Source)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.readResult(Unknown Source)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.pingWithNoOpen(Unknown
Source)
at org.apache.derby.impl.drda.NetworkServerControlImpl.ping(Unknown
Source)
at org.apache.derby.drda.NetworkServerControl.ping(Unknown Source)
at
org.apache.derbyTesting.junit.NetworkServerTestSetup.pingForServerUp(NetworkServerTestSetup.java:608)
at
org.apache.derbyTesting.junit.NetworkServerTestSetup.pingForServerStart(NetworkServerTestSetup.java:679)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.pingServer(ReplicationRun.java:2162)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.startServer(ReplicationRun.java:1951)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878(ReplicationRun_Local_3_p5.java:100)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:619)
at junit.framework.TestCase.runTest(TestCase.java:164)
at junit.framework.TestCase.runBare(TestCase.java:130)
at
org.apache.derbyTesting.junit.BaseTestCase.runBare(BaseTestCase.java:117)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.runBare(ReplicationRun.java:246)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:120)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.extensions.TestSetup.run(TestSetup.java:25)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.textui.TestRunner.doRun(TestRunner.java:121)
at junit.textui.TestRunner.start(TestRunner.java:185)
at junit.textui.TestRunner.main(TestRunner.java:143)
java.net.SocketException: Connection reset
at java.net.SocketInputStream.read(SocketInputStream.java:197)
at java.net.SocketInputStream.read(SocketInputStream.java:116)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.fillReplyBuffer(Unknown
Source)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.readResult(Unknown Source)
at
org.apache.derby.impl.drda.NetworkServerControlImpl.pingWithNoOpen(Unknown
Source)
at org.apache.derby.impl.drda.NetworkServerControlImpl.ping(Unknown
Source)
at org.apache.derby.drda.NetworkServerControl.ping(Unknown Source)
at
org.apache.derbyTesting.junit.NetworkServerTestSetup.pingForServerUp(NetworkServerTestSetup.java:608)
at
org.apache.derbyTesting.junit.NetworkServerTestSetup.pingForServerStart(NetworkServerTestSetup.java:679)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.pingServer(ReplicationRun.java:2162)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.startServer(ReplicationRun.java:1951)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878(ReplicationRun_Local_3_p5.java:100)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:619)
at junit.framework.TestCase.runTest(TestCase.java:164)
at junit.framework.TestCase.runBare(TestCase.java:130)
at
org.apache.derbyTesting.junit.BaseTestCase.runBare(BaseTestCase.java:117)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.runBare(ReplicationRun.java:246)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:120)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24)
at junit.extensions.TestSetup$1.protect(TestSetup.java:21)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.extensions.TestSetup.run(TestSetup.java:25)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.framework.TestSuite.runTest(TestSuite.java:230)
at junit.framework.TestSuite.run(TestSuite.java:225)
at junit.textui.TestRunner.doRun(TestRunner.java:121)
at junit.textui.TestRunner.start(TestRunner.java:185)
at junit.textui.TestRunner.main(TestRunner.java:143)
There was no fail directory.
I send a signal to the hanging process (using 'SendSignal) which successfully
created a javacore.txt file. The Thread Details section showed this:
2XMFULLTHDDUMP Full thread dump J9 VM (J2RE 5.0 IBM J9 2.3 Windows XP x86-32
build j9vmwi3223-2012101220121010_124616_lHdSMr, native threads):
3XMTHREADINFO "main" (TID:0x000D0B00, sys_thread_t:0x00036C48, state:CW,
native ID:0x00000B64) prio=5
4XESTACKTRACE at java/lang/Object.wait(Native Method)
4XESTACKTRACE at java/lang/Object.wait(Object.java:199)
4XESTACKTRACE at
org/apache/derby/impl/drda/NetworkServerControlImpl.blockingStart(Bytecode
PC:349)
4XESTACKTRACE at
org/apache/derby/impl/drda/NetworkServerControlImpl.executeWork(Bytecode PC:101)
4XESTACKTRACE at
org/apache/derby/drda/NetworkServerControl.main(Bytecode PC:76)
3XMTHREADINFO "JIT Compilation Thread" (TID:0x000D0F00,
sys_thread_t:0x00036EA0, state:CW, native ID:0x00000268) prio=11
3XMTHREADINFO3 No Java callstack associated with this thread
3XMTHREADINFO "Signal Dispatcher" (TID:0x000D1300,
sys_thread_t:0x00037350, state:R, native ID:0x00001258) prio=5
4XESTACKTRACE at com/ibm/misc/SignalDispatcher.waitForSignal(Native
Method)
4XESTACKTRACE at
com/ibm/misc/SignalDispatcher.run(SignalDispatcher.java:88)
3XMTHREADINFO "Gc Slave Thread" (TID:0x622D8200, sys_thread_t:0x00037800,
state:CW, native ID:0x000010C0) prio=5
3XMTHREADINFO3 No Java callstack associated with this thread
3XMTHREADINFO "Finalizer thread" (TID:0x622D8600, sys_thread_t:0x62A619C0,
state:CW, native ID:0x00000AD4) prio=5
3XMTHREADINFO3 No Java callstack associated with this thread
3XMTHREADINFO "Timer-0" (TID:0x622D8A00, sys_thread_t:0x62A61C18,
state:CW, native ID:0x00000BF8) prio=5
4XESTACKTRACE at java/lang/Object.wait(Native Method)
4XESTACKTRACE at java/lang/Object.wait(Object.java:199)
4XESTACKTRACE at java/util/TimerThread.mainLoop(Timer.java:508)
4XESTACKTRACE at java/util/TimerThread.run(Timer.java:487)
3XMTHREADINFO "MemoryPoolMXBean notification dispatcher" (TID:0x6334F300,
sys_thread_t:0x62A61E70, state:CW, native ID:0x00000A84) prio=6
4XESTACKTRACE at
com/ibm/lang/management/MemoryNotificationThread.processNotificationLoop(Native
Method)
4XESTACKTRACE at
com/ibm/lang/management/MemoryNotificationThread.run(MemoryNotificationThread.java:55)
3XMTHREADINFO "NetworkServerThread_1" (TID:0x6334F700,
sys_thread_t:0x62A620C8, state:R, native ID:0x000014D8) prio=5
4XESTACKTRACE at java/net/PlainSocketImpl.socketAccept(Native Method)
4XESTACKTRACE at
java/net/PlainSocketImpl.accept(PlainSocketImpl.java:479)
4XESTACKTRACE at
java/net/ServerSocket.implAccept(ServerSocket.java:473)
4XESTACKTRACE at java/net/ServerSocket.accept(ServerSocket.java:444)
4XESTACKTRACE at
org/apache/derby/impl/drda/ClientThread$1.run(Bytecode PC:14)
4XESTACKTRACE at
org/apache/derby/impl/drda/ClientThread$1.run(Bytecode PC:1)
4XESTACKTRACE at
java/security/AccessController.doPrivileged(AccessController.java:192)
4XESTACKTRACE at
org/apache/derby/impl/drda/ClientThread.acceptClientWithRetry(Bytecode PC:8)
4XESTACKTRACE at org/apache/derby/impl/drda/ClientThread.run(Bytecode
PC:3)
After this, I killed the hanging process, and a 'fail' directory was then
created and the tests went on.
I will attach the non-database files from the 'fail' directory.
The error in the error.stacktrace was:
-------
junit.framework.AssertionFailedError: Server did not start in time
at junit.framework.Assert.fail(Assert.java:47)
at junit.framework.Assert.assertTrue(Assert.java:20)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.pingServer(ReplicationRun.java:2162)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun.startServer(ReplicationRun.java:1951)
at
org.apache.derbyTesting.functionTests.tests.replicationTests.ReplicationRun_Local_3_p5.testReplication_Local_3_p5_DERBY_3878(ReplicationRun_Local_3_p5.java:100)
...
-------------------------
In db_slave-derby.log I can see this error:
ERROR XRE08: Replication slave mode started successfully for database
'C:\jartest\JarResults.2012-12-18\ibm15_suites.All\db_slave\wombat'. Connection
refused because the database is in replication slave mode.
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira
