Line stays open

Asterisk Asterisk Support
1

When we have callers call in we have a delay set to 3 rings, if no one gets to it in those 3 rings then it goes to the IVR.
The issue is if the caller hangs up before someone answers or VM picks up (after selecting the right dept in the IVR) then it leaves the line/channel in an open state. The IVR is setup as such:
I have an announcement
direct dial is -yes
timeout -11
invalid retries -1
invalid retry recording -default
append announcement - unchecked
return on invalid -unchecked
invalid recording -default
invalid destination - voicemail box 210
timeout retries - 1
timeout retry recording - default
append announcement on timeout -unchecked
timeout recording - default
timeout destination - voicemail box 210

it appears from the asterisk info that the channel are going or have the line open to mailbox 210
I uploaded a screen shot of my extension settings.
Thanks.

screencapture-10-168-1-174-admin-config-php-1478534022902.png1920×5212 397 KB

2

It would help if you post the cli output.

3

Here is the output from the last time i did it.
also when i hang up calling in it still rings two more time.

[2016-11-07 11:23:18] VERBOSE[12696][C-00000002] sig_analog.c: – Starting simple switch on ‘DAHDI/1-1’
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:1] NoOp(“DAHDI/1-1”, "Entering from-dahdi with DID == ") in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:2] Ringing(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:3] Set(“DAHDI/1-1”, “DID=s”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:4] NoOp(“DAHDI/1-1”, “DID is now s”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:5] GotoIf(“DAHDI/1-1”, “1?dahdiok:checkzap”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (from-analog,s,9)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:9] NoOp(“DAHDI/1-1”, “Is a DAHDi Channel”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:10] Set(“DAHDI/1-1”, “CHAN=1-1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:11] Set(“DAHDI/1-1”, “CHAN=1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:12] Macro(“DAHDI/1-1”, “from-dahdi-1,s,1”) in new stack
[2016-11-07 11:23:19] WARNING[12696][C-00000002] app_macro.c: No such context ‘macro-from-dahdi-1’ for macro ‘from-dahdi-1’. Was called by s@from-analog
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:13] NoOp(“DAHDI/1-1”, “Returned from Macro from-dahdi-1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-analog:14] Goto(“DAHDI/1-1”, “from-pstn,s,1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (from-pstn,s,1)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:1] Set(“DAHDI/1-1”, “__DIRECTION=INBOUND”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:2] Gosub(“DAHDI/1-1”, “sub-record-check,s,1(in,s,dontcare)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/1-1”, “0?initialized”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:2] Set(“DAHDI/1-1”, “__REC_STATUS=INITIALIZED”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:3] Set(“DAHDI/1-1”, “NOW=1478539399”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:4] Set(“DAHDI/1-1”, “__DAY=07”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:5] Set(“DAHDI/1-1”, “__MONTH=11”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:6] Set(“DAHDI/1-1”, “__YEAR=2016”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:7] Set(“DAHDI/1-1”, “__TIMESTR=20161107-112319”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:8] Set(“DAHDI/1-1”, “__FROMEXTEN=unknown”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:9] Set(“DAHDI/1-1”, “__MON_FMT=wav”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/1-1”, “Recordings initialized”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/1-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/1-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/1-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/1-1”, “2?checkaction”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/1-1”, “1?sub-record-check,in,1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,in,1)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [in@sub-record-check:1] NoOp(“DAHDI/1-1”, “Inbound Recording Check to s”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [in@sub-record-check:2] Set(“DAHDI/1-1”, “FROMEXTEN=unknown”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [in@sub-record-check:3] ExecIf(“DAHDI/1-1”, “0?Set(FROMEXTEN=)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [in@sub-record-check:4] Gosub(“DAHDI/1-1”, “recordcheck,1(dontcare,in,s)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/1-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/1-1”, “dontcare”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [in@sub-record-check:5] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:3] Gosub(“DAHDI/1-1”, “app-blacklist-check,s,1()”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“DAHDI/1-1”, “0?blacklisted”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@app-blacklist-check:2] Set(“DAHDI/1-1”, “CALLED_BLACKLIST=1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@app-blacklist-check:3] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:4] ExecIf(“DAHDI/1-1”, “1?Set(__FROM_DID=s)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:5] Set(“DAHDI/1-1”, “CDR(did)=s”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:6] ExecIf(“DAHDI/1-1”, “1 ?Set(CALLERID(name)=)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:7] Set(“DAHDI/1-1”, “CHANNEL(musicclass)=default”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:8] Set(“DAHDI/1-1”, “__MOHCLASS=default”) in new stack
[2016-11-07 11:23:19] WARNING[12696][C-00000002] func_channel.c: Unknown or unavailable item requested: ‘reversecharge’
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:9] GotoIf(“DAHDI/1-1”, “0?macro-hangupcall”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:10] Set(“DAHDI/1-1”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:11] Set(“DAHDI/1-1”, “CALLERPRES()=allowed_not_screened”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@from-pstn:12] Goto(“DAHDI/1-1”, “ext-group,603,1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (ext-group,603,1)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:1] Macro(“DAHDI/1-1”, “user-callerid,”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/1-1”, “TOUCH_MONITOR=1478539398.9”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/1-1”, “0?report”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/1-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/1-1”, “0?limit”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/1-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/1-1”, “1?report”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/1-1”, “0?continue”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:17] ExecIf(“DAHDI/1-1”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:18] Set(“DAHDI/1-1”, “__TTL=64”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:19] GotoIf(“DAHDI/1-1”, “1?continue”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/1-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/1-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/1-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/1-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/1-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:2] Macro(“DAHDI/1-1”, “blkvm-setifempty,”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“DAHDI/1-1”, “1?init”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“DAHDI/1-1”, “__BLKVM_CHANNEL=DAHDI/1-1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“DAHDI/1-1”, “SHARED(BLKVM,DAHDI/1-1)=TRUE”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“DAHDI/1-1”, “GOSUB_RETVAL=TRUE”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:3] GotoIf(“DAHDI/1-1”, “1?skipov”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (ext-group,603,6)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:6] Set(“DAHDI/1-1”, “RRNODEST=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:7] Set(“DAHDI/1-1”, “__NODEST=603”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:8] GosubIf(“DAHDI/1-1”, “0?sub-rgsetcid,s,1()”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:9] Gosub(“DAHDI/1-1”, “sub-record-check,s,1(rg,603,dontcare)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/1-1”, “7?initialized”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,s,10)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/1-1”, “Recordings initialized”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/1-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/1-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/1-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/1-1”, “2?checkaction”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/1-1”, “0?sub-record-check,rg,1”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:18] NoOp(“DAHDI/1-1”, “Generic rg Recording Check - unknown 603”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:19] Gosub(“DAHDI/1-1”, “recordcheck,1(dontcare,rg,603)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/1-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/1-1”, “dontcare”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:20] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:10] Set(“DAHDI/1-1”, “RingGroupMethod=ringall”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:11] Macro(“DAHDI/1-1”, “dial,12,Ttr,205-206-204”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:1] GotoIf(“DAHDI/1-1”, “0?dial”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:2] Set(“DAHDI/1-1”, “CHANNEL(musicclass)=default”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:3] AGI(“DAHDI/1-1”, “dialparties.agi”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 205 to extension map
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 206 to extension map
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 204 to extension map
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 205 cf is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 206 cf is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 204 cf is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 205 do not disturb is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 206 do not disturb is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 204 do not disturb is disabled
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: DbDel CALLTRACE/205 - Caller ID is not defined
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: DbDel CALLTRACE/206 - Caller ID is not defined
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: DbDel CALLTRACE/204 - Caller ID is not defined
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Filtered ARG3: 205-206-204
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] res_agi.c: – <DAHDI/1-1>AGI Script dialparties.agi completed, returning 0
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:7] Dial(“DAHDI/1-1”, “SIP/205&SIP/206&SIP/204,12,trM(auto-blkvm)”) in new stack
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/205
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/206
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/204
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – SIP/204-00000009 connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – SIP/206-00000008 connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:19] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-00000007 connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:20] VERBOSE[12696][C-00000002] app_dial.c: – SIP/204-00000009 is ringing
[2016-11-07 11:23:20] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-00000007 is ringing
[2016-11-07 11:23:20] VERBOSE[12696][C-00000002] app_dial.c: – SIP/206-00000008 is ringing
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] app_dial.c: – Nobody picked up in 12000 ms
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:8] Set(“DAHDI/1-1”, “DIALSTATUS=NOANSWER”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:9] GosubIf(“DAHDI/1-1”, “0?NOANSWER,1”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:12] Gosub(“DAHDI/1-1”, “sub-record-cancel,s,1()”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-cancel:1] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:13] Set(“DAHDI/1-1”, “RingGroupMethod=”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:14] GotoIf(“DAHDI/1-1”, “0?nodest”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:15] Set(“DAHDI/1-1”,

4

“__NODEST=”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:16] Macro(“DAHDI/1-1”, “blkvm-clr,”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“DAHDI/1-1”, “SHARED(BLKVM,DAHDI/1-1)=”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“DAHDI/1-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:23:31] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [603@ext-group:17] Goto(“DAHDI/1-1”, “ivr-1,s,1”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Goto (ivr-1,s,1)
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:1] Set(“DAHDI/1-1”, “TIMEOUT_LOOPCOUNT=0”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:2] Set(“DAHDI/1-1”, “INVALID_LOOPCOUNT=0”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:3] Set(“DAHDI/1-1”, “_IVR_CONTEXT_ivr-1=”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:4] Set(“DAHDI/1-1”, “_IVR_CONTEXT=ivr-1”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:5] Set(“DAHDI/1-1”, “__IVR_RETVM=”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:6] GotoIf(“DAHDI/1-1”, “0?skip”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:7] Answer(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:32] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:8] Wait(“DAHDI/1-1”, “1”) in new stack
[2016-11-07 11:23:33] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:9] Set(“DAHDI/1-1”, “IVR_MSG=custom/IVR1”) in new stack
[2016-11-07 11:23:33] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:10] Set(“DAHDI/1-1”, “TIMEOUT(digit)=3”) in new stack
[2016-11-07 11:23:33] VERBOSE[12696][C-00000002] func_timeout.c: – Digit timeout set to 3.000
[2016-11-07 11:23:33] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@ivr-1:11] ExecIf(“DAHDI/1-1”, “1?Background(custom/IVR1)”) in new stack
[2016-11-07 11:23:33] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘custom/IVR1.slin’ (language ‘en’)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [1@ivr-1:1] Goto(“DAHDI/1-1”, “ext-group,600,1”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (ext-group,600,1)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:1] Macro(“DAHDI/1-1”, “user-callerid,”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/1-1”, “TOUCH_MONITOR=1478539398.9”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/1-1”, “0?report”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/1-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/1-1”, “0?limit”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/1-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/1-1”, “1?report”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/1-1”, “0?continue”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:17] ExecIf(“DAHDI/1-1”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:18] Set(“DAHDI/1-1”, “__TTL=63”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:19] GotoIf(“DAHDI/1-1”, “1?continue”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/1-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/1-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/1-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/1-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/1-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:2] Macro(“DAHDI/1-1”, “blkvm-setifempty,”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“DAHDI/1-1”, “0?init”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:2] Set(“DAHDI/1-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-setifempty:3] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:3] GotoIf(“DAHDI/1-1”, “0?skipov”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:4] Macro(“DAHDI/1-1”, “blkvm-set,reset”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-set:1] ExecIf(“DAHDI/1-1”, “0?Set(__BLKVM_CHANNEL=DAHDI/1-1)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-set:2] Set(“DAHDI/1-1”, “SHARED(BLKVM,DAHDI/1-1)=TRUE”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-set:3] Set(“DAHDI/1-1”, “GOSUB_RETVAL=TRUE”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-set:4] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:5] Set(“DAHDI/1-1”, “__NODEST=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:6] Set(“DAHDI/1-1”, “RRNODEST=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:7] Set(“DAHDI/1-1”, “__NODEST=600”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:8] GosubIf(“DAHDI/1-1”, “0?sub-rgsetcid,s,1()”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:9] Gosub(“DAHDI/1-1”, “sub-record-check,s,1(rg,600,dontcare)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/1-1”, “7?initialized”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,s,10)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/1-1”, “Recordings initialized”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/1-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/1-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/1-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/1-1”, “2?checkaction”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/1-1”, “0?sub-record-check,rg,1”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:18] NoOp(“DAHDI/1-1”, “Generic rg Recording Check - unknown 600”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:19] Gosub(“DAHDI/1-1”, “recordcheck,1(dontcare,rg,600)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/1-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/1-1”, “dontcare”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-check:20] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:10] Set(“DAHDI/1-1”, “RingGroupMethod=memoryhunt”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:11] Macro(“DAHDI/1-1”, “dial,10,Ttr,205-201-202”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:1] GotoIf(“DAHDI/1-1”, “0?dial”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:2] Set(“DAHDI/1-1”, “CHANNEL(musicclass)=default”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:3] AGI(“DAHDI/1-1”, “dialparties.agi”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: dialparties.agi: Methodology of ring is ‘memoryhunt’
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 205 to extension map
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 201 to extension map
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Added extension 202 to extension map
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 205 cf is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 201 cf is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 202 cf is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 205 do not disturb is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 201 do not disturb is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Extension 202 do not disturb is disabled
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – dialparties.agi: Filtered ARG3: 205-201-202
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] res_agi.c: – <DAHDI/1-1>AGI Script dialparties.agi completed, returning 0
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:20] NoOp(“DAHDI/1-1”, "Returned from dialparties with hunt groups to dial ") in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:21] Set(“DAHDI/1-1”, “HuntLoop=0”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:22] GotoIf(“DAHDI/1-1”, “1?a30”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,26)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:26] Set(“DAHDI/1-1”, “HuntMember=HuntMember0”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:27] GotoIf(“DAHDI/1-1”, “0?a32:a35”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,31)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:31] GotoIf(“DAHDI/1-1”, “1?a36:a50”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,32)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:32] Set(“DAHDI/1-1”, “CTLoop=0”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=205”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/205)=unknown”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=1”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “1?a42”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,38)
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:38] Dial(“DAHDI/1-1”, “SIP/205,10,trM(auto-blkvm)”) in new stack
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:38] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/205
[2016-11-07 11:23:39] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000a is ringing
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] app_dial.c: – Nobody picked up in 10000 ms
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:39] GotoIf(“DAHDI/1-1”, “0?ANSWER,1”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:40] Set(“DAHDI/1-1”, “HuntLoop=1”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:41] GotoIf(“DAHDI/1-1”, “1?a46”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,43)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:43] Set(“DAHDI/1-1”, “HuntMembers=2”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:44] Goto(“DAHDI/1-1”, “s,a22”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,22)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:22] GotoIf(“DAHDI/1-1”, “1?a30”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,26)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:26] Set(“DAHDI/1-1”, “HuntMember=HuntMember1”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:27] GotoIf(“DAHDI/1-1”, “0?a32:a35”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,31)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:31] GotoIf(“DAHDI/1-1”, “1?a36:a50”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,32)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:32] Set(“DAHDI/1-1”, “CTLoop=0”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=205”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/205)=unknown”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=1”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=201”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/201)=unknown”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=2”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “1?a42”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,38)
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:38] Dial(“DAHDI/1-1”, “SIP/205&SIP/201,10,trM(auto-blkvm)”) in new stack
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/205
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/201
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] app_dial.c: – SIP/201-0000000c connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:48] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000b connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:49] VERBOSE[12696][C-00000002] app_dial.c: – SIP/201-0000000c is ringing
[2016-11-07 11:23:49] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000b is ringing
[2016-11-07 11:23:49] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000b is ringing
[2016-11-07 11:23:58] VERBOSE[12696][C-00000002] app_dial.c: – Nobody picked up in 10000 ms
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:39] GotoIf(“DAHDI/1-1”, “0?ANSWER,1”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:40] Set(“DAHDI/1-1”, “HuntLoop=2”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:41] GotoIf(“DAHDI/1-1”, “1?a46”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,43)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:43] Set(“DAHDI/1-1”, “HuntMembers=1”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:44] Goto(“DAHDI/1-1”, “s,a22”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,22)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:22] GotoIf(“DAHDI/1-1”, “1?a30”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,26)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:26] Set(“DAHDI/1-1”, “HuntMember=HuntMember2”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:27] GotoIf(“DAHDI/1-1”, “0?a32:a35”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,31)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:31] GotoIf(“DAHDI/1-1”, “1?a36:a50”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,32)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:32] Set(“DAHDI/1-1”, “CTLoop=0”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=205”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/205)=unknown”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=1”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=201”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/201)=unknown”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=2”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “0?a42”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:34] Set(“DAHDI/1-1”, “CT_EXTEN=202”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:35] Set(“DAHDI/1-1”, “DB(CALLTRACE/202)=unknown”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:36] Set(“DAHDI/1-1”, “CTLoop=3”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:37] Goto(“DAHDI/1-1”, “s,a37”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,33)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:33] GotoIf(“DAHDI/1-1”, “1?a42”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,38)
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:38] Dial(“DAHDI/1-1”, “SIP/205&SIP/201&SIP/202,10,trM(auto-blkvm)”) in new stack
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/205
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/201
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – Called SIP/202
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/202-0000000f connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/201-0000000e connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000d connected line has changed. Saving it until answer for DAHDI/1-1
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/202-0000000f is ringing
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000d is ringing
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/205-0000000d is ringing

