[asterisk-bugs] [Asterisk 0017521]: [patch] Brief lagginess on IAX2 channels is fatal

[Asterisk Bug Tracker]

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:              2011-02-16 18:57 CST
====================================================================== 
Summary:                    [patch] 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...
related to          0018511 [patch] Asterisk hangs with no calls be...
====================================================================== 

---------------------------------------------------------------------- 
 (0132061) jcovert (reporter) - 2011-02-16 18:57
 https://issues.asterisk.org/view.php?id=17521#c132061 
---------------------------------------------------------------------- 
1.8.3-rc2:

Originating station is ulaw.  Transcoding seems to make the problem
worse.

Can you try to reproduce this on an older, slow machine?  Or with another
process using up most of the CPU on a faster machine?  No Digium hardware
installed for timing.

    -- Executing [8344 at dialstation:2] Dial("SIP/x21-00000003",
"IAX2/pbx.digium.com/s,120") in new stack
    -- Called pbx.digium.com/s
    -- Call accepted by 216.207.245.8 (format gsm)
    -- Format for call is gsm
    -- IAX2/216.207.245.8:4569-6503 answered SIP/x21-00000003
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503
[Feb 16 17:49:34] WARNING[16181]: channel.c:1434 __ast_queue_frame:
Exceptionally long voice queue length queuing to
IAX2/216.207.245.8:4569-6503 

Issue History 
Date Modified    Username       Field                    Change               
====================================================================== 
2011-02-16 18:57 jcovert        Note Added: 0132061                          
======================================================================