Ring Groups not ringing

f1systems · December 5, 2019, 8:39pm

FreePBX 14.0.13.12 (all updates current as of post)
ESXI 6.7.1 VM with 4GB, 60GB (35GB free)

I had posted this issue before the holiday and the post closed before I got back. Recapping the issue:

My Inbound Route to any Ring Group of any size does not ring the group.

Ring Groups work as intended once after the PBX is booted and then do not ring.

The caller hears the Announcement of “Transferring” that is played as you enter each Ring Group but the phones do not ring. The Directory and IVR work as expected.

The order or groups, Directory and IVR have no impact.
The specific destination has no impact.
Ring Time has no impact

I do not know where to look for logs that would cover this activity. Any help would be appreciated.
Thanks for the assistance.

cynjut · December 5, 2019, 8:59pm

Logs. We’re gonna need logs. The reason I say this is because one of your devices is snagging the call before any of the other phones in the RG start ringing. Once it’s answered, you’re stuck.

f1systems · December 5, 2019, 9:59pm

Thank you, yes, log information would really help. Which logs and what am I looking for?

I am better with bash than with the CLI in the web interface but please point me in a specific direction.

arielgrin · December 5, 2019, 10:01pm

/var/log/asterisk/full

lgaetz · December 5, 2019, 10:21pm

Same one requested the last time:
https://wiki.freepbx.org/display/SUP/Providing+Great+Debug#ProvidingGreatDebug-AsteriskLogs-PartII

f1systems · December 5, 2019, 11:29pm

Doing my best here. If I did not provide the info you requested it is likely because I did not understand what you are asking me.

I made an inbound call at 16:22 with Inbound Route destination set to Ring Group 1 with a failure destination of the IVR. The call went straight to the IVR.

grep 1575588144.81 /var/log/asterisk/full*

/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:22] Set(“PJSIP/Flowroute-00000051”, “__CRM_LINKEDID=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/Flowroute-00000051”, “MASTER CHANNEL: 1575588144.81 = 1575588144.81”) in new stack

The output from grep C-00000048 full* is 500 lines.

f1systems · December 6, 2019, 12:00am