5

[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/202-0000000f is ringing
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/201-0000000e is ringing
[2016-11-07 11:23:59] VERBOSE[12696][C-00000002] app_dial.c: – SIP/201-0000000e is ringing
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] app_dial.c: – Nobody picked up in 10000 ms
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:39] GotoIf(“DAHDI/1-1”, “0?ANSWER,1”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:40] Set(“DAHDI/1-1”, “HuntLoop=3”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:41] GotoIf(“DAHDI/1-1”, “1?a46”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,43)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:43] Set(“DAHDI/1-1”, “HuntMembers=0”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:44] Goto(“DAHDI/1-1”, “s,a22”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-dial,s,22)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:22] GotoIf(“DAHDI/1-1”, “0?a30”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-dial:23] NoOp(“DAHDI/1-1”, “Returning there are no members left in the hunt group to ring”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:12] Gosub(“DAHDI/1-1”, “sub-record-cancel,s,1()”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@sub-record-cancel:1] Return(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:13] Set(“DAHDI/1-1”, “RingGroupMethod=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:14] GotoIf(“DAHDI/1-1”, “0?nodest”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:15] Set(“DAHDI/1-1”, “__NODEST=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:16] Macro(“DAHDI/1-1”, “blkvm-clr,”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“DAHDI/1-1”, “SHARED(BLKVM,DAHDI/1-1)=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“DAHDI/1-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [600@ext-group:17] Goto(“DAHDI/1-1”, “ext-local,vmu210,1”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (ext-local,vmu210,1)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmu210@ext-local:1] Macro(“DAHDI/1-1”, “vm,210,NOANSWER,”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-vm:1] Macro(“DAHDI/1-1”, “user-callerid,SKIPTTL”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/1-1”, “TOUCH_MONITOR=1478539398.9”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/1-1”, “0?report”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/1-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/1-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/1-1”, “0?limit”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/1-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/1-1”, “1?report”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/1-1”, “1?continue”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/1-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/1-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/1-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/1-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/1-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-vm:2] Set(“DAHDI/1-1”, “VMGAIN=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-vm:3] Macro(“DAHDI/1-1”, “blkvm-check,”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-check:1] Set(“DAHDI/1-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-check:2] ExecIf(“DAHDI/1-1”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-blkvm-check:3] MacroExit(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-vm:4] GotoIf(“DAHDI/1-1”, “1?vmx,1”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-vm,vmx,1)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:1] Set(“DAHDI/1-1”, “MEXTEN=210”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:2] Set(“DAHDI/1-1”, “MMODE=NOANSWER”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:3] Set(“DAHDI/1-1”, “RETVM=”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:4] Set(“DAHDI/1-1”, “MODE=unavail”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:5] Macro(“DAHDI/1-1”, “get-vmcontext,210”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“DAHDI/1-1”, “VMCONTEXT=default”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“DAHDI/1-1”, “0?200:300”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:6] Set(“DAHDI/1-1”, “MODE=unavail”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:7] NoOp(“DAHDI/1-1”, “MODE IS: unavail”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:8] GotoIf(“DAHDI/1-1”, “1?chknomsg”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-vm,vmx,10)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:10] GotoIf(“DAHDI/1-1”, “0?s-NOANSWER,1”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:11] GotoIf(“DAHDI/1-1”, “1?notdirect”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-vm,vmx,13)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:13] NoOp(“DAHDI/1-1”, "Checking if ext 210 is enabled: ") in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [vmx@macro-vm:14] GotoIf(“DAHDI/1-1”, “1?s-NOANSWER,1”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-vm,s-NOANSWER,1)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s-NOANSWER@macro-vm:1] Macro(“DAHDI/1-1”, “get-vmcontext,210”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“DAHDI/1-1”, “VMCONTEXT=default”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“DAHDI/1-1”, “0?200:300”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“DAHDI/1-1”, “”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] pbx.c: – Executing [s-NOANSWER@macro-vm:2] VoiceMail(“DAHDI/1-1”, “210@default,u”) in new stack
[2016-11-07 11:24:09] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘vm-theperson.ulaw’ (language ‘en’)
[2016-11-07 11:24:11] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘digits/2.ulaw’ (language ‘en’)
[2016-11-07 11:24:11] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘digits/1.ulaw’ (language ‘en’)
[2016-11-07 11:24:12] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘digits/0.ulaw’ (language ‘en’)
[2016-11-07 11:24:13] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘vm-isunavail.ulaw’ (language ‘en’)
[2016-11-07 11:24:14] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘vm-intro.ulaw’ (language ‘en’)
[2016-11-07 11:24:19] VERBOSE[12696][C-00000002] file.c: – <DAHDI/1-1> Playing ‘beep.ulaw’ (language ‘en’)
[2016-11-07 11:24:20] VERBOSE[12696][C-00000002] app_voicemail.c: – Recording the message
[2016-11-07 11:24:20] VERBOSE[12696][C-00000002] app.c: – x=0, open writing: /var/spool/asterisk/voicemail/default/210/tmp/EVdidd format: wav, 0x7f9bf80273a8
[2016-11-07 11:24:22] VERBOSE[12788][C-00000003] sig_analog.c: – Starting simple switch on ‘DAHDI/2-1’
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:1] NoOp(“DAHDI/2-1”, "Entering from-dahdi with DID == ") in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:2] Ringing(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:3] Set(“DAHDI/2-1”, “DID=s”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:4] NoOp(“DAHDI/2-1”, “DID is now s”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:5] GotoIf(“DAHDI/2-1”, “1?dahdiok:checkzap”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (from-analog,s,9)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:9] NoOp(“DAHDI/2-1”, “Is a DAHDi Channel”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:10] Set(“DAHDI/2-1”, “CHAN=2-1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:11] Set(“DAHDI/2-1”, “CHAN=2”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:12] Macro(“DAHDI/2-1”, “from-dahdi-2,s,1”) in new stack
[2016-11-07 11:24:23] WARNING[12788][C-00000003] app_macro.c: No such context ‘macro-from-dahdi-2’ for macro ‘from-dahdi-2’. Was called by s@from-analog
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:13] NoOp(“DAHDI/2-1”, “Returned from Macro from-dahdi-2”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-analog:14] Goto(“DAHDI/2-1”, “from-pstn,s,1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (from-pstn,s,1)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:1] Set(“DAHDI/2-1”, “__DIRECTION=INBOUND”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:2] Gosub(“DAHDI/2-1”, “sub-record-check,s,1(in,s,dontcare)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/2-1”, “0?initialized”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:2] Set(“DAHDI/2-1”, “__REC_STATUS=INITIALIZED”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:3] Set(“DAHDI/2-1”, “NOW=1478539463”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:4] Set(“DAHDI/2-1”, “__DAY=07”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:5] Set(“DAHDI/2-1”, “__MONTH=11”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:6] Set(“DAHDI/2-1”, “__YEAR=2016”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:7] Set(“DAHDI/2-1”, “__TIMESTR=20161107-112423”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:8] Set(“DAHDI/2-1”, “__FROMEXTEN=unknown”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:9] Set(“DAHDI/2-1”, “__MON_FMT=wav”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/2-1”, “Recordings initialized”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/2-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/2-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/2-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/2-1”, “2?checkaction”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/2-1”, “1?sub-record-check,in,1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,in,1)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [in@sub-record-check:1] NoOp(“DAHDI/2-1”, “Inbound Recording Check to s”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [in@sub-record-check:2] Set(“DAHDI/2-1”, “FROMEXTEN=unknown”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [in@sub-record-check:3] ExecIf(“DAHDI/2-1”, “0?Set(FROMEXTEN=)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [in@sub-record-check:4] Gosub(“DAHDI/2-1”, “recordcheck,1(dontcare,in,s)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/2-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/2-1”, “dontcare”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [in@sub-record-check:5] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:3] Gosub(“DAHDI/2-1”, “app-blacklist-check,s,1()”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“DAHDI/2-1”, “0?blacklisted”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@app-blacklist-check:2] Set(“DAHDI/2-1”, “CALLED_BLACKLIST=1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@app-blacklist-check:3] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:4] ExecIf(“DAHDI/2-1”, “1?Set(__FROM_DID=s)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:5] Set(“DAHDI/2-1”, “CDR(did)=s”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:6] ExecIf(“DAHDI/2-1”, “1 ?Set(CALLERID(name)=)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:7] Set(“DAHDI/2-1”, “CHANNEL(musicclass)=default”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:8] Set(“DAHDI/2-1”, “__MOHCLASS=default”) in new stack
[2016-11-07 11:24:23] WARNING[12788][C-00000003] func_channel.c: Unknown or unavailable item requested: ‘reversecharge’
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:9] GotoIf(“DAHDI/2-1”, “0?macro-hangupcall”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:10] Set(“DAHDI/2-1”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:11] Set(“DAHDI/2-1”, “CALLERPRES()=allowed_not_screened”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@from-pstn:12] Goto(“DAHDI/2-1”, “ext-group,603,1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (ext-group,603,1)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:1] Macro(“DAHDI/2-1”, “user-callerid,”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/2-1”, “TOUCH_MONITOR=1478539462.19”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/2-1”, “0?report”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/2-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/2-1”, “0?limit”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/2-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/2-1”, “1?report”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/2-1”, “0?continue”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:17] ExecIf(“DAHDI/2-1”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:18] Set(“DAHDI/2-1”, “__TTL=64”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:19] GotoIf(“DAHDI/2-1”, “1?continue”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/2-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/2-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/2-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/2-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/2-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:2] Macro(“DAHDI/2-1”, “blkvm-setifempty,”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“DAHDI/2-1”, “1?init”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“DAHDI/2-1”, “__BLKVM_CHANNEL=DAHDI/2-1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“DAHDI/2-1”, “SHARED(BLKVM,DAHDI/2-1)=TRUE”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“DAHDI/2-1”, “GOSUB_RETVAL=TRUE”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:3] GotoIf(“DAHDI/2-1”, “1?skipov”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (ext-group,603,6)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:6] Set(“DAHDI/2-1”, “RRNODEST=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:7] Set(“DAHDI/2-1”, “__NODEST=603”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:8] GosubIf(“DAHDI/2-1”, “0?sub-rgsetcid,s,1()”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:9] Gosub(“DAHDI/2-1”, “sub-record-check,s,1(rg,603,dontcare)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/2-1”, “7?initialized”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,s,10)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/2-1”, “Recordings initialized”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/2-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/2-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/2-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/2-1”, “2?checkaction”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/2-1”, “0?sub-record-check,rg,1”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:18] NoOp(“DAHDI/2-1”, “Generic rg Recording Check - unknown 603”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:19] Gosub(“DAHDI/2-1”, “recordcheck,1(dontcare,rg,603)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/2-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/2-1”, “dontcare”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:20] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:10] Set(“DAHDI/2-1”, “RingGroupMethod=ringall”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:11] Macro(“DAHDI/2-1”, “dial,12,Ttr,205-206-204”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:1] GotoIf(“DAHDI/2-1”, “0?dial”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:2] Set(“DAHDI/2-1”, “CHANNEL(musicclass)=default”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:3] AGI(“DAHDI/2-1”, “dialparties.agi”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Added extension 205 to extension map
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Added extension 206 to extension map
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Added extension 204 to extension map
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 205 cf is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 206 cf is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 204 cf is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 205 do not disturb is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 206 do not disturb is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Extension 204 do not disturb is disabled
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: DbDel CALLTRACE/205 - Caller ID is not defined

6

[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: DbDel CALLTRACE/206 - Caller ID is not defined
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: DbDel CALLTRACE/204 - Caller ID is not defined
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – dialparties.agi: Filtered ARG3: 205-206-204
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] res_agi.c: – <DAHDI/2-1>AGI Script dialparties.agi completed, returning 0
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:7] Dial(“DAHDI/2-1”, “SIP/205&SIP/206&SIP/204,12,trM(auto-blkvm)”) in new stack
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – Called SIP/205
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – Called SIP/206
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – Called SIP/204
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – SIP/204-00000012 connected line has changed. Saving it until answer for DAHDI/2-1
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – SIP/206-00000011 connected line has changed. Saving it until answer for DAHDI/2-1
[2016-11-07 11:24:23] VERBOSE[12788][C-00000003] app_dial.c: – SIP/205-00000010 connected line has changed. Saving it until answer for DAHDI/2-1
[2016-11-07 11:24:24] VERBOSE[12788][C-00000003] app_dial.c: – SIP/204-00000012 is ringing
[2016-11-07 11:24:24] VERBOSE[12788][C-00000003] app_dial.c: – SIP/205-00000010 is ringing
[2016-11-07 11:24:24] VERBOSE[12788][C-00000003] app_dial.c: – SIP/206-00000011 is ringing
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] app_dial.c: – Nobody picked up in 12000 ms
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:8] Set(“DAHDI/2-1”, “DIALSTATUS=NOANSWER”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial:9] GosubIf(“DAHDI/2-1”, “0?NOANSWER,1”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:12] Gosub(“DAHDI/2-1”, “sub-record-cancel,s,1()”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-cancel:1] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:13] Set(“DAHDI/2-1”, “RingGroupMethod=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:14] GotoIf(“DAHDI/2-1”, “0?nodest”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:15] Set(“DAHDI/2-1”, “__NODEST=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:16] Macro(“DAHDI/2-1”, “blkvm-clr,”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“DAHDI/2-1”, “SHARED(BLKVM,DAHDI/2-1)=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“DAHDI/2-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [603@ext-group:17] Goto(“DAHDI/2-1”, “ivr-1,s,1”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Goto (ivr-1,s,1)
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:1] Set(“DAHDI/2-1”, “TIMEOUT_LOOPCOUNT=0”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:2] Set(“DAHDI/2-1”, “INVALID_LOOPCOUNT=0”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:3] Set(“DAHDI/2-1”, “_IVR_CONTEXT_ivr-1=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:4] Set(“DAHDI/2-1”, “_IVR_CONTEXT=ivr-1”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:5] Set(“DAHDI/2-1”, “__IVR_RETVM=”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:6] GotoIf(“DAHDI/2-1”, “0?skip”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:7] Answer(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:35] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:8] Wait(“DAHDI/2-1”, “1”) in new stack
[2016-11-07 11:24:36] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:9] Set(“DAHDI/2-1”, “IVR_MSG=custom/IVR1”) in new stack
[2016-11-07 11:24:36] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:10] Set(“DAHDI/2-1”, “TIMEOUT(digit)=3”) in new stack
[2016-11-07 11:24:36] VERBOSE[12788][C-00000003] func_timeout.c: – Digit timeout set to 3.000
[2016-11-07 11:24:36] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@ivr-1:11] ExecIf(“DAHDI/2-1”, “1?
Background(custom/IVR1)”) in new stack
[2016-11-07 11:24:36] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘custom/IVR1.slin’ (language ‘en’)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [4@ivr-1:1] Goto(“DAHDI/2-1”, “from-did-direct,205,1”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (from-did-direct,205,1)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [205@from-did-direct:1] GotoIf(“DAHDI/2-1”, “1?ext-local,205,1”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (ext-local,205,1)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [205@ext-local:1] Set(“DAHDI/2-1”, “__RINGTIMER=15”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [205@ext-local:2] Macro(“DAHDI/2-1”, “exten-vm,205,205,0,0,0”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“DAHDI/2-1”, “user-callerid,”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/2-1”, “TOUCH_MONITOR=1478539462.19”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/2-1”, “0?report”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/2-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/2-1”, “0?limit”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/2-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/2-1”, “1?report”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/2-1”, “0?continue”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:17] ExecIf(“DAHDI/2-1”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:18] Set(“DAHDI/2-1”, “__TTL=63”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:19] GotoIf(“DAHDI/2-1”, “1?continue”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/2-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/2-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/2-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/2-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/2-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:2] Set(“DAHDI/2-1”, “RingGroupMethod=none”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:3] Set(“DAHDI/2-1”, “__EXTTOCALL=205”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:4] Set(“DAHDI/2-1”, “__PICKUPMARK=205”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:5] Set(“DAHDI/2-1”, “RT=15”) in new stack
[2016-11-07 11:24:43] WARNING[12788][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:6] ExecIf(“DAHDI/2-1”, “0?Macro(vm,205,DIRECTDIAL,)”) in new stack
[2016-11-07 11:24:43] WARNING[12788][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2016-11-07 11:24:43] WARNING[12788][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:7] ExecIf(“DAHDI/2-1”, “0?MacroExit()”) in new stack
[2016-11-07 11:24:43] WARNING[12788][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:8] Gosub(“DAHDI/2-1”, “sub-record-check,s,1(exten,205,dontcare)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/2-1”, “7?initialized”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,s,10)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:10] NoOp(“DAHDI/2-1”, “Recordings initialized”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/2-1”, “0?Set(ARG3=dontcare)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/2-1”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“DAHDI/2-1”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“DAHDI/2-1”, “5?checkaction”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,s,17)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“DAHDI/2-1”, “1?sub-record-check,exten,1”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,exten,1)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:1] NoOp(“DAHDI/2-1”, “Exten Recording Check between unknown and 205”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:2] Set(“DAHDI/2-1”, “CALLTYPE=external”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:3] ExecIf(“DAHDI/2-1”, “0?Set(CALLTYPE=)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:4] Set(“DAHDI/2-1”, “CALLEE=dontcare”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:5] ExecIf(“DAHDI/2-1”, “0?Set(CALLEE=dontcare)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:6] GotoIf(“DAHDI/2-1”, “1?callee”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,exten,11)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:11] Gosub(“DAHDI/2-1”, “recordcheck,1(dontcare,external,205)”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“DAHDI/2-1”, “Starting recording check against dontcare”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“DAHDI/2-1”, “dontcare”) in new stack
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-11-07 11:24:43] VERBOSE[12788][C-00000003] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [exten@sub-record-check:12] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:9] GotoIf(“DAHDI/2-1”, “1?macrodial”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-exten-vm,s,15)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:15] GosubIf(“DAHDI/2-1”, “0?clrheader,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:16] Macro(“DAHDI/2-1”, “dial-one,15,Ttr,205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:1] Set(“DAHDI/2-1”, “DEXTEN=205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:2] Set(“DAHDI/2-1”, “DIALSTATUS_CW=”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:3] GosubIf(“DAHDI/2-1”, “0?screen,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:4] GosubIf(“DAHDI/2-1”, “0?cf,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:5] GotoIf(“DAHDI/2-1”, “1?skip1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-dial-one,s,8)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:8] GotoIf(“DAHDI/2-1”, “0?nodial”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:9] GotoIf(“DAHDI/2-1”, “0?continue”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:10] Set(“DAHDI/2-1”, “EXTHASCW=ENABLED”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:11] GotoIf(“DAHDI/2-1”, “0?next1:cwinusebusy”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-dial-one,s,23)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:23] GotoIf(“DAHDI/2-1”, “1?next3:continue”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-dial-one,s,24)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:24] ExecIf(“DAHDI/2-1”, “0?Set(DIALSTATUS_CW=BUSY)”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:25] GotoIf(“DAHDI/2-1”, “0?nodial”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:26] GosubIf(“DAHDI/2-1”, “1?dstring,1():dlocal,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:1] Set(“DAHDI/2-1”, “DSTRING=”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:2] Set(“DAHDI/2-1”, “DEVICES=205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:3] ExecIf(“DAHDI/2-1”, “0?Return()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:4] ExecIf(“DAHDI/2-1”, “0?Set(DEVICES=05)”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:5] Set(“DAHDI/2-1”, “LOOPCNT=1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:6] Set(“DAHDI/2-1”, “ITER=1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:7] Set(“DAHDI/2-1”, “THISDIAL=SIP/205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:8] GosubIf(“DAHDI/2-1”, “1?zap2dahdi,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:1] ExecIf(“DAHDI/2-1”, “0?Return()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:2] Set(“DAHDI/2-1”, “NEWDIAL=”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:3] Set(“DAHDI/2-1”, “LOOPCNT2=1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:4] Set(“DAHDI/2-1”, “ITER2=1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:5] Set(“DAHDI/2-1”, “THISPART2=SIP/205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:6] ExecIf(“DAHDI/2-1”, “0?Set(THISPART2=DAHDI/205)”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:7] Set(“DAHDI/2-1”, “NEWDIAL=SIP/205&”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:8] Set(“DAHDI/2-1”, “ITER2=2”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:9] GotoIf(“DAHDI/2-1”, “0?begin2”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:10] Set(“DAHDI/2-1”, “THISDIAL=SIP/205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [zap2dahdi@macro-dial-one:11] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:9] GotoIf(“DAHDI/2-1”, “1?doset”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-dial-one,dstring,13)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:13] Set(“DAHDI/2-1”, “DSTRING=SIP/205&”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:14] Set(“DAHDI/2-1”, “ITER=2”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:15] GotoIf(“DAHDI/2-1”, “0?begin”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:16] ExecIf(“DAHDI/2-1”, “0?Return()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:17] Set(“DAHDI/2-1”, “DSTRING=SIP/205”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [dstring@macro-dial-one:18] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:27] GotoIf(“DAHDI/2-1”, “0?nodial”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:28] GotoIf(“DAHDI/2-1”, “0?skiptrace”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:29] GosubIf(“DAHDI/2-1”, “0?ctset,1():ctclear,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [ctclear@macro-dial-one:1] NoOp(“DAHDI/2-1”, "Deleting: CALLTRACE/205 ") in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [ctclear@macro-dial-one:2] Return(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:30] Set(“DAHDI/2-1”, “D_OPTIONS=Ttr”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:31] ExecIf(“DAHDI/2-1”, “0?SIPAddHeader(Alert-Info: )”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:32] ExecIf(“DAHDI/2-1”, “0?SIPAddHeader()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:33] ExecIf(“DAHDI/2-1”, “1?Set(CHANNEL(musicclass)=default)”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:34] GosubIf(“DAHDI/2-1”, “0?qwait,1()”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:35] Set(“DAHDI/2-1”, “__CWIGNORE=”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:36] Set(“DAHDI/2-1”, “__KEEPCID=TRUE”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:37] GotoIf(“DAHDI/2-1”, “0?usegoto,1”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:38] GotoIf(“DAHDI/2-1”, “1?godial”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-dial-one,s,43)
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:43] Macro(“DAHDI/2-1”, “dialout-one-predial-hook,”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dialout-one-predial-hook:1] MacroExit(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:44] ExecIf(“DAHDI/2-1”, “1?Set(D_OPTIONS=trI)”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:45] Dial(“DAHDI/2-1”, “SIP/205,15,trI”) in new stack
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP TOS bits 184
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] netsock2.c: == Using SIP RTP CoS mark 5
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] app_dial.c: – Called SIP/205
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] app_dial.c: – Connected line update to DAHDI/2-1 prevented.
[2016-11-07 11:24:44] VERBOSE[12788][C-00000003] app_dial.c: – SIP/205-00000013 is ringing
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] app_dial.c: – Nobody picked up in 15000 ms
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:46] ExecIf(“DAHDI/2-1”, “0?MacroExit()”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:47] ExecIf(“DAHDI/2-1”, “0?Set(DIALSTATUS=)”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:48] GosubIf(“DAHDI/2-1”, “0?s-NOANSWER,1()”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-dial-one:49] MacroExit(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:17] Set(“DAHDI/2-1”, “SV_DIALSTATUS=NOANSWER”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:18] GosubIf(“DAHDI/2-1”, “0?docfu,1()”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:19] GosubIf(“DAHDI/2-1”, “0?docfb,1()”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:20] Set(“DAHDI/2-1”, “DIALSTATUS=NOANSWER”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:21] ExecIf(“DAHDI/2-1”, “0?MacroExit()”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:22] GotoIf(“DAHDI/2-1”, “0?s-NOANSWER,1”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-exten-vm:23] Macro(“DAHDI/2-1”, “vm,205,NOANSWER,”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-vm:1] Macro(“DAHDI/2-1”, “user-callerid,SKIPTTL”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/2-1”, “TOUCH_MONITOR=1478539462.19”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/2-1”, “0?report”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/2-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/2-1”, “0?limit”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:7] Set(“DAHDI/2-1”, “AMPUSERCIDNAME=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“DAHDI/2-1”, “1?report”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“DAHDI/2-1”, “1?continue”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/2-1”, “CALLERID(number)=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:31] Set(“DAHDI/2-1”, “CALLERID(name)=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:32] Set(“DAHDI/2-1”, “CDR(cnum)=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:33] Set(“DAHDI/2-1”, “CDR(cnam)=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-user-callerid:34] Set(“DAHDI/2-1”, “CHANNEL(language)=en”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-vm:2] Set(“DAHDI/2-1”, “VMGAIN=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-vm:3] Macro(“DAHDI/2-1”, “blkvm-check,”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-check:1] Set(“DAHDI/2-1”, “GOSUB_RETVAL=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-check:2] ExecIf(“DAHDI/2-1”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-blkvm-check:3] MacroExit(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-vm:4] GotoIf(“DAHDI/2-1”, “1?vmx,1”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-vm,vmx,1)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:1] Set(“DAHDI/2-1”, “MEXTEN=205”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:2] Set(“DAHDI/2-1”, “MMODE=NOANSWER”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:3] Set(“DAHDI/2-1”, “RETVM=”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:4] Set(“DAHDI/2-1”, “MODE=unavail”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:5] Macro(“DAHDI/2-1”, “get-vmcontext,205”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“DAHDI/2-1”, “VMCONTEXT=default”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“DAHDI/2-1”, “0?200:300”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:6] Set(“DAHDI/2-1”, “MODE=unavail”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:7] NoOp(“DAHDI/2-1”, “MODE IS: unavail”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:8] GotoIf(“DAHDI/2-1”, “1?chknomsg”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-vm,vmx,10)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:10] GotoIf(“DAHDI/2-1”, “0?s-NOANSWER,1”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:11] GotoIf(“DAHDI/2-1”, “1?notdirect”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-vm,vmx,13)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:13] NoOp(“DAHDI/2-1”, "Checking if ext 205 is enabled: ") in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [vmx@macro-vm:14] GotoIf(“DAHDI/2-1”, “1?s-NOANSWER,1”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-vm,s-NOANSWER,1)

