IVR/Directory

I have a small Freepbx installed. I have one IVR running and I can have the caller type the extensions last name and it will properly forward the call. However when they try to put in the extension and go directly to the persons extension they get a message they have been transferred out of the system and then the ivr starts again(which it is supposed to do on an invalid extension)
I am just not sure why it won’t goto the extension directly. I tried playing with the settings on the IVR module,I set it to enable direct extensions Yes.
Any ideas would be greatly appreciated
Yosef G

Please provide a call trace via pastebin: https://wiki.freepbx.org/display/SUP/Providing+Great+Debug#ProvidingGreatDebug-AsteriskLogs-PartII

Please also post a screenshot of your IVR settings.

I couldn’t figure out the directions to provide great logs but I hope this will be good enough

the extension I was trying to dial was 6030 if that helps
thank you
Yosef G

[2021-06-22 13:18:50] VERBOSE[26500][C-000167bf] netsock2.c: Using SIP RTP TOS bits 184
[2021-06-22 13:18:50] VERBOSE[26500][C-000167bf] netsock2.c: Using SIP RTP CoS mark 5
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Catch-All DID Match - Found 5708441178 - You probably want a DID for this.”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:2] Set(“SIP/voip.ms1-0000ae7e”, “__FROM_DID=5708441178”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:3] Goto(“SIP/voip.ms1-0000ae7e”, “ext-did,s,1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (ext-did,s,1)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:1] Set(“SIP/voip.ms1-0000ae7e”, “__DIRECTION=INBOUND”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:2] Gosub(“SIP/voip.ms1-0000ae7e”, “sub-record-check,s,1(in,s,dontcare)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?initialized”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/voip.ms1-0000ae7e”, “__REC_STATUS=INITIALIZED”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/voip.ms1-0000ae7e”, “NOW=1624382330”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/voip.ms1-0000ae7e”, “__DAY=22”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/voip.ms1-0000ae7e”, “__MONTH=06”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/voip.ms1-0000ae7e”, “__YEAR=2021”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/voip.ms1-0000ae7e”, “__TIMESTR=20210622-131850”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/voip.ms1-0000ae7e”, “__FROMEXTEN=unknown”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/voip.ms1-0000ae7e”, “__MON_FMT=wav”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/voip.ms1-0000ae7e”, “Recordings initialized”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(ARG3=dontcare)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/voip.ms1-0000ae7e”, “REC_POLICY_MODE_SAVE=”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(REC_STATUS=NO)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/voip.ms1-0000ae7e”, “2?checkaction”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,s,17)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/voip.ms1-0000ae7e”, “1?sub-record-check,in,1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,in,1)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Inbound Recording Check to s”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:2] Set(“SIP/voip.ms1-0000ae7e”, “FROMEXTEN=unknown”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:3] ExecIf(“SIP/voip.ms1-0000ae7e”, “10?Set(FROMEXTEN=5703461748)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:4] Gosub(“SIP/voip.ms1-0000ae7e”, “recordcheck,1(dontcare,in,s)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Starting recording check against dontcare”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/voip.ms1-0000ae7e”, “dontcare”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:5] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:3] Set(“SIP/voip.ms1-0000ae7e”, “CHANNEL(tonezone)=us”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:4] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(__FROM_DID=s)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:5] Set(“SIP/voip.ms1-0000ae7e”, “returnhere=1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:6] Gosub(“SIP/voip.ms1-0000ae7e”, “app-blacklist-check,s,1()”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:1] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?blacklisted”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:2] Set(“SIP/voip.ms1-0000ae7e”, “CALLED_BLACKLIST=1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:3] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:7] Set(“SIP/voip.ms1-0000ae7e”, “CDR(did)=5708441178”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:8] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:9] ExecIf(“SIP/voip.ms1-0000ae7e”, “0 ?Set(CALLERID(name)=5703461748)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:10] Set(“SIP/voip.ms1-0000ae7e”, “__MOHCLASS=”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:11] Set(“SIP/voip.ms1-0000ae7e”, “__REVERSAL_REJECT=FALSE”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:12] GotoIf(“SIP/voip.ms1-0000ae7e”, “1?post-reverse-charge”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (ext-did,s,14)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:14] NoOp(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:15] Set(“SIP/voip.ms1-0000ae7e”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:16] Set(“SIP/voip.ms1-0000ae7e”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:17] Set(“SIP/voip.ms1-0000ae7e”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:18] Set(“SIP/voip.ms1-0000ae7e”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:19] NoOp(“SIP/voip.ms1-0000ae7e”, “CallerID Entry Point”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:20] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_DIRECTION=INBOUND”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:21] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_SOURCE=5703461748”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:22] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_LINKEDID=1624382330.138074”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:23] AGI(“SIP/voip.ms1-0000ae7e”, “agi://127.0.0.1/sangomacrm.agi,true”) in new stack
[2021-06-22 13:18:50] VERBOSE[1517][C-000167be] file.c: <PJSIP/201-00016665> Playing ‘check-number-dial-again.alaw’ (language ‘en’)
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] res_agi.c: <SIP/voip.ms1-0000ae7e>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:24] ExecIf(“SIP/voip.ms1-0000ae7e”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:25] Goto(“SIP/voip.ms1-0000ae7e”, “directory,1,1”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (directory,1,1)
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:1] Answer(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:2] Wait(“SIP/voip.ms1-0000ae7e”, “1”) in new stack
[2021-06-22 13:18:52] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:3] AGI(“SIP/voip.ms1-0000ae7e”, “agi://127.0.0.1/directory.agi,dir=1,retivr=true”) in new stack
[2021-06-22 13:18:52] VERBOSE[1517][C-000167be] pbx.c: Executing [00046812111802@from-internal:6] Wait(“PJSIP/201-00016665”, “1”) in new stack
[2021-06-22 13:18:53] VERBOSE[1539][C-000167bf] res_agi.c: AGI Script Executing Application: (background) Options: (custom/replacement-1599058008321)
[2021-06-22 13:18:53] VERBOSE[1539][C-000167bf] file.c: <SIP/voip.ms1-0000ae7e> Playing ‘custom/replacement-1599058008321.ulaw’ (language ‘en’)
[2021-06-22 13:18:50] VERBOSE[26500][C-000167bf] netsock2.c: Using SIP RTP TOS bits 184
[2021-06-22 13:18:50] VERBOSE[26500][C-000167bf] netsock2.c: Using SIP RTP CoS mark 5
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Catch-All DID Match - Found 5708441178 - You probably want a DID for this.”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:2] Set(“SIP/voip.ms1-0000ae7e”, “__FROM_DID=5708441178”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [5708441178@from-trunk:3] Goto(“SIP/voip.ms1-0000ae7e”, “ext-did,s,1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (ext-did,s,1)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:1] Set(“SIP/voip.ms1-0000ae7e”, “__DIRECTION=INBOUND”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:2] Gosub(“SIP/voip.ms1-0000ae7e”, “sub-record-check,s,1(in,s,dontcare)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?initialized”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/voip.ms1-0000ae7e”, “__REC_STATUS=INITIALIZED”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/voip.ms1-0000ae7e”, “NOW=1624382330”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/voip.ms1-0000ae7e”, “__DAY=22”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/voip.ms1-0000ae7e”, “__MONTH=06”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/voip.ms1-0000ae7e”, “__YEAR=2021”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/voip.ms1-0000ae7e”, “__TIMESTR=20210622-131850”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/voip.ms1-0000ae7e”, “__FROMEXTEN=unknown”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/voip.ms1-0000ae7e”, “__MON_FMT=wav”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/voip.ms1-0000ae7e”, “Recordings initialized”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(ARG3=dontcare)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/voip.ms1-0000ae7e”, “REC_POLICY_MODE_SAVE=”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(REC_STATUS=NO)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/voip.ms1-0000ae7e”, “2?checkaction”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,s,17)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/voip.ms1-0000ae7e”, “1?sub-record-check,in,1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,in,1)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Inbound Recording Check to s”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:2] Set(“SIP/voip.ms1-0000ae7e”, “FROMEXTEN=unknown”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:3] ExecIf(“SIP/voip.ms1-0000ae7e”, “10?Set(FROMEXTEN=5703461748)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:4] Gosub(“SIP/voip.ms1-0000ae7e”, “recordcheck,1(dontcare,in,s)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/voip.ms1-0000ae7e”, “Starting recording check against dontcare”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/voip.ms1-0000ae7e”, “dontcare”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [in@sub-record-check:5] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:3] Set(“SIP/voip.ms1-0000ae7e”, “CHANNEL(tonezone)=us”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:4] ExecIf(“SIP/voip.ms1-0000ae7e”, “0?Set(__FROM_DID=s)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:5] Set(“SIP/voip.ms1-0000ae7e”, “returnhere=1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:6] Gosub(“SIP/voip.ms1-0000ae7e”, “app-blacklist-check,s,1()”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:1] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?blacklisted”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:2] Set(“SIP/voip.ms1-0000ae7e”, “CALLED_BLACKLIST=1”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@app-blacklist-check:3] Return(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:7] Set(“SIP/voip.ms1-0000ae7e”, “CDR(did)=5708441178”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:8] GotoIf(“SIP/voip.ms1-0000ae7e”, “0?”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:9] ExecIf(“SIP/voip.ms1-0000ae7e”, “0 ?Set(CALLERID(name)=5703461748)”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:10] Set(“SIP/voip.ms1-0000ae7e”, “__MOHCLASS=”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:11] Set(“SIP/voip.ms1-0000ae7e”, “__REVERSAL_REJECT=FALSE”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:12] GotoIf(“SIP/voip.ms1-0000ae7e”, “1?post-reverse-charge”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (ext-did,s,14)
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:14] NoOp(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:15] Set(“SIP/voip.ms1-0000ae7e”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:16] Set(“SIP/voip.ms1-0000ae7e”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:17] Set(“SIP/voip.ms1-0000ae7e”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:18] Set(“SIP/voip.ms1-0000ae7e”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:19] NoOp(“SIP/voip.ms1-0000ae7e”, “CallerID Entry Point”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:20] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_DIRECTION=INBOUND”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:21] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_SOURCE=5703461748”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:22] Set(“SIP/voip.ms1-0000ae7e”, “__CRM_LINKEDID=1624382330.138074”) in new stack
[2021-06-22 13:18:50] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:23] AGI(“SIP/voip.ms1-0000ae7e”, “agi://127.0.0.1/sangomacrm.agi,true”) in new stack
[2021-06-22 13:18:50] VERBOSE[1517][C-000167be] file.c: <PJSIP/201-00016665> Playing ‘check-number-dial-again.alaw’ (language ‘en’)
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] res_agi.c: <SIP/voip.ms1-0000ae7e>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:24] ExecIf(“SIP/voip.ms1-0000ae7e”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [s@ext-did:25] Goto(“SIP/voip.ms1-0000ae7e”, “directory,1,1”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx_builtins.c: Goto (directory,1,1)
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:1] Answer(“SIP/voip.ms1-0000ae7e”, “”) in new stack
[2021-06-22 13:18:51] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:2] Wait(“SIP/voip.ms1-0000ae7e”, “1”) in new stack
[2021-06-22 13:18:52] VERBOSE[1539][C-000167bf] pbx.c: Executing [1@directory:3] AGI(“SIP/voip.ms1-0000ae7e”, “agi://127.0.0.1/directory.agi,dir=1,retivr=true”) in new stack
[2021-06-22 13:18:52] VERBOSE[1517][C-000167be] pbx.c: Executing [00046812111802@from-internal:6] Wait(“PJSIP/201-00016665”, “1”) in new stack
[2021-06-22 13:18:53] VERBOSE[1539][C-000167bf] res_agi.c: AGI Script Executing Application: (background) Options: (custom/replacement-1599058008321)
[2021-06-22 13:18:53] VERBOSE[1539][C-000167bf] file.c: <SIP/voip.ms1-0000ae7e> Playing ‘custom/replacement-1599058008321.ulaw’ (language ‘en’)

You pasted your call log twice, looks like.

Are you dialing 201 from the IVR? Is that extension in the directory?

It is not easy to read your logs when posting without formatting properly, hence we asked to post it via pastebin. See instructions in the link above.

How is your call getting into the IVR - you are dropping into your “any/any” route. At some point, you’re probably going to want to change this so that your inbound calls have a matching DID on the Inbound Route that goes specifically to the Inbound IVR.

I see. It seems like you pointed your inbound route to the directory instead of to the IVR.

OK
I will change the answering to go to the IVR straight not sure whythat was like that. ( I am waiting for apply config to finish as it is taking a long time)
The reason why it has Any is that we only have one trunk coming in currently so there was no need to change that. Hopefully adding some trunks shortly and going to have to change that so I guess no time like the present(unless waiting for apply config to finish)

Yosef

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