How to hide outbound CID for extension

[david55]

It looks like you need to achieve:

Privacy: Id
P-Asserted-Identity: “don’t care” acceptable-callerid@acceptable-domain-name

I don’t know how you do that in FreePBX other than custom dialplan (to set the Asterisk option for privacy, not to directly add the privacy header). However there may be a more GUI friendly way.

I don’t think “hidden” has any special meaning.

“don’t care” means that this value is not critical rather than should be entered literally.

From might need to be the same, but their documentation does say that PAI has highest priority for caller ID.

[jkalber]

@david55

Please provide /var/log/asterisk/full, enabled if necessary, and with verbosity at least 5.

Unsure if I am doing this right or wrong but I’m running into an issue when I SSH into the FreePBX and try to run that command this is what it says below.

[root@freepbx ~]# /var/log/asterisk/full
-bash: /var/log/asterisk/full: Permission denied
[root@freepbx ~]#

[jkalber]

@DarrellSpears

I believe that should work for you providing your VoIP provider allows anonymous caller id. I’ve been using this for over 10 years and I tested it yesterday and it works for me. The word hidden blocks the name and number. You don’t have to code anonymous. The telephone company provides that detail when they see the caller id is hidden. Some telephone companies may display “OUT OF AREA” for hidden caller id. It depends on the phone company that your call is routed to.

Unfortunately, this did not help resolving the issue.

[airsay]

You may need to run through a quick Linux tutorial.

Need to run “cat /var/log/asterisk/full” without the quotes. It’s going to be a super long output that would scroll by real quick. Often that will be piped to grep when looking for something specific such as

cat /var/log/asterisk/ful | grep "something you are searching for"

I’m still a rookie but that’s often what I run if I’m searching for something the the logs

[david55]

If reading it interactively, I would use less, rather than cat (other file pagers are available).

[jkalber]

Alright here is the full log. Should I be doing this as I’m trying to dial out using *67?

