[asterisk-dev] [IAX2] Question on unrecoverable race condition and VNAK's Oseq
Alex Hermann
alex at speakup.nl
Thu Mar 12 10:56:04 CDT 2009
On Tuesday 03 March 2009, you wrote:
> > I'm sometimes seeing a race condition in the IAX2 protocol, from which
> >
> > the protocol isn't able to recover.
> How often does this occur. Can you get a wireshark log of this?
It happens seemingly at random, although there seems to be a relation to the
round-trip time. When it has happened for a peer, it will reoccur with high
probability for the same peer.
I haven't seen this on 1.2 <-> 1.2 nor 1.4 <-> 1.4 systems, only 1.4 <-> 1.2.
I can't anonymize a pcap file, can I send you one privately?
I got a new case, this time with Asterisk log:
[Mar 10 17:25:24] VERBOSE[13382] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ
[Mar 10 17:25:24] VERBOSE[13382] logger.c: Timestamp: 00001ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:24] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP
[Mar 10 17:25:24] VERBOSE[13409] logger.c: Timestamp: 00676ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13382] logger.c: Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT
[Mar 10 17:25:25] VERBOSE[13382] logger.c: Timestamp: 00638ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13382] logger.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK
[Mar 10 17:25:25] VERBOSE[13382] logger.c: Timestamp: 00638ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13390] logger.c: Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER
[Mar 10 17:25:25] VERBOSE[13390] logger.c: Timestamp: 00641ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13390] logger.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK
[Mar 10 17:25:25] VERBOSE[13390] logger.c: Timestamp: 00641ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 003 Type: CONTROL Subclass: (20?)
[Mar 10 17:25:25] VERBOSE[13409] logger.c: Timestamp: 01314ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: VOICE Subclass: 16
[Mar 10 17:25:25] VERBOSE[13409] logger.c: Timestamp: 01328ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13359] logger.c: Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 002 Type: VOICE Subclass: 16
[Mar 10 17:25:25] VERBOSE[13359] logger.c: Timestamp: 00760ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:25] VERBOSE[13359] logger.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK
[Mar 10 17:25:25] VERBOSE[13359] logger.c: Timestamp: 00760ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:26] VERBOSE[13395] logger.c: Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK
[Mar 10 17:25:26] VERBOSE[13395] logger.c: Timestamp: 01314ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:26] VERBOSE[13393] logger.c: Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK
[Mar 10 17:25:26] VERBOSE[13393] logger.c: Timestamp: 01328ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:34] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:34] VERBOSE[13409] logger.c: Timestamp: 10022ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:34] VERBOSE[13399] logger.c: Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 005 Type: IAX Subclass: LAGRP
[Mar 10 17:25:34] VERBOSE[13399] logger.c: Timestamp: 10022ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:34] VERBOSE[13399] logger.c: Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: ACK
[Mar 10 17:25:34] VERBOSE[13399] logger.c: Timestamp: 10022ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:34] VERBOSE[13363] logger.c: Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:34] VERBOSE[13363] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:36] VERBOSE[13385] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:36] VERBOSE[13385] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:40] VERBOSE[13383] logger.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:40] VERBOSE[13383] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:40] VERBOSE[13383] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:40] VERBOSE[13383] logger.c: Timestamp: 16105ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13375] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:41] VERBOSE[13375] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13399] logger.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:41] VERBOSE[13399] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13399] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:41] VERBOSE[13399] logger.c: Timestamp: 16721ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13363] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:41] VERBOSE[13363] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13396] logger.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:41] VERBOSE[13396] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:41] VERBOSE[13396] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:41] VERBOSE[13396] logger.c: Timestamp: 17334ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13392] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:42] VERBOSE[13392] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13401] logger.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:42] VERBOSE[13401] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13401] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:42] VERBOSE[13401] logger.c: Timestamp: 17943ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13359] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:42] VERBOSE[13359] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13359] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:42] VERBOSE[13359] logger.c: Timestamp: 18105ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13382] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:42] VERBOSE[13382] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13394] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:42] VERBOSE[13394] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:42] VERBOSE[13394] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:42] VERBOSE[13394] logger.c: Timestamp: 18549ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13382] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:43] VERBOSE[13382] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13394] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:43] VERBOSE[13394] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13394] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:43] VERBOSE[13394] logger.c: Timestamp: 18726ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13399] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:43] VERBOSE[13399] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13371] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:43] VERBOSE[13371] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13371] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:43] VERBOSE[13371] logger.c: Timestamp: 19165ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13387] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:43] VERBOSE[13387] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13379] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:43] VERBOSE[13379] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:43] VERBOSE[13379] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:43] VERBOSE[13379] logger.c: Timestamp: 19340ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13392] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:44] VERBOSE[13392] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13401] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:44] VERBOSE[13401] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13401] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:44] VERBOSE[13401] logger.c: Timestamp: 19786ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13374] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:44] VERBOSE[13374] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13358] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:44] VERBOSE[13358] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13358] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:44] VERBOSE[13358] logger.c: Timestamp: 19971ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:44] VERBOSE[13409] logger.c: Timestamp: 20026ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13400] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:44] VERBOSE[13400] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13386] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:44] VERBOSE[13386] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13386] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:44] VERBOSE[13386] logger.c: Timestamp: 20411ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13383] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:44] VERBOSE[13383] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13369] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:44] VERBOSE[13369] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13369] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:44] VERBOSE[13369] logger.c: Timestamp: 20588ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13406] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 006 Type: IAX Subclass: LAGRP
[Mar 10 17:25:44] VERBOSE[13406] logger.c: Timestamp: 20026ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:44] VERBOSE[13406] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:44] VERBOSE[13406] logger.c: Timestamp: 20649ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13358] logger.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 006 Type: IAX Subclass: PING
[Mar 10 17:25:45] VERBOSE[13358] logger.c: Timestamp: 20028ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13376] logger.c: Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 006 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13376] logger.c: Timestamp: 20031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13409] logger.c: Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 005 Type: IAX Subclass: PING
[Mar 10 17:25:45] VERBOSE[13409] logger.c: Timestamp: 21022ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13378] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13378] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13406] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:45] VERBOSE[13406] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13406] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13406] logger.c: Timestamp: 21029ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13363] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 006 Type: IAX Subclass: LAGRP
[Mar 10 17:25:45] VERBOSE[13363] logger.c: Timestamp: 20026ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13363] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13363] logger.c: Timestamp: 21032ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13396] logger.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 006 Type: IAX Subclass: PING
[Mar 10 17:25:45] VERBOSE[13396] logger.c: Timestamp: 20028ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13367] logger.c: Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 006 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13367] logger.c: Timestamp: 20031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13359] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13359] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13393] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:45] VERBOSE[13393] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13393] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13393] logger.c: Timestamp: 21208ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13398] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 006 Type: IAX Subclass: LAGRP
[Mar 10 17:25:45] VERBOSE[13398] logger.c: Timestamp: 20026ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13398] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13398] logger.c: Timestamp: 21209ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13381] logger.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 006 Type: IAX Subclass: PING
[Mar 10 17:25:45] VERBOSE[13381] logger.c: Timestamp: 20028ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13364] logger.c: Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 006 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13364] logger.c: Timestamp: 20031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13377] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13377] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13391] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:45] VERBOSE[13391] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13391] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13391] logger.c: Timestamp: 21265ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13368] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 006 Type: IAX Subclass: LAGRP
[Mar 10 17:25:45] VERBOSE[13368] logger.c: Timestamp: 20026ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13368] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:45] VERBOSE[13368] logger.c: Timestamp: 21268ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13385] logger.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 006 Type: IAX Subclass: PING
[Mar 10 17:25:45] VERBOSE[13385] logger.c: Timestamp: 20028ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13404] logger.c: Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 006 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:45] VERBOSE[13404] logger.c: Timestamp: 20031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:45] VERBOSE[13385] logger.c: Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 007 Type: IAX Subclass: PONG
[Mar 10 17:25:45] VERBOSE[13385] logger.c: Timestamp: 21022ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
.......
[Mar 10 17:25:56] VERBOSE[13405] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:56] VERBOSE[13405] logger.c: Timestamp: 32684ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13385] logger.c: Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 008 Type: IAX Subclass: LAGRP
[Mar 10 17:25:56] VERBOSE[13385] logger.c: Timestamp: 30061ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13385] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:56] VERBOSE[13385] logger.c: Timestamp: 32687ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13368] logger.c: Rx-Frame Retry[ No] -- OSeqno: 012 ISeqno: 008 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:56] VERBOSE[13368] logger.c: Timestamp: 30029ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13372] logger.c: Rx-Frame Retry[ No] -- OSeqno: 013 ISeqno: 008 Type: IAX Subclass: HANGUP
[Mar 10 17:25:56] VERBOSE[13372] logger.c: Timestamp: 30215ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13372] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:56] VERBOSE[13372] logger.c: Timestamp: 32690ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13366] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:56] VERBOSE[13366] logger.c: Timestamp: 10011ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13404] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 006 ISeqno: 007 Type: CONTROL Subclass: (255?)
[Mar 10 17:25:56] VERBOSE[13404] logger.c: Timestamp: 15444ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13404] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:56] VERBOSE[13404] logger.c: Timestamp: 32671ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13373] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 007 ISeqno: 007 Type: IAX Subclass: LAGRP
[Mar 10 17:25:56] VERBOSE[13373] logger.c: Timestamp: 20026ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13373] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:25:56] VERBOSE[13373] logger.c: Timestamp: 32674ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13360] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 008 ISeqno: 007 Type: IAX Subclass: PING
[Mar 10 17:25:56] VERBOSE[13360] logger.c: Timestamp: 20028ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13383] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 009 ISeqno: 007 Type: IAX Subclass: LAGRQ
[Mar 10 17:25:56] VERBOSE[13383] logger.c: Timestamp: 20031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:25:56] VERBOSE[13407] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 010 ISeqno: 007 Type: IAX Subclass: PONG
[Mar 10 17:25:56] VERBOSE[13407] logger.c: Timestamp: 21022ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
.........
[Mar 10 17:26:08] VERBOSE[13390] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:26:08] VERBOSE[13390] logger.c: Timestamp: 44336ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13394] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 011 ISeqno: 009 Type: IAX Subclass: LAGRP
[Mar 10 17:26:08] VERBOSE[13394] logger.c: Timestamp: 30061ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13394] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:26:08] VERBOSE[13394] logger.c: Timestamp: 44339ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13384] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 012 ISeqno: 008 Type: IAX Subclass: LAGRQ
[Mar 10 17:26:08] VERBOSE[13384] logger.c: Timestamp: 30029ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13380] logger.c: Rx-Frame Retry[Yes] -- OSeqno: 013 ISeqno: 008 Type: IAX Subclass: HANGUP
[Mar 10 17:26:08] VERBOSE[13380] logger.c: Timestamp: 30215ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13380] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:26:08] VERBOSE[13380] logger.c: Timestamp: 44342ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13359] logger.c: Rx-Frame Retry[ No] -- OSeqno: 014 ISeqno: 009 Type: IAX Subclass: LAGRP
[Mar 10 17:26:08] VERBOSE[13359] logger.c: Timestamp: 40031ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13359] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK
[Mar 10 17:26:08] VERBOSE[13359] logger.c: Timestamp: 44345ms SCall: 01723 DCall: 00002 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13405] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13405] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13385] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13385] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13377] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13377] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13368] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13368] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13391] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13391] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13404] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13404] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13366] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13366] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13370] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13370] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13373] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13373] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
[Mar 10 17:26:08] VERBOSE[13369] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL
[Mar 10 17:26:08] VERBOSE[13369] logger.c: Timestamp: 00000ms SCall: 00002 DCall: 01723 [123.123.123.123:4569]
--
Greetings,
Alex Hermann
More information about the asterisk-dev
mailing list