qpid-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Sandy Pratt <prat...@adobe.com>
Subject RE: Qpid Cluster Errors
Date Wed, 18 Nov 2009 01:33:41 GMT
I managed to capture a log today while trace was on.  Broker1 and broker2 are in a cluster,
and broker1 is pulling messages from federated_broker1 when the error occurred:

2009-nov-17 17:22:29 debug DeliveryRecord::setEnded() id=840
2009-nov-17 17:22:29 debug Accepted 840
2009-nov-17 17:22:29 debug user1@QPID.5d051ed2-74fc-49bc-91ba-144d594b863c: receiver marked
completed: 18 incomplete: { } unknown-completed: { [1,18] }
2009-nov-17 17:22:29 trace broker1:3193(READY) DLVR 838300: Frame[BEbe; channel=0; {SessionCompletedBody:
commands={ [293,629] }; }] data broker2:21467-85
2009-nov-17 17:22:29 debug user1@QPID.8d28476a-f279-44b2-ae04-37410bc344b5: sender marked
completed: { [293,629] }
2009-nov-17 17:22:29 debug Exception constructed: user1@QPID.8d28476a-f279-44b2-ae04-37410bc344b5:
confirmed < (630+0) but only sent < (629+0) (qpid/SessionState.cpp:163)
2009-nov-17 17:22:29 error Execution exception: invalid-argument: user1@QPID.8d28476a-f279-44b2-ae04-37410bc344b5:
confirmed < (630+0) but only sent < (629+0) (qpid/SessionState.cpp:163)
2009-nov-17 17:22:29 error broker1:3193(READY/error) channel error 838300 on broker2:21467-85(shadow):
invalid-argument: user1@QPID.8d28476a-f279-44b2-ae04-37410bc344b5: confirmed < (630+0)
but only sent < (629+0) (qpid/SessionState.cpp:163) (unresolved: broker1:3193 broker2:21467
)
2009-nov-17 17:22:29 trace MCAST broker2:21467-0: {ClusterErrorCheckBody: type=1; frame-seq=838300;
}
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker1:3193-0 Frame[BEbe;
channel=0; {ClusterErrorCheckBody: type=1; frame-seq=838300; }]]
2009-nov-17 17:22:29 debug broker1:3193(READY/error) error 838300 outcome agrees with broker1:3193
2009-nov-17 17:22:29 debug broker1:3193(READY/error) Error 838300 still unresolved: broker2:21467
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-90 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=64; }]]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-85 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=96; }]]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-84  data 26
bytes]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-88 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=512; }]]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-88  data 26
bytes]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-90  data 26
bytes]
2009-nov-17 17:22:29 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-86 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=128; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-83 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=128; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-89 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=32; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-87 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=32; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-91  data 26
bytes]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-92 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=256; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-91 Frame[BEbe;
channel=0; {ClusterConnectionDeliverDoOutputBody: limit=62; }]]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-86  data 26
bytes]
2009-nov-17 17:22:30 trace broker1:3193(READY/error) DLVR: Event[broker2:21467-0 Frame[BEbe;
channel=0; {ClusterErrorCheckBody: type=0; frame-seq=838300; }]]
2009-nov-17 17:22:30 critical broker1:3193(READY/error) error 838300 did not occur on broker2:21467
2009-nov-17 17:22:30 debug Exception constructed: Aborted by local failure that did not occur
on all replicas
2009-nov-17 17:22:30 error Error delivering frames: Aborted by local failure that did not
occur on all replicas
2009-nov-17 17:22:30 notice broker1:3193(LEFT/error) leaving cluster renga-qpid-dev
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-92(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-91(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-90(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-89(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-88(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-87(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-86(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-85(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-84(shadow)
2009-nov-17 17:22:30 debug broker1:3193(LEFT/error) deleted connection: broker2:21467-83(shadow)
2009-nov-17 17:22:30 debug Shutting down CPG
2009-nov-17 17:22:30 notice Shut down
2009-nov-17 17:22:30 error Connection federated_broker1:5672 closed by error: closed by management(320)
2009-nov-17 17:22:30 debug Journal "test": Destroyed
2009-nov-17 17:22:30 debug Journal "coreToNode": Destroyed
2009-nov-17 17:22:30 debug Journal "TplStore": Destroyed

---------------------------------------------------------------------
Apache Qpid - AMQP Messaging Implementation
Project:      http://qpid.apache.org
Use/Interact: mailto:users-subscribe@qpid.apache.org


Mime
View raw message