Hangup Cause 41

Redmor · March 25, 2022, 8:36am

I have a problem with some calls and I can’t figure out what’s happening.

I get TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 41 - failing through to other trunks and the “message all-circuits-busy-now&please-try-call-later” is played.

I don’t know if the calleed number is busy or if the trunk failed.

Can you help me?
If it’s only a busy caleld number, can I change the message to a busy tone?


274695	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("PJSIP/90217-00001354", "1?Set(GROUP(concurrency_limit)=217)") in new stack	
274696	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/90217-00001354", "0?Set(CHANNEL(language)=)") in new stack	
274697	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/90217-00001354", "Macro Depth is 1") in new stack	
274698	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/90217-00001354", "1?report2:macroerror") in new stack	
274699	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-user-callerid,s,30)	
274700	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/90217-00001354", "1?continue") in new stack	
274701	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-user-callerid,s,49)	
274702	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/90217-00001354", "CALLERID(number)=217") in new stack	
274703	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/90217-00001354", "CALLERID(name)=MacTelnet") in new stack	
274704	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("PJSIP/90217-00001354", "0?cnum") in new stack	
274705	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/90217-00001354", "CDR(cnam)=MacTelnet") in new stack	
274706	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/90217-00001354", "CDR(cnum)=217") in new stack	
274707	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/90217-00001354", "CHANNEL(language)=it") in new stack	
274708	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@from-internal:2] Set("PJSIP/90217-00001354", "ROUTEUSER=217") in new stack	
274709	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@from-internal:3] Set("PJSIP/90217-00001354", "ROUTEUSER=217") in new stack	
274710	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@from-internal:4] GotoIf("PJSIP/90217-00001354", "1?notblind") in new stack	
274711	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (from-internal,3334445566,7)	
274712	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@from-internal:7] GotoIf("PJSIP/90217-00001354", "1?restrictedroute-ff9057345c5c687da826a2c5ae2a1222,3334445566,2:outbound-allroutes,3334445566,2") in new stack	
274713	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (restrictedroute-ff9057345c5c687da826a2c5ae2a1222,3334445566,2)	
274714	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:2] Gosub("PJSIP/90217-00001354", "sub-record-check,s,1(out,3334445566,dontcare)") in new stack	
274715	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/90217-00001354", "0?initialized") in new stack	
274716	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/90217-00001354", "__REC_STATUS=INITIALIZED") in new stack	
274717	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/90217-00001354", "NOW=1648196318") in new stack	
274718	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/90217-00001354", "__DAY=25") in new stack	
274719	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/90217-00001354", "__MONTH=03") in new stack	
274720	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/90217-00001354", "__YEAR=2022") in new stack	
274721	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/90217-00001354", "__TIMESTR=20220325-091838") in new stack	
274722	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/90217-00001354", "__FROMEXTEN=217") in new stack	
274723	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/90217-00001354", "__MON_FMT=wav") in new stack	
274724	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/90217-00001354", "Recordings initialized") in new stack	
274725	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/90217-00001354", "0?Set(ARG3=dontcare)") in new stack	
274726	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/90217-00001354", "REC_POLICY_MODE_SAVE=") in new stack	
274727	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/90217-00001354", "0?Set(REC_STATUS=NO)") in new stack	
274728	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/90217-00001354", "3?checkaction") in new stack	
274729	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (sub-record-check,s,17)	
274730	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/90217-00001354", "1?sub-record-check,out,1") in new stack	
274731	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (sub-record-check,out,1)	
274732	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [out@sub-record-check:1] NoOp("PJSIP/90217-00001354", "Outbound Recording Check from 217 to 3334445566") in new stack	
274733	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [out@sub-record-check:2] Set("PJSIP/90217-00001354", "RECMODE=dontcare") in new stack	
274734	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [out@sub-record-check:3] ExecIf("PJSIP/90217-00001354", "1?Goto(routewins)") in new stack	
274735	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (sub-record-check,out,7)	
274736	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [out@sub-record-check:7] Gosub("PJSIP/90217-00001354", "recordcheck,1(dontcare,out,3334445566)") in new stack	
274737	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/90217-00001354", "Starting recording check against dontcare") in new stack	
274738	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/90217-00001354", "dontcare") in new stack	
274739	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
274740	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/90217-00001354", "") in new stack	
274741	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [out@sub-record-check:8] Return("PJSIP/90217-00001354", "") in new stack	
274742	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:3] ExecIf("PJSIP/90217-00001354", "0 ?Set(CDR(accountcode)=)") in new stack	
274743	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:4] Set("PJSIP/90217-00001354", "_ROUTEID=22") in new stack	
274744	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:5] Set("PJSIP/90217-00001354", "_ROUTENAME=ER_GNR_Elsynet_003") in new stack	
274745	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:6] Set("PJSIP/90217-00001354", "MOHCLASS=default") in new stack	
274746	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:7] ExecIf("PJSIP/90217-00001354", "1?Set(TRUNKCIDOVERRIDE=01234567003)") in new stack	
274747	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:8] Set("PJSIP/90217-00001354", "_CALLERIDNAMEINTERNAL=MacTelnet") in new stack	
274748	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:9] Set("PJSIP/90217-00001354", "_CALLERIDNUMINTERNAL=217") in new stack	
274749	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:10] Set("PJSIP/90217-00001354", "_EMAILNOTIFICATION=FALSE") in new stack	
274750	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:11] Set("PJSIP/90217-00001354", "_NODEST=") in new stack	
274751	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:12] Macro("PJSIP/90217-00001354", "dialout-trunk,13,3334445566,,off") in new stack	
274752	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:1] Set("PJSIP/90217-00001354", "DIAL_TRUNK=13") in new stack	
274753	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:2] UserEvent("PJSIP/90217-00001354", "zulu-outbound-call,from:217,to:3334445566") in new stack	
274754	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:3] ExecIf("PJSIP/90217-00001354", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack	
274755	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:4] GosubIf("PJSIP/90217-00001354", "0?sub-pincheck,s,1()") in new stack	
274756	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:5] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(num)=217)") in new stack	
274757	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:6] GotoIf("PJSIP/90217-00001354", "0?disabletrunk,1") in new stack	
274758	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:7] Set("PJSIP/90217-00001354", "DIAL_NUMBER=3334445566") in new stack	
274759	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:8] Set("PJSIP/90217-00001354", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack	
274760	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:9] Set("PJSIP/90217-00001354", "OUTBOUND_GROUP=OUT_13") in new stack	
274761	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:10] Set("PJSIP/90217-00001354", "DIAL_TRUNK_OPTIONS=T") in new stack	
274762	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf("PJSIP/90217-00001354", "0?nomax") in new stack	
274763	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/90217-00001354", "0?chanfull") in new stack	
274764	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:13] GotoIf("PJSIP/90217-00001354", "0?skipoutcid") in new stack	
274765	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:14] Macro("PJSIP/90217-00001354", "outbound-callerid,13") in new stack	
274766	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/90217-00001354", "217") in new stack	
274767	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/90217-00001354", "") in new stack	
274768	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/90217-00001354", "off") in new stack	
274769	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(name-pres)=)") in new stack	
274770	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(num-pres)=)") in new stack	
274771	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:6] Set("PJSIP/90217-00001354", "HOTDESCKCHAN=90217-00001354") in new stack	
274772	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:7] Set("PJSIP/90217-00001354", "HOTDESKEXTEN=90217") in new stack	
274773	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:8] Set("PJSIP/90217-00001354", "HOTDESKCALL=0") in new stack	
274774	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("PJSIP/90217-00001354", "0?Set(HOTDESKCALL=1)") in new stack	
274775	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(name)=)") in new stack	
274776	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:11] Set("PJSIP/90217-00001354", "ALLOWTHISROUTE=NO") in new stack	
274777	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("PJSIP/90217-00001354", "0?Set(ALLOWTHISROUTE=YES)") in new stack	
274778	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("PJSIP/90217-00001354", "0?Hangup()") in new stack	
274779	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("PJSIP/90217-00001354", "0?Set(REALCALLERIDNUM=217)") in new stack	
274780	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/90217-00001354", "0?Set(AMPUSER=217)") in new stack	
274781	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("PJSIP/90217-00001354", "1?normcid") in new stack	
274782	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)	
274783	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:20] Set("PJSIP/90217-00001354", "USEROUTCID=01234567217") in new stack	
274784	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:21] Set("PJSIP/90217-00001354", "EMERGENCYCID=") in new stack	
274785	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/90217-00001354", "0?Set(EMERGENCYCID=)") in new stack	
274786	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:23] Set("PJSIP/90217-00001354", "TRUNKOUTCID=01234567001") in new stack	
274787	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("PJSIP/90217-00001354", "1?trunkcid") in new stack	
274788	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)	
274789	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("PJSIP/90217-00001354", "1?Set(CALLERID(all)=01234567001)") in new stack	
274790	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("PJSIP/90217-00001354", "1?Set(CALLERID(all)=01234567217)") in new stack	
274791	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("PJSIP/90217-00001354", "1?Set(CALLERID(all)=01234567003)") in new stack	
274792	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(all)=217)") in new stack	
274793	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:34] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(all)=217)") in new stack	
274794	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:35] Set("PJSIP/90217-00001354", "TIOHIDE=no") in new stack	
274795	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack	
274796	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack	
274797	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack	
274798	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:39] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack	
274799	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:40] Set("PJSIP/90217-00001354", "CDR(outbound_cnum)=01234567003") in new stack	
274800	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outbound-callerid:41] Set("PJSIP/90217-00001354", "CDR(outbound_cnam)=") in new stack	
274801	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:15] GosubIf("PJSIP/90217-00001354", "1?sub-flp-13,s,1()") in new stack	
274802	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-flp-13:1] ExecIf("PJSIP/90217-00001354", "0?Set(TARGET_FLP_13=3764559)") in new stack	
274803	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-flp-13:2] GotoIf("PJSIP/90217-00001354", "0?match") in new stack	
274804	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-flp-13:3] ExecIf("PJSIP/90217-00001354", "0?Set(TARGET_FLP_13=00453764559)") in new stack	
274805	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-flp-13:4] GotoIf("PJSIP/90217-00001354", "0?match") in new stack	
274806	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@sub-flp-13:5] Return("PJSIP/90217-00001354", "") in new stack	
274807	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:16] Set("PJSIP/90217-00001354", "OUTNUM=3334445566") in new stack	
274808	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:17] Set("PJSIP/90217-00001354", "custom=PJSIP") in new stack	
274809	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/90217-00001354", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack	
274810	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:19] ExecIf("PJSIP/90217-00001354", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack	
274811	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:20] Macro("PJSIP/90217-00001354", "dialout-trunk-predial-hook,") in new stack	
274812	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/90217-00001354", "") in new stack	
274813	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:21] GotoIf("PJSIP/90217-00001354", "0?skipcrm") in new stack	
274814	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:22] Set("PJSIP/90217-00001354", "__CRM_DIRECTION=OUTBOUND") in new stack	
274815	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:23] Set("PJSIP/90217-00001354", "__CRM_DESTINATION=3334445566") in new stack	
274816	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:24] Set("PJSIP/90217-00001354", "__CRM_SOURCE=217") in new stack	
274817	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:25] AGI("PJSIP/90217-00001354", "agi://127.0.0.1/sangomacrm.agi") in new stack	
274818	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] res_agi.c: <PJSIP/90217-00001354>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
274819	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:26] Set("PJSIP/90217-00001354", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack	
274820	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:27] NoOp("PJSIP/90217-00001354", "CRM Finished") in new stack	
274821	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:28] GotoIf("PJSIP/90217-00001354", "0?bypass,1") in new stack	
274822	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("PJSIP/90217-00001354", "1?Set(CONNECTEDLINE(name,i)=CID:01234567003)") in new stack	
274823	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("PJSIP/90217-00001354", "0?Set(CONNECTEDLINE(name,i)=CID:(HiddCHANUNAVAIL HANGUPCAUSE: 41en)01234567003)") in new stack	
274824	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("PJSIP/90217-00001354", "0?customtrunk") in new stack	
274825	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("PJSIP/90217-00001354", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack	
274826	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:33] Set("PJSIP/90217-00001354", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack	
274827	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("PJSIP/90217-00001354", "PJSIP/3334445566@GNR,300,Tb(func-apply-sipheaders^s^1,(13))U(sub-send-obroute-email^3334445566^3334445566^13^1648196318^^01234567003)") in new stack	
274828	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] app_stack.c: PJSIP/GNR-00001355 Internal Gosub(func-apply-sipheaders,s,1(13)) start	
274829	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/GNR-00001355", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
274830	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/GNR-00001355", "Applying SIP Headers to channel PJSIP/GNR-00001355") in new stack	
274831	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/GNR-00001355", "TECH=PJSIP") in new stack	
274832	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/GNR-00001355", "SIPHEADERKEYS=Alert-Info") in new stack	
274833	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/GNR-00001355", "1") in new stack	
274834	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:6] Set("PJSIP/GNR-00001355", "sipheader=unset") in new stack	
274835	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("PJSIP/GNR-00001355", "0?SIPRemoveHeader(Alert-Info:)") in new stack	
274836	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("PJSIP/GNR-00001355", "1?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack	
274837	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("PJSIP/GNR-00001355", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack	
274838	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("PJSIP/GNR-00001355", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack	
274839	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("PJSIP/GNR-00001355", "0?SIPAddHeader(Alert-Info:unset)") in new stack	
274840	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("PJSIP/GNR-00001355", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack	
274841	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("PJSIP/GNR-00001355", "") in new stack	
274842	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/GNR-00001355", "0") in new stack	
274843	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/GNR-00001355", "") in new stack	
274844	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] app_stack.c: Spawn extension (from-trunk, 3334445566, 1) exited non-zero on 'PJSIP/GNR-00001355'	
274845	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] app_stack.c: PJSIP/GNR-00001355 Internal Gosub(func-apply-sipheaders,s,1(13)) complete GOSUB_RETVAL=	
274846	[2022-03-25 09:18:39] VERBOSE[28689][C-000004d4] app_dial.c: Called PJSIP/3334445566@GNR	
274847	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)	
274848	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:35] NoOp("PJSIP/90217-00001354", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 41") in new stack	
274849	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-dialout-trunk:36] GotoIf("PJSIP/90217-00001354", "0?continue,1:s-CHANUNAVAIL,1") in new stack	
274850	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)	
274851	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("PJSIP/90217-00001354", "RC=41") in new stack	
274852	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("PJSIP/90217-00001354", "41,1") in new stack	
274853	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-dialout-trunk,41,1)	
274854	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [41@macro-dialout-trunk:1] Goto("PJSIP/90217-00001354", "continue,1") in new stack	
274855	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)	
274856	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp("PJSIP/90217-00001354", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 41 - failing through to other trunks") in new stack	
274857	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf("PJSIP/90217-00001354", "1?Set(CALLERID(number)=217)") in new stack	
274858	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:13] Macro("PJSIP/90217-00001354", "outisbusy,") in new stack	
274859	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outisbusy:1] Progress("PJSIP/90217-00001354", "") in new stack	
274860	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outisbusy:2] GotoIf("PJSIP/90217-00001354", "0?emergency,1") in new stack	
274861	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outisbusy:3] GotoIf("PJSIP/90217-00001354", "0?intracompany,1") in new stack	
274862	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outisbusy:4] Playback("PJSIP/90217-00001354", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack	
274863	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] file.c: <PJSIP/90217-00001354> Playing 'all-circuits-busy-now.ulaw' (language 'it')		
274865	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] res_rtp_asterisk.c: 0x7f82d408afa0 -- Strict RTP learning after ICE completion	
274867	[2022-03-25 09:19:08] VERBOSE[28689][C-000004d4] res_rtp_asterisk.c: 0x7f82d408afa0 -- Strict RTP switching to RTP target address myIP:49698 as source	
274868	[2022-03-25 09:19:10] VERBOSE[28689][C-000004d4] file.c: <PJSIP/90217-00001354> Playing 'please-try-call-later.ulaw' (language 'it')	
274869	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-outisbusy:5] Congestion("PJSIP/90217-00001354", "20") in new stack	
274870	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'PJSIP/90217-00001354' in macro 'outisbusy'	
274871	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Spawn extension (restrictedroute-ff9057345c5c687da826a2c5ae2a1222, 3334445566, 13) exited non-zero on 'PJSIP/90217-00001354'	
274872	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [h@restrictedroute-ff9057345c5c687da826a2c5ae2a1222:1] Hangup("PJSIP/90217-00001354", "") in new stack	
274873	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Spawn extension (restrictedroute-ff9057345c5c687da826a2c5ae2a1222, h, 1) exited non-zero on 'PJSIP/90217-00001354'	
274874	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] app_stack.c: PJSIP/90217-00001354 Internal Gosub(crm-hangup,s,1) start	
274875	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/90217-00001354", "Sending Hangup to CRM") in new stack	
274876	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/90217-00001354", "HANGUP CAUSE: 34") in new stack	
274877	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/90217-00001354", "0?Set(__CRM_VOICEMAIL=)") in new stack	
274878	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/90217-00001354", "MASTER CHANNEL: 1648196318.27033 = 1648196318.27033") in new stack	
274879	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/90217-00001354", "0?return") in new stack	
274880	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/90217-00001354", "__CRM_HANGUP=1") in new stack	
274881	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/90217-00001354", "agi://127.0.0.1/sangomacrm.agi") in new stack	
274882	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] res_agi.c: <PJSIP/90217-00001354>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
274883	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/90217-00001354", "") in new stack	
274884	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] app_stack.c: Spawn extension (restrictedroute-ff9057345c5c687da826a2c5ae2a1222, h, 1) exited non-zero on 'PJSIP/90217-00001354'	
274885	[2022-03-25 09:19:13] VERBOSE[28689][C-000004d4] app_stack.c: PJSIP/90217-00001354 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

