Hi.
The trunk is registered on the provider’s server normally, incoming calls come. But when we try to make an outgoing one in the logs we see the following “[2021-03-02 13:21:45] WARNING [6544] [C-00000036]: chan_sip.c: 24427 handle_response_invite: Received response:” Forbidden “from '<sip: 4995517748@217.15.55.222>; tag = as076f9150 '”
Asterisk Version 16.15.1
At the same time, this trunk with exactly the same settings works on asterisk version 13.28.1
Sip debug outgoing call below:
[BEGIN] 02.03.2021 13:22:59
freepbx*CLI> sip set debug ip 217.15.55.222
SIP Debugging Enabled for IP: 217.15.55.222
== Using SIP VIDEO TOS bits 136
== Using SIP VIDEO CoS mark 6
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
-- Executing [89262029268@from-internal:1] Macro("SIP/911-00000064", "user-callerid,LIMIT,EXTERNAL,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/911-00000064", "TOUCH_MONITOR=1614680505.119") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/911-00000064", "AMPUSER=911") in new stack
-- Executing [s@macro-user-callerid:3] Set("SIP/911-00000064", "HOTDESCKCHAN=911-00000064") in new stack
-- Executing [s@macro-user-callerid:4] Set("SIP/911-00000064", "HOTDESKEXTEN=911") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/911-00000064", "HOTDESKCALL=0") in new stack
-- Executing [s@macro-user-callerid:6] ExecIf("SIP/911-00000064", "0?Set(HOTDESKCALL=1)") in new stack
-- Executing [s@macro-user-callerid:7] ExecIf("SIP/911-00000064", "0?Set(CALLERID(name)=)") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/911-00000064", "0?report") in new stack
-- Executing [s@macro-user-callerid:9] ExecIf("SIP/911-00000064", "1?Set(REALCALLERIDNUM=911)") in new stack
-- Executing [s@macro-user-callerid:10] Set("SIP/911-00000064", "AMPUSER=911") in new stack
-- Executing [s@macro-user-callerid:11] GotoIf("SIP/911-00000064", "0?limit") in new stack
-- Executing [s@macro-user-callerid:12] Set("SIP/911-00000064", "AMPUSERCIDNAME=ИТ Отдел") in new stack
-- Executing [s@macro-user-callerid:13] ExecIf("SIP/911-00000064", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
-- Executing [s@macro-user-callerid:14] GotoIf("SIP/911-00000064", "0?report") in new stack
-- Executing [s@macro-user-callerid:15] Set("SIP/911-00000064", "AMPUSERCID=911") in new stack
-- Executing [s@macro-user-callerid:16] Set("SIP/911-00000064", "__DIAL_OPTIONS=HhTtr") in new stack
-- Executing [s@macro-user-callerid:17] Set("SIP/911-00000064", "CALLERID(all)="ИТ Отдел" <911>") in new stack
-- Executing [s@macro-user-callerid:18] ExecIf("SIP/911-00000064", "0?Set(CUSDIAL=)") in new stack
-- Executing [s@macro-user-callerid:19] ExecIf("SIP/911-00000064", "0?Set(CALLERID(all)="ИТ Отдел" <911>)") in new stack
-- Executing [s@macro-user-callerid:20] GotoIf("SIP/911-00000064", "0?limit") in new stack
-- Executing [s@macro-user-callerid:21] ExecIf("SIP/911-00000064", "1?Set(GROUP(concurrency_limit)=911)") in new stack
-- Executing [s@macro-user-callerid:22] ExecIf("SIP/911-00000064", "0?Set(CHANNEL(language)=)") in new stack
-- Executing [s@macro-user-callerid:23] NoOp("SIP/911-00000064", "Macro Depth is 1") in new stack
-- Executing [s@macro-user-callerid:24] GotoIf("SIP/911-00000064", "1?report2:macroerror") in new stack
-- Goto (macro-user-callerid,s,25)
-- Executing [s@macro-user-callerid:25] GotoIf("SIP/911-00000064", "1?continue") in new stack
-- Goto (macro-user-callerid,s,44)
-- Executing [s@macro-user-callerid:44] Set("SIP/911-00000064", "CALLERID(number)=911") in new stack
-- Executing [s@macro-user-callerid:45] Set("SIP/911-00000064", "CALLERID(name)=ИТ Отдел") in new stack
-- Executing [s@macro-user-callerid:46] GotoIf("SIP/911-00000064", "0?cnum") in new stack
-- Executing [s@macro-user-callerid:47] Set("SIP/911-00000064", "CDR(cnam)=ИТ Отдел") in new stack
-- Executing [s@macro-user-callerid:48] Set("SIP/911-00000064", "CDR(cnum)=911") in new stack
-- Executing [s@macro-user-callerid:49] Set("SIP/911-00000064", "CHANNEL(language)=ru") in new stack
-- Executing [89262029268@from-internal:2] Gosub("SIP/911-00000064", "sub-record-check,s,1(out,89262029268,dontcare)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/911-00000064", "0?initialized") in new stack
-- Executing [s@sub-record-check:2] Set("SIP/911-00000064", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:3] Set("SIP/911-00000064", "NOW=1614680505") in new stack
-- Executing [s@sub-record-check:4] Set("SIP/911-00000064", "__DAY=02") in new stack
-- Executing [s@sub-record-check:5] Set("SIP/911-00000064", "__MONTH=03") in new stack
-- Executing [s@sub-record-check:6] Set("SIP/911-00000064", "__YEAR=2021") in new stack
-- Executing [s@sub-record-check:7] Set("SIP/911-00000064", "__TIMESTR=20210302-132145") in new stack
-- Executing [s@sub-record-check:8] Set("SIP/911-00000064", "__FROMEXTEN=911") in new stack
-- Executing [s@sub-record-check:9] Set("SIP/911-00000064", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:10] NoOp("SIP/911-00000064", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/911-00000064", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/911-00000064", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/911-00000064", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/911-00000064", "3?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/911-00000064", "1?sub-record-check,out,1") in new stack
-- Goto (sub-record-check,out,1)
-- Executing [out@sub-record-check:1] NoOp("SIP/911-00000064", "Outbound Recording Check from 911 to 89262029268") in new stack
-- Executing [out@sub-record-check:2] Set("SIP/911-00000064", "RECMODE=dontcare") in new stack
-- Executing [out@sub-record-check:3] ExecIf("SIP/911-00000064", "1?Goto(routewins)") in new stack
-- Goto (sub-record-check,out,7)
-- Executing [out@sub-record-check:7] Gosub("SIP/911-00000064", "recordcheck,1(dontcare,out,89262029268)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/911-00000064", "Starting recording check against dontcare") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/911-00000064", "dontcare") in new stack
-- Goto (sub-record-check,recordcheck,3)
-- Executing [recordcheck@sub-record-check:3] Return("SIP/911-00000064", "") in new stack
-- Executing [out@sub-record-check:8] Return("SIP/911-00000064", "") in new stack
-- Executing [89262029268@from-internal:3] ExecIf("SIP/911-00000064", "0 ?Set(CDR(accountcode)=)") in new stack
-- Executing [89262029268@from-internal:4] Set("SIP/911-00000064", "_ROUTEID=9") in new stack
-- Executing [89262029268@from-internal:5] Set("SIP/911-00000064", "_ROUTENAME=911") in new stack
-- Executing [89262029268@from-internal:6] Set("SIP/911-00000064", "MOHCLASS=default") in new stack
-- Executing [89262029268@from-internal:7] ExecIf("SIP/911-00000064", "1?Set(TRUNKCIDOVERRIDE=4995517748)") in new stack
-- Executing [89262029268@from-internal:8] Set("SIP/911-00000064", "_CALLERIDNAMEINTERNAL=ИТ Отдел") in new stack
-- Executing [89262029268@from-internal:9] Set("SIP/911-00000064", "_CALLERIDNUMINTERNAL=911") in new stack
-- Executing [89262029268@from-internal:10] Set("SIP/911-00000064", "_EMAILNOTIFICATION=FALSE") in new stack
-- Executing [89262029268@from-internal:11] Set("SIP/911-00000064", "_NODEST=") in new stack
-- Executing [89262029268@from-internal:12] Macro("SIP/911-00000064", "dialout-trunk,1,89262029268,,off") in new stack
-- Executing [s@macro-dialout-trunk:1] Set("SIP/911-00000064", "DIAL_TRUNK=1") in new stack
-- Executing [s@macro-dialout-trunk:2] ExecIf("SIP/911-00000064", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack
-- Executing [s@macro-dialout-trunk:3] GosubIf("SIP/911-00000064", "0?sub-pincheck,s,1()") in new stack
-- Executing [s@macro-dialout-trunk:4] ExecIf("SIP/911-00000064", "0?Set(CALLERID(num)=911)") in new stack
-- Executing [s@macro-dialout-trunk:5] GotoIf("SIP/911-00000064", "0?disabletrunk,1") in new stack
-- Executing [s@macro-dialout-trunk:6] Set("SIP/911-00000064", "DIAL_NUMBER=89262029268") in new stack
-- Executing [s@macro-dialout-trunk:7] Set("SIP/911-00000064", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack
-- Executing [s@macro-dialout-trunk:8] Set("SIP/911-00000064", "OUTBOUND_GROUP=OUT_1") in new stack
-- Executing [s@macro-dialout-trunk:9] Set("SIP/911-00000064", "DIAL_TRUNK_OPTIONS=T") in new stack
-- Executing [s@macro-dialout-trunk:10] GotoIf("SIP/911-00000064", "1?nomax") in new stack
-- Goto (macro-dialout-trunk,s,12)
-- Executing [s@macro-dialout-trunk:12] GotoIf("SIP/911-00000064", "0?skipoutcid") in new stack
-- Executing [s@macro-dialout-trunk:13] Macro("SIP/911-00000064", "outbound-callerid,1") in new stack
-- Executing [s@macro-outbound-callerid:1] NoOp("SIP/911-00000064", "911") in new stack
-- Executing [s@macro-outbound-callerid:2] NoOp("SIP/911-00000064", "") in new stack
-- Executing [s@macro-outbound-callerid:3] NoOp("SIP/911-00000064", "off") in new stack
-- Executing [s@macro-outbound-callerid:4] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(name-pres)=)") in new stack
-- Executing [s@macro-outbound-callerid:5] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(num-pres)=)") in new stack
-- Executing [s@macro-outbound-callerid:6] Set("SIP/911-00000064", "HOTDESCKCHAN=911-00000064") in new stack
-- Executing [s@macro-outbound-callerid:7] Set("SIP/911-00000064", "HOTDESKEXTEN=911") in new stack
-- Executing [s@macro-outbound-callerid:8] Set("SIP/911-00000064", "HOTDESKCALL=0") in new stack
-- Executing [s@macro-outbound-callerid:9] ExecIf("SIP/911-00000064", "0?Set(HOTDESKCALL=1)") in new stack
-- Executing [s@macro-outbound-callerid:10] ExecIf("SIP/911-00000064", "0?Set(CALLERID(name)=)") in new stack
-- Executing [s@macro-outbound-callerid:11] Set("SIP/911-00000064", "ALLOWTHISROUTE=NO") in new stack
-- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/911-00000064", "0?Set(ALLOWTHISROUTE=YES)") in new stack
-- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/911-00000064", "0?Hangup()") in new stack
-- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/911-00000064", "0?Set(REALCALLERIDNUM=911)") in new stack
-- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/911-00000064", "0?Set(AMPUSER=911)") in new stack
-- Executing [s@macro-outbound-callerid:16] GotoIf("SIP/911-00000064", "1?normcid") in new stack
-- Goto (macro-outbound-callerid,s,20)
-- Executing [s@macro-outbound-callerid:20] Set("SIP/911-00000064", "USEROUTCID=") in new stack
-- Executing [s@macro-outbound-callerid:21] Set("SIP/911-00000064", "EMERGENCYCID=") in new stack
-- Executing [s@macro-outbound-callerid:22] ExecIf("SIP/911-00000064", "0?Set(EMERGENCYCID=)") in new stack
-- Executing [s@macro-outbound-callerid:23] Set("SIP/911-00000064", "TRUNKOUTCID=4995517748") in new stack
-- Executing [s@macro-outbound-callerid:24] GotoIf("SIP/911-00000064", "1?trunkcid") in new stack
-- Goto (macro-outbound-callerid,s,30)
-- Executing [s@macro-outbound-callerid:30] ExecIf("SIP/911-00000064", "1?Set(CALLERID(all)=4995517748)") in new stack
-- Executing [s@macro-outbound-callerid:31] ExecIf("SIP/911-00000064", "0?Set(CALLERID(all)=)") in new stack
-- Executing [s@macro-outbound-callerid:32] ExecIf("SIP/911-00000064", "1?Set(CALLERID(all)=4995517748)") in new stack
-- Executing [s@macro-outbound-callerid:33] ExecIf("SIP/911-00000064", "0?Set(CALLERID(all)=911)") in new stack
-- Executing [s@macro-outbound-callerid:34] ExecIf("SIP/911-00000064", "0?Set(CALLERID(all)=911)") in new stack
-- Executing [s@macro-outbound-callerid:35] Set("SIP/911-00000064", "TIOHIDE=no") in new stack
-- Executing [s@macro-outbound-callerid:36] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
-- Executing [s@macro-outbound-callerid:37] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
-- Executing [s@macro-outbound-callerid:38] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
-- Executing [s@macro-outbound-callerid:39] ExecIf("SIP/911-00000064", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
-- Executing [s@macro-outbound-callerid:40] Set("SIP/911-00000064", "CDR(outbound_cnum)=4995517748") in new stack
-- Executing [s@macro-outbound-callerid:41] Set("SIP/911-00000064", "CDR(outbound_cnam)=") in new stack
-- Executing [s@macro-dialout-trunk:14] GosubIf("SIP/911-00000064", "0?sub-flp-1,s,1()") in new stack
-- Executing [s@macro-dialout-trunk:15] Set("SIP/911-00000064", "OUTNUM=89262029268") in new stack
-- Executing [s@macro-dialout-trunk:16] Set("SIP/911-00000064", "custom=SIP/rostelecom") in new stack
-- Executing [s@macro-dialout-trunk:17] ExecIf("SIP/911-00000064", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
-- Executing [s@macro-dialout-trunk:18] ExecIf("SIP/911-00000064", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
-- Executing [s@macro-dialout-trunk:19] Macro("SIP/911-00000064", "dialout-trunk-predial-hook,") in new stack
-- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/911-00000064", "") in new stack
-- Executing [s@macro-dialout-trunk:20] GotoIf("SIP/911-00000064", "0?bypass,1") in new stack
-- Executing [s@macro-dialout-trunk:21] ExecIf("SIP/911-00000064", "1?Set(CONNECTEDLINE(num,i)=89262029268)") in new stack
-- Executing [s@macro-dialout-trunk:22] ExecIf("SIP/911-00000064", "1?Set(CONNECTEDLINE(name,i)=CID:4995517748)") in new stack
-- Executing [s@macro-dialout-trunk:23] ExecIf("SIP/911-00000064", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)4995517748)") in new stack
-- Executing [s@macro-dialout-trunk:24] GotoIf("SIP/911-00000064", "0?customtrunk") in new stack
-- Executing [s@macro-dialout-trunk:25] ExecIf("SIP/911-00000064", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack
-- Executing [s@macro-dialout-trunk:26] Set("SIP/911-00000064", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
-- Executing [s@macro-dialout-trunk:27] Dial("SIP/911-00000064", "SIP/rostelecom/89262029268,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^89262029268^89262029268^1^1614680505^^4995517748)") in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
-- SIP/rostelecom-00000065 Internal Gosub(func-apply-sipheaders,s,1(1)) start
-- Executing [s@func-apply-sipheaders:1] NoOp("SIP/rostelecom-00000065", "Applying SIP Headers to channel SIP/rostelecom-00000065") in new stack
-- Executing [s@func-apply-sipheaders:2] Set("SIP/rostelecom-00000065", "TECH=SIP") in new stack
-- Executing [s@func-apply-sipheaders:3] Set("SIP/rostelecom-00000065", "SIPHEADERKEYS=Alert-Info") in new stack
-- Executing [s@func-apply-sipheaders:4] While("SIP/rostelecom-00000065", "1") in new stack
-- Executing [s@func-apply-sipheaders:5] Set("SIP/rostelecom-00000065", "sipheader=unset") in new stack
-- Executing [s@func-apply-sipheaders:6] ExecIf("SIP/rostelecom-00000065", "1?SIPRemoveHeader(Alert-Info:)") in new stack
-- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/rostelecom-00000065", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
-- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/rostelecom-00000065", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
-- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/rostelecom-00000065", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
-- Executing [s@func-apply-sipheaders:10] ExecIf("SIP/rostelecom-00000065", "0?SIPAddHeader(Alert-Info:unset)") in new stack
-- Executing [s@func-apply-sipheaders:11] ExecIf("SIP/rostelecom-00000065", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
-- Executing [s@func-apply-sipheaders:12] EndWhile("SIP/rostelecom-00000065", "") in new stack
-- Executing [s@func-apply-sipheaders:4] While("SIP/rostelecom-00000065", "0") in new stack
-- Executing [s@func-apply-sipheaders:13] Return("SIP/rostelecom-00000065", "") in new stack
== Spawn extension (from-trunk, 89262029268, 1) exited non-zero on 'SIP/rostelecom-00000065'
-- SIP/rostelecom-00000065 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
Audio is at 10040
Adding codec alaw to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 217.15.55.222:5060:
INVITE sip:89262029268@217.15.55.222 SIP/2.0
Via: SIP/2.0/UDP 178.176.21.177:5060;branch=z9hG4bK4dded504;rport
Max-Forwards: 70
From: <sip:4995517748@217.15.55.222>;tag=as076f9150
To: <sip:89262029268@217.15.55.222>
Contact: <sip:4995517748@178.176.21.177:5060>
Call-ID: 646c251432746f797ed6b62047cad9e2@217.15.55.222
CSeq: 102 INVITE
User-Agent: FPBX-15.0.17.24(16.15.1)
Date: Tue, 02 Mar 2021 10:21:45 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 244
v=0
o=root 1774654593 1774654593 IN IP4 178.176.21.177
s=Asterisk PBX 16.15.1
c=IN IP4 178.176.21.177
t=0 0
m=audio 10040 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=maxptime:150
a=sendrecv
---
-- Called SIP/rostelecom/89262029268
<--- SIP read from UDP:217.15.55.222:5060 --->
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP 10.214.8.2:5060;branch=z9hG4bK4dded504;received=178.176.21.177;rport=48208
Call-ID: 646c251432746f797ed6b62047cad9e2@217.15.55.222
From: <sip:4995517748@217.15.55.222>;tag=as076f9150
To: <sip:89262029268@217.15.55.222>;tag=z9hG4bK4dded504
CSeq: 102 INVITE
P-Eltex-Diagnostic: Administratively prohibited
Content-Length: 0
<------------->
--- (8 headers 0 lines) ---
Transmitting (NAT) to 217.15.55.222:5060:
ACK sip:89262029268@217.15.55.222 SIP/2.0
Via: SIP/2.0/UDP 178.176.21.177:5060;branch=z9hG4bK4dded504;rport
Max-Forwards: 70
From: <sip:4995517748@217.15.55.222>;tag=as076f9150
To: <sip:89262029268@217.15.55.222>;tag=z9hG4bK4dded504
Contact: <sip:4995517748@178.176.21.177:5060>
Call-ID: 646c251432746f797ed6b62047cad9e2@217.15.55.222
CSeq: 102 ACK
User-Agent: FPBX-15.0.17.24(16.15.1)
Content-Length: 0
---
[2021-03-02 13:21:45] WARNING[6544][C-00000036]: chan_sip.c:24427 handle_response_invite: Received response: "Forbidden" from '<sip:4995517748@217.15.55.222>;tag=as076f9150'
Scheduling destruction of SIP dialog '646c251432746f797ed6b62047cad9e2@217.15.55.222' in 6400 ms (Method: INVITE)
== Everyone is busy/congested at this time (1:0/0/1)
-- Executing [s@macro-dialout-trunk:28] NoOp("SIP/911-00000064", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack
-- Executing [s@macro-dialout-trunk:29] GotoIf("SIP/911-00000064", "0?continue,1:s-CHANUNAVAIL,1") in new stack
-- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
-- Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("SIP/911-00000064", "RC=21") in new stack
-- Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("SIP/911-00000064", "21,1") in new stack
-- Goto (macro-dialout-trunk,21,1)
-- Executing [21@macro-dialout-trunk:1] Goto("SIP/911-00000064", "continue,1") in new stack
-- Goto (macro-dialout-trunk,continue,1)
-- Executing [continue@macro-dialout-trunk:1] NoOp("SIP/911-00000064", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack
-- Executing [continue@macro-dialout-trunk:2] ExecIf("SIP/911-00000064", "1?Set(CALLERID(number)=911)") in new stack
-- Executing [89262029268@from-internal:13] Macro("SIP/911-00000064", "outisbusy,") in new stack
-- Executing [s@macro-outisbusy:1] Progress("SIP/911-00000064", "") in new stack
-- Executing [s@macro-outisbusy:2] GotoIf("SIP/911-00000064", "0?emergency,1") in new stack
-- Executing [s@macro-outisbusy:3] GotoIf("SIP/911-00000064", "0?intracompany,1") in new stack
-- Executing [s@macro-outisbusy:4] Playback("SIP/911-00000064", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack
-- <SIP/911-00000064> Playing 'all-circuits-busy-now.ulaw' (language 'ru')
-- <SIP/911-00000064> Playing 'please-try-call-later.ulaw' (language 'ru')
-- Executing [s@macro-outisbusy:5] Congestion("SIP/911-00000064", "20") in new stack
[2021-03-02 13:21:49] WARNING[17607][C-00000036]: channel.c:4968 ast_prod: Prodding channel 'SIP/911-00000064' failed
== Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'SIP/911-00000064' in macro 'outisbusy'
== Spawn extension (from-internal, 89262029268, 13) exited non-zero on 'SIP/911-00000064'
-- Executing [h@from-internal:1] Macro("SIP/911-00000064", "hangupcall") in new stack
-- Executing [s@macro-hangupcall:1] GotoIf("SIP/911-00000064", "1?theend") in new stack
-- Goto (macro-hangupcall,s,3)
-- Executing [s@macro-hangupcall:3] ExecIf("SIP/911-00000064", "0?Set(CDR(recordingfile)=)") in new stack
-- Executing [s@macro-hangupcall:4] NoOp("SIP/911-00000064", " montior file= ") in new stack
-- Executing [s@macro-hangupcall:5] GotoIf("SIP/911-00000064", "1?skipagi") in new stack
-- Goto (macro-hangupcall,s,7)
-- Executing [s@macro-hangupcall:7] Hangup("SIP/911-00000064", "") in new stack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/911-00000064' in macro 'hangupcall'
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/911-00000064'
Really destroying SIP dialog '646c251432746f797ed6b62047cad9e2@217.15.55.222' Method: INVITE
freepbx*CLI> sip set debug off
SIP Debugging Disabled
[END] 02.03.2021 13:23:27