Indeed my apologizes
Here it is
2003-06-03 15:07:00,476 TRACE [org.jboss.mq.il.oil.OILServerILService] Setting TcpNoDelay Option to:true
2003-06-03 15:07:00,477 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : authenticate
2003-06-03 15:07:00,477 TRACE [org.jboss.mq.security.ServerSecurityInterceptor] Autenticating user null/null
2003-06-03 15:07:00,477 TRACE [org.jboss.security.plugins.JaasSecurityManager.jbossmq] validateCache, info=org.jboss.security.plugins.JaasSecurityManager$DomainInfo@155e0bc
2003-06-03 15:07:00,477 TRACE [org.jboss.mq.security.SecurityManager] Username: null is authenticated
2003-06-03 15:07:00,477 TRACE [org.jboss.mq.security.SecurityManager] Adding group : class org.jboss.security.NestableGroup Roles(members:guest)
2003-06-03 15:07:00,477 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : authenticate
2003-06-03 15:07:00,515 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : getID
2003-06-03 15:07:00,516 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : getID
2003-06-03 15:07:00,525 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : ping
2003-06-03 15:07:00,525 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : 1054645620515
2003-06-03 15:07:00,525 DEBUG [org.jboss.mq.il.oil.OILClientIL] ConnectionReceiverOILClient is connecting to: 192.168.6.33:37581
2003-06-03 15:07:00,530 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : ping
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : addMessage
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : QUEUE.kp/v0.0.1/parcelInstruction
jmsDeliveryMode : 2
jmsExpiration : 0
jmsPriority : 4
jmsMessageID : ID:47-10546456205481
jmsTimeStamp : 1054645620548
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:true
msgReadOnly : false
producerClientId: ID:47
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
}
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.security.SecurityManager] Checking authorize on subjectInfo: SubjectInfo {subject=Subject:
Principal: guest
Principal: Roles(members:guest)
;principal=null;roles=Roles(members:guest) for rolePrincipals [guest]
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] counter lock aquire 43
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] counter lock release 43
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] add lock aquire message 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] add lock aquire lruCache 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] add locks release43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=0.29993507
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageReference] invalidate lock aquire 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.server.MessageReference] invalidate lock relased 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,549 TRACE [org.jboss.mq.pm.jdbc2.PersistenceManager] About to add message 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 transaction=null
2003-06-03 15:07:00,550 TRACE [org.jboss.tm.TransactionImpl] Created new instance for tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=]
2003-06-03 15:07:00,550 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] subject: null
2003-06-03 15:07:00,550 INFO [org.jboss.resource.connectionmanager.TxConnectionManager] getManagedConnection returning unassociated connection
2003-06-03 15:07:00,550 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] supplying ManagedConnection from pool: org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@b09fac
2003-06-03 15:07:00,550 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener] enlisting currenttx: TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=], ManagedConnection: org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@b09fac
2003-06-03 15:07:00,550 TRACE [org.jboss.tm.TransactionImpl] enlistResource(): Entered, tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=] status=STATUS_ACTIVE
2003-06-03 15:07:00,550 TRACE [org.jboss.tm.TransactionImpl] startResource(XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1]) entered: org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@1c30dfa flags=0
2003-06-03 15:07:00,550 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource] start, xid: XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1], flags: 0
2003-06-03 15:07:00,551 TRACE [org.jboss.tm.TransactionImpl] startResource(XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1]) leaving: org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@1c30dfa flags=0
2003-06-03 15:07:00,551 TRACE [org.jboss.tm.TransactionImpl] registerSynchronization(): Entered, tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=] status=STATUS_ACTIVE
2003-06-03 15:07:00,551 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] registering connection from org.jboss.resource.connectionmanager.TxConnectionManager@511a6e, connection record: org.jboss.resource.connectionmanager.ConnectionRecord@44ec30, key: null
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,551 TRACE [org.jboss.mq.pm.jdbc2.PersistenceManager] Inserting message 43 msg=3 hard NOT_STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 transaction=null
2003-06-03 15:07:00,553 TRACE [org.jboss.mq.pm.jdbc2.PersistenceManager] Added message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 transaction=null
2003-06-03 15:07:00,553 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener] connectionClosed called
2003-06-03 15:07:00,553 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] unregistering connection from org.jboss.resource.connectionmanager.TxConnectionManager@511a6e, object: org.jboss.resource.adapter.jdbc.WrappedConnection@4a2ec6, key: null
2003-06-03 15:07:00,553 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener] unregisterConnection: 0 handles left
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] Committing, tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=], status=STATUS_ACTIVE
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] calling sync 0, org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener$TxRemover@1724f31
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] Before completion done, tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=], status=STATUS_ACTIVE
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] endresources(0): state=1
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] endResource(XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1]) entered: org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@1c30dfa flag=67108864
2003-06-03 15:07:00,553 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource] end on xid: XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1] called with flags 67108864
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] endResource(XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=1]) leaving: org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@1c30dfa flag=67108864
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] One phase commit: One resource.
2003-06-03 15:07:00,553 TRACE [org.jboss.tm.TransactionImpl] Committing resources, resourceStates[0]=3
2003-06-03 15:07:00,560 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] putting ManagedConnection back into pool
2003-06-03 15:07:00,562 TRACE [org.jboss.tm.TransactionImpl] Committed OK, tx=TransactionImpl:XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//565, BranchQual=]
2003-06-03 15:07:00,562 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,562 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,562 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909 wasHard=true
2003-06-03 15:07:00,563 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 43 msg=3 hard STORED PERSISTENT queue=QUEUE.kp/v0.0.1/parcelInstruction priority=4 hashCode=18802909
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.SpyConnectionConsumer] SpyConnectionConsumer:QUEUE.kp/v0.0.1/parcelInstruction->addMessage(mes=org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : QUEUE.kp/v0.0.1/parcelInstruction
jmsDeliveryMode : 2
jmsExpiration : 0
jmsPriority : 4
jmsMessageID : ID:47-10546456205481
jmsTimeStamp : 1054645620548
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:false
msgReadOnly : true
producerClientId: ID:47
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
})
2003-06-03 15:07:00,564 TRACE [org.jboss.jms.asf.StdServerSessionPool] getting a server session
2003-06-03 15:07:00,564 TRACE [org.jboss.jms.asf.StdServerSessionPool] using server session: org.jboss.jms.asf.StdServerSession@2bc184
2003-06-03 15:07:00,564 TRACE [org.jboss.jms.asf.StdServerSession] starting invokes on server session
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : receive
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : -2147483648
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : -1
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.security.ServerSecurityInterceptor] Checking receive authorize on SpyDistributedConnection:ID:13/45910380be4bcd0ac8da0559be130b97 subId=-2147483648
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.security.SecurityManager] Checking authorize on subjectInfo: SubjectInfo {subject=Subject:
Principal: Roles(members:guest)
;principal=null;roles=Roles(members:guest) for rolePrincipals [guest]
2003-06-03 15:07:00,564 TRACE [org.jboss.jms.asf.StdServerSession] running...
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.SpyXAResourceManager] Starting tx with new xid=-9223372036854775805
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.SpySession] setting current tx id: -9223372036854775805, previous: null
2003-06-03 15:07:00,564 TRACE [org.jboss.mq.SpyXAResourceManager] Ack'ing message xid=-9223372036854775805
2003-06-03 15:07:00,564 TRACE [org.jboss.jms.asf.StdServerSession] onMessage running (pool, session, xaSession, useLocalTX): , org.jboss.mq.SpyTopicSession@a2bd15, org.jboss.mq.SpyTopicSession@a2bd15, true
2003-06-03 15:07:00,565 TRACE [org.jboss.mq.SpyXAResource] Start xid=XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//567, BranchQual=], flags=0
2003-06-03 15:07:00,565 TRACE [org.jboss.mq.SpyXAResourceManager] Converting tx anonXid=-9223372036854775805, xid=XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//567, BranchQual=]
2003-06-03 15:07:00,565 TRACE [org.jboss.mq.SpySession] setting current tx id: XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//567, BranchQual=], previous: -9223372036854775805
2003-06-03 15:07:00,565 TRACE [org.jboss.jms.asf.StdServerSession] Using optimized 1p commit to control TX.
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.jms.JMSContainerInvoker] processing message: org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : QUEUE.kp/v0.0.1/parcelInstruction
jmsDeliveryMode : 2
jmsExpiration : 0
jmsPriority : 4
jmsMessageID : ID:47-10546456205481
jmsTimeStamp : 1054645620548
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:false
msgReadOnly : true
producerClientId: ID:47
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
}
2003-06-03 15:07:00,565 TRACE [org.jboss.util.TCLStack] Setting TCL to java.net.URLClassLoader@fe135d; pushing java.net.URLClassLoader@fe135d
2003-06-03 15:07:00,565 TRACE [org.jboss.util.TCLStack] Stack: [java.net.URLClassLoader@fe135d]
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.ProxyFactoryFinderInterceptor] invokerBInding is null in ProxyFactoryFinder
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.LogInterceptor] Start method=onMessage
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Current transaction in MI is null
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] TX_NOT_SUPPORTED for onMessage
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Thread came in with tx null
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.MessageDrivenInstancePool] Get instance org.jboss.ejb.plugins.MessageDrivenInstancePool@1c047f0#1#class com.kiala.kialapointserver.jms.ParcelCreatorMessageBean
2003-06-03 15:07:00,565 TRACE [org.jboss.ejb.plugins.MessageDrivenInstancePool] Acquired(true) strictMaxSize semaphore, remaining=0
2003-06-03 15:07:00,565 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] new stack for key: com.kiala.kialapointserver.jms.ParcelCreatorMessageBean@b2e9be
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.ProxyFactoryFinderInterceptor] invokerBInding is null in ProxyFactoryFinder
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.LogInterceptor] Start method=create
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Current transaction in MI is null
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] TX_SUPPORTS for create
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Thread came in with tx null
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.LogInterceptor] End method=create
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.ProxyFactoryFinderInterceptor] invokerBInding is null in ProxyFactoryFinder
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.LogInterceptor] Start method=debug
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Current transaction in MI is null
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] TX_SUPPORTS for debug
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Thread came in with tx null
2003-06-03 15:07:00,566 TRACE [org.jboss.ejb.plugins.StatelessSessionInstancePool] Get instance org.jboss.ejb.plugins.StatelessSessionInstancePool@1f6b81c#1#class com.kiala.debugging.LogWriterSession
2003-06-03 15:07:00,566 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] old stack for key: com.kiala.debugging.LogWriterSession@b1656f
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.Connection] Connection Initializing
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.Connection] Getting the serverIL
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.Connection] serverIL=org.jboss.mq.il.jvm.JVMServerIL@7a6c34
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.Connection] Authenticating
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.Connection] Authenticating user null
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : authenticate
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.security.ServerSecurityInterceptor] Autenticating user null/null
2003-06-03 15:07:00,566 TRACE [org.jboss.security.plugins.JaasSecurityManager.jbossmq] validateCache, info=org.jboss.security.plugins.JaasSecurityManager$DomainInfo@155e0bc
2003-06-03 15:07:00,566 TRACE [org.jboss.mq.security.SecurityManager] Username: null is authenticated
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.security.SecurityManager] Adding group : class org.jboss.security.NestableGroup Roles(members:guest)
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : authenticate
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.Connection] Starting the clientIL service
2003-06-03 15:07:00,567 DEBUG [org.jboss.mq.GenericConnectionFactory] Handing out ClientIL: org.jboss.mq.il.jvm.JVMClientILService
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.Connection] Connection establishment successful
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.Connection] Checking clientID :null
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : getID
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : getID
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.Connection] Connection establishment successful
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : addMessage
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : TOPIC.debugTopic
jmsDeliveryMode : 1
jmsExpiration : 0
jmsPriority : 2
jmsMessageID : ID:48-10546456205671
jmsTimeStamp : 1054645620567
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:true
msgReadOnly : false
producerClientId: ID:48
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
}
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.security.SecurityManager] Checking authorize on subjectInfo: SubjectInfo {subject=Subject:
Principal: guest
Principal: Roles(members:guest)
;principal=null;roles=Roles(members:guest) for rolePrincipals [guest]
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.MessageCache] counter lock aquire 44
2003-06-03 15:07:00,567 TRACE [org.jboss.mq.server.MessageCache] counter lock release 44
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add lock aquire message 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add lock aquire lruCache 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add locks release44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=0.3286968
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] counter lock aquire 45
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] counter lock release 45
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add lock aquire message 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add lock aquire lruCache 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] add locks release45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] run lock aquire, validateSoftReferenceDepth
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] Memory usage serverity=0.33284178
2003-06-03 15:07:00,568 TRACE [org.jboss.mq.server.MessageCache] run lock release, validateSoftReferenceDepth
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 45 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:1.-2147483648 priority=2 hashCode=12150765 wasHard=true
2003-06-03 15:07:00,569 TRACE [org.jboss.mq.server.MessageReference] getMessage lock aquire 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire message 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent lock aquire lrucache 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.MessageCache] messageReferenceUsedEvent locks released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588 wasHard=true
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.MessageReference] getMessage lock released 44 msg=15 hard NOT_STORED NON_PERSISTENT queue=TOPIC.debugTopic.ID:3.-2147483648 priority=2 hashCode=27114588
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.SpyConnectionConsumer] SpyConnectionConsumer:TOPIC.debugTopic->addMessage(mes=org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : TOPIC.debugTopic
jmsDeliveryMode : 1
jmsExpiration : 0
jmsPriority : 2
jmsMessageID : ID:48-10546456205671
jmsTimeStamp : 1054645620567
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:false
msgReadOnly : true
producerClientId: ID:48
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
})
2003-06-03 15:07:00,570 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : receive
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : receive
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : -2147483648
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : 0
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.security.ServerSecurityInterceptor] Checking receive authorize on SpyDistributedConnection:ID:13/45910380be4bcd0ac8da0559be130b97 subId=-2147483648
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.security.SecurityManager] Checking authorize on subjectInfo: SubjectInfo {subject=Subject:
Principal: Roles(members:guest)
;principal=null;roles=Roles(members:guest) for rolePrincipals [guest]
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.TracingInterceptor] RETURN : receive
2003-06-03 15:07:00,571 TRACE [org.jboss.jms.asf.StdServerSessionPool] getting a server session
2003-06-03 15:07:00,571 TRACE [org.jboss.jms.asf.StdServerSessionPool] using server session: org.jboss.jms.asf.StdServerSession@26d560
2003-06-03 15:07:00,571 TRACE [org.jboss.jms.asf.StdServerSession] starting invokes on server session
2003-06-03 15:07:00,571 TRACE [org.jboss.mq.server.TracingInterceptor] CALLED : receive
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : -2147483648
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.server.TracingInterceptor] ARG : -1
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.security.ServerSecurityInterceptor] Checking receive authorize on SpyDistributedConnection:ID:3/ff634b50cbe946917e2909ddd7f005aa subId=-2147483648
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.security.SecurityManager] Checking authorize on subjectInfo: SubjectInfo {subject=Subject:
Principal: Roles(members:guest)
;principal=null;roles=Roles(members:guest) for rolePrincipals [guest]
2003-06-03 15:07:00,572 TRACE [org.jboss.jms.asf.StdServerSession] running...
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpyXAResourceManager] Starting tx with new xid=-9223372036854775793
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpySession] setting current tx id: -9223372036854775793, previous: null
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpyXAResourceManager] Ack'ing message xid=-9223372036854775793
2003-06-03 15:07:00,572 TRACE [org.jboss.jms.asf.StdServerSession] onMessage running (pool, session, xaSession, useLocalTX): , org.jboss.mq.SpyTopicSession@8bfdea, org.jboss.mq.SpyTopicSession@8bfdea, true
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpyXAResource] Start xid=XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//569, BranchQual=], flags=0
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpyXAResourceManager] Converting tx anonXid=-9223372036854775793, xid=XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//569, BranchQual=]
2003-06-03 15:07:00,572 TRACE [org.jboss.mq.SpySession] setting current tx id: XidImpl [FormatId=257, GlobalId=biohazard.dev.kiala.com//569, BranchQual=], previous: -9223372036854775793
2003-06-03 15:07:00,572 TRACE [org.jboss.jms.asf.StdServerSession] Using optimized 1p commit to control TX.
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.jms.JMSContainerInvoker] processing message: org.jboss.mq.SpyTextMessage {
Header {
jmsDestination : TOPIC.debugTopic
jmsDeliveryMode : 1
jmsExpiration : 0
jmsPriority : 2
jmsMessageID : ID:48-10546456205671
jmsTimeStamp : 1054645620567
jmsCorrelationID: null
jmsReplyTo : null
jmsType : null
jmsRedelivered : false
jmsPropertiesReadWrite:false
msgReadOnly : true
producerClientId: ID:48
}
Body {
text :<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE create-parcel PUBLIC "-//Kiala SA//DTD Create Parcel 0.0.1//EN" "http://dtd.kiala.com/create-parcel_0_0_1.dtd">
<create-parcel>
<dsp-parcel-id>LOAD1</dsp-parcel-id>
BARLOAD1
Customer 1
<cod-amount currency="EUR">11.11</cod-amount>
<expected-delivery-date>2003-05-16 10:00:00</expected-delivery-date>
<process-id>1</process-id>
</create-parcel>
}
}
2003-06-03 15:07:00,572 TRACE [org.jboss.util.TCLStack] Setting TCL to java.net.URLClassLoader@725967; pushing java.net.URLClassLoader@725967
2003-06-03 15:07:00,572 TRACE [org.jboss.util.TCLStack] Stack: [java.net.URLClassLoader@725967]
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.ProxyFactoryFinderInterceptor] invokerBInding is null in ProxyFactoryFinder
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.LogInterceptor] Start method=onMessage
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Current transaction in MI is null
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] TX_NOT_SUPPORTED for onMessage
2003-06-03 15:07:00,572 TRACE [org.jboss.ejb.plugins.TxInterceptorCMT] Thread came in with tx null
2003-06-03 15:07:00,573 TRACE [org.jboss.ejb.plugins.MessageDrivenInstancePool] Get instance org.jboss.ejb.plugins.MessageDrivenInstancePool@1da8fc#1#class com.kiala.debugging.Debug2LogfileMessageBean
2003-06-03 15:07:00,573 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] new stack for key: com.kiala.debugging.Debug2LogfileMessageBean@14174f9
2003-06-03 15:07:00,578 TRACE [org.jboss.resource.connectionmanager.CachedConnectionManager] popped object: org.jboss.resource.connectionmanager.CachedConnectionManager$KeyConnectionAssociation@14174f9
2003-06-03 15:07:00,578 TRACE [org.jboss.ejb.plugins.MessageDrivenInstancePool] 0/100 Free instance:org.jboss.ejb.plugins.MessageDrivenInstancePool@1da8fc#null#null#true#class com.kiala.debugging.Debug2LogfileMessageBean
2003-06-03 15:07:00,578 TRACE [org.jboss.ejb.plugins.LogInterceptor] End method=onMessage