Redmor · March 25, 2022, 8:38am

First part of the log.

274666	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@zulu-from-internal:1] Set("PJSIP/90217-00001354", "ZULU_ID=dcd9cbb7-58fb-428b-9d44-69f1a6d77289") in new stack	
274667	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@zulu-from-internal:2] Goto("PJSIP/90217-00001354", "from-internal,3334445566,1") in new stack	
274668	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx_builtins.c: Goto (from-internal,3334445566,1)	
274669	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [3334445566@from-internal:1] Macro("PJSIP/90217-00001354", "user-callerid,LIMIT") in new stack	
274670	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/90217-00001354", "TOUCH_MONITOR=1648196318.27033") in new stack	
274671	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/90217-00001354", "CHANCONTEXT=") in new stack	
274672	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/90217-00001354", "CHANCONTEXT=") in new stack	
274673	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/90217-00001354", "CHANEXTENCONTEXT=90217-00001354") in new stack	
274674	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/90217-00001354", "CHANEXTEN=90217-00001354") in new stack	
274675	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/90217-00001354", "CALLERID(number)=217") in new stack	
274676	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/90217-00001354", "AMPUSER=217") in new stack	
274677	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/90217-00001354", "HOTDESCKCHAN=90217-00001354") in new stack	
274678	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/90217-00001354", "HOTDESKEXTEN=90217") in new stack	
274679	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/90217-00001354", "HOTDESKCALL=0") in new stack	
274680	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/90217-00001354", "0?Set(HOTDESKCALL=1)") in new stack	
274681	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(name)=)") in new stack	
274682	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/90217-00001354", "0?report") in new stack	
274683	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/90217-00001354", "1?Set(REALCALLERIDNUM=217)") in new stack	
274684	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/90217-00001354", "AMPUSER=217") in new stack	
274685	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/90217-00001354", "0?limit") in new stack	
274686	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/90217-00001354", "AMPUSERCIDNAME=MacTelnet") in new stack	
274687	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/90217-00001354", "0?Set(__CIDMASQUERADING=TRUE)") in new stack	
274688	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/90217-00001354", "0?report") in new stack	
274689	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/90217-00001354", "AMPUSERCID=217") in new stack	
274690	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:21] Set("PJSIP/90217-00001354", "__DIAL_OPTIONS=HhTtr") in new stack	
274691	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:22] Set("PJSIP/90217-00001354", "CALLERID(all)="MacTelnet" <217>") in new stack	
274692	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/90217-00001354", "0?Set(CUSDIAL=)") in new stack	
274693	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/90217-00001354", "0?Set(CALLERID(all)="MacTelnet" <217>)") in new stack	
274694	[2022-03-25 09:18:38] VERBOSE[28689][C-000004d4] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("PJSIP/90217-00001354", "0?limit") in new stack

