Can't dial outbound calls

jonathannico · September 9, 2024, 12:26am

Hello,
This evening, users became unable to make outbound calls. Nothing was changed immediately before. I have pasted the logs below for the call if it helps.

129721	[2024-09-08 19:45:04] VERBOSE[87244] netsock2.c: Using SIP RTP Audio TOS bits 184	
129722	[2024-09-08 19:45:04] VERBOSE[87244] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.	
129723	[2024-09-08 19:45:04] VERBOSE[87244] netsock2.c: Using SIP RTP Audio CoS mark 5	
129724	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [5555550911@from-internal:1] Macro("PJSIP/6649-00000063", "user-callerid,LIMIT") in new stack	
129725	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/6649-00000063", "TOUCH_MONITOR=1725839104.250") in new stack	
129726	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/6649-00000063", "CHANCONTEXT=") in new stack	
129727	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/6649-00000063", "CHANCONTEXT=") in new stack	
129728	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/6649-00000063", "CHANEXTENCONTEXT=6649-00000063") in new stack	
129729	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/6649-00000063", "CHANEXTEN=6649-00000063") in new stack	
129730	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/6649-00000063", "CALLERID(number)=6649") in new stack	
129731	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/6649-00000063", "AMPUSER=6649") in new stack	
129732	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/6649-00000063", "HOTDESCKCHAN=6649-00000063") in new stack	
129733	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/6649-00000063", "HOTDESKEXTEN=6649") in new stack	
129734	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/6649-00000063", "HOTDESKCALL=0") in new stack	
129735	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/6649-00000063", "0?Set(HOTDESKCALL=1)") in new stack	
129736	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/6649-00000063", "0?Set(CALLERID(name)=)") in new stack	
129737	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/6649-00000063", "0?report") in new stack	
129738	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/6649-00000063", "1?Set(REALCALLERIDNUM=6649)") in new stack	
129739	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/6649-00000063", "AMPUSER=6649") in new stack	
129740	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/6649-00000063", "0?limit") in new stack	
129741	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/6649-00000063", "AMPUSERCIDNAME=TEST USER") in new stack	
129742	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/6649-00000063", "0?Set(__CIDMASQUERADING=TRUE)") in new stack	
129743	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/6649-00000063", "0?report") in new stack	
129744	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/6649-00000063", "AMPUSERCID=6649") in new stack	
129745	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:21] Set("PJSIP/6649-00000063", "__DIAL_OPTIONS=HhTtr") in new stack	
129746	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:22] Set("PJSIP/6649-00000063", "CALLERID(all)="TEST USER" <6649>") in new stack	
129747	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/6649-00000063", "0?Set(CUSDIAL=)") in new stack	
129748	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/6649-00000063", "0?Set(CALLERID(all)="TEST USER" <6649>)") in new stack	
129749	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("PJSIP/6649-00000063", "0?limit") in new stack	
129750	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("PJSIP/6649-00000063", "1?Set(GROUP(concurrency_limit)=6649)") in new stack	
129751	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/6649-00000063", "0?Set(CHANNEL(language)=)") in new stack	
129752	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/6649-00000063", "Macro Depth is 1") in new stack	
129753	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/6649-00000063", "1?report2:macroerror") in new stack	
129754	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (macro-user-callerid,s,30)	
129755	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/6649-00000063", "1?continue") in new stack	
129756	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (macro-user-callerid,s,49)	
129757	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/6649-00000063", "CALLERID(number)=6649") in new stack	
129758	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/6649-00000063", "CALLERID(name)=TEST USER") in new stack	
129759	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("PJSIP/6649-00000063", "0?cnum") in new stack	
129760	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/6649-00000063", "__MCNUM=6649") in new stack	
129761	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/6649-00000063", "__MCNAME=TEST USER") in new stack	
129762	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/6649-00000063", "__MCEXTEN=6649") in new stack	
129763	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/6649-00000063", "__MCORGCHAN=PJSIP/6649-00000063") in new stack	
129764	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:56] Set("PJSIP/6649-00000063", "CDR(cnam)=TEST USER") in new stack	
129765	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:57] Set("PJSIP/6649-00000063", "CDR(cnum)=6649") in new stack	
129766	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@macro-user-callerid:58] Set("PJSIP/6649-00000063", "CHANNEL(language)=en") in new stack	
129767	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [5555550911@from-internal:2] Set("PJSIP/6649-00000063", "ROUTEUSER=6649") in new stack	
129768	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [5555550911@from-internal:3] Set("PJSIP/6649-00000063", "ROUTEUSER=6649") in new stack	
129769	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [5555550911@from-internal:4] GotoIf("PJSIP/6649-00000063", "1?notblind") in new stack	
129770	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (from-internal,5555550911,7)	
129771	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [5555550911@from-internal:7] GotoIf("PJSIP/6649-00000063", "1?restrictedroute-cfcd208495d565ef66e7dff9f98764da,5555550911,2:outbound-allroutes,5555550911,2") in new stack	
129772	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (restrictedroute-cfcd208495d565ef66e7dff9f98764da,5555550911,2)	
129773	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Channel 'PJSIP/6649-00000063' sent to invalid extension: context,exten,priority=restrictedroute-cfcd208495d565ef66e7dff9f98764da,5555550911,2	
129774	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [i@restrictedroute-cfcd208495d565ef66e7dff9f98764da:1] Goto("PJSIP/6649-00000063", "bad-number,s,1") in new stack	
129775	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (bad-number,s,1)	
129776	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [s@bad-number:1] Goto("PJSIP/6649-00000063", "11,1") in new stack	
129777	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx_builtins.c: Goto (bad-number,11,1)	
129778	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:1] ResetCDR("PJSIP/6649-00000063", "") in new stack	
129779	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:2] NoCDR("PJSIP/6649-00000063", "") in new stack	
129780	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:3] Progress("PJSIP/6649-00000063", "") in new stack	
129781	[2024-09-08 19:45:04] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:4] Wait("PJSIP/6649-00000063", "1") in new stack	
129782	[2024-09-08 19:45:05] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:5] Playback("PJSIP/6649-00000063", "silence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer") in new stack	
129783	[2024-09-08 19:45:05] VERBOSE[110034][C-000000a0] file.c: <PJSIP/6649-00000063> Playing 'silence/1.ulaw' (language 'en')	
129784	[2024-09-08 19:45:06] VERBOSE[110034][C-000000a0] file.c: <PJSIP/6649-00000063> Playing 'cannot-complete-as-dialed.ulaw' (language 'en')	
129785	[2024-09-08 19:45:08] VERBOSE[110034][C-000000a0] file.c: <PJSIP/6649-00000063> Playing 'check-number-dial-again.ulaw' (language 'en')

