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

Asterisk Bug Tracker noreply at bugs.digium.com
Wed May 18 19:07:45 CDT 2011


The following issue has been SUBMITTED. 
====================================================================== 
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:                     new
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-18 19:07 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

====================================================================== 

Issue History 
Date Modified    Username       Field                    Change               
====================================================================== 
2011-05-18 19:07 dballenger     New Issue                                    
2011-05-18 19:07 dballenger     Asterisk Version          => 1.6.2.18        
2011-05-18 19:07 dballenger     Regression                => No              
2011-05-18 19:07 dballenger     SVN Branch (only for SVN checkouts, not tarball
releases) => N/A             
======================================================================




More information about the asterisk-bugs mailing list