I’ve spent hours on this. I give up and need your help.
Issue is with DISA.
Scenario: Caller dials DID >> FreePBX answers >> Presses 2 on IVR >> DISA Answers >> PIN Entered >> Dial Tone Active >> Caller dials number via DID to call out >> Call hangs up.
Logs are here:
1 [2023-05-25 03:07:02] Asterisk 18.16.0 built by mockbuild @ jenkins7 on a x86_64 running Linux on 2023-01-16 06:50:30 UTC
2 [2023-05-25 03:07:02] VERBOSE[25583] logger.c: Asterisk Queue Logger restarted
3 [2023-05-25 03:07:02] VERBOSE[25583] asterisk.c: Remote UNIX connection disconnected
5 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-sip-external:1] NoOp("PJSIP/anonymous-00000033", "Received incoming SIP connection from unknown peer to 0170") in new stack
6 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-sip-external:2] Set("PJSIP/anonymous-00000033", "DID=0170") in new stack
7 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-sip-external:3] Goto("PJSIP/anonymous-00000033", "s,1") in new stack
8 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (from-sip-external,s,1)
9 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@from-sip-external:1] GotoIf("PJSIP/anonymous-00000033", "1?setlanguage:checkanon") in new stack
10 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (from-sip-external,s,2)
11 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@from-sip-external:2] Set("PJSIP/anonymous-00000033", "CHANNEL(language)=en") in new stack
12 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@from-sip-external:3] GotoIf("PJSIP/anonymous-00000033", "0?noanonymous") in new stack
13 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@from-sip-external:4] Goto("PJSIP/anonymous-00000033", "from-trunk,0170,1") in new stack
14 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (from-trunk,0170,1)
15 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:1] Set("PJSIP/anonymous-00000033", "__DIRECTION=INBOUND") in new stack
16 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:2] Gosub("PJSIP/anonymous-00000033", "sub-record-check,s,1(in,0170,dontcare)") in new stack
17 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000033", "0?initialized") in new stack
18 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/anonymous-00000033", "__REC_STATUS=INITIALIZED") in new stack
19 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/anonymous-00000033", "NOW=1685000564") in new stack
20 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/anonymous-00000033", "__DAY=25") in new stack
21 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/anonymous-00000033", "__MONTH=05") in new stack
22 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/anonymous-00000033", "__YEAR=2023") in new stack
23 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/anonymous-00000033", "__TIMESTR=20230525-074244") in new stack
24 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/anonymous-00000033", "__FROMEXTEN=unknown") in new stack
25 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/anonymous-00000033", "__MON_FMT=wav") in new stack
26 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000033", "Recordings initialized") in new stack
27 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000033", "0?Set(ARG3=dontcare)") in new stack
28 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000033", "REC_POLICY_MODE_SAVE=") in new stack
29 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000033", "0?Set(REC_STATUS=NO)") in new stack
30 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000033", "2?checkaction") in new stack
31 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,s,17)
32 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000033", "1?sub-record-check,in,1") in new stack
33 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,in,1)
34 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/anonymous-00000033", "Inbound Recording Check to 0170") in new stack
35 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/anonymous-00000033", "FROMEXTEN=unknown") in new stack
36 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/anonymous-00000033", "12?Set(FROMEXTEN=+18446288729)") in new stack
37 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/anonymous-00000033", "recordcheck,1(dontcare,in,0170)") in new stack
38 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000033", "Starting recording check against dontcare") in new stack
39 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000033", "dontcare") in new stack
40 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
41 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/anonymous-00000033", "") in new stack
42 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/anonymous-00000033", "") in new stack
43 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:3] Set("PJSIP/anonymous-00000033", "CHANNEL(tonezone)=us") in new stack
44 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:4] Set("PJSIP/anonymous-00000033", "__FROM_DID=0170") in new stack
45 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:5] Set("PJSIP/anonymous-00000033", "returnhere=1") in new stack
46 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:6] Gosub("PJSIP/anonymous-00000033", "app-blacklist-check,s,1()") in new stack
47 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/anonymous-00000033", "0?blacklisted") in new stack
48 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/anonymous-00000033", "CALLED_BLACKLIST=1") in new stack
49 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/anonymous-00000033", "") in new stack
50 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:7] Set("PJSIP/anonymous-00000033", "CDR(did)=0170") in new stack
51 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:8] GotoIf("PJSIP/anonymous-00000033", "0?") in new stack
52 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:9] ExecIf("PJSIP/anonymous-00000033", "0 ?Set(CALLERID(name)=+18446288729)") in new stack
53 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:10] Set("PJSIP/anonymous-00000033", "__MOHCLASS=") in new stack
54 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:11] Ringing("PJSIP/anonymous-00000033", "") in new stack
55 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:12] Set("PJSIP/anonymous-00000033", "__RINGINGSENT=TRUE") in new stack
56 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:13] Set("PJSIP/anonymous-00000033", "__REVERSAL_REJECT=FALSE") in new stack
57 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:14] GotoIf("PJSIP/anonymous-00000033", "1?post-reverse-charge") in new stack
58 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (from-trunk,0170,16)
59 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:16] NoOp("PJSIP/anonymous-00000033", "") in new stack
60 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:17] Set("PJSIP/anonymous-00000033", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
61 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:18] Set("PJSIP/anonymous-00000033", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
62 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:19] Set("PJSIP/anonymous-00000033", "CALLERID(name-pres)=allowed_not_screened") in new stack
63 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:20] Set("PJSIP/anonymous-00000033", "CALLERID(num-pres)=allowed_not_screened") in new stack
64 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:21] NoOp("PJSIP/anonymous-00000033", "CallerID Entry Point") in new stack
65 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:22] Set("PJSIP/anonymous-00000033", "__CRM_DIRECTION=INBOUND") in new stack
66 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:23] Set("PJSIP/anonymous-00000033", "__CRM_SOURCE=+18446288729") in new stack
67 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:24] Set("PJSIP/anonymous-00000033", "__CRM_LINKEDID=1685000564.63") in new stack
68 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:25] AGI("PJSIP/anonymous-00000033", "agi://127.0.0.1/sangomacrm.agi,true") in new stack
69 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] res_agi.c: <PJSIP/anonymous-00000033>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
70 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:26] ExecIf("PJSIP/anonymous-00000033", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
71 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [0170@from-trunk:27] Goto("PJSIP/anonymous-00000033", "ivr-1,s,1") in new stack
72 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (ivr-1,s,1)
73 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:1] Set("PJSIP/anonymous-00000033", "TIMEOUT_LOOPCOUNT=0") in new stack
74 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:2] Set("PJSIP/anonymous-00000033", "INVALID_LOOPCOUNT=0") in new stack
75 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:3] Set("PJSIP/anonymous-00000033", "_IVR_CONTEXT_ivr-1=") in new stack
76 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:4] Set("PJSIP/anonymous-00000033", "_IVR_CONTEXT=ivr-1") in new stack
77 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:5] Set("PJSIP/anonymous-00000033", "__IVR_RETVM=") in new stack
78 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:6] GotoIf("PJSIP/anonymous-00000033", "0?skip") in new stack
79 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:7] Answer("PJSIP/anonymous-00000033", "") in new stack
80 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:8] Set("PJSIP/anonymous-00000033", "IVR_MSG=") in new stack
81 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:9] Set("PJSIP/anonymous-00000033", "TIMEOUT(digit)=3") in new stack
82 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] func_timeout.c: Digit timeout set to 3.000
83 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:10] ExecIf("PJSIP/anonymous-00000033", "0?Background()") in new stack
84 [2023-05-25 07:42:44] VERBOSE[4973][C-00000023] pbx.c: Executing [s@ivr-1:11] WaitExten("PJSIP/anonymous-00000033", "10,") in new stack
85 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] pbx.c: Executing [2@ivr-1:1] Set("PJSIP/anonymous-00000033", "__ivrreturn=0") in new stack
86 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] pbx.c: Executing [2@ivr-1:2] Goto("PJSIP/anonymous-00000033", "disa,1,1") in new stack
87 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (disa,1,1)
88 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:1] Answer("PJSIP/anonymous-00000033", "") in new stack
89 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:2] Authenticate("PJSIP/anonymous-00000033", "/etc/asterisk/disa-1.conf,") in new stack
90 [2023-05-25 07:42:47] VERBOSE[4973][C-00000023] file.c: <PJSIP/anonymous-00000033> Playing 'agent-pass.alaw' (language 'en')
91 [2023-05-25 07:42:51] VERBOSE[4973][C-00000023] file.c: <PJSIP/anonymous-00000033> Playing 'auth-thankyou.alaw' (language 'en')
92 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:3] Gosub("PJSIP/anonymous-00000033", "sub-record-check,s,1(disa,1,never)") in new stack
93 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000033", "12?initialized") in new stack
94 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,s,10)
95 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000033", "Recordings initialized") in new stack
96 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000033", "0?Set(ARG3=dontcare)") in new stack
97 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000033", "REC_POLICY_MODE_SAVE=") in new stack
98 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000033", "0?Set(REC_STATUS=NO)") in new stack
99 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000033", "4?checkaction") in new stack
100 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,s,17)
101 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000033", "0?sub-record-check,disa,1") in new stack
102 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/anonymous-00000033", "Generic disa Recording Check - +18446288729 1") in new stack
103 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/anonymous-00000033", "recordcheck,1(never,disa,1)") in new stack
104 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000033", "Starting recording check against never") in new stack
105 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000033", "never") in new stack
106 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,recordcheck,14)
107 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:14] Set("PJSIP/anonymous-00000033", "__REC_POLICY_MODE=NEVER") in new stack
108 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:15] Goto("PJSIP/anonymous-00000033", "stoprec") in new stack
109 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx_builtins.c: Goto (sub-record-check,recordcheck,26)
110 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:26] NoOp("PJSIP/anonymous-00000033", "Stopping recording: disa, 1") in new stack
111 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:27] Set("PJSIP/anonymous-00000033", "__REC_STATUS=STOPPED") in new stack
112 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:28] System("PJSIP/anonymous-00000033", "/var/lib/asterisk/bin/stoprecording.php "PJSIP/anonymous-00000033"") in new stack
113 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [recordcheck@sub-record-check:29] Return("PJSIP/anonymous-00000033", "") in new stack
114 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/anonymous-00000033", "") in new stack
115 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:4] Set("PJSIP/anonymous-00000033", "_DISA=disa^1^newcall") in new stack
116 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:5] Set("PJSIP/anonymous-00000033", "_DISACONTEXT=from-internal") in new stack
117 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:6] Set("PJSIP/anonymous-00000033", "_KEEPCID=TRUE") in new stack
118 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:7] Set("PJSIP/anonymous-00000033", "_HANGUP=T") in new stack
119 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:8] Set("PJSIP/anonymous-00000033", "TIMEOUT(digit)=3") in new stack
120 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] func_timeout.c: Digit timeout set to 3.000
121 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:9] Set("PJSIP/anonymous-00000033", "TIMEOUT(response)=10") in new stack
122 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] func_timeout.c: Response timeout set to 10.000
123 [2023-05-25 07:42:52] VERBOSE[4973][C-00000023] pbx.c: Executing [1@disa:10] DISA("PJSIP/anonymous-00000033", "no-password,disa-dial") in new stack
124 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [6988009420@disa-dial:1] NoOp("PJSIP/anonymous-00000033", "called 6988009420 in from-internal by ID: 1") in new stack
125 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [6988009420@disa-dial:2] Dial("PJSIP/anonymous-00000033", "Local/6988009420@from-internal,300,T") in new stack
126 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] app_dial.c: Called Local/6988009420@from-internal
127 [2023-05-25 07:43:00] WARNING[4973][C-00000023] channel.c: No path to translate from Local/6988009420@from-internal-00000006;1 to PJSIP/anonymous-00000033
128 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Spawn extension (disa-dial, 6988009420, 2) exited non-zero on 'PJSIP/anonymous-00000033'
129 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [h@disa-dial:1] NoOp("PJSIP/anonymous-00000033", "called h in from-internal by ID: 1") in new stack
130 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [h@disa-dial:2] Dial("PJSIP/anonymous-00000033", "Local/h@from-internal,300,T") in new stack
131 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] app_dial.c: Caller hung up before dial.
132 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000033'
133 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] app_stack.c: PJSIP/anonymous-00000033 Internal Gosub(crm-hangup,s,1) start
134 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/anonymous-00000033", "Sending Hangup to CRM") in new stack
135 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/anonymous-00000033", "HANGUP CAUSE: 0") in new stack
136 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/anonymous-00000033", "0?Set(__CRM_VOICEMAIL=)") in new stack
137 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/anonymous-00000033", "MASTER CHANNEL: 1685000564.63 = 1685000564.63") in new stack
138 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/anonymous-00000033", "0?return") in new stack
139 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/anonymous-00000033", "__CRM_HANGUP=1") in new stack
140 [2023-05-25 07:43:00] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/anonymous-00000033", "agi://127.0.0.1/sangomacrm.agi") in new stack
141 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [6988009420@from-internal:1] Macro("Local/6988009420@from-internal-00000006;2", "user-callerid,LIMIT,EXTERNAL,") in new stack
142 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/6988009420@from-internal-00000006;2", "TOUCH_MONITOR=1685000580.65") in new stack
143 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [h@from-internal:1] Macro("Local/6988009420@from-internal-00000006;2", "hangupcall") in new stack
144 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [s@macro-hangupcall:1] Gosub("Local/6988009420@from-internal-00000006;2", "app-missedcall-hangup,s,1()") in new stack
145 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/6988009420@from-internal-00000006;2", "Callee: s") in new stack
146 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/6988009420@from-internal-00000006;2", "Caller: ") in new stack
147 [2023-05-25 07:43:00] VERBOSE[5061][C-00000023] pbx.c: Executing [s@app-missedcall-hangup:3] AGI("Local/6988009420@from-internal-00000006;2", "agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-00000006;2,,") in new stack
148 [2023-05-25 07:43:01] VERBOSE[4973][C-00000023] res_agi.c: <PJSIP/anonymous-00000033>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
149 [2023-05-25 07:43:01] VERBOSE[4973][C-00000023] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/anonymous-00000033", "") in new stack
150 [2023-05-25 07:43:01] VERBOSE[4973][C-00000023] app_stack.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000033'
151 [2023-05-25 07:43:01] VERBOSE[4973][C-00000023] app_stack.c: PJSIP/anonymous-00000033 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
152 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] res_agi.c: agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-00000006;2,,: As a minimum this script requires extension or 's' as argument
153 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] res_agi.c: <Local/6988009420@from-internal-00000006;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
154 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx.c: Executing [s@app-missedcall-hangup:4] Return("Local/6988009420@from-internal-00000006;2", "") in new stack
155 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx.c: Executing [s@macro-hangupcall:2] GotoIf("Local/6988009420@from-internal-00000006;2", "1?theend") in new stack
156 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx_builtins.c: Goto (macro-hangupcall,s,4)
157 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx.c: Executing [s@macro-hangupcall:4] ExecIf("Local/6988009420@from-internal-00000006;2", "0?Set(CDR(recordingfile)=)") in new stack
158 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx.c: Executing [s@macro-hangupcall:5] Hangup("Local/6988009420@from-internal-00000006;2", "") in new stack
159 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] app_macro.c: Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Local/6988009420@from-internal-00000006;2' in macro 'hangupcall'
160 [2023-05-25 07:43:01] VERBOSE[5061][C-00000023] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-00000006;2'
FYI. I am able to dial out from extensions without issues. So trunk and outbound is setup ok. Any help is appreciated.