Outbound calling borked after asterisk-version-switch


#1

Running the current pbxact release (PBXact 15.0.17.24) but on Asterisk 15, I decided to upgrade asterisk version (since 15 is eol). Using asterisk-version-switch I jumped to Asterisk 17, updated all available modules and started testing. Inbound calling and endpoint to endpoint calling worked, but outbound calling resulted in route busy errors on both of my trunks (Sipstation and VoipMuch).
Rolling back to 16 or 15 did not restore functionality.

Not sure what’s gone wrong, any help?

[Feb 14 18:21:42]     -- <PJSIP/1020-00000002> Playing 'check-number-dial-again.ulaw' (language 'en')
[Feb 14 18:21:42]        > 0x7febb42dea90 -- Strict RTP learning complete - Locking on source address 10.8.0.3:12108
[Feb 14 18:21:46]   == Setting global variable 'SIPDOMAIN' to '10.8.0.1'
[Feb 14 18:21:46]   == Using SIP RTP Audio TOS bits 184
[Feb 14 18:21:46]   == Using SIP RTP Audio TOS bits 184 in TCLASS field.
[Feb 14 18:21:46]   == Using SIP RTP Audio CoS mark 5
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@from-internal:1] Macro("PJSIP/1020-00000003", "user-callerid,LIMIT") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:1] Set("PJSIP/1020-00000003", "TOUCH_MONITOR=1613348506.71") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:2] Set("PJSIP/1020-00000003", "AMPUSER=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:3] Set("PJSIP/1020-00000003", "HOTDESCKCHAN=1020-00000003") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:4] Set("PJSIP/1020-00000003", "HOTDESKEXTEN=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:5] Set("PJSIP/1020-00000003", "HOTDESKCALL=0") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:6] ExecIf("PJSIP/1020-00000003", "0?Set(HOTDESKCALL=1)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:7] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(name)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:8] GotoIf("PJSIP/1020-00000003", "0?report") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:9] ExecIf("PJSIP/1020-00000003", "1?Set(REALCALLERIDNUM=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:10] Set("PJSIP/1020-00000003", "AMPUSER=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:11] GotoIf("PJSIP/1020-00000003", "0?limit") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:12] Set("PJSIP/1020-00000003", "AMPUSERCIDNAME=Richard@S") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:13] ExecIf("PJSIP/1020-00000003", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:14] GotoIf("PJSIP/1020-00000003", "0?report") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:15] Set("PJSIP/1020-00000003", "AMPUSERCID=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:16] Set("PJSIP/1020-00000003", "__DIAL_OPTIONS=Ttr") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:17] Set("PJSIP/1020-00000003", "CALLERID(all)="Richard@S" <1020>") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:18] ExecIf("PJSIP/1020-00000003", "0?Set(CUSDIAL=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:19] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(all)="Richard@S" <1020>)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:20] GotoIf("PJSIP/1020-00000003", "0?limit") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:21] ExecIf("PJSIP/1020-00000003", "1?Set(GROUP(concurrency_limit)=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:22] ExecIf("PJSIP/1020-00000003", "0?Set(CHANNEL(language)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:23] NoOp("PJSIP/1020-00000003", "Macro Depth is 1") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:24] GotoIf("PJSIP/1020-00000003", "1?report2:macroerror") in new stack
[Feb 14 18:21:46]     -- Goto (macro-user-callerid,s,25)
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:25] GotoIf("PJSIP/1020-00000003", "1?continue") in new stack
[Feb 14 18:21:46]     -- Goto (macro-user-callerid,s,44)
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:44] Set("PJSIP/1020-00000003", "CALLERID(number)=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:45] Set("PJSIP/1020-00000003", "CALLERID(name)=Richard@S") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:46] GotoIf("PJSIP/1020-00000003", "0?cnum") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:47] Set("PJSIP/1020-00000003", "CDR(cnam)=Richard@S") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:48] Set("PJSIP/1020-00000003", "CDR(cnum)=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:49] Set("PJSIP/1020-00000003", "CHANNEL(language)=en") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-user-callerid:50] GosubIf("PJSIP/1020-00000003", "0?app-check-classofservce,s,1()") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@from-internal:2] Set("PJSIP/1020-00000003", "ROUTEUSER=1020") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@from-internal:3] Set("PJSIP/1020-00000003", "ROUTEUSER=1020") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@from-internal:4] GotoIf("PJSIP/1020-00000003", "1?notblind") in new stack
[Feb 14 18:21:46]     -- Goto (from-internal,Outbound#Replaced,7)
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@from-internal:7] GotoIf("PJSIP/1020-00000003", "1?restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c,Outbound#Replaced,2:outbound-allroutes,Outbound#Replaced,2") in new stack
[Feb 14 18:21:46]     -- Goto (restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c,Outbound#Replaced,2)
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:2] Gosub("PJSIP/1020-00000003", "sub-record-check,s,1(out,Outbound#Replaced,dontcare)") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:1] GotoIf("PJSIP/1020-00000003", "0?initialized") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:2] Set("PJSIP/1020-00000003", "__REC_STATUS=INITIALIZED") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:3] Set("PJSIP/1020-00000003", "NOW=1613348506") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:4] Set("PJSIP/1020-00000003", "__DAY=14") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:5] Set("PJSIP/1020-00000003", "__MONTH=02") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:6] Set("PJSIP/1020-00000003", "__YEAR=2021") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:7] Set("PJSIP/1020-00000003", "__TIMESTR=20210214-182146") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:8] Set("PJSIP/1020-00000003", "__FROMEXTEN=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:9] Set("PJSIP/1020-00000003", "__MON_FMT=wav") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:10] NoOp("PJSIP/1020-00000003", "Recordings initialized") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:11] ExecIf("PJSIP/1020-00000003", "0?Set(ARG3=dontcare)") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:12] Set("PJSIP/1020-00000003", "REC_POLICY_MODE_SAVE=") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:13] ExecIf("PJSIP/1020-00000003", "0?Set(REC_STATUS=NO)") in new stack
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:14] GotoIf("PJSIP/1020-00000003", "3?checkaction") in new stack
[Feb 14 18:21:46]     -- Goto (sub-record-check,s,17)
[Feb 14 18:21:46]     -- Executing [s@sub-record-check:17] GotoIf("PJSIP/1020-00000003", "1?sub-record-check,out,1") in new stack
[Feb 14 18:21:46]     -- Goto (sub-record-check,out,1)
[Feb 14 18:21:46]     -- Executing [out@sub-record-check:1] NoOp("PJSIP/1020-00000003", "Outbound Recording Check from 1020 to Outbound#Replaced") in new stack
[Feb 14 18:21:46]     -- Executing [out@sub-record-check:2] Set("PJSIP/1020-00000003", "RECMODE=dontcare") in new stack
[Feb 14 18:21:46]     -- Executing [out@sub-record-check:3] ExecIf("PJSIP/1020-00000003", "1?Goto(routewins)") in new stack
[Feb 14 18:21:46]     -- Goto (sub-record-check,out,7)
[Feb 14 18:21:46]     -- Executing [out@sub-record-check:7] Gosub("PJSIP/1020-00000003", "recordcheck,1(dontcare,out,Outbound#Replaced)") in new stack
[Feb 14 18:21:46]     -- Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/1020-00000003", "Starting recording check against dontcare") in new stack
[Feb 14 18:21:46]     -- Executing [recordcheck@sub-record-check:2] Goto("PJSIP/1020-00000003", "dontcare") in new stack
[Feb 14 18:21:46]     -- Goto (sub-record-check,recordcheck,3)
[Feb 14 18:21:46]     -- Executing [recordcheck@sub-record-check:3] Return("PJSIP/1020-00000003", "") in new stack
[Feb 14 18:21:46]     -- Executing [out@sub-record-check:8] Return("PJSIP/1020-00000003", "") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:3] ExecIf("PJSIP/1020-00000003", "0 ?Set(CDR(accountcode)=)") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:4] Set("PJSIP/1020-00000003", "_ROUTEID=8") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:5] Set("PJSIP/1020-00000003", "_ROUTENAME=Outbound Route for 1020 US") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:6] Set("PJSIP/1020-00000003", "MOHCLASS=default") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:7] ExecIf("PJSIP/1020-00000003", "1?Set(TRUNKCIDOVERRIDE="OutboundCIDReplaced") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:8] Set("PJSIP/1020-00000003", "_CALLERIDNAMEINTERNAL=Richard@S") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:9] Set("PJSIP/1020-00000003", "_CALLERIDNUMINTERNAL=1020") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:10] Set("PJSIP/1020-00000003", "_EMAILNOTIFICATION=FALSE") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:11] Set("PJSIP/1020-00000003", "_NODEST=") in new stack
[Feb 14 18:21:46]     -- Executing [Outbound#Replaced@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:12] Macro("PJSIP/1020-00000003", "dialout-trunk,2,Outbound#Replaced,,off") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:1] Set("PJSIP/1020-00000003", "DIAL_TRUNK=2") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:2] UserEvent("PJSIP/1020-00000003", "zulu-outbound-call,from:1020,to:Outbound#Replaced") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:3] ExecIf("PJSIP/1020-00000003", "0?Set(DIAL_OPTIONS=tr)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:4] GosubIf("PJSIP/1020-00000003", "0?sub-pincheck,s,1()") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:5] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(num)=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:6] GotoIf("PJSIP/1020-00000003", "0?disabletrunk,1") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:7] Set("PJSIP/1020-00000003", "DIAL_NUMBER=Outbound#Replaced") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:8] Set("PJSIP/1020-00000003", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:9] Set("PJSIP/1020-00000003", "OUTBOUND_GROUP=OUT_2") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:10] Set("PJSIP/1020-00000003", "DIAL_TRUNK_OPTIONS=T") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:11] GotoIf("PJSIP/1020-00000003", "1?nomax") in new stack
[Feb 14 18:21:46]     -- Goto (macro-dialout-trunk,s,13)
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:13] GotoIf("PJSIP/1020-00000003", "0?skipoutcid") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:14] Macro("PJSIP/1020-00000003", "outbound-callerid,2") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/1020-00000003", "1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/1020-00000003", "") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/1020-00000003", "off") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(name-pres)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(num-pres)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:6] Set("PJSIP/1020-00000003", "HOTDESCKCHAN=1020-00000003") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:7] Set("PJSIP/1020-00000003", "HOTDESKEXTEN=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:8] Set("PJSIP/1020-00000003", "HOTDESKCALL=0") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:9] ExecIf("PJSIP/1020-00000003", "0?Set(HOTDESKCALL=1)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:10] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(name)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:11] Set("PJSIP/1020-00000003", "ALLOWTHISROUTE=NO") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:12] ExecIf("PJSIP/1020-00000003", "0?Set(ALLOWTHISROUTE=YES)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:13] ExecIf("PJSIP/1020-00000003", "0?Hangup()") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:14] ExecIf("PJSIP/1020-00000003", "0?Set(REALCALLERIDNUM=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/1020-00000003", "0?Set(AMPUSER=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:16] GotoIf("PJSIP/1020-00000003", "1?normcid") in new stack
[Feb 14 18:21:46]     -- Goto (macro-outbound-callerid,s,20)
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:20] Set("PJSIP/1020-00000003", "USEROUTCID=") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:21] Set("PJSIP/1020-00000003", "EMERGENCYCID="OutboundCIDReplaced") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/1020-00000003", "0?Set(EMERGENCYCID=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:23] Set("PJSIP/1020-00000003", "TRUNKOUTCID="OutboundCIDReplaced) in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:24] GotoIf("PJSIP/1020-00000003", "1?trunkcid") in new stack
[Feb 14 18:21:46]     -- Goto (macro-outbound-callerid,s,30)
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:30] ExecIf("PJSIP/1020-00000003", "1?Set(CALLERID(all)="OutboundCIDReplaced)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:31] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(all)=)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:32] ExecIf("PJSIP/1020-00000003", "1?Set(CALLERID(all)=OutboundCIDReplaced)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:33] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERID(all)=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:34] ExecIf("PJSIP/1020-00000003", "1?Set(CALLERID(all)=1020)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:35] Set("PJSIP/1020-00000003", "TIOHIDE=no") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:36] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:37] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:38] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:39] ExecIf("PJSIP/1020-00000003", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:40] Set("PJSIP/1020-00000003", "CDR(outbound_cnum)=1020") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-outbound-callerid:41] Set("PJSIP/1020-00000003", "CDR(outbound_cnam)=") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:15] GosubIf("PJSIP/1020-00000003", "0?sub-flp-2,s,1()") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:16] Set("PJSIP/1020-00000003", "OUTNUM=Outbound#Replaced") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:17] Set("PJSIP/1020-00000003", "custom=SIP/fpbx-1-ytan1oSTxCwG") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/1020-00000003", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:19] ExecIf("PJSIP/1020-00000003", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:20] Macro("PJSIP/1020-00000003", "dialout-trunk-predial-hook,") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/1020-00000003", "") in new stack
[Feb 14 18:21:46]     -- Executing [s@macro-dialout-trunk:21] GotoIf("PJSIP/1020-00000003", "0?bypass,1") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:22] ExecIf("PJSIP/1020-00000003", "1?Set(CONNECTEDLINE(num,i)=Outbound#Replaced)") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:23] ExecIf("PJSIP/1020-00000003", "1?Set(CONNECTEDLINE(name,i)=CID:1020)") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:24] ExecIf("PJSIP/1020-00000003", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)1020)") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:25] GotoIf("PJSIP/1020-00000003", "0?customtrunk") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:26] ExecIf("PJSIP/1020-00000003", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:27] Set("PJSIP/1020-00000003", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
[Feb 14 18:21:47]     -- Executing [s@macro-dialout-trunk:28] Dial("PJSIP/1020-00000003", "SIP/fpbx-1-ytan1oSTxCwG/Outbound#Replaced,300,Tb(func-apply-sipheaders^s^1,(2))U(sub-send-obroute-email^Outbound#Replaced^Outbound#Replaced^2^1613348506^^1020)") in new stack
[Feb 14 18:21:47]   == Using SIP RTP TOS bits 184
[Feb 14 18:21:47]   == Using SIP RTP CoS mark 5
[Feb 14 18:21:47]     -- SIP/fpbx-1-ytan1oSTxCwG-00000002 Internal Gosub(func-apply-sipheaders,s,1(2)) start
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:1] NoOp("SIP/fpbx-1-ytan1oSTxCwG-00000002", "Applying SIP Headers to channel SIP/fpbx-1-ytan1oSTxCwG-00000002") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:2] Set("SIP/fpbx-1-ytan1oSTxCwG-00000002", "TECH=SIP") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:3] Set("SIP/fpbx-1-ytan1oSTxCwG-00000002", "SIPHEADERKEYS=Alert-Info") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:4] While("SIP/fpbx-1-ytan1oSTxCwG-00000002", "1") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:5] Set("SIP/fpbx-1-ytan1oSTxCwG-00000002", "sipheader=unset") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:6] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "1?SIPRemoveHeader(Alert-Info:)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:10] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0?SIPAddHeader(Alert-Info:unset)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:11] ExecIf("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:12] EndWhile("SIP/fpbx-1-ytan1oSTxCwG-00000002", "") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:4] While("SIP/fpbx-1-ytan1oSTxCwG-00000002", "0") in new stack
[Feb 14 18:21:47]     -- Executing [s@func-apply-sipheaders:13] Return("SIP/fpbx-1-ytan1oSTxCwG-00000002", "") in new stack
[Feb 14 18:21:47]   == Spawn extension (from-pstn, Outbound#Replaced, 1) exited non-zero on 'SIP/fpbx-1-ytan1oSTxCwG-00000002'
[Feb 14 18:21:47]     -- SIP/fpbx-1-ytan1oSTxCwG-00000002 Internal Gosub(func-apply-sipheaders,s,1(2)) complete GOSUB_RETVAL=
[Feb 14 18:21:47]     -- Called SIP/fpbx-1-ytan1oSTxCwG/Outbound#Replaced
[Feb 14 18:21:48]     -- SIP/fpbx-1-ytan1oSTxCwG-00000002 redirecting info has changed, passing it to PJSIP/1020-00000003
[Feb 14 18:21:48]     -- SIP/fpbx-1-ytan1oSTxCwG-00000002 is busy
[Feb 14 18:21:48]   == Everyone is busy/congested at this time (1:1/0/0)
[Feb 14 18:21:48]     -- Executing [s@macro-dialout-trunk:29] NoOp("PJSIP/1020-00000003", "Dial failed for some reason with DIALSTATUS = BUSY and HANGUPCAUSE = 19") in new stack
[Feb 14 18:21:48]     -- Executing [s@macro-dialout-trunk:30] GotoIf("PJSIP/1020-00000003", "0?continue,1:s-BUSY,1") in new stack
[Feb 14 18:21:48]     -- Goto (macro-dialout-trunk,s-BUSY,1)
[Feb 14 18:21:48]     -- Executing [s-BUSY@macro-dialout-trunk:1] NoOp("PJSIP/1020-00000003", "Dial failed due to trunk reporting BUSY - giving up") in new stack
[Feb 14 18:21:48]     -- Executing [s-BUSY@macro-dialout-trunk:2] PlayTones("PJSIP/1020-00000003", "busy") in new stack
[Feb 14 18:21:48]     -- Executing [s-BUSY@macro-dialout-trunk:3] Busy("PJSIP/1020-00000003", "20") in new stack
[Feb 14 18:21:48]   == Spawn extension (macro-dialout-trunk, s-BUSY, 3) exited non-zero on 'PJSIP/1020-00000003' in macro 'dialout-trunk'
[Feb 14 18:21:48]   == Spawn extension (restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c, Outbound#Replaced, 12) exited non-zero on 'PJSIP/1020-00000003'
[Feb 14 18:21:48]     -- Executing [h@restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c:1] Hangup("PJSIP/1020-00000003", "") in new stack
[Feb 14 18:21:48]   == Spawn extension (restrictedroute-d1308a78dfbb97fce72e6f0645f97e2c, h, 1) exited non-zero on 'PJSIP/1020-00000003'

#2

Check your Extension Routes/restricted routes module is still allowing your extensions


#3

Turns out it’s unrelated to the change in Asterisk version, rolling back core to 15.0.12.46 solved the issue.

Core issue: I was testing against a Canadian phone number. Canadian providers reject calls with improperly formatted callerid. Upgrading to core 15.0.12.48 caused the signaled callerid to be incorrect (despite Route CID Override Extension = Yes it was sending my extension’s cid).

Will probably fill out a bug report when I’ve recovered from panicking lol