Philip Harvey created QPID-4958: ----------------------------------- Summary: Java Performance Tests - race condition client registration detection causes tests to hang Key: QPID-4958 URL: https://issues.apache.org/jira/browse/QPID-4958 Project: Qpid Issue Type: Bug Components: Java Performance Tests Affects Versions: 0.22 Reporter: Philip Harvey Assignee: Philip Harvey
Occasionally various tests in ControllerAndClientTest fail with errors such as: {noformat} main 2013-06-25 14:39:25,539 ERROR [qpid.disttest.controller.TestRunner] Couldn't run test org.apache.qpid.disttest.DistributedTestException: After 30000ms ... Timed out waiting for command responses ... Expecting 10 more responses. at org.apache.qpid.disttest.controller.TestRunner.awaitLatch(TestRunner.java:293) at org.apache.qpid.disttest.controller.TestRunner.awaitCommandResponses(TestRunner.java:183) at org.apache.qpid.disttest.controller.TestRunner.runParts(TestRunner.java:130) at org.apache.qpid.disttest.controller.TestRunner.run(TestRunner.java:103) at org.apache.qpid.disttest.controller.Controller.runAllTests(Controller.java:171) at org.apache.qpid.systest.disttest.controllerandclient.ControllerAndClientTest.runTestsForTwoClients(ControllerAndClientTest.java:195) at org.apache.qpid.systest.disttest.controllerandclient.ControllerAndClientTest.testProducerAndThreeConsumersInSeparateClients(ControllerAndClientTest.java:136) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) {noformat} The relevant test log excerpts are shown below. {noformat} main 2013-06-25 14:38:35,357 INFO [qpid.disttest.controller.Controller] Awaiting client registrations ... 908 Dispatcher-1-Conn-2 2013-06-25 14:38:35,448 INFO [qpid.disttest.controller.ClientRegistry] Client registered: 63a95928-7d12-48ad-9326-133da9a0ddb6 ... 920 Dispatcher-1-Conn-2 2013-06-25 14:38:35,450 INFO [qpid.disttest.controller.ClientRegistry] Client registered: 2510ce56-20d4-43a2-84db-193a87b1cfec ... {noformat} Client thread timing out after the 5 seconds set by the JUnit test: {noformat} 997 2510ce56-20d4-43a2-84db-193a87b1cfec-thread 2013-06-25 14:38:40,423 DEBUG [apache.qpid.client.AMQSession] Closing session: org.apache.qpid.client.AMQSes sion_0_8@5e111b5c {noformat} Controller sends test set-up commands, 20 seconds after "Awaiting client registrations". This happens to be the length of the client registration time-out, suggesting that the "await client registrations" code didn't notice that client registrations. {noformat} 1080 main 2013-06-25 14:38:55,476 DEBUG [qpid.disttest.controller.TestRunner] About to send 10 command(s) {noformat} -- 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 --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@qpid.apache.org For additional commands, e-mail: dev-h...@qpid.apache.org