DISA issues, hangs up after a number is dialed

dicko · May 27, 2023, 4:11pm

You need to paste a log of a failed call.

isodos · May 27, 2023, 4:37pm

You’re right. Done.

isodos · May 27, 2023, 4:39pm

Call flow should be as such:

User dials into pbx >> inbound route catches & sends it to DISA >> PIN >> Dial 6988009420 (ex) >> Dial out

There’s an outbound route that adds +30 when 69. is used. I can call out from the extensions ok, but DISA doesn’t want to.

2	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-sip-external:1] NoOp("PJSIP/anonymous-00000072", "Received incoming SIP connection from unknown peer to 0170") in new stack	
3	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-sip-external:2] Set("PJSIP/anonymous-00000072", "DID=0170") in new stack	
4	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-sip-external:3] Goto("PJSIP/anonymous-00000072", "s,1") in new stack	
5	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (from-sip-external,s,1)	
6	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@from-sip-external:1] GotoIf("PJSIP/anonymous-00000072", "1?setlanguage:checkanon") in new stack	
7	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (from-sip-external,s,2)	
8	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@from-sip-external:2] Set("PJSIP/anonymous-00000072", "CHANNEL(language)=en") in new stack	
9	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@from-sip-external:3] GotoIf("PJSIP/anonymous-00000072", "0?noanonymous") in new stack	
10	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@from-sip-external:4] Goto("PJSIP/anonymous-00000072", "from-trunk,0170,1") in new stack	
11	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (from-trunk,0170,1)	
12	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:1] Set("PJSIP/anonymous-00000072", "__DIRECTION=INBOUND") in new stack	
13	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:2] Gosub("PJSIP/anonymous-00000072", "sub-record-check,s,1(in,0170,dontcare)") in new stack	
14	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000072", "0?initialized") in new stack	
15	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/anonymous-00000072", "__REC_STATUS=INITIALIZED") in new stack	
16	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/anonymous-00000072", "NOW=1685205542") in new stack	
17	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/anonymous-00000072", "__DAY=27") in new stack	
18	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/anonymous-00000072", "__MONTH=05") in new stack	
19	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/anonymous-00000072", "__YEAR=2023") in new stack	
20	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/anonymous-00000072", "__TIMESTR=20230527-163902") in new stack	
21	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/anonymous-00000072", "__FROMEXTEN=unknown") in new stack	
22	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/anonymous-00000072", "__MON_FMT=wav") in new stack	
23	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000072", "Recordings initialized") in new stack	
24	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000072", "0?Set(ARG3=dontcare)") in new stack	
25	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000072", "REC_POLICY_MODE_SAVE=") in new stack	
26	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000072", "0?Set(REC_STATUS=NO)") in new stack	
27	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000072", "2?checkaction") in new stack	
28	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,s,17)	
29	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000072", "1?sub-record-check,in,1") in new stack	
30	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,in,1)	
31	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/anonymous-00000072", "Inbound Recording Check to 0170") in new stack	
32	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/anonymous-00000072", "FROMEXTEN=unknown") in new stack	
33	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/anonymous-00000072", "12?Set(FROMEXTEN=+18446288729)") in new stack	
34	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/anonymous-00000072", "recordcheck,1(dontcare,in,0170)") in new stack	
35	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000072", "Starting recording check against dontcare") in new stack	
36	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000072", "dontcare") in new stack	
37	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
38	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/anonymous-00000072", "") in new stack	
39	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/anonymous-00000072", "") in new stack	
40	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:3] Set("PJSIP/anonymous-00000072", "CHANNEL(tonezone)=gr") in new stack	
41	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:4] Set("PJSIP/anonymous-00000072", "__FROM_DID=0170") in new stack	
42	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:5] Set("PJSIP/anonymous-00000072", "returnhere=1") in new stack	
43	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:6] Gosub("PJSIP/anonymous-00000072", "app-blacklist-check,s,1()") in new stack	
44	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/anonymous-00000072", "0?blacklisted") in new stack	
45	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/anonymous-00000072", "CALLED_BLACKLIST=1") in new stack	
46	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/anonymous-00000072", "") in new stack	
47	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:7] Set("PJSIP/anonymous-00000072", "CDR(did)=0170") in new stack	
48	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:8] GotoIf("PJSIP/anonymous-00000072", "0?") in new stack	
49	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:9] ExecIf("PJSIP/anonymous-00000072", "1 ?Set(CALLERID(name)=+18446288729)") in new stack	
50	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:10] Set("PJSIP/anonymous-00000072", "__MOHCLASS=") in new stack	
51	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:11] Set("PJSIP/anonymous-00000072", "__REVERSAL_REJECT=FALSE") in new stack	
52	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:12] GotoIf("PJSIP/anonymous-00000072", "1?post-reverse-charge") in new stack	
53	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (from-trunk,0170,14)	
54	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:14] NoOp("PJSIP/anonymous-00000072", "") in new stack	
55	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:15] Set("PJSIP/anonymous-00000072", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack	
56	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:16] Set("PJSIP/anonymous-00000072", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack	
57	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:17] Set("PJSIP/anonymous-00000072", "CALLERID(name-pres)=allowed_not_screened") in new stack	
58	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:18] Set("PJSIP/anonymous-00000072", "CALLERID(num-pres)=allowed_not_screened") in new stack	
59	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:19] NoOp("PJSIP/anonymous-00000072", "CallerID Entry Point") in new stack	
60	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:20] Set("PJSIP/anonymous-00000072", "__CRM_DIRECTION=INBOUND") in new stack	
61	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:21] Set("PJSIP/anonymous-00000072", "__CRM_SOURCE=+18446288729") in new stack	
62	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:22] Set("PJSIP/anonymous-00000072", "__CRM_LINKEDID=1685205542.138") in new stack	
63	[2023-05-27 16:39:02] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:23] AGI("PJSIP/anonymous-00000072", "agi://127.0.0.1/sangomacrm.agi,true") in new stack	
64	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] res_agi.c: <PJSIP/anonymous-00000072>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
65	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:24] ExecIf("PJSIP/anonymous-00000072", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
66	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] pbx.c: Executing [0170@from-trunk:25] Goto("PJSIP/anonymous-00000072", "disa,1,1") in new stack	
67	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (disa,1,1)	
68	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:1] Answer("PJSIP/anonymous-00000072", "") in new stack	
69	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:2] Authenticate("PJSIP/anonymous-00000072", "/etc/asterisk/disa-1.conf,") in new stack	
70	[2023-05-27 16:39:03] VERBOSE[7104][C-0000004a] file.c: <PJSIP/anonymous-00000072> Playing 'agent-pass.alaw' (language 'en')	
71	[2023-05-27 16:39:08] VERBOSE[7104][C-0000004a] file.c: <PJSIP/anonymous-00000072> Playing 'auth-thankyou.alaw' (language 'en')	
72	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:3] Gosub("PJSIP/anonymous-00000072", "sub-record-check,s,1(disa,1,never)") in new stack	
73	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000072", "12?initialized") in new stack	
74	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,s,10)	
75	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000072", "Recordings initialized") in new stack	
76	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000072", "0?Set(ARG3=dontcare)") in new stack	
77	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000072", "REC_POLICY_MODE_SAVE=") in new stack	
78	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000072", "0?Set(REC_STATUS=NO)") in new stack	
79	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000072", "4?checkaction") in new stack	
80	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,s,17)	
81	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000072", "0?sub-record-check,disa,1") in new stack	
82	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/anonymous-00000072", "Generic disa Recording Check - +18446288729 1") in new stack	
83	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/anonymous-00000072", "recordcheck,1(never,disa,1)") in new stack	
84	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000072", "Starting recording check against never") in new stack	
85	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000072", "never") in new stack	
86	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,recordcheck,14)	
87	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:14] Set("PJSIP/anonymous-00000072", "__REC_POLICY_MODE=NEVER") in new stack	
88	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:15] Goto("PJSIP/anonymous-00000072", "stoprec") in new stack	
89	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx_builtins.c: Goto (sub-record-check,recordcheck,26)	
90	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:26] NoOp("PJSIP/anonymous-00000072", "Stopping recording: disa, 1") in new stack	
91	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:27] Set("PJSIP/anonymous-00000072", "__REC_STATUS=STOPPED") in new stack	
92	[2023-05-27 16:39:09] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:28] System("PJSIP/anonymous-00000072", "/var/lib/asterisk/bin/stoprecording.php "PJSIP/anonymous-00000072"") in new stack	
93	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [recordcheck@sub-record-check:29] Return("PJSIP/anonymous-00000072", "") in new stack	
94	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/anonymous-00000072", "") in new stack	
95	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:4] Set("PJSIP/anonymous-00000072", "_DISA=disa^1^newcall") in new stack	
96	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:5] Set("PJSIP/anonymous-00000072", "_DISACONTEXT=from-internal") in new stack	
97	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:6] Set("PJSIP/anonymous-00000072", "_KEEPCID=TRUE") in new stack	
98	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:7] Set("PJSIP/anonymous-00000072", "_HANGUP=T") in new stack	
99	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:8] Set("PJSIP/anonymous-00000072", "TIMEOUT(digit)=3") in new stack	
100	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] func_timeout.c: Digit timeout set to 3.000	
101	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:9] Set("PJSIP/anonymous-00000072", "TIMEOUT(response)=10") in new stack	
102	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] func_timeout.c: Response timeout set to 10.000	
103	[2023-05-27 16:39:11] VERBOSE[7104][C-0000004a] pbx.c: Executing [1@disa:10] DISA("PJSIP/anonymous-00000072", "no-password,disa-dial") in new stack	
104	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [6988009420@disa-dial:1] NoOp("PJSIP/anonymous-00000072", "called 6988009420 in from-internal by ID: 1") in new stack	
105	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [6988009420@disa-dial:2] Dial("PJSIP/anonymous-00000072", "Local/6988009420@from-internal,300,T") in new stack	
106	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] app_dial.c: Called Local/6988009420@from-internal	
107	[2023-05-27 16:39:18] WARNING[7104][C-0000004a] channel.c: No path to translate from Local/6988009420@from-internal-0000000c;1 to PJSIP/anonymous-00000072	
108	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Spawn extension (disa-dial, 6988009420, 2) exited non-zero on 'PJSIP/anonymous-00000072'	
109	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [h@disa-dial:1] NoOp("PJSIP/anonymous-00000072", "called h in from-internal by ID: 1") in new stack	
110	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [h@disa-dial:2] Dial("PJSIP/anonymous-00000072", "Local/h@from-internal,300,T") in new stack	
111	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] app_dial.c: Caller hung up before dial.	
112	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000072'	
113	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] app_stack.c: PJSIP/anonymous-00000072 Internal Gosub(crm-hangup,s,1) start	
114	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/anonymous-00000072", "Sending Hangup to CRM") in new stack	
115	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/anonymous-00000072", "HANGUP CAUSE: 0") in new stack	
116	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/anonymous-00000072", "0?Set(__CRM_VOICEMAIL=)") in new stack	
117	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/anonymous-00000072", "MASTER CHANNEL: 1685205542.138 = 1685205542.138") in new stack	
118	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/anonymous-00000072", "0?return") in new stack	
119	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/anonymous-00000072", "__CRM_HANGUP=1") in new stack	
120	[2023-05-27 16:39:18] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/anonymous-00000072", "agi://127.0.0.1/sangomacrm.agi") in new stack	
121	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [6988009420@from-internal:1] Macro("Local/6988009420@from-internal-0000000c;2", "user-callerid,LIMIT,EXTERNAL,") in new stack	
122	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/6988009420@from-internal-0000000c;2", "TOUCH_MONITOR=1685205558.140") in new stack	
123	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [h@from-internal:1] Macro("Local/6988009420@from-internal-0000000c;2", "hangupcall") in new stack	
124	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@macro-hangupcall:1] Gosub("Local/6988009420@from-internal-0000000c;2", "app-missedcall-hangup,s,1()") in new stack	
125	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/6988009420@from-internal-0000000c;2", "Callee: s") in new stack	
126	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/6988009420@from-internal-0000000c;2", "Caller: ") in new stack	
127	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@app-missedcall-hangup:3] AGI("Local/6988009420@from-internal-0000000c;2", "agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-0000000c;2,,") in new stack	
128	[2023-05-27 16:39:19] VERBOSE[7104][C-0000004a] res_agi.c: <PJSIP/anonymous-00000072>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
129	[2023-05-27 16:39:19] VERBOSE[7104][C-0000004a] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/anonymous-00000072", "") in new stack	
130	[2023-05-27 16:39:19] VERBOSE[7104][C-0000004a] app_stack.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000072'	
131	[2023-05-27 16:39:19] VERBOSE[7104][C-0000004a] app_stack.c: PJSIP/anonymous-00000072 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=	
132	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] res_agi.c: agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-0000000c;2,,: As a minimum this script requires extension or 's' as argument	
133	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] res_agi.c: <Local/6988009420@from-internal-0000000c;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0	
134	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@app-missedcall-hangup:4] Return("Local/6988009420@from-internal-0000000c;2", "") in new stack	
135	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@macro-hangupcall:2] GotoIf("Local/6988009420@from-internal-0000000c;2", "1?theend") in new stack	
136	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx_builtins.c: Goto (macro-hangupcall,s,4)	
137	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@macro-hangupcall:4] ExecIf("Local/6988009420@from-internal-0000000c;2", "0?Set(CDR(recordingfile)=)") in new stack	
138	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Executing [s@macro-hangupcall:5] Hangup("Local/6988009420@from-internal-0000000c;2", "") in new stack	
139	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] app_macro.c: Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Local/6988009420@from-internal-0000000c;2' in macro 'hangupcall'	
140	[2023-05-27 16:39:19] VERBOSE[7248][C-0000004a] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-0000000c;2'