/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [13034793242@from-pstn:1] NoOp(“PJSIP/Flowroute-00000051”, “Catch-All DID Match - Found 13034793242 - You probably want a DID for this.”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [13034793242@from-pstn:2] Set(“PJSIP/Flowroute-00000051”, “__FROM_DID=13034793242”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [13034793242@from-pstn:3] Goto(“PJSIP/Flowroute-00000051”, “ext-did,s,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-did,s,1)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:1] Set(“PJSIP/Flowroute-00000051”, “__DIRECTION=INBOUND”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:2] Gosub(“PJSIP/Flowroute-00000051”, “sub-record-check,s,1(in,s,dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/Flowroute-00000051”, “0?initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/Flowroute-00000051”, “__REC_STATUS=INITIALIZED”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/Flowroute-00000051”, “NOW=1575588144”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/Flowroute-00000051”, “__DAY=05”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/Flowroute-00000051”, “__MONTH=12”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/Flowroute-00000051”, “__YEAR=2019”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/Flowroute-00000051”, “__TIMESTR=20191205-162224”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/Flowroute-00000051”, “__FROMEXTEN=unknown”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/Flowroute-00000051”, “__MON_FMT=wav”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/Flowroute-00000051”, “Recordings initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ARG3=dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/Flowroute-00000051”, “REC_POLICY_MODE_SAVE=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(REC_STATUS=NO)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/Flowroute-00000051”, “2?checkaction”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/Flowroute-00000051”, “1?sub-record-check,in,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,in,1)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [in@sub-record-check:1] NoOp(“PJSIP/Flowroute-00000051”, “Inbound Recording Check to s”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [in@sub-record-check:2] Set(“PJSIP/Flowroute-00000051”, “FROMEXTEN=unknown”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [in@sub-record-check:3] ExecIf(“PJSIP/Flowroute-00000051”, “12?Set(FROMEXTEN=+13034640033)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [in@sub-record-check:4] Gosub(“PJSIP/Flowroute-00000051”, “recordcheck,1(dontcare,in,s)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/Flowroute-00000051”, “Starting recording check against dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/Flowroute-00000051”, “dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [in@sub-record-check:5] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:3] Set(“PJSIP/Flowroute-00000051”, “CHANNEL(tonezone)=us”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:4] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(__FROM_DID=s)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:5] Set(“PJSIP/Flowroute-00000051”, “returnhere=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:6] Gosub(“PJSIP/Flowroute-00000051”, “app-blacklist-check,s,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@app-blacklist-check:1] GotoIf(“PJSIP/Flowroute-00000051”, “0?blacklisted”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@app-blacklist-check:2] Set(“PJSIP/Flowroute-00000051”, “CALLED_BLACKLIST=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@app-blacklist-check:3] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:7] Set(“PJSIP/Flowroute-00000051”, “CDR(did)=13034793242”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:8] GotoIf(“PJSIP/Flowroute-00000051”, “0?”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:9] ExecIf(“PJSIP/Flowroute-00000051”, “0 ?Set(CALLERID(name)=+13034640033)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:10] Set(“PJSIP/Flowroute-00000051”, “__MOHCLASS=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:11] Set(“PJSIP/Flowroute-00000051”, “__REVERSAL_REJECT=FALSE”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:12] GotoIf(“PJSIP/Flowroute-00000051”, “1?post-reverse-charge”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-did,s,14)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:14] NoOp(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:15] Set(“PJSIP/Flowroute-00000051”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:16] Set(“PJSIP/Flowroute-00000051”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:17] Set(“PJSIP/Flowroute-00000051”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:18] Set(“PJSIP/Flowroute-00000051”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:19] NoOp(“PJSIP/Flowroute-00000051”, “CallerID Entry Point”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:20] Set(“PJSIP/Flowroute-00000051”, “__CRM_DIRECTION=INBOUND”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:21] Set(“PJSIP/Flowroute-00000051”, “__CRM_SOURCE=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:22] Set(“PJSIP/Flowroute-00000051”, “__CRM_LINKEDID=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:23] AGI(“PJSIP/Flowroute-00000051”, “sangomacrm.agi,true”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: <PJSIP/Flowroute-00000051>AGI Script sangomacrm.agi completed, returning 0
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:24] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ext-did:25] Goto(“PJSIP/Flowroute-00000051”, “ext-group,1,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-group,1,1)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:1] GotoIf(“PJSIP/Flowroute-00000051”, “0?cid”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:2] PlayTones(“PJSIP/Flowroute-00000051”, “ring”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:3] Progress(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:4] Macro(“PJSIP/Flowroute-00000051”, “user-callerid,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/Flowroute-00000051”, “0?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(REALCALLERIDNUM=+13034640033)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/Flowroute-00000051”, “0?limit”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/Flowroute-00000051”, “AMPUSERCIDNAME=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/Flowroute-00000051”, “1?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:17] NoOp(“PJSIP/Flowroute-00000051”, “Macro Depth is 1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/Flowroute-00000051”, “1?report2:macroerror”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,19)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/Flowroute-00000051”, “0?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:20] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:21] Set(“PJSIP/Flowroute-00000051”, “__TTL=64”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:22] GotoIf(“PJSIP/Flowroute-00000051”, “1?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,38)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/Flowroute-00000051”, “CALLERID(number)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:39] Set(“PJSIP/Flowroute-00000051”, “CALLERID(name)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:40] GotoIf(“PJSIP/Flowroute-00000051”, “0?cnum”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/Flowroute-00000051”, “CDR(cnam)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/Flowroute-00000051”, “CDR(cnum)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:43] Set(“PJSIP/Flowroute-00000051”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:5] Macro(“PJSIP/Flowroute-00000051”, “blkvm-setifempty,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf(“PJSIP/Flowroute-00000051”, “1?init”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set(“PJSIP/Flowroute-00000051”, “__BLKVM_CHANNEL=PJSIP/Flowroute-00000051”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set(“PJSIP/Flowroute-00000051”, “SHARED(BLKVM,PJSIP/Flowroute-00000051)=TRUE”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set(“PJSIP/Flowroute-00000051”, “GOSUB_RETVAL=TRUE”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:6] GotoIf(“PJSIP/Flowroute-00000051”, “1?skipov”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-group,1,9)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:9] Set(“PJSIP/Flowroute-00000051”, “RRNODEST=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:10] Set(“PJSIP/Flowroute-00000051”, “__NODEST=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:11] GosubIf(“PJSIP/Flowroute-00000051”, “0?sub-rgsetcid,s,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:12] Gosub(“PJSIP/Flowroute-00000051”, “sub-record-check,s,1(rg,1,dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/Flowroute-00000051”, “12?initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,s,10)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/Flowroute-00000051”, “Recordings initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ARG3=dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/Flowroute-00000051”, “REC_POLICY_MODE_SAVE=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(REC_STATUS=NO)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/Flowroute-00000051”, “2?checkaction”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/Flowroute-00000051”, “0?sub-record-check,rg,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:18] NoOp(“PJSIP/Flowroute-00000051”, “Generic rg Recording Check - +13034640033 1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:19] Gosub(“PJSIP/Flowroute-00000051”, “recordcheck,1(dontcare,rg,1)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/Flowroute-00000051”, “Starting recording check against dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/Flowroute-00000051”, “dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/Flowroute-00000051”, “”) in new stack

f1systems · December 6, 2019, 12:01am

/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:20] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:13] Set(“PJSIP/Flowroute-00000051”, “RingGroupMethod=ringall”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:14] Set(“PJSIP/Flowroute-00000051”, “__ALT_CONFIRM_MSG=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:15] GotoIf(“PJSIP/Flowroute-00000051”, “0?RGVQANNOUNCE:NORGVQANNOUNCE”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-group,1,18)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:18] Macro(“PJSIP/Flowroute-00000051”, “dial,60,HhTtr,204-704”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:1] NoOp(“PJSIP/Flowroute-00000051”, "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:2] Set(“PJSIP/Flowroute-00000051”, “__CRM_SOURCE=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:3] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ALERT_INFO=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:4] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ALERT_INFO=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:5] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ALERT_INFO=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:6] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(CHANNEL(musicclass)=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:7] AGI(“PJSIP/Flowroute-00000051”, “dialparties.agi”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Starting New Dialparties.agi
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Caller ID name is ‘F1 SYSTEMS’ number is ‘+13034640033’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CW Ignore is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CF Ignore is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Added extension 204 to extension map
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Added extension 704 to extension map
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 204 cf is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 704 cf is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 204 do not disturb is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 704 do not disturb is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/204
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: dbset CALLTRACE/204 to +13034640033
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/704
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: dbset CALLTRACE/704 to +13034640033
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Filtered ARG3: 204-704
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Setting default NOANSWER DIALSTATUS since no extensions available
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOL_MODE ‘’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOL is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOLPARENT is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: <PJSIP/Flowroute-00000051>AGI Script dialparties.agi completed, returning 0
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:8] NoOp(“PJSIP/Flowroute-00000051”, “Returned from dialparties with no extensions to call and DIALSTATUS: NOANSWER”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:9] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:19] Gosub(“PJSIP/Flowroute-00000051”, “sub-record-cancel,s,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-cancel:1] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:20] Set(“PJSIP/Flowroute-00000051”, “RingGroupMethod=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:21] GotoIf(“PJSIP/Flowroute-00000051”, “0?nodest”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:22] Set(“PJSIP/Flowroute-00000051”, “__NODEST=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:23] Macro(“PJSIP/Flowroute-00000051”, “blkvm-clr,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:1] Set(“PJSIP/Flowroute-00000051”, “SHARED(BLKVM,PJSIP/Flowroute-00000051)=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:2] Set(“PJSIP/Flowroute-00000051”, “GOSUB_RETVAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:24] Goto(“PJSIP/Flowroute-00000051”, “ivr-2,s,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ivr-2,s,1)
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:1] Set(“PJSIP/Flowroute-00000051”, “TIMEOUT_LOOPCOUNT=0”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:2] Set(“PJSIP/Flowroute-00000051”, “INVALID_LOOPCOUNT=0”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:3] Set(“PJSIP/Flowroute-00000051”, “_IVR_CONTEXT_ivr-2=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:4] Set(“PJSIP/Flowroute-00000051”, “_IVR_CONTEXT=ivr-2”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:5] Set(“PJSIP/Flowroute-00000051”, “__IVR_RETVM=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:6] GotoIf(“PJSIP/Flowroute-00000051”, “0?skip”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:7] Answer(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:25] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:8] Set(“PJSIP/Flowroute-00000051”, “IVR_MSG=custom/greeting”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:25] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:9] Set(“PJSIP/Flowroute-00000051”, “TIMEOUT(digit)=3”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:25] VERBOSE[11915][C-00000048] func_timeout.c: Digit timeout set to 3.000
/var/log/asterisk/full:[2019-12-05 16:22:25] VERBOSE[11915][C-00000048] pbx.c: Executing [s@ivr-2:10] ExecIf(“PJSIP/Flowroute-00000051”, “1?Background(custom/greeting)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:25] VERBOSE[11915][C-00000048] file.c: <PJSIP/Flowroute-00000051> Playing ‘custom/greeting.slin’ (language ‘en’)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ivr-2:1] GotoIf(“PJSIP/Flowroute-00000051”, “0?i,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ivr-2:2] Macro(“PJSIP/Flowroute-00000051”, “blkvm-clr,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:1] Set(“PJSIP/Flowroute-00000051”, “SHARED(BLKVM,PJSIP/Flowroute-00000051)=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:2] Set(“PJSIP/Flowroute-00000051”, “GOSUB_RETVAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ivr-2:3] Set(“PJSIP/Flowroute-00000051”, “__NODEST=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ivr-2:4] Goto(“PJSIP/Flowroute-00000051”, “from-did-direct,201,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (from-did-direct,201,1)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@from-did-direct:1] GotoIf(“PJSIP/Flowroute-00000051”, “1?ext-local,201,1:followme-check,201,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (ext-local,201,1)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ext-local:1] Set(“PJSIP/Flowroute-00000051”, “__RINGTIMER=15”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [201@ext-local:2] Macro(“PJSIP/Flowroute-00000051”, “exten-vm,201,201,0,0,0”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:1] Macro(“PJSIP/Flowroute-00000051”, “user-callerid,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/Flowroute-00000051”, “0?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(REALCALLERIDNUM=+13034640033)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/Flowroute-00000051”, “0?limit”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/Flowroute-00000051”, “AMPUSERCIDNAME=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/Flowroute-00000051”, “1?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:17] NoOp(“PJSIP/Flowroute-00000051”, “Macro Depth is 2”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/Flowroute-00000051”, “1?report2:macroerror”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,19)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/Flowroute-00000051”, “0?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:20] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:21] Set(“PJSIP/Flowroute-00000051”, “__TTL=63”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:22] GotoIf(“PJSIP/Flowroute-00000051”, “1?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,38)

