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

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?

can you provide a call trace

Thanks for taking a look, James.

-- Accepting call from '414xxxxxxx' to 'xxxxxxx' on channel 0/22, span 1 -- Executing [[email protected]:1] Set("DAHDI/i1/414xxxxxxx-605", "__FROM_DID=xxxxxxx") in new stack -- Executing [[email protected]:2] Gosub("DAHDI/i1/414xxxxxxx-605", "app-blacklist-check,s,1()") in new stack -- Executing [[email protected]:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?blacklisted") in new stack -- Executing [[email protected]:2] Set("DAHDI/i1/414xxxxxxx-605", "CALLED_BLACKLIST=1") in new stack -- Executing [[email protected]:3] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [[email protected]:3] Set("DAHDI/i1/414xxxxxxx-605", "CDR(did)=xxxxxxx") in new stack -- Executing [[email protected]:4] ExecIf("DAHDI/i1/414xxxxxxx-605", "0 ?Set(CALLERID(name)=414xxxxxxx)") in new stack -- Executing [[email protected]:5] Set("DAHDI/i1/414xxxxxxx-605", "CHANNEL(musicclass)=default") in new stack -- Executing [[email protected]:6] Set("DAHDI/i1/414xxxxxxx-605", "__MOHCLASS=default") in new stack -- Executing [[email protected]:7] Set("DAHDI/i1/414xxxxxxx-605", "__CALLINGPRES_SV=allowed") in new stack -- Executing [[email protected]:8] Set("DAHDI/i1/414xxxxxxx-605", "CALLERPRES()=allowed_not_screened") in new stack -- Executing [[email protected]:9] Goto("DAHDI/i1/414xxxxxxx-605", "app-daynight,0,1") in new stack -- Goto (app-daynight,0,1) -- Executing [[email protected]:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?timeconditions,4,1:timeconditions,1,1") in new stack -- Goto (timeconditions,1,1) -- Executing [[email protected]:1] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "16:50-23:59,mon-thu,*,*?truestate") in new stack -- Executing [[email protected]:2] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "16:00-23:59,fri,*,*?truestate") in new stack -- Executing [[email protected]:3] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "00:00-23:59,sat-sun,*,*?truestate") in new stack -- Executing [[email protected]:4] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "00:00-08:30,mon-fri,*,*?truestate") in new stack -- Executing [[email protected]:5] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "*,*,4,jul?truestate") in new stack -- Executing [[email protected]:6] GotoIfTime("DAHDI/i1/414xxxxxxx-605", "*,*,1,jan?truestate") in new stack -- Executing [[email protected]:7] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?truegoto") in new stack -- Executing [[email protected]:8] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(DB(TC/1)=)") in new stack -- Executing [[email protected]:9] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?ivr-2,s,1") in new stack -- Goto (ivr-2,s,1) -- Executing [[email protected]:1] Set("DAHDI/i1/414xxxxxxx-605", "INVALID_LOOPCOUNT=0") in new stack -- Executing [[email protected]:2] Set("DAHDI/i1/414xxxxxxx-605", "_IVR_CONTEXT_ivr-2=") in new stack -- Executing [[email protected]:3] Set("DAHDI/i1/414xxxxxxx-605", "_IVR_CONTEXT=ivr-2") in new stack -- Executing [[email protected]:4] Set("DAHDI/i1/414xxxxxxx-605", "__IVR_RETVM=") in new stack -- Executing [[email protected]:5] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?skip") in new stack -- Executing [[email protected]:6] Answer("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [[email protected]:7] Wait("DAHDI/i1/414xxxxxxx-605", "1") in new stack -- Executing [[email protected]:8] Set("DAHDI/i1/414xxxxxxx-605", "IVR_MSG=custom/thank-you-for-calling-karen-mp3") in new stack -- Executing [[email protected]:9] Set("DAHDI/i1/414xxxxxxx-605", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [[email protected]: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 [[email protected]:11] WaitExten("DAHDI/i1/414xxxxxxx-605", "1,") in new stack -- Timeout on DAHDI/i1/414xxxxxxx-605, going to 't' -- Executing [[email protected]:1] Goto("DAHDI/i1/414xxxxxxx-605", "ext-queues,1000,1") in new stack -- Goto (ext-queues,1000,1) -- Executing [[email protected]:1] Macro("DAHDI/i1/414xxxxxxx-605", "user-callerid,") in new stack -- Executing [[email protected]:1] Set("DAHDI/i1/414xxxxxxx-605", "TOUCH_MONITOR=1401983519.5614") in new stack -- Executing [[email protected]:2] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSER=414xxxxxxx") in new stack -- Executing [[email protected]:3] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?report") in new stack -- Executing [[email protected]:4] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [[email protected]:5] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSER=") in new stack -- Executing [[email protected]:6] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?limit") in new stack -- Executing [[email protected]:7] Set("DAHDI/i1/414xxxxxxx-605", "AMPUSERCIDNAME=") in new stack -- Executing [[email protected]:8] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?report") in new stack -- Goto (macro-user-callerid,s,16) -- Executing [[email protected]:16] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?continue") in new stack -- Executing [[email protected]:17] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack -- Executing [[email protected]:18] Set("DAHDI/i1/414xxxxxxx-605", "__TTL=64") in new stack -- Executing [[email protected]:19] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [[email protected]:30] Set("DAHDI/i1/414xxxxxxx-605", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [[email protected]:31] Set("DAHDI/i1/414xxxxxxx-605", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [[email protected]:32] Set("DAHDI/i1/414xxxxxxx-605", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [[email protected]:33] Set("DAHDI/i1/414xxxxxxx-605", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [[email protected]:34] Set("DAHDI/i1/414xxxxxxx-605", "CHANNEL(language)=en") in new stack -- Executing [[email protected]:2] Answer("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [[email protected]:3] Set("DAHDI/i1/414xxxxxxx-605", "__NODEST=1000") in new stack -- Executing [[email protected]:4] Set("DAHDI/i1/414xxxxxxx-605", "QCIDPP=") in new stack -- Executing [[email protected]:5] Set("DAHDI/i1/414xxxxxxx-605", "VQ_CIDPP=") in new stack -- Executing [[email protected]:6] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Macro(prepend-cid,)") in new stack -- Executing [[email protected]:7] Set("DAHDI/i1/414xxxxxxx-605", "QAINFO=") in new stack -- Executing [[email protected]:8] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AINFO=") in new stack -- Executing [[email protected]:9] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(__ALERT_INFO=)") in new stack -- Executing [[email protected]:10] Set("DAHDI/i1/414xxxxxxx-605", "QJOINMSG=") in new stack -- Executing [[email protected]:11] Set("DAHDI/i1/414xxxxxxx-605", "VQ_JOINMSG=") in new stack -- Executing [[email protected]:12] Set("DAHDI/i1/414xxxxxxx-605", "QMOH=default") in new stack -- Executing [[email protected]:13] Set("DAHDI/i1/414xxxxxxx-605", "VQ_MOH=") in new stack -- Executing [[email protected]:14] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__MOHCLASS=default)") in new stack -- Executing [[email protected]:15] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [[email protected]:16] Set("DAHDI/i1/414xxxxxxx-605", "QRETRY=n") in new stack -- Executing [[email protected]:17] Set("DAHDI/i1/414xxxxxxx-605", "VQ_RETRY=") in new stack -- Executing [[email protected]:18] Set("DAHDI/i1/414xxxxxxx-605", "QOPTIONS=tn") in new stack -- Executing [[email protected]:19] Set("DAHDI/i1/414xxxxxxx-605", "VQ_OPTIONS=") in new stack -- Executing [[email protected]:20] Set("DAHDI/i1/414xxxxxxx-605", "QGOSUB=") in new stack -- Executing [[email protected]:21] Set("DAHDI/i1/414xxxxxxx-605", "VQ_GOSUB=") in new stack -- Executing [[email protected]:22] Set("DAHDI/i1/414xxxxxxx-605", "QAGI=") in new stack -- Executing [[email protected]:23] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AGI=") in new stack -- Executing [[email protected]:24] Set("DAHDI/i1/414xxxxxxx-605", "QRULE=") in new stack -- Executing [[email protected]:25] Set("DAHDI/i1/414xxxxxxx-605", "VQ_RULE=") in new stack -- Executing [[email protected]:26] Set("DAHDI/i1/414xxxxxxx-605", "QPOSITION=") in new stack -- Executing [[email protected]:27] Set("DAHDI/i1/414xxxxxxx-605", "VQ_POSITION=") in new stack -- Executing [[email protected]:28] Set("DAHDI/i1/414xxxxxxx-605", "__MIXMON_FORMAT=wav49") in new stack -- Executing [[email protected]:29] Gosub("DAHDI/i1/414xxxxxxx-605", "sub-record-check,s,1(q,1000,always)") in new stack -- Executing [[email protected]:1] Set("DAHDI/i1/414xxxxxxx-605", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [[email protected]:2] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [[email protected]:7] Set("DAHDI/i1/414xxxxxxx-605", "__MON_FMT=WAV") in new stack -- Executing [[email protected]:8] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?next") in new stack -- Goto (sub-record-check,s,11) -- Executing [[email protected]:11] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Return()") in new stack -- Executing [[email protected]:12] ExecIf("DAHDI/i1/414xxxxxxx-605", "1?Set(__REC_POLICY_MODE=always)") in new stack -- Executing [[email protected]:13] GotoIf("DAHDI/i1/414xxxxxxx-605", "0?q,1") in new stack -- Executing [[email protected]:14] Set("DAHDI/i1/414xxxxxxx-605", "__REC_STATUS=INITIALIZED") in new stack -- Executing [[email protected]:15] Set("DAHDI/i1/414xxxxxxx-605", "NOW=1401983531") in new stack -- Executing [[email protected]:16] Set("DAHDI/i1/414xxxxxxx-605", "__DAY=05") in new stack -- Executing [[email protected]:17] Set("DAHDI/i1/414xxxxxxx-605", "__MONTH=06") in new stack -- Executing [[email protected]:18] Set("DAHDI/i1/414xxxxxxx-605", "__YEAR=2014") in new stack -- Executing [[email protected]:19] Set("DAHDI/i1/414xxxxxxx-605", "__TIMESTR=20140605-105211") in new stack -- Executing [[email protected]:20] Set("DAHDI/i1/414xxxxxxx-605", "__FROMEXTEN=414xxxxxxx") in new stack -- Executing [[email protected]:21] Set("DAHDI/i1/414xxxxxxx-605", "__CALLFILENAME=q-1000-414xxxxxxx-20140605-105211-1401983519.5614") in new stack -- Executing [[email protected]:22] Goto("DAHDI/i1/414xxxxxxx-605", "q,1") in new stack -- Goto (sub-record-check,q,1) -- Executing [[email protected]:1] GosubIf("DAHDI/i1/414xxxxxxx-605", "1?recq,1(q,1000,414xxxxxxx)") in new stack -- Executing [[email protected]:1] Set("DAHDI/i1/414xxxxxxx-605", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack -- Executing [[email protected]:2] Set("DAHDI/i1/414xxxxxxx-605", "MONITOR_FILENAME=2014/06/05/q-1000-414xxxxxxx-20140605-105211-1401983519.5614") in new stack -- Executing [[email protected]:3] MixMonitor("DAHDI/i1/414xxxxxxx-605", "2014/06/05/q-1000-414xxxxxxx-20140605-105211-1401983519.5614.wav49,,") in new stack -- Executing [[email protected]:4] Set("DAHDI/i1/414xxxxxxx-605", "__REC_STATUS=RECORDING") in new stack == Begin MixMonitor Recording DAHDI/i1/414xxxxxxx-605 -- Executing [[email protected]:5] Set("DAHDI/i1/414xxxxxxx-605", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [[email protected]:6] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [[email protected]:2] Return("DAHDI/i1/414xxxxxxx-605", "") in new stack -- Executing [10[email protected]:30] Set("DAHDI/i1/414xxxxxxx-605", "__CFIGNORE=TRUE") in new stack -- Executing [[email protected]:31] Set("DAHDI/i1/414xxxxxxx-605", "__FORWARD_CONTEXT=block-cf") in new stack -- Executing [[email protected]:32] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Playback(, )") in new stack -- Executing [[email protected]:33] QueueLog("DAHDI/i1/414xxxxxxx-605", "1000,1401983519.5614,NONE,DID,xxxxxxx") in new stack -- Executing [[email protected]:34] Set("DAHDI/i1/414xxxxxxx-605", "QAANNOUNCE=") in new stack -- Executing [[email protected]:35] Set("DAHDI/i1/414xxxxxxx-605", "VQ_AANNOUNCE=") in new stack -- Executing [[email protected]:36] Set("DAHDI/i1/414xxxxxxx-605", "QMAXWAIT=120") in new stack -- Executing [[email protected]:37] Set("DAHDI/i1/414xxxxxxx-605", "VQ_MAXWAIT=") in new stack -- Executing [[email protected]: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/[email protected]/n -- Executing [[email protected]:1] Set("Local/[email protected];2", "QAGENT=4800") in new stack -- Executing [[email protected]:2] Goto("Local/[email protected];2", "1000,1") in new stack -- Goto (from-queue,1000,1) -- Executing [[email protected]:1] Goto("Local/[email protected];2", "from-queue-exten-only,4800,1") in new stack -- Goto (from-queue-exten-only,4800,1) -- Executing [[email protected]:1] Set("Local/[email protected];2", "RingGroupMethod=none") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "QDOPTS=") in new stack -- Executing [[email protected]:3] Gosub("Local/[email protected];2", "sub-record-check,s,1(exten,4800)") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [[email protected]:2] GotoIf("Local/[email protected];2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [[email protected]:7] Set("Local/[email protected];2", "__MON_FMT=WAV") in new stack -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "0?next") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [[email protected]:10] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:4] Macro("Local/[email protected];2", "dial-one,,trx,4800") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DEXTEN=4800") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "DIALSTATUS_CW=") in new stack -- Executing [[email protected]:3] GosubIf("Local/[email protected];2", "0?screen,1()") in new stack -- Executing [[email protected]:4] GosubIf("Local/[email protected];2", "0?cf,1()") in new stack -- Executing [[email protected]:5] GotoIf("Local/[email protected];2", "1?skip1") in new stack -- Goto (macro-dial-one,s,8) -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "0?continue") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "EXTHASCW=") in new stack -- Executing [[email protected]:11] GotoIf("Local/[email protected];2", "1?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,12) -- Executing [[email protected]:12] GotoIf("Local/[email protected];2", "0?docfu:skip3") in new stack -- Goto (macro-dial-one,s,16) -- Executing [[email protected]:16] GotoIf("Local/[email protected];2", "1?next2:continue") in new stack -- Goto (macro-dial-one,s,17) -- Executing [[email protected]:17] GotoIf("Local/[email protected];2", "1?continue") in new stack -- Goto (macro-dial-one,s,25) -- Executing [[email protected]dial-one:25] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:26] GosubIf("Local/[email protected];2", "1?dstring,1():dlocal,1()") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DSTRING=") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "DEVICES=4800") in new stack -- Executing [[email protected]:3] ExecIf("Local/[email protected];2", "0?Return()") in new stack -- Executing [[email protected]:4] ExecIf("Local/[email protected];2", "0?Set(DEVICES=800)") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "LOOPCNT=1") in new stack -- Executing [[email protected]:6] Set("Local/[email protected];2", "ITER=1") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "THISDIAL=SIP/4800") in new stack -- Executing [[email protected]:8] GosubIf("Local/[email protected];2", "1?zap2dahdi,1()") in new stack -- Executing [[email protected]:1] ExecIf("Local/[email protected];2", "0?Return()") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "NEWDIAL=") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];2", "LOOPCNT2=1") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "ITER2=1") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "THISPART2=SIP/4800") in new stack -- Executing [[email protected]:6] ExecIf("Local/[email protected];2", "0?Set(THISPART2=DAHDI/4800)") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "NEWDIAL=SIP/4800&") in new stack -- Executing [[email protected]:8] Set("Local/[email protected];2", "ITER2=2") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "0?begin2") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "THISDIAL=SIP/4800") in new stack -- Executing [[email protected]:11] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "DSTRING=SIP/4800&") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "ITER=2") in new stack -- Executing [[email protected]:11] GotoIf("Local/[email protected];2", "0?begin") in new stack -- Executing [[email protected]:12] Set("Local/[email protected];2", "DSTRING=SIP/4800") in new stack -- Executing [[email protected]:13] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:27] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:28] GotoIf("Local/[email protected];2", "0?skiptrace") in new stack -- Executing [[email protected]:29] GosubIf("Local/[email protected];2", "1?ctset,1():ctclear,1()") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DB(CALLTRACE/4800)=414xxxxxxx") in new stack -- Executing [[email protected]:2] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:30] Set("Local/[email protected];2", "D_OPTIONS=trxM(auto-blkvm)") in new stack -- Executing [[email protected]:31] ExecIf("Local/[email protected];2", "0?SIPAddHeader(Alert-Info: )") in new stack -- Executing [[email protected]:32] ExecIf("Local/[email protected];2", "0?SIPAddHeader()") in new stack -- Executing [[email protected]:33] ExecIf("Local/[email protected];2", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [[email protected]:34] GosubIf("Local/[email protected];2", "0?qwait,1()") in new stack -- Executing [[email protected]:35] Set("Local/[email protected];2", "__CWIGNORE=") in new stack -- Executing [[email protected]:36] Set("Local/[email protected];2", "__KEEPCID=TRUE") in new stack -- Executing [[email protected]:37] GotoIf("Local/[email protected];2", "0?usegoto,1") in new stack -- Executing [[email protected]:38] GotoIf("Local/[email protected];2", "1?godial") in new stack -- Goto (macro-dial-one,s,43) -- Executing [[email protected]:43] Dial("Local/[email protected];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/[email protected];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/[email protected];1 is ringing -- SIP/4800-00000991 answered Local/[email protected];2 -- Executing [[email protected]:1] Set("SIP/4800-00000991", "__MACRO_RESULT=") in new stack -- Executing [[email protected]:2] Set("SIP/4800-00000991", "CFIGNORE=") in new stack -- Executing [[email protected]:3] Set("SIP/4800-00000991", "MASTER_CHANNEL(CFIGNORE)=") in new stack -- Executing [[email protected]:4] Set("SIP/4800-00000991", "FORWARD_CONTEXT=from-internal") in new stack -- Executing [[email protected]:5] Set("SIP/4800-00000991", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack -- Executing [[email protected]:6] Macro("SIP/4800-00000991", "blkvm-clr,") in new stack -- Executing [[email protected]:1] Set("SIP/4800-00000991", "SHARED(BLKVM,)=") in new stack -- Executing [[email protected]:2] Set("SIP/4800-00000991", "GOSUB_RETVAL=") in new stack -- Executing [[email protected]:3] MacroExit("SIP/4800-00000991", "") in new stack -- Executing [[email protected]: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 [[email protected]: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/[email protected];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/[email protected];2' in macro 'dial-one' == Spawn extension (from-internal, 4805, 1) exited non-zero on 'Local/[email protected];2' -- Executing [[email protected]:1] GotoIf("Local/[email protected];2", "0?ext-local,4805,1") in new stack -- Executing [[email protected]:2] Macro("Local/[email protected];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 [[email protected]:1] Set("Local/[email protected];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 [[email protected]:2] Set("Local/[email protected];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 [[email protected]:3] GotoIf("Local/[email protected];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 [[email protected]:16] GotoIf("Local/[email protected];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 [[email protected]:17] ExecIf("Local/[email protected];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 [[email protected]:18] Set("Local/[email protected];2", "__TTL=63") in new stack -- Executing [[email protected]:19] GotoIf("Local/[email protected];2", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [[email protected]:30] Set("Local/[email protected];2", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [[email protected]:31] Set("Local/[email protected];2", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [[email protected]:32] Set("Local/[email protected];2", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [[email protected]:33] Set("Local/[email protected];2", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [[email protected]:34] Set("Local/[email protected];2", "CHANNEL(language)=en") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];2", "DIAL_OPTIONS=trxI") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "CONNECTEDLINE(num)=4805") in new stack -- Executing [[email protected]:5] Gosub("Local/[email protected];2", "sub-presencestate-display,s,1(4805)") in new stack -- Executing [[email protected]:1] Goto("Local/[email protected];2", "state-available,1") in new stack -- Goto (sub-presencestate-display,state-available,1) -- Executing [[email protected]:1] Set("Local/[email protected];2", "PRESENCESTATE_DISPLAY=(Available)") in new stack -- Executing [[email protected]:2] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:6] Set("Local/[email protected];2", "CONNECTEDLINE(name,i)=Brendt Johannsen(Available)") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "FM_DIALSTATUS=NOT_INUSE") in new stack -- Executing [[email protected]:8] Set("Local/[email protected];2", "__EXTTOCALL=4805") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "__PICKUPMARK=4805") in new stack -- Executing [[email protected]:10] Macro("Local/[email protected];2", "blkvm-setifempty,") in new stack -- Executing [[email protected]:1] GotoIf("Local/[email protected];2", "1?init") in new stack -- Goto (macro-blkvm-setifempty,s,4) -- Executing [[email protected]:4] Set("Local/[email protected];2", "__BLKVM_CHANNEL=Local/[email protected];2") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "SHARED(BLKVM,Local/[email protected];2)=TRUE") in new stack -- Executing [[email protected]:6] Set("Local/[email protected];2", "GOSUB_RETVAL=TRUE") in new stack -- Executing [[email protected]:7] MacroExit("Local/[email protected];2", "") in new stack -- Executing [[email protected]:11] GotoIf("Local/[email protected];2", "1?skipov") in new stack -- Goto (from-internal,4805,14) -- Executing [[email protected]:14] Set("Local/[email protected];2", "RRNODEST=1000") in new stack -- Executing [[email protected]:15] Set("Local/[email protected];2", "__NODEST=4805") in new stack -- Executing [[email protected]:16] GosubIf("Local/[email protected];2", "0?sub-fmsetcid,s,1()") in new stack -- Executing [[email protected]:17] Set("Local/[email protected];2", "RecordMethod=Group") in new stack -- Executing [[email protected]:18] Gosub("Local/[email protected];2", "sub-record-check,s,1(exten,4805,)") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [[email protected]:2] GotoIf("Local/[email protected];2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [[email protected]:7] Set("Local/[email protected];2", "__MON_FMT=WAV") in new stack -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "0?next") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [[email protected]:10] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:19] Set("Local/[email protected];2", "RingGroupMethod=ringallv2") in new stack -- Executing [[email protected]:20] Set("Local/[email protected];2", "_FMGRP=4805") in new stack -- Executing [[email protected]:21] GotoIf("Local/[email protected];2", "0?doconfirm") in new stack -- Executing [[email protected]:22] Macro("Local/[email protected];2", "dial,24,trxI,4805-91262xxxxxxx#") in new stack -- Executing [[email protected]:1] GotoIf("Local/[email protected];2", "0?dial") in new stack -- Executing [[email protected]:2] SetMusicOnHold("Local/[email protected];2", "default") in new stack -- Executing [[email protected]:3] AGI("Local/[email protected];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 [[email protected]:7] Dial("Local/[email protected];2", "Local/[email protected]&Local/FMGL-91262xxxxxxx#@from-internal,24,trxIM(auto-blkvm)") in new stack -- Called Local/[email protected] -- Executing [[email protected]:1] NoCDR("Local/[email protected];2", "") in new stack -- Called Local/FMGL-91262xxxxxxx#@from-internal -- Executing [[email protected]:2] Set("Local/[email protected];2", "RingGroupMethod=") in new stack -- Executing [FMGL-91262xxxxxxx#@from-internal:1] NoCDR("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];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 [[email protected]:4] Set("Local/[email protected];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 [[email protected]:5] Macro("Local/[email protected];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 [[email protected]:1] Set("Local/[email protected];2", "__EXTTOCALL=4805") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "RT=24") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];2", "CFUEXT=") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "CFBEXT=") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "CWI_TMP=") in new stack -- Executing [[email protected]:6] Macro("Local/[email protected];2", "dial-one,24,trx,4805") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DEXTEN=4805") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "DIALSTATUS_CW=") in new stack -- Executing [[email protected]:3] GosubIf("Local/[email protected];2", "0?screen,1()") in new stack -- Executing [[email protected]:4] GosubIf("Local/[email protected];2", "0?cf,1()") in new stack -- Executing [[email protected]:5] GotoIf("Local/[email protected];2", "1?skip1") in new stack -- Goto (macro-dial-one,s,8) -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "0?continue") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "EXTHASCW=ENABLED") in new stack -- Executing [[email protected]:11] GotoIf("Local/[email protected];2", "0?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,23) -- Executing [[email protected]:23] GotoIf("Local/[email protected];2", "1?next3:continue") in new stack -- Goto (macro-dial-one,s,24) -- Executing [[email protected]:24] ExecIf("Local/[email protected];2", "0?Set(DIALSTATUS_CW=BUSY)") in new stack -- Executing [[email protected]:25] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:26] GosubIf("Local/[email protected];2", "1?dstring,1():dlocal,1()") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DSTRING=") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "DEVICES=4805") in new stack -- Executing [[email protected]:3] ExecIf("Local/[email protected];2", "0?Return()") in new stack -- Executing [[email protected]:4] ExecIf("Local/[email protected];2", "0?Set(DEVICES=805)") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "LOOPCNT=1") in new stack -- Executing [[email protected]:6] Set("Local/[email protected];2", "ITER=1") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "THISDIAL=SIP/4805") in new stack -- Executing [[email protected]:8] GosubIf("Local/[email protected];2", "1?zap2dahdi,1()") in new stack -- Executing [[email protected]:1] ExecIf("Local/[email protected];2", "0?Return()") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "NEWDIAL=") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];2", "LOOPCNT2=1") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "ITER2=1") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "THISPART2=SIP/4805") in new stack -- Executing [[email protected]:6] ExecIf("Local/[email protected];2", "0?Set(THISPART2=DAHDI/4805)") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "NEWDIAL=SIP/4805&") in new stack -- Executing [[email protected]:8] Set("Local/[email protected];2", "ITER2=2") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "0?begin2") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "THISDIAL=SIP/4805") in new stack -- Executing [[email protected]:11] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "DSTRING=SIP/4805&") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "ITER=2") in new stack -- Executing [[email protected]:11] GotoIf("Local/[email protected];2", "0?begin") in new stack -- Executing [[email protected]:12] Set("Local/[email protected];2", "DSTRING=SIP/4805") in new stack -- Executing [[email protected]:13] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:27] GotoIf("Local/[email protected];2", "0?nodial") in new stack -- Executing [[email protected]:28] GotoIf("Local/[email protected];2", "0?skiptrace") in new stack -- Executing [[email protected]:29] GosubIf("Local/[email protected];2", "1?ctset,1():ctclear,1()") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DB(CALLTRACE/4805)=414xxxxxxx") in new stack -- Executing [[email protected]:2] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:30] Set("Local/[email protected];2", "D_OPTIONS=trxM(auto-blkvm)") in new stack -- Executing [[email protected]:31] ExecIf("Local/[email protected];2", "0?SIPAddHeader(Alert-Info: )") in new stack -- Executing [[email protected]:32] ExecIf("Local/[email protected]-internal-8235;2", "0?SIPAddHeader()") in new stack -- Executing [[email protected]:33] ExecIf("Local/[email protected];2", "1?Set(CHANNEL(musicclass)=default)") in new stack -- Executing [[email protected]:34] GosubIf("Local/[email protected];2", "0?qwait,1()") in new stack -- Executing [[email protected]:35] Set("Local/[email protected];2", "__CWIGNORE=") in new stack -- Executing [[email protected]:36] Set("Local/[email protected];2", "__KEEPCID=TRUE") in new stack -- Executing [[email protected]:37] GotoIf("Local/[email protected];2", "0?usegoto,1") in new stack -- Executing [[email protected]:38] GotoIf("Local/[email protected];2", "1?godial") in new stack -- Goto (macro-dial-one,s,43) -- Executing [[email protected]:43] Dial("Local/[email protected];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/[email protected];1 is ringing -- Connected line update to Local/[email protected];2 prevented. -- Connected line update to Local/[email protected];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/[email protected];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/[email protected];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 [[email protected]:1] GotoIf("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "0?dial") in new stack -- Executing [[email protected]:2] SetMusicOnHold("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "default") in new stack -- Executing [[email protected]: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 [[email protected]:7] Dial("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "Local/[email protected]/n,20,trxM(auto-blkvm)") in new stack -- Called Local/[email protected]/n -- Local/FMGL-91262xxxxxxx#@from-internal-9096;1 is ringing -- Executing [[email protected]:1] Macro("Local/[email protected];2", "user-callerid,LIMIT,EXTERNAL,") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "TOUCH_MONITOR=1401983552.5624") in new stack -- Executing [[email protected]:2] Set("Local/[email protected];2", "AMPUSER=414xxxxxxx") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected];2", "0?report") in new stack -- Executing [[email protected]:4] ExecIf("Local/[email protected];2", "1?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "AMPUSER=") in new stack -- Executing [[email protected]:6] GotoIf("Local/[email protected];2", "0?limit") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "AMPUSERCIDNAME=") in new stack -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "1?report") in new stack -- Goto (macro-user-callerid,s,16) -- Executing [[email protected]:16] GotoIf("Local/[email protected];2", "1?continue") in new stack -- Goto (macro-user-callerid,s,30) -- Executing [[email protected]:30] Set("Local/[email protected];2", "CALLERID(number)=414xxxxxxx") in new stack -- Executing [[email protected]:31] Set("Local/[email protected];2", "CALLERID(name)=WIRELESS CALLER") in new stack -- Executing [[email protected]:32] Set("Local/[email protected];2", "CDR(cnum)=414xxxxxxx") in new stack -- Executing [[email protected]:33] Set("Local/9126[email protected];2", "CDR(cnam)=WIRELESS CALLER") in new stack -- Executing [[email protected]:34] Set("Local/[email protected];2", "CHANNEL(language)=en") in new stack -- Executing [[email protected]:2] ExecIf("Local/[email protected];2", "0 ?Set(CDR(accountcode)=)") in new stack -- Executing [[email protected]:3] Set("Local/[email protected];2", "_NODEST=") in new stack -- Executing [[email protected]:4] Gosub("Local/[email protected];2", "sub-record-check,s,1(out,91262xxxxxxx,)") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "REC_POLICY_MODE_SAVE=always") in new stack -- Executing [[email protected]:2] GotoIf("Local/[email protected];2", "1?check") in new stack -- Goto (sub-record-check,s,7) -- Executing [[email protected]:7] Set("Local/[email protected];2", "__MON_FMT=WAV") in new stack -- Executing [[email protected]:8] GotoIf("Local/[email protected];2", "0?next") in new stack -- Executing [[email protected]:9] Set("Local/[email protected];2", "CDR(recordingfile)=q-1000-414xxxxxxx-20140605-105211-1401983519.5614.WAV") in new stack -- Executing [[email protected]:10] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:5] Macro("Local/[email protected];2", "dialout-trunk,1,1262xxxxxxx,,off") in new stack -- Executing [[email protected]:1] Set("Local/[email protected];2", "DIAL_TRUNK=1") in new stack -- Executing [[email protected]:2] GosubIf("Local/[email protected];2", "0?sub-pincheck,s,1()") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected];2", "0?disabletrunk,1") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "DIAL_NUMBER=1262xxxxxxx") in new stack -- Executing [[email protected]:5] Set("Local/[email protected];2", "DIAL_TRUNK_OPTIONS=trx") in new stack -- Executing [[email protected]:6] Set("Local/[email protected];2", "OUTBOUND_GROUP=OUT_1") in new stack -- Executing [[email protected]:7] GotoIf("Local/[email protected];2", "1?nomax") in new stack -- Goto (macro-dialout-trunk,s,9) -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "0?skipoutcid") in new stack -- Executing [[email protected]:10] Set("Local/[email protected];2", "DIAL_TRUNK_OPTIONS=") in new stack -- Executing [[email protected]:11] Macro("Local/[email protected];2", "outbound-callerid,1") in new stack -- Executing [[email protected]:1] ExecIf("Local/[email protected];2", "1?Set(CALLERPRES()=allowed)") in new stack -- Executing [[email protected]:2] ExecIf("Local/[email protected];2", "0?Set(REALCALLERIDNUM=414xxxxxxx)") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected];2", "0?normcid") in new stack -- Executing [[email protected]:4] Set("Local/[email protected];2", "USEROUTCID=414xxxxxxx") in new stack -- Executing [[email protected]:5] GotoIf("Local/[email protected];2", "1?bypass") in new stack -- Goto (macro-outbound-callerid,s,7) -- Executing [[email protected]:7] Set("Local/[email protected];2", "EMERGENCYCID=") in new stack -- Executing [[email protected]:8] Set("Local/[email protected];2", "TRUNKOUTCID=xxx-xxx-xxxx") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected];2", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,14) -- Executing [[email protected]:14] ExecIf("Local/[email protected];2", "1?Set(CALLERID(all)=xxx-xxx-xxxx)") in new stack -- Executing [[email protected]:15] ExecIf("Local/[email protected];2", "1?Set(CALLERID(all)=414xxxxxxx)") in new stack -- Executing [[email protected]:16] ExecIf("Local/[email protected];2", "0?Set(CALLERID(all)=)") in new stack -- Executing [[email protected]:17] ExecIf("Local/[email protected];2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack -- Executing [[email protected]:18] Set("Local/[email protected];2", "CDR(outbound_cnum)=414xxxxxxx") in new stack -- Executing [[email protected]:19] Set("Local/[email protected];2", "CDR(outbound_cnam)=") in new stack -- Executing [[email protected]:12] GosubIf("Local/[email protected];2", "1?sub-flp-1,s,1()") in new stack -- Executing [[email protected]:1] ExecIf("Local/[email protected];2", "0?Set(TARGET_FLP_1=xxxxxxx)") in new stack -- Executing [[email protected]:2] GotoIf("Local/[email protected];2", "0?match") in new stack -- Executing [[email protected]:3] Return("Local/[email protected];2", "") in new stack -- Executing [[email protected]:13] Set("Local/[email protected];2", "OUTNUM=1262xxxxxxx") in new stack -- Executing [[email protected]:14] Set("Local/[email protected];2", "custom=DAHDI/g0") in new stack -- Executing [[email protected]:15] ExecIf("Local/[email protected];2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack -- Executing [[email protected]:16] ExecIf("Local/[email protected];2", "0?Set(DIAL_TRUNK_OPTIONS=M(confirm))") in new stack -- Executing [[email protected]:17] Macro("Local/[email protected];2", "dialout-trunk-predial-hook,") in new stack -- Executing [[email protected]:1] MacroExit("Local/[email protected];2", "") in new stack -- Executing [[email protected]:18] GotoIf("Local/[email protected];2", "0?bypass,1") in new stack -- Executing [[email protected]:19] ExecIf("Local/[email protected];2", "0?Set(CONNECTEDLINE(num,i)=1262xxxxxxx)") in new stack -- Executing [[email protected]:20] ExecIf("Local/[email protected];2", "0?Set(CONNECTEDLINE(name,i)=CID:414xxxxxxx)") in new stack -- Executing [[email protected]:21] GotoIf("Local/[email protected];2", "0?customtrunk") in new stack -- Executing [[email protected]:22] Dial("Local/[email protected];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/[email protected];2 -- Local/[email protected];1 is proceeding passing it to Local/FMGL-91262xxxxxxx#@from-internal-9096;2 -- DAHDI/i1/1262xxxxxxx-606 is making progress passing it to Local/[email protected];2 -- Local/[email protected];1 is making progress passing it to Local/FMGL-91262xxxxxxx#@from-internal-9096;2 -- DAHDI/i1/1262xxxxxxx-606 is ringing -- Local/[email protected];1 is ringing -- Local/FMGL-91262xxxxxxx#@from-internal-9096;1 is ringing -- Nobody picked up in 24000 ms -- Executing [[email protected]:44] ExecIf("Local/[email protected];2", "0?MacroExit()") in new stack -- Executing [[email protected]:45] ExecIf("Local/[email protected];2", "0?Set(DIALSTATUS=)") in new stack -- Executing [[email protected]:46] GosubIf("Local/[email protected];2", "0?s-NOANSWER,1()") in new stack -- Executing [[email protected]:47] MacroExit("Local/[email protected];2", "") in new stack -- Executing [[email protected]:7] Set("Local/[email protected];2", "__CWIGNORE=") in new stack -- Executing [[email protected]:8] Set("Local/[email protected];2", "PR_DIALSTATUS=NOANSWER") in new stack -- Executing [[email protected]:9] GosubIf("Local/[email protected];2", "0?docfu,1()") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4827 -- Executing [[email protected]:10] GosubIf("Local/[email protected];2", "0?docfb,1()") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4829 -- Executing [[email protected]:11] Set("Local/[email protected];2", "DIALSTATUS=NOANSWER") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4825 -- Executing [[email protected]:12] Goto("Local/[email protected];2", "s-NOANSWER,1") in new stack -- Goto (macro-simple-dial,s-NOANSWER,1) -- Executing [[email protected]:1] NoOp("Local/[email protected];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 [[email protected]:6] ExecIf("Local/[email protected];2", "0?Set(SHARED(FM_DND,Local/[email protected];2)=DND)") in new stack == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4803 -- Executing [[email protected]:7] Hangup("Local/[email protected];2", "") in new stack == Spawn extension (from-internal, FMPR-4805, 7) exited non-zero on 'Local/[email protected];2' == Extension Changed auto_hint_4805[from-internal] new state Idle for Notify User 4816 -- Executing [[email protected]:1] Hangup("Local/[email protected];2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/[email protected];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 [[email protected]:8] Set("Local/[email protected];2", "DIALSTATUS=NOANSWER") in new stack -- Executing [[email protected]:9] GosubIf("Local/[email protected];2", "0?NOANSWER,1") in new stack -- Executing [[email protected]:23] Goto("Local/[email protected];2", "nextstep") in new stack -- Goto (from-internal,4805,25) -- Hungup 'DAHDI/i1/1262xxxxxxx-606' -- Executing [[email protected]:25] Set("Local/[email protected]om-queue-004c;2", "RingGroupMethod=") in new stack == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'Local/[email protected];2' in macro 'dialout-trunk' == Spawn extension (from-internal, 91262xxxxxxx, 5) exited non-zero on 'Local/[email protected];2' -- Executing [[email protected]:26] GotoIf("Local/[email protected];2", "1?nodest") in new stack -- Executing [[email protected]:1] Hangup("Local/[email protected];2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/[email protected];2' -- Goto (from-internal,4805,32) -- Executing [[email protected]:32] NoOp("Local/[email protected];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/[email protected];2' status is 'NOANSWER' -- Executing [[email protected]:1] Hangup("Local/[email protected];2", "") in new stack -- Executing [[email protected]:1] Hangup("Local/FMGL-91262xxxxxxx#@from-internal-9096;2", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/[email protected];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 [[email protected]:1] Macro("DAHDI/i1/414xxxxxxx-605", "hangupcall,") in new stack -- Executing [[email protected]:1] GotoIf("DAHDI/i1/414xxxxxxx-605", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [[email protected]:3] ExecIf("DAHDI/i1/414xxxxxxx-605", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [[email protected]: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

Anyone else having this issue?

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

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.

is this done from a queue call?

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

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

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.

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

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!