david55 · May 27, 2023, 5:05pm

This generally indicates a configuration error, as there should be no good reason for not defining a matching endpoint.

You are lacking a required codec translation module. What codecs are you using?

isodos · May 27, 2023, 5:19pm

hey mate, so nice of you to lay a hand on this.

and

I just went by what zadarma had on their how-to tutorial.

Further more, I found this inside pjsip.endpoint.conf, if it helps:

;--------------------------------------------------------------------------------;
;          Do NOT edit this file as it is auto-generated by FreePBX.             ;
;--------------------------------------------------------------------------------;
; For information on adding additional paramaters to this file, please visit the ;
; FreePBX.org wiki page, or ask on IRC. This file was created by the new FreePBX ;
; BMO - Big Module Object. Any similarity in naming with BMO from Adventure Time ;
; is totally deliberate.                                                         ;
;--------------------------------------------------------------------------------;
#include pjsip.endpoint_custom.conf

[200]
type=endpoint
aors=200
auth=200-auth
tos_audio=ef
tos_video=af41
cos_audio=5
cos_video=4
allow=ulaw,alaw,g722,opus
context=from-internal
callerid=HellasConnect Support <200>

dtmf_mode=rfc4733
direct_media=yes
mailboxes=200@device

mwi_subscribe_replaces_unsolicited=yes
aggregate_mwi=no
use_avpf=no
rtcp_mux=no
max_audio_streams=1
max_video_streams=1
bundle=no
ice_support=no
media_use_received_transport=no
trust_id_inbound=yes
user_eq_phone=no
send_connected_line=yes
media_encryption=no
timers=yes
timers_min_se=90
media_encryption_optimistic=no
refer_blind_progress=yes
refer_blind_progress=yes
rtp_timeout=30
rtp_timeout_hold=300
rtp_keepalive=0
send_pai=yes
rtp_symmetric=yes
rewrite_contact=yes
force_rport=yes
language=en
one_touch_recording=on
record_on_feature=apprecord
record_off_feature=apprecord

[anonymous]
type=endpoint
context=from-sip-external
allow=all

[xxxxxxxxxx]
type=endpoint
transport=0.0.0.0-udp
context=from-pstn
disallow=all
allow=ulaw,alaw
aors=xxxxxxxxxx
send_connected_line=false
rtp_keepalive=0
language=en
outbound_auth=xxxxxxxxxx
from_domain=sip.zadarma.com
from_user=xxxxxxxxxx
contact_user=xxxxxxxxxx
user_eq_phone=no
t38_udptl=no
t38_udptl_ec=none
fax_detect=no
trust_id_inbound=no
t38_udptl_nat=no
direct_media=no
media_encryption=sdes
rtp_symmetric=yes
dtmf_mode=auto

where xxxxxxxxxx is my userID for zadarma.

PitzKey · May 27, 2023, 5:36pm

Post don’t create duplicate posts

isodos · May 27, 2023, 5:38pm

sorry mate

david55 · May 27, 2023, 6:26pm

If you are getting anonymous matching it is normally the type=identify section that is wrong.

isodos · May 27, 2023, 7:03pm

its

[806722]
type=identify
endpoint=806722
match=sip.zadarma.com

isodos · May 27, 2023, 7:21pm

im a bit of a newb to this, so pardon if i dont understand where to look / what to do.

Stewart1 · May 27, 2023, 10:38pm

There seem to be some inconsistencies with SRV records at Zadarma. I recommend setting Match (Permit) for the trunk to the numeric IPs of their netblocks:
185.45.155.0/24,185.45.152.0/24,195.122.19.0/24,37.139.38.138/24

