Processing DTMF

Hi here!
I need help with proccesing signal DTMF by asterisk.
I do not understand why the asterisk does not correctly process DTMF signals. Signals arrive at asterisk correctly.
Example:
10.0.0.10 - asterisk
10.0.0.75 - ip-phone Grandstream
Grandstream press buttons 8733, asterisk processed only ‘83’
<

>

-- Executing [188@from-internal-xfer:10] Read("Local/188@from-internal-xfer-000031ba;2", "PIN,enter-conf-pin-number,,,,") in new stack
    -- <Local/188@from-internal-xfer-000031ba;2> Playing 'enter-conf-pin-number.slin' (language 'ru')
[2020-10-08 16:05:23] DTMF[20016][C-00004d17]: channel.c:4084 __ast_read: DTMF end '8' received on SIP/111-0000b7e6, duration 240 ms
[2020-10-08 16:05:23] DTMF[20016][C-00004d17]: channel.c:4111 __ast_read: DTMF begin emulation of '8' with duration 240 queued on SIP/111-0000b7e6
    --  Feature Found: ATXFi-8 exten: ATXFi-8
[2020-10-08 16:05:24] DTMF[20016][C-00004d17]: channel.c:4248 __ast_read: DTMF end emulation of '8' queued on SIP/111-0000b7e6
    --  Feature Found: ATXFi-8 exten: ATXFi-8
[2020-10-08 16:05:24] DTMF[7461][C-00004d17]: channel.c:4084 __ast_read: DTMF end '7' received on SIP/111-0000b7e6, duration 240 ms
[2020-10-08 16:05:24] DTMF[7461][C-00004d17]: channel.c:4154 __ast_read: DTMF end passthrough '7' on SIP/111-0000b7e6
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4170 __ast_read: DTMF begin '8' received on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4174 __ast_read: DTMF begin ignored '8' on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4084 __ast_read: DTMF end '8' received on Local/188@from-internal-xfer-000031ba;2, duration 251 ms
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4154 __ast_read: DTMF end passthrough '8' on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:24] DTMF[20016][C-00004d17]: channel.c:4084 __ast_read: DTMF end '3' received on SIP/111-0000b7e6, duration 240 ms
[2020-10-08 16:05:24] DTMF[20016][C-00004d17]: channel.c:4111 __ast_read: DTMF begin emulation of '3' with duration 240 queued on SIP/111-0000b7e6
    --  Feature Found: ATXFi-3 exten: ATXFi-3
[2020-10-08 16:05:24] DTMF[20016][C-00004d17]: channel.c:4248 __ast_read: DTMF end emulation of '3' queued on SIP/111-0000b7e6
    --  Feature Found: ATXFi-3 exten: ATXFi-3
[2020-10-08 16:05:24] DTMF[7461][C-00004d17]: channel.c:4084 __ast_read: DTMF end '3' received on SIP/111-0000b7e6, duration 240 ms
[2020-10-08 16:05:24] DTMF[7461][C-00004d17]: channel.c:4154 __ast_read: DTMF end passthrough '3' on SIP/111-0000b7e6
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4170 __ast_read: DTMF begin '3' received on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:24] DTMF[20028][C-00004d17]: channel.c:4174 __ast_read: DTMF begin ignored '3' on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4084 __ast_read: DTMF end '3' received on Local/188@from-internal-xfer-000031ba;2, duration 261 ms
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4154 __ast_read: DTMF end passthrough '3' on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:25] DTMF[20016][C-00004d17]: channel.c:4084 __ast_read: DTMF end '#' received on SIP/111-0000b7e6, duration 240 ms
[2020-10-08 16:05:25] DTMF[20016][C-00004d17]: channel.c:4111 __ast_read: DTMF begin emulation of '#' with duration 240 queued on SIP/111-0000b7e6
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4170 __ast_read: DTMF begin '#' received on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4174 __ast_read: DTMF begin ignored '#' on Local/188@from-internal-xfer-000031ba;2
[2020-10-08 16:05:25] DTMF[20016][C-00004d17]: channel.c:4248 __ast_read: DTMF end emulation of '#' queued on SIP/111-0000b7e6
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4084 __ast_read: DTMF end '#' received on Local/188@from-internal-xfer-000031ba;2, duration 250 ms
[2020-10-08 16:05:25] DTMF[20028][C-00004d17]: channel.c:4154 __ast_read: DTMF end passthrough '#' on Local/188@from-internal-xfer-000031ba;2
    -- User entered '83'

If press the buttons slowly - its working!
Why it happens?

Is there a reason you’re using INFO DTMF? It’s highly recommended to use RFC2833/RFC4733, as INFO DTMF is actually received after DTMF completes.

DTMF INFO i using for illustrative purposes. With RFC2833 same
User press 8733, processing 873

Снимок экрана от 2020-10-13 11-47-44