dobrosavljevic · September 9, 2024, 5:19pm

This indicates that it was possibly your carrier that rejected the outbound call:

129782	[2024-09-08 19:45:05] VERBOSE[110034][C-000000a0] pbx.c: Executing [11@bad-number:5] Playback("PJSIP/6649-00000063", "silence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer") in new stack

Reach out to them and have them look at that attempt and tell you why the call was rejected.

david55 · September 9, 2024, 8:33pm

It’s being rejected by FreePBX’s restricted route logic, not by the provider. I’m afraid the online documentation has disappeared, so I can’t provide any more detail.

jonathannico · September 9, 2024, 8:49pm

I see. Does anyone else have any ideas about FreePBX’s restricted route logic?

dobrosavljevic · September 9, 2024, 9:05pm

I stand corrected, I did totally miss that. I am actually not sure where that’s actually configured. Is this the same thing as Class of Service?

dicko · September 10, 2024, 2:34am

probably not here, it is an obfuscated commercial module, go to the source

lgaetz · September 10, 2024, 12:20pm

All FreePBX wiki content has been migrated to Sangoma Documentation including for the Extension Routing module

https://sangomakb.atlassian.net/wiki/spaces/PG/pages/32572684/Extension+Routing

jonathannico · September 10, 2024, 1:37pm

Is there a way to identify the malfunctioning module?

david55 · September 10, 2024, 3:14pm

What I think it is referring to is https://sangomakb.atlassian.net/wiki/spaces/PG/pages/25690346/Outbound+Routes+Configuration+Examples#2.--Route-Name:--Restricted

However, this is just from documentation, and I may have missed something.

jonathannico · September 10, 2024, 7:17pm

I found the problem! For some reason, FreePBX put all my extensions into the “Blocked Extensions” category under “Additional Settings” in both my outbound routes (One normal and one for Emergency). Thank you for all the help troubleshooting!

system · September 17, 2024, 7:17pm

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