[asterisk-dev] iax2 connection drops after some minutes
Pavel Jezek
pavel.jezek at i.cz
Tue Sep 5 06:36:24 MST 2006
I'm sending some IAX debug messages...
I think nothing special here, maybe higher packet loss (I have iax jb
turned on)
after cca 10mins one direction of call drops,
message:
[Sep 5 15:17:53] NOTICE[11761]: sched.c:283 ast_sched_del: Attempted to
delete nonexistent schedule entry 387519!
always appears after hangup (even after normal "undropped" call)
PJ
Tx-Frame Retry[000] -- OSeqno: 182 ISeqno: 189 Type: IAX Subclass: PONG
Timestamp: 600018ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
RR_JITTER : 589
RR_LOSS : 16777326
RR_PKTS : 19747
RR_DELAY : 629
RR_DROPPED : 212
RR_OUTOFORDER : 1
Tx-Frame Retry[000] -- OSeqno: 183 ISeqno: 190 Type: IAX Subclass: LAGRP
Timestamp: 600021ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 184 ISeqno: 190 Type: IAX Subclass: PING
Timestamp: 600016ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 185 ISeqno: 190 Type: IAX Subclass: LAGRQ
Timestamp: 600019ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 189 ISeqno: 183 Type: IAX Subclass: ACK
Timestamp: 600018ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 190 ISeqno: 184 Type: IAX Subclass: ACK
Timestamp: 600021ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 190 ISeqno: 185 Type: IAX Subclass: PONG
Timestamp: 600016ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
RR_JITTER : 64
RR_LOSS : 50331676
RR_PKTS : 19262
RR_DELAY : 115
RR_DROPPED : 3
RR_OUTOFORDER : 0
Tx-Frame Retry[-01] -- OSeqno: 185 ISeqno: 191 Type: IAX Subclass: ACK
Timestamp: 600016ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 191 ISeqno: 186 Type: IAX Subclass: LAGRP
Timestamp: 600019ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Tx-Frame Retry[-01] -- OSeqno: 186 ISeqno: 192 Type: IAX Subclass: ACK
Timestamp: 600019ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[001] -- OSeqno: 186 ISeqno: 192 Type: IAX Subclass: LAGRQ
Timestamp: 610014ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 192 ISeqno: 186 Type: IAX Subclass: LAGRQ
Timestamp: 610020ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 187 ISeqno: 193 Type: IAX Subclass: LAGRP
Timestamp: 610020ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[001] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE
Timestamp: 00003ms SCall: 00046 DCall: 00000 [85.160.88.27:4569]
Tx-Frame Retry[001] -- OSeqno: 187 ISeqno: 193 Type: IAX Subclass: LAGRP
Timestamp: 610020ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE
Tx-Frame Retry[000] -- OSeqno: 188 ISeqno: 195 Type: IAX Subclass: PONG
Timestamp: 620019ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
RR_JITTER : 1053
RR_LOSS : 50331760
RR_PKTS : 20412
RR_DELAY : 1093
RR_DROPPED : 212
RR_OUTOFORDER : 1
Rx-Frame Retry[ No] -- OSeqno: 195 ISeqno: 188 Type: IAX Subclass: LAGRQ
Timestamp: 620022ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 189 ISeqno: 196 Type: IAX Subclass: LAGRP
Timestamp: 620022ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 190 ISeqno: 196 Type: IAX Subclass: PING
Timestamp: 620016ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Tx-Frame Retry[000] -- OSeqno: 191 ISeqno: 196 Type: IAX Subclass: LAGRQ
Timestamp: 620019ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 195 ISeqno: 189 Type: IAX Subclass: ACK
Timestamp: 620019ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 196 ISeqno: 190 Type: IAX Subclass: ACK
Timestamp: 620022ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 196 ISeqno: 191 Type: IAX Subclass: PONG
Timestamp: 620016ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
RR_JITTER : 64
RR_LOSS : 50331676
RR_PKTS : 19262
RR_DELAY : 115
RR_DROPPED : 3
RR_OUTOFORDER : 0
Tx-Frame Retry[-01] -- OSeqno: 191 ISeqno: 197 Type: IAX Subclass: ACK
Timestamp: 620016ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 197 ISeqno: 192 Type: IAX Subclass: LAGRP
Timestamp: 620019ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
Tx-Frame Retry[-01] -- OSeqno: 192 ISeqno: 198 Type: IAX Subclass: ACK
Timestamp: 620019ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
Rx-Frame Retry[ No] -- OSeqno: 197 ISeqno: 187 Type: IAX Subclass: PING
Rx-Frame Retry[ No] -- OSeqno: 200 ISeqno: 194 Type: IAX Subclass:
HANGUP
Timestamp: 631572ms SCall: 00015 DCall: 00050 [85.160.88.27:4569]
CAUSE CODE : 16
Tx-Frame Retry[-01] -- OSeqno: 194 ISeqno: 201 Type: IAX Subclass: ACK
Timestamp: 631572ms SCall: 00050 DCall: 00015 [85.160.88.27:4569]
[Sep 5 15:17:53] NOTICE[11761]: sched.c:283 ast_sched_del: Attempted to
delete nonexistent schedule entry 387519!
-- Hungup 'IAX2/bill-52'
== Spawn extension (default, 324, 3) exited non-zero on 'IAX2/honzat-50'
-- Hungup 'IAX2/honzat-50'
Andrew Kohlsmith wrote:
> On Tuesday 05 September 2006 08:27, Pavel Jezek wrote:
>
>> I'm experiencing iax2 connection drops after three-ten minutes
>> (connection was successfully established before drop)
>> connection is dropped in one direction only, so one site hear, but
>> oposite site no,
>> this messages appears in asterisk console....
>> any idea?
>>
>
> We need the output of IAX2 debug at the very least, and ideally a packet dump
> showing the entire call setup and eventual drop. If you can provide this,
> make sure to change your passwords and not to talk about anything you'd not
> want public. :-)
>
> -A.
> _______________________________________________
> --Bandwidth and Colocation provided by Easynews.com --
>
> asterisk-dev mailing list
> To UNSUBSCRIBE or update options visit:
> http://lists.digium.com/mailman/listinfo/asterisk-dev
>
More information about the asterisk-dev
mailing list