-- <Local/188@from-internal-xfer-00003291;2> Playing 'enter-conf-pin-number.slin' (language 'ru')
[2020-10-13 11:41:19] DTMF[25970][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '8' received on SIP/111-0000bc0f
[2020-10-13 11:41:19] DTMF[25970][C-00004efe]: channel.c:4181 __ast_read: DTMF begin passthrough '8' on SIP/111-0000bc0f
    --  Feature Found: ATXFi-8 exten: ATXFi-8
[2020-10-13 11:41:19] DTMF[25970][C-00004efe]: channel.c:4084 __ast_read: DTMF end '8' received on SIP/111-0000bc0f, duration 160 ms
[2020-10-13 11:41:19] DTMF[25970][C-00004efe]: channel.c:4125 __ast_read: DTMF end accepted with begin '8' on SIP/111-0000bc0f
[2020-10-13 11:41:19] DTMF[25970][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '8' on SIP/111-0000bc0f
    --  Feature Found: ATXFi-8 exten: ATXFi-8
[2020-10-13 11:41:19] DTMF[26077][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '8' received on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:19] DTMF[26077][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '8' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:19] DTMF[7461][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '7' received on SIP/111-0000bc0f
[2020-10-13 11:41:19] DTMF[7461][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '7' on SIP/111-0000bc0f
[2020-10-13 11:41:19] DTMF[26077][C-00004efe]: channel.c:4084 __ast_read: DTMF end '8' received on Local/188@from-internal-xfer-00003291;2, duration 160 ms
[2020-10-13 11:41:19] DTMF[26077][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '8' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4084 __ast_read: DTMF end '7' received on SIP/111-0000bc0f, duration 160 ms
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4111 __ast_read: DTMF begin emulation of '7' with duration 160 queued on SIP/111-0000bc0f
    --  Feature Found: ATXFi-7 exten: ATXFi-7
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4248 __ast_read: DTMF end emulation of '7' queued on SIP/111-0000bc0f
    --  Feature Found: ATXFi-7 exten: ATXFi-7
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '7' received on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '7' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:20] DTMF[7461][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '3' received on SIP/111-0000bc0f
[2020-10-13 11:41:20] DTMF[7461][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '3' on SIP/111-0000bc0f
[2020-10-13 11:41:20] DTMF[7461][C-00004efe]: channel.c:4084 __ast_read: DTMF end '3' received on SIP/111-0000bc0f, duration 160 ms
[2020-10-13 11:41:20] DTMF[7461][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '3' on SIP/111-0000bc0f
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4084 __ast_read: DTMF end '7' received on Local/188@from-internal-xfer-00003291;2, duration 178 ms
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '7' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '3' received on SIP/111-0000bc0f
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4181 __ast_read: DTMF begin passthrough '3' on SIP/111-0000bc0f
    --  Feature Found: ATXFi-3 exten: ATXFi-3
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4084 __ast_read: DTMF end '3' received on SIP/111-0000bc0f, duration 160 ms
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4125 __ast_read: DTMF end accepted with begin '3' on SIP/111-0000bc0f
[2020-10-13 11:41:20] DTMF[25970][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '3' on SIP/111-0000bc0f
    --  Feature Found: ATXFi-3 exten: ATXFi-3
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '3' received on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:20] DTMF[26077][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '3' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4084 __ast_read: DTMF end '3' received on Local/188@from-internal-xfer-00003291;2, duration 160 ms
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '3' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:21] DTMF[25970][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '#' received on SIP/111-0000bc0f
[2020-10-13 11:41:21] DTMF[25970][C-00004efe]: channel.c:4181 __ast_read: DTMF begin passthrough '#' on SIP/111-0000bc0f
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4170 __ast_read: DTMF begin '#' received on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4174 __ast_read: DTMF begin ignored '#' on Local/188@from-internal-xfer-00003291;2
[2020-10-13 11:41:21] DTMF[25970][C-00004efe]: channel.c:4084 __ast_read: DTMF end '#' received on SIP/111-0000bc0f, duration 160 ms
[2020-10-13 11:41:21] DTMF[25970][C-00004efe]: channel.c:4125 __ast_read: DTMF end accepted with begin '#' on SIP/111-0000bc0f
[2020-10-13 11:41:21] DTMF[25970][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '#' on SIP/111-0000bc0f
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4084 __ast_read: DTMF end '#' received on Local/188@from-internal-xfer-00003291;2, duration 160 ms
[2020-10-13 11:41:21] DTMF[26077][C-00004efe]: channel.c:4154 __ast_read: DTMF end passthrough '#' on Local/188@from-internal-xfer-00003291;2
    -- User entered '873'

What version of Asterisk are you using?

Asterisk 11.6-cert4
relaxdtmf=yes/no - It does not help

Personally I don’t support old versions of Asterisk, as many times issues in them have been resolved in later versions.

Also, this is an old version of Asterisk 11. The final version was 11.25.3. Also, unless you have paid support from Sangoma, you should not be using cert versions, if a more recent version exists.