If DISA still doesn’t work, confirm that ‘connection from unknown peer’ is gone, then post a new log.

isodos · May 28, 2023, 7:40am

I added them, even turned off the firewall on the pbx and vultr. No change to the DISA.

2	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-sip-external:1] NoOp("PJSIP/anonymous-00000075", "Received incoming SIP connection from unknown peer to 0170") in new stack	
3	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-sip-external:2] Set("PJSIP/anonymous-00000075", "DID=0170") in new stack	
4	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-sip-external:3] Goto("PJSIP/anonymous-00000075", "s,1") in new stack	
5	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (from-sip-external,s,1)	
6	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@from-sip-external:1] GotoIf("PJSIP/anonymous-00000075", "1?setlanguage:checkanon") in new stack	
7	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (from-sip-external,s,2)	
8	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@from-sip-external:2] Set("PJSIP/anonymous-00000075", "CHANNEL(language)=en") in new stack	
9	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@from-sip-external:3] GotoIf("PJSIP/anonymous-00000075", "0?noanonymous") in new stack	
10	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@from-sip-external:4] Goto("PJSIP/anonymous-00000075", "from-trunk,0170,1") in new stack	
11	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (from-trunk,0170,1)	
12	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:1] Set("PJSIP/anonymous-00000075", "__DIRECTION=INBOUND") in new stack	
13	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:2] Gosub("PJSIP/anonymous-00000075", "sub-record-check,s,1(in,0170,dontcare)") in new stack	
14	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000075", "0?initialized") in new stack	
15	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/anonymous-00000075", "__REC_STATUS=INITIALIZED") in new stack	
16	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/anonymous-00000075", "NOW=1685259531") in new stack	
17	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/anonymous-00000075", "__DAY=28") in new stack	
18	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/anonymous-00000075", "__MONTH=05") in new stack	
19	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/anonymous-00000075", "__YEAR=2023") in new stack	
20	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/anonymous-00000075", "__TIMESTR=20230528-073851") in new stack	
21	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/anonymous-00000075", "__FROMEXTEN=unknown") in new stack	
22	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/anonymous-00000075", "__MON_FMT=wav") in new stack	
23	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000075", "Recordings initialized") in new stack	
24	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000075", "0?Set(ARG3=dontcare)") in new stack	
25	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000075", "REC_POLICY_MODE_SAVE=") in new stack	
26	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000075", "0?Set(REC_STATUS=NO)") in new stack	
27	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000075", "2?checkaction") in new stack	
28	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,s,17)	
29	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000075", "1?sub-record-check,in,1") in new stack	
30	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,in,1)	
31	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/anonymous-00000075", "Inbound Recording Check to 0170") in new stack	
32	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/anonymous-00000075", "FROMEXTEN=unknown") in new stack	
33	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/anonymous-00000075", "12?Set(FROMEXTEN=+18446288729)") in new stack	
34	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/anonymous-00000075", "recordcheck,1(dontcare,in,0170)") in new stack	
35	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000075", "Starting recording check against dontcare") in new stack	
36	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000075", "dontcare") in new stack	
37	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
38	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/anonymous-00000075", "") in new stack	
39	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/anonymous-00000075", "") in new stack	
40	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:3] Set("PJSIP/anonymous-00000075", "CHANNEL(tonezone)=gr") in new stack	
41	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:4] Set("PJSIP/anonymous-00000075", "__FROM_DID=0170") in new stack	
42	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:5] Set("PJSIP/anonymous-00000075", "returnhere=1") in new stack	
43	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:6] Gosub("PJSIP/anonymous-00000075", "app-blacklist-check,s,1()") in new stack	
44	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/anonymous-00000075", "0?blacklisted") in new stack	
45	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/anonymous-00000075", "CALLED_BLACKLIST=1") in new stack	
46	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/anonymous-00000075", "") in new stack	
47	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:7] Set("PJSIP/anonymous-00000075", "CDR(did)=0170") in new stack	
48	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:8] GotoIf("PJSIP/anonymous-00000075", "0?") in new stack	
49	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:9] ExecIf("PJSIP/anonymous-00000075", "1 ?Set(CALLERID(name)=+18446288729)") in new stack	
50	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:10] Set("PJSIP/anonymous-00000075", "__MOHCLASS=") in new stack	
51	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:11] Set("PJSIP/anonymous-00000075", "__REVERSAL_REJECT=FALSE") in new stack	
52	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:12] GotoIf("PJSIP/anonymous-00000075", "1?post-reverse-charge") in new stack	
53	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (from-trunk,0170,14)	
54	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:14] NoOp("PJSIP/anonymous-00000075", "") in new stack	
55	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:15] Set("PJSIP/anonymous-00000075", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack	
56	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:16] Set("PJSIP/anonymous-00000075", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack	
57	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:17] Set("PJSIP/anonymous-00000075", "CALLERID(name-pres)=allowed_not_screened") in new stack	
58	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:18] Set("PJSIP/anonymous-00000075", "CALLERID(num-pres)=allowed_not_screened") in new stack	
59	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:19] NoOp("PJSIP/anonymous-00000075", "CallerID Entry Point") in new stack	
60	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:20] Set("PJSIP/anonymous-00000075", "__CRM_DIRECTION=INBOUND") in new stack	
61	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:21] Set("PJSIP/anonymous-00000075", "__CRM_SOURCE=+18446288729") in new stack	
62	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:22] Set("PJSIP/anonymous-00000075", "__CRM_LINKEDID=1685259531.147") in new stack	
63	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:23] AGI("PJSIP/anonymous-00000075", "agi://127.0.0.1/sangomacrm.agi,true") in new stack	
64	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] res_agi.c: <PJSIP/anonymous-00000075>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
65	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:24] ExecIf("PJSIP/anonymous-00000075", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
66	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [0170@from-trunk:25] Goto("PJSIP/anonymous-00000075", "disa,1,1") in new stack	
67	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (disa,1,1)	
68	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:1] Answer("PJSIP/anonymous-00000075", "") in new stack	
69	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:2] Authenticate("PJSIP/anonymous-00000075", "/etc/asterisk/disa-1.conf,") in new stack	
70	[2023-05-28 07:38:51] VERBOSE[27731][C-0000004d] file.c: <PJSIP/anonymous-00000075> Playing 'agent-pass.alaw' (language 'en')	
71	[2023-05-28 07:38:58] VERBOSE[27731][C-0000004d] file.c: <PJSIP/anonymous-00000075> Playing 'auth-thankyou.alaw' (language 'en')	
72	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:3] Gosub("PJSIP/anonymous-00000075", "sub-record-check,s,1(disa,1,never)") in new stack	
73	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000075", "12?initialized") in new stack	
74	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,s,10)	
75	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000075", "Recordings initialized") in new stack	
76	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000075", "0?Set(ARG3=dontcare)") in new stack	
77	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000075", "REC_POLICY_MODE_SAVE=") in new stack	
78	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000075", "0?Set(REC_STATUS=NO)") in new stack	
79	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000075", "4?checkaction") in new stack	
80	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,s,17)	
81	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000075", "0?sub-record-check,disa,1") in new stack	
82	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/anonymous-00000075", "Generic disa Recording Check - +18446288729 1") in new stack	
83	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/anonymous-00000075", "recordcheck,1(never,disa,1)") in new stack	
84	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000075", "Starting recording check against never") in new stack	
85	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000075", "never") in new stack	
86	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,recordcheck,14)	
87	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:14] Set("PJSIP/anonymous-00000075", "__REC_POLICY_MODE=NEVER") in new stack	
88	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:15] Goto("PJSIP/anonymous-00000075", "stoprec") in new stack	
89	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx_builtins.c: Goto (sub-record-check,recordcheck,26)	
90	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:26] NoOp("PJSIP/anonymous-00000075", "Stopping recording: disa, 1") in new stack	
91	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:27] Set("PJSIP/anonymous-00000075", "__REC_STATUS=STOPPED") in new stack	
92	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:28] System("PJSIP/anonymous-00000075", "/var/lib/asterisk/bin/stoprecording.php "PJSIP/anonymous-00000075"") in new stack	
93	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [recordcheck@sub-record-check:29] Return("PJSIP/anonymous-00000075", "") in new stack	
94	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/anonymous-00000075", "") in new stack	
95	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:4] Set("PJSIP/anonymous-00000075", "_DISA=disa^1^newcall") in new stack	
96	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:5] Set("PJSIP/anonymous-00000075", "_DISACONTEXT=from-internal") in new stack	
97	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:6] Set("PJSIP/anonymous-00000075", "_KEEPCID=TRUE") in new stack	
98	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:7] Set("PJSIP/anonymous-00000075", "_HANGUP=T") in new stack	
99	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:8] Set("PJSIP/anonymous-00000075", "TIMEOUT(digit)=3") in new stack	
100	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] func_timeout.c: Digit timeout set to 3.000	
101	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:9] Set("PJSIP/anonymous-00000075", "TIMEOUT(response)=10") in new stack	
102	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] func_timeout.c: Response timeout set to 10.000	
103	[2023-05-28 07:38:59] VERBOSE[27731][C-0000004d] pbx.c: Executing [1@disa:10] DISA("PJSIP/anonymous-00000075", "no-password,disa-dial") in new stack	
104	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000075'	
105	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] app_stack.c: PJSIP/anonymous-00000075 Internal Gosub(crm-hangup,s,1) start	
106	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/anonymous-00000075", "Sending Hangup to CRM") in new stack	
107	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/anonymous-00000075", "HANGUP CAUSE: 0") in new stack	
108	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/anonymous-00000075", "0?Set(__CRM_VOICEMAIL=)") in new stack	
109	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/anonymous-00000075", "MASTER CHANNEL: 1685259531.147 = 1685259531.147") in new stack	
110	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/anonymous-00000075", "0?return") in new stack	
111	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/anonymous-00000075", "__CRM_HANGUP=1") in new stack	
112	[2023-05-28 07:39:06] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/anonymous-00000075", "agi://127.0.0.1/sangomacrm.agi") in new stack	
113	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [6988009420@from-internal:1] Macro("Local/6988009420@from-internal-0000000f;2", "user-callerid,LIMIT,EXTERNAL,") in new stack	
114	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/6988009420@from-internal-0000000f;2", "TOUCH_MONITOR=1685259546.149") in new stack	
115	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [h@from-internal:1] Macro("Local/6988009420@from-internal-0000000f;2", "hangupcall") in new stack	
116	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:1] Gosub("Local/6988009420@from-internal-0000000f;2", "app-missedcall-hangup,s,1()") in new stack	
117	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/6988009420@from-internal-0000000f;2", "Callee: s") in new stack	
118	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/6988009420@from-internal-0000000f;2", "Caller: ") in new stack	
119	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@app-missedcall-hangup:3] AGI("Local/6988009420@from-internal-0000000f;2", "agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-0000000f;2,,") in new stack	
120	[2023-05-28 07:39:06] VERBOSE[27827][C-0000004d] res_agi.c: agi://127.0.0.1/missedcallnotify.php,,,s,0,,Local/6988009420@from-internal-0000000f;2,,: As a minimum this script requires extension or 's' as argument	
121	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] res_agi.c: <Local/6988009420@from-internal-0000000f;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0	
122	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@app-missedcall-hangup:4] Return("Local/6988009420@from-internal-0000000f;2", "") in new stack	
123	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:2] GotoIf("Local/6988009420@from-internal-0000000f;2", "1?theend") in new stack	
124	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx_builtins.c: Goto (macro-hangupcall,s,4)	
125	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:4] ExecIf("Local/6988009420@from-internal-0000000f;2", "0?Set(CDR(recordingfile)=)") in new stack	
126	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:5] Hangup("Local/6988009420@from-internal-0000000f;2", "") in new stack	
127	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] app_macro.c: Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Local/6988009420@from-internal-0000000f;2' in macro 'hangupcall'	
128	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-0000000f;2'	
129	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] res_agi.c: <Local/6988009420@from-internal-0000000f;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0	
130	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@app-missedcall-hangup:4] Return("Local/6988009420@from-internal-0000000f;2", "") in new stack	
131	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:2] GotoIf("Local/6988009420@from-internal-0000000f;2", "1?theend") in new stack	
132	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx_builtins.c: Goto (macro-hangupcall,s,4)	
133	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:4] ExecIf("Local/6988009420@from-internal-0000000f;2", "0?Set(CDR(recordingfile)=)") in new stack	
134	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Executing [s@macro-hangupcall:5] Hangup("Local/6988009420@from-internal-0000000f;2", "") in new stack	
135	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] app_macro.c: Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Local/6988009420@from-internal-0000000f;2' in macro 'hangupcall'	
136	[2023-05-28 07:39:07] VERBOSE[27827][C-0000004d] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-0000000f;2'	
137	[2023-05-28 07:39:07] VERBOSE[27731][C-0000004d] res_agi.c: <PJSIP/anonymous-00000075>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
138	[2023-05-28 07:39:07] VERBOSE[27731][C-0000004d] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/anonymous-00000075", "") in new stack	
139	[2023-05-28 07:39:07] VERBOSE[27731][C-0000004d] app_stack.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000075'	
140	[2023-05-28 07:39:07] VERBOSE[27731][C-0000004d] app_stack.c: PJSIP/anonymous-00000075 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

