IVR не переводит звонок

Добрый день.

Вот так настроена ivr меню

Режим DTMF выбран авто в сотрудниках и в настройках провайдера.

При входящем звонке проигрывается звуковой файл, но при вводе доп. номера переадресация не происходит.

Подскажите куда стоит смотреть для решения этой проблемы?

В разделе "Системные логи" следует смотреть лог asterisk/verbose
В нем видно, что пришло через DTMF. 

Как минимум логи приложите.

Что вообще происходит при нажатии той или иной комбинации.

такое может быть если есть проблемы с настройкой NAT, когда со стороны звонящего на АТС нет звука

Вот лог asterisk/verbose правда не понял как можно его выложить сразу весь. При звонке проигрывается звуковой сигнал, пытаюсь нажать 1 и ничего не происходит
pbx.c: Executing [738********@SIP-1654673162-incoming:1] NoOp("PJSIP/SIP-1654673162-00000007", "--- Incoming call ---") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:2] Set("PJSIP/SIP-1654673162-00000007", "CHANNEL(language)=ru-ru") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:3] Set("PJSIP/SIP-1654673162-00000007", "CHANNEL(hangup_handler_wipe)=hangup_handler,s,1") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:4] Set("PJSIP/SIP-1654673162-00000007", "__FROM_DID=738********") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:5] Set("PJSIP/SIP-1654673162-00000007", "__FROM_CHAN=PJSIP/SIP-1654673162-00000007") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:6] ExecIf("PJSIP/SIP-1654673162-00000007", "1?Gosub(set_from_peer,s,1)") in new stack
pbx_lua.c: Executing [s@set_from_peer:1] NoOp("PJSIP/SIP-1654673162-00000007", "__FROM_PEER set to SIP-1654673162")
pbx_lua.c: Executing [s@set_from_peer:1] return("PJSIP/SIP-1654673162-00000007", "")
pbx.c: Executing [738********@SIP-1654673162-incoming:7] ExecIf("PJSIP/SIP-1654673162-00000007", "0?Set(__FROM_PEER=895********)") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:8] Gosub("PJSIP/SIP-1654673162-00000007", "add-trim-prefix-clid,738********,1") in new stack
pbx.c: Executing [738********@add-trim-prefix-clid:1] NoOp("PJSIP/SIP-1654673162-00000007", "--- Incoming call from 895******** ---") in new stack
pbx.c: Executing [738********@add-trim-prefix-clid:2] GosubIf("PJSIP/SIP-1654673162-00000007", "0?add-trim-prefix-clid-custom,738********,1") in new stack
pbx.c: Executing [738********@add-trim-prefix-clid:3] Return("PJSIP/SIP-1654673162-00000007", "") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:9] Set("PJSIP/SIP-1654673162-00000007", "__TRANSFER_OPTIONS=t") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:10] Gosub("PJSIP/SIP-1654673162-00000007", "check-out-work-time,738********,1") in new stack
pbx.c: Executing [738********@check-out-work-time:1] Set("PJSIP/SIP-1654673162-00000007", "currentYear=2022") in new stack
pbx.c: Executing [738********@check-out-work-time:2] GosubIf("PJSIP/SIP-1654673162-00000007", "0?check-out-work-time-2022,738********,1") in new stack
pbx.c: Executing [738********@check-out-work-time:3] ExecIfTime("PJSIP/SIP-1654673162-00000007", "00:00-09:00,mon-fri,*,*?Goto(work-time-set-var-1,738********,1)") in new stack
pbx.c: Executing [738********@check-out-work-time:4] ExecIfTime("PJSIP/SIP-1654673162-00000007", "18:00-23:00,mon-fri,*,*?Goto(work-time-set-var-2,738********,1)") in new stack
pbx.c: Executing [738********@check-out-work-time:5] ExecIfTime("PJSIP/SIP-1654673162-00000007", "00:00-23:00,sat-sun,*,*?Goto(work-time-set-var-3,738********,1)") in new stack
pbx.c: Executing [738********@check-out-work-time:6] Return("PJSIP/SIP-1654673162-00000007", "") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:11] Set("PJSIP/SIP-1654673162-00000007", "IN_NEED_ANNONCE=1") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:12] GosubIf("PJSIP/SIP-1654673162-00000007", "0?SIP-1654673162-incoming-custom,738********,1") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:13] Set("PJSIP/SIP-1654673162-00000007", "M_TIMEOUT=0") in new stack
pbx.c: Executing [738********@SIP-1654673162-incoming:14] ExecIf("PJSIP/SIP-1654673162-00000007", "1?Dial(Local/2201@internal,,tKg)") in new stack
app_dial.c: Called Local/2201@internal
pbx.c: Executing [2201@internal:1] Goto("Local/2201@internal-00000005;2", "ivr-2201,s,1") in new stack
pbx_builtins.c: Goto (ivr-2201,s,1)
pbx.c: Executing [s@ivr-2201:1] ExecIf("Local/2201@internal-00000005;2", "1?Gosub(set_orign_chan,s,1)") in new stack
pbx.c: Executing [s@set_orign_chan:1] Wait("Local/2201@internal-00000005;2", "0.2") in new stack
pbx.c: Executing [s@set_orign_chan:2] Set("Local/2201@internal-00000005;2", "pl=1") in new stack
pbx.c: Executing [s@set_orign_chan:3] Set("Local/2201@internal-00000005;2", "orign_chan=") in new stack
pbx.c: Executing [s@set_orign_chan:4] ExecIf("Local/2201@internal-00000005;2", "1?Set(orign_chan=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:5] ExecIf("Local/2201@internal-00000005;2", "0?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:6] ExecIf("Local/2201@internal-00000005;2", "0?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:7] ExecIf("Local/2201@internal-00000005;2", "0?Set(__FROM_CHAN=)") in new stack
pbx.c: Executing [s@set_orign_chan:8] Return("Local/2201@internal-00000005;2", "") in new stack
pbx.c: Executing [s@ivr-2201:2] Set("Local/2201@internal-00000005;2", "APPEXTEN=2201") in new stack
pbx.c: Executing [s@ivr-2201:3] Gosub("Local/2201@internal-00000005;2", "dial_app,s,1") in new stack
pbx_lua.c: Executing [s@dial_app:1] CELGenUserEvent("Local/2201@internal-00000005;2", "eyJJU19PUkdOVCI6ZmFsc2UsIlVOSVFVRUlEIjoibWlrb3BieC0xNjU1NDM2MDcwLjE5XzMxMDgzZCIsImFjdGlvbiI6ImRpYWwiLCJhZ2lfY2hhbm5lbCI6IkxvY2FsLzIyMDAxMDBAaW50ZXJuYWwtMDAwMDAwMDU7MiIsImRpZCI6IjczODQzMzIwMjIwIiwiZHN0X2NoYW4iOiJBcHA6MjIwMDEwMCIsImRzdF9udW0iOiIyMjAwMTAwIiwiZnJvbV9hY2NvdW50IjoiU0lQLTE2NTQ2NzMxNjIiLCJpc19hcHAiOjEsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3Iiwic3JjX2NoYW4iOiJQSlNJUC9TSVAtMTY1NDY3MzE2Mi0wMDAwMDAwNyIsInNyY19udW0iOiI4OTUxMTc3NTMxOSIsInN0YXJ0IjoiMjAyMi0wNi0xNyAxMDoyMToxMS41NzIiLCJ0cmFuc2ZlciI6IjAiLCJ2ZXJib3NlX2NhbGxfaWQiOiJbQy0wMDAwMDAwNV0ifQ==")
pbx_lua.c: Executing [s@dial_app:1] UserEvent("Local/2201@internal-00000005;2", "CdrConnector,AgiData:eyJJU19PUkdOVCI6ZmFsc2UsIlVOSVFVRUlEIjoibWlrb3BieC0xNjU1NDM2MDcwLjE5XzMxMDgzZCIsImFjdGlvbiI6ImRpYWwiLCJhZ2lfY2hhbm5lbCI6IkxvY2FsLzIyMDAxMDBAaW50ZXJuYWwtMDAwMDAwMDU7MiIsImRpZCI6IjczODQzMzIwMjIwIiwiZHN0X2NoYW4iOiJBcHA6MjIwMDEwMCIsImRzdF9udW0iOiIyMjAwMTAwIiwiZnJvbV9hY2NvdW50IjoiU0lQLTE2NTQ2NzMxNjIiLCJpc19hcHAiOjEsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3Iiwic3JjX2NoYW4iOiJQSlNJUC9TSVAtMTY1NDY3MzE2Mi0wMDAwMDAwNyIsInNyY19udW0iOiI4OTUxMTc3NTMxOSIsInN0YXJ0IjoiMjAyMi0wNi0xNyAxMDoyMToxMS41NzIiLCJ0cmFuc2ZlciI6IjAiLCJ2ZXJib3NlX2NhbGxfaWQiOiJbQy0wMDAwMDAwNV0ifQ==")
pbx_lua.c: Executing [s@dial_app:1] return("Local/2201@internal-00000005;2", "")
pbx.c: Executing [s@ivr-2201:4] Answer("Local/2201@internal-00000005;2", "") in new stack
app_dial.c: Local/2201@internal-00000005;1 answered PJSIP/SIP-1654673162-00000007
bridge_channel.c: Channel Local/2201@internal-00000005;1 joined 'simple_bridge' basic-bridge <e899b8cb-4467-4142-8fe6-8fc1822e89df>
bridge_channel.c: Channel PJSIP/SIP-1654673162-00000007 joined 'simple_bridge' basic-bridge <e899b8cb-4467-4142-8fe6-8fc1822e89df>
pbx.c: Executing [s@ivr-2201:5] Set("Local/2201@internal-00000005;2", "try_count=0") in new stack
pbx.c: Executing [s@ivr-2201:6] Set("Local/2201@internal-00000005;2", "try_count=1") in new stack
pbx.c: Executing [s@ivr-2201:7] GotoIf("Local/2201@internal-00000005;2", "0?internal,2001,1") in new stack
pbx.c: Executing [s@ivr-2201:8] Set("Local/2201@internal-00000005;2", "TIMEOUT(digit)=2") in new stack
func_timeout.c: Digit timeout set to 2.000
pbx.c: Executing [s@ivr-2201:9] BackGround("Local/2201@internal-00000005;2", "/storage/usbdisk1/mikopbx/media/custom/miko_hello") in new stack
file.c: <Local/2201@internal-00000005;2> Playing '/storage/usbdisk1/mikopbx/media/custom/miko_hello.slin' (language 'ru-ru')
pbx.c: Executing [s@ivr-2201:10] WaitExten("Local/2201@internal-00000005;2", "10") in new stack
pbx_builtins.c: Timeout on Local/2201@internal-00000005;2, going to 't'
pbx.c: Executing [t@ivr-2201:1] Goto("Local/2201@internal-00000005;2", "s,6") in new stack
pbx_builtins.c: Goto (ivr-2201,s,6)
pbx.c: Executing [s@ivr-2201:6] Set("Local/2201@internal-00000005;2", "try_count=2") in new stack
pbx.c: Executing [s@ivr-2201:7] GotoIf("Local/2201@internal-00000005;2", "1?internal,2001,1") in new stack
pbx_builtins.c: Goto (internal,2001,1)
pbx.c: Executing [2001@internal:1] NoOp("Local/2201@internal-00000005;2", "--- Start Queue ---") in new stack
pbx.c: Executing [2001@internal:2] Answer("Local/2201@internal-00000005;2", "") in new stack
pbx.c: Executing [2001@internal:3] Set("Local/2201@internal-00000005;2", "__QUEUE_SRC_CHAN=Local/2201@internal-00000005;2") in new stack
pbx.c: Executing [2001@internal:4] ExecIf("Local/2201@internal-00000005;2", "1?Gosub(set_orign_chan,s,1)") in new stack
pbx.c: Executing [s@set_orign_chan:1] Wait("Local/2201@internal-00000005;2", "0.2") in new stack
pbx.c: Executing [s@set_orign_chan:2] Set("Local/2201@internal-00000005;2", "pl=1") in new stack
pbx.c: Executing [s@set_orign_chan:3] Set("Local/2201@internal-00000005;2", "orign_chan=PJSIP/SIP-1654673162-00000007") in new stack
pbx.c: Executing [s@set_orign_chan:4] ExecIf("Local/2201@internal-00000005;2", "0?Set(orign_chan=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:5] ExecIf("Local/2201@internal-00000005;2", "1?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:6] ExecIf("Local/2201@internal-00000005;2", "0?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:7] ExecIf("Local/2201@internal-00000005;2", "0?Set(__FROM_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:8] Return("Local/2201@internal-00000005;2", "") in new stack
pbx.c: Executing [2001@internal:5] Set("Local/2201@internal-00000005;2", "CHANNEL(hangup_handler_wipe)=hangup_handler,s,1") in new stack
pbx.c: Executing [2001@internal:6] Gosub("Local/2201@internal-00000005;2", "queue_start,2001,1") in new stack
pbx_lua.c: Executing [2001@queue_start:1] CELGenUserEvent("Local/2201@internal-00000005;2", "eyJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjA3MC4xOV9pdDQ3N0IiLCJhY3Rpb24iOiJxdWV1ZV9zdGFydCIsImRpZCI6IjczODQzMzIwMjIwIiwiZHN0X2NoYW4iOiJRdWV1ZToyMDAxIiwiZHN0X251bSI6IjIwMDEiLCJpc19hcHAiOiIxIiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfY2hhbiI6IlBKU0lQL1NJUC0xNjU0NjczMTYyLTAwMDAwMDA3Iiwic3JjX251bSI6Ijg5NTExNzc1MzE5Iiwic3RhcnQiOiIyMDIyLTA2LTE3IDEwOjIxOjQ1LjAyNyIsInRyYW5zZmVyIjoiMCJ9")
pbx_lua.c: Executing [2001@queue_start:1] UserEvent("Local/2201@internal-00000005;2", "CdrConnector,AgiData:eyJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjA3MC4xOV9pdDQ3N0IiLCJhY3Rpb24iOiJxdWV1ZV9zdGFydCIsImRpZCI6IjczODQzMzIwMjIwIiwiZHN0X2NoYW4iOiJRdWV1ZToyMDAxIiwiZHN0X251bSI6IjIwMDEiLCJpc19hcHAiOiIxIiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfY2hhbiI6IlBKU0lQL1NJUC0xNjU0NjczMTYyLTAwMDAwMDA3Iiwic3JjX251bSI6Ijg5NTExNzc1MzE5Iiwic3RhcnQiOiIyMDIyLTA2LTE3IDEwOjIxOjQ1LjAyNyIsInRyYW5zZmVyIjoiMCJ9")
pbx_lua.c: Executing [2001@queue_start:1] return("Local/2201@internal-00000005;2", "")
pbx.c: Executing [2001@internal:7] Queue("Local/2201@internal-00000005;2", "QUEUE-F38325E796B3FFB8938BA383AA119148,kT,,,300,,,queue_agent_answer") in new stack
res_musiconhold.c: Started music on hold, class 'default', on channel 'Local/2201@internal-00000005;2'
app_queue.c: Called Local/404@internal/n
pbx.c: Executing [404@internal:1] Goto("Local/404@internal-00000006;2", "internal-users,404,1") in new stack
pbx_builtins.c: Goto (internal-users,404,1)
pbx.c: Executing [404@internal-users:1] Set("Local/404@internal-00000006;2", "CHANNEL(hangup_handler_wipe)=hangup_handler,s,1") in new stack
pbx.c: Executing [404@internal-users:2] ExecIf("Local/404@internal-00000006;2", "0?Set(SIPADDHEADER01=") in new stack
pbx.c: Executing [404@internal-users:3] ExecIf("Local/404@internal-00000006;2", "1?Gosub(set_orign_chan,s,1)") in new stack
pbx.c: Executing [s@set_orign_chan:1] Wait("Local/404@internal-00000006;2", "0.2") in new stack
pbx.c: Executing [s@set_orign_chan:2] Set("Local/404@internal-00000006;2", "pl=1") in new stack
pbx.c: Executing [s@set_orign_chan:3] Set("Local/404@internal-00000006;2", "orign_chan=") in new stack
pbx.c: Executing [s@set_orign_chan:4] ExecIf("Local/404@internal-00000006;2", "1?Set(orign_chan=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:5] ExecIf("Local/404@internal-00000006;2", "1?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:6] ExecIf("Local/404@internal-00000006;2", "0?Set(__QUEUE_SRC_CHAN=PJSIP/SIP-1654673162-00000007)") in new stack
pbx.c: Executing [s@set_orign_chan:7] ExecIf("Local/404@internal-00000006;2", "0?Set(__FROM_CHAN=)") in new stack
pbx.c: Executing [s@set_orign_chan:8] Return("Local/404@internal-00000006;2", "") in new stack
pbx.c: Executing [404@internal-users:4] Gosub("Local/404@internal-00000006;2", "dial,404,1") in new stack
pbx_lua.c: Executing [404@dial:1] CELGenUserEvent("Local/404@internal-00000006;2", "eyJJU19PUkdOVCI6ZmFsc2UsIlVOSVFVRUlEIjoibWlrb3BieC0xNjU1NDM2MTA1LjIxXzFHODkyUyIsImFjdGlvbiI6ImRpYWwiLCJhZ2lfY2hhbm5lbCI6IkxvY2FsLzQwNEBpbnRlcm5hbC0wMDAwMDAwNjsyIiwiZGlkIjoiNzM4NDMzMjAyMjAiLCJkc3RfbnVtIjoiNDA0IiwiZnJvbV9hY2NvdW50IjoiU0lQLTE2NTQ2NzMxNjIiLCJsaW5rZWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xNyIsInNyY19jaGFuIjoiUEpTSVAvU0lQLTE2NTQ2NzMxNjItMDAwMDAwMDciLCJzcmNfbnVtIjoiODk1MTE3NzUzMTkiLCJzdGFydCI6IjIwMjItMDYtMTcgMTA6MjE6NDUuMDQ4IiwidHJhbnNmZXIiOiIwIiwidmVyYm9zZV9jYWxsX2lkIjoiW0MtMDAwMDAwMDVdIn0=")
pbx_lua.c: Executing [404@dial:1] UserEvent("Local/404@internal-00000006;2", "CdrConnector,AgiData:eyJJU19PUkdOVCI6ZmFsc2UsIlVOSVFVRUlEIjoibWlrb3BieC0xNjU1NDM2MTA1LjIxXzFHODkyUyIsImFjdGlvbiI6ImRpYWwiLCJhZ2lfY2hhbm5lbCI6IkxvY2FsLzQwNEBpbnRlcm5hbC0wMDAwMDAwNjsyIiwiZGlkIjoiNzM4NDMzMjAyMjAiLCJkc3RfbnVtIjoiNDA0IiwiZnJvbV9hY2NvdW50IjoiU0lQLTE2NTQ2NzMxNjIiLCJsaW5rZWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xNyIsInNyY19jaGFuIjoiUEpTSVAvU0lQLTE2NTQ2NzMxNjItMDAwMDAwMDciLCJzcmNfbnVtIjoiODk1MTE3NzUzMTkiLCJzdGFydCI6IjIwMjItMDYtMTcgMTA6MjE6NDUuMDQ4IiwidHJhbnNmZXIiOiIwIiwidmVyYm9zZV9jYWxsX2lkIjoiW0MtMDAwMDAwMDVdIn0=")
pbx_lua.c: Executing [404@dial:1] return("Local/404@internal-00000006;2", "")
pbx.c: Executing [404@internal-users:5] ExecIf("Local/404@internal-00000006;2", "0?Goto(internal-num-undefined,404,1)") in new stack
pbx.c: Executing [404@internal-users:6] ExecIf("Local/404@internal-00000006;2", "0?Set(DIALSTATUS=BUSY)") in new stack
pbx.c: Executing [404@internal-users:7] GotoIf("Local/404@internal-00000006;2", "0?fw_start") in new stack
pbx.c: Executing [404@internal-users:8] Set("Local/404@internal-00000006;2", "ringlength=") in new stack
pbx.c: Executing [404@internal-users:9] ExecIf("Local/404@internal-00000006;2", "1?Set(ringlength=600)") in new stack
pbx.c: Executing [404@internal-users:10] ExecIf("Local/404@internal-00000006;2", "1?Set(ringlength=600)") in new stack
pbx.c: Executing [404@internal-users:11] GosubIf("Local/404@internal-00000006;2", "0?internal-users-custom,404,1") in new stack
pbx.c: Executing [404@internal-users:12] Gosub("Local/404@internal-00000006;2", "set-dial-contacts,404,1") in new stack
pbx.c: Executing [404@set-dial-contacts:1] NoOp("Local/404@internal-00000006;2", "") in new stack
pbx.c: Executing [404@set-dial-contacts:2] Set("Local/404@internal-00000006;2", "DST_CONTACT=PJSIP/404/sip:404@192.168.*.*:5070") in new stack
pbx.c: Executing [404@set-dial-contacts:3] Return("Local/404@internal-00000006;2", "") in new stack
pbx.c: Executing [404@internal-users:13] ExecIf("Local/404@internal-00000006;2", "0?Set(__PT1C_SIP_HEADER=)") in new stack
pbx.c: Executing [404@internal-users:14] ExecIf("Local/404@internal-00000006;2", "0?Set(TRANSFER_OPTIONS=Tt)") in new stack
pbx.c: Executing [404@internal-users:15] ExecIf("Local/404@internal-00000006;2", "1?Dial(PJSIP/404/sip:404@192.168.*.*:5070,600,tekKHhU(dial_answer)b(dial_create_chan,s,1)):Set(DIALSTATUS=CHANUNAVAIL)") in new stack
app_stack.c: PJSIP/404-00000008 Internal Gosub(dial_create_chan,s,1) start
pbx.c: Executing [s@dial_create_chan:1] Gosub("PJSIP/404-00000008", "lua_dial_create_chan,s,1") in new stack
pbx_lua.c: Executing [s@lua_dial_create_chan:1] NoOp("PJSIP/404-00000008", "to_account set to 404")
pbx_lua.c: Executing [s@lua_dial_create_chan:1] CELGenUserEvent("PJSIP/404-00000008", "eyJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJkaWFsX2NyZWF0ZV9jaGFuIiwiZHN0X2NhbGxfaWQiOiI1ZGUwMzIzNy1kZTQyLTRlMjgtYWUwZS1mNjEzZGM3ZjBlNGMiLCJkc3RfY2hhbiI6IlBKU0lQLzQwNC0wMDAwMDAwOCIsImV2ZW50X3RpbWUiOiIyMDIyLTA2LTE3IDEwOjIxOjQ1LjA3OCIsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3IiwidG9fYWNjb3VudCI6IjQwNCJ9")
pbx_lua.c: Executing [s@lua_dial_create_chan:1] UserEvent("PJSIP/404-00000008", "CdrConnector,AgiData:eyJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJkaWFsX2NyZWF0ZV9jaGFuIiwiZHN0X2NhbGxfaWQiOiI1ZGUwMzIzNy1kZTQyLTRlMjgtYWUwZS1mNjEzZGM3ZjBlNGMiLCJkc3RfY2hhbiI6IlBKU0lQLzQwNC0wMDAwMDAwOCIsImV2ZW50X3RpbWUiOiIyMDIyLTA2LTE3IDEwOjIxOjQ1LjA3OCIsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3IiwidG9fYWNjb3VudCI6IjQwNCJ9")
pbx_lua.c: Executing [s@lua_dial_create_chan:1] return("PJSIP/404-00000008", "")
pbx.c: Executing [s@dial_create_chan:2] Set("PJSIP/404-00000008", "pt1c_is_dst=1") in new stack
pbx.c: Executing [s@dial_create_chan:3] ExecIf("PJSIP/404-00000008", "0?Set(PJSIP_HEADER(add,)=)") in new stack
pbx.c: Executing [s@dial_create_chan:4] Set("PJSIP/404-00000008", "__PT1C_SIP_HEADER=") in new stack
pbx.c: Executing [s@dial_create_chan:5] Set("PJSIP/404-00000008", "CHANNEL(hangup_handler_wipe)=hangup_handler,s,1") in new stack
pbx.c: Executing [s@dial_create_chan:6] Return("PJSIP/404-00000008", "") in new stack
app_stack.c: Spawn extension (all_peers, 404, 1) exited non-zero on 'PJSIP/404-00000008'
app_stack.c: PJSIP/404-00000008 Internal Gosub(dial_create_chan,s,1) complete GOSUB_RETVAL=
app_dial.c: Called PJSIP/404/sip:404@192.168.*.*:5070
app_dial.c: PJSIP/404-00000008 is ringing
app_queue.c: Local/404@internal-00000006;1 is ringing
app_stack.c: PJSIP/404-00000008 Internal Gosub(hangup_handler,s,1) start
pbx.c: Executing [s@hangup_handler:1] NoOp("PJSIP/404-00000008", "--- hangup - PJSIP/404-00000008 ---") in new stack
pbx.c: Executing [s@hangup_handler:2] Gosub("PJSIP/404-00000008", "hangup_chan,s,1") in new stack
pbx_lua.c: Executing [s@hangup_chan:1] CELGenUserEvent("PJSIP/404-00000008", "eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJoYW5ndXBfY2hhbiIsImFnaV9jaGFubmVsIjoiUEpTSVAvNDA0LTAwMDAwMDA4IiwiYWdpX3RocmVhZGlkIjoibWlrb3BieC0xNjU1NDM2MTA1LjIyXzg1OGtlWCIsImRpYWxzdGF0dXMiOiIiLCJkaWQiOiI3Mzg0MzMyMDIyMCIsImVuZCI6IjIwMjItMDYtMTcgMTA6MjE6NTIuMTg5IiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfbnVtIjoiNDA0In0=")
pbx_lua.c: Executing [s@hangup_chan:1] UserEvent("PJSIP/404-00000008", "CdrConnector,AgiData:eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJoYW5ndXBfY2hhbiIsImFnaV9jaGFubmVsIjoiUEpTSVAvNDA0LTAwMDAwMDA4IiwiYWdpX3RocmVhZGlkIjoibWlrb3BieC0xNjU1NDM2MTA1LjIyXzg1OGtlWCIsImRpYWxzdGF0dXMiOiIiLCJkaWQiOiI3Mzg0MzMyMDIyMCIsImVuZCI6IjIwMjItMDYtMTcgMTA6MjE6NTIuMTg5IiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfbnVtIjoiNDA0In0=")
pbx_lua.c: Executing [s@hangup_chan:1] return("PJSIP/404-00000008", "")
pbx.c: Executing [s@hangup_handler:3] Return("PJSIP/404-00000008", "") in new stack
app_stack.c: Spawn extension (all_peers, 404, 1) exited non-zero on 'PJSIP/404-00000008'
app_stack.c: PJSIP/404-00000008 Internal Gosub(hangup_handler,s,1) complete GOSUB_RETVAL=
app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
pbx.c: Executing [404@internal-users:16] NoOp("Local/404@internal-00000006;2", "start dial hangup") in new stack
pbx.c: Executing [404@internal-users:17] ExecIf("Local/404@internal-00000006;2", "0?Goto(internal-fw,404,1)") in new stack
pbx.c: Executing [404@internal-users:18] ExecIf("Local/404@internal-00000006;2", "0?Goto(internal-fw,404,1)") in new stack
pbx.c: Executing [404@internal-users:19] ExecIf("Local/404@internal-00000006;2", "0?AGI(check_redirect.php,)") in new stack
pbx.c: Executing [404@internal-users:20] Hangup("Local/404@internal-00000006;2", "") in new stack
pbx.c: Spawn extension (internal-users, 404, 20) exited non-zero on 'Local/404@internal-00000006;2'
pbx.c: Executing [h@internal-users:1] ExecIf("Local/404@internal-00000006;2", "0?Goto(transfer_dial_hangup,h,1)") in new stack
app_stack.c: Local/404@internal-00000006;2 Internal Gosub(hangup_handler,s,1) start
pbx.c: Executing [s@hangup_handler:1] NoOp("Local/404@internal-00000006;2", "--- hangup - Local/404@internal-00000006;2 ---") in new stack
pbx.c: Executing [s@hangup_handler:2] Gosub("Local/404@internal-00000006;2", "hangup_chan,s,1") in new stack
pbx_lua.c: Executing [s@hangup_chan:1] CELGenUserEvent("Local/404@internal-00000006;2", "eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJoYW5ndXBfY2hhbiIsImFnaV9jaGFubmVsIjoiTG9jYWwvNDA0QGludGVybmFsLTAwMDAwMDA2OzIiLCJhZ2lfdGhyZWFkaWQiOiJtaWtvcGJ4LTE2NTU0MzYxMDUuMjFfNGg2b003IiwiZGlhbHN0YXR1cyI6IkNIQU5VTkFWQUlMIiwiZGlkIjoiNzM4NDMzMjAyMjAiLCJlbmQiOiIyMDIyLTA2LTE3IDEwOjIxOjUyLjIwNCIsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3Iiwic3JjX251bSI6Ijg5NTExNzc1MzE5In0=")
pbx_lua.c: Executing [s@hangup_chan:1] UserEvent("Local/404@internal-00000006;2", "CdrConnector,AgiData:eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6Im1pa29wYngtMTY1NTQzNjEwNS4yMV8xRzg5MlMiLCJhY3Rpb24iOiJoYW5ndXBfY2hhbiIsImFnaV9jaGFubmVsIjoiTG9jYWwvNDA0QGludGVybmFsLTAwMDAwMDA2OzIiLCJhZ2lfdGhyZWFkaWQiOiJtaWtvcGJ4LTE2NTU0MzYxMDUuMjFfNGg2b003IiwiZGlhbHN0YXR1cyI6IkNIQU5VTkFWQUlMIiwiZGlkIjoiNzM4NDMzMjAyMjAiLCJlbmQiOiIyMDIyLTA2LTE3IDEwOjIxOjUyLjIwNCIsImxpbmtlZGlkIjoibWlrb3BieC0xNjU1NDM2MDcwLjE3Iiwic3JjX251bSI6Ijg5NTExNzc1MzE5In0=")
pbx_lua.c: Executing [s@hangup_chan:1] return("Local/404@internal-00000006;2", "")
pbx.c: Executing [s@hangup_handler:3] Return("Local/404@internal-00000006;2", "") in new stack
app_stack.c: Spawn extension (internal-users, h, 2) exited non-zero on 'Local/404@internal-00000006;2'
app_stack.c: Local/404@internal-00000006;2 Internal Gosub(hangup_handler,s,1) complete GOSUB_RETVAL=
app_queue.c: Nobody picked up in 7000 ms
res_musiconhold.c: Stopped music on hold on Local/2201@internal-00000005;2
file.c: <Local/2201@internal-00000005;2> Playing 'queue-youarenext.gsm' (language 'ru-ru')
app_queue.c: Told Local/2201@internal-00000005;2 in QUEUE-F38325E796B3FFB8938BA383AA119148 their queue position (which was 1)
file.c: <Local/2201@internal-00000005;2> Playing 'queue-thankyou.gsm' (language 'ru-ru')
bridge_channel.c: Channel PJSIP/SIP-1654673162-00000007 left 'simple_bridge' basic-bridge <e899b8cb-4467-4142-8fe6-8fc1822e89df>
bridge_channel.c: Channel Local/2201@internal-00000005;1 left 'simple_bridge' basic-bridge <e899b8cb-4467-4142-8fe6-8fc1822e89df>
pbx.c: Spawn extension (SIP-1654673162-incoming, 738********, 14) exited non-zero on 'PJSIP/SIP-1654673162-00000007'
app_stack.c: PJSIP/SIP-1654673162-00000007 Internal Gosub(hangup_handler,s,1) start
pbx.c: Executing [s@hangup_handler:1] NoOp("PJSIP/SIP-1654673162-00000007", "--- hangup - PJSIP/SIP-1654673162-00000007 ---") in new stack
pbx.c: Executing [s@hangup_handler:2] Gosub("PJSIP/SIP-1654673162-00000007", "hangup_chan,s,1") in new stack
pbx_lua.c: Executing [s@hangup_chan:1] CELGenUserEvent("PJSIP/SIP-1654673162-00000007", "eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6IiIsImFjdGlvbiI6Imhhbmd1cF9jaGFuIiwiYWdpX2NoYW5uZWwiOiJQSlNJUC9TSVAtMTY1NDY3MzE2Mi0wMDAwMDAwNyIsImFnaV90aHJlYWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xN181OHdjU3UiLCJkaWFsc3RhdHVzIjoiQU5TV0VSRUQiLCJkaWQiOiI3Mzg0MzMyMDIyMCIsImVuZCI6IjIwMjItMDYtMTcgMTA6MjE6NTkuMzMyIiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfbnVtIjoiODk1MTE3NzUzMTkifQ==")
pbx_lua.c: Executing [s@hangup_chan:1] UserEvent("PJSIP/SIP-1654673162-00000007", "CdrConnector,AgiData:eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6IiIsImFjdGlvbiI6Imhhbmd1cF9jaGFuIiwiYWdpX2NoYW5uZWwiOiJQSlNJUC9TSVAtMTY1NDY3MzE2Mi0wMDAwMDAwNyIsImFnaV90aHJlYWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xN181OHdjU3UiLCJkaWFsc3RhdHVzIjoiQU5TV0VSRUQiLCJkaWQiOiI3Mzg0MzMyMDIyMCIsImVuZCI6IjIwMjItMDYtMTcgMTA6MjE6NTkuMzMyIiwibGlua2VkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTciLCJzcmNfbnVtIjoiODk1MTE3NzUzMTkifQ==")
pbx_lua.c: Executing [s@hangup_chan:1] return("PJSIP/SIP-1654673162-00000007", "")
pbx.c: Executing [s@hangup_handler:3] Return("PJSIP/SIP-1654673162-00000007", "") in new stack
app_stack.c: Spawn extension (SIP-1654673162-incoming, 738********, 14) exited non-zero on 'PJSIP/SIP-1654673162-00000007'
app_stack.c: PJSIP/SIP-1654673162-00000007 Internal Gosub(hangup_handler,s,1) complete GOSUB_RETVAL=
pbx.c: Spawn extension (internal, 2001, 7) exited non-zero on 'Local/2201@internal-00000005;2'
pbx.c: Executing [h@internal:1] ExecIf("Local/2201@internal-00000005;2", "0?Goto(transfer_dial_hangup,h,1)") in new stack
app_stack.c: Local/2201@internal-00000005;2 Internal Gosub(hangup_handler,s,1) start
pbx.c: Executing [s@hangup_handler:1] NoOp("Local/2201@internal-00000005;2", "--- hangup - Local/2201@internal-00000005;2 ---") in new stack
pbx.c: Executing [s@hangup_handler:2] Gosub("Local/2201@internal-00000005;2", "hangup_chan,s,1") in new stack
pbx_lua.c: Executing [s@hangup_chan:1] CELGenUserEvent("Local/2201@internal-00000005;2", "eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6IiIsImFjdGlvbiI6Imhhbmd1cF9jaGFuIiwiYWdpX2NoYW5uZWwiOiJMb2NhbC8yMjAwMTAwQGludGVybmFsLTAwMDAwMDA1OzIiLCJhZ2lfdGhyZWFkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTlfM3IzOThXIiwiZGlhbHN0YXR1cyI6IiIsImRpZCI6IjczODQzMzIwMjIwIiwiZW5kIjoiMjAyMi0wNi0xNyAxMDoyMTo1OS4zMzUiLCJsaW5rZWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xNyIsInNyY19udW0iOiI4OTUxMTc3NTMxOSJ9")
pbx_lua.c: Executing [s@hangup_chan:1] UserEvent("Local/2201@internal-00000005;2", "CdrConnector,AgiData:eyJPTERfTElOS0VESUQiOiIiLCJVTklRVUVJRCI6IiIsImFjdGlvbiI6Imhhbmd1cF9jaGFuIiwiYWdpX2NoYW5uZWwiOiJMb2NhbC8yMjAwMTAwQGludGVybmFsLTAwMDAwMDA1OzIiLCJhZ2lfdGhyZWFkaWQiOiJtaWtvcGJ4LTE2NTU0MzYwNzAuMTlfM3IzOThXIiwiZGlhbHN0YXR1cyI6IiIsImRpZCI6IjczODQzMzIwMjIwIiwiZW5kIjoiMjAyMi0wNi0xNyAxMDoyMTo1OS4zMzUiLCJsaW5rZWRpZCI6Im1pa29wYngtMTY1NTQzNjA3MC4xNyIsInNyY19udW0iOiI4OTUxMTc3NTMxOSJ9")
pbx_lua.c: Executing [s@hangup_chan:1] return("Local/2201@internal-00000005;2", "")
pbx.c: Executing [s@hangup_handler:3] Return("Local/2201@internal-00000005;2", "") in new stack
app_stack.c: Spawn extension (internal, h, 2) exited non-zero on 'Local/2201@internal-00000005;2'
app_stack.c: Local/2201@internal-00000005;2 Internal Gosub(hangup_handler,s,1) complete GOSUB_RETVAL=

Начните со статьи:

В выложенных логах не вижу dtmf, попробуйте еще его отфильтровать по “dtmf”.

Вероятнее всего проблема с NAT, или, что маловероятно, нужно явно прописать dtmf mode.

В логах по фильтру dtmf ничего нету, статью изучу.

значит DTMF не доходят до АТС