Не проходят входящие звонки от определенного оператора

[ekurakin]

Добрый день, обнаружилась проблема что если звонить на корпоративный номер (+7ХХХХХХХХХ), то с некоторых операторов звонок проходит нормально и все работает (точно знаю что если звонить с МТС то все работает), а если попытаться позвонить с другого мобильного оператора Билайн например то происходит переадресация и звонок сбрасывается. Сможете подсказать в каком направлении копать и где искать ошибку?
Asterisk (Ver. 13.2.0)
FreePBX 12.0.76.6

[ded]

Смотреть в командную строку Астериск при прохождении входящего из МТС, сохранить, и при входящем из Билайна, тоже сохранить. Сравнивать, пытаться понять по журналу - где сбрасывается, и почему.

[ekurakin]

При звонке с Билайна в логах ничего не появляется (смотрел в Asterisk Log Files файл full)

Звонок с МТС

[Показать] Спойлер:

Код: выделить все

[2023-11-20 07:34:42] VERBOSE[32635][C-00000015] app_dial.c: Called SIP/SV_7495XXXXXXX/79854XXXX
[2023-11-20 07:34:43] VERBOSE[32635][C-00000015] app_dial.c: SIP/SV_7495XXXXXXX-0000003f is ringing
[2023-11-20 07:34:45] VERBOSE[32635][C-00000015] app_dial.c: SIP/SV_7495XXXXXXX-0000003f is making progress passing it to SIP/2027-0000003e
[2023-11-20 07:34:49] VERBOSE[32635][C-00000015] app_macro.c: Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'SIP/2027-0000003e' in macro 'dialout-trunk'
[2023-11-20 07:34:49] VERBOSE[32635][C-00000015] pbx.c: Spawn extension (from-internal, 989854XXXX, 7) exited non-zero on 'SIP/2027-0000003e'
[2023-11-20 07:34:49] VERBOSE[32635][C-00000015] pbx.c: Executing [h@from-internal:1] Hangup("SIP/2027-0000003e", "") in new stack
[2023-11-20 07:34:49] VERBOSE[32635][C-00000015] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/2027-0000003e'
[2023-11-20 07:35:10] VERBOSE[2656][C-00000016] netsock2.c: Using SIP RTP TOS bits 184
[2023-11-20 07:35:10] VERBOSE[2656][C-00000016] netsock2.c: Using SIP RTP CoS mark 5
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:1] Set("SIP/SV_7495XXXXXXX-00000040", "__DIRECTION=INBOUND") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:2] Gosub("SIP/SV_7495XXXXXXX-00000040", "sub-record-check,s,1(in,7495XXXXXXX,dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:2] Set("SIP/SV_7495XXXXXXX-00000040", "__REC_STATUS=INITIALIZED") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:3] Set("SIP/SV_7495XXXXXXX-00000040", "NOW=1700454910") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:4] Set("SIP/SV_7495XXXXXXX-00000040", "__DAY=20") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:5] Set("SIP/SV_7495XXXXXXX-00000040", "__MONTH=11") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:6] Set("SIP/SV_7495XXXXXXX-00000040", "__YEAR=2023") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:7] Set("SIP/SV_7495XXXXXXX-00000040", "__TIMESTR=20231120-073510") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:8] Set("SIP/SV_7495XXXXXXX-00000040", "__FROMEXTEN=unknown") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:9] Set("SIP/SV_7495XXXXXXX-00000040", "__MON_FMT=wav") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/SV_7495XXXXXXX-00000040", "Recordings initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(ARG3=dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:12] Set("SIP/SV_7495XXXXXXX-00000040", "REC_POLICY_MODE_SAVE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(REC_STATUS=NO)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/SV_7495XXXXXXX-00000040", "2?checkaction") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,s,17)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/SV_7495XXXXXXX-00000040", "1?sub-record-check,in,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,in,1)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/SV_7495XXXXXXX-00000040", "Inbound Recording Check to 7495XXXXXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [in@sub-record-check:2] Set("SIP/SV_7495XXXXXXX-00000040", "FROMEXTEN=unknown") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/SV_7495XXXXXXX-00000040", "10?Set(FROMEXTEN=9854XXXX)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/SV_7495XXXXXXX-00000040", "recordcheck,1(dontcare,in,7495XXXXXXX)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/SV_7495XXXXXXX-00000040", "Starting recording check against dontcare") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/SV_7495XXXXXXX-00000040", "dontcare") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,recordcheck,3)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [in@sub-record-check:5] Return("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:3] Gosub("SIP/SV_7495XXXXXXX-00000040", "app-blacklist-check,s,1()") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?blacklisted") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/SV_7495XXXXXXX-00000040", "CALLED_BLACKLIST=1") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:4] Set("SIP/SV_7495XXXXXXX-00000040", "__FROM_DID=7495XXXXXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:5] Set("SIP/SV_7495XXXXXXX-00000040", "CDR(did)=7495XXXXXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:6] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0 ?Set(CALLERID(name)=9854XXXX)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:7] Set("SIP/SV_7495XXXXXXX-00000040", "CHANNEL(musicclass)=MyMusic") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:8] Set("SIP/SV_7495XXXXXXX-00000040", "__MOHCLASS=MyMusic") in new stack
[2023-11-20 07:35:10] WARNING[32673][C-00000016] func_channel.c: Unknown or unavailable item requested: 'reversecharge'
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:9] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?macro-hangupcall") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:10] Set("SIP/SV_7495XXXXXXX-00000040", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:11] Set("SIP/SV_7495XXXXXXX-00000040", "CALLERPRES()=allowed_not_screened") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [7495XXXXXXX@from-trunk:12] Goto("SIP/SV_7495XXXXXXX-00000040", "ext-queues,2098,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (ext-queues,2098,1)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:1] Macro("SIP/SV_7495XXXXXXX-00000040", "user-callerid,") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/SV_7495XXXXXXX-00000040", "TOUCH_MONITOR=1700454910.614") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/SV_7495XXXXXXX-00000040", "AMPUSER=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?report") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("SIP/SV_7495XXXXXXX-00000040", "1?Set(REALCALLERIDNUM=9854XXXX)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/SV_7495XXXXXXX-00000040", "AMPUSER=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?limit") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/SV_7495XXXXXXX-00000040", "AMPUSERCIDNAME=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/SV_7495XXXXXXX-00000040", "1?report") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (macro-user-callerid,s,16)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?continue") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:17] ExecIf("SIP/SV_7495XXXXXXX-00000040", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:18] Set("SIP/SV_7495XXXXXXX-00000040", "__TTL=64") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("SIP/SV_7495XXXXXXX-00000040", "1?continue") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (macro-user-callerid,s,30)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:30] Set("SIP/SV_7495XXXXXXX-00000040", "CALLERID(number)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:31] Set("SIP/SV_7495XXXXXXX-00000040", "CALLERID(name)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:32] Set("SIP/SV_7495XXXXXXX-00000040", "CDR(cnum)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:33] Set("SIP/SV_7495XXXXXXX-00000040", "CDR(cnam)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-user-callerid:34] Set("SIP/SV_7495XXXXXXX-00000040", "CHANNEL(language)=ru") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:2] Answer("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:3] Macro("SIP/SV_7495XXXXXXX-00000040", "blkvm-set,reset") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-blkvm-set:1] ExecIf("SIP/SV_7495XXXXXXX-00000040", "1?Set(__BLKVM_CHANNEL=SIP/SV_7495XXXXXXX-00000040)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-blkvm-set:2] Set("SIP/SV_7495XXXXXXX-00000040", "SHARED(BLKVM,SIP/SV_7495XXXXXXX-00000040)=TRUE") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-blkvm-set:3] Set("SIP/SV_7495XXXXXXX-00000040", "GOSUB_RETVAL=TRUE") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@macro-blkvm-set:4] MacroExit("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:4] ExecIf("SIP/SV_7495XXXXXXX-00000040", "1?Set(_DIAL_OPTIONS=TtrM(auto-blkvm))") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:5] Set("SIP/SV_7495XXXXXXX-00000040", "__NODEST=2098") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:6] Set("SIP/SV_7495XXXXXXX-00000040", "QCIDPP=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:7] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_CIDPP=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:8] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Macro(prepend-cid,)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:9] Set("SIP/SV_7495XXXXXXX-00000040", "QAINFO=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:10] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_AINFO=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:11] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(__ALERT_INFO=)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:12] Set("SIP/SV_7495XXXXXXX-00000040", "QJOINMSG=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:13] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_JOINMSG=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:14] Set("SIP/SV_7495XXXXXXX-00000040", "QRETRY=n") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:15] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_RETRY=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:16] Set("SIP/SV_7495XXXXXXX-00000040", "QOPTIONS=tn") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:17] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_OPTIONS=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:18] Set("SIP/SV_7495XXXXXXX-00000040", "QGOSUB=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:19] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_GOSUB=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:20] Set("SIP/SV_7495XXXXXXX-00000040", "QAGI=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:21] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_AGI=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:22] Set("SIP/SV_7495XXXXXXX-00000040", "QRULE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:23] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_RULE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:24] Set("SIP/SV_7495XXXXXXX-00000040", "QPOSITION=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:25] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_POSITION=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:26] Gosub("SIP/SV_7495XXXXXXX-00000040", "sub-record-check,s,1(q,2098,dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/SV_7495XXXXXXX-00000040", "10?initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,s,10)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/SV_7495XXXXXXX-00000040", "Recordings initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(ARG3=dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:12] Set("SIP/SV_7495XXXXXXX-00000040", "REC_POLICY_MODE_SAVE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(REC_STATUS=NO)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/SV_7495XXXXXXX-00000040", "1?checkaction") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,s,17)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/SV_7495XXXXXXX-00000040", "0?sub-record-check,q,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/SV_7495XXXXXXX-00000040", "Generic q Recording Check - 9854XXXX 2098") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/SV_7495XXXXXXX-00000040", "recordcheck,1(dontcare,q,2098)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/SV_7495XXXXXXX-00000040", "Starting recording check against dontcare") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/SV_7495XXXXXXX-00000040", "dontcare") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Goto (sub-record-check,recordcheck,3)
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [s@sub-record-check:20] Return("SIP/SV_7495XXXXXXX-00000040", "") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:27] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Playback(, )") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:28] QueueLog("SIP/SV_7495XXXXXXX-00000040", "2098,1700454910.614,NONE,DID,7495XXXXXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:29] Set("SIP/SV_7495XXXXXXX-00000040", "QAANNOUNCE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:30] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_AANNOUNCE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:31] Set("SIP/SV_7495XXXXXXX-00000040", "QMOH=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:32] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_MOH=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:33] ExecIf("SIP/SV_7495XXXXXXX-00000040", "0?Set(__MOHCLASS=)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:34] ExecIf("SIP/SV_7495XXXXXXX-00000040", "1?Set(CHANNEL(musicclass)=MyMusic)") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:35] Set("SIP/SV_7495XXXXXXX-00000040", "QMAXWAIT=10") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:36] Set("SIP/SV_7495XXXXXXX-00000040", "VQ_MAXWAIT=") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:37] Set("SIP/SV_7495XXXXXXX-00000040", "QUEUENUM=2098") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:38] Set("SIP/SV_7495XXXXXXX-00000040", "QUEUEJOINTIME=1700454910") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] pbx.c: Executing [2098@ext-queues:39] Queue("SIP/SV_7495XXXXXXX-00000040", "2098,tn,,,10,,,,,") in new stack
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] res_musiconhold.c: Started music on hold, class 'MyMusic', on channel 'SIP/SV_7495XXXXXXX-00000040'
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] app_queue.c: Called Local/2005@from-queue/n
[2023-11-20 07:35:10] VERBOSE[32673][C-00000016] app_queue.c: -- LazyMembers debugging - Numbusies: 0, Nummems: 1
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2005@from-queue:1] Set("Local/2005@from-queue-00000016;2", "QAGENT=2005") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2005@from-queue:2] Goto("Local/2005@from-queue-00000016;2", "2098,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (from-queue,2098,1)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2098@from-queue:1] Goto("Local/2005@from-queue-00000016;2", "from-internal,2005,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (from-internal,2005,1)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2005@from-internal:1] GotoIf("Local/2005@from-queue-00000016;2", "1?ext-local,2005,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (ext-local,2005,1)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2005@ext-local:1] Set("Local/2005@from-queue-00000016;2", "__RINGTIMER=15") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [2005@ext-local:2] Macro("Local/2005@from-queue-00000016;2", "exten-vm,novm,2005,0,0,0") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:1] Macro("Local/2005@from-queue-00000016;2", "user-callerid,") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/2005@from-queue-00000016;2", "TOUCH_MONITOR=1700454910.619") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:2] Set("Local/2005@from-queue-00000016;2", "AMPUSER=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("Local/2005@from-queue-00000016;2", "1?report") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-user-callerid,s,16)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("Local/2005@from-queue-00000016;2", "0?continue") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:17] ExecIf("Local/2005@from-queue-00000016;2", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:18] Set("Local/2005@from-queue-00000016;2", "__TTL=63") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("Local/2005@from-queue-00000016;2", "1?continue") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-user-callerid,s,30)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:30] Set("Local/2005@from-queue-00000016;2", "CALLERID(number)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:31] Set("Local/2005@from-queue-00000016;2", "CALLERID(name)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:32] Set("Local/2005@from-queue-00000016;2", "CDR(cnum)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:33] Set("Local/2005@from-queue-00000016;2", "CDR(cnam)=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-user-callerid:34] Set("Local/2005@from-queue-00000016;2", "CHANNEL(language)=ru") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:2] Set("Local/2005@from-queue-00000016;2", "RingGroupMethod=none") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:3] Set("Local/2005@from-queue-00000016;2", "__EXTTOCALL=2005") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:4] Set("Local/2005@from-queue-00000016;2", "__PICKUPMARK=2005") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:5] Set("Local/2005@from-queue-00000016;2", "RT=") in new stack
[2023-11-20 07:35:10] WARNING[32675][C-00000016] chan_sip.c: This function can only be used on SIP channels.
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("Local/2005@from-queue-00000016;2", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2023-11-20 07:35:10] WARNING[32675][C-00000016] chan_sip.c: This function can only be used on SIP channels.
[2023-11-20 07:35:10] WARNING[32675][C-00000016] chan_sip.c: This function can only be used on SIP channels.
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("Local/2005@from-queue-00000016;2", "0?MacroExit()") in new stack
[2023-11-20 07:35:10] WARNING[32675][C-00000016] chan_sip.c: This function can only be used on SIP channels.
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:8] Gosub("Local/2005@from-queue-00000016;2", "sub-record-check,s,1(exten,2005,dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/2005@from-queue-00000016;2", "0?initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:2] Set("Local/2005@from-queue-00000016;2", "__REC_STATUS=INITIALIZED") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:3] Set("Local/2005@from-queue-00000016;2", "NOW=1700454910") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:4] Set("Local/2005@from-queue-00000016;2", "__DAY=20") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:5] Set("Local/2005@from-queue-00000016;2", "__MONTH=11") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:6] Set("Local/2005@from-queue-00000016;2", "__YEAR=2023") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:7] Set("Local/2005@from-queue-00000016;2", "__TIMESTR=20231120-073510") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:8] Set("Local/2005@from-queue-00000016;2", "__FROMEXTEN=9854XXXX") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:9] Set("Local/2005@from-queue-00000016;2", "__MON_FMT=wav") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/2005@from-queue-00000016;2", "Recordings initialized") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(ARG3=dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:12] Set("Local/2005@from-queue-00000016;2", "REC_POLICY_MODE_SAVE=") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(REC_STATUS=NO)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/2005@from-queue-00000016;2", "5?checkaction") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (sub-record-check,s,17)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/2005@from-queue-00000016;2", "1?sub-record-check,exten,1") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (sub-record-check,exten,1)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/2005@from-queue-00000016;2", "Exten Recording Check between 9854XXXX and 2005") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:2] Set("Local/2005@from-queue-00000016;2", "CALLTYPE=external") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(CALLTYPE=)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:4] Set("Local/2005@from-queue-00000016;2", "CALLEE=dontcare") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(CALLEE=dontcare)") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/2005@from-queue-00000016;2", "1?callee") in new stack
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Goto (sub-record-check,exten,11)
[2023-11-20 07:35:10] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/2005@from-queue-00000016;2", "recordcheck,1(dontcare,external,2005)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/2005@from-queue-00000016;2", "Starting recording check against dontcare") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/2005@from-queue-00000016;2", "dontcare") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (sub-record-check,recordcheck,3)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [exten@sub-record-check:12] Return("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:9] GotoIf("Local/2005@from-queue-00000016;2", "11?macrodial") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-exten-vm,s,15)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:15] GosubIf("Local/2005@from-queue-00000016;2", "0?clrheader,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-exten-vm:16] Macro("Local/2005@from-queue-00000016;2", "dial-one,,TtrM(auto-blkvm),2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:1] Set("Local/2005@from-queue-00000016;2", "DEXTEN=2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:2] Set("Local/2005@from-queue-00000016;2", "DIALSTATUS_CW=") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:3] GosubIf("Local/2005@from-queue-00000016;2", "0?screen,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:4] GosubIf("Local/2005@from-queue-00000016;2", "0?cf,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:5] GotoIf("Local/2005@from-queue-00000016;2", "1?skip1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-dial-one,s,8)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:8] GotoIf("Local/2005@from-queue-00000016;2", "0?nodial") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/2005@from-queue-00000016;2", "0?continue") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:10] Set("Local/2005@from-queue-00000016;2", "EXTHASCW=ENABLED") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:11] GotoIf("Local/2005@from-queue-00000016;2", "0?next1:cwinusebusy") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-dial-one,s,23)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:23] GotoIf("Local/2005@from-queue-00000016;2", "1?next3:continue") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-dial-one,s,24)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:24] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(DIALSTATUS_CW=BUSY)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:25] GotoIf("Local/2005@from-queue-00000016;2", "0?nodial") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:26] GosubIf("Local/2005@from-queue-00000016;2", "1?dstring,1():dlocal,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:1] Set("Local/2005@from-queue-00000016;2", "DSTRING=") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:2] Set("Local/2005@from-queue-00000016;2", "DEVICES=2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("Local/2005@from-queue-00000016;2", "0?Return()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(DEVICES=005)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:5] Set("Local/2005@from-queue-00000016;2", "LOOPCNT=1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:6] Set("Local/2005@from-queue-00000016;2", "ITER=1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:7] Set("Local/2005@from-queue-00000016;2", "THISDIAL=SIP/2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("Local/2005@from-queue-00000016;2", "1?zap2dahdi,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/2005@from-queue-00000016;2", "0?Return()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("Local/2005@from-queue-00000016;2", "NEWDIAL=") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("Local/2005@from-queue-00000016;2", "LOOPCNT2=1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("Local/2005@from-queue-00000016;2", "ITER2=1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("Local/2005@from-queue-00000016;2", "THISPART2=SIP/2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/2005@from-queue-00000016;2", "0?Set(THISPART2=DAHDI/2005)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("Local/2005@from-queue-00000016;2", "NEWDIAL=SIP/2005&") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("Local/2005@from-queue-00000016;2", "ITER2=2") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/2005@from-queue-00000016;2", "0?begin2") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("Local/2005@from-queue-00000016;2", "THISDIAL=SIP/2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("Local/2005@from-queue-00000016;2", "1?doset") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-dial-one,dstring,13)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:13] Set("Local/2005@from-queue-00000016;2", "DSTRING=SIP/2005&") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:14] Set("Local/2005@from-queue-00000016;2", "ITER=2") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf("Local/2005@from-queue-00000016;2", "0?begin") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:16] ExecIf("Local/2005@from-queue-00000016;2", "0?Return()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:17] Set("Local/2005@from-queue-00000016;2", "DSTRING=SIP/2005") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [dstring@macro-dial-one:18] Return("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:27] GotoIf("Local/2005@from-queue-00000016;2", "0?nodial") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:28] GotoIf("Local/2005@from-queue-00000016;2", "0?skiptrace") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:29] GosubIf("Local/2005@from-queue-00000016;2", "1?ctset,1():ctclear,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [ctset@macro-dial-one:1] Set("Local/2005@from-queue-00000016;2", "DB(CALLTRACE/2005)=9854XXXX") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [ctset@macro-dial-one:2] Return("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:30] Set("Local/2005@from-queue-00000016;2", "D_OPTIONS=TtrM(auto-blkvm)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:31] ExecIf("Local/2005@from-queue-00000016;2", "0?SIPAddHeader(Alert-Info: )") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:32] ExecIf("Local/2005@from-queue-00000016;2", "0?SIPAddHeader()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:33] ExecIf("Local/2005@from-queue-00000016;2", "1?Set(CHANNEL(musicclass)=MyMusic)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:34] GosubIf("Local/2005@from-queue-00000016;2", "0?qwait,1()") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:35] Set("Local/2005@from-queue-00000016;2", "__CWIGNORE=") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:36] Set("Local/2005@from-queue-00000016;2", "__KEEPCID=TRUE") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:37] GotoIf("Local/2005@from-queue-00000016;2", "0?usegoto,1") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:38] GotoIf("Local/2005@from-queue-00000016;2", "1?godial") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Goto (macro-dial-one,s,43)
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:43] Macro("Local/2005@from-queue-00000016;2", "dialout-one-predial-hook,") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("Local/2005@from-queue-00000016;2", "") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:44] ExecIf("Local/2005@from-queue-00000016;2", "1?Set(D_OPTIONS=trM(auto-blkvm)I)") in new stack
[2023-11-20 07:35:11] VERBOSE[32675][C-00000016] pbx.c: Executing [s@macro-dial-one:45] Dial("Local/2005@from-queue-00000016;2", "SIP/2005,,trM(auto-blkvm)I") in new stack

