Return to IVR after VM time ringging

Hello, I’m configured the return to IVR after VM. The extentions do not have any VM, so it is supposed to go back to the IVR inmediatly after the ring time expires. It is working, the problem is that the default time is 15 seconds but its taking 60 seconds to play the sound and go back to the IVR. I need to lower that time. How can I?

Here the logs for my call

-- Executing [8092427047@from-trunk-sip-to-claro:1] Set("SIP/to-claro-00002172", "GROUP()=OUT_4") in new stack
-- Executing [8092427047@from-trunk-sip-to-claro:2] Goto("SIP/to-claro-00002172", "from-trunk,8092427047,1") in new stack
-- Goto (from-trunk,8092427047,1)
-- Executing [8092427047@from-trunk:1] NoOp("SIP/to-claro-00002172", "Catch-All DID Match - Found 8092427047 - You probably want a DID for this.") in new stack
-- Executing [8092427047@from-trunk:2] Set("SIP/to-claro-00002172", "__FROM_DID=8092427047") in new stack
-- Executing [8092427047@from-trunk:3] Goto("SIP/to-claro-00002172", "ext-did,s,1") in new stack
-- Goto (ext-did,s,1)
-- Executing [s@ext-did:1] ExecIf("SIP/to-claro-00002172", "0?Set(__FROM_DID=s)") in new stack
-- Executing [s@ext-did:2] Gosub("SIP/to-claro-00002172", "app-blacklist-check,s,1()") in new stack
-- Executing [s@app-blacklist-check:1] GotoIf("SIP/to-claro-00002172", "0?blacklisted") in new stack
-- Executing [s@app-blacklist-check:2] Set("SIP/to-claro-00002172", "CALLED_BLACKLIST=1") in new stack
-- Executing [s@app-blacklist-check:3] Return("SIP/to-claro-00002172", "") in new stack
-- Executing [s@ext-did:3] Set("SIP/to-claro-00002172", "CDR(did)=8092427047") in new stack
-- Executing [s@ext-did:4] ExecIf("SIP/to-claro-00002172", "1 ?Set(CALLERID(name)=8498865770)") in new stack
-- Executing [s@ext-did:5] Set("SIP/to-claro-00002172", "CHANNEL(musicclass)=default") in new stack
-- Executing [s@ext-did:6] Set("SIP/to-claro-00002172", "__MOHCLASS=default") in new stack
-- Executing [s@ext-did:7] Set("SIP/to-claro-00002172", "__CALLINGPRES_SV=allowed_not_screened") in new stack
-- Executing [s@ext-did:8] Set("SIP/to-claro-00002172", "CALLERPRES()=allowed_not_screened") in new stack
-- Executing [s@ext-did:9] Goto("SIP/to-claro-00002172", "ivr-4,s,1") in new stack
-- Goto (ivr-4,s,1)
-- Executing [s@ivr-4:1] Set("SIP/to-claro-00002172", "_IVR_CONTEXT_ivr-4=") in new stack
-- Executing [s@ivr-4:2] Set("SIP/to-claro-00002172", "_IVR_CONTEXT=ivr-4") in new stack
-- Executing [s@ivr-4:3] Set("SIP/to-claro-00002172", "__IVR_RETVM=RETURN") in new stack
-- Executing [s@ivr-4:4] GotoIf("SIP/to-claro-00002172", "0?skip") in new stack
-- Executing [s@ivr-4:5] Answer("SIP/to-claro-00002172", "") in new stack
   > 0x7fc4d413af10 -- Probation passed - setting RTP source address to 172.31.21.254:43344
