[asterisk-bugs] [Asterisk 0017521]: Brief lagginess on IAX2 channels is fatal
Asterisk Bug Tracker
noreply at bugs.digium.com
Thu Dec 30 03:25:27 UTC 2010
A NOTE has been added to this issue.
======================================================================
https://issues.asterisk.org/view.php?id=17521
======================================================================
Reported By: jcovert
Assigned To:
======================================================================
Project: Asterisk
Issue ID: 17521
Category: Channels/chan_iax2
Reproducibility: always
Severity: major
Priority: normal
Status: acknowledged
Asterisk Version: 1.6.2.8
JIRA: SWP-1718
Regression: No
Reviewboard Link:
SVN Branch (only for SVN checkouts, not tarball releases): N/A
SVN Revision (number only!):
Request Review:
======================================================================
Date Submitted: 2010-06-17 10:32 CDT
Last Modified: 2010-12-29 21:25 CST
======================================================================
Summary: Brief lagginess on IAX2 channels is fatal
Description:
The problem reported in issue https://issues.asterisk.org/view.php?id=15609 and
https://issues.asterisk.org/view.php?id=15900 continues:
[Jun 17 09:55:14] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
[Jun 17 09:57:54] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
[Jun 17 09:57:54] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
[Jun 17 09:58:07] NOTICE[15579]: chan_iax2.c:11447 __iax2_poke_noanswer:
Peer 'x29' is now UNREACHABLE! Time: 2
[Jun 17 09:58:07] NOTICE[15579]: chan_iax2.c:11447 __iax2_poke_noanswer:
Peer 'jrclaptop' is now UNREACHABLE! Time: 4
[Jun 17 09:58:07] NOTICE[15579]: chan_iax2.c:11447 __iax2_poke_noanswer:
Peer 'x38' is now UNREACHABLE! Time: 136
[Jun 17 09:58:10] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
[Jun 17 09:58:10] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
[Jun 17 09:58:10] WARNING[15579]: channel.c:1044 __ast_queue_frame:
Exceptionally long voice queue length queuing to IAX2/x38-9660
-- Hungup 'IAX2/x38-9660'
== Spawn extension (dialstation, 38, 1) exited non-zero on
'SIP/x28-0000048b'
[Jun 17 09:58:12] NOTICE[15579]: chan_iax2.c:10418 socket_process: Peer
'x29' is now REACHABLE! Time: 2
[Jun 17 09:58:12] NOTICE[15579]: chan_iax2.c:10418 socket_process: Peer
'jrclaptop' is now REACHABLE! Time: 4
[Jun 17 09:58:12] NOTICE[15579]: chan_iax2.c:10418 socket_process: Peer
'x38' is now REACHABLE! Time: 137
This tends to reproduce for me only on transatlantic calls.
/john
======================================================================
Relationships ID Summary
----------------------------------------------------------------------
related to 0015609 [patch] WARNING[23025]: channel.c:952 _...
related to 0015900 Console flood & CPU load 100% when ...
related to 0017625 "I should never be called!" m...
======================================================================
----------------------------------------------------------------------
(0130038) jcovert (reporter) - 2010-12-29 21:25
https://issues.asterisk.org/view.php?id=17521#c130038
----------------------------------------------------------------------
In case you don't have a Cisco ATA 186 handy, a Polycom 330 will do just
fine. x26 is a Polycom on the local LAN as well:
asterisk*CLI> originate sip/x26 application dial
IAX2/guest at iax.covert.org/ringnoanswer
-- Launching dial(IAX2/guest at iax.covert.org/ringnoanswer) on
SIP/x26-0000010f
-- Called guest at iax.covert.org/ringnoanswer
-- Accepting UNAUTHENTICATED call from 192.168.0.100:
> requested format = ulaw,
> requested prefs = (ulaw|alaw|g726|gsm),
> actual format = ulaw,
> host prefs = (ulaw|alaw|g726|gsm),
> priority = caller
-- Call accepted by 192.168.0.100 (format ulaw)
-- Format for call is ulaw
-- Executing [ringnoanswer at sip:1]
Progress("IAX2/192.168.0.100:4569-14367", "") in new stack
-- Executing [ringnoanswer at sip:2]
NoOp("IAX2/192.168.0.100:4569-14367", ""Cisco 26" <26>") in new stack
-- Executing [ringnoanswer at sip:3]
PlayTones("IAX2/192.168.0.100:4569-14367", "440+495/2000,0/4000") in new
stack
-- IAX2/192.168.0.100:4569-9274 is making progress passing it to
SIP/x26-0000010f
-- Executing [ringnoanswer at sip:4]
Wait("IAX2/192.168.0.100:4569-14367", "120") in new stack
[Dec 29 22:21:43] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:43] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:44] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:51] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:56] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:57] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:21:57] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-14367
[Dec 29 22:22:06] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:22:06] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-14367
[Dec 29 22:22:07] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:22:08] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:22:14] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
[Dec 29 22:22:15] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-9274
-- Hungup 'IAX2/192.168.0.100:4569-9274'
[Dec 29 22:22:59] WARNING[22843]: channel.c:1399 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/192.168.0.100:4569-14367
== Spawn extension (sip, ringnoanswer, 4) exited non-zero on
'IAX2/192.168.0.100:4569-14367'
-- Hungup 'IAX2/192.168.0.100:4569-14367'
[Dec 29 22:22:59] NOTICE[22843]: chan_iax2.c:11867 __iax2_poke_noanswer:
Peer 'x38' is now UNREACHABLE! Time: 300
[Dec 29 22:23:01] NOTICE[22843]: chan_iax2.c:11867 __iax2_poke_noanswer:
Peer 'jrclaptop' is now UNREACHABLE! Time: 4
[Dec 29 22:23:04] NOTICE[22843]: chan_iax2.c:10802 socket_process: Peer
'x38' is now REACHABLE! Time: 133
[Dec 29 22:23:06] NOTICE[22843]: chan_iax2.c:10802 socket_process: Peer
'jrclaptop' is now REACHABLE! Time: 4
Note that this time both the remote x38 IAX peer as well as a LOCAL IAX
peer (jrclaptop) went unreachable during the test.
/john
Issue History
Date Modified Username Field Change
======================================================================
2010-12-29 21:25 jcovert Note Added: 0130038
======================================================================
More information about the asterisk-bugs
mailing list