Stewart1 · May 28, 2023, 1:46pm

Sorry, I had assumed that the connection from unknown peer was because the Zadarma trunk was not being properly recognized as the incoming source, so I suggested a change that might fix that.

Now, it seems that the 0170 DID you are calling is on a different trunk, though you didn’t mention any other trunks. How does this call come in (a different SIP trunk, PRI, GSM or POTS gateway, etc.)? We should fix that so it is no longer taken as ‘unknown’.

isodos · May 28, 2023, 1:59pm

I have a DID with Zadarma >> It is set to fwd incoming calls to [email protected] >> Incoming Route catches 0170 and then routes it to wherever (in this case DISA).

1 trunk - 1 incoming route - 1 outgoing route - all co

Stewart1 · May 28, 2023, 3:10pm

Possibly, when they do this type of forwarding, they send from an IP address different from those noted at

At the Asterisk command prompt, type
pjsip set logger on
and make a test call in. The Asterisk log will now include a SIP trace that will show the IP address from which Zadarma sent the INVITE. Add that IP address to Match (Permit) for the Zadarma trunk.

Now make another test call and with luck, you will no longer see ‘unknown peer’.

isodos · May 28, 2023, 7:56pm

I turned it on - showing no IPs, unless I’m blind. Below is my firewall for the PBX.

