Greetings!
After my web application starts up, an initial message send to queue does
not get cosume by the consumer. However, subsequent messages sent to the
queue are consumed by the consumer. Has anyone experience a similar problem?
If so, how did you resolve it? So far, I have not recieved any errors
indicating that something is wrong.
The following is a snippet of my log file:
<Sending: WireFormatInfo { version=2,
properties={TightEncodingEnabled=true, CacheSize=1024,
TcpNoDelayEnabled=true, SizePrefixDisabled=false, StackTr
aceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true},
magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:05:29,438 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Received WireFormat:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=fa
lse, StackTraceEnabled=true, MaxInactivityDuration=30000,
CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:05:29,701 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Sending:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=false, StackTr
aceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true},
magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:05:29,746 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp:///127.0.0.1:40915 before negotiation: OpenWireFormat{version=2,
cacheEnabled=false, stackTraceEnabled=false, tightEncodingEnabled=false,
sizePre
fixDisabled=false}>
2006-12-18 13:05:29,746 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp:///127.0.0.1:40915 after negotiation: OpenWireFormat{version=2,
cacheEnabled=true, stackTraceEnabled=true, tightEncodingEnabled=true,
sizePrefixD
isabled=false}>
2006-12-18 13:05:29,748 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Received WireFormat:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=fa
lse, StackTraceEnabled=true, MaxInactivityDuration=30000,
CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:05:29,748 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp://localhost/127.0.0.1:51616 before negotiation:
OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
tightEncodingEnabled=false
, sizePrefixDisabled=false}>
2006-12-18 13:05:29,748 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp://localhost/127.0.0.1:51616 after negotiation:
OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
tightEncodingEnabled=true, si
zePrefixDisabled=false}>
2006-12-18 13:05:29,751 DEBUG
[org.apache.activemq.broker.TransportConnection] - <Setting up new
connection: [EMAIL PROTECTED]>
2006-12-18 13:05:29,769 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
topic://ActiveMQ.Advisory.Connection>
2006-12-18 13:05:30,804 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
topic://ActiveMQ.Advisory.Topic>
2006-12-18 13:05:30,810 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding consumer:
ID:localhost.localdomain-52061-1166475923445-3:0:-1:1>
2006-12-18 13:05:31,002 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding consumer:
ID:localhost.localdomain-52061-1166475923445-3:0:-1:2>
2006-12-18 13:05:31,003 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
queue://com.phoenix.queue.Invitation>
2006-12-18 13:05:31,016 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
topic://ActiveMQ.Advisory.Queue>
2006-12-18 13:05:31,022 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
topic://ActiveMQ.Advisory.Consumer.Queue.com.phoenix.queue.Invitation>
2006-12-18 13:15:16,289 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Sending:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=false, StackTr
aceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true},
magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:15:16,290 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Sending:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=false, StackTr
aceEnabled=true, MaxInactivityDuration=30000, CacheEnabled=true},
magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:15:16,302 DEBUG [org.apache.activemq.TransactionContext] -
<Start:
[globalId=10000000ffffffee3dffffffee147f001000000000000000000000000000000000000000000000000,branchId=20000000ffffffee3dffffffee147f00100000000000000000000
0000000000000000000000000000]>
2006-12-18 13:15:16,304 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Received WireFormat:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=fa
lse, StackTraceEnabled=true, MaxInactivityDuration=30000,
CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:15:16,304 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp:///127.0.0.1:39877 before negotiation: OpenWireFormat{version=2,
cacheEnabled=false, stackTraceEnabled=false, tightEncodingEnabled=false,
sizePre
fixDisabled=false}>
2006-12-18 13:15:16,304 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp:///127.0.0.1:39877 after negotiation: OpenWireFormat{version=2,
cacheEnabled=true, stackTraceEnabled=true, tightEncodingEnabled=true,
sizePrefixD
isabled=false}>
2006-12-18 13:15:16,305 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] - <Received WireFormat:
WireFormatInfo { version=2, properties={TightEncodingEnabled=true,
CacheSize=1024, TcpNoDelayEnabled=true, SizePrefixDisabled=fa
lse, StackTraceEnabled=true, MaxInactivityDuration=30000,
CacheEnabled=true}, magic=[A,c,t,i,v,e,M,Q]}>
2006-12-18 13:15:16,305 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp://localhost/127.0.0.1:51616 before negotiation:
OpenWireFormat{version=2, cacheEnabled=false, stackTraceEnabled=false,
tightEncodingEnabled=false
, sizePrefixDisabled=false}>
2006-12-18 13:15:16,305 DEBUG
[org.apache.activemq.transport.WireFormatNegotiator] -
<tcp://localhost/127.0.0.1:51616 after negotiation:
OpenWireFormat{version=2, cacheEnabled=true, stackTraceEnabled=true,
tightEncodingEnabled=true, si
zePrefixDisabled=false}>
2006-12-18 13:15:16,306 DEBUG
[org.apache.activemq.broker.TransportConnection] - <Setting up new
connection: [EMAIL PROTECTED]>
2006-12-18 13:15:16,308 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding consumer:
ID:localhost.localdomain-52061-1166475923445-3:1:-1:1>
2006-12-18 13:15:16,318 DEBUG [org.apache.activemq.TransactionContext] -
<Started XA transaction:
XID:1197822575:0100000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
000000:0200000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000>
2006-12-18 13:15:16,388 DEBUG
[org.springframework.transaction.support.TransactionSynchronizationManager]
- <Bound value
[EMAIL PROTECTED] for key
[org.apache.activemq.ra.ActiveMQConnection
[EMAIL PROTECTED] to thread [http-8443-Processor25]>
2006-12-18 13:15:16,410 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Adding destination:
topic://ActiveMQ.Advisory.Producer.Queue.com.phoenix.queue.Invitation>
2006-12-18 13:15:16,436 DEBUG [org.springframework.jms.core.JmsTemplate] -
<Sending created message [ActiveMQObjectMessage {commandId = 0,
responseRequired = false, messageId = null, originalDestination = null,
originalTransactionId =
null, producerId = null, destination = null, transactionId = null,
expiration = 0, timestamp = 0, arrival = 0, correlationId = null, replyTo =
null, persistent = false, type = null, priority = 0, groupID = null,
groupSequence = 0, targ
etConsumerId = null, compressed = false, userID = null, content =
[EMAIL PROTECTED], marshalledProperties = null,
dataStructure = null, redeliveryCounter = 0, size = 0, properties = null,
readOnlyProperties
= false, readOnlyBody = false, droppable = false}]>
2006-12-18 13:15:16,448 DEBUG [org.apache.activemq.ActiveMQSession] -
<Sending message: ActiveMQObjectMessage {commandId = 0, responseRequired =
false, messageId = ID:localhost.localdomain-52061-1166475923445-3:1:1:1:1,
originalDestina
tion = null, originalTransactionId = null, producerId =
ID:localhost.localdomain-52061-1166475923445-3:1:1:1, destination =
queue://com.phoenix.queue.Invitation, transactionId =
XID:1197822575:0100000000000000ee3dee147f0000010000000000
00000000000000000000000000000000000000000000000000000000000000000000000000000000000000:0200000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000,
expiration = 0, ti
mestamp = 1166476516437, arrival = 0, correlationId = null, replyTo = null,
persistent = true, type = null, priority = 4, groupID = null, groupSequence
= 0, targetConsumerId = null, compressed = false, userID = null, content =
org.apac
[EMAIL PROTECTED], marshalledProperties = null,
dataStructure = null, redeliveryCounter = 0, size = 0, properties = null,
readOnlyProperties = true, readOnlyBody = true, droppable = false}>
2006-12-18 13:15:16,620 DEBUG
[org.springframework.transaction.support.TransactionSynchronizationManager]
- <Removed value
[EMAIL PROTECTED] for key
[org.apache.activemq.ra.ActiveMQConnecti
[EMAIL PROTECTED] from thread [http-8443-Processor25]>
2006-12-18 13:15:16,623 DEBUG [org.apache.activemq.TransactionContext] -
<End:
[globalId=10000000ffffffee3dffffffee147f001000000000000000000000000000000000000000000000000,branchId=20000000ffffffee3dffffffee147f0010000000000000000000000
00000000000000000000000000]>
2006-12-18 13:15:16,624 DEBUG [org.apache.activemq.TransactionContext] -
<Ended XA transaction:
XID:1197822575:0100000000000000ee3dee147f00000100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
0000:0200000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000>
2006-12-18 13:15:16,625 DEBUG [org.apache.activemq.TransactionContext] -
<Prepare:
[globalId=10000000ffffffee3dffffffee147f001000000000000000000000000000000000000000000000000,branchId=20000000ffffffee3dffffffee147f001000000000000000000
000000000000000000000000000000]>
2006-12-18 13:15:16,626 DEBUG
[org.apache.activemq.transaction.XATransaction] - <XA Transaction prepare:
XID:1197822575:0100000000000000ee3dee147f00000100000000000000000000000000000000000000000000000000000000000000000000000000000000000
0000000000000:0200000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000>
2006-12-18 13:15:16,845 DEBUG [org.apache.activemq.TransactionContext] -
<Commit:
[globalId=10000000ffffffee3dffffffee147f001000000000000000000000000000000000000000000000000,branchId=20000000ffffffee3dffffffee147f0010000000000000000000
00000000000000000000000000000]>
2006-12-18 13:15:16,845 DEBUG
[org.apache.activemq.transaction.XATransaction] - <XA Transaction commit:
XID:1197822575:0100000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000
000000000000:0200000000000000ee3dee147f000001000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000>
2006-12-18 13:15:16,849 DEBUG [org.apache.activemq.ra.ServerSessionPoolImpl]
- <ServerSession requested.>
2006-12-18 13:15:16,853 DEBUG
[org.apache.activemq.broker.region.AbstractRegion] - <Removing consumer:
ID:localhost.localdomain-52061-1166475923445-3:1:-1:1>
2006-12-18 13:15:16,871 DEBUG [org.apache.activemq.ra.ServerSessionPoolImpl]
- <Created a new session: ServerSessionImpl:0>
2006-12-18 13:15:16,872 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Starting run.>
2006-12-18 13:15:16,873 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Work accepted:
[EMAIL PROTECTED]>
2006-12-18 13:15:16,874 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Work started: javax.resource.spi.work.WorkEvent[source=Work
:ServerSessionImpl:0]>
2006-12-18 13:15:16,874 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Running>
2006-12-18 13:15:16,874 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<run loop start>
2006-12-18 13:15:16,875 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<run loop end>
2006-12-18 13:15:16,875 DEBUG [org.apache.activemq.ra.ServerSessionPoolImpl]
- <Session returned to pool: ServerSessionImpl:0>
2006-12-18 13:15:16,875 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Run finished>
2006-12-18 13:15:16,875 DEBUG [org.apache.activemq.ra.ServerSessionImpl:0] -
<Work completed: javax.resource.spi.work.WorkEvent[source=Work
:ServerSessionImpl:0]>
Thanks inadvance,
Curtney
--
View this message in context:
http://www.nabble.com/Initial-Message-Sent-to-Queue-Not-Consumed-tf2842705.html#a7937553
Sent from the jencks - user mailing list archive at Nabble.com.
---------------------------------------------------------------------
To unsubscribe from this list please visit:
http://xircles.codehaus.org/manage_email