7

[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s-NOANSWER@macro-vm:1] Macro(“DAHDI/2-1”, “get-vmcontext,205”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“DAHDI/2-1”, “VMCONTEXT=default”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“DAHDI/2-1”, “0?200:300”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“DAHDI/2-1”, “”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] pbx.c: – Executing [s-NOANSWER@macro-vm:2] VoiceMail(“DAHDI/2-1”, “205@default,u”) in new stack
[2016-11-07 11:24:59] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘vm-theperson.ulaw’ (language ‘en’)
[2016-11-07 11:25:01] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘digits/2.ulaw’ (language ‘en’)
[2016-11-07 11:25:01] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘digits/0.ulaw’ (language ‘en’)
[2016-11-07 11:25:02] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘digits/5.ulaw’ (language ‘en’)
[2016-11-07 11:25:03] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘vm-isunavail.ulaw’ (language ‘en’)
[2016-11-07 11:25:04] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘vm-intro.ulaw’ (language ‘en’)
[2016-11-07 11:25:09] VERBOSE[12788][C-00000003] file.c: – <DAHDI/2-1> Playing ‘beep.ulaw’ (language ‘en’)
[2016-11-07 11:25:10] VERBOSE[12788][C-00000003] app_voicemail.c: – Recording the message
[2016-11-07 11:25:10] VERBOSE[12788][C-00000003] app.c: – x=0, open writing: /var/spool/asterisk/voicemail/default/205/tmp/Gx8Pml format: wav, 0x7f9bf4001738

