The client quickly dials the internal number

Good afternoon. Faced with such a problem.
The client in the IVR QUICKLY dials the internal number “567” and receives the error “no-valid-response-transferring”.
In the logs app_read.c: User entered ‘57’.

And so with all the numbers, the 2nd digit is lost
If the user types "278: app_read.c: User entered ‘28’.
Tell me how to solve this problem

You need to enable DTMF logging, and also tell us the channel technology in use and whether it is using inband DTMF, and otherwise how is DTMF encoded. The first thing to be determined is whether Asterisk is actually receiving the digits, and, if so, whether they meet the timing requirements for DTMF.

I have freepbx,

sip*CLI> logger show channels
Logger queue limit: 1000

Channel Type Formatter Status Configuration


/var/log/asterisk/messages File default Enabled - NOTICE WARNING ERROR
Console default Enabled - NOTICE WARNING ERROR VERBOSE DTMF
/var/log/asterisk/fail2ban File default Enabled - NOTICE WARNING SECURITY
/var/log/asterisk/full File default Enabled - DEBUG NOTICE WARNING ERROR VERBOSE
Console default Enabled - DEBUG NOTICE WARNING ERROR VERBOSE

SIP DTMF Signaling - rfc2833

log

The client calls 308

Logger

99132 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] app_read.c: User entered ‘38’
99133 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:9] GotoIf(“PJSIP/tel.ru-0000894e”, “0?#,1”) in new stack
99134 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:10] GotoIf(“PJSIP/tel.ru-0000894e”, “0?t,1”) in new stack
99135 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:11] ExecIf(“PJSIP/tel.ru-0000894e”, “0?Set(LOCALEXT=1)”) in new stack
99136 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:12] GotoIf(“PJSIP/tel.ru-0000894e”, “0?i,1”) in new stack
99137 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:13] GotoIf(“PJSIP/tel.ru-0000894e”, “0?from-did-direct-ivr,38,1”) in new stack
99138 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx.c: Executing [s@ivr-1:14] Goto(“PJSIP/tel.ru-0000894e”, “38,1”) in new stack
99139 [2021-12-06 18:45:09] VERBOSE[32677][C-00017ea3] pbx_builtins.c: Goto (ivr-1,38,1)

Looks like you only have DTMF enabled on the console, but you have taken your log from the full log. (Better to enable it on the full log, than to screen scrape the console.)

I corrected the logs. Could there be a problem on the part of the provider? The problem is only with external numbers on the IVR

If you have correctly enabled DTMF logging, no DTMF digits were sent by the provider in the period covered by the logs. That seems to conflict with your initial position that some were being recognized.

I turned on the DTMF logs separately and called the IVR from an external number at 308 and 689

8 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF begin ‘3’ received on PJSIP/tel.ru-0000001b
9 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF begin ignored ‘3’ on PJSIP/tel.ru-0000001b
10 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF end ‘3’ received on PJSIP/tel.ru-0000001b, duration 180 ms
11 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF end passthrough ‘3’ on PJSIP/tel.ru-0000001b
12 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF begin ‘8’ received on PJSIP/tel.ru-0000001b
13 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF begin ignored ‘8’ on PJSIP/tel.ru-0000001b
14 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF end ‘8’ received on PJSIP/tel.ru-0000001b, duration 180 ms
15 [2021-12-06 23:19:25] DTMF[2726][C-00000016] channel.c: DTMF end passthrough ‘8’ on PJSIP/tel.ru-0000001b
16 [2021-12-06 23:19:39] DTMF[2780][C-00000017] channel.c: DTMF begin ‘6’ received on PJSIP/tel.ru-0000001c
17 [2021-12-06 23:19:39] DTMF[2780][C-00000017] channel.c: DTMF begin ignored ‘6’ on PJSIP/tel.ru-0000001c
18 [2021-12-06 23:19:39] DTMF[2780][C-00000017] channel.c: DTMF end ‘6’ received on PJSIP/tel.ru-0000001c, duration 180 ms
19 [2021-12-06 23:19:39] DTMF[2780][C-00000017] channel.c: DTMF end passthrough ‘6’ on PJSIP/tel.ru-0000001c
20 [2021-12-06 23:19:40] DTMF[2780][C-00000017] channel.c: DTMF begin ‘9’ received on PJSIP/tel.ru-0000001c
21 [2021-12-06 23:19:40] DTMF[2780][C-00000017] channel.c: DTMF begin ignored ‘9’ on PJSIP/tel.ru-0000001c
22 [2021-12-06 23:19:40] DTMF[2780][C-00000017] channel.c: DTMF end ‘9’ received on PJSIP/tel.ru-0000001c, duration 180 ms
23 [2021-12-06 23:19:40] DTMF[2780][C-00000017] channel.c: DTMF end passthrough ‘9’ on PJSIP/tel.ru-0000001c

Were any of 3, 6, 8, and 9 ignored?

It feels like the average figure is disappearing

Yes, here I was typing

235
367
580
496