[root@freepbx ~]# cat /var/log/asterisk/full
[2025-04-15 03:23:02] Asterisk 16.27.0 built by mockbuild @ jenkins7 on a x86_64 running Linux on 2022-07-07 05:53:12 UTC
[2025-04-15 03:23:02] VERBOSE[18206] logger.c: Asterisk Queue Logger restarted
[2025-04-15 03:23:02] VERBOSE[18206] asterisk.c: Remote UNIX connection disconnected
[2025-04-15 04:50:24] NOTICE[2337] chan_iax2.c: Peer ‘Houston-InterOffice’ is now UNREACHABLE! Time: 11
[2025-04-15 04:50:30] NOTICE[2334] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now UNREACHABLE! Time: 47
[2025-04-15 04:50:34] NOTICE[2337] chan_iax2.c: Peer ‘Houston-InterOffice’ is now REACHABLE! Time: 11
[2025-04-15 04:50:40] NOTICE[2337] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now REACHABLE! Time: 47
[2025-04-15 06:23:50] NOTICE[2333] chan_iax2.c: Peer ‘Houston-InterOffice’ is now TOO LAGGED (15507 ms)!
[2025-04-15 06:24:00] NOTICE[2331] chan_iax2.c: Peer ‘Houston-InterOffice’ is now REACHABLE! Time: 11
[2025-04-15 06:25:06] NOTICE[2331] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now UNREACHABLE! Time: 47
[2025-04-15 06:25:22] NOTICE[2335] chan_iax2.c: Peer ‘Houston-InterOffice’ is now UNREACHABLE! Time: 11
[2025-04-15 06:25:32] NOTICE[2335] chan_iax2.c: Peer ‘Houston-InterOffice’ is now REACHABLE! Time: 10
[2025-04-15 06:25:35] NOTICE[2332] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now REACHABLE! Time: 48
[2025-04-15 07:34:00] NOTICE[2331] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now UNREACHABLE! Time: 47
[2025-04-15 07:34:10] NOTICE[2339] chan_iax2.c: Peer ‘NewYork-InterOffice’ is now REACHABLE! Time: 47
[2025-04-15 07:54:28] VERBOSE[2343][C-0000003c] netsock2.c: Using SIP RTP TOS bits 184
[2025-04-15 07:54:28] VERBOSE[2343][C-0000003c] netsock2.c: Using SIP RTP CoS mark 5
[2025-04-15 07:54:28] VERBOSE[2092] chan_sip.c: Extension Changed 3438[ext-local] new state InUse for Notify User 3435
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:1] Macro(“SIP/3438-00000094”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:1] Set(“SIP/3438-00000094”, “TOUCH_MONITOR=1744721668.187”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:2] Set(“SIP/3438-00000094”, “CHANCONTEXT=”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:3] Set(“SIP/3438-00000094”, “CHANCONTEXT=”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:4] Set(“SIP/3438-00000094”, “CHANEXTENCONTEXT=3438-00000094”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:5] Set(“SIP/3438-00000094”, “CHANEXTEN=3438-00000094”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:6] Set(“SIP/3438-00000094”, “CALLERID(number)=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:7] Set(“SIP/3438-00000094”, “AMPUSER=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:8] Set(“SIP/3438-00000094”, “HOTDESCKCHAN=3438-00000094”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:9] Set(“SIP/3438-00000094”, “HOTDESKEXTEN=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:10] Set(“SIP/3438-00000094”, “HOTDESKCALL=0”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:11] ExecIf(“SIP/3438-00000094”, “0?Set(HOTDESKCALL=1)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:12] ExecIf(“SIP/3438-00000094”, “0?Set(CALLERID(name)=)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“SIP/3438-00000094”, “0?report”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“SIP/3438-00000094”, “1?Set(REALCALLERIDNUM=3438)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:15] Set(“SIP/3438-00000094”, “AMPUSER=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:16] GotoIf(“SIP/3438-00000094”, “0?limit”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:17] Set(“SIP/3438-00000094”, “AMPUSERCIDNAME=Jordan Kalber”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“SIP/3438-00000094”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“SIP/3438-00000094”, “0?report”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:20] Set(“SIP/3438-00000094”, “AMPUSERCID=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:21] Set(“SIP/3438-00000094”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:22] Set(“SIP/3438-00000094”, “CALLERID(all)=“Jordan Kalber” <3438>”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:23] ExecIf(“SIP/3438-00000094”, “0?Set(CUSDIAL=)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:24] ExecIf(“SIP/3438-00000094”, “0?Set(CALLERID(all)=“Jordan Kalber” <3438>)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“SIP/3438-00000094”, “0?limit”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“SIP/3438-00000094”, “1?Set(GROUP(concurrency_limit)=3438)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:27] ExecIf(“SIP/3438-00000094”, “0?Set(CHANNEL(language)=)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:28] NoOp(“SIP/3438-00000094”, “Macro Depth is 1”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:29] GotoIf(“SIP/3438-00000094”, “1?report2:macroerror”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (macro-user-callerid,s,30)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:30] GotoIf(“SIP/3438-00000094”, “1?continue”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (macro-user-callerid,s,49)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:49] Set(“SIP/3438-00000094”, “CALLERID(number)=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:50] Set(“SIP/3438-00000094”, “CALLERID(name)=Jordan Kalber”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:51] GotoIf(“SIP/3438-00000094”, “0?cnum”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:52] Set(“SIP/3438-00000094”, “CDR(cnam)=Jordan Kalber”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:53] Set(“SIP/3438-00000094”, “CDR(cnum)=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-user-callerid:54] Set(“SIP/3438-00000094”, “CHANNEL(language)=en”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:2] Gosub(“SIP/3438-00000094”, “sub-record-check,s,1(out,*678478946020,dontcare)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/3438-00000094”, “0?initialized”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/3438-00000094”, “__REC_STATUS=INITIALIZED”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/3438-00000094”, “NOW=1744721668”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/3438-00000094”, “__DAY=15”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/3438-00000094”, “__MONTH=04”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/3438-00000094”, “__YEAR=2025”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/3438-00000094”, “__TIMESTR=20250415-075428”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/3438-00000094”, “__FROMEXTEN=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/3438-00000094”, “__MON_FMT=wav”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/3438-00000094”, “Recordings initialized”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/3438-00000094”, “0?Set(ARG3=dontcare)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/3438-00000094”, “REC_POLICY_MODE_SAVE=”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/3438-00000094”, “0?Set(REC_STATUS=NO)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/3438-00000094”, “3?checkaction”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (sub-record-check,s,17)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/3438-00000094”, “1?sub-record-check,out,1”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (sub-record-check,out,1)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [out@sub-record-check:1] NoOp(“SIP/3438-00000094”, “Outbound Recording Check from 3438 to *678478946020”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [out@sub-record-check:2] Set(“SIP/3438-00000094”, “RECMODE=dontcare”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [out@sub-record-check:3] ExecIf(“SIP/3438-00000094”, “1?Goto(routewins)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (sub-record-check,out,7)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [out@sub-record-check:7] Gosub(“SIP/3438-00000094”, “recordcheck,1(dontcare,out,*678478946020)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/3438-00000094”, “Starting recording check against dontcare”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/3438-00000094”, “dontcare”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/3438-00000094”, “”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [out@sub-record-check:8] Return(“SIP/3438-00000094”, “”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:3] ExecIf(“SIP/3438-00000094”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:4] Set(“SIP/3438-00000094”, “_ROUTEID=10”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:5] Set(“SIP/3438-00000094”, “_ROUTENAME=BlockCID”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:6] Set(“SIP/3438-00000094”, “MOHCLASS=default”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:7] ExecIf(“SIP/3438-00000094”, “1?Set(TRUNKCIDOVERRIDE=Hidden)”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:8] Set(“SIP/3438-00000094”, “_CALLERIDNAMEINTERNAL=Jordan Kalber”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:9] Set(“SIP/3438-00000094”, “_CALLERIDNUMINTERNAL=3438”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:10] Set(“SIP/3438-00000094”, “_EMAILNOTIFICATION=FALSE”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:11] Set(“SIP/3438-00000094”, “_NODEST=”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [*678478946020@from-internal:12] Macro(“SIP/3438-00000094”, “outisbusy,”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-outisbusy:1] Progress(“SIP/3438-00000094”, “”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-outisbusy:2] GotoIf(“SIP/3438-00000094”, “0?emergency,1”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-outisbusy:3] GotoIf(“SIP/3438-00000094”, “0?intracompany,1”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-outisbusy:4] Playback(“SIP/3438-00000094”, “all-circuits-busy-now&please-try-call-later, noanswer”) in new stack
[2025-04-15 07:54:28] VERBOSE[16914][C-0000003c] file.c: <SIP/3438-00000094> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] file.c: <SIP/3438-00000094> Playing ‘please-try-call-later.ulaw’ (language ‘en’)
[2025-04-15 07:54:30] VERBOSE[2092] chan_sip.c: Extension Changed 3438[ext-local] new state Idle for Notify User 3435
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx.c: Executing [h@from-internal:1] Macro(“SIP/3438-00000094”, “hangupcall”) in new stack
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“SIP/3438-00000094”, “1?theend”) in new stack
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“SIP/3438-00000094”, “0?Set(CDR(recordingfile)=)”) in new stack
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx.c: Executing [s@macro-hangupcall:4] Hangup(“SIP/3438-00000094”, “”) in new stack
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/3438-00000094’ in macro ‘hangupcall’
[2025-04-15 07:54:30] VERBOSE[16914][C-0000003c] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/3438-00000094’

[david55]

No call is being attempted.

[jkalber]

Ok I think I got it this time, thoughts?

[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:3] ExecIf(“SIP/3438-000000a1”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:4] Set(“SIP/3438-000000a1”, “_ROUTEID=10”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:5] Set(“SIP/3438-000000a1”, “_ROUTENAME=BlockCID”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:6] Set(“SIP/3438-000000a1”, “MOHCLASS=default”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:7] ExecIf(“SIP/3438-000000a1”, “1?Set(TRUNKCIDOVERRIDE=Hidden)”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:8] Set(“SIP/3438-000000a1”, “_CALLERIDNAMEINTERNAL=Jordan Kalber”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:9] Set(“SIP/3438-000000a1”, “_CALLERIDNUMINTERNAL=3438”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:10] Set(“SIP/3438-000000a1”, “_EMAILNOTIFICATION=FALSE”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:11] Set(“SIP/3438-000000a1”, “_NODEST=”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [*678478946020@from-internal:12] Macro(“SIP/3438-000000a1”, “outisbusy,”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [s@macro-outisbusy:1] Progress(“SIP/3438-000000a1”, “”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [s@macro-outisbusy:2] GotoIf(“SIP/3438-000000a1”, “0?emergency,1”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [s@macro-outisbusy:3] GotoIf(“SIP/3438-000000a1”, “0?intracompany,1”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] pbx.c: Executing [s@macro-outisbusy:4] Playback(“SIP/3438-000000a1”, “all-circuits-busy-now&please-try-call-later, noanswer”) in new stack
[2025-04-15 10:11:30] VERBOSE[32711][C-00000045] file.c: <SIP/3438-000000a1> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)

[david55]

Still no dial application call.

[jkalber]

Ok, so what am I doing wrong? I don’t have all but maybe a second before the call ends and there isn’t any ringing. I run the command and then hit send on my phone to place the call.

[david55]

The dialplan is detecting that the call will fail without actually attempting it, so there is no INVITE request, and therefore nothing in the headers that could be the cause of the failure.

[jkalber]

Ok, I don’t really understand sorry and forgive me I’m not an expert when it comes to FreePBX. What do you recommend I try next?

[david55]

As I don’t know the FreePBX dialplan well enough to understand what it is testing to decide that the outbound route is busy, I’d suggest using the CLI command:

dialplan show *678478946020@from-internal

to see what the actual code is.

Someone more familiar may be able to say why it thinks the trunk is busy, just from the logs.

You still seem to be using the value “Hidden” which I don’t believe has any special meaning.

[jkalber]

I went ahead and ran that command, here are the results.

[root@freepbx ~]# dialplan show *678478946020@from-internal
-bash: dialplan: command not found

I changed the Route CID from “Anonymous” to hidden because @DarrellSpears recommended that so I figured it was worth a shot. I just changed it back to “Anonymous”.

[airsay]

Before running the dialplan show, you need to be in the Asterisk CLI

asterisk -rvvv will drop you in the Asterisk CLI. THEN you type the dialplan show *678478946020@from-internal

I’m learning how more experienced folks here read the logs so I’m interested in their troubleshooting. Also doing the best I can to get you going. Stay the course, it’s only rough at the beginning. When you get the hang of it, it’s gets really nice

[dicko]

Four filters to consider

man cat
cat
man grep
grep {expression}
pipe
man less
less

generally start with the most catholic varable like ‘date’ then progressively narrow your search by adding more "|grep {expression2}

You can rediorect the output to a file if you want or ‘tee’ when you’re comfy with that

[jkalber]

Alright, here is the dial plan as requested.

Executing [*678478946020@from-internal:1] Macro(“SIP/3438-00000158”, “use r-callerid,LIMIT,EXTERNAL,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/3438-00000158”, “TOUCH_MONIT OR=1745337422.437”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/3438-00000158”, “CHANCONTEXT =”) in new stack
– Executing [s@macro-user-callerid:3] Set(“SIP/3438-00000158”, “CHANCONTEXT =”) in new stack
– Executing [s@macro-user-callerid:4] Set(“SIP/3438-00000158”, “CHANEXTENCO NTEXT=3438-00000158”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/3438-00000158”, “CHANEXTEN=3 438-00000158”) in new stack
– Executing [s@macro-user-callerid:6] Set(“SIP/3438-00000158”, “CALLERID(nu mber)=3438”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/3438-00000158”, “AMPUSER=343 8”) in new stack
– Executing [s@macro-user-callerid:8] Set(“SIP/3438-00000158”, “HOTDESCKCHA N=3438-00000158”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/3438-00000158”, “HOTDESKEXTE N=3438”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/3438-00000158”, “HOTDESKCAL L=0”) in new stack
– Executing [s@macro-user-callerid:11] ExecIf(“SIP/3438-00000158”, “0?Set(H OTDESKCALL=1)”) in new stack
– Executing [s@macro-user-callerid:12] ExecIf(“SIP/3438-00000158”, “0?Set(C ALLERID(name)=)”) in new stack
– Executing [s@macro-user-callerid:13] GotoIf(“SIP/3438-00000158”, “0?repor t”) in new stack
– Executing [s@macro-user-callerid:14] ExecIf(“SIP/3438-00000158”, “1?Set(R EALCALLERIDNUM=3438)”) in new stack
– Executing [s@macro-user-callerid:15] Set(“SIP/3438-00000158”, “AMPUSER=34 38”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/3438-00000158”, "0?limit ") in new stack
– Executing [s@macro-user-callerid:17] Set(“SIP/3438-00000158”, “AMPUSERCID NAME=Jordan Kalber”) in new stack
– Executing [s@macro-user-callerid:18] ExecIf(“SIP/3438-00000158”, “0?Set(_ _CIDMASQUERADING=TRUE)”) in new stack
– Executing [s@macro-user-callerid:19] GotoIf(“SIP/3438-00000158”, “0?repor t”) in new stack
– Executing [s@macro-user-callerid:20] Set(“SIP/3438-00000158”, “AMPUSERCID =3438”) in new stack
– Executing [s@macro-user-callerid:21] Set(“SIP/3438-00000158”, “__DIAL_OPT IONS=HhTtr”) in new stack
– Executing [s@macro-user-callerid:22] Set(“SIP/3438-00000158”, “CALLERID(a ll)=“Jordan Kalber” <3438>”) in new stack
– Executing [s@macro-user-callerid:23] ExecIf(“SIP/3438-00000158”, “0?Set(C USDIAL=)”) in new stack
– Executing [s@macro-user-callerid:24] ExecIf(“SIP/3438-00000158”, “0?Set(C ALLERID(all)=“Jordan Kalber” <3438>)”) in new stack
– Executing [s@macro-user-callerid:25] GotoIf(“SIP/3438-00000158”, "0?limit ") in new stack
– Executing [s@macro-user-callerid:26] ExecIf(“SIP/3438-00000158”, “1?Set(G ROUP(concurrency_limit)=3438)”) in new stack
– Executing [s@macro-user-callerid:27] ExecIf(“SIP/3438-00000158”, “0?Set(C HANNEL(language)=)”) in new stack
– Executing [s@macro-user-callerid:28] NoOp(“SIP/3438-00000158”, “Macro Dep th is 1”) in new stack
– Executing [s@macro-user-callerid:29] GotoIf(“SIP/3438-00000158”, “1?repor t2:macroerror”) in new stack
– Goto (macro-user-callerid,s,30)
– Executing [s@macro-user-callerid:30] GotoIf(“SIP/3438-00000158”, “1?conti nue”) in new stack
– Goto (macro-user-callerid,s,49)
– Executing [s@macro-user-callerid:49] Set(“SIP/3438-00000158”, “CALLERID(n umber)=3438”) in new stack
– Executing [s@macro-user-callerid:50] Set(“SIP/3438-00000158”, “CALLERID(n ame)=Jordan Kalber”) in new stack
– Executing [s@macro-user-callerid:51] GotoIf(“SIP/3438-00000158”, “0?cnum” ) in new stack
– Executing [s@macro-user-callerid:52] Set(“SIP/3438-00000158”, “CDR(cnam)= Jordan Kalber”) in new stack
– Executing [s@macro-user-callerid:53] Set(“SIP/3438-00000158”, “CDR(cnum)= 3438”) in new stack
– Executing [s@macro-user-callerid:54] Set(“SIP/3438-00000158”, “CHANNEL(la nguage)=en”) in new stack
– Executing [*678478946020@from-internal:2] Gosub(“SIP/3438-00000158”, “sub -record-check,s,1(out,*678478946020,dontcare)”) in new stack
– Executing [s@sub-record-check:1] GotoIf(“SIP/3438-00000158”, “0?initializ ed”) in new stack
– Executing [s@sub-record-check:2] Set(“SIP/3438-00000158”, “__REC_STATUS=I NITIALIZED”) in new stack
– Executing [s@sub-record-check:3] Set(“SIP/3438-00000158”, "NOW=1745337422 ") in new stack
– Executing [s@sub-record-check:4] Set(“SIP/3438-00000158”, “__DAY=22”) in new stack
– Executing [s@sub-record-check:5] Set(“SIP/3438-00000158”, “__MONTH=04”) i n new stack
– Executing [s@sub-record-check:6] Set(“SIP/3438-00000158”, “__YEAR=2025”) in new stack
– Executing [s@sub-record-check:7] Set(“SIP/3438-00000158”, “__TIMESTR=2025 0422-105702”) in new stack
– Executing [s@sub-record-check:8] Set(“SIP/3438-00000158”, “__FROMEXTEN=34 38”) in new stack
– Executing [s@sub-record-check:9] Set(“SIP/3438-00000158”, “_MON_FMT=wav" ) in new stack
– Executing [s@sub-record-check:10] NoOp(“SIP/3438-00000158”, “Recordings i nitialized”) in new stack
– Executing [s@sub-record-check:11] ExecIf(“SIP/3438-00000158”, “0?Set(ARG3 =dontcare)”) in new stack
– Executing [s@sub-record-check:12] Set(“SIP/3438-00000158”, “REC_POLICY_MO DE_SAVE=”) in new stack
– Executing [s@sub-record-check:13] ExecIf(“SIP/3438-00000158”, "0?Set(REC STATUS=NO)”) in new stack
– Executing [s@sub-record-check:14] GotoIf(“SIP/3438-00000158”, “3?checkact ion”) in new stack
– Goto (sub-record-check,s,17)
– Executing [s@sub-record-check:17] GotoIf(“SIP/3438-00000158”, “1?sub-reco rd-check,out,1”) in new stack
– Goto (sub-record-check,out,1)
– Executing [out@sub-record-check:1] NoOp(“SIP/3438-00000158”, “Outbound Re cording Check from 3438 to *678478946020”) in new stack
– Executing [out@sub-record-check:2] Set(“SIP/3438-00000158”, “RECMODE=dont care”) in new stack
– Executing [out@sub-record-check:3] ExecIf(“SIP/3438-00000158”, “1?Goto(ro utewins)”) in new stack
– Goto (sub-record-check,out,7)
– Executing [out@sub-record-check:7] Gosub(“SIP/3438-00000158”, “recordchec k,1(dontcare,out,*678478946020)”) in new stack
– Executing [recordcheck@sub-record-check:1] NoOp(“SIP/3438-00000158”, “Sta rting recording check against dontcare”) in new stack
– Executing [recordcheck@sub-record-check:2] Goto(“SIP/3438-00000158”, “don tcare”) in new stack
– Goto (sub-record-check,recordcheck,3)
– Executing [recordcheck@sub-record-check:3] Return(“SIP/3438-00000158”, “” ) in new stack
– Executing [out@sub-record-check:8] Return(“SIP/3438-00000158”, “”) in new stack
– Executing [*678478946020@from-internal:3] ExecIf(“SIP/3438-00000158”, “0 ?Set(CDR(accountcode)=)”) in new stack
– Executing [*678478946020@from-internal:4] Set(“SIP/3438-00000158”, “_ROUT EID=10”) in new stack
– Executing [*678478946020@from-internal:5] Set(“SIP/3438-00000158”, “_ROUT ENAME=BlockCID”) in new stack
– Executing [*678478946020@from-internal:6] Set(“SIP/3438-00000158”, “MOHCL ASS=default”) in new stack
– Executing [*678478946020@from-internal:7] ExecIf(“SIP/3438-00000158”, “1? Set(TRUNKCIDOVERRIDE=“Anonymous”)”) in new stack
– Executing [*678478946020@from-internal:8] Set(“SIP/3438-00000158”, “_CALL ERIDNAMEINTERNAL=Jordan Kalber”) in new stack
– Executing [*678478946020@from-internal:9] Set(“SIP/3438-00000158”, “_CALL ERIDNUMINTERNAL=3438”) in new stack
– Executing [*678478946020@from-internal:10] Set(“SIP/3438-00000158”, “_EMA ILNOTIFICATION=FALSE”) in new stack
– Executing [*678478946020@from-internal:11] Set(“SIP/3438-00000158”, “_NOD EST=”) in new stack
– Executing [678478946020@from-internal:12] Macro(“SIP/3438-00000158”, “ou tisbusy,”) in new stack
– Executing [s@macro-outisbusy:1] Progress(“SIP/3438-00000158”, “”) in new stack
– Executing [s@macro-outisbusy:2] GotoIf(“SIP/3438-00000158”, “0?emergency, 1”) in new stack
– Executing [s@macro-outisbusy:3] GotoIf(“SIP/3438-00000158”, “0?intracompa ny,1”) in new stack
– Executing [s@macro-outisbusy:4] Playback(“SIP/3438-00000158”, “all-circui ts-busy-now&please-try-call-later, noanswer”) in new stack
– <SIP/3438-00000158> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
– <SIP/3438-00000158> Playing ‘please-try-call-later.ulaw’ (language ‘en’)
== Extension Changed 3438[ext-local] new state Idle for Notify User 3435
– Executing [h@from-internal:1] Macro(“SIP/3438-00000158”, “hangupcall”) in new stack
– Executing [s@macro-hangupcall:1] GotoIf(“SIP/3438-00000158”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf(“SIP/3438-00000158”, “0?Set(CDR(r ecordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:4] Hangup(“SIP/3438-00000158”, “”) in new s tack
== Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/3438-00000 158’ in macro ‘hangupcall’
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/3438-00000158 ’
freepbxCLI> dialplan show *678478946020@from-internal

[david55]

That’s a trace of the dialplan, not the actual dialplan; it is doesn’t show the contents of expressions, or the names of variables. I’m pretty sure that 678478946020 is not matching anything in the dialplan, but there may be other reasons why it is reaching the call to outisbusy.