8

Here is what my channels say still. it will stay this way until i restart asterisk.

Channel Location State Application(Data)
DAHDI/1-1 s-NOANSWER@macro-vm: Up VoiceMail(210@default,u)
DAHDI/2-1 s-NOANSWER@macro-vm: Up VoiceMail(205@default,u)
2 active channels
2 active calls
4 calls processed

9

You appear to be using an analog line, correct? In that case it’s up to the provider to send some sort of signal that the remote side has hung up - and not all providers do so. If they didn’t you would see the exact behavior you’re seeing.

10

Yes we have a 4 port card with 2 analog lines.
I just ran a test with my cell phone but this time i let it go through and answered it.
i then hung up my cell phone and left the desk phone off hook. after a few seconds i got a busy signal but it never did terminate. when i finally hung up the desk phone it cleared the channel.
so what can i do about this?

11

You should not use analogue lines if you want disconnect supervision.

However, if you must use them, the service provider has to provide it in a form that Asterisk understands and Asterisk has to be configured to detect it. It think Asterisk can use a loss of battery voltage and a busy tone, as ways of detecting this.

Also we are not experts on FreePBX, so GUI screenshots are of limited used, and unedited log files have far to much noise for most people to bother looking at them.

12

we dont have a choice of phone providers around here. the last smaller one just got bought out last month. so we have one company now is all.
I am new to all this so if you could help me figure out how to set the loss of voltage or busy tone that would be most helpful.
if there is a better way to post the information requested i would be glad to do so just let me know how/what.