2	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-sip-external:1] NoOp("PJSIP/anonymous-00000089", "Received incoming SIP connection from unknown peer to 0170") in new stack	
3	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-sip-external:2] Set("PJSIP/anonymous-00000089", "DID=0170") in new stack	
4	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-sip-external:3] Goto("PJSIP/anonymous-00000089", "s,1") in new stack	
5	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (from-sip-external,s,1)	
6	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@from-sip-external:1] GotoIf("PJSIP/anonymous-00000089", "1?setlanguage:checkanon") in new stack	
7	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (from-sip-external,s,2)	
8	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@from-sip-external:2] Set("PJSIP/anonymous-00000089", "CHANNEL(language)=en") in new stack	
9	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@from-sip-external:3] GotoIf("PJSIP/anonymous-00000089", "0?noanonymous") in new stack	
10	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@from-sip-external:4] Goto("PJSIP/anonymous-00000089", "from-trunk,0170,1") in new stack	
11	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (from-trunk,0170,1)	
12	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:1] Set("PJSIP/anonymous-00000089", "__DIRECTION=INBOUND") in new stack	
13	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:2] Gosub("PJSIP/anonymous-00000089", "sub-record-check,s,1(in,0170,dontcare)") in new stack	
14	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000089", "0?initialized") in new stack	
15	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/anonymous-00000089", "__REC_STATUS=INITIALIZED") in new stack	
16	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/anonymous-00000089", "NOW=1685303410") in new stack	
17	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/anonymous-00000089", "__DAY=28") in new stack	
18	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/anonymous-00000089", "__MONTH=05") in new stack	
19	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/anonymous-00000089", "__YEAR=2023") in new stack	
20	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/anonymous-00000089", "__TIMESTR=20230528-195010") in new stack	
21	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/anonymous-00000089", "__FROMEXTEN=unknown") in new stack	
22	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/anonymous-00000089", "__MON_FMT=wav") in new stack	
23	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000089", "Recordings initialized") in new stack	
24	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000089", "0?Set(ARG3=dontcare)") in new stack	
25	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000089", "REC_POLICY_MODE_SAVE=") in new stack	
26	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000089", "0?Set(REC_STATUS=NO)") in new stack	
27	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000089", "2?checkaction") in new stack	
28	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,s,17)	
29	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000089", "1?sub-record-check,in,1") in new stack	
30	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,in,1)	
31	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/anonymous-00000089", "Inbound Recording Check to 0170") in new stack	
32	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/anonymous-00000089", "FROMEXTEN=unknown") in new stack	
33	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/anonymous-00000089", "12?Set(FROMEXTEN=+18446288729)") in new stack	
34	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/anonymous-00000089", "recordcheck,1(dontcare,in,0170)") in new stack	
35	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000089", "Starting recording check against dontcare") in new stack	
36	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000089", "dontcare") in new stack	
37	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
38	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/anonymous-00000089", "") in new stack	
39	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/anonymous-00000089", "") in new stack	
40	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:3] Set("PJSIP/anonymous-00000089", "CHANNEL(tonezone)=gr") in new stack	
41	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:4] Set("PJSIP/anonymous-00000089", "__FROM_DID=0170") in new stack	
42	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:5] Set("PJSIP/anonymous-00000089", "returnhere=1") in new stack	
43	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:6] Gosub("PJSIP/anonymous-00000089", "app-blacklist-check,s,1()") in new stack	
44	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/anonymous-00000089", "0?blacklisted") in new stack	
45	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/anonymous-00000089", "CALLED_BLACKLIST=1") in new stack	
46	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/anonymous-00000089", "") in new stack	
47	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:7] Set("PJSIP/anonymous-00000089", "CDR(did)=0170") in new stack	
48	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:8] GotoIf("PJSIP/anonymous-00000089", "0?") in new stack	
49	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:9] ExecIf("PJSIP/anonymous-00000089", "1 ?Set(CALLERID(name)=+18446288729)") in new stack	
50	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:10] Set("PJSIP/anonymous-00000089", "__MOHCLASS=") in new stack	
51	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:11] Set("PJSIP/anonymous-00000089", "__REVERSAL_REJECT=FALSE") in new stack	
52	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:12] GotoIf("PJSIP/anonymous-00000089", "1?post-reverse-charge") in new stack	
53	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (from-trunk,0170,14)	
54	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:14] NoOp("PJSIP/anonymous-00000089", "") in new stack	
55	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:15] Set("PJSIP/anonymous-00000089", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack	
56	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:16] Set("PJSIP/anonymous-00000089", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack	
57	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:17] Set("PJSIP/anonymous-00000089", "CALLERID(name-pres)=allowed_not_screened") in new stack	
58	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:18] Set("PJSIP/anonymous-00000089", "CALLERID(num-pres)=allowed_not_screened") in new stack	
59	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:19] NoOp("PJSIP/anonymous-00000089", "CallerID Entry Point") in new stack	
60	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:20] Set("PJSIP/anonymous-00000089", "__CRM_DIRECTION=INBOUND") in new stack	
61	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:21] Set("PJSIP/anonymous-00000089", "__CRM_SOURCE=+18446288729") in new stack	
62	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:22] Set("PJSIP/anonymous-00000089", "__CRM_LINKEDID=1685303410.179") in new stack	
63	[2023-05-28 19:50:10] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:23] AGI("PJSIP/anonymous-00000089", "agi://127.0.0.1/sangomacrm.agi,true") in new stack	
64	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] res_agi.c: <PJSIP/anonymous-00000089>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
65	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:24] ExecIf("PJSIP/anonymous-00000089", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
66	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] pbx.c: Executing [0170@from-trunk:25] Goto("PJSIP/anonymous-00000089", "disa,1,1") in new stack	
67	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (disa,1,1)	
68	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:1] Answer("PJSIP/anonymous-00000089", "") in new stack	
69	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:2] Authenticate("PJSIP/anonymous-00000089", "/etc/asterisk/disa-1.conf,") in new stack	
70	[2023-05-28 19:50:11] VERBOSE[9208][C-0000005d] file.c: <PJSIP/anonymous-00000089> Playing 'agent-pass.alaw' (language 'en')	
71	[2023-05-28 19:50:16] VERBOSE[9208][C-0000005d] file.c: <PJSIP/anonymous-00000089> Playing 'auth-thankyou.alaw' (language 'en')	
72	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:3] Gosub("PJSIP/anonymous-00000089", "sub-record-check,s,1(disa,1,never)") in new stack	
73	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-00000089", "12?initialized") in new stack	
74	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,s,10)	
75	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-00000089", "Recordings initialized") in new stack	
76	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-00000089", "0?Set(ARG3=dontcare)") in new stack	
77	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-00000089", "REC_POLICY_MODE_SAVE=") in new stack	
78	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-00000089", "0?Set(REC_STATUS=NO)") in new stack	
79	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-00000089", "4?checkaction") in new stack	
80	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,s,17)	
81	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-00000089", "0?sub-record-check,disa,1") in new stack	
82	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/anonymous-00000089", "Generic disa Recording Check - +18446288729 1") in new stack	
83	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/anonymous-00000089", "recordcheck,1(never,disa,1)") in new stack	
84	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-00000089", "Starting recording check against never") in new stack	
85	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-00000089", "never") in new stack	
86	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,recordcheck,14)	
87	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:14] Set("PJSIP/anonymous-00000089", "__REC_POLICY_MODE=NEVER") in new stack	
88	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:15] Goto("PJSIP/anonymous-00000089", "stoprec") in new stack	
89	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx_builtins.c: Goto (sub-record-check,recordcheck,26)	
90	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:26] NoOp("PJSIP/anonymous-00000089", "Stopping recording: disa, 1") in new stack	
91	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:27] Set("PJSIP/anonymous-00000089", "__REC_STATUS=STOPPED") in new stack	
92	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:28] System("PJSIP/anonymous-00000089", "/var/lib/asterisk/bin/stoprecording.php "PJSIP/anonymous-00000089"") in new stack	
93	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [recordcheck@sub-record-check:29] Return("PJSIP/anonymous-00000089", "") in new stack	
94	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/anonymous-00000089", "") in new stack	
95	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:4] Set("PJSIP/anonymous-00000089", "_DISA=disa^1^newcall") in new stack	
96	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:5] Set("PJSIP/anonymous-00000089", "_DISACONTEXT=from-internal") in new stack	
97	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:6] Set("PJSIP/anonymous-00000089", "_KEEPCID=TRUE") in new stack	
98	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:7] Set("PJSIP/anonymous-00000089", "_HANGUP=T") in new stack	
99	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:8] Set("PJSIP/anonymous-00000089", "TIMEOUT(digit)=3") in new stack	
100	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] func_timeout.c: Digit timeout set to 3.000	
101	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:9] Set("PJSIP/anonymous-00000089", "TIMEOUT(response)=10") in new stack	
102	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] func_timeout.c: Response timeout set to 10.000	
103	[2023-05-28 19:50:17] VERBOSE[9208][C-0000005d] pbx.c: Executing [1@disa:10] DISA("PJSIP/anonymous-00000089", "no-password,disa-dial") in new stack	
104	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [6988009420@disa-dial:1] NoOp("PJSIP/anonymous-00000089", "called 6988009420 in from-internal by ID: 1") in new stack	
105	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [6988009420@disa-dial:2] Dial("PJSIP/anonymous-00000089", "Local/6988009420@from-internal,300,T") in new stack	
106	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] app_dial.c: Called Local/6988009420@from-internal	
107	[2023-05-28 19:50:24] WARNING[9208][C-0000005d] channel.c: No path to translate from Local/6988009420@from-internal-00000015;1 to PJSIP/anonymous-00000089	
108	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Spawn extension (disa-dial, 6988009420, 2) exited non-zero on 'PJSIP/anonymous-00000089'	
109	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [h@disa-dial:1] NoOp("PJSIP/anonymous-00000089", "called h in from-internal by ID: 1") in new stack	
110	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [h@disa-dial:2] Dial("PJSIP/anonymous-00000089", "Local/h@from-internal,300,T") in new stack	
111	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] app_dial.c: Caller hung up before dial.	
112	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000089'	
113	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] app_stack.c: PJSIP/anonymous-00000089 Internal Gosub(crm-hangup,s,1) start	
114	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/anonymous-00000089", "Sending Hangup to CRM") in new stack	
115	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/anonymous-00000089", "HANGUP CAUSE: 0") in new stack	
116	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/anonymous-00000089", "0?Set(__CRM_VOICEMAIL=)") in new stack	
117	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/anonymous-00000089", "MASTER CHANNEL: 1685303410.179 = 1685303410.179") in new stack	
118	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/anonymous-00000089", "0?return") in new stack	
119	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/anonymous-00000089", "__CRM_HANGUP=1") in new stack	
120	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/anonymous-00000089", "agi://127.0.0.1/sangomacrm.agi") in new stack	
121	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [6988009420@from-internal:1] Macro("Local/6988009420@from-internal-00000015;2", "user-callerid,LIMIT,EXTERNAL,") in new stack	
122	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/6988009420@from-internal-00000015;2", "TOUCH_MONITOR=1685303424.181") in new stack	
123	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [h@from-internal:1] Macro("Local/6988009420@from-internal-00000015;2", "hangupcall") in new stack	
124	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/6988009420@from-internal-00000015;2", "__MCVMSTATUS=") in new stack	
125	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/6988009420@from-internal-00000015;2", "app-missedcall-hangup,s,1()") in new stack	
126	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/6988009420@from-internal-00000015;2", "Dialed: s") in new stack	
127	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/6988009420@from-internal-00000015;2", "Caller: ") in new stack	
128	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/6988009420@from-internal-00000015;2", "1?exit") in new stack	
129	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)	
130	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/6988009420@from-internal-00000015;2", "") in new stack	
131	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-hangupcall:3] GotoIf("Local/6988009420@from-internal-00000015;2", "1?theend") in new stack	
132	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx_builtins.c: Goto (macro-hangupcall,s,5)	
133	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-hangupcall:5] ExecIf("Local/6988009420@from-internal-00000015;2", "0?Set(CDR(recordingfile)=)") in new stack	
134	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Executing [s@macro-hangupcall:6] Hangup("Local/6988009420@from-internal-00000015;2", "") in new stack	
135	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'Local/6988009420@from-internal-00000015;2' in macro 'hangupcall'	
136	[2023-05-28 19:50:24] VERBOSE[9254][C-0000005d] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-00000015;2'	
137	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] res_agi.c: <PJSIP/anonymous-00000089>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
138	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/anonymous-00000089", "") in new stack	
139	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] app_stack.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-00000089'	
140	[2023-05-28 19:50:24] VERBOSE[9208][C-0000005d] app_stack.c: PJSIP/anonymous-00000089 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=```

One more thing I'd like to add, if the items below are set to OFF, I get no calls from Zadarma.

https://i.ibb.co/QP9QrHH/incoming.png

I have now opened a ticket with Zadarma as well, to see what they have to say about all this. Although, testing Twilio has the same results for outgoing calls.

Stewart1 · May 28, 2023, 8:51pm

Please confirm that at the Asterisk command prompt (not a shell prompt) you typed
pjsip set logger on
and saw the response
PJSIP Logging enabled

Also, note that pjsip logging gets disabled by any restart or reload, so make the test call right after enabling logging, without making any configuration changes.

isodos · May 28, 2023, 9:04pm

Yeah I did a reload afterwards, thanks for pointing that out.

Here it is:

2	[2023-05-28 21:01:43] VERBOSE[2479] res_pjsip_logger.c: <--- Received SIP request (1253 bytes) from UDP:185.45.155.33:5060 --->	
3	INVITE sip:[email protected]:5060 SIP/2.0	
4	Record-Route: <sip:185.45.155.33;lr=on;ftag=as3942cb83>	
5	Via: SIP/2.0/UDP 185.45.155.33;branch=z9hG4bK8644.634fabce70782e2625c21412c22f6192.0	
6	Via: SIP/2.0/UDP 185.45.155.21:5060;rport=5060;branch=z9hG4bK7806a5c9	
7	Max-Forwards: 69	
8	From: <sip:[email protected]>;tag=as3942cb83	
9	To: <sip:[email protected]:5060>	
10	Contact: <sip:[email protected]:5060>	
11	Call-ID: [email protected]:5060	
12	CSeq: 102 INVITE	
13	User-Agent: Zadarma Voip	
14	Date: Sun, 28 May 2023 21:01:43 GMT	
15	Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE	
16	Supported: replaces	
17	P-Called-Party-ID: <sip:15854[email protected]>	
18	CALLED_DID: 15854380170	
19	Content-Type: application/sdp	
20	Content-Length: 426	
21		
22	v=0	
23	o=root 244011065 244011065 IN IP4 185.45.155.21	
24	s=Zadarma Voip	
25	c=IN IP4 185.45.155.21	
26	t=0 0	
27	m=audio 10070 RTP/AVP 0 8 18 110 117 119 3 101	
28	a=rtpmap:0 PCMU/8000	
29	a=rtpmap:8 PCMA/8000	
30	a=rtpmap:18 G729/8000	
31	a=fmtp:18 annexb=no	
32	a=rtpmap:110 speex/8000	
33	a=rtpmap:117 speex/16000	
34	a=rtpmap:119 speex/32000	
35	a=rtpmap:3 GSM/8000	
36	a=rtpmap:101 telephone-event/8000	
37	a=fmtp:101 0-16	
38	a=ptime:20	
39	a=maxptime:60	
40	a=sendrecv	
41		
42	[2023-05-28 21:01:43] VERBOSE[28257] res_pjsip_logger.c: <--- Transmitting SIP response (498 bytes) to UDP:185.45.155.33:5060 --->	
43	SIP/2.0 100 Trying	
44	Via: SIP/2.0/UDP 185.45.155.33;rport=5060;received=185.45.155.33;branch=z9hG4bK8644.634fabce70782e2625c21412c22f6192.0	
45	Via: SIP/2.0/UDP 185.45.155.21:5060;rport=5060;branch=z9hG4bK7806a5c9	
46	Record-Route: <sip:185.45.155.33;lr;ftag=as3942cb83>	
47	Call-ID: [email protected]:5060	
48	From: <sip:[email protected]>;tag=as3942cb83	
49	To: <sip:[email protected]>	
50	CSeq: 102 INVITE	
51	Server: FPBX-16.0.40.3(18.16.0)	
52	Content-Length: 0	
53		
54		
55	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-sip-external:1] NoOp("PJSIP/anonymous-0000008a", "Received incoming SIP connection from unknown peer to 0170") in new stack	
56	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-sip-external:2] Set("PJSIP/anonymous-0000008a", "DID=0170") in new stack	
57	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-sip-external:3] Goto("PJSIP/anonymous-0000008a", "s,1") in new stack	
58	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (from-sip-external,s,1)	
59	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@from-sip-external:1] GotoIf("PJSIP/anonymous-0000008a", "1?setlanguage:checkanon") in new stack	
60	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (from-sip-external,s,2)	
61	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@from-sip-external:2] Set("PJSIP/anonymous-0000008a", "CHANNEL(language)=en") in new stack	
62	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@from-sip-external:3] GotoIf("PJSIP/anonymous-0000008a", "0?noanonymous") in new stack	
63	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@from-sip-external:4] Goto("PJSIP/anonymous-0000008a", "from-trunk,0170,1") in new stack	
64	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (from-trunk,0170,1)	
65	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:1] Set("PJSIP/anonymous-0000008a", "__DIRECTION=INBOUND") in new stack	
66	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:2] Gosub("PJSIP/anonymous-0000008a", "sub-record-check,s,1(in,0170,dontcare)") in new stack	
67	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-0000008a", "0?initialized") in new stack	
68	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/anonymous-0000008a", "__REC_STATUS=INITIALIZED") in new stack	
69	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/anonymous-0000008a", "NOW=1685307703") in new stack	
70	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/anonymous-0000008a", "__DAY=28") in new stack	
71	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/anonymous-0000008a", "__MONTH=05") in new stack	
72	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/anonymous-0000008a", "__YEAR=2023") in new stack	
73	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/anonymous-0000008a", "__TIMESTR=20230528-210143") in new stack	
74	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/anonymous-0000008a", "__FROMEXTEN=unknown") in new stack	
75	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/anonymous-0000008a", "__MON_FMT=wav") in new stack	
76	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-0000008a", "Recordings initialized") in new stack	
77	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-0000008a", "0?Set(ARG3=dontcare)") in new stack	
78	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-0000008a", "REC_POLICY_MODE_SAVE=") in new stack	
79	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-0000008a", "0?Set(REC_STATUS=NO)") in new stack	
80	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-0000008a", "2?checkaction") in new stack	
81	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,s,17)	
82	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-0000008a", "1?sub-record-check,in,1") in new stack	
83	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,in,1)	
84	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/anonymous-0000008a", "Inbound Recording Check to 0170") in new stack	
85	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/anonymous-0000008a", "FROMEXTEN=unknown") in new stack	
86	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/anonymous-0000008a", "12?Set(FROMEXTEN=+18446288729)") in new stack	
87	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/anonymous-0000008a", "recordcheck,1(dontcare,in,0170)") in new stack	
88	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-0000008a", "Starting recording check against dontcare") in new stack	
89	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-0000008a", "dontcare") in new stack	
90	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
91	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/anonymous-0000008a", "") in new stack	
92	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/anonymous-0000008a", "") in new stack	
93	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:3] Set("PJSIP/anonymous-0000008a", "CHANNEL(tonezone)=gr") in new stack	
94	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:4] Set("PJSIP/anonymous-0000008a", "__FROM_DID=0170") in new stack	
95	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:5] Set("PJSIP/anonymous-0000008a", "returnhere=1") in new stack	
96	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:6] Gosub("PJSIP/anonymous-0000008a", "app-blacklist-check,s,1()") in new stack	
97	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/anonymous-0000008a", "0?blacklisted") in new stack	
98	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/anonymous-0000008a", "CALLED_BLACKLIST=1") in new stack	
99	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/anonymous-0000008a", "") in new stack	
100	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:7] Set("PJSIP/anonymous-0000008a", "CDR(did)=0170") in new stack	
101	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:8] GotoIf("PJSIP/anonymous-0000008a", "0?") in new stack	
102	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:9] ExecIf("PJSIP/anonymous-0000008a", "1 ?Set(CALLERID(name)=+18446288729)") in new stack	
103	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:10] Set("PJSIP/anonymous-0000008a", "__MOHCLASS=") in new stack	
104	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:11] Set("PJSIP/anonymous-0000008a", "__REVERSAL_REJECT=FALSE") in new stack	
105	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:12] GotoIf("PJSIP/anonymous-0000008a", "1?post-reverse-charge") in new stack	
106	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (from-trunk,0170,14)	
107	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:14] NoOp("PJSIP/anonymous-0000008a", "") in new stack	
108	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:15] Set("PJSIP/anonymous-0000008a", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack	
109	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:16] Set("PJSIP/anonymous-0000008a", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack	
110	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:17] Set("PJSIP/anonymous-0000008a", "CALLERID(name-pres)=allowed_not_screened") in new stack	
111	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:18] Set("PJSIP/anonymous-0000008a", "CALLERID(num-pres)=allowed_not_screened") in new stack	
112	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:19] NoOp("PJSIP/anonymous-0000008a", "CallerID Entry Point") in new stack	
113	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:20] Set("PJSIP/anonymous-0000008a", "__CRM_DIRECTION=INBOUND") in new stack	
114	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:21] Set("PJSIP/anonymous-0000008a", "__CRM_SOURCE=+18446288729") in new stack	
115	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:22] Set("PJSIP/anonymous-0000008a", "__CRM_LINKEDID=1685307703.182") in new stack	
116	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:23] AGI("PJSIP/anonymous-0000008a", "agi://127.0.0.1/sangomacrm.agi,true") in new stack	
117	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] res_agi.c: <PJSIP/anonymous-0000008a>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
118	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:24] ExecIf("PJSIP/anonymous-0000008a", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
119	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [0170@from-trunk:25] Goto("PJSIP/anonymous-0000008a", "disa,1,1") in new stack	
120	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (disa,1,1)	
121	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:1] Answer("PJSIP/anonymous-0000008a", "") in new stack	
122	[2023-05-28 21:01:43] VERBOSE[28257] res_pjsip_logger.c: <--- Transmitting SIP response (1185 bytes) to UDP:185.45.155.33:5060 --->	
123	SIP/2.0 200 OK	
124	Via: SIP/2.0/UDP 185.45.155.33;rport=5060;received=185.45.155.33;branch=z9hG4bK8644.634fabce70782e2625c21412c22f6192.0	
125	Via: SIP/2.0/UDP 185.45.155.21:5060;rport=5060;branch=z9hG4bK7806a5c9	
126	Record-Route: <sip:185.45.155.33;lr;ftag=as3942cb83>	
127	Call-ID: [email protected]:5060	
128	From: <sip:[email protected]>;tag=as3942cb83	
129	To: <sip:[email protected]>;tag=492e52fd-628f-4673-8a83-e6b954021f22	
130	CSeq: 102 INVITE	
131	Server: FPBX-16.0.40.3(18.16.0)	
132	Contact: <sip:149.248.54.120:5060>	
133	Allow: OPTIONS, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, MESSAGE, REFER	
134	Supported: 100rel, timer, replaces, norefersub	
135	Content-Type: application/sdp	
136	Content-Length: 421	
137		
138	v=0	
139	o=- 244011065 244011067 IN IP4 149.248.54.120	
140	s=Asterisk	
141	c=IN IP4 149.248.54.120	
142	t=0 0	
143	m=audio 17796 RTP/AVP 0 8 3 18 110 117 119 101	
144	a=rtpmap:0 PCMU/8000	
145	a=rtpmap:8 PCMA/8000	
146	a=rtpmap:3 GSM/8000	
147	a=rtpmap:18 G729/8000	
148	a=fmtp:18 annexb=no	
149	a=rtpmap:110 speex/8000	
150	a=rtpmap:117 speex/16000	
151	a=rtpmap:119 speex/32000	
152	a=rtpmap:101 telephone-event/8000	
153	a=fmtp:101 0-16	
154	a=ptime:20	
155	a=maxptime:60	
156	a=sendrecv	
157		
158	[2023-05-28 21:01:43] VERBOSE[2479] res_pjsip_logger.c: <--- Received SIP request (526 bytes) from UDP:185.45.155.33:5060 --->	
159	ACK sip:149.248.54.120:5060 SIP/2.0	
160	Via: SIP/2.0/UDP 185.45.155.33;branch=z9hG4bK8644.1855fb92e3be808183dd91eeace1ed63.0	
161	Via: SIP/2.0/UDP 185.45.155.21:5060;rport=5060;branch=z9hG4bK41c954b1	
162	Max-Forwards: 69	
163	From: <sip:[email protected]>;tag=as3942cb83	
164	To: <sip:[email protected]:5060>;tag=492e52fd-628f-4673-8a83-e6b954021f22	
165	Contact: <sip:[email protected]:5060>	
166	Call-ID: [email protected]:5060	
167	CSeq: 102 ACK	
168	User-Agent: Zadarma Voip	
169	Content-Length: 0	
170		
171		
172	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:2] Authenticate("PJSIP/anonymous-0000008a", "/etc/asterisk/disa-1.conf,") in new stack	
173	[2023-05-28 21:01:43] VERBOSE[28291][C-0000005e] file.c: <PJSIP/anonymous-0000008a> Playing 'agent-pass.alaw' (language 'en')	
174	[2023-05-28 21:01:50] VERBOSE[28257] res_pjsip_logger.c: <--- Transmitting SIP request (430 bytes) to UDP:185.45.155.17:5060 --->	
175	OPTIONS sip:sip.zadarma.com:5060 SIP/2.0	
176	Via: SIP/2.0/UDP 149.248.54.120:5060;rport;branch=z9hG4bKPja9c6293a-9523-4c9c-98f1-5a215e9924e2	
177	From: <sip:[email protected]>;tag=de969576-2de9-4dd6-8a51-99e4cc2f3e03	
178	To: <sip:sip.zadarma.com>	
179	Contact: <sip:[email protected]:5060>	
180	Call-ID: ee0f8661-2a18-4589-aa60-ea352088dcdc	
181	CSeq: 3095 OPTIONS	
182	Max-Forwards: 70	
183	User-Agent: FPBX-16.0.40.3(18.16.0)	
184	Content-Length: 0	
185		
186		
187	[2023-05-28 21:01:50] VERBOSE[2479] res_pjsip_logger.c: <--- Received SIP response (404 bytes) from UDP:185.45.155.17:5060 --->	
188	SIP/2.0 200 OK	
189	Via: SIP/2.0/UDP 149.248.54.120:5060;rport=5060;branch=z9hG4bKPja9c6293a-9523-4c9c-98f1-5a215e9924e2;received=149.248.54.120	
190	From: <sip:[email protected]>;tag=de969576-2de9-4dd6-8a51-99e4cc2f3e03	
191	To: <sip:sip.zadarma.com>;tag=cd7ad5b3eaa806970f17789ffe546ac7.7f008c15	
192	Call-ID: ee0f8661-2a18-4589-aa60-ea352088dcdc	
193	CSeq: 3095 OPTIONS	
194	Server: Zadarma server	
195	Content-Length: 0	
196		
197		
198	[2023-05-28 21:01:51] VERBOSE[28291][C-0000005e] file.c: <PJSIP/anonymous-0000008a> Playing 'auth-thankyou.alaw' (language 'en')	
199	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:3] Gosub("PJSIP/anonymous-0000008a", "sub-record-check,s,1(disa,1,never)") in new stack	
200	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/anonymous-0000008a", "12?initialized") in new stack	
201	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,s,10)	
202	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/anonymous-0000008a", "Recordings initialized") in new stack	
203	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/anonymous-0000008a", "0?Set(ARG3=dontcare)") in new stack	
204	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/anonymous-0000008a", "REC_POLICY_MODE_SAVE=") in new stack	
205	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/anonymous-0000008a", "0?Set(REC_STATUS=NO)") in new stack	
206	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/anonymous-0000008a", "4?checkaction") in new stack	
207	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,s,17)	
208	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/anonymous-0000008a", "0?sub-record-check,disa,1") in new stack	
209	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/anonymous-0000008a", "Generic disa Recording Check - +18446288729 1") in new stack	
210	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/anonymous-0000008a", "recordcheck,1(never,disa,1)") in new stack	
211	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/anonymous-0000008a", "Starting recording check against never") in new stack	
212	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/anonymous-0000008a", "never") in new stack	
213	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,recordcheck,14)	
214	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:14] Set("PJSIP/anonymous-0000008a", "__REC_POLICY_MODE=NEVER") in new stack	
215	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:15] Goto("PJSIP/anonymous-0000008a", "stoprec") in new stack	
216	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx_builtins.c: Goto (sub-record-check,recordcheck,26)	
217	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:26] NoOp("PJSIP/anonymous-0000008a", "Stopping recording: disa, 1") in new stack	
218	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:27] Set("PJSIP/anonymous-0000008a", "__REC_STATUS=STOPPED") in new stack	
219	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:28] System("PJSIP/anonymous-0000008a", "/var/lib/asterisk/bin/stoprecording.php "PJSIP/anonymous-0000008a"") in new stack	
220	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [recordcheck@sub-record-check:29] Return("PJSIP/anonymous-0000008a", "") in new stack	
221	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/anonymous-0000008a", "") in new stack	
222	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:4] Set("PJSIP/anonymous-0000008a", "_DISA=disa^1^newcall") in new stack	
223	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:5] Set("PJSIP/anonymous-0000008a", "_DISACONTEXT=from-internal") in new stack	
224	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:6] Set("PJSIP/anonymous-0000008a", "_KEEPCID=TRUE") in new stack	
225	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:7] Set("PJSIP/anonymous-0000008a", "_HANGUP=T") in new stack	
226	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:8] Set("PJSIP/anonymous-0000008a", "TIMEOUT(digit)=3") in new stack	
227	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] func_timeout.c: Digit timeout set to 3.000	
228	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:9] Set("PJSIP/anonymous-0000008a", "TIMEOUT(response)=10") in new stack	
229	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] func_timeout.c: Response timeout set to 10.000	
230	[2023-05-28 21:01:52] VERBOSE[28291][C-0000005e] pbx.c: Executing [1@disa:10] DISA("PJSIP/anonymous-0000008a", "no-password,disa-dial") in new stack	
231	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [6988009420@disa-dial:1] NoOp("PJSIP/anonymous-0000008a", "called 6988009420 in from-internal by ID: 1") in new stack	
232	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [6988009420@disa-dial:2] Dial("PJSIP/anonymous-0000008a", "Local/6988009420@from-internal,300,T") in new stack	
233	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] app_dial.c: Called Local/6988009420@from-internal	
234	[2023-05-28 21:01:59] WARNING[28291][C-0000005e] channel.c: No path to translate from Local/6988009420@from-internal-00000016;1 to PJSIP/anonymous-0000008a	
235	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Spawn extension (disa-dial, 6988009420, 2) exited non-zero on 'PJSIP/anonymous-0000008a'	
236	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [h@disa-dial:1] NoOp("PJSIP/anonymous-0000008a", "called h in from-internal by ID: 1") in new stack	
237	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [h@disa-dial:2] Dial("PJSIP/anonymous-0000008a", "Local/h@from-internal,300,T") in new stack	
238	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] app_dial.c: Caller hung up before dial.	
239	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-0000008a'	
240	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] app_stack.c: PJSIP/anonymous-0000008a Internal Gosub(crm-hangup,s,1) start	
241	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/anonymous-0000008a", "Sending Hangup to CRM") in new stack	
242	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/anonymous-0000008a", "HANGUP CAUSE: 0") in new stack	
243	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/anonymous-0000008a", "0?Set(__CRM_VOICEMAIL=)") in new stack	
244	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/anonymous-0000008a", "MASTER CHANNEL: 1685307703.182 = 1685307703.182") in new stack	
245	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/anonymous-0000008a", "0?return") in new stack	
246	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/anonymous-0000008a", "__CRM_HANGUP=1") in new stack	
247	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/anonymous-0000008a", "agi://127.0.0.1/sangomacrm.agi") in new stack	
248	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [6988009420@from-internal:1] Macro("Local/6988009420@from-internal-00000016;2", "user-callerid,LIMIT,EXTERNAL,") in new stack	
249	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/6988009420@from-internal-00000016;2", "TOUCH_MONITOR=1685307719.184") in new stack	
250	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [h@from-internal:1] Macro("Local/6988009420@from-internal-00000016;2", "hangupcall") in new stack	
251	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/6988009420@from-internal-00000016;2", "__MCVMSTATUS=") in new stack	
252	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/6988009420@from-internal-00000016;2", "app-missedcall-hangup,s,1()") in new stack	
253	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/6988009420@from-internal-00000016;2", "Dialed: s") in new stack	
254	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/6988009420@from-internal-00000016;2", "Caller: ") in new stack	
255	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/6988009420@from-internal-00000016;2", "1?exit") in new stack	
256	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)	
257	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/6988009420@from-internal-00000016;2", "") in new stack	
258	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-hangupcall:3] GotoIf("Local/6988009420@from-internal-00000016;2", "1?theend") in new stack	
259	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx_builtins.c: Goto (macro-hangupcall,s,5)	
260	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-hangupcall:5] ExecIf("Local/6988009420@from-internal-00000016;2", "0?Set(CDR(recordingfile)=)") in new stack	
261	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Executing [s@macro-hangupcall:6] Hangup("Local/6988009420@from-internal-00000016;2", "") in new stack	
262	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'Local/6988009420@from-internal-00000016;2' in macro 'hangupcall'	
263	[2023-05-28 21:01:59] VERBOSE[28343][C-0000005e] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/6988009420@from-internal-00000016;2'	
264	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] res_agi.c: <PJSIP/anonymous-0000008a>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
265	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/anonymous-0000008a", "") in new stack	
266	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] app_stack.c: Spawn extension (disa-dial, h, 2) exited non-zero on 'PJSIP/anonymous-0000008a'	
267	[2023-05-28 21:01:59] VERBOSE[28291][C-0000005e] app_stack.c: PJSIP/anonymous-0000008a Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=	
268	[2023-05-28 21:01:59] VERBOSE[28257] res_pjsip_logger.c: <--- Transmitting SIP request (511 bytes) to UDP:185.45.155.33:5060 --->	
269	BYE sip:[email protected]:5060 SIP/2.0	
270	Via: SIP/2.0/UDP 149.248.54.120:5060;rport;branch=z9hG4bKPj5e081bed-c642-4ab3-9c01-490794c9b5c2	
271	From: <sip:[email protected]>;tag=492e52fd-628f-4673-8a83-e6b954021f22	
272	To: <sip:[email protected]>;tag=as3942cb83	
273	Call-ID: [email protected]:5060	
274	CSeq: 11091 BYE	
275	Route: <sip:185.45.155.33;lr;ftag=as3942cb83>	
276	Reason: Q.850;cause=0	
277	Max-Forwards: 70	
278	User-Agent: FPBX-16.0.40.3(18.16.0)	
279	Content-Length: 0	
280		
281		
282	[2023-05-28 21:01:59] VERBOSE[2479] res_pjsip_logger.c: <--- Received SIP response (516 bytes) from UDP:185.45.155.33:5060 --->	
283	SIP/2.0 200 OK	
284	Via: SIP/2.0/UDP 149.248.54.120:5060;received=149.248.54.120;rport=5060;branch=z9hG4bKPj5e081bed-c642-4ab3-9c01-490794c9b5c2	
285	From: <sip:[email protected]>;tag=492e52fd-628f-4673-8a83-e6b954021f22	
286	To: <sip:[email protected]>;tag=as3942cb83	
287	Call-ID: 1d0f488414411659[email protected]:5060	
288	CSeq: 11091 BYE	
289	Server: Zadarma Voip	
290	Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE	
291	Supported: replaces	
292	Content-Length: 0	
293

Stewart1 · May 29, 2023, 4:37am

Since 185.45.155.33 is in the first block specified in Match (Permit) (185.45.155.0/24), it should have matched the trunk (and you wouldn’t need Allow Anonymous Inbound SIP Calls or Allow SIP Guests). We need to find out why it didn’t.

In various posts, you have a config file section [806722] and one [xxxxxxxxxx]. Please explain. Are they representing the same trunk? If not, do you have separate trunks for incoming and outgoing? Or is one not Zadarma?

Please post the contents of /etc/asterisk/pjsip.identify.conf

In Asterisk SIP Settings, chan_pjsip tab, what do you have for Endpoint Identifier Order? If you changed this from the default, please explain.

In the settings for the Zadarma inbound trunk, what do you have for Match (Permit)? For Match Inbound Authentication?

isodos · May 29, 2023, 6:35am

Newb, trying to disclosed my IDs on here but I found out you can’t as there’s a history. So xxxxxxxx is in reality 806722.

[806722]
type=identify
endpoint=806722
match=sip.zadarma.com

In the settings for the Zadarma inbound trunk, what do you have for Match (Permit)? For Match Inbound Authentication?
[/quote]

Do you mean under trunks > pjsip Settings > general?

I have Outbound selected, as per zadarmas guide. I tried “both” and used IP authentication @ zadarma’s end but it didnt make a diff.