f1systems · December 6, 2019, 12:02am

/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-dial-one,s,25)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:25] GotoIf(“PJSIP/Flowroute-00000051”, “0?next3:continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-dial-one,s,27)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:27] GotoIf(“PJSIP/Flowroute-00000051”, “0?nodial”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:28] GosubIf(“PJSIP/Flowroute-00000051”, “1?dstring,1():dlocal,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:1] Set(“PJSIP/Flowroute-00000051”, “DSTRING=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:2] Set(“PJSIP/Flowroute-00000051”, “DEVICES=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf(“PJSIP/Flowroute-00000051”, “0?Return()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(DEVICES=01)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:5] Set(“PJSIP/Flowroute-00000051”, “LOOPCNT=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:6] Set(“PJSIP/Flowroute-00000051”, “ITER=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:7] Set(“PJSIP/Flowroute-00000051”, “THISDIAL=PJSIP/201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf(“PJSIP/Flowroute-00000051”, “1?zap2dahdi,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf(“PJSIP/Flowroute-00000051”, “0?Return()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set(“PJSIP/Flowroute-00000051”, “NEWDIAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set(“PJSIP/Flowroute-00000051”, “LOOPCNT2=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set(“PJSIP/Flowroute-00000051”, “ITER2=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set(“PJSIP/Flowroute-00000051”, “THISPART2=PJSIP/201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(THISPART2=DAHDIIP/201)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set(“PJSIP/Flowroute-00000051”, “NEWDIAL=PJSIP/201&”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set(“PJSIP/Flowroute-00000051”, “ITER2=2”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf(“PJSIP/Flowroute-00000051”, “0?begin2”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set(“PJSIP/Flowroute-00000051”, “THISDIAL=PJSIP/201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf(“PJSIP/Flowroute-00000051”, “0?docheck”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:10] NoOp(“PJSIP/Flowroute-00000051”, “Debug: Found PJSIP Destination PJSIP/201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf(“PJSIP/Flowroute-00000051”, “0?doset”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:12] NoOp(“PJSIP/Flowroute-00000051”, “Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:13] Set(“PJSIP/Flowroute-00000051”, “THISDIAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:14] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(DIALSTATUS=CHANUNAVAIL)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf(“PJSIP/Flowroute-00000051”, “1?skipset”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-dial-one,dstring,17)

f1systems · December 6, 2019, 12:03am

/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/Flowroute-00000051”, “CALLERID(number)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:39] Set(“PJSIP/Flowroute-00000051”, “CALLERID(name)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:40] GotoIf(“PJSIP/Flowroute-00000051”, “0?cnum”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/Flowroute-00000051”, “CDR(cnam)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/Flowroute-00000051”, “CDR(cnum)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:43] Set(“PJSIP/Flowroute-00000051”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:2] Set(“PJSIP/Flowroute-00000051”, “RingGroupMethod=none”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:3] Set(“PJSIP/Flowroute-00000051”, “__EXTTOCALL=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:4] Set(“PJSIP/Flowroute-00000051”, “__PICKUPMARK=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:5] Set(“PJSIP/Flowroute-00000051”, “RT=15”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:6] ExecIf(“PJSIP/Flowroute-00000051”, “0?Macro(vm,201,DIRECTDIAL,)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:7] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:8] ExecIf(“PJSIP/Flowroute-00000051”, “0?Gosub(ext-intercom,*80201,1())”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:9] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:10] ExecIf(“PJSIP/Flowroute-00000051”, “0?ChanSpy(PJSIP/201,q)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:11] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] WARNING[11915][C-00000048] chan_sip.c: This function can only be used on SIP channels.
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:12] ExecIf(“PJSIP/Flowroute-00000051”, “0?Macro(vm,201,DIRECTDIAL,)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:13] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:14] ExecIf(“PJSIP/Flowroute-00000051”, “0?Gosub(ext-intercom,*80201,1())”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:15] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:16] ExecIf(“PJSIP/Flowroute-00000051”, “0?ChanSpy(PJSIP/201,q)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:17] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:18] Gosub(“PJSIP/Flowroute-00000051”, “sub-record-check,s,1(exten,201,dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/Flowroute-00000051”, “12?initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,s,10)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/Flowroute-00000051”, “Recordings initialized”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(ARG3=dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/Flowroute-00000051”, “REC_POLICY_MODE_SAVE=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(REC_STATUS=NO)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/Flowroute-00000051”, “5?checkaction”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/Flowroute-00000051”, “1?sub-record-check,exten,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,exten,1)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:1] NoOp(“PJSIP/Flowroute-00000051”, “Exten Recording Check between +13034640033 and 201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:2] Set(“PJSIP/Flowroute-00000051”, “CALLTYPE=external”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:3] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(CALLTYPE=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:4] Set(“PJSIP/Flowroute-00000051”, “CALLEE=dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:5] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(CALLEE=dontcare)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:6] GotoIf(“PJSIP/Flowroute-00000051”, “1?callee”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,exten,11)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:11] Gosub(“PJSIP/Flowroute-00000051”, “recordcheck,1(dontcare,external,201)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/Flowroute-00000051”, “Starting recording check against dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/Flowroute-00000051”, “dontcare”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [exten@sub-record-check:12] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:19] GotoIf(“PJSIP/Flowroute-00000051”, “1?macrodial”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-exten-vm,s,25)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:25] GosubIf(“PJSIP/Flowroute-00000051”, “0?clrheader,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:26] Macro(“PJSIP/Flowroute-00000051”, “dial-one,15,HhTtr,201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:1] Set(“PJSIP/Flowroute-00000051”, “DEXTEN=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:2] Set(“PJSIP/Flowroute-00000051”, “__CRM_SOURCE=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:3] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(__EXTTOCALL=201)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:4] Set(“PJSIP/Flowroute-00000051”, “DIALSTATUS_CW=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:5] GosubIf(“PJSIP/Flowroute-00000051”, “0?screen,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:6] GosubIf(“PJSIP/Flowroute-00000051”, “0?cf,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:7] GotoIf(“PJSIP/Flowroute-00000051”, “1?skip1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-dial-one,s,10)

f1systems · December 6, 2019, 12:03am

/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:10] GotoIf(“PJSIP/Flowroute-00000051”, “0?nodial”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:11] GotoIf(“PJSIP/Flowroute-00000051”, “0?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:12] Set(“PJSIP/Flowroute-00000051”, “EXTHASCW=ENABLED”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:13] GotoIf(“PJSIP/Flowroute-00000051”, “0?next1:cwinusebusy”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:17] Set(“PJSIP/Flowroute-00000051”, “ITER=2”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:18] GotoIf(“PJSIP/Flowroute-00000051”, “0?begin”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [dstring@macro-dial-one:19] ExecIf(“PJSIP/Flowroute-00000051”, “1?Return()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:29] GotoIf(“PJSIP/Flowroute-00000051”, “1?nodial”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-dial-one,s,60)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:60] NoOp(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:61] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(DIALSTATUS=NOANSWER)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:62] NoOp(“PJSIP/Flowroute-00000051”, “Returned from dial-one with nothing to call and DIALSTATUS: CHANUNAVAIL”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial-one:63] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:27] Set(“PJSIP/Flowroute-00000051”, “SV_DIALSTATUS=CHANUNAVAIL”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:28] GosubIf(“PJSIP/Flowroute-00000051”, “0?docfu,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:29] GosubIf(“PJSIP/Flowroute-00000051”, “0?docfb,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:30] Set(“PJSIP/Flowroute-00000051”, “DIALSTATUS=CHANUNAVAIL”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:31] ExecIf(“PJSIP/Flowroute-00000051”, “0?MacroExit()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:32] GotoIf(“PJSIP/Flowroute-00000051”, “0?s-CHANUNAVAIL,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-exten-vm:33] Macro(“PJSIP/Flowroute-00000051”, “vm,201,CHANUNAVAIL,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-vm:1] Macro(“PJSIP/Flowroute-00000051”, “user-callerid,SKIPTTL”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/Flowroute-00000051”, “TOUCH_MONITOR=1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/Flowroute-00000051”, “0?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(REALCALLERIDNUM=+13034640033)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/Flowroute-00000051”, “AMPUSER=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/Flowroute-00000051”, “0?limit”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/Flowroute-00000051”, “AMPUSERCIDNAME=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/Flowroute-00000051”, “1?report”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,17)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:17] NoOp(“PJSIP/Flowroute-00000051”, “Macro Depth is 3”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/Flowroute-00000051”, “1?report2:macroerror”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,19)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/Flowroute-00000051”, “1?continue”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-user-callerid,s,38)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/Flowroute-00000051”, “CALLERID(number)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:39] Set(“PJSIP/Flowroute-00000051”, “CALLERID(name)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:40] GotoIf(“PJSIP/Flowroute-00000051”, “0?cnum”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/Flowroute-00000051”, “CDR(cnam)=F1 SYSTEMS”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/Flowroute-00000051”, “CDR(cnum)=+13034640033”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-user-callerid:43] Set(“PJSIP/Flowroute-00000051”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-vm:2] Set(“PJSIP/Flowroute-00000051”, “VMGAIN=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-vm:3] Macro(“PJSIP/Flowroute-00000051”, “blkvm-check,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-check:1] Set(“PJSIP/Flowroute-00000051”, “GOSUB_RETVAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-check:3] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-vm:4] GotoIf(“PJSIP/Flowroute-00000051”, “1?vmx,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-vm,vmx,1)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:1] Set(“PJSIP/Flowroute-00000051”, “__EXTTOCALL=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:2] Set(“PJSIP/Flowroute-00000051”, “__CRM_VOICEMAIL=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:3] Set(“PJSIP/Flowroute-00000051”, “MEXTEN=201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:4] Set(“PJSIP/Flowroute-00000051”, “MMODE=CHANUNAVAIL”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:5] Set(“PJSIP/Flowroute-00000051”, “RETVM=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:6] Set(“PJSIP/Flowroute-00000051”, “MODE=unavail”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:7] Macro(“PJSIP/Flowroute-00000051”, “get-vmcontext,201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:1] Set(“PJSIP/Flowroute-00000051”, “VMCONTEXT=default”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf(“PJSIP/Flowroute-00000051”, “0?200:300”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:8] Set(“PJSIP/Flowroute-00000051”, “MODE=unavail”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:9] NoOp(“PJSIP/Flowroute-00000051”, “MODE IS: unavail”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:10] GotoIf(“PJSIP/Flowroute-00000051”, “1?chknomsg”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-vm,vmx,12)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:12] GotoIf(“PJSIP/Flowroute-00000051”, “0?s-CHANUNAVAIL,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:13] GotoIf(“PJSIP/Flowroute-00000051”, “1?notdirect”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-vm,vmx,15)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:15] NoOp(“PJSIP/Flowroute-00000051”, “Checking if ext 201 is enabled: blocked”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [vmx@macro-vm:16] GotoIf(“PJSIP/Flowroute-00000051”, “1?s-CHANUNAVAIL,1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-vm,s-CHANUNAVAIL,1)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s-CHANUNAVAIL@macro-vm:1] Macro(“PJSIP/Flowroute-00000051”, “get-vmcontext,201”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:1] Set(“PJSIP/Flowroute-00000051”, “VMCONTEXT=default”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf(“PJSIP/Flowroute-00000051”, “0?200:300”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] pbx.c: Executing [s-CHANUNAVAIL@macro-vm:2] VoiceMail(“PJSIP/Flowroute-00000051”, “201@default,u”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:37] VERBOSE[11915][C-00000048] file.c: <PJSIP/Flowroute-00000051> Playing ‘/var/spool/asterisk/voicemail/default/201/unavail.slin’ (language ‘en’)
/var/log/asterisk/full:[2019-12-05 16:22:40] VERBOSE[11915][C-00000048] file.c: <PJSIP/Flowroute-00000051> Playing ‘vm-intro.ulaw’ (language ‘en’)
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_macro.c: Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘PJSIP/Flowroute-00000051’ in macro ‘vm’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_macro.c: Spawn extension (macro-exten-vm, s, 33) exited non-zero on ‘PJSIP/Flowroute-00000051’ in macro ‘exten-vm’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Spawn extension (ext-local, 201, 2) exited non-zero on ‘PJSIP/Flowroute-00000051’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [h@ext-local:1] Macro(“PJSIP/Flowroute-00000051”, “hangupcall,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“PJSIP/Flowroute-00000051”, “1?theend”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-hangupcall,s,3)
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“PJSIP/Flowroute-00000051”, “0?Set(CDR(recordingfile)=)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-hangupcall:4] NoOp(“PJSIP/Flowroute-00000051”, " montior file= ") in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-hangupcall:5] GotoIf(“PJSIP/Flowroute-00000051”, “1?skipagi”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx_builtins.c: Goto (macro-hangupcall,s,7)
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-hangupcall:7] Hangup(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/Flowroute-00000051’ in macro ‘hangupcall’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on ‘PJSIP/Flowroute-00000051’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_stack.c: PJSIP/Flowroute-00000051 Internal Gosub(crm-hangup,s,1) start
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:1] NoOp(“PJSIP/Flowroute-00000051”, “Sending Hangup to CRM”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:2] NoOp(“PJSIP/Flowroute-00000051”, “HANGUP CAUSE: 16”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:3] ExecIf(“PJSIP/Flowroute-00000051”, “1?Set(__CRM_VOICEMAIL=FAILED)”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/Flowroute-00000051”, “MASTER CHANNEL: 1575588144.81 = 1575588144.81”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:5] GotoIf(“PJSIP/Flowroute-00000051”, “0?return”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:6] Set(“PJSIP/Flowroute-00000051”, “__CRM_HANGUP=1”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:7] AGI(“PJSIP/Flowroute-00000051”, “sangomacrm.agi”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] res_agi.c: <PJSIP/Flowroute-00000051>AGI Script sangomacrm.agi completed, returning 0
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] pbx.c: Executing [s@crm-hangup:8] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_stack.c: Spawn extension (ext-local, h, 1) exited non-zero on ‘PJSIP/Flowroute-00000051’
/var/log/asterisk/full:[2019-12-05 16:22:42] VERBOSE[11915][C-00000048] app_stack.c: PJSIP/Flowroute-00000051 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
/var/log/asterisk/full-20191204:[2019-12-03 13:31:07] VERBOSE[12237][C-00000048] pbx.c: Executing [dorecord@systemrecording-gui:1] Record(“Local/717@from-internal-00000002;1”, “/var/spool/asterisk/tmp/7171575405066808.wav,k”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:31:07] VERBOSE[12237][C-00000048] file.c: <Local/717@from-internal-00000002;1> Playing ‘beep.slin16’ (language ‘en’)
/var/log/asterisk/full-20191204:[2019-12-03 13:31:10] VERBOSE[12237][C-00000048] pbx.c: Spawn extension (systemrecording-gui, dorecord, 1) exited non-zero on ‘Local/717@from-internal-00000002;1’
/var/log/asterisk/full-20191204:[2019-12-03 13:31:10] VERBOSE[12237][C-00000048] pbx.c: Executing [h@systemrecording-gui:1] System(“Local/717@from-internal-00000002;1”, “touch /var/spool/asterisk/tmp/7171575405066808.finished”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:31:10] VERBOSE[12237][C-00000048] pbx.c: Executing [h@systemrecording-gui:2] Hangup(“Local/717@from-internal-00000002;1”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:31:10] VERBOSE[12237][C-00000048] pbx.c: Spawn extension (systemrecording-gui, h, 2) exited non-zero on ‘Local/717@from-internal-00000002;1’
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [9011441923937029@from-sip-external:1] NoOp(“PJSIP/anonymous-0000004a”, “Received incoming SIP connection from unknown peer to 9011441923937029”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [9011441923937029@from-sip-external:2] Set(“PJSIP/anonymous-0000004a”, “DID=9011441923937029”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [9011441923937029@from-sip-external:3] Goto(“PJSIP/anonymous-0000004a”, “s,1”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,1)
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:1] GotoIf(“PJSIP/anonymous-0000004a”, “1?setlanguage:checkanon”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,2)
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:2] Set(“PJSIP/anonymous-0000004a”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:3] GotoIf(“PJSIP/anonymous-0000004a”, “1?noanonymous”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,5)
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:5] Set(“PJSIP/anonymous-0000004a”, “TIMEOUT(absolute)=15”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] func_timeout.c: Channel will hangup at 2019-12-03 13:58:49.132 MST.
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:6] Set(“PJSIP/anonymous-0000004a”, “receveip=pjsip,remote_addr”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:7] Log(“PJSIP/anonymous-0000004a”, "WARNING,“Rejecting unknown SIP connection from 45.143.220.102:62518"”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] WARNING[3839][C-00000048] Ext. s: “Rejecting unknown SIP connection from 45.143.220.102:62518”
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:8] Answer(“PJSIP/anonymous-0000004a”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:34] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:9] Wait(“PJSIP/anonymous-0000004a”, “2”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:36] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:10] Playback(“PJSIP/anonymous-0000004a”, “ss-noservice”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:36] VERBOSE[3839][C-00000048] file.c: <PJSIP/anonymous-0000004a> Playing ‘ss-noservice.ulaw’ (language ‘en’)
/var/log/asterisk/full-20191204:[2019-12-03 13:58:41] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:11] PlayTones(“PJSIP/anonymous-0000004a”, “congestion”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:41] VERBOSE[3839][C-00000048] pbx.c: Executing [s@from-sip-external:12] Congestion(“PJSIP/anonymous-0000004a”, “5”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:46] VERBOSE[3839][C-00000048] pbx.c: Spawn extension (from-sip-external, s, 12) exited non-zero on ‘PJSIP/anonymous-0000004a’
/var/log/asterisk/full-20191204:[2019-12-03 13:58:46] VERBOSE[3839][C-00000048] pbx.c: Executing [h@from-sip-external:1] Hangup(“PJSIP/anonymous-0000004a”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 13:58:46] VERBOSE[3839][C-00000048] pbx.c: Spawn extension (from-sip-external, h, 1) exited non-zero on ‘PJSIP/anonymous-0000004a’
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [1011442868065001@from-sip-external:1] NoOp(“PJSIP/anonymous-0000004c”, “Received incoming SIP connection from unknown peer to 1011442868065001”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [1011442868065001@from-sip-external:2] Set(“PJSIP/anonymous-0000004c”, “DID=1011442868065001”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [1011442868065001@from-sip-external:3] Goto(“PJSIP/anonymous-0000004c”, “s,1”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,1)
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:1] GotoIf(“PJSIP/anonymous-0000004c”, “1?setlanguage:checkanon”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,2)
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:2] Set(“PJSIP/anonymous-0000004c”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:3] GotoIf(“PJSIP/anonymous-0000004c”, “1?noanonymous”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,5)
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:5] Set(“PJSIP/anonymous-0000004c”, “TIMEOUT(absolute)=15”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] func_timeout.c: Channel will hangup at 2019-12-03 14:41:41.788 MST.
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:6] Set(“PJSIP/anonymous-0000004c”, “receveip=pjsip,remote_addr”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:7] Log(“PJSIP/anonymous-0000004c”, "WARNING,“Rejecting unknown SIP connection from 45.143.220.102:50812"”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] WARNING[20014][C-00000048] Ext. s: “Rejecting unknown SIP connection from 45.143.220.102:50812”
/var/log/asterisk/full-20191204:[2019-12-03 14:41:26] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:8] Answer(“PJSIP/anonymous-0000004c”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:27] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:9] Wait(“PJSIP/anonymous-0000004c”, “2”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:29] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:10] Playback(“PJSIP/anonymous-0000004c”, “ss-noservice”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:29] VERBOSE[20014][C-00000048] file.c: <PJSIP/anonymous-0000004c> Playing ‘ss-noservice.ulaw’ (language ‘en’)
/var/log/asterisk/full-20191204:[2019-12-03 14:41:34] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:11] PlayTones(“PJSIP/anonymous-0000004c”, “congestion”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:34] VERBOSE[20014][C-00000048] pbx.c: Executing [s@from-sip-external:12] Congestion(“PJSIP/anonymous-0000004c”, “5”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:39] VERBOSE[20014][C-00000048] pbx.c: Spawn extension (from-sip-external, s, 12) exited non-zero on ‘PJSIP/anonymous-0000004c’
/var/log/asterisk/full-20191204:[2019-12-03 14:41:39] VERBOSE[20014][C-00000048] pbx.c: Executing [h@from-sip-external:1] Hangup(“PJSIP/anonymous-0000004c”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:41:39] VERBOSE[20014][C-00000048] pbx.c: Spawn extension (from-sip-external, h, 1) exited non-zero on ‘PJSIP/anonymous-0000004c’
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [011441902933948@from-sip-external:1] NoOp(“PJSIP/anonymous-00000048”, “Received incoming SIP connection from unknown peer to 011441902933948”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [011441902933948@from-sip-external:2] Set(“PJSIP/anonymous-00000048”, “DID=011441902933948”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [011441902933948@from-sip-external:3] Goto(“PJSIP/anonymous-00000048”, “s,1”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,1)
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:1] GotoIf(“PJSIP/anonymous-00000048”, “1?setlanguage:checkanon”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,2)
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:2] Set(“PJSIP/anonymous-00000048”, “CHANNEL(language)=en”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:3] GotoIf(“PJSIP/anonymous-00000048”, “1?noanonymous”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx_builtins.c: Goto (from-sip-external,s,5)
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:5] Set(“PJSIP/anonymous-00000048”, “TIMEOUT(absolute)=15”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] func_timeout.c: Channel will hangup at 2019-12-03 14:52:45.849 MST.
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:6] Set(“PJSIP/anonymous-00000048”, “receveip=pjsip,remote_addr”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:7] Log(“PJSIP/anonymous-00000048”, "WARNING,“Rejecting unknown SIP connection from 45.143.220.102:59089"”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] WARNING[4217][C-00000048] Ext. s: “Rejecting unknown SIP connection from 45.143.220.102:59089”
/var/log/asterisk/full-20191204:[2019-12-03 14:52:30] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:8] Answer(“PJSIP/anonymous-00000048”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:31] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:9] Wait(“PJSIP/anonymous-00000048”, “2”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:33] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:10] Playback(“PJSIP/anonymous-00000048”, “ss-noservice”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:33] VERBOSE[4217][C-00000048] file.c: <PJSIP/anonymous-00000048> Playing ‘ss-noservice.ulaw’ (language ‘en’)
/var/log/asterisk/full-20191204:[2019-12-03 14:52:38] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:11] PlayTones(“PJSIP/anonymous-00000048”, “congestion”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:38] VERBOSE[4217][C-00000048] pbx.c: Executing [s@from-sip-external:12] Congestion(“PJSIP/anonymous-00000048”, “5”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:43] VERBOSE[4217][C-00000048] pbx.c: Spawn extension (from-sip-external, s, 12) exited non-zero on ‘PJSIP/anonymous-00000048’
/var/log/asterisk/full-20191204:[2019-12-03 14:52:43] VERBOSE[4217][C-00000048] pbx.c: Executing [h@from-sip-external:1] Hangup(“PJSIP/anonymous-00000048”, “”) in new stack
/var/log/asterisk/full-20191204:[2019-12-03 14:52:43] VERBOSE[4217][C-00000048] pbx.c: Spawn extension (from-sip-external, h, 1) exited non-zero on ‘PJSIP/anonymous-00000048’

