On the server side: ==================== * initiate call with OSeqno: 000 ISeqno: 000 ---------------------------------------------------- [2015-03-12 13:25:42.689] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW [2015-03-12 13:25:42.689] VERBOSE[6954] chan_iax2.c: Timestamp: 00009ms SCall: 25289 DCall: 00000 45.56.114.174:4566 * Rx with OSeqno: 000 ISeqno: 001 ------------------------------------------- [2015-03-12 13:25:42.776] VERBOSE[6961] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: CTOKEN [2015-03-12 13:25:42.776] VERBOSE[6961] chan_iax2.c: Timestamp: 00009ms SCall: 00001 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 000 ISeqno: 000 ----------------------------------------- [2015-03-12 13:25:42.776] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW [2015-03-12 13:25:42.776] VERBOSE[6954] chan_iax2.c: Timestamp: 00096ms SCall: 25289 DCall: 00000 45.56.114.174:4566 * Rx with OSeqno: 000 ISeqno: 001 --------------------------------------------- [2015-03-12 13:25:42.864] VERBOSE[6957] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ [2015-03-12 13:25:42.864] VERBOSE[6957] chan_iax2.c: Timestamp: 00003ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 001 ISeqno: 001 -------------------------------------------- [2015-03-12 13:25:42.864] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP [2015-03-12 13:25:42.864] VERBOSE[6954] chan_iax2.c: Timestamp: 00184ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 001 ISeqno: 002 ------------------------------------------- [2015-03-12 13:25:42.954] VERBOSE[6966] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT [2015-03-12 13:25:42.954] DEBUG[6965] chan_iax2.c: IN Trunking 2 call chunks in 48 bytes ts=80. Calls: 13924, 4645, [2015-03-12 13:25:42.954] VERBOSE[6966] chan_iax2.c: Timestamp: 00087ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 002 ISeqno: 002 ----------------------------------------- [2015-03-12 13:25:42.954] VERBOSE[6966][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK [2015-03-12 13:25:42.954] DEBUG[6957][C-00000003] chan_iax2.c: For call=27186, set last=1108 [2015-03-12 13:25:42.954] VERBOSE[6966][C-0000000d] chan_iax2.c: Timestamp: 00087ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 002 ISeqno: 002 -------------------------------------------- [2015-03-12 13:25:43.955] VERBOSE[6957] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER [2015-03-12 13:25:43.955] VERBOSE[6957] chan_iax2.c: Timestamp: 01090ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 002 ISeqno: 003 ----------------------------------------- [2015-03-12 13:25:43.955] VERBOSE[6957][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK [2015-03-12 13:25:43.955] VERBOSE[6957][C-0000000d] chan_iax2.c: Timestamp: 01090ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx 'stop sound' with OSeqno: 003 ISeqno: 002 --------------------------------------------------------- [2015-03-12 13:25:43.955] VERBOSE[6957] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) [2015-03-12 13:25:43.955] VERBOSE[6957] chan_iax2.c: Timestamp: 01093ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 002 ISeqno: 004 ---------------------------------------- [2015-03-12 13:25:43.955] VERBOSE[6957][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK [2015-03-12 13:25:43.955] VERBOSE[6957][C-0000000d] chan_iax2.c: Timestamp: 01093ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Tx packet with OSeqno: 002 ISeqno: 004 ------------------------------------------------- [2015-03-12 13:25:44.055] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 004 Type: VOICE Subclass: 136 [2015-03-12 13:25:44.055] VERBOSE[6954] chan_iax2.c: Timestamp: 01375ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 004 ISeqno: 003 ---------------------------------------- [2015-03-12 13:25:44.142] VERBOSE[6960] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: IAX Subclass: ACK [2015-03-12 13:25:44.142] VERBOSE[6960] chan_iax2.c: Timestamp: 01375ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Rx with OSeqno: 004 ISeqno: 003 ------------------------------------------ [2015-03-12 13:25:44.144] VERBOSE[6958] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: VOICE Subclass: 136 [2015-03-12 13:25:44.144] VERBOSE[6958] chan_iax2.c: Timestamp: 01280ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 003 ISeqno: 005 ---------------------------------------- [2015-03-12 13:25:44.144] VERBOSE[6958][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK [2015-03-12 13:25:44.144] VERBOSE[6958][C-0000000d] chan_iax2.c: Timestamp: 01280ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Tx with OSeqno: 003 ISeqno: 005 ------------------------------------------ [2015-03-12 13:25:52.688] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: LAGRQ [2015-03-12 13:25:52.688] VERBOSE[6954] chan_iax2.c: Timestamp: 10008ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 005 ISeqno: 004 ------------------------------------------ [2015-03-12 13:25:52.775] VERBOSE[6961] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: LAGRP [2015-03-12 13:25:52.776] DEBUG[7071][C-0000001c] chan_iax2.c: calc_timestamp: call 19987/11350: Timestamp slaved to delivery time [2015-03-12 13:25:52.776] VERBOSE[6961] chan_iax2.c: Timestamp: 10008ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 004 ISeqno: 006 ---------------------------------------- [2015-03-12 13:25:52.776] VERBOSE[6961][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK [2015-03-12 13:25:52.776] VERBOSE[6961][C-0000000d] chan_iax2.c: Timestamp: 10008ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 006 ISeqno: 004 ------------------------------------------ [2015-03-12 13:25:52.864] VERBOSE[6961] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: LAGRQ [2015-03-12 13:25:52.864] VERBOSE[6961] chan_iax2.c: Timestamp: 09992ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 004 ISeqno: 007 ------------------------------------------ [2015-03-12 13:25:52.864] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: LAGRP [2015-03-12 13:25:52.864] VERBOSE[6954] chan_iax2.c: Timestamp: 09992ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 007 ISeqno: 005 ---------------------------------------- [2015-03-12 13:25:52.950] VERBOSE[6962] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: ACK [2015-03-12 13:25:52.950] VERBOSE[6962] chan_iax2.c: Timestamp: 09992ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 005 ISeqno: 007 ------------------------------------------ [2015-03-12 13:26:02.688] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: LAGRQ [2015-03-12 13:26:02.688] VERBOSE[6954] chan_iax2.c: Timestamp: 20007ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 007 ISeqno: 005 ------------------------------------------ [2015-03-12 13:26:02.863] VERBOSE[6964] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: LAGRQ [2015-03-12 13:26:02.863] VERBOSE[6964] chan_iax2.c: Timestamp: 19717ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 006 ISeqno: 008 ------------------------------------------ [2015-03-12 13:26:02.863] VERBOSE[6954] chan_iax2.c: Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 008 Type: IAX Subclass: LAGRP [2015-03-12 13:26:02.863] VERBOSE[6954] chan_iax2.c: Timestamp: 19717ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with OSeqno: 005 ISeqno: 005 ----------------------------------------- [2015-03-12 13:26:02.966] VERBOSE[6961] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: VNAK [2015-03-12 13:26:02.966] VERBOSE[6961] chan_iax2.c: Timestamp: 19815ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Tx with OSeqno: 005 ISeqno: 007 ------------------------------------------ [2015-03-12 13:26:02.966] VERBOSE[6961][C-0000000d] chan_iax2.c: Tx-Frame Retry[001] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: LAGRQ [2015-03-12 13:26:02.966] VERBOSE[6961][C-0000000d] chan_iax2.c: Timestamp: 20007ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Tx with OSeqno: 006 ISeqno: 008 ------------------------------------------ [2015-03-12 13:26:02.966] VERBOSE[6961][C-0000000d] chan_iax2.c: Tx-Frame Retry[001] -- OSeqno: 006 ISeqno: 008 Type: IAX Subclass: LAGRP [2015-03-12 13:26:02.966] VERBOSE[6961][C-0000000d] chan_iax2.c: Timestamp: 19717ms SCall: 25289 DCall: 07431 45.56.114.174:4566 * Rx with 008 ISeqno: 007 -------------------------------- [2015-03-12 13:26:03.071] VERBOSE[6960] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 007 Type: IAX Subclass: ACK [2015-03-12 13:26:03.071] VERBOSE[6960] chan_iax2.c: Timestamp: 19717ms SCall: 07431 DCall: 25289 45.56.114.174:4566 * Rx with OSeqno: 008 ISeqno: 006 ------------------------------------------ [2015-03-12 13:26:03.099] VERBOSE[6960] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 006 Type: IAX Subclass: LAGRP [2015-03-12 13:26:03.099] VERBOSE[6960] chan_iax2.c: Timestamp: 20007ms SCall: 07431 DCall: 25289 45.56.114.174:4566 then the cancelling spree: [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 7 [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 8 [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 9 [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 10 [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 11 [2015-03-12 13:26:03.099] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 12 . . . . . [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 255 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 0 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 1 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 2 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 3 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 4 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: Cancelling transmission of packet 5 [2015-03-12 13:26:03.100] DEBUG[6960][C-0000000d] chan_iax2.c: IAX subclass 12 received * Tx with OSeqno: 006 ISeqno: 009 ---------------------------------------- [2015-03-12 13:26:03.100] VERBOSE[6960][C-0000000d] chan_iax2.c: Tx-Frame Retry[-01] -- OSeqno: 006 ISeqno: 009 Type: IAX Subclass: ACK [2015-03-12 13:26:03.100] VERBOSE[6960][C-0000000d] chan_iax2.c: Timestamp: 20007ms SCall: 25289 DCall: 07431 45.56.114.174:4566