Outbound calls go back to IVR!


(Georgios) #1

Hello all,
The topology is as follows. Freepbx is using Grandstream GXX4104 with two PSTN lines. I have set up an IVR.
All incoming calls are working fine, no problem with hangups or CallerID or disconnect tones.

The weird part is when you try to call from an extension (any extension) to an external phone (gsm or landline). The result is to hear the IVR options!! I tried to disable one by one and eventually both trunks (both PSTN) and the result is the same. Even with no trunks enabled at all you hear the IVR when you try to make an outbound call. Could you please help me out?

Please find below the logs…

[2021-09-21 12:35:42] VERBOSE[2562] netsock2.c: Using SIP RTP Audio TOS bits 184
[2021-09-21 12:35:42] VERBOSE[2562] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2021-09-21 12:35:42] VERBOSE[2562] netsock2.c: Using SIP RTP Audio CoS mark 5
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/23-0000000e", "Catch-All DID Match - Found 06938751318 - You probably want a DID for this.") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "__FROM_DID=06938751318") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Goto("PJSIP/23-0000000e", "ext-did,s,1") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (ext-did,s,1)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] Set("PJSIP/23-0000000e", "__DIRECTION=INBOUND") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Gosub("PJSIP/23-0000000e", "sub-record-check,s,1(in,s,dontcare)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/23-0000000e", "0?initialized") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "__REC_STATUS=INITIALIZED") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Set("PJSIP/23-0000000e", "NOW=1632216942") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] Set("PJSIP/23-0000000e", "__DAY=21") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] Set("PJSIP/23-0000000e", "__MONTH=09") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:6] Set("PJSIP/23-0000000e", "__YEAR=2021") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:7] Set("PJSIP/23-0000000e", "__TIMESTR=20210921-123542") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:8] Set("PJSIP/23-0000000e", "__FROMEXTEN=unknown") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:9] Set("PJSIP/23-0000000e", "__MON_FMT=wav") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:10] NoOp("PJSIP/23-0000000e", "Recordings initialized") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:11] ExecIf("PJSIP/23-0000000e", "0?Set(ARG3=dontcare)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:12] Set("PJSIP/23-0000000e", "REC_POLICY_MODE_SAVE=") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:13] ExecIf("PJSIP/23-0000000e", "0?Set(REC_STATUS=NO)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:14] GotoIf("PJSIP/23-0000000e", "2?checkaction") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (sub-record-check,s,17)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:17] GotoIf("PJSIP/23-0000000e", "1?sub-record-check,in,1") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (sub-record-check,in,1)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/23-0000000e", "Inbound Recording Check to s") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "FROMEXTEN=unknown") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] ExecIf("PJSIP/23-0000000e", "2?Set(FROMEXTEN=23)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] Gosub("PJSIP/23-0000000e", "recordcheck,1(dontcare,in,s)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/23-0000000e", "Starting recording check against dontcare") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Goto("PJSIP/23-0000000e", "dontcare") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Return("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] Return("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Set("PJSIP/23-0000000e", "CHANNEL(tonezone)=gr") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] ExecIf("PJSIP/23-0000000e", "0?Set(__FROM_DID=s)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] Set("PJSIP/23-0000000e", "returnhere=1") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:6] Gosub("PJSIP/23-0000000e", "app-blacklist-check,s,1()") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/23-0000000e", "0?blacklisted") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "CALLED_BLACKLIST=1") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Return("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:7] Set("PJSIP/23-0000000e", "CDR(did)=06938751318") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:8] GotoIf("PJSIP/23-0000000e", "0?") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:9] ExecIf("PJSIP/23-0000000e", "0 ?Set(CALLERID(name)=23)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:10] Set("PJSIP/23-0000000e", "__MOHCLASS=") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:11] Set("PJSIP/23-0000000e", "__REVERSAL_REJECT=FALSE") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:12] GotoIf("PJSIP/23-0000000e", "1?post-reverse-charge") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (ext-did,s,14)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:14] NoOp("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:15] Set("PJSIP/23-0000000e", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:16] Set("PJSIP/23-0000000e", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:17] Set("PJSIP/23-0000000e", "CALLERID(name-pres)=allowed_not_screened") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:18] Set("PJSIP/23-0000000e", "CALLERID(num-pres)=allowed_not_screened") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:19] NoOp("PJSIP/23-0000000e", "CallerID Entry Point") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:20] Set("PJSIP/23-0000000e", "__CRM_DIRECTION=INBOUND") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:21] Set("PJSIP/23-0000000e", "__CRM_SOURCE=23") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:22] Set("PJSIP/23-0000000e", "__CRM_LINKEDID=1632216942.17") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:23] AGI("PJSIP/23-0000000e", "agi://127.0.0.1/sangomacrm.agi,true") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] res_agi.c: <PJSIP/23-0000000e>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:24] ExecIf("PJSIP/23-0000000e", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:25] Goto("PJSIP/23-0000000e", "timeconditions,1,1") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (timeconditions,1,1)
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] Set("PJSIP/23-0000000e", "DB(TC/1/INUSESTATE)=INUSE") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] NoOp("PJSIP/23-0000000e", "TIMENOW: 12:35,Tue,21,Sep,Europe/Athens") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] NoOp("PJSIP/23-0000000e", "TIMEMATCHED: TRUE") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] GotoIfTime("PJSIP/23-0000000e", "08:00-16:00,mon-sat,1-31,jan-dec,Europe/Athens?truestate") in new stack
[2021-09-21 12:35:42] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (timeconditions,1,14)
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:14] GotoIf("PJSIP/23-0000000e", "0?falsegoto") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:15] ExecIf("PJSIP/23-0000000e", "0?Set(DB(TC/1)=)") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:16] Set("PJSIP/23-0000000e", "DEVICE_STATE(Custom:TC1)=NOT_INUSE") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:17] ExecIf("PJSIP/23-0000000e", "0?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:18] GotoIf("PJSIP/23-0000000e", "1?ivr-2,s,1") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx_builtins.c: Goto (ivr-2,s,1)
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] Set("PJSIP/23-0000000e", "TIMEOUT_LOOPCOUNT=0") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] Set("PJSIP/23-0000000e", "INVALID_LOOPCOUNT=0") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] Set("PJSIP/23-0000000e", "_IVR_CONTEXT_ivr-2=") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] Set("PJSIP/23-0000000e", "_IVR_CONTEXT=ivr-2") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] Set("PJSIP/23-0000000e", "__IVR_RETVM=") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:6] GotoIf("PJSIP/23-0000000e", "0?skip") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:7] Answer("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:8] Set("PJSIP/23-0000000e", "IVR_MSG=custom/Anakiklosi-day") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:9] Set("PJSIP/23-0000000e", "TIMEOUT(digit)=0") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] func_timeout.c: Digit timeout set to 0.000
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:10] Read("PJSIP/23-0000000e", "IVREXT,custom/Anakiklosi-day,,,0,0") in new stack
[2021-09-21 12:35:43] VERBOSE[7304][C-0000000b] file.c: <PJSIP/23-0000000e> Playing 'custom/Anakiklosi-day.ulaw' (language 'en')
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] app_read.c: User disconnected
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] Hangup("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Spawn extension (ivr-2, h, 1) exited non-zero on 'PJSIP/23-0000000e'
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] app_stack.c: PJSIP/23-0000000e Internal Gosub(crm-hangup,s,1) start
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/23-0000000e", "Sending Hangup to CRM") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:2] NoOp("PJSIP/23-0000000e", "HANGUP CAUSE: 16") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:3] ExecIf("PJSIP/23-0000000e", "0?Set(__CRM_VOICEMAIL=)") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:4] NoOp("PJSIP/23-0000000e", "MASTER CHANNEL: 1632216942.17 = 1632216942.17") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:5] GotoIf("PJSIP/23-0000000e", "0?return") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:6] Set("PJSIP/23-0000000e", "__CRM_HANGUP=1") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:7] AGI("PJSIP/23-0000000e", "agi://127.0.0.1/sangomacrm.agi") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] res_agi.c: <PJSIP/23-0000000e>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] pbx.c: Executing [[email protected]:8] Return("PJSIP/23-0000000e", "") in new stack
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] app_stack.c: Spawn extension (ivr-2, h, 1) exited non-zero on 'PJSIP/23-0000000e'
[2021-09-21 12:35:44] VERBOSE[7304][C-0000000b] app_stack.c: PJSIP/23-0000000e Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
[2021-09-21 12:35:49] WARNING[2562] res_pjsip_registrar.c: Endpoint 'anonymous' (192.168.1.252:5060) has no configured AORs
[2021-09-21 12:35:52] WARNING[2562] res_pjsip_registrar.c: Endpoint 'anonymous' (192.168.1.252:5062) has no configured AORs
[2021-09-21 12:36:00] NOTICE[2562] res_pjsip_exten_state.c: Endpoint '23' state subscription failed: Extension '204' does not exist in context 'from-trunk' or has no associated hint
[2021-09-21 12:36:01] NOTICE[2562] res_pjsip_exten_state.c: Endpoint '23' state subscription failed: Extension '204' does not exist in context 'from-trunk' or has no associated hint