-- Executing [s@ivr-4:6] Wait("SIP/to-claro-00002172", "1") in new stack
-- Executing [s@ivr-4:7] Set("SIP/to-claro-00002172", "IVR_MSG=custom/IVR2") in new stack
-- Executing [s@ivr-4:8] Set("SIP/to-claro-00002172", "TIMEOUT(digit)=3") in new stack
-- Digit timeout set to 3.000
-- Executing [s@ivr-4:9] ExecIf("SIP/to-claro-00002172", "1?Background(custom/IVR2)") in new stack
-- <SIP/to-claro-00002172> Playing 'custom/IVR2.slin' (language 'es')
== CDR updated on SIP/to-claro-00002172
-- Executing [2104@ivr-4:1] Macro("SIP/to-claro-00002172", "blkvm-clr,") in new stack
-- Executing [s@macro-blkvm-clr:1] Set("SIP/to-claro-00002172", "SHARED(BLKVM,)=") in new stack
-- Executing [s@macro-blkvm-clr:2] Set("SIP/to-claro-00002172", "GOSUB_RETVAL=") in new stack
-- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/to-claro-00002172", "") in new stack
-- Executing [2104@ivr-4:2] Set("SIP/to-claro-00002172", "__NODEST=") in new stack
-- Executing [2104@ivr-4:3] Goto("SIP/to-claro-00002172", "from-did-direct,2104,1") in new stack
-- Goto (from-did-direct,2104,1)
-- Executing [2104@from-did-direct:1] Set("SIP/to-claro-00002172", "__RINGTIMER=15") in new stack
-- Executing [2104@from-did-direct:2] Macro("SIP/to-claro-00002172", "exten-vm,novm,2104,0,0,0") in new stack
-- Executing [s@macro-exten-vm:1] Macro("SIP/to-claro-00002172", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/to-claro-00002172", "TOUCH_MONITOR=1492788079.9489") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/to-claro-00002172", "AMPUSER=8498865770") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("SIP/to-claro-00002172", "0?report") in new stack
-- Executing [s@macro-user-callerid:4] ExecIf("SIP/to-claro-00002172", "1?Set(REALCALLERIDNUM=8498865770)") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/to-claro-00002172", "AMPUSER=") in new stack
-- Executing [s@macro-user-callerid:6] GotoIf("SIP/to-claro-00002172", "0?limit") in new stack
-- Executing [s@macro-user-callerid:7] Set("SIP/to-claro-00002172", "AMPUSERCIDNAME=") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/to-claro-00002172", "1?report") in new stack
-- Goto (macro-user-callerid,s,15)
-- Executing [s@macro-user-callerid:15] GotoIf("SIP/to-claro-00002172", "0?continue") in new stack
-- Executing [s@macro-user-callerid:16] Set("SIP/to-claro-00002172", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:17] GotoIf("SIP/to-claro-00002172", "1?continue") in new stack
-- Goto (macro-user-callerid,s,28)
-- Executing [s@macro-user-callerid:28] Set("SIP/to-claro-00002172", "CALLERID(number)=8498865770") in new stack
-- Executing [s@macro-user-callerid:29] Set("SIP/to-claro-00002172", "CALLERID(name)=8498865770") in new stack
-- Executing [s@macro-user-callerid:30] Set("SIP/to-claro-00002172", "CDR(cnum)=8498865770") in new stack
-- Executing [s@macro-user-callerid:31] Set("SIP/to-claro-00002172", "CDR(cnam)=8498865770") in new stack
-- Executing [s@macro-user-callerid:32] Set("SIP/to-claro-00002172", "CHANNEL(language)=es") in new stack
-- Executing [s@macro-exten-vm:2] Set("SIP/to-claro-00002172", "RingGroupMethod=none") in new stack
-- Executing [s@macro-exten-vm:3] Set("SIP/to-claro-00002172", "__EXTTOCALL=2104") in new stack
-- Executing [s@macro-exten-vm:4] Set("SIP/to-claro-00002172", "__PICKUPMARK=2104") in new stack
-- Executing [s@macro-exten-vm:5] Set("SIP/to-claro-00002172", "RT=") in new stack
-- Executing [s@macro-exten-vm:6] Gosub("SIP/to-claro-00002172", "sub-record-check,s,1(exten,2104,)") in new stack
-- Executing [s@sub-record-check:1] Set("SIP/to-claro-00002172", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:2] GotoIf("SIP/to-claro-00002172", "1?check") in new stack
-- Goto (sub-record-check,s,7)
-- Executing [s@sub-record-check:7] Set("SIP/to-claro-00002172", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:8] GotoIf("SIP/to-claro-00002172", "1?next") in new stack
-- Goto (sub-record-check,s,11)
-- Executing [s@sub-record-check:11] ExecIf("SIP/to-claro-00002172", "0?Return()") in new stack
-- Executing [s@sub-record-check:12] ExecIf("SIP/to-claro-00002172", "0?Set(__REC_POLICY_MODE=)") in new stack
-- Executing [s@sub-record-check:13] GotoIf("SIP/to-claro-00002172", "0?exten,1") in new stack
-- Executing [s@sub-record-check:14] Set("SIP/to-claro-00002172", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:15] Set("SIP/to-claro-00002172", "NOW=1492788084") in new stack
-- Executing [s@sub-record-check:16] Set("SIP/to-claro-00002172", "__DAY=21") in new stack
-- Executing [s@sub-record-check:17] Set("SIP/to-claro-00002172", "__MONTH=04") in new stack
-- Executing [s@sub-record-check:18] Set("SIP/to-claro-00002172", "__YEAR=2017") in new stack
-- Executing [s@sub-record-check:19] Set("SIP/to-claro-00002172", "__TIMESTR=20170421-112124") in new stack
-- Executing [s@sub-record-check:20] Set("SIP/to-claro-00002172", "__FROMEXTEN=8498865770") in new stack
-- Executing [s@sub-record-check:21] Set("SIP/to-claro-00002172", "__CALLFILENAME=exten-2104-8498865770-20170421-112124-1492788079.9489") in new stack
-- Executing [s@sub-record-check:22] Goto("SIP/to-claro-00002172", "exten,1") in new stack
-- Goto (sub-record-check,exten,1)
-- Executing [exten@sub-record-check:1] GotoIf("SIP/to-claro-00002172", "0?callee") in new stack
-- Executing [exten@sub-record-check:2] Set("SIP/to-claro-00002172", "__REC_POLICY_MODE=dontcare") in new stack
-- Executing [exten@sub-record-check:3] GotoIf("SIP/to-claro-00002172", "1?caller") in new stack
-- Goto (sub-record-check,exten,10)
-- Executing [exten@sub-record-check:10] Set("SIP/to-claro-00002172", "__REC_POLICY_MODE=") in new stack
-- Executing [exten@sub-record-check:11] GosubIf("SIP/to-claro-00002172", "0?record,1(exten,2104,8498865770)") in new stack
-- Executing [exten@sub-record-check:12] Return("SIP/to-claro-00002172", "") in new stack
-- Executing [s@macro-exten-vm:7] Macro("SIP/to-claro-00002172", "dial-one,,tr,2104") in new stack
-- Executing [s@macro-dial-one:1] Set("SIP/to-claro-00002172", "DEXTEN=2104") in new stack
-- Executing [s@macro-dial-one:2] Set("SIP/to-claro-00002172", "DIALSTATUS_CW=") in new stack
-- Executing [s@macro-dial-one:3] GosubIf("SIP/to-claro-00002172", "0?screen,1()") in new stack
-- Executing [s@macro-dial-one:4] GosubIf("SIP/to-claro-00002172", "0?cf,1()") in new stack
-- Executing [s@macro-dial-one:5] GotoIf("SIP/to-claro-00002172", "1?skip1") in new stack
-- Goto (macro-dial-one,s,8)
-- Executing [s@macro-dial-one:8] GotoIf("SIP/to-claro-00002172", "0?nodial") in new stack
-- Executing [s@macro-dial-one:9] GotoIf("SIP/to-claro-00002172", "0?continue") in new stack
-- Executing [s@macro-dial-one:10] Set("SIP/to-claro-00002172", "EXTHASCW=") in new stack
-- Executing [s@macro-dial-one:11] GotoIf("SIP/to-claro-00002172", "1?next1:cwinusebusy") in new stack
-- Goto (macro-dial-one,s,12)
-- Executing [s@macro-dial-one:12] GotoIf("SIP/to-claro-00002172", "0?docfu:skip3") in new stack
-- Goto (macro-dial-one,s,16)
-- Executing [s@macro-dial-one:16] GotoIf("SIP/to-claro-00002172", "1?next2:continue") in new stack
-- Goto (macro-dial-one,s,17)
-- Executing [s@macro-dial-one:17] GotoIf("SIP/to-claro-00002172", "1?continue") in new stack
-- Goto (macro-dial-one,s,25)
-- Executing [s@macro-dial-one:25] GotoIf("SIP/to-claro-00002172", "0?nodial") in new stack
-- Executing [s@macro-dial-one:26] GosubIf("SIP/to-claro-00002172", "1?dstring,1():dlocal,1()") in new stack
-- Executing [dstring@macro-dial-one:1] Set("SIP/to-claro-00002172", "DSTRING=") in new stack
-- Executing [dstring@macro-dial-one:2] Set("SIP/to-claro-00002172", "DEVICES=2104") in new stack
-- Executing [dstring@macro-dial-one:3] ExecIf("SIP/to-claro-00002172", "0?Return()") in new stack
-- Executing [dstring@macro-dial-one:4] ExecIf("SIP/to-claro-00002172", "0?Set(DEVICES=104)") in new stack
-- Executing [dstring@macro-dial-one:5] Set("SIP/to-claro-00002172", "LOOPCNT=1") in new stack
-- Executing [dstring@macro-dial-one:6] Set("SIP/to-claro-00002172", "ITER=1") in new stack
-- Executing [dstring@macro-dial-one:7] Set("SIP/to-claro-00002172", "THISDIAL=SIP/2104") in new stack
-- Executing [dstring@macro-dial-one:8] GosubIf("SIP/to-claro-00002172", "1?zap2dahdi,1()") in new stack
-- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/to-claro-00002172", "0?Return()") in new stack
-- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/to-claro-00002172", "NEWDIAL=") in new stack
-- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/to-claro-00002172", "LOOPCNT2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/to-claro-00002172", "ITER2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/to-claro-00002172", "THISPART2=SIP/2104") in new stack
-- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/to-claro-00002172", "0?Set(THISPART2=DAHDI/2104)") in new stack
-- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/to-claro-00002172", "NEWDIAL=SIP/2104&") in new stack
-- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/to-claro-00002172", "ITER2=2") in new stack
-- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/to-claro-00002172", "0?begin2") in new stack
-- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/to-claro-00002172", "THISDIAL=SIP/2104") in new stack
-- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/to-claro-00002172", "") in new stack
-- Executing [dstring@macro-dial-one:9] Set("SIP/to-claro-00002172", "DSTRING=SIP/2104&") in new stack
-- Executing [dstring@macro-dial-one:10] Set("SIP/to-claro-00002172", "ITER=2") in new stack
-- Executing [dstring@macro-dial-one:11] GotoIf("SIP/to-claro-00002172", "0?begin") in new stack
-- Executing [dstring@macro-dial-one:12] Set("SIP/to-claro-00002172", "DSTRING=SIP/2104") in new stack
-- Executing [dstring@macro-dial-one:13] Return("SIP/to-claro-00002172", "") in new stack
-- Executing [s@macro-dial-one:27] GotoIf("SIP/to-claro-00002172", "0?nodial") in new stack
-- Executing [s@macro-dial-one:28] GotoIf("SIP/to-claro-00002172", "0?skiptrace") in new stack
-- Executing [s@macro-dial-one:29] GosubIf("SIP/to-claro-00002172", "1?ctset,1():ctclear,1()") in new stack
-- Executing [ctset@macro-dial-one:1] Set("SIP/to-claro-00002172", "DB(CALLTRACE/2104)=8498865770") in new stack
-- Executing [ctset@macro-dial-one:2] Return("SIP/to-claro-00002172", "") in new stack
-- Executing [s@macro-dial-one:30] Set("SIP/to-claro-00002172", "D_OPTIONS=tr") in new stack
-- Executing [s@macro-dial-one:31] ExecIf("SIP/to-claro-00002172", "0?SIPAddHeader(Alert-Info: )") in new stack
-- Executing [s@macro-dial-one:32] ExecIf("SIP/to-claro-00002172", "0?SIPAddHeader()") in new stack
-- Executing [s@macro-dial-one:33] ExecIf("SIP/to-claro-00002172", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [s@macro-dial-one:34] GosubIf("SIP/to-claro-00002172", "0?qwait,1()") in new stack
-- Executing [s@macro-dial-one:35] Set("SIP/to-claro-00002172", "__CWIGNORE=") in new stack
-- Executing [s@macro-dial-one:36] Set("SIP/to-claro-00002172", "__KEEPCID=TRUE") in new stack
-- Executing [s@macro-dial-one:37] GotoIf("SIP/to-claro-00002172", "0?usegoto,1") in new stack
-- Executing [s@macro-dial-one:38] GotoIf("SIP/to-claro-00002172", "1?godial") in new stack
-- Goto (macro-dial-one,s,43)
-- Executing [s@macro-dial-one:43] Dial("SIP/to-claro-00002172", "SIP/2104,,tr") in new stack
-- Executing [s@macro-dial-one:44] ExecIf("SIP/to-claro-00002172", "0?MacroExit()") in new stack
-- Executing [s@macro-dial-one:45] ExecIf("SIP/to-claro-00002172", "0?Set(DIALSTATUS=)") in new stack
-- Executing [s@macro-dial-one:46] GosubIf("SIP/to-claro-00002172", "0?s-CHANUNAVAIL,1()") in new stack
-- Executing [s@macro-dial-one:47] MacroExit("SIP/to-claro-00002172", "") in new stack
-- Executing [s@macro-exten-vm:8] Set("SIP/to-claro-00002172", "SV_DIALSTATUS=CHANUNAVAIL") in new stack
-- Executing [s@macro-exten-vm:9] GosubIf("SIP/to-claro-00002172", "0?docfu,1()") in new stack
-- Executing [s@macro-exten-vm:10] GosubIf("SIP/to-claro-00002172", "0?docfb,1()") in new stack
-- Executing [s@macro-exten-vm:11] Set("SIP/to-claro-00002172", "DIALSTATUS=CHANUNAVAIL") in new stack
-- Executing [s@macro-exten-vm:12] ExecIf("SIP/to-claro-00002172", "0?MacroExit()") in new stack
-- Executing [s@macro-exten-vm:13] GotoIf("SIP/to-claro-00002172", "1?s-CHANUNAVAIL,1") in new stack
-- Goto (macro-exten-vm,s-CHANUNAVAIL,1)
-- Executing [s-CHANUNAVAIL@macro-exten-vm:1] GotoIf("SIP/to-claro-00002172", "1?exit,1") in new stack
-- Goto (macro-exten-vm,exit,1)
-- Executing [exit@macro-exten-vm:1] Playback("SIP/to-claro-00002172", "beep&line-busy-transfer-menu&silence/1") in new stack
-- <SIP/to-claro-00002172> Playing 'beep.gsm' (language 'es')
-- <SIP/to-claro-00002172> Playing 'line-busy-transfer-menu.slin' (language 'es')
-- <SIP/to-claro-00002172> Playing 'silence/1.gsm' (language 'es')
-- Executing [exit@macro-exten-vm:2] MacroExit("SIP/to-claro-00002172", "") in new stack
-- Executing [2104@from-did-direct:3] Set("SIP/to-claro-00002172", "__PICKUPMARK=") in new stack
-- Executing [2104@from-did-direct:4] Goto("SIP/to-claro-00002172", "ivr-4,return,1") in new stack
-- Goto (ivr-4,return,1)
-- Executing [return@ivr-4:1] Set("SIP/to-claro-00002172", "_IVR_CONTEXT=ivr-4") in new stack
-- Executing [return@ivr-4:2] Set("SIP/to-claro-00002172", "_IVR_CONTEXT_ivr-4=") in new stack
-- Executing [return@ivr-4:3] Set("SIP/to-claro-00002172", "IVR_MSG=custom/IVR2") in new stack
-- Executing [return@ivr-4:4] Goto("SIP/to-claro-00002172", "s,start") in new stack
-- Goto (ivr-4,s,8)
-- Executing [s@ivr-4:8] Set("SIP/to-claro-00002172", "TIMEOUT(digit)=3") in new stack
-- Digit timeout set to 3.000
-- Executing [s@ivr-4:9] ExecIf("SIP/to-claro-00002172", "1?Background(custom/IVR2)") in new stack
-- <SIP/to-claro-00002172> Playing 'custom/IVR2.slin' (language 'es')

== Spawn extension (ivr-4, s, 9) exited non-zero on ‘SIP/to-claro-00002172’
– Executing [h@ivr-4:1] Hangup(“SIP/to-claro-00002172”, “”) in new stack
== Spawn extension (ivr-4, h, 1) exited non-zero on ‘SIP/to-claro-00002172’

You’ve provided a log which indicates a comlex dialplan, but not the dialplan itself!

If you are trying to customise FreePBX, you may have better luck on their support forum, as we don’t know the details of their standard dialplan.

1 Like