[ded]

http://asterisk.ru/knowledgebase/debug

[ekurakin]

Сохранил файл pcap во время звонка с МТС, отследил вот это

[Показать] Спойлер:

Код: выделить все

INVITE sip:7495XXXXXX@172.17.52.3:5060 SIP/2.0
Via: SIP/2.0/UDP 83.1XX.XX.XX:5060;branch=zqwdS3FK2b1fae99;rport
Max-Forwards: 70
From: "9854XXXXXX" <sip:98548XXXX@83.1XX.XX.XX>;tag=as6073200b
To: <sip:7495XXXXX@172.17.52.3:5060>
Contact: <sip:9854XXXXX@83.1XX.XX.XX:5060>
Call-ID: 075dcaea1ee1fc3ac34cdadqf0cb336d3@83.1XX.XX.XX:5060
CSeq: 102 INVITE
User-Agent: Asterisk PBX 1.8.10.0
Date: Mon, 20 Nov 2023 08:39:27 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 284

v=0

s=Asterisk PBX 1.8.10.0
c=IN IP4 83.1XX.XX.XX
t=0 0
m=audio 18878 RTP/AVP 8 3 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv


При звонке с Билайна такого сообщения нету.

[ded]

На нет - и суда нет.
Если ничего не прибегает оттуда, как можно проанализировать ситуацию?

[debauchery]

Подскажу один лайфхак - не надо дебажить такие штуки на АТС, поставьте на комп простого клиента SIP, например MicroSIP и позвоните в него. Дошел звонок - значит косяк в настройке АТС, не дошел - значит косяк оператора связи и морщите его сначала.