(Lorne Gaetz) #2

You say this is an outbound call from a local extension, but the log lines are for a call in the from-trunk context. If this is a local extension it needs to be in the from-internal context.


(Georgios) #3

Igaetz, thank you for your immediate response. I am puzzled because the whole thing was set up in my office and worked smoothly without any problems whatsoever and when I moved everything to the client’s office and made the appropriate changes, of course, it went sour with the outgoing calls…

I will try “from-internal” and come back.


(Georgios) #4

Igaetz,i changed from-internal among afewother things. Now when i try to call a number i hear the message" The number you have dialed in not in service…" Can you please help me out?

indent preformatted text by 4 spaces

[2021-09-24 14:39:25] VERBOSE[21470] netsock2.c: Using SIP RTP Audio TOS bits 184
[2021-09-24 14:39:25] VERBOSE[21470] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2021-09-24 14:39:25] VERBOSE[21470] netsock2.c: Using SIP RTP Audio CoS mark 5
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/20-00000020”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] Set(“PJSIP/20-00000020”, “TOUCH_MONITOR=1632483565.42”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/20-00000020”, “CHANCONTEXT=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] Set(“PJSIP/20-00000020”, “CHANCONTEXT=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] Set(“PJSIP/20-00000020”, “CHANEXTENCONTEXT=20-00000020”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] Set(“PJSIP/20-00000020”, “CHANEXTEN=20-00000020”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/20-00000020”, “CALLERID(number)=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/20-00000020”, “AMPUSER=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/20-00000020”, “HOTDESCKCHAN=20-00000020”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/20-00000020”, “HOTDESKEXTEN=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] Set(“PJSIP/20-00000020”, “HOTDESKCALL=0”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/20-00000020”, “0?Set(HOTDESKCALL=1)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(name)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/20-00000020”, “0?report”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/20-00000020”, “1?Set(REALCALLERIDNUM=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:15] Set(“PJSIP/20-00000020”, “AMPUSER=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:16] GotoIf(“PJSIP/20-00000020”, “0?limit”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:17] Set(“PJSIP/20-00000020”, “AMPUSERCIDNAME=Console”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:18] ExecIf(“PJSIP/20-00000020”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:19] GotoIf(“PJSIP/20-00000020”, “0?report”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:20] Set(“PJSIP/20-00000020”, “AMPUSERCID=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:21] Set(“PJSIP/20-00000020”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:22] Set(“PJSIP/20-00000020”, “CALLERID(all)=“Console” <20>”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:23] ExecIf(“PJSIP/20-00000020”, “0?Set(CUSDIAL=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:24] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(all)=“Console” <20>)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:25] GotoIf(“PJSIP/20-00000020”, “0?limit”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:26] ExecIf(“PJSIP/20-00000020”, “1?Set(GROUP(concurrency_limit)=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:27] ExecIf(“PJSIP/20-00000020”, “0?Set(CHANNEL(language)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:28] NoOp(“PJSIP/20-00000020”, “Macro Depth is 1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:29] GotoIf(“PJSIP/20-00000020”, “1?report2:macroerror”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (macro-user-callerid,s,30)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:30] GotoIf(“PJSIP/20-00000020”, “1?continue”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (macro-user-callerid,s,49)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:49] Set(“PJSIP/20-00000020”, “CALLERID(number)=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:50] Set(“PJSIP/20-00000020”, “CALLERID(name)=Console”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:51] GotoIf(“PJSIP/20-00000020”, “0?cnum”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:52] Set(“PJSIP/20-00000020”, “CDR(cnam)=Console”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:53] Set(“PJSIP/20-00000020”, “CDR(cnum)=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:54] Set(“PJSIP/20-00000020”, “CHANNEL(language)=en”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] Gosub(“PJSIP/20-00000020”, “sub-record-check,s,1(out,96938751318,dontcare)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/20-00000020”, “0?initialized”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/20-00000020”, “__REC_STATUS=INITIALIZED”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] Set(“PJSIP/20-00000020”, “NOW=1632483565”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] Set(“PJSIP/20-00000020”, “__DAY=24”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] Set(“PJSIP/20-00000020”, “__MONTH=09”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/20-00000020”, “__YEAR=2021”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/20-00000020”, “__TIMESTR=20210924-143925”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/20-00000020”, “__FROMEXTEN=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/20-00000020”, “__MON_FMT=wav”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] NoOp(“PJSIP/20-00000020”, “Recordings initialized”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/20-00000020”, “0?Set(ARG3=dontcare)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] Set(“PJSIP/20-00000020”, “REC_POLICY_MODE_SAVE=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/20-00000020”, “0?Set(REC_STATUS=NO)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:14] GotoIf(“PJSIP/20-00000020”, “3?checkaction”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (sub-record-check,s,17)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/20-00000020”, “1?sub-record-check,out,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (sub-record-check,out,1)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/20-00000020”, “Outbound Recording Check from 20 to 96938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/20-00000020”, “RECMODE=dontcare”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/20-00000020”, “1?Goto(routewins)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (sub-record-check,out,7)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] Gosub(“PJSIP/20-00000020”, “recordcheck,1(dontcare,out,96938751318)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/20-00000020”, “Starting recording check against dontcare”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] Goto(“PJSIP/20-00000020”, “dontcare”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] Return(“PJSIP/20-00000020”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Return(“PJSIP/20-00000020”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/20-00000020”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] Set(“PJSIP/20-00000020”, “_ROUTEID=2”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] Set(“PJSIP/20-00000020”, “_ROUTENAME=Outbound_Route”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/20-00000020”, “MOHCLASS=default”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] ExecIf(“PJSIP/20-00000020”, “1?Set(TRUNKCIDOVERRIDE=2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/20-00000020”, “_CALLERIDNAMEINTERNAL=Console”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/20-00000020”, “_CALLERIDNUMINTERNAL=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] Set(“PJSIP/20-00000020”, “_EMAILNOTIFICATION=FALSE”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] Set(“PJSIP/20-00000020”, “_NODEST=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] Macro(“PJSIP/20-00000020”, “dialout-trunk,2,6938751318,off”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]ialout-trunk:1] Set(“PJSIP/20-00000020”, “DIAL_TRUNK=2”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] ExecIf(“PJSIP/20-00000020”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] GosubIf(“PJSIP/20-00000020”, “0?sub-pincheck,s,1()”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(num)=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] GotoIf(“PJSIP/20-00000020”, “0?disabletrunk,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/20-00000020”, “DIAL_NUMBER=6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/20-00000020”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/20-00000020”, “OUTBOUND_GROUP=OUT_2”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/20-00000020”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] GotoIf(“PJSIP/20-00000020”, “0?nomax”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] GotoIf(“PJSIP/20-00000020”, “0?chanfull”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] GotoIf(“PJSIP/20-00000020”, “0?skipoutcid”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:13] Macro(“PJSIP/20-00000020”, “outbound-callerid,2”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/20-00000020”, “20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/20-00000020”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] NoOp(“PJSIP/20-00000020”, “off”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/20-00000020”, “HOTDESCKCHAN=20-00000020”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/20-00000020”, “HOTDESKEXTEN=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/20-00000020”, “HOTDESKCALL=0”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] ExecIf(“PJSIP/20-00000020”, “0?Set(HOTDESKCALL=1)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(name)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] Set(“PJSIP/20-00000020”, “ALLOWTHISROUTE=NO”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] ExecIf(“PJSIP/20-00000020”, “0?Set(ALLOWTHISROUTE=YES)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/20-00000020”, “0?Hangup()”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/20-00000020”, “0?Set(REALCALLERIDNUM=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/20-00000020”, “0?Set(AMPUSER=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:16] GotoIf(“PJSIP/20-00000020”, “1?normcid”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:20] Set(“PJSIP/20-00000020”, “USEROUTCID=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:21] Set(“PJSIP/20-00000020”, “EMERGENCYCID=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:22] ExecIf(“PJSIP/20-00000020”, “0?Set(EMERGENCYCID=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:23] Set(“PJSIP/20-00000020”, “TRUNKOUTCID=2641056719”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:24] GotoIf(“PJSIP/20-00000020”, “1?trunkcid”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:30] ExecIf(“PJSIP/20-00000020”, “1?Set(CALLERID(all)=2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:31] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(all)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:32] ExecIf(“PJSIP/20-00000020”, “1?Set(CALLERID(all)=2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:33] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(all)=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:34] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERID(all)=20)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:35] Set(“PJSIP/20-00000020”, “TIOHIDE=no”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:36] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:37] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:38] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:39] ExecIf(“PJSIP/20-00000020”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:40] Set(“PJSIP/20-00000020”, “CDR(outbound_cnum)=2641056719”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:41] Set(“PJSIP/20-00000020”, “CDR(outbound_cnam)=”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:14] GosubIf(“PJSIP/20-00000020”, “0?sub-flp-2,s,1()”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:15] Set(“PJSIP/20-00000020”, “OUTNUM=6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:16] Set(“PJSIP/20-00000020”, “custom=SIP/FXO”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:17] ExecIf(“PJSIP/20-00000020”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:18] ExecIf(“PJSIP/20-00000020”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:19] Macro(“PJSIP/20-00000020”, “dialout-trunk-predial-hook,”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] MacroExit(“PJSIP/20-00000020”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:20] GotoIf(“PJSIP/20-00000020”, “0?skipcrm”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:21] Set(“PJSIP/20-00000020”, “__CRM_DIRECTION=OUTBOUND”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:22] Set(“PJSIP/20-00000020”, “__CRM_DESTINATION=6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:23] Set(“PJSIP/20-00000020”, “__CRM_SOURCE=20”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:24] AGI(“PJSIP/20-00000020”, “agi://127.0.0.1/sangomacrm.agi”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] res_agi.c: <PJSIP/20-00000020>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:25] Set(“PJSIP/20-00000020”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:26] NoOp(“PJSIP/20-00000020”, “CRM Finished”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:27] GotoIf(“PJSIP/20-00000020”, “0?bypass,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:28] ExecIf(“PJSIP/20-00000020”, “1?Set(CONNECTEDLINE(num,i)=6938751318)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:29] ExecIf(“PJSIP/20-00000020”, “1?Set(CONNECTEDLINE(name,i)=CID:2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:30] ExecIf(“PJSIP/20-00000020”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:31] GotoIf(“PJSIP/20-00000020”, “0?customtrunk”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:32] ExecIf(“PJSIP/20-00000020”, “0?Set(DIAL_TRUNK_OPTIONS=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:33] Set(“PJSIP/20-00000020”, “HASH(__SIPHEADERS,Alert-Info)=unset”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:34] Dial(“PJSIP/20-00000020”, “SIP/FXO/6938751318,300,Tb(func-apply-sipheaders^s^1,(2))U(sub-send-obroute-email^6938751318^96938751318^2^1632483565^^2641056719)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] netsock2.c: Using SIP RTP TOS bits 184
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] netsock2.c: Using SIP RTP CoS mark 5
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: SIP/FXO-0000000a Internal Gosub(func-apply-sipheaders,s,1(2)) start
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] ExecIf(“SIP/FXO-0000000a”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] NoOp(“SIP/FXO-0000000a”, “Applying SIP Headers to channel SIP/FXO-0000000a”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] Set(“SIP/FXO-0000000a”, “TECH=SIP”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:4] Set(“SIP/FXO-0000000a”, “SIPHEADERKEYS=Alert-Info”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] While(“SIP/FXO-0000000a”, “1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:6] Set(“SIP/FXO-0000000a”, “sipheader=unset”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:7] ExecIf(“SIP/FXO-0000000a”, “1?SIPRemoveHeader(Alert-Info:)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:8] ExecIf(“SIP/FXO-0000000a”, “0?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:9] ExecIf(“SIP/FXO-0000000a”, “0?Set(sipheader=http://127.0.0.1;info=unset)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:10] ExecIf(“SIP/FXO-0000000a”, “0?Set(sipheader=http://127.0.0.1unset)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:11] ExecIf(“SIP/FXO-0000000a”, “0?SIPAddHeader(Alert-Info:unset)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:12] ExecIf(“SIP/FXO-0000000a”, “0?Set(PJSIP_HEADER(add,Alert-Info)=unset)”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:13] EndWhile(“SIP/FXO-0000000a”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:5] While(“SIP/FXO-0000000a”, “0”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:14] Return(“SIP/FXO-0000000a”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: Spawn extension (from-trunk, 96938751318, 1) exited non-zero on ‘SIP/FXO-0000000a’
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: SIP/FXO-0000000a Internal Gosub(func-apply-sipheaders,s,1(2)) complete GOSUB_RETVAL=
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_dial.c: Called SIP/FXO/6938751318
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/anonymous-00000021”, “Received incoming SIP connection from unknown peer to 6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:2] Set(“PJSIP/anonymous-00000021”, “DID=6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:3] Goto(“PJSIP/anonymous-00000021”, “s,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx_builtins.c: Goto (from-sip-external,s,1)
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/anonymous-00000021”, “1?setlanguage:checkanon”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx_builtins.c: Goto (from-sip-external,s,2)
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:2] Set(“PJSIP/anonymous-00000021”, “CHANNEL(language)=en”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/anonymous-00000021”, “0?noanonymous”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:4] Goto(“PJSIP/anonymous-00000021”, “from-trunk,6938751318,1”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx_builtins.c: Goto (from-trunk,6938751318,1)
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:1] Set(“PJSIP/anonymous-00000021”, “__FROM_DID=6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/anonymous-00000021”, “Received an unknown call with DID set to 6938751318”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:3] Goto(“PJSIP/anonymous-00000021”, “s,a2”) in new stack
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx_builtins.c: Goto (from-trunk,s,2)
[2021-09-24 14:39:25] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:2] Answer(“PJSIP/anonymous-00000021”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_dial.c: SIP/FXO-0000000a answered PJSIP/20-00000020
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: SIP/FXO-0000000a Internal Gosub(sub-send-obroute-email,s,1(6938751318,96938751318,2,1632483565,2641056719)) start
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] GotoIf(“SIP/FXO-0000000a”, “0?sendEmail”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:2] NoOp(“SIP/FXO-0000000a”, “email notifications disabled…exiting.”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:3] Return(“SIP/FXO-0000000a”, “”) in new stack
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: Spawn extension (from-trunk, , 1) exited non-zero on ‘SIP/FXO-0000000a’
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] app_stack.c: SIP/FXO-0000000a Internal Gosub(sub-send-obroute-email,s,1(6938751318,96938751318,2,1632483565,2641056719)) complete GOSUB_RETVAL=
[2021-09-24 14:39:25] VERBOSE[23591][C-0000001f] bridge_channel.c: Channel SIP/FXO-0000000a joined ‘simple_bridge’ basic-bridge <6308b51c-ed3e-411a-9804-d76d7f688890>
[2021-09-24 14:39:25] VERBOSE[23578][C-0000001f] bridge_channel.c: Channel PJSIP/20-00000020 joined ‘simple_bridge’ basic-bridge <6308b51c-ed3e-411a-9804-d76d7f688890>
[2021-09-24 14:39:26] WARNING[23590][C-00000020] chan_sip.c: This function can only be used on SIP channels.
[2021-09-24 14:39:26] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:3] Log(“PJSIP/anonymous-00000021”, "WARNING,Friendly Scanner from ") in new stack
[2021-09-24 14:39:26] WARNING[23590][C-00000020] Ext. s: Friendly Scanner from
[2021-09-24 14:39:26] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:4] Wait(“PJSIP/anonymous-00000021”, “2”) in new stack
[2021-09-24 14:39:28] VERBOSE[23590][C-00000020] pbx.c: Executing [[email protected]:5] Playback(“PJSIP/anonymous-00000021”, “ss-noservice”) in new stack
[2021-09-24 14:39:28] VERBOSE[23590][C-00000020] file.c: <PJSIP/anonymous-00000021> Playing ‘ss-noservice.ulaw’ (language ‘en’)
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] bridge_channel.c: Channel PJSIP/20-00000020 left ‘simple_bridge’ basic-bridge <6308b51c-ed3e-411a-9804-d76d7f688890>
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] app_macro.c: Spawn extension (macro-dialout-trunk, s, 34) exited non-zero on ‘PJSIP/20-00000020’ in macro ‘dialout-trunk’
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] pbx.c: Spawn extension (from-internal, 96938751318, 12) exited non-zero on ‘PJSIP/20-00000020’
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/20-00000020”, “hangupcall”) in new stack
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/20-00000020”, “1?theend”) in new stack
[2021-09-24 14:39:29] VERBOSE[23578][C-0000001f] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2021-09-24 14:39:29] VERBOSE[23591][C-0000001f] bridge_channel.c: Channel SIP/FXO-0000000a left ‘simple_bridge’ basic-bridge <6308b51c-ed3e-411a-9804-d76d7f688890>


(Sholinaty) #5

from your logs, it looks like you tried to call:
6938751318

that number goes fast-busy, and may indeed ACTUALLY be not-in-service…