qpid-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Keith W <keith.w...@gmail.com>
Subject Re: [Java Broker- 6.0.1] AMQP random errors when sending messages using Proton-c 0.12.2
Date Mon, 08 Aug 2016 09:55:44 GMT
Adel,


On 8 August 2016 at 09:23, Adel Boutros <adelboutros@live.com> wrote:
>
> It seems the Broker is sending "null" message and the client is unable to decode it as
it excepts something else like "AMQP". Do you know why?
>
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x0e\x02\x00\x00\x00\x00S\x18\xc0\x01\x00
> 2016-08-08 09:57:31,567 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:57:31,567 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:57:46,582 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:57:46,582 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:01,597 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:01,597 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:16,612 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:16,612 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:31,627 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:31,627 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
>

If you are referring to connection using ephemeral 48430, the
frequency of those empty frames makes me suspect the Broker believes
connection idle.  It send them to keep the connection alive.  This is
normal behaviour.

http://docs.oasis-open.org/amqp/core/v1.0/os/amqp-core-transport-v1.0-os.html#doc-doc-idle-time-out

You can see from earlier in the log that the connection sent/received
a Disposition, so we know this connection is well beyond the AMQP
negotiation stage.

> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (FRM) - RECV[/10.25.6.48:48430|1]
: Disposition{role=receiver,first=12328,last=12328,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|1]
: Disposition{role=sender,first=12328,last=12328,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x1e\x02\x00\x00\x01\x00S\x15\xc0\x11\x05Bp\x00\x000(p\x00\x000(A\x00S$E

(snip)

I don't think ephemeral 48430 corresponds to the following client side
activity.

> [0x24cb620]:  -> AMQP
> [0x24cb620]:0 -> @open(16) [container-id="4ecb736a-44a4-4c6a-9a68-2d2018f60c13", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb620]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb620]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb620]:0 -> @close(24) [error=@error(29) [condition=:"amqp:connection:framing-error",
description="AMQP header mismatch: Insufficient data to determine protocol [''] (connection
aborted)"]]
> [0x24cb620]:  <- EOS

It looks like the client pipelined an open but the stream was closed.
Now the Broker will close connections that it believes don't send the
protocol header in time, producing a log message "CON-1003 : Closed
due to inactivity" as it does so. There was a defect in the feature
QPID-7033 which was fixed in 6.0.2 which meant that connections could
be unfairly closed.  Do you see CON-1003s in the logs.  I suggest you
try upgrading to 6.0.4 and repeat the test.

Kind regards Keith




We don't see container id  4ecb736a-44a4-4c6a-9a68-2d2018f60c13



> last couple lines of Broker logs where error occurs
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - RECV[/10.25.6.48:38759]
: AMQP\x00\x01\x00\x00
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - RECV[/10.25.6.48:38759]
: \x00\x00\x00Z\x02\x00\x00\x00\x00S\x10\xd0\x00\x00\x00J\x00\x00\x00\x0a\xa1$1a8dd705-8a2b-4a58-bf0b-8e73f3ea2152\xa1\x10dell445srv:10455@`\x7f\xffp*\x05\xf1\xff@@@@@\x00\x00\x00!\x02\x00\x00\x00\x00S\x11\xd0\x00\x00\x00\x11\x00\x00\x00\x04@R\x00p\x7f\xff\xff\xffp\x7f\xff\xff\xff\x00\x00\x00]\x02\x00\x00\x00\x00S\x12\xd0\x00\x00\x00M\x00\x00\x00\x0a\xa1\x031/1R\x00BP\x02P\x00\x00S(\xd0\x00\x00\x00\x11\x00\x00\x00\x0b@R\x00@R\x00B@@@@@@\x00S)\xd0\x00\x00\x00\x18\x00\x00\x00\x07\xa1\x0aperf.topicR\x00@R\x00B@@@@R\x00
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Open{containerId=1a8dd705-8a2b-4a58-bf0b-8e73f3ea2152,hostname=dell445srv:10455,channelMax=32767,idleTimeOut=705032703}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Open{containerId=5c480e45-a289-4c16-947b-f352419370af,maxFrameSize=32768,channelMax=255,idleTimeOut=0,properties={product=qpid,
version=6.0.1, qpid.build=1731621, qpid.instance_name=Broker}}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00\x95\x02\x00\x00\x00\x00S\x10\xc0\x88\x0a\xa1$5c480e45-a289-4c16-947b-f352419370af@p\x00\x00\x80\x00`\x00\xffC@@@@\xc1Q\x08\xa3\x07product\xa1\x04qpid\xa3\x07version\xa1\x056.0.1\xa3\x0aqpid.build\xa1\x071731621\xa3\x12qpid.instance_name\xa1\x06Broker
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Begin{nextOutgoingId=0,incomingWindow=2147483647,outgoingWindow=2147483647}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Begin{remoteChannel=0,nextOutgoingId=0,incomingWindow=2048,outgoingWindow=2048}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00\x1c\x02\x00\x00\x00\x00S\x11\xc0\x0f\x04`\x00\x00Cp\x00\x00\x08\x00p\x00\x00\x08\x00
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Attach{name=1/1,handle=0,role=sender,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false},initialDeliveryCount=0}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Attach{name=1/1,handle=0,role=receiver,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false}}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00:\x02\x00\x00\x00\x00S\x12\xc0-\x07\xa1\x031/1CAP\x02P\x00\x00S(\xc0\x06\x05@C@CB\x00S)\xc0\x11\x05\xa1\x0aperf.topicC@CB
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Flow{nextIncomingId=0,incomingWindow=2048,nextOutgoingId=0,outgoingWindow=2048,handle=0,deliveryCount=0,linkCredit=20000,echo=false}
> 2016-08-08 09:57:16,550 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00$\x02\x00\x00\x00\x00S\x13\xc0\x17\x0aCp\x00\x00\x08\x00Cp\x00\x00\x08\x00CCp\x00\x00N
@@B
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (RAW) - RECV[/10.25.6.48:38759]
: \x00\x00\x01(\x02\x00\x00\x00\x00S\x14\xd0\x00\x00\x00\x18\x00\x00\x00\x08R\x00R\x00\xa0\x08\xe7\x90\x00\x00\x00\x00\x00\x00R\x00BB@@\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00G\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xa7\xa1\x10ValidationStatus\xa1\x09VALIDATED\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x02\x00\x00\x00\x00S\x16\xd0\x00\x00\x00\x08\x00\x00\x00\x03R\x00A@\x00\x00\x00\x15\x02\x00\x00\x00\x00S\x18\xd0\x00\x00\x00\x05\x00\x00\x00\x01@
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Transfer{handle=0,deliveryId=0,deliveryTag=\xe7\x90\x00\x00\x00\x00\x00\x00,messageFormat=0,settled=false,more=false}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Disposition{role=receiver,first=0,last=0,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|1]
: Transfer{handle=0,deliveryId=12328,deliveryTag=\x00\x00\x00\x00\x00\x000(,messageFormat=0}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00\x16\x02\x00\x00\x00\x00S\x15\xc0\x09\x05ACCA\x00S$E
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00\x10\x02\x00\x00\x00\x00S\x16\xc0\x03\x02CA
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - RECV[/10.25.6.48:38759|0]
: Close{}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (FRM) - SEND[/10.25.6.48:38759|0]
: Close{}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:38759] (RAW) - SEND[/10.25.6.48:38759]
: \x00\x00\x00\x0e\x02\x00\x00\x00\x00S\x18\xc0\x01\x00
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x01\x1f\x02\x00\x00\x01\x00S\x14\xc0\x12\x04Cp\x00\x000(\xa0\x08\x00\x00\x00\x00\x00\x000(C\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00G\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xa7\xa1\x10ValidationStatus\xa1\x09VALIDATED\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (RAW) - RECV[/10.25.6.48:48430]
: \x00\x00\x00\x1e\x02\x00\x00\x01\x00S\x15\xc0\x11\x05Ap\x00\x000(p\x00\x000(A\x00S$E
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (FRM) - RECV[/10.25.6.48:48430|1]
: Disposition{role=receiver,first=12328,last=12328,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|1]
: Disposition{role=sender,first=12328,last=12328,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,551 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x1e\x02\x00\x00\x01\x00S\x15\xc0\x11\x05Bp\x00\x000(p\x00\x000(A\x00S$E
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - RECV[/10.25.6.48:38760]
: AMQP\x00\x01\x00\x00
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - RECV[/10.25.6.48:38760]
: \x00\x00\x00Z\x02\x00\x00\x00\x00S\x10\xd0\x00\x00\x00J\x00\x00\x00\x0a\xa1$7b4afe62-9a41-4a54-9b84-b5413534b249\xa1\x10dell445srv:10455@`\x7f\xffp*\x05\xf1\xff@@@@@\x00\x00\x00!\x02\x00\x00\x00\x00S\x11\xd0\x00\x00\x00\x11\x00\x00\x00\x04@R\x00p\x7f\xff\xff\xffp\x7f\xff\xff\xff\x00\x00\x00]\x02\x00\x00\x00\x00S\x12\xd0\x00\x00\x00M\x00\x00\x00\x0a\xa1\x031/1R\x00BP\x02P\x00\x00S(\xd0\x00\x00\x00\x11\x00\x00\x00\x0b@R\x00@R\x00B@@@@@@\x00S)\xd0\x00\x00\x00\x18\x00\x00\x00\x07\xa1\x0aperf.topicR\x00@R\x00B@@@@R\x00
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Open{containerId=7b4afe62-9a41-4a54-9b84-b5413534b249,hostname=dell445srv:10455,channelMax=32767,idleTimeOut=705032703}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Open{containerId=5c480e45-a289-4c16-947b-f352419370af,maxFrameSize=32768,channelMax=255,idleTimeOut=0,properties={product=qpid,
version=6.0.1, qpid.build=1731621, qpid.instance_name=Broker}}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00\x95\x02\x00\x00\x00\x00S\x10\xc0\x88\x0a\xa1$5c480e45-a289-4c16-947b-f352419370af@p\x00\x00\x80\x00`\x00\xffC@@@@\xc1Q\x08\xa3\x07product\xa1\x04qpid\xa3\x07version\xa1\x056.0.1\xa3\x0aqpid.build\xa1\x071731621\xa3\x12qpid.instance_name\xa1\x06Broker
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Begin{nextOutgoingId=0,incomingWindow=2147483647,outgoingWindow=2147483647}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Begin{remoteChannel=0,nextOutgoingId=0,incomingWindow=2048,outgoingWindow=2048}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00\x1c\x02\x00\x00\x00\x00S\x11\xc0\x0f\x04`\x00\x00Cp\x00\x00\x08\x00p\x00\x00\x08\x00
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Attach{name=1/1,handle=0,role=sender,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false},initialDeliveryCount=0}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Attach{name=1/1,handle=0,role=receiver,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false}}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00:\x02\x00\x00\x00\x00S\x12\xc0-\x07\xa1\x031/1CAP\x02P\x00\x00S(\xc0\x06\x05@C@CB\x00S)\xc0\x11\x05\xa1\x0aperf.topicC@CB
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Flow{nextIncomingId=0,incomingWindow=2048,nextOutgoingId=0,outgoingWindow=2048,handle=0,deliveryCount=0,linkCredit=20000,echo=false}
> 2016-08-08 09:57:16,553 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00$\x02\x00\x00\x00\x00S\x13\xc0\x17\x0aCp\x00\x00\x08\x00Cp\x00\x00\x08\x00CCp\x00\x00N
@@B
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (RAW) - RECV[/10.25.6.48:38760]
: \x00\x00\x01'\x02\x00\x00\x00\x00S\x14\xd0\x00\x00\x00\x18\x00\x00\x00\x08R\x00R\x00\xa0\x08\xe9\x90\x00\x00\x00\x00\x00\x00R\x00BB@@\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00F\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xaa\xa1\x10ValidationStatus\xa1\x08IN_ERROR\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x02\x00\x00\x00\x00S\x16\xd0\x00\x00\x00\x08\x00\x00\x00\x03R\x00A@\x00\x00\x00\x15\x02\x00\x00\x00\x00S\x18\xd0\x00\x00\x00\x05\x00\x00\x00\x01@
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Transfer{handle=0,deliveryId=0,deliveryTag=\xe9\x90\x00\x00\x00\x00\x00\x00,messageFormat=0,settled=false,more=false}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Disposition{role=receiver,first=0,last=0,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00\x16\x02\x00\x00\x00\x00S\x15\xc0\x09\x05ACCA\x00S$E
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00\x10\x02\x00\x00\x00\x00S\x16\xc0\x03\x02CA
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - RECV[/10.25.6.48:38760|0]
: Close{}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (FRM) - SEND[/10.25.6.48:38760|0]
: Close{}
> 2016-08-08 09:57:16,554 DEBUG [IO-/10.25.6.48:38760] (RAW) - SEND[/10.25.6.48:38760]
: \x00\x00\x00\x0e\x02\x00\x00\x00\x00S\x18\xc0\x01\x00
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (RAW) - RECV[/10.25.6.48:38761]
: AMQP\x00\x01\x00\x00
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (RAW) - RECV[/10.25.6.48:38761]
: \x00\x00\x00Z\x02\x00\x00\x00\x00S\x10\xd0\x00\x00\x00J\x00\x00\x00\x0a\xa1$88202c18-54f3-4463-924d-842ea1cc9466\xa1\x10dell445srv:10455@`\x7f\xffp*\x05\xf1\xff@@@@@\x00\x00\x00!\x02\x00\x00\x00\x00S\x11\xd0\x00\x00\x00\x11\x00\x00\x00\x04@R\x00p\x7f\xff\xff\xffp\x7f\xff\xff\xff\x00\x00\x00]\x02\x00\x00\x00\x00S\x12\xd0\x00\x00\x00M\x00\x00\x00\x0a\xa1\x031/1R\x00BP\x02P\x00\x00S(\xd0\x00\x00\x00\x11\x00\x00\x00\x0b@R\x00@R\x00B@@@@@@\x00S)\xd0\x00\x00\x00\x18\x00\x00\x00\x07\xa1\x0aperf.topicR\x00@R\x00B@@@@R\x00
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Open{containerId=88202c18-54f3-4463-924d-842ea1cc9466,hostname=dell445srv:10455,channelMax=32767,idleTimeOut=705032703}
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Open{containerId=5c480e45-a289-4c16-947b-f352419370af,maxFrameSize=32768,channelMax=255,idleTimeOut=0,properties={product=qpid,
version=6.0.1, qpid.build=1731621, qpid.instance_name=Broker}}
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x95\x02\x00\x00\x00\x00S\x10\xc0\x88\x0a\xa1$5c480e45-a289-4c16-947b-f352419370af@p\x00\x00\x80\x00`\x00\xffC@@@@\xc1Q\x08\xa3\x07product\xa1\x04qpid\xa3\x07version\xa1\x056.0.1\xa3\x0aqpid.build\xa1\x071731621\xa3\x12qpid.instance_name\xa1\x06Broker
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Begin{nextOutgoingId=0,incomingWindow=2147483647,outgoingWindow=2147483647}
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Begin{remoteChannel=0,nextOutgoingId=0,incomingWindow=2048,outgoingWindow=2048}
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x1c\x02\x00\x00\x00\x00S\x11\xc0\x0f\x04`\x00\x00Cp\x00\x00\x08\x00p\x00\x00\x08\x00
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Attach{name=1/1,handle=0,role=sender,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false},initialDeliveryCount=0}
> 2016-08-08 09:57:16,556 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Attach{name=1/1,handle=0,role=receiver,sndSettleMode=mixed,rcvSettleMode=first,source=Source{durable=none,timeout=0,dynamic=false},target=Target{address=perf.topic,durable=none,timeout=0,dynamic=false}}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00:\x02\x00\x00\x00\x00S\x12\xc0-\x07\xa1\x031/1CAP\x02P\x00\x00S(\xc0\x06\x05@C@CB\x00S)\xc0\x11\x05\xa1\x0aperf.topicC@CB
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Flow{nextIncomingId=0,incomingWindow=2048,nextOutgoingId=0,outgoingWindow=2048,handle=0,deliveryCount=0,linkCredit=20000,echo=false}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00$\x02\x00\x00\x00\x00S\x13\xc0\x17\x0aCp\x00\x00\x08\x00Cp\x00\x00\x08\x00CCp\x00\x00N
@@B
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - RECV[/10.25.6.48:38761]
: \x00\x00\x01'\x02\x00\x00\x00\x00S\x14\xd0\x00\x00\x00\x18\x00\x00\x00\x08R\x00R\x00\xa0\x08\xeb\x90\x00\x00\x00\x00\x00\x00R\x00BB@@\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00F\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xac\xa1\x10ValidationStatus\xa1\x08IN_ERROR\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x02\x00\x00\x00\x00S\x16\xd0\x00\x00\x00\x08\x00\x00\x00\x03R\x00A@\x00\x00\x00\x15\x02\x00\x00\x00\x00S\x18\xd0\x00\x00\x00\x05\x00\x00\x00\x01@
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Transfer{handle=0,deliveryId=0,deliveryTag=\xeb\x90\x00\x00\x00\x00\x00\x00,messageFormat=0,settled=false,more=false}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Disposition{role=receiver,first=0,last=0,settled=true,state=Accepted{}}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x16\x02\x00\x00\x00\x00S\x15\xc0\x09\x05ACCA\x00S$E
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Detach{handle=0,closed=true}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x10\x02\x00\x00\x00\x00S\x16\xc0\x03\x02CA
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - RECV[/10.25.6.48:38761|0]
: Close{}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (FRM) - SEND[/10.25.6.48:38761|0]
: Close{}
> 2016-08-08 09:57:16,557 DEBUG [IO-/10.25.6.48:38761] (RAW) - SEND[/10.25.6.48:38761]
: \x00\x00\x00\x0e\x02\x00\x00\x00\x00S\x18\xc0\x01\x00
> 2016-08-08 09:57:31,567 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:57:31,567 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:57:46,582 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:57:46,582 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:01,597 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:01,597 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:16,612 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:16,612 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
> 2016-08-08 09:58:31,627 DEBUG [IO-/10.25.6.48:48430] (FRM) - SEND[/10.25.6.48:48430|0]
: null
> 2016-08-08 09:58:31,627 DEBUG [IO-/10.25.6.48:48430] (RAW) - SEND[/10.25.6.48:48430]
: \x00\x00\x00\x08\x02\x00\x00\x00
>
> last couple lines of Client logs where error occurs
> [0x24cb620]:  -> AMQP
> [0x24cb620]:0 -> @open(16) [container-id="e025d61c-2e7a-413c-ab7c-8c173a9b407b", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb620]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb620]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb620]:  <- AMQP
> [0x24cb620]:0 <- @open(16) [container-id="5c480e45-a289-4c16-947b-f352419370af", max-frame-size=32768,
channel-max=255, idle-time-out=0, properties={:product="qpid", :version="6.0.1", :"qpid.build"="1731621",
:"qpid.instance_name"="Broker"}]
> [0x24cb620]:0 <- @begin(17) [remote-channel=0, next-outgoing-id=0, incoming-window=2048,
outgoing-window=2048]
> [0x24cb620]:0 <- @attach(18) [name="1/1", handle=0, role=true, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false]]
> [0x24cb620]:0 <- @flow(19) [next-incoming-id=0, incoming-window=2048, next-outgoing-id=0,
outgoing-window=2048, handle=0, delivery-count=0, link-credit=20000, echo=false]
> [0x24cb620]:0 -> @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"\xe5\x90\x00\x00\x00\x00\x00\x00",
message-format=0, settled=false, more=false] (256) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00G\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xa5\xa1\x10ValidationStatus\xa1\x09VALIDATED\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"
> [0x24cb620]:0 -> @detach(22) [handle=0, closed=true]
> [0x24cb620]:0 -> @close(24) []
> [0x24cb620]:  -> EOS
> [0x24cb620]:0 <- @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36)
[]]
> [0x24cb620]:0 <- @detach(22) [handle=0, closed=true]
> [0x24cb620]:0 <- @close(24) []
> [0x24cb620]:  <- EOS
> [0x24cb730]:  -> AMQP
> [0x24cb730]:0 -> @open(16) [container-id="1a8dd705-8a2b-4a58-bf0b-8e73f3ea2152", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb730]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb730]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb730]:  <- AMQP
> [0x24cb730]:0 <- @open(16) [container-id="5c480e45-a289-4c16-947b-f352419370af", max-frame-size=32768,
channel-max=255, idle-time-out=0, properties={:product="qpid", :version="6.0.1", :"qpid.build"="1731621",
:"qpid.instance_name"="Broker"}]
> [0x24cb730]:0 <- @begin(17) [remote-channel=0, next-outgoing-id=0, incoming-window=2048,
outgoing-window=2048]
> [0x24cb730]:0 <- @attach(18) [name="1/1", handle=0, role=true, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false]]
> [0x24cb730]:0 <- @flow(19) [next-incoming-id=0, incoming-window=2048, next-outgoing-id=0,
outgoing-window=2048, handle=0, delivery-count=0, link-credit=20000, echo=false]
> [0x24cb730]:0 -> @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"\xe7\x90\x00\x00\x00\x00\x00\x00",
message-format=0, settled=false, more=false] (256) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00G\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xa7\xa1\x10ValidationStatus\xa1\x09VALIDATED\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"
> [0x24cb730]:0 -> @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 -> @close(24) []
> [0x24cb730]:  -> EOS
> [0x24cb730]:0 <- @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36)
[]]
> [0x24cb730]:0 <- @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 <- @close(24) []
> [0x24cb730]:  <- EOS
> [0x24cb730]:  -> AMQP
> [0x24cb730]:0 -> @open(16) [container-id="7b4afe62-9a41-4a54-9b84-b5413534b249", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb730]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb730]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb730]:  <- AMQP
> [0x24cb730]:0 <- @open(16) [container-id="5c480e45-a289-4c16-947b-f352419370af", max-frame-size=32768,
channel-max=255, idle-time-out=0, properties={:product="qpid", :version="6.0.1", :"qpid.build"="1731621",
:"qpid.instance_name"="Broker"}]
> [0x24cb730]:0 <- @begin(17) [remote-channel=0, next-outgoing-id=0, incoming-window=2048,
outgoing-window=2048]
> [0x24cb730]:0 <- @attach(18) [name="1/1", handle=0, role=true, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false]]
> [0x24cb730]:0 <- @flow(19) [next-incoming-id=0, incoming-window=2048, next-outgoing-id=0,
outgoing-window=2048, handle=0, delivery-count=0, link-credit=20000, echo=false]
> [0x24cb730]:0 -> @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"\xe9\x90\x00\x00\x00\x00\x00\x00",
message-format=0, settled=false, more=false] (255) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00F\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xaa\xa1\x10ValidationStatus\xa1\x08IN_ERROR\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"
> [0x24cb730]:0 -> @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 -> @close(24) []
> [0x24cb730]:  -> EOS
> [0x24cb730]:0 <- @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36)
[]]
> [0x24cb730]:0 <- @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 <- @close(24) []
> [0x24cb730]:  <- EOS
> [0x24cb730]:  -> AMQP
> [0x24cb730]:0 -> @open(16) [container-id="88202c18-54f3-4463-924d-842ea1cc9466", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb730]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb730]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb730]:  <- AMQP
> [0x24cb730]:0 <- @open(16) [container-id="5c480e45-a289-4c16-947b-f352419370af", max-frame-size=32768,
channel-max=255, idle-time-out=0, properties={:product="qpid", :version="6.0.1", :"qpid.build"="1731621",
:"qpid.instance_name"="Broker"}]
> [0x24cb730]:0 <- @begin(17) [remote-channel=0, next-outgoing-id=0, incoming-window=2048,
outgoing-window=2048]
> [0x24cb730]:0 <- @attach(18) [name="1/1", handle=0, role=true, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false]]
> [0x24cb730]:0 <- @flow(19) [next-incoming-id=0, incoming-window=2048, next-outgoing-id=0,
outgoing-window=2048, handle=0, delivery-count=0, link-credit=20000, echo=false]
> [0x24cb730]:0 -> @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"\xeb\x90\x00\x00\x00\x00\x00\x00",
message-format=0, settled=false, more=false] (255) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Ss\xd0\x00\x00\x00-\x00\x00\x00\x0d@@@\xa1\x0atradeevent@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00St\xd1\x00\x00\x00F\x00\x00\x00\x06\xa1\x0cSourceModule\xa1\x02MX\xa1\x09Timestamp\x81\x00\x00\x01Vi'\xe6\xac\xa1\x10ValidationStatus\xa1\x08IN_ERROR\x00Sw\xa0d\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"
> [0x24cb730]:0 -> @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 -> @close(24) []
> [0x24cb730]:  -> EOS
> [0x24cb730]:0 <- @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36)
[]]
> [0x24cb730]:0 <- @detach(22) [handle=0, closed=true]
> [0x24cb730]:0 <- @close(24) []
> [0x24cb730]:  <- EOS
> [0x24cb620]:  -> AMQP
> [0x24cb620]:0 -> @open(16) [container-id="4ecb736a-44a4-4c6a-9a68-2d2018f60c13", hostname="dell445srv:10455",
channel-max=32767, idle-time-out=705032703]
> [0x24cb620]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647]
> [0x24cb620]:0 -> @attach(18) [name="1/1", handle=0, role=false, snd-settle-mode=2,
rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41)
[address="perf.topic", durable=0, timeout=0, dynamic=false], initial-delivery-count=0]
> [0x24cb620]:0 -> @close(24) [error=@error(29) [condition=:"amqp:connection:framing-error",
description="AMQP header mismatch: Insufficient data to determine protocol [''] (connection
aborted)"]]
> [0x24cb620]:  <- EOS
> SimpleSenderHandler::on_transport_error: amqp:connection:framing-error: AMQP header mismatch:
Insufficient data to determine protocol [''] (connection aborted)
>
> Regards,
> Adel
>
>> Subject: Re: [Java Broker- 6.0.1] AMQP random errors when sending messages using
Proton-c 0.12.2
>> From: astitcher@redhat.com
>> To: users@qpid.apache.org
>> Date: Fri, 5 Aug 2016 15:07:42 -0400
>>
>> On Fri, 2016-08-05 at 19:16 +0200, Adel Boutros wrote:
>> > Hello,
>> >
>> > I have a Proton-c C++ sender which sends messages using the container
>> > API. For each message to send, I open a new container which means
>> > that for each message, I open and close a new connection. I am
>> > getting 2 random exceptions on Linux in the
>> > "proton::handler::on_transport_error" method:
>> >
>> > amqp:connection:framing-error: AMQP header mismatch: Insufficient
>> > data to determine protocol [''] (connection aborted).
>>
>> This seems to be caused because the other side just closed the
>> connection without sending anything at all.
>>
>> At least that is how the proton engine is seeing it - it could be that
>> something else in the io path is messed up, but I don't know much about
>> the code you seem to be using as it's not in the current versions of
>> the API implementation (0.14.0 is about to be released).
>>
>> I notice there is no authentication set up here, maybe the other end is
>> requiring it?
>>
>> > and
>> > proton:io: connect: Cannot assign requested address.
>>
>> I'm not sure, but I think this is likely just a consequence of the
>> previous error.
>>
>> It would be useful to see what the other side of the connection sees/is
>> doing.
>>
>> Andrew
>>
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail: users-unsubscribe@qpid.apache.org
>> For additional commands, e-mail: users-help@qpid.apache.org
>>
>


---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@qpid.apache.org
For additional commands, e-mail: users-help@qpid.apache.org


Mime
View raw message