Follow-me disconnects upon no answer. Never goes to voicemail

General Help
1

FreePBX 2.11.0.27 and Asterisk 1.8.15-cert5.

Calls that are blind-transferred to an extension with Follow-me configured disconnects when not answered - where they should be going to voicemail.

The follow-me settings for this extension are: ringallv2, initial ring 4 seconds, ring time 20 seconds, follow-me list is extension and cell phone, no announcement, confirm calls yes, destination if no answer is set to the extensions voicemail. We have also tried setting to “Normal Extension Behavior”. We are on a PRI from TDS (AT&T).

If the user does not answer his cell phone the call just flat out terminates. It never goes to voicemail. I do not believe we had this problem on Asterisk 1.6, though I’m not sure that is related as I would guess this is a dialplan or Follow-me configuration issue?

2

can you provide a call trace

3

Thanks for taking a look, James.

-- Accepting call from '414xxxxxxx' to 'xxxxxxx' on channel 0/22, span 1 -- Executing [xxxxxxx@from-pstn:1] Set("DAHDI/i1/414xxxxxxx-605", "__FROM_DID=xxxxxxx") in new stack -- Executing [xxxxxxx@from-pstn:2] Gosub("DAHDI/i1/414xxxxxxx-605", "app-blacklist-check,s,1()") in new stack -- Executing [s@app-blacklist-check:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?blacklisted") in new stack -- Executing [s@app-blacklist-check:2] Set("DAHDI/i1/414xxxxxxx-605", "CALLED_BLACKLIST=1") in new stack -- Executing [s@app-blacklist-check:3] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [xxxxxxx@from-pstn:3] Set("DAHDI/i1/414xxxxxxx-605", "CDR(did)=xxxxxxx") in new stack -- Executing [xxxxxxx@from-pstn:4] ExecIf("DAHDI/i1/414xxxxxxx-605", "0 ?Set(CALLERID(name)=414xxxxxxx)") in new stack -- Executing [xxxxxxx@from-pstn:5] Set("DAHDI/i1/414xxxxxxx-605", "CHANNEL(musicclass)=default") in new stack -- Executing [xxxxxxx@from-pstn:6] Set("DAHDI/i1/414xxxxxxx-605", "__MOHCLASS=default") in new stack -- Executing [xxxxxxx@from-pstn:7] Set("DAHDI/i1/414xxxxxxx-605", "__CALLINGPRES_SV=allowed") in new stack -- Executing [xxxxxxx@from-pstn:8] Set("DAHDI/i1/414xxxxxxx-605", "CALLERPRES()=allowed_not_screened") in new stack -- Executing [xxxxxxx@from-pstn:9] Goto("DAHDI/i1/414xxxxxxx-605", "app-daynight,0,1") in new stack -- Goto (app-daynight,0,1) -- Executing [0@app-daynight:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?timeconditions,4,1:timeconditions,1,1") in new stack -- Goto (timeconditions,1,1) -- Executing [1@timeconditions:1] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "16:50-23:59,mon-thu,*,*?truestate") in new stack -- Executing [1@timeconditions:2] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "16:00-23:59,fri,*,*?truestate") in new stack -- Executing [1@timeconditions:3] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "00:00-23:59,sat-sun,*,*?truestate") in new stack -- Executing [1@timeconditions:4] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "00:00-08:30,mon-fri,*,*?truestate") in new stack -- Executing [1@timeconditions:5] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "*,*,4,jul?truestate") in new stack -- Executing [1@timeconditions:6] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "*,*,1,jan?truestate") in new stack -- Executing [1@timeconditions:7] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?truegoto") in new stack -- Executing [1@timeconditions:8] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(DB(TC/1)=)") in new stack -- Executing [1@timeconditions:9] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?ivr-2,s,1") in new stack -- Goto (ivr-2,s,1) -- Executing [s@ivr-2:1] Set("DAHDI/i1/414xxxxxxx-605", "INVALID_LOOPCOUNT=0") in new stack -- Executing [s@ivr-2:2] Set("DAHDI/i1/414xxxxxxx-605", "_IVR_CONTEXT_ivr-2=") in new stack -- Executing [s@ivr-2:3] Set("DAHDI/i1/414xxxxxxx-605", "_IVR_CONTEXT=ivr-2") in new stack -- Executing [s@ivr-2:4] Set("DAHDI/i1/414xxxxxxx-605", "__IVR_RETVM=") in new stack -- Executing [s@ivr-2:5] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?skip") in new stack -- Executing [s@ivr-2:6] Answer("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [s@ivr-2:7] Wait("DAHDI/i1/414xxxxxxx-605", "1") in new stack -- Executing [s@ivr-2:8] Set("DAHDI/i1/414xxxxxxx-605", "IVR_MSG=custom/thank-you-for-calling-karen-mp3") in new stack -- Executing [s@ivr-2:9] Set("DAHDI/i1/414xxxxxxx-605", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [s@ivr-2:10] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Background(custom/thank-you-for-calling-karen-mp3)") in new stack [2014-06-05 10:52:00] WARNING[21176]: mp3/interface.c:216 decodeMP3: Junk at the beginning of frame 49443303 [2014-06-05 10:52:00] WARNING[21176]: mp3/interface.c:216 decodeMP3: Junk at the beginning of frame 49443303 -- Playing 'custom/thank-you-for-calling-karen-mp3.slin' (language 'en') -- Executing [s@ivr-2:11] WaitExten("DAHDI/i1/414xxxxxxx-605", "1,") in new stack -- Timeout on DAHDI/i1/414xxxxxxx-605, going to 't' -- Executing [t@ivr-2:1] Goto("DAHDI/i1/414xxxxxxx-605", "ext-queues,1000,1") in new stack -- Goto (ext-queues,1000,1) -- Executing [1000@ext-queues:1] Macro("DAHDI/i1/414xxxxxxx-605", "user-callerid,") in new stack -- Executing [s@macro-user-callerid:1] Set("DAHDI/i1/414xxxxxxx-605", "TOUCH_MONITOR=1401983519.5614") in new stack -- Executing [s@macro-user-callerid:2] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSER=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:3] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?report") in new stack -- Executing [s@macro-user-callerid:4] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [s@macro-user-callerid:5] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?limit") in new stack -- Executing [s@macro-user-callerid:7] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?report") in new stack -- Goto (macro-user-callerid,s,16) -- Executing [s@macro-user-callerid:16] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?continue") in new stack -- Executing [s@macro-user-callerid:17] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack -- Executing [s@macro-user-callerid:18] Set("DAHDI/i1/414xxxxxxx-605", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:19] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [s@macro-user-callerid:30] Set("DAHDI/i1/414xxxxxxx-605", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:31] Set("DAHDI/i1/414xxxxxxx-605", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:32] Set("DAHDI/i1/414xxxxxxx-605", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:33] Set("DAHDI/i1/414xxxxxxx-605", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:34] Set("DAHDI/i1/414xxxxxxx-605", "CHANNEL(language)=en") in new stack -- Executing [1000@ext-queues:2] Answer("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [1000@ext-queues:3] Set("DAHDI/i1/414xxxxxxx-605", "__NODEST=1000") in new stack -- Executing [1000@ext-queues:4] Set("DAHDI/i1/414xxxxxxx-605", "QCIDPP=") in new stack -- Executing [1000@ext-queues:5] Set("DAHDI/i1/414xxxxxxx-605", "VQ_CIDPP=") in new stack -- Executing [1000@ext-queues:6] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Macro(prepend-cid,)") in new stack -- Executing [1000@ext-queues:7] Set("DAHDI/i1/414xxxxxxx-605", "QAINFO=") in new stack -- Executing [1000@ext-queues:8] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AINFO=") in new stack -- Executing [1000@ext-queues:9] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(__ALERT_INFO=)") in new stack -- Executing [1000@ext-queues:10] Set("DAHDI/i1/414xxxxxxx-605", "QJOINMSG=") in new stack -- Executing [1000@ext-queues:11] Set("DAHDI/i1/414xxxxxxx-605", "VQ_JOINMSG=") in new stack -- Executing [1000@ext-queues:12] Set("DAHDI/i1/414xxxxxxx-605", "QMOH=default") in new stack -- Executing [1000@ext-queues:13] Set("DAHDI/i1/414xxxxxxx-605", "VQ_MOH=") in new stack -- Executing [1000@ext-queues:14] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__MOHCLASS=default)") in new stack -- Executing [1000@ext-queues:15] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [1000@ext-queues:16] Set("DAHDI/i1/414xxxxxxx-605", "QRETRY=n") in new stack -- Executing [1000@ext-queues:17] Set("DAHDI/i1/414xxxxxxx-605", "VQ_RETRY=") in new stack -- Executing [1000@ext-queues:18] Set("DAHDI/i1/414xxxxxxx-605", "QOPTIONS=tn") in new stack -- Executing [1000@ext-queues:19] Set("DAHDI/i1/414xxxxxxx-605", "VQ_OPTIONS=") in new stack -- Executing [1000@ext-queues:20] Set("DAHDI/i1/414xxxxxxx-605", "QGOSUB=") in new stack -- Executing [1000@ext-queues:21] Set("DAHDI/i1/414xxxxxxx-605", "VQ_GOSUB=") in new stack -- Executing [1000@ext-queues:22] Set("DAHDI/i1/414xxxxxxx-605", "QAGI=") in new stack -- Executing [1000@ext-queues:23] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AGI=") in new stack -- Executing [1000@ext-queues:24] Set("DAHDI/i1/414xxxxxxx-605", "QRULE=") in new stack -- Executing [1000@ext-queues:25] Set("DAHDI/i1/414xxxxxxx-605", "VQ_RULE=") in new stack -- Executing [1000@ext-queues:26] Set("DAHDI/i1/414xxxxxxx-605", "QPOSITION=") in new stack -- Executing [1000@ext-queues:27] Set("DAHDI/i1/414xxxxxxx-605", "VQ_POSITION=") in new stack -- Executing [1000@ext-queues:28] Set("DAHDI/i1/414xxxxxxx-605", "__MIXMON_FORMAT=wav49") in new stack -- Executing [1000@ext-queues:29] Gosub("DAHDI/i1/414xxxxxxx-605", "sub-record-check,s,1(q,1000,always)") in new stack -- Executing [s@sub-record-check:1] Set("DAHDI/i1/414xxxxxxx-605", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [s@sub-record-check:2] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [s@sub-record-check:7] Set("DAHDI/i1/414xxxxxxx-605", "__MON_FMT=WAV") in new stack -- Executing [s@sub-record-check:8] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?next") in new stack -- Goto (sub-record-check,s,11) -- Executing [s@sub-record-check:11] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Return()") in new stack -- Executing [s@sub-record-check:12] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__REC_POLICY_MODE=always)") in new stack -- Executing [s@sub-record-check:13] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?q,1") in new stack -- Executing [s@sub-record-check:14] Set("DAHDI/i1/414xxxxxxx-605", "__REC_STATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:15] Set("DAHDI/i1/414xxxxxxx-605", "NOW=1401983531") in new stack -- Executing [s@sub-record-check:16] Set("DAHDI/i1/414xxxxxxx-605", "__DAY=05") in new stack -- Executing [s@sub-record-check:17] Set("DAHDI/i1/414xxxxxxx-605", "__MONTH=06") in new stack -- Executing [s@sub-record-check:18] Set("DAHDI/i1/414xxxxxxx-605", "__YEAR=2014") in new stack -- Executing [s@sub-record-check:19] Set("DAHDI/i1/414xxxxxxx-605", "__TIMESTR=20140605-105211") in new stack -- Executing [s@sub-record-check:20] Set("DAHDI/i1/414xxxxxxx-605", "__FROMEXTEN=414xxxxxxx") in new stack -- Executing [s@sub-record-check:21] Set("DAHDI/i1/414xxxxxxx-605", "__CALLFILENAME=q-1000-414xxxxxxx-20140605-105211-1401983519.5614") in new stack -- Executing [s@sub-record-check:22] Goto("DAHDI/i1/414xxxxxxx-605", "q,1") in new stack -- Goto (sub-record-check,q,1) -- Executing [q@sub-record-check:1] GosubIf("DAHDI/i1/414xxxxxxx-605", "1?recq,1(q,1000,414xxxxxxx)") in new stack -- Executing [recq@sub-record-check:1] Set("DAHDI/i1/414xxxxxxx-605", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack -- Executing [recq@sub-record-check:2] Set("DAHDI/i1/414xxxxxxx-605", "MONITOR_FILENAME=2014/06/05/q-1000-414xxxxxxx-20140605-105211-1401983519.5614") in new stack -- Executing [recq@sub-record-check:3] MixMonitor("DAHDI/i1/414xxxxxxx-605", "2014/06/05/q-1000-414xxxxxxx-20140605-105211-1401983519.5614.wav49,,") in new stack -- Executing [recq@sub-record-check:4] Set("DAHDI/i1/414xxxxxxx-605", "__REC_STATUS=RECORDING") in new stack == Begin MixMonitor Recording DAHDI/i1/414xxxxxxx-605 -- Executing [recq@sub-record-check:5] Set("DAHDI/i1/414xxxxxxx-605", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [recq@sub-record-check:6] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [q@sub-record-check:2] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [1000@ext-queues:30] Set("DAHDI/i1/414xxxxxxx-605", "__CFIGNORE=TRUE") in new stack -- Executing [1000@ext-queues:31] Set("DAHDI/i1/414xxxxxxx-605", "__FORWARD_CONTEXT=block-cf") in new stack -- Executing [1000@ext-queues:32] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Playback(, )") in new stack -- Executing [1000@ext-queues:33] QueueLog("DAHDI/i1/414xxxxxxx-605", "1000,1401983519.5614,NONE,DID,xxxxxxx") in new stack -- Executing [1000@ext-queues:34] Set("DAHDI/i1/414xxxxxxx-605", "QAANNOUNCE=") in new stack -- Executing [1000@ext-queues:35] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AANNOUNCE=") in new stack -- Executing [1000@ext-queues:36] Set("DAHDI/i1/414xxxxxxx-605", "QMAXWAIT=120") in new stack -- Executing [1000@ext-queues:37] Set("DAHDI/i1/414xxxxxxx-605", "VQ_MAXWAIT=") in new stack -- Executing [1000@ext-queues:38] Queue("DAHDI/i1/414xxxxxxx-605", "1000,tn,,,120,,,,,") in new stack -- Started music on hold, class 'default', on DAHDI/i1/414xxxxxxx-605 -- Called Local/4800@from-queue/n -- Executing [4800@from-queue:1] Set("Local/4800@from-queue-004c;2", "QAGENT=4800") in new stack -- Executing [4800@from-queue:2] Goto("Local/4800@from-queue-004c;2", "1000,1") in new stack -- Goto (from-queue,1000,1) -- Executing [1000@from-queue:1] Goto("Local/4800@from-queue-004c;2", "from-queue-exten-only,4800,1") in new stack -- Goto (from-queue-exten-only,4800,1) -- Executing [4800@from-queue-exten-only:1] Set("Local/4800@from-queue-004c;2", "RingGroupMethod=none") in new stack -- Executing [4800@from-queue-exten-only:2] Set("Local/4800@from-queue-004c;2", "QDOPTS=") in new stack -- Executing [4800@from-queue-exten-only:3] Gosub("Local/4800@from-queue-004c;2", "sub-record-check,s,1(exten,4800)") in new stack -- Executing [s@sub-record-check:1] Set("Local/4800@from-queue-004c;2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [s@sub-record-check:2] GotoIf("Local/4800@from-queue-004c;2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [s@sub-record-check:7] Set("Local/4800@from-queue-004c;2", "__MON_FMT=WAV") in new stack -- Executing [s@sub-record-check:8] GotoIf("Local/4800@from-queue-004c;2", "0?next") in new stack -- Executing [s@sub-record-check:9] Set("Local/4800@from-queue-004c;2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [s@sub-record-check:10] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [4800@from-queue-exten-only:4] Macro("Local/4800@from-queue-004c;2", "dial-one,,trx,4800") in new stack -- Executing [s@macro-dial-one:1] Set("Local/4800@from-queue-004c;2", "DEXTEN=4800") in new stack -- Executing [s@macro-dial-one:2] Set("Local/4800@from-queue-004c;2", "DIALSTATUS_CW=") in new stack -- Executing [s@macro-dial-one:3] GosubIf("Local/4800@from-queue-004c;2", "0?screen,1()") in new stack -- Executing [s@macro-dial-one:4] GosubIf("Local/4800@from-queue-004c;2", "0?cf,1()") in new stack -- Executing [s@macro-dial-one:5] GotoIf("Local/4800@from-queue-004c;2", "1?skip1") in new stack -- Goto (macro-dial-one,s,8) -- Executing [s@macro-dial-one:8] GotoIf("Local/4800@from-queue-004c;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:9] GotoIf("Local/4800@from-queue-004c;2", "0?continue") in new stack -- Executing [s@macro-dial-one:10] Set("Local/4800@from-queue-004c;2", "EXTHASCW=") in new stack -- Executing [s@macro-dial-one:11] GotoIf("Local/4800@from-queue-004c;2", "1?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,12) -- Executing [s@macro-dial-one:12] GotoIf("Local/4800@from-queue-004c;2", "0?docfu:skip3") in new stack -- Goto (macro-dial-one,s,16) -- Executing [s@macro-dial-one:16] GotoIf("Local/4800@from-queue-004c;2", "1?next2:continue") in new stack -- Goto (macro-dial-one,s,17) -- Executing [s@macro-dial-one:17] GotoIf("Local/4800@from-queue-004c;2", "1?continue") in new stack -- Goto (macro-dial-one,s,25) -- Executing [s@macro-dial-one:25] GotoIf("Local/4800@from-queue-004c;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:26] GosubIf("Local/4800@from-queue-004c;2", "1?dstring,1():dlocal,1()") in new stack -- Executing [dstring@macro-dial-one:1] Set("Local/4800@from-queue-004c;2", "DSTRING=") in new stack -- Executing [dstring@macro-dial-one:2] Set("Local/4800@from-queue-004c;2", "DEVICES=4800") in new stack -- Executing [dstring@macro-dial-one:3] ExecIf("Local/4800@from-queue-004c;2", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:4] ExecIf("Local/4800@from-queue-004c;2", "0?Set(DEVICES=800)") in new stack -- Executing [dstring@macro-dial-one:5] Set("Local/4800@from-queue-004c;2", "LOOPCNT=1") in new stack -- Executing [dstring@macro-dial-one:6] Set("Local/4800@from-queue-004c;2", "ITER=1") in new stack -- Executing [dstring@macro-dial-one:7] Set("Local/4800@from-queue-004c;2", "THISDIAL=SIP/4800") in new stack -- Executing [dstring@macro-dial-one:8] GosubIf("Local/4800@from-queue-004c;2", "1?zap2dahdi,1()") in new stack -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/4800@from-queue-004c;2", "0?Return()") in new stack -- Executing [zap2dahdi@macro-dial-one:2] Set("Local/4800@from-queue-004c;2", "NEWDIAL=") in new stack -- Executing [zap2dahdi@macro-dial-one:3] Set("Local/4800@from-queue-004c;2", "LOOPCNT2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:4] Set("Local/4800@from-queue-004c;2", "ITER2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:5] Set("Local/4800@from-queue-004c;2", "THISPART2=SIP/4800") in new stack -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/4800@from-queue-004c;2", "0?Set(THISPART2=DAHDI/4800)") in new stack -- Executing [zap2dahdi@macro-dial-one:7] Set("Local/4800@from-queue-004c;2", "NEWDIAL=SIP/4800&") in new stack -- Executing [zap2dahdi@macro-dial-one:8] Set("Local/4800@from-queue-004c;2", "ITER2=2") in new stack -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/4800@from-queue-004c;2", "0?begin2") in new stack -- Executing [zap2dahdi@macro-dial-one:10] Set("Local/4800@from-queue-004c;2", "THISDIAL=SIP/4800") in new stack -- Executing [zap2dahdi@macro-dial-one:11] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [dstring@macro-dial-one:9] Set("Local/4800@from-queue-004c;2", "DSTRING=SIP/4800&") in new stack -- Executing [dstring@macro-dial-one:10] Set("Local/4800@from-queue-004c;2", "ITER=2") in new stack -- Executing [dstring@macro-dial-one:11] GotoIf("Local/4800@from-queue-004c;2", "0?begin") in new stack -- Executing [dstring@macro-dial-one:12] Set("Local/4800@from-queue-004c;2", "DSTRING=SIP/4800") in new stack -- Executing [dstring@macro-dial-one:13] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [s@macro-dial-one:27] GotoIf("Local/4800@from-queue-004c;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:28] GotoIf("Local/4800@from-queue-004c;2", "0?skiptrace") in new stack -- Executing [s@macro-dial-one:29] GosubIf("Local/4800@from-queue-004c;2", "1?ctset,1():ctclear,1()") in new stack -- Executing [ctset@macro-dial-one:1] Set("Local/4800@from-queue-004c;2", "DB(CALLTRACE/4800)=414xxxxxxx") in new stack -- Executing [ctset@macro-dial-one:2] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [s@macro-dial-one:30] Set("Local/4800@from-queue-004c;2", "D_OPTIONS=trxM(auto-blkvm)") in new stack -- Executing [s@macro-dial-one:31] ExecIf("Local/4800@from-queue-004c;2", "0?SIPAddHeader(Alert-Info: )") in new stack -- Executing [s@macro-dial-one:32] ExecIf("Local/4800@from-queue-004c;2", "0?SIPAddHeader()") in new stack -- Executing [s@macro-dial-one:33] ExecIf("Local/4800@from-queue-004c;2", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [s@macro-dial-one:34] GosubIf("Local/4800@from-queue-004c;2", "0?qwait,1()") in new stack -- Executing [s@macro-dial-one:35] Set("Local/4800@from-queue-004c;2", "__CWIGNORE=") in new stack -- Executing [s@macro-dial-one:36] Set("Local/4800@from-queue-004c;2", "__KEEPCID=TRUE") in new stack -- Executing [s@macro-dial-one:37] GotoIf("Local/4800@from-queue-004c;2", "0?usegoto,1") in new stack -- Executing [s@macro-dial-one:38] GotoIf("Local/4800@from-queue-004c;2", "1?godial") in new stack -- Goto (macro-dial-one,s,43) -- Executing [s@macro-dial-one:43] Dial("Local/4800@from-queue-004c;2", "SIP/4800,,trxM(auto-blkvm)") in new stack == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 -- Called SIP/4800 -- Local/4800@from-queue-004c;1 is ringing == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4807 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4812 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4802 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4826 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4806 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4834 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4810 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4814 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4825 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4833 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4808 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4816 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4800 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4803 == Extension Changed auto_hint_4800[from-internal] new state Ringing for Notify User 4821 -- SIP/4800-00000991 is ringing -- Local/4800@from-queue-004c;1 is ringing -- SIP/4800-00000991 answered Local/4800@from-queue-004c;2 -- Executing [s@macro-auto-blkvm:1] Set("SIP/4800-00000991", "__MACRO_RESULT=") in new stack -- Executing [s@macro-auto-blkvm:2] Set("SIP/4800-00000991", "CFIGNORE=") in new stack -- Executing [s@macro-auto-blkvm:3] Set("SIP/4800-00000991", "MASTER_CHANNEL(CFIGNORE)=") in new stack -- Executing [s@macro-auto-blkvm:4] Set("SIP/4800-00000991", "FORWARD_CONTEXT=from-internal") in new stack -- Executing [s@macro-auto-blkvm:5] Set("SIP/4800-00000991", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack -- Executing [s@macro-auto-blkvm:6] Macro("SIP/4800-00000991", "blkvm-clr,") in new stack -- Executing [s@macro-blkvm-clr:1] Set("SIP/4800-00000991", "SHARED(BLKVM,)=") in new stack -- Executing [s@macro-blkvm-clr:2] Set("SIP/4800-00000991", "GOSUB_RETVAL=") in new stack -- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/4800-00000991", "") in new stack -- Executing [s@macro-auto-blkvm:7] ExecIf("SIP/4800-00000991", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=4800)") in new stack == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4807 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4812 -- Executing [s@macro-auto-blkvm:8] ExecIf("SIP/4800-00000991", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Front Desk)") in new stack == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4802 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4826 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4806 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4834 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4810 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4814 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4825 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4833 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4808 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4816 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4800 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4803 == Extension Changed auto_hint_4800[from-internal] new state InUse for Notify User 4821 -- Local/4800@from-queue-004c;1 answered DAHDI/i1/414xxxxxxx-605 -- Stopped music on hold on DAHDI/i1/414xxxxxxx-605 == Spawn extension (from-internal, 4805, 1) exited non-zero on 'Local/4800@from-queue-004c;2' in macro 'dial-one' == Spawn extension (from-internal, 4805, 1) exited non-zero on 'Local/4800@from-queue-004c;2' -- Executing [4805@from-internal:1] GotoIf("Local/4800@from-queue-004c;2", "0?ext-local,4805,1") in new stack -- Executing [4805@from-internal:2] Macro("Local/4800@from-queue-004c;2", "user-callerid,") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4807 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4812 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4802 -- Executing [s@macro-user-callerid:1] Set("Local/4800@from-queue-004c;2", "TOUCH_MONITOR=1401983531.5616") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4826 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4806 -- Executing [s@macro-user-callerid:2] Set("Local/4800@from-queue-004c;2", "AMPUSER=414xxxxxxx") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4834 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4810 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4814 -- Executing [s@macro-user-callerid:3] GotoIf("Local/4800@from-queue-004c;2", "1?report") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4825 -- Goto (macro-user-callerid,s,16) == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4833 -- Executing [s@macro-user-callerid:16] GotoIf("Local/4800@from-queue-004c;2", "0?continue") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4808 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4816 -- Executing [s@macro-user-callerid:17] ExecIf("Local/4800@from-queue-004c;2", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4800 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4803 == Extension Changed auto_hint_4800[from-internal] new state Idle for Notify User 4821 -- Executing [s@macro-user-callerid:18] Set("Local/4800@from-queue-004c;2", "__TTL=63") in new stack -- Executing [s@macro-user-callerid:19] GotoIf("Local/4800@from-queue-004c;2", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [s@macro-user-callerid:30] Set("Local/4800@from-queue-004c;2", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:31] Set("Local/4800@from-queue-004c;2", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:32] Set("Local/4800@from-queue-004c;2", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:33] Set("Local/4800@from-queue-004c;2", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:34] Set("Local/4800@from-queue-004c;2", "CHANNEL(language)=en") in new stack -- Executing [4805@from-internal:3] Set("Local/4800@from-queue-004c;2", "DIAL_OPTIONS=trxI") in new stack -- Executing [4805@from-internal:4] Set("Local/4800@from-queue-004c;2", "CONNECTEDLINE(num)=4805") in new stack -- Executing [4805@from-internal:5] Gosub("Local/4800@from-queue-004c;2", "sub-presencestate-display,s,1(4805)") in new stack -- Executing [s@sub-presencestate-display:1] Goto("Local/4800@from-queue-004c;2", "state-available,1") in new stack -- Goto (sub-presencestate-display,state-available,1) -- Executing [state-available@sub-presencestate-display:1] Set("Local/4800@from-queue-004c;2", "PRESENCESTATE_DISPLAY=(Available)") in new stack -- Executing [state-available@sub-presencestate-display:2] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [4805@from-internal:6] Set("Local/4800@from-queue-004c;2", "CONNECTEDLINE(name,i)=Brendt Johannsen(Available)") in new stack -- Executing [4805@from-internal:7] Set("Local/4800@from-queue-004c;2", "FM_DIALSTATUS=NOT_INUSE") in new stack -- Executing [4805@from-internal:8] Set("Local/4800@from-queue-004c;2", "__EXTTOCALL=4805") in new stack -- Executing [4805@from-internal:9] Set("Local/4800@from-queue-004c;2", "__PICKUPMARK=4805") in new stack -- Executing [4805@from-internal:10] Macro("Local/4800@from-queue-004c;2", "blkvm-setifempty,") in new stack -- Executing [s@macro-blkvm-setifempty:1] GotoIf("Local/4800@from-queue-004c;2", "1?init") in new stack -- Goto (macro-blkvm-setifempty,s,4) -- Executing [s@macro-blkvm-setifempty:4] Set("Local/4800@from-queue-004c;2", "__BLKVM_CHANNEL=Local/4800@from-queue-004c;2") in new stack -- Executing [s@macro-blkvm-setifempty:5] Set("Local/4800@from-queue-004c;2", "SHARED(BLKVM,Local/4800@from-queue-004c;2)=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:6] Set("Local/4800@from-queue-004c;2", "GOSUB_RETVAL=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:7] MacroExit("Local/4800@from-queue-004c;2", "") in new stack -- Executing [4805@from-internal:11] GotoIf("Local/4800@from-queue-004c;2", "1?skipov") in new stack -- Goto (from-internal,4805,14) -- Executing [4805@from-internal:14] Set("Local/4800@from-queue-004c;2", "RRNODEST=1000") in new stack -- Executing [4805@from-internal:15] Set("Local/4800@from-queue-004c;2", "__NODEST=4805") in new stack -- Executing [4805@from-internal:16] GosubIf("Local/4800@from-queue-004c;2", "0?sub-fmsetcid,s,1()") in new stack -- Executing [4805@from-internal:17] Set("Local/4800@from-queue-004c;2", "RecordMethod=Group") in new stack -- Executing [4805@from-internal:18] Gosub("Local/4800@from-queue-004c;2", "sub-record-check,s,1(exten,4805,)") in new stack -- Executing [s@sub-record-check:1] Set("Local/4800@from-queue-004c;2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [s@sub-record-check:2] GotoIf("Local/4800@from-queue-004c;2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [s@sub-record-check:7] Set("Local/4800@from-queue-004c;2", "__MON_FMT=WAV") in new stack -- Executing [s@sub-record-check:8] GotoIf("Local/4800@from-queue-004c;2", "0?next") in new stack -- Executing [s@sub-record-check:9] Set("Local/4800@from-queue-004c;2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [s@sub-record-check:10] Return("Local/4800@from-queue-004c;2", "") in new stack -- Executing [4805@from-internal:19] Set("Local/4800@from-queue-004c;2", "RingGroupMethod=ringallv2") in new stack -- Executing [4805@from-internal:20] Set("Local/4800@from-queue-004c;2", "_FMGRP=4805") in new stack -- Executing [4805@from-internal:21] GotoIf("Local/4800@from-queue-004c;2", "0?doconfirm") in new stack -- Executing [4805@from-internal:22] Macro("Local/4800@from-queue-004c;2", "dial,24,trxI,4805-91262xxxxxxx#") in new stack -- Executing [s@macro-dial:1] GotoIf("Local/4800@from-queue-004c;2", "0?dial") in new stack -- Executing [s@macro-dial:2] SetMusicOnHold("Local/4800@from-queue-004c;2", "default") in new stack -- Executing [s@macro-dial:3] AGI("Local/4800@from-queue-004c;2", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi dialparties.agi: Starting New Dialparties.agi dialparties.agi: Caller ID name is 'WIRELESS CALLER' number is '414xxxxxxx' dialparties.agi: Methodology of ring is 'ringallv2' -- dialparties.agi: Added extension 4805 to extension map -- dialparties.agi: Added extension 91262xxxxxxx# to extension map -- dialparties.agi: Extension 4805 cf is disabled -- dialparties.agi: Extension 91262xxxxxxx# cf is disabled -- dialparties.agi: Extension 4805 do not disturb is disabled -- dialparties.agi: dbset CALLTRACE/4805 to 414xxxxxxx -- dialparties.agi: Filtered ARG3: 4805-91262xxxxxxx -- AGI Script dialparties.agi completed, returning 0 -- Executing [s@macro-dial:7] Dial("Local/4800@from-queue-004c;2", "Local/FMPR-4805@from-internal&Local/FMGL-91262xxxxxxx#@from-internal,24,trxIM(auto-blkvm)") in new stack -- Called Local/FMPR-4805@from-internal -- Executing [FMPR-4805@from-internal:1] NoCDR("Local/FMPR-4805@from-internal-8235;2", "") in new stack -- Called Local/FMGL-91262xxxxxxx#@from-internal -- Executing [FMPR-4805@from-internal:2] Set("Local/FMPR-4805@from-internal-8235;2", "RingGroupMethod=") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:1] NoCDR("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "") in new stack -- Executing [FMPR-4805@from-internal:3] Set("Local/FMPR-4805@from-internal-8235;2", "USE_CONFIRMATION=") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:2] Set("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "ENDLOOP=1401983552") in new stack -- Executing [FMPR-4805@from-internal:4] Set("Local/FMPR-4805@from-internal-8235;2", "RINGGROUP_INDEX=") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:3] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dodnd") in new stack -- Executing [FMPR-4805@from-internal:5] Macro("Local/FMPR-4805@from-internal-8235;2", "simple-dial,4805,24") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:4] Wait("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1") in new stack -- Executing [s@macro-simple-dial:1] Set("Local/FMPR-4805@from-internal-8235;2", "__EXTTOCALL=4805") in new stack -- Executing [s@macro-simple-dial:2] Set("Local/FMPR-4805@from-internal-8235;2", "RT=24") in new stack -- Executing [s@macro-simple-dial:3] Set("Local/FMPR-4805@from-internal-8235;2", "CFUEXT=") in new stack -- Executing [s@macro-simple-dial:4] Set("Local/FMPR-4805@from-internal-8235;2", "CFBEXT=") in new stack -- Executing [s@macro-simple-dial:5] Set("Local/FMPR-4805@from-internal-8235;2", "CWI_TMP=") in new stack -- Executing [s@macro-simple-dial:6] Macro("Local/FMPR-4805@from-internal-8235;2", "dial-one,24,trx,4805") in new stack -- Executing [s@macro-dial-one:1] Set("Local/FMPR-4805@from-internal-8235;2", "DEXTEN=4805") in new stack -- Executing [s@macro-dial-one:2] Set("Local/FMPR-4805@from-internal-8235;2", "DIALSTATUS_CW=") in new stack -- Executing [s@macro-dial-one:3] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?screen,1()") in new stack -- Executing [s@macro-dial-one:4] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?cf,1()") in new stack -- Executing [s@macro-dial-one:5] GotoIf("Local/FMPR-4805@from-internal-8235;2", "1?skip1") in new stack -- Goto (macro-dial-one,s,8) -- Executing [s@macro-dial-one:8] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:9] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?continue") in new stack -- Executing [s@macro-dial-one:10] Set("Local/FMPR-4805@from-internal-8235;2", "EXTHASCW=ENABLED") in new stack -- Executing [s@macro-dial-one:11] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,23) -- Executing [s@macro-dial-one:23] GotoIf("Local/FMPR-4805@from-internal-8235;2", "1?next3:continue") in new stack -- Goto (macro-dial-one,s,24) -- Executing [s@macro-dial-one:24] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Set(DIALSTATUS_CW=BUSY)") in new stack -- Executing [s@macro-dial-one:25] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:26] GosubIf("Local/FMPR-4805@from-internal-8235;2", "1?dstring,1():dlocal,1()") in new stack -- Executing [dstring@macro-dial-one:1] Set("Local/FMPR-4805@from-internal-8235;2", "DSTRING=") in new stack -- Executing [dstring@macro-dial-one:2] Set("Local/FMPR-4805@from-internal-8235;2", "DEVICES=4805") in new stack -- Executing [dstring@macro-dial-one:3] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:4] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Set(DEVICES=805)") in new stack -- Executing [dstring@macro-dial-one:5] Set("Local/FMPR-4805@from-internal-8235;2", "LOOPCNT=1") in new stack -- Executing [dstring@macro-dial-one:6] Set("Local/FMPR-4805@from-internal-8235;2", "ITER=1") in new stack -- Executing [dstring@macro-dial-one:7] Set("Local/FMPR-4805@from-internal-8235;2", "THISDIAL=SIP/4805") in new stack -- Executing [dstring@macro-dial-one:8] GosubIf("Local/FMPR-4805@from-internal-8235;2", "1?zap2dahdi,1()") in new stack -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Return()") in new stack -- Executing [zap2dahdi@macro-dial-one:2] Set("Local/FMPR-4805@from-internal-8235;2", "NEWDIAL=") in new stack -- Executing [zap2dahdi@macro-dial-one:3] Set("Local/FMPR-4805@from-internal-8235;2", "LOOPCNT2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:4] Set("Local/FMPR-4805@from-internal-8235;2", "ITER2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:5] Set("Local/FMPR-4805@from-internal-8235;2", "THISPART2=SIP/4805") in new stack -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Set(THISPART2=DAHDI/4805)") in new stack -- Executing [zap2dahdi@macro-dial-one:7] Set("Local/FMPR-4805@from-internal-8235;2", "NEWDIAL=SIP/4805&") in new stack -- Executing [zap2dahdi@macro-dial-one:8] Set("Local/FMPR-4805@from-internal-8235;2", "ITER2=2") in new stack -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?begin2") in new stack -- Executing [zap2dahdi@macro-dial-one:10] Set("Local/FMPR-4805@from-internal-8235;2", "THISDIAL=SIP/4805") in new stack -- Executing [zap2dahdi@macro-dial-one:11] Return("Local/FMPR-4805@from-internal-8235;2", "") in new stack -- Executing [dstring@macro-dial-one:9] Set("Local/FMPR-4805@from-internal-8235;2", "DSTRING=SIP/4805&") in new stack -- Executing [dstring@macro-dial-one:10] Set("Local/FMPR-4805@from-internal-8235;2", "ITER=2") in new stack -- Executing [dstring@macro-dial-one:11] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?begin") in new stack -- Executing [dstring@macro-dial-one:12] Set("Local/FMPR-4805@from-internal-8235;2", "DSTRING=SIP/4805") in new stack -- Executing [dstring@macro-dial-one:13] Return("Local/FMPR-4805@from-internal-8235;2", "") in new stack -- Executing [s@macro-dial-one:27] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:28] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?skiptrace") in new stack -- Executing [s@macro-dial-one:29] GosubIf("Local/FMPR-4805@from-internal-8235;2", "1?ctset,1():ctclear,1()") in new stack -- Executing [ctset@macro-dial-one:1] Set("Local/FMPR-4805@from-internal-8235;2", "DB(CALLTRACE/4805)=414xxxxxxx") in new stack -- Executing [ctset@macro-dial-one:2] Return("Local/FMPR-4805@from-internal-8235;2", "") in new stack -- Executing [s@macro-dial-one:30] Set("Local/FMPR-4805@from-internal-8235;2", "D_OPTIONS=trxM(auto-blkvm)") in new stack -- Executing [s@macro-dial-one:31] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?SIPAddHeader(Alert-Info: )") in new stack -- Executing [s@macro-dial-one:32] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?SIPAddHeader()") in new stack -- Executing [s@macro-dial-one:33] ExecIf("Local/FMPR-4805@from-internal-8235;2", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [s@macro-dial-one:34] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?qwait,1()") in new stack -- Executing [s@macro-dial-one:35] Set("Local/FMPR-4805@from-internal-8235;2", "__CWIGNORE=") in new stack -- Executing [s@macro-dial-one:36] Set("Local/FMPR-4805@from-internal-8235;2", "__KEEPCID=TRUE") in new stack -- Executing [s@macro-dial-one:37] GotoIf("Local/FMPR-4805@from-internal-8235;2", "0?usegoto,1") in new stack -- Executing [s@macro-dial-one:38] GotoIf("Local/FMPR-4805@from-internal-8235;2", "1?godial") in new stack -- Goto (macro-dial-one,s,43) -- Executing [s@macro-dial-one:43] Dial("Local/FMPR-4805@from-internal-8235;2", "SIP/4805,24,trxM(auto-blkvm)") in new stack == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 -- Called SIP/4805 -- Local/FMPR-4805@from-internal-8235;1 is ringing -- Connected line update to Local/4800@from-queue-004c;2 prevented. -- Connected line update to Local/4800@from-queue-004c;2 prevented. == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4827 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4829 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4825 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4833 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4808 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4803 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4816 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4821 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4800 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4805 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4809 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4802 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4834 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4839 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4811 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4806 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4838 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4826 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4807 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4812 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4837 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4818 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4810 == Extension Changed auto_hint_4805[from-internal] new state Ringing for Notify User 4814 -- SIP/4805-00000992 is ringing -- Local/FMPR-4805@from-internal-8235;1 is ringing -- Executing [FMGL-91262xxxxxxx#@from-internal:5] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1?start") in new stack -- Goto (from-internal,FMGL-91262xxxxxxx#,3) -- Executing [FMGL-91262xxxxxxx#@from-internal:3] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dodnd") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:4] Wait("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:5] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1?start") in new stack -- Goto (from-internal,FMGL-91262xxxxxxx#,3) -- Executing [FMGL-91262xxxxxxx#@from-internal:3] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dodnd") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:4] Wait("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:5] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1?start") in new stack -- Goto (from-internal,FMGL-91262xxxxxxx#,3) -- Executing [FMGL-91262xxxxxxx#@from-internal:3] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dodnd") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:4] Wait("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "1") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:5] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?start") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:6] Set("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "SHARED(FM_DND,Local/4800@from-queue-004c;2)=") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:7] Macro("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "dial,20,trx,91262xxxxxxx#") in new stack -- Executing [s@macro-dial:1] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dial") in new stack -- Executing [s@macro-dial:2] SetMusicOnHold("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "default") in new stack -- Executing [s@macro-dial:3] AGI("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi dialparties.agi: Starting New Dialparties.agi dialparties.agi: Caller ID name is 'WIRELESS CALLER' number is '414xxxxxxx' dialparties.agi: Methodology of ring is 'ringall' -- dialparties.agi: Added extension 91262xxxxxxx# to extension map -- dialparties.agi: Extension 91262xxxxxxx# cf is disabled -- dialparties.agi: Filtered ARG3: 91262xxxxxxx -- AGI Script dialparties.agi completed, returning 0 -- Executing [s@macro-dial:7] Dial("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "Local/91262xxxxxxx@from-internal/n,20,trxM(auto-blkvm)") in new stack -- Called Local/91262xxxxxxx@from-internal/n -- Local/FMGL-91262xxxxxxx#@from-internal-9096;1 is ringing -- Executing [91262xxxxxxx@from-internal:1] Macro("Local/91262xxxxxxx@from-internal-3f92;2", "user-callerid,LIMIT,EXTERNAL,") in new stack -- Executing [s@macro-user-callerid:1] Set("Local/91262xxxxxxx@from-internal-3f92;2", "TOUCH_MONITOR=1401983552.5624") in new stack -- Executing [s@macro-user-callerid:2] Set("Local/91262xxxxxxx@from-internal-3f92;2", "AMPUSER=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:3] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?report") in new stack -- Executing [s@macro-user-callerid:4] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [s@macro-user-callerid:5] Set("Local/91262xxxxxxx@from-internal-3f92;2", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?limit") in new stack -- Executing [s@macro-user-callerid:7] Set("Local/91262xxxxxxx@from-internal-3f92;2", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?report") in new stack -- Goto (macro-user-callerid,s,16) -- Executing [s@macro-user-callerid:16] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [s@macro-user-callerid:30] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:31] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:32] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [s@macro-user-callerid:33] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [s@macro-user-callerid:34] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CHANNEL(language)=en") in new stack -- Executing [91262xxxxxxx@from-internal:2] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0 ?Set(CDR(accountcode)=)") in new stack -- Executing [91262xxxxxxx@from-internal:3] Set("Local/91262xxxxxxx@from-internal-3f92;2", "_NODEST=") in new stack -- Executing [91262xxxxxxx@from-internal:4] Gosub("Local/91262xxxxxxx@from-internal-3f92;2", "sub-record-check,s,1(out,91262xxxxxxx,)") in new stack -- Executing [s@sub-record-check:1] Set("Local/91262xxxxxxx@from-internal-3f92;2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [s@sub-record-check:2] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [s@sub-record-check:7] Set("Local/91262xxxxxxx@from-internal-3f92;2", "__MON_FMT=WAV") in new stack -- Executing [s@sub-record-check:8] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?next") in new stack -- Executing [s@sub-record-check:9] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [s@sub-record-check:10] Return("Local/91262xxxxxxx@from-internal-3f92;2", "") in new stack -- Executing [91262xxxxxxx@from-internal:5] Macro("Local/91262xxxxxxx@from-internal-3f92;2", "dialout-trunk,1,1262xxxxxxx,,off") in new stack -- Executing [s@macro-dialout-trunk:1] Set("Local/91262xxxxxxx@from-internal-3f92;2", "DIAL_TRUNK=1") in new stack -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?sub-pincheck,s,1()") in new stack -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?disabletrunk,1") in new stack -- Executing [s@macro-dialout-trunk:4] Set("Local/91262xxxxxxx@from-internal-3f92;2", "DIAL_NUMBER=1262xxxxxxx") in new stack -- Executing [s@macro-dialout-trunk:5] Set("Local/91262xxxxxxx@from-internal-3f92;2", "DIAL_TRUNK_OPTIONS=trx") in new stack -- Executing [s@macro-dialout-trunk:6] Set("Local/91262xxxxxxx@from-internal-3f92;2", "OUTBOUND_GROUP=OUT_1") in new stack -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?nomax") in new stack -- Goto (macro-dialout-trunk,s,9) -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?skipoutcid") in new stack -- Executing [s@macro-dialout-trunk:10] Set("Local/91262xxxxxxx@from-internal-3f92;2", "DIAL_TRUNK_OPTIONS=") in new stack -- Executing [s@macro-dialout-trunk:11] Macro("Local/91262xxxxxxx@from-internal-3f92;2", "outbound-callerid,1") in new stack -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?Set(CALLERPRES()=allowed)") in new stack -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [s@macro-outbound-callerid:3] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?normcid") in new stack -- Executing [s@macro-outbound-callerid:4] Set("Local/91262xxxxxxx@from-internal-3f92;2", "USEROUTCID=414xxxxxxx") in new stack -- Executing [s@macro-outbound-callerid:5] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?bypass") in new stack -- Goto (macro-outbound-callerid,s,7) -- Executing [s@macro-outbound-callerid:7] Set("Local/91262xxxxxxx@from-internal-3f92;2", "EMERGENCYCID=") in new stack -- Executing [s@macro-outbound-callerid:8] Set("Local/91262xxxxxxx@from-internal-3f92;2", "TRUNKOUTCID=xxx-xxx-xxxx") in new stack -- Executing [s@macro-outbound-callerid:9] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,14) -- Executing [s@macro-outbound-callerid:14] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?Set(CALLERID(all)=xxx-xxx-xxxx)") in new stack -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?Set(CALLERID(all)=414xxxxxxx)") in new stack -- Executing [s@macro-outbound-callerid:16] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(CALLERID(all)=)") in new stack -- Executing [s@macro-outbound-callerid:17] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack -- Executing [s@macro-outbound-callerid:18] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CDR(outbound_cnum)=414xxxxxxx") in new stack -- Executing [s@macro-outbound-callerid:19] Set("Local/91262xxxxxxx@from-internal-3f92;2", "CDR(outbound_cnam)=") in new stack -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/91262xxxxxxx@from-internal-3f92;2", "1?sub-flp-1,s,1()") in new stack -- Executing [s@sub-flp-1:1] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(TARGET_FLP_1=xxxxxxx)") in new stack -- Executing [s@sub-flp-1:2] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?match") in new stack -- Executing [s@sub-flp-1:3] Return("Local/91262xxxxxxx@from-internal-3f92;2", "") in new stack -- Executing [s@macro-dialout-trunk:13] Set("Local/91262xxxxxxx@from-internal-3f92;2", "OUTNUM=1262xxxxxxx") in new stack -- Executing [s@macro-dialout-trunk:14] Set("Local/91262xxxxxxx@from-internal-3f92;2", "custom=DAHDI/g0") in new stack -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(DIAL_TRUNK_OPTIONS=M(confirm))") in new stack -- Executing [s@macro-dialout-trunk:17] Macro("Local/91262xxxxxxx@from-internal-3f92;2", "dialout-trunk-predial-hook,") in new stack -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/91262xxxxxxx@from-internal-3f92;2", "") in new stack -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?bypass,1") in new stack -- Executing [s@macro-dialout-trunk:19] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(CONNECTEDLINE(num,i)=1262xxxxxxx)") in new stack -- Executing [s@macro-dialout-trunk:20] ExecIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?Set(CONNECTEDLINE(name,i)=CID:414xxxxxxx)") in new stack -- Executing [s@macro-dialout-trunk:21] GotoIf("Local/91262xxxxxxx@from-internal-3f92;2", "0?customtrunk") in new stack -- Executing [s@macro-dialout-trunk:22] Dial("Local/91262xxxxxxx@from-internal-3f92;2", "DAHDI/g0/1262xxxxxxx,300,") in new stack [2014-06-05 10:52:32] DEBUG[21227]: sig_pri.c:1016 sig_pri_request: sig_pri_request 2 [2014-06-05 10:52:32] DEBUG[21227]: sig_pri.c:6591 sig_pri_call: CALLER NAME: NUM: 414xxxxxxx -- Requested transfer capability: 0x00 - SPEECH -- Called DAHDI/g0/1262xxxxxxx -- DAHDI/i1/1262xxxxxxx-606 is proceeding passing it to Local/91262xxxxxxx@from-internal-3f92;2 -- Local/91262xxxxxxx@from-internal-3f92;1 is proceeding passing it to Local/FMGL-91262xxxxxxx#@from-internal-9096;2 -- DAHDI/i1/1262xxxxxxx-606 is making progress passing it to Local/91262xxxxxxx@from-internal-3f92;2 -- Local/91262xxxxxxx@from-internal-3f92;1 is making progress passing it to Local/FMGL-91262xxxxxxx#@from-internal-9096;2 -- DAHDI/i1/1262xxxxxxx-606 is ringing -- Local/91262xxxxxxx@from-internal-3f92;1 is ringing -- Local/FMGL-91262xxxxxxx#@from-internal-9096;1 is ringing -- Nobody picked up in 24000 ms -- Executing [s@macro-dial-one:44] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?MacroExit()") in new stack -- Executing [s@macro-dial-one:45] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Set(DIALSTATUS=)") in new stack -- Executing [s@macro-dial-one:46] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?s-NOANSWER,1()") in new stack -- Executing [s@macro-dial-one:47] MacroExit("Local/FMPR-4805@from-internal-8235;2", "") in new stack -- Executing [s@macro-simple-dial:7] Set("Local/FMPR-4805@from-internal-8235;2", "__CWIGNORE=") in new stack -- Executing [s@macro-simple-dial:8] Set("Local/FMPR-4805@from-internal-8235;2", "PR_DIALSTATUS=NOANSWER") in new stack -- Executing [s@macro-simple-dial:9] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?docfu,1()") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4827 -- Executing [s@macro-simple-dial:10] GosubIf("Local/FMPR-4805@from-internal-8235;2", "0?docfb,1()") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4829 -- Executing [s@macro-simple-dial:11] Set("Local/FMPR-4805@from-internal-8235;2", "DIALSTATUS=NOANSWER") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4825 -- Executing [s@macro-simple-dial:12] Goto("Local/FMPR-4805@from-internal-8235;2", "s-NOANSWER,1") in new stack -- Goto (macro-simple-dial,s-NOANSWER,1) -- Executing [s-NOANSWER@macro-simple-dial:1] NoOp("Local/FMPR-4805@from-internal-8235;2", "Extension is reporting s-NOANSWER") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4833 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4808 -- Executing [FMPR-4805@from-internal:6] ExecIf("Local/FMPR-4805@from-internal-8235;2", "0?Set(SHARED(FM_DND,Local/4800@from-queue-004c;2)=DND)") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4803 -- Executing [FMPR-4805@from-internal:7] Hangup("Local/FMPR-4805@from-internal-8235;2", "") in new stack == Spawn extension (from-internal, FMPR-4805, 7) exited non-zero on 'Local/FMPR-4805@from-internal-8235;2' == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4816 -- Executing [h@from-internal:1] Hangup("Local/FMPR-4805@from-internal-8235;2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMPR-4805@from-internal-8235;2' == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4821 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4800 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4805 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4809 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4802 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4834 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4839 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4811 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4806 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4838 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4826 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4807 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4812 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4837 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4818 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4810 == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4814 -- Nobody picked up in 24000 ms -- Executing [s@macro-dial:8] Set("Local/4800@from-queue-004c;2", "DIALSTATUS=NOANSWER") in new stack -- Executing [s@macro-dial:9] GosubIf("Local/4800@from-queue-004c;2", "0?NOANSWER,1") in new stack -- Executing [4805@from-internal:23] Goto("Local/4800@from-queue-004c;2", "nextstep") in new stack -- Goto (from-internal,4805,25) -- Hungup 'DAHDI/i1/1262xxxxxxx-606' -- Executing [4805@from-internal:25] Set("Local/4800@from-queue-004c;2", "RingGroupMethod=") in new stack == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'Local/91262xxxxxxx@from-internal-3f92;2' in macro 'dialout-trunk' == Spawn extension (from-internal, 91262xxxxxxx, 5) exited non-zero on 'Local/91262xxxxxxx@from-internal-3f92;2' -- Executing [4805@from-internal:26] GotoIf("Local/4800@from-queue-004c;2", "1?nodest") in new stack -- Executing [h@from-internal:1] Hangup("Local/91262xxxxxxx@from-internal-3f92;2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/91262xxxxxxx@from-internal-3f92;2' -- Goto (from-internal,4805,32) -- Executing [4805@from-internal:32] NoOp("Local/4800@from-queue-004c;2", "SKIPPING DEST, CALL CAME FROM Q/RG: 1000") in new stack == Spawn extension (macro-dial, s, 7) exited non-zero on 'Local/FMGL-91262xxxxxxx#@from-internal-9096;2' in macro 'dial' == Spawn extension (from-internal, FMGL-91262xxxxxxx#, 7) exited non-zero on 'Local/FMGL-91262xxxxxxx#@from-internal-9096;2' [2014-06-05 10:52:53] ERROR[21227]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. [2014-06-05 10:52:53] ERROR[21227]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. -- Auto fallthrough, channel 'Local/4800@from-queue-004c;2' status is 'NOANSWER' -- Executing [h@from-internal:1] Hangup("Local/4800@from-queue-004c;2", "") in new stack -- Executing [h@from-internal:1] Hangup("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/4800@from-queue-004c;2' == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMGL-91262xxxxxxx#@from-internal-9096;2' [2014-06-05 10:52:53] ERROR[21197]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. [2014-06-05 10:52:53] ERROR[21197]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. -- Executing [h@ext-queues:1] Macro("DAHDI/i1/414xxxxxxx-605", "hangupcall,") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [s@macro-hangupcall:3] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [s@macro-hangupcall:4] Hangup("DAHDI/i1/414xxxxxxx-605", "") in new stack == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'DAHDI/i1/414xxxxxxx-605' in macro 'hangupcall' == Spawn extension (ext-queues, h, 1) exited non-zero on 'DAHDI/i1/414xxxxxxx-605' [2014-06-05 10:52:53] ERROR[21176]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. [2014-06-05 10:52:53] ERROR[21176]: cdr_odbc.c:149 odbc_log: Unable to retrieve database handle. CDR failed. == Spawn extension (ext-queues, 1000, 38) exited non-zero on 'DAHDI/i1/414xxxxxxx-605' -- Hungup 'DAHDI/i1/414xxxxxxx-605' == MixMonitor close filestream == End MixMonitor Recording DAHDI/i1/414xxxxxxx-605
4

Anyone else having this issue?

5

if you are passing the original caller id, your provider may be shutting down the call because the caller id is not on the list of numbers you own

6

Hi bksales,

Thanks for your response. The calls complete no problem. The issue is that if the call was blind transferred and is not answered it never goes to voicemail. It just hangs up.

7

is this done from a queue call?

8

Also how are your users transferring, feature code, phone button, operator panel?

9

Yes, it is done from a queue call and then is blind transferred with FOP2.

10

That is correct. Anytime a call comes from a queue the no-vm flag is set for the call and that holds forever for the call.

11

Thanks Tony, that makes sense and takes the mystery out of it for me. Is it possible to override that for a specific queue?

12

Actually, I just switched to a ring group. I swear there was a reason I originally configured this as a queue, but as I’m comparing the two - I don’t think it makes much of a difference for this intended purpose.

Thanks to all for the help!