f1systems · December 6, 2019, 12:14am

I think this might be what I am looking for. It seems to say that no extensions were available so the Ring Group failed. Why is the question.

/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Starting New Dialparties.agi
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Caller ID name is ‘F1 SYSTEMS’ number is ‘+13034640033’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CW Ignore is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CF Ignore is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Added extension 204 to extension map
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Added extension 704 to extension map
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 204 cf is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 704 cf is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 204 do not disturb is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Extension 704 do not disturb is disabled
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/204
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: dbset CALLTRACE/204 to +13034640033
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/704
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: dbset CALLTRACE/704 to +13034640033
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Filtered ARG3: 204-704
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: Setting default NOANSWER DIALSTATUS since no extensions available
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOL_MODE ‘’
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOL is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: dialparties.agi: RVOLPARENT is:
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] res_agi.c: <PJSIP/Flowroute-00000051>AGI Script dialparties.agi completed, returning 0
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:8] NoOp(“PJSIP/Flowroute-00000051”, “Returned from dialparties with no extensions to call and DIALSTATUS: NOANSWER”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-dial:9] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:19] Gosub(“PJSIP/Flowroute-00000051”, “sub-record-cancel,s,1()”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@sub-record-cancel:1] Return(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:20] Set(“PJSIP/Flowroute-00000051”, “RingGroupMethod=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:21] GotoIf(“PJSIP/Flowroute-00000051”, “0?nodest”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:22] Set(“PJSIP/Flowroute-00000051”, “__NODEST=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:23] Macro(“PJSIP/Flowroute-00000051”, “blkvm-clr,”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:1] Set(“PJSIP/Flowroute-00000051”, “SHARED(BLKVM,PJSIP/Flowroute-00000051)=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:2] Set(“PJSIP/Flowroute-00000051”, “GOSUB_RETVAL=”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit(“PJSIP/Flowroute-00000051”, “”) in new stack
/var/log/asterisk/full:[2019-12-05 16:22:24] VERBOSE[11915][C-00000048] pbx.c: Executing [1@ext-group:24] Goto(“PJSIP/Flowroute-00000051”, “ivr-2,s,1”) in new stack

f1systems · December 6, 2019, 12:16am

Thank you. I guess I meant what am I looking for in the log.

arielgrin · December 6, 2019, 12:51am

You should be looking at the start of the call to the ring group and see how it goes from there. You can do a tail -f and try a call to the ring group, or start the Asterisk console with a high verbose level.

f1systems · December 12, 2019, 10:20pm

Rebooting after changing a Ring Group solves the issue.

Don’t know why this is happening but it is reproducible on this system. If any change is made to a Ring Group, none of the Ring Groups will ring until the system is rebooted. Log shows that the extensions are unavailable.Once rebooted, the Ring Groups work normally.

Not a very satisfying answer but I can live with it.

arielgrin · December 12, 2019, 10:48pm

I would say that the issue is not with the ring group per se, but the extensions being unavailable. If it happens again, do a sip show peers if using chan_sip before rebooting the server. If the extensions appear as unavailable, you need to find out why is that happening.

f1systems · December 12, 2019, 11:29pm

The extensions are provisioned and can call out while in the state of the Ring Group not ringing. That is, we can see that the phones don’t ring and can immediately dial an outside number or an extension and they ring normally.

arielgrin · December 12, 2019, 11:49pm

Are the extension the same local network with the server or are they remote or the server is hosted in the cloud?

f1systems · December 12, 2019, 11:52pm

They are all on the sane local network as the PBX. As I said, rebooting after a change works, without the reboot the log for the incoming call shows the extensions unavailable. That is if I am reading things right.

arielgrin · December 13, 2019, 12:23am

Phones being unavailable to receive calls but becoming available immediately after making an outbound call sound a lo like NAT issue/misconfiguration, that is why I asked if they were remote.