[asterisk-bugs] [Asterisk 0019324]: Local Channels not passing DTMF Tones properly

Asterisk Bug Tracker noreply at bugs.digium.com
Thu May 19 14:27:54 CDT 2011


The following issue requires your FEEDBACK. 
====================================================================== 
https://issues.asterisk.org/view.php?id=19324 
====================================================================== 
Reported By:                dballenger
Assigned To:                
====================================================================== 
Project:                    Asterisk
Issue ID:                   19324
Category:                   Channels/chan_local
Reproducibility:            always
Severity:                   major
Priority:                   normal
Status:                     feedback
Asterisk Version:           1.6.2.18 
JIRA:                        
Regression:                 No 
Reviewboard Link:            
SVN Branch (only for SVN checkouts, not tarball releases): N/A 
SVN Revision (number only!):  
Request Review:              
====================================================================== 
Date Submitted:             2011-05-18 19:07 CDT
Last Modified:              2011-05-19 14:27 CDT
====================================================================== 
Summary:                    Local Channels not passing DTMF Tones properly
Description: 
This appears to be the same (or at least a similar) issue to bug report
https://issues.asterisk.org/view.php?id=18784

When a call goes through a local channels, the DTMF digits don't always
get passed reliably.  I don't exactly know what version I first saw the
issue on, but I can confirm it is present in 1.6.2.17.2 and 1.6.2.18

Here is a sample dialplan which was used to duplicate the issue for the
log entries pasted below:
exten => 601,1,Answer
exten => 601,2,Read(digits)
exten => 601,3,SayDigits(${digits})
exten => 602,1,Dial(Local/601 at mcid19-outgoing/n)

Calling 601 directly yields the proper results (all pressed DTMF digits
are properly read back out), but when calling 602, DTMF digit recognition
is sporadic at best (pressing 1,2,3,4,5,6,7,8,9 yielded "1,4,7")

DTMF log when directly dialing extension:
2011-05-18T23:57:39+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'1' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:39+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '1' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:39+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '1' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'2' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '2' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '2' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'3' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '3' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '3' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'4' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '4' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '4' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'5' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '5' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:40+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '5' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'6' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '6' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '6' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'7' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '7' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '7' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'8' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '8' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:41+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '8' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'9' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '9' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '9' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'#' received on SCCP/mcid19-dballenger-line1-00000010, duration 0 ms
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '#' on SCCP/mcid19-dballenger-line1-00000010
2011-05-18T23:57:42+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '#' on SCCP/mcid19-dballenger-line1-00000010

DTMF log when going through Local channel:
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'1' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
emulation of '1' with duration 100 queued on
SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
emulation of '1' queued on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'2' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '2' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '2' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'3' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '3' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '3' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
'1' received on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
ignored '1' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'1' received on Local/601 at mcid19-outgoing-e40a;2, duration 100 ms
2011-05-18T23:58:30+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '1' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'4' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
emulation of '4' with duration 100 queued on
SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
emulation of '4' queued on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'5' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '5' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '5' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
'4' received on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
ignored '4' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'4' received on Local/601 at mcid19-outgoing-e40a;2, duration 100 ms
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '4' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'6' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '6' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '6' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'7' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
emulation of '7' with duration 100 queued on
SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:31+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
emulation of '7' queued on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'8' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '8' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '8' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
'7' received on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
ignored '7' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'7' received on Local/601 at mcid19-outgoing-e40a;2, duration 100 ms
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '7' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'9' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
accepted without begin '9' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '9' on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'#' received on SCCP/mcid19-dballenger-line1-00000011, duration 0 ms
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
emulation of '#' with duration 100 queued on
SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
emulation of '#' queued on SCCP/mcid19-dballenger-line1-00000011
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
'#' received on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF begin
ignored '#' on Local/601 at mcid19-outgoing-e40a;2
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
'#' received on Local/601 at mcid19-outgoing-e40a;2, duration 100 ms
2011-05-18T23:58:32+00:00 dl0002 asterisk[38696]: DTMF[38696]: DTMF end
passthrough '#' on Local/601 at mcid19-outgoing-e40a;2

======================================================================
Relationships       ID      Summary
----------------------------------------------------------------------
related to          0018784 Local channel DTMF detection broken by ...
====================================================================== 

Issue History 
Date Modified    Username       Field                    Change               
====================================================================== 
2011-05-19 14:27 lmadsen        Status                   new => feedback     
======================================================================




More information about the asterisk-bugs mailing list