13

The telephone operator has to do these.

Relevant bits of chan_dahid.conf.sample, which you should already have are:

;usesmdi=yes
;smdiport=/dev/ttyS0
;
; On trunk interfaces (FXS) and E&M interfaces (E&M, Wink, Feature Group D
; etc, it can be useful to perform busy detection either in an effort to
; detect hangup or for detecting busies.  This enables listening for
; the beep-beep busy pattern.
;
;busydetect=yes
;
; If busydetect is enabled, it is also possible to specify how many busy tones
; to wait for before hanging up.  The default is 3, but it might be
; safer to set to 6 or even 8.  Mind that the higher the number, the more
; time that will be needed to hangup a channel, but lowers the probability
; that you will get random hangups.
;
;busycount=6
;
; If busydetect is enabled, it is also possible to specify the cadence of your
; busy signal.  In many countries, it is 500msec on, 500msec off.  Without
; busypattern specified, we'll accept any regular sound-silence pattern that
; repeats <busycount> times as a busy signal.  If you specify busypattern,
; then we'll further check the length of the sound (tone) and silence, which
; will further reduce the chance of a false positive.
;
;busypattern=500,500
;
; NOTE: In make menuselect, you'll find further options to tweak the busy
; detector.  If your country has a busy tone with the same length tone and
; silence (as many countries do), consider enabling the
; BUSYDETECT_COMPARE_TONE_AND_SILENCE option.
;
; To further detect which hangup tone your telco provider is sending, it is
; useful to use the dahdi_monitor utility to record the audio that main/dsp.c
; is receiving after the caller hangs up.
;
; For FXS (FXO signalled) ports
;   switch the line polarity to signal the connected PBX that an outgoing
;   call was answered by the remote party.
; For FXO (FXS signalled) ports
;   watch for a polarity reversal to mark when a outgoing call is
;   answered by the remote party.
;

; For FXS (FXO signalled) ports
;   switch the line polarity to signal the connected PBX that the current
;   call was "hung up" by the remote party
; For FXO (FXS signalled) ports
;   In some countries, a polarity reversal is used to signal the disconnect of a
;   phone line.  If the hanguponpolarityswitch option is selected, the call will
;   be considered "hung up" on a polarity reversal.
;
;hanguponpolarityswitch=yes
;
; polarityonanswerdelay: minimal time period (ms) between the answer
;                        polarity switch and hangup polarity switch.
;                        (default: 600ms)
;
; On trunk interfaces (FXS) it can be useful to attempt to follow the progress
; of a call through RINGING, BUSY, and ANSWERING.   If turned on, call
; progress attempts to determine answer, busy, and ringing on phone lines.
; This feature is HIGHLY EXPERIMENTAL and can easily detect false answers,
; so don't count on it being very accurate.
;
; Few zones are supported at the time of this writing, but may be selected
; with "progzone".
;
; progzone also affects the pattern used for buzydetect (unless
; busypattern is set explicitly). The possible values are:
;   us (default)
;   ca (alias for 'us')
;   cr (Costa Rica)
;   br (Brazil, alias for 'cr')
;   uk
;
; This feature can also easily detect false hangups. The symptoms of this is
; being disconnected in the middle of a call for no reason.
;

Whilst I thought there was a loss of battery option (which is one of the methods used in the UK), I can’t find it.

14

although my file does not look like that. i did find the busy detect and set it to 5 with no luck.
I changed the cards from kewl to loop start as well with no success either. i emailed our phone provider but have little hope of getting help there. any other suggestions?

15

Get an ISDN connection, either directly, or via a SIP service provider.

16

The phone company just left. they had to change something in their system and now we are good to go.
Thanks all for all the help!