815 [2021-12-07 14:01:24] DTMF[29136][C-0000006a] channel.c: DTMF begin ‘2’ received on PJSIP/tel.ru-0000012a
816 [2021-12-07 14:01:24] DTMF[29136][C-0000006a] channel.c: DTMF begin ignored ‘2’ on PJSIP/tel.ru-0000012a
817 [2021-12-07 14:01:24] DTMF[29136][C-0000006a] channel.c: DTMF end ‘2’ received on PJSIP/tel.ru-0000012a, duration 180 ms
818 [2021-12-07 14:01:24] DTMF[29136][C-0000006a] channel.c: DTMF end passthrough ‘2’ on PJSIP/tel.ru-0000012a
819 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF begin ‘3’ received on PJSIP/tel.ru-0000012a
820 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF begin ignored ‘3’ on PJSIP/tel.ru-0000012a
821 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF end ‘3’ received on PJSIP/tel.ru-0000012a, duration 160 ms
822 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF end passthrough ‘3’ on PJSIP/tel.ru-0000012a
823 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF begin ‘5’ received on PJSIP/tel.ru-0000012a
824 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF begin ignored ‘5’ on PJSIP/tel.ru-0000012a
825 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF end ‘5’ received on PJSIP/tel.ru-0000012a, duration 180 ms
826 [2021-12-07 14:01:25] DTMF[29136][C-0000006a] channel.c: DTMF end passthrough ‘5’ on PJSIP/tel.ru-0000012a

827 [2021-12-07 14:01:43] DTMF[29216][C-0000006b] channel.c: DTMF begin ‘3’ received on PJSIP/tel.ru-0000012c
828 [2021-12-07 14:01:43] DTMF[29216][C-0000006b] channel.c: DTMF begin ignored ‘3’ on PJSIP/tel.ru-0000012c
829 [2021-12-07 14:01:43] DTMF[29216][C-0000006b] channel.c: DTMF end ‘3’ received on PJSIP/tel.ru-0000012c, duration 180 ms
830 [2021-12-07 14:01:43] DTMF[29216][C-0000006b] channel.c: DTMF end passthrough ‘3’ on PJSIP/tel.ru-0000012c
831 [2021-12-07 14:01:44] DTMF[29216][C-0000006b] channel.c: DTMF begin ‘6’ received on PJSIP/tel.ru-0000012c
832 [2021-12-07 14:01:44] DTMF[29216][C-0000006b] channel.c: DTMF begin ignored ‘6’ on PJSIP/tel.ru-0000012c
833 [2021-12-07 14:01:44] DTMF[29216][C-0000006b] channel.c: DTMF end ‘6’ received on PJSIP/tel.ru-0000012c, duration 180 ms
834 [2021-12-07 14:01:44] DTMF[29216][C-0000006b] channel.c: DTMF end passthrough ‘6’ on PJSIP/tel.ru-0000012c

835 [2021-12-07 14:02:11] DTMF[29410][C-0000006c] channel.c: DTMF begin ‘5’ received on PJSIP/tel.ru-0000012d
836 [2021-12-07 14:02:11] DTMF[29410][C-0000006c] channel.c: DTMF begin ignored ‘5’ on PJSIP/tel.ru-0000012d
837 [2021-12-07 14:02:11] DTMF[29410][C-0000006c] channel.c: DTMF end ‘5’ received on PJSIP/tel.ru-0000012d, duration 180 ms
838 [2021-12-07 14:02:11] DTMF[29410][C-0000006c] channel.c: DTMF end passthrough ‘5’ on PJSIP/tel.ru-0000012d
839 [2021-12-07 14:02:12] DTMF[29410][C-0000006c] channel.c: DTMF begin ‘0’ received on PJSIP/tel.ru-0000012d
840 [2021-12-07 14:02:12] DTMF[29410][C-0000006c] channel.c: DTMF begin ignored ‘0’ on PJSIP/tel.ru-0000012d
841 [2021-12-07 14:02:12] DTMF[29410][C-0000006c] channel.c: DTMF end ‘0’ received on PJSIP/tel.ru-0000012d, duration 180 ms
842 [2021-12-07 14:02:12] DTMF[29410][C-0000006c] channel.c: DTMF end passthrough ‘0’ on PJSIP/tel.ru-0000012d

843 [2021-12-07 14:02:29] DTMF[29514][C-0000006d] channel.c: DTMF begin ‘4’ received on PJSIP/tel.ru-0000012e
844 [2021-12-07 14:02:29] DTMF[29514][C-0000006d] channel.c: DTMF begin ignored ‘4’ on PJSIP/tel.ru-0000012e
845 [2021-12-07 14:02:29] DTMF[29514][C-0000006d] channel.c: DTMF end ‘4’ received on PJSIP/tel.ru-0000012e, duration 200 ms
846 [2021-12-07 14:02:29] DTMF[29514][C-0000006d] channel.c: DTMF end passthrough ‘4’ on PJSIP/tel.ru-0000012e
847 [2021-12-07 14:02:30] DTMF[29514][C-0000006d] channel.c: DTMF begin ‘6’ received on PJSIP/tel.ru-0000012e
848 [2021-12-07 14:02:30] DTMF[29514][C-0000006d] channel.c: DTMF begin ignored ‘6’ on PJSIP/tel.ru-0000012e
849 [2021-12-07 14:02:30] DTMF[29514][C-0000006d] channel.c: DTMF end ‘6’ received on PJSIP/tel.ru-0000012e, duration 180 ms
850 [2021-12-07 14:02:30] DTMF[29514][C-0000006d] channel.c: DTMF end passthrough ‘6’ on PJSIP/tel.ru-0000012e

It looks like the missing digits are not being transmitted by the upstream system. You could double check that using “rtp set debug on”, or using tcpdump and wireshark to capture the RTP before it reaches Asterisk.

By a SIP provider?

I just called the IVR from an internal number and there were no problems, only with external numbers

By whatever is at the other end of the tel.ru trunk (although it could be even further up stream if the DTMF is carried out of band further away (e.g. over a mobile phone network)).

The problem for some reason appears only on iphone 13

Mobile phones transmit DTMF out of band, so it could be the phone itself not sending the digits. I’d suggest calling a real landline number (no VoIP anywhere) and using something like audacity to capture and analyse the actual tones being forwarded by the mobile base station.

This topic was automatically closed 31 days after the last reply. New replies are no longer allowed.