david55 · March 25, 2022, 11:09am

41 is not busy. Assuming chan_pjsip honours RFC 3398, it is one of the following SIP failures:

   400 Bad Request                       41 Temporary Failure
   481 Call/Transaction Does not Exist   41 Temporary Failure
   500 Server internal error             41 Temporary failure
   503 Service unavailable               41 Temporary failure

For the specific one, use the CLI command “psjip set logger on” to capture the actual SIP exchanges.

Redmor · March 25, 2022, 11:41am

I have to set it in asterisk configuration file because I can’t keep the CLI opened, can you tell me how to change the file?

david55 · March 25, 2022, 11:54am

The setting will stay in effect until you use the corresponding off command, or restart Asterisk.

You should take the logs from /var/log/asterisk/fulll, not the CLI screen.

Redmor · March 25, 2022, 1:18pm

No in my case I have to modify them in file, even verbose keeps going to off when I exit from CLI.

Redmor · March 29, 2022, 1:08pm

Here’s verbose and logger, I’ve pasted it in pastebin.

https://pastebin.com/8Xw6ULur

david55 · March 29, 2022, 1:19pm

Error, this is a private paste or is pending moderation. If this paste belongs to you, please login to Pastebin to view it

Also there is a FreePBX community pastebin server: https://pastebin.freepbx.org/

