[jboss-jira] [JBoss JIRA] Commented: (JBMESSAGING-775) org.jboss.test.messaging.jms.selector.SelectorTest.testManyQueueWithExpired() locks up

[Ovidiu Feodorov (JIRA)]

    [ http://jira.jboss.com/jira/browse/JBMESSAGING-775?page=comments#action_12351496 ] 
            
Ovidiu Feodorov commented on JBMESSAGING-775:
---------------------------------------------

Deadlock:

18:38:11,234 TRACE @main [MessageCallbackHandler] MessageCallbackHandler[4] receiving, timeout = 1000

#
# main has MessageCallbackHandler[4]'s main lock
#

18:38:11,234 TRACE @main [MessageCallbackHandler] MessageCallbackHandler[4]: receive, timeout 1000 ms, blocking poll on queue
18:38:11,234 TRACE @main [MessageCallbackHandler] MessageCallbackHandler[4] received delegator->JBossMessage[1]:PERSISTENT after being blocked on buffer
18:38:11,234 TRACE @main [RoutableSupport] JBossMessage[1]:PERSISTENT expired by 2280 ms
18:38:11,234 TRACE @main [MessageCallbackHandler] Message JBossMessage[1]:PERSISTENT has expired - cancelling to server
18:38:11,250 TRACE @main [ClientLogInterceptor] invoking SessionDelegate[3].cancelDelivery(org.jboss.jms.server.endpoint.DefaultCancel at c2cf83)
18:38:11,250 TRACE @main [DelegateSupport] SessionDelegate[3] invoking cancelDelivery(..) synchronously on server
18:38:11,250 TRACE @main [ServerLogInterceptor] invoking SessionAdvised->SessionEndpoint[3].cancelDelivery(org.jboss.jms.server.endpoint.DefaultCancel at c2cf83)
18:38:11,250 TRACE @main [ServerSessionEndpoint] SessionEndpoint[3] cancelDelivery org.jboss.jms.server.endpoint.DefaultCancel at c2cf83
18:38:11,250 TRACE @main [TransactionRepository] created transaction TX(0):ACTIVE
18:38:11,250 TRACE @main [SimpleMessageStore] MemoryStore[13037557] generated Reference[256]:RELIABLE for JBossMessage[256]:PERSISTENT
18:38:11,250 WARN  @main [ServerSessionEndpoint] Cannot move to destination since destination has not been deployed! The message will be removed
18:38:11,250 TRACE @main [SimpleDelivery] Delivery[Reference[1]:RELIABLE](active) acknowledging delivery in TX(0):ACTIVE
18:38:11,250 TRACE @main [ChannelSupport] acknowledging Delivery[Reference[1]:RELIABLE](active) transactionally in TX(0):ACTIVE

...


18:38:11,250 TRACE @Thread-3 [ChannelSupport] Queue[0/Queue] pushing Reference[4]:RELIABLE
18:38:11,250 TRACE @Thread-3 [ServerConsumerEndpoint] ConsumerEndpoint[4] receives Reference[4]:RELIABLE for delivery
18:38:11,250 TRACE @Thread-3 [ServerConsumerEndpoint] ConsumerEndpoint[4] has the main lock, preparing the message for delivery

#
# Thread-3 has ConsumerEndpoint[4]'s startStopLock
#

18:38:11,250 TRACE @Thread-3 [ServerConsumerEndpoint] message selector accepts the message
18:38:11,250 TRACE @Thread-3 [ServerSessionEndpoint] SessionEndpoint[3] added delivery 3: Delivery[Reference[4]:RELIABLE](active)
18:38:11,250 TRACE @Thread-3 [ServerConsumerEndpoint] ConsumerEndpoint[4] submitting message JBossMessage[4]:PERSISTENT to the remoting layer to be sent asynchronously
18:38:11,250 TRACE @Thread-3 [MessageCallbackHandler] Receiving message delegator->JBossMessage[4]:PERSISTENT from the remoting layer

#
# thread 3 waits for the MessageCallbackHandler's main lock
#


18:38:11,250 TRACE @main [ChannelSupport] Queue[0/Queue] added Delivery[Reference[1]:RELIABLE](active) to memory on transaction TX(0):ACTIVE
18:38:11,250 TRACE @main [Transaction] TX(0):ACTIVE executing before commit hooks
18:38:11,265 TRACE @main [JDBCPersistenceManager] removing Reference[1]:RELIABLE from channel 0
18:38:11,265 TRACE @main [JDBCPersistenceManager] Batch update DELETE FROM JMS_MESSAGE_REFERENCE WHERE MESSAGEID=? AND CHANNELID=? AND STATE='C', deleted total of 1 rows
18:38:11,265 TRACE @main [JDBCPersistenceManager] Batch update UPDATE JMS_MESSAGE SET CHANNELCOUNT = CHANNELCOUNT - 1 WHERE MESSAGEID=?, updated total of 1 rows
18:38:11,265 TRACE @main [JDBCPersistenceManager] Batch update DELETE FROM JMS_MESSAGE WHERE MESSAGEID=? AND CHANNELCOUNT=0, deleted total of 1 rows
18:38:11,265 TRACE @main [Transaction] TX(0):COMMITTED committed
18:38:11,265 TRACE @main [Transaction] TX(0):COMMITTED executing after commit hooks

#
# main waits (somehow) for ConsumerEndpoint[4]'s startStopLock
#


> org.jboss.test.messaging.jms.selector.SelectorTest.testManyQueueWithExpired() locks up
> --------------------------------------------------------------------------------------
>
>                 Key: JBMESSAGING-775
>                 URL: http://jira.jboss.com/jira/browse/JBMESSAGING-775
>             Project: JBoss Messaging
>          Issue Type: Sub-task
>          Components: Tests and Performance
>            Reporter: Ovidiu Feodorov
>         Assigned To: Ovidiu Feodorov
>             Fix For: 1.2.0.Beta2
>
>
> Test temporarily commented out.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators: http://jira.jboss.com/jira/secure/Administrators.jspa
-
For more information on JIRA, see: http://www.atlassian.com/software/jira