Redmor · March 29, 2022, 1:28pm

FreePBX one seems working.

https://pastebin.freepbx.org/view/5775188b

david55 · March 29, 2022, 2:41pm

Asterisk sent an INVITE at Line 397 and received Service Unavailable with additional information of “Reason: Q.850 ;cause=41 ;text=“Temporary Failure””, at Line 2005 .

Given the 29 seconds between them, I think there was a timeout. That might be because the service provider system was receiving a failure message, in band, as early media, or it might be because it failed to supply a complete number. However, it could well be happening further upstream.

503 is a catch all error, and doesn’t really say much about what really went wrong.

Redmor · March 29, 2022, 3:25pm

Should I ask my VoIP provider to have a check?

Stewart1 · March 29, 2022, 3:42pm

The INVITE starting at line 397 shows 192.168.84.84 (a private IP address) in Via, Contact and SDP. Is this (or does it represent) the LAN address of Asterisk? If so, that is strange, because Asterisk would normally substitute its public IP when sending to a non-local address. Please confirm that in Asterisk SIP Settings, Local Networks and External Address are correctly set. If you change these, after Submit and Apply Config you must restart Asterisk.

Also, line 431 shows received=192.168.84.84, but it is impossible for the provider to have received the INVITE from a private address. Usually, this means that your router/firewall has a SIP ALG enabled and is modifying the SIP traffic. If possible, try disabling that and post make and model.

Do you mean that calls to specific numbers always fail? If so, do you see a pattern (for example, all calls to Wind mobile)? If not (a call to a given number will sometimes work and sometimes fail), do you see a pattern there (for example, only when other calls are in progress)?

system · April 29, 2022, 3:42pm

This topic was automatically closed 31 days after the last reply. New replies are no longer allowed.