I’m using FreePBX 16.0.40.8 and I’m facing a problem with the URA. When a customer selects the option for the desired industry, the call is not transferred immediately. Instead, we need to wait about 20 seconds, at which point the URA message starts again. Only after this reset and new selection of the desired option is the call effectively transferred. What could be causing this problem?
It is probably some adjustment needed in your IVR (URA) configuration… can you print the settings and post them for us to analyze?
1 Like
Of course, here is the IVR configuration:
[ivr-1] ; URA HORARIO COMERCIAL
include => ivr-1-custom
exten => fax,1,Goto(${CUT(FAX_DEST,^,1)},${CUT(FAX_DEST,^,2)},${CUT(FAX_DEST,^,3)})
exten => s,1,Set(TIMEOUT_LOOPCOUNT=0)
exten => s,n,Set(INVALID_LOOPCOUNT=0)
exten => s,n,Set(IVR_CONTEXT${CONTEXT}=${IVR_CONTEXT})
exten => s,n,Set(_IVR_CONTEXT=${CONTEXT})
exten => s,n,Set(__IVR_RETVM=)
exten => s,n,GotoIf($[“${CHANNEL(state)}” = “Up”]?skip)
exten => s,n,Answer
exten => s,n(skip),Set(IVR_MSG=custom/Sem_musica)
exten => s,n(start),Set(DIGITS=)
exten => s,n,Set(IVREXT=)
exten => s,n,Set(NODEFOUND=0)
exten => s,n,Set(LOCALEXT=0)
exten => s,n,Set(DIREXT=0)
exten => s,n(beforewhile),ExecIf($[“${IVREXT}” != “”]?Set(DIGITS=${DIGITS}${IVREXT}))
exten => s,n,While($[“${NODEFOUND}” = “0”] )
exten => s,n,Read(IVREXT,${IVR_MSG},1,0,5)
exten => s,n,Set(IVR_MSG=)
exten => s,n,GotoIf($[“${READSTATUS}” = “OK” & “${IVREXT}” = “”]?#,1)
exten => s,n,GotoIf($[“${READSTATUS}” = “TIMEOUT” & “${DIGITS}” != “”]?i,1)
exten => s,n,GotoIf($[“${READSTATUS}” = “TIMEOUT” & “${IVREXT}” = “”]?t,1)
exten => s,n,Noop(${DB(DEVICE/${DIGITS}${IVREXT}/user)})
exten => s,n,ExecIf($[“${DB(DEVICE/${DIGITS}${IVREXT}/user)}” != “”]?Set(LOCALEXT=1))
exten => s,n,GotoIf($[“${LOCALEXT}” = “1”]?from-did-direct-ivr,${DIGITS}${IVREXT},1)
exten => s,n,Noop(${CONTEXT}${DIGITS},${IVREXT},1)
exten => s,n,ExecIf($[“${DIALPLAN_EXISTS(${CONTEXT},${DIGITS}${IVREXT},1)}” != “0”]?Set(NODEFOUND=1))
exten => s,n,GotoIf($[“${NODEFOUND}” = “0”]?beforewhile:nodedial)
exten => s,n,EndWhile
exten => s,n,GotoIf($[“${DIALPLAN_EXISTS(${CONTEXT},${DIGITS},1)}” = “0”]?i,1)
exten => s,n(nodedial),Goto(${DIGITS}${IVREXT},1)
exten => 1,1,Set(__ivrreturn=0)
exten => 1,n(ivrsel-1),Goto(ext-queues,8091,1)
exten => 2,1,Set(__ivrreturn=0)
exten => 2,n(ivrsel-2),Goto(ext-queues,8090,1)
exten => 3,1,Set(__ivrreturn=0)
exten => 3,n(ivrsel-3),Goto(ext-queues,8092,1)
exten => 8003,1,Set(__ivrreturn=0)
exten => 8003,n(ivrsel-8003),Goto(from-did-direct,8003,1)
exten => 8005,1,Set(__ivrreturn=0)
exten => 8005,n(ivrsel-8005),Goto(from-did-direct,8005,1)
exten => 8006,1,Set(__ivrreturn=0)
exten => 8006,n(ivrsel-8006),Goto(from-did-direct,8006,1)
exten => 8007,1,Set(__ivrreturn=0)
exten => 8007,n(ivrsel-8007),Goto(from-did-direct,8007,1)
exten => 8008,1,Set(__ivrreturn=0)
exten => 8008,n(ivrsel-8008),Goto(from-did-direct,8008,1)
exten => 8009,1,Set(__ivrreturn=0)
exten => 8009,n(ivrsel-8009),Goto(from-did-direct,8009,1)
exten => 8012,1,Set(__ivrreturn=0)
exten => 8012,n(ivrsel-8012),Goto(from-did-direct,8012,1)
exten => 8013,1,Set(__ivrreturn=0)
exten => 8013,n(ivrsel-8013),Goto(from-did-direct,8013,1)
exten => 8015,1,Set(__ivrreturn=0)
exten => 8015,n(ivrsel-8015),Goto(from-did-direct,8015,1)
exten => 8021,1,Set(__ivrreturn=0)
exten => 8021,n(ivrsel-8021),Goto(from-did-direct,8021,1)
exten => 8022,1,Set(__ivrreturn=0)
exten => 8022,n(ivrsel-8022),Goto(from-did-direct,8022,1)
exten => 8023,1,Set(__ivrreturn=0)
exten => 8023,n(ivrsel-8023),Goto(from-did-direct,8023,1)
exten => 8024,1,Set(__ivrreturn=0)
exten => 8024,n(ivrsel-8024),Goto(from-did-direct,8024,1)
exten => 8029,1,Set(__ivrreturn=0)
exten => 8029,n(ivrsel-8029),Goto(from-did-direct,8029,1)
exten => 8080,1,Set(__ivrreturn=0)
exten => 8080,n(ivrsel-8080),Goto(ext-group,8080,1)
exten => i,1,Set(INVALID_LOOPCOUNT=$[${INVALID_LOOPCOUNT}+1])
exten => i,n,GotoIf($[${INVALID_LOOPCOUNT} > 3]?final)
exten => i,n,Set(IVR_MSG=custom/opcao_invalida&custom/Sem_musica)
exten => i,n,Goto(s,start)
exten => i,n(final),Playback(custom/opcao_invalida)
exten => i,n,GotoIf($[“x${IVR_CONTEXT_${CONTEXT}}” = “x”]?ivr-2,s,1:${IVR_CONTEXT_${CONTEXT}},return,1)
exten => t,1,Set(TIMEOUT_LOOPCOUNT=$[${TIMEOUT_LOOPCOUNT}+1])
exten => t,n,GotoIf($[${TIMEOUT_LOOPCOUNT} > 3]?final)
exten => t,n,Set(IVR_MSG=custom/Sem_musica)
exten => t,n,Goto(s,start)
exten => t,n(final),Playback(custom/Sem_musica)
exten => t,n,Goto(ivr-2,s,1)
exten => return,1,Set(IVR_CONTEXT=${CONTEXT})
exten => return,n,Set(IVR_CONTEXT${CONTEXT}=${IVR_CONTEXT${CONTEXT}})
exten => return,n,Set(IVR_MSG=custom/Sem_musica)
exten => return,n,Goto(s,start)
exten => h,1,Hangup()
exten => hang,1,Playback(vm-goodbye)
exten => hang,n,Hangup()
;–== end of [ivr-1] ==–;
Thank you in advance for your attention.
Post a pertinent log from /var/log/asterisk/full , it will have time-stamps.
Here is the log running now in real time.
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:2] Set(“Local/8024@from-queue-000002c5;2”, “__CRM_SOURCE=+5579999122511”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:3] ExecIf(“Local/8024@from-queue-000002c5;2”, “1?Set(ALERT_INFO=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:4] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(ALERT_INFO=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:5] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(ALERT_INFO=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:6] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(CHANNEL(musicclass)=default)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:7] AGI(“Local/8024@from-queue-000002c5;2”, “agi://127.0.0.1/dialparties.agi”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Starting New Dialparties.agi
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Caller ID name is ‘+5579999122511’ number is ‘+5579999122511’
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: CW Ignore is: TRUE
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: CF Ignore is:
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: CW IN_USE/BUSY is: 1
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Ringgroup confirm is :
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Methodology of ring is ‘ringallv2-prim’
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 8024 to extension map
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 8024 cf is disabled
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 8024 do not disturb is disabled
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 8024 has ExtensionState: 0
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 8024 has ExtensionState: 0
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Checking CW and CFB status for extension 8024
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Discovered PJSIP Endpoint PJSIP/8024
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Ended up with real PJSIP Dial string PJSIP/8024/sip:[email protected]:56181;ob
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/8024 to +5579999122511
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: Filtered ARG3: 8024
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: RING ALL V2 :
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOL_MODE ‘dontcare’
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOL is:
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOLPARENT is:
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] res_agi.c: <Local/8024@from-queue-000002c5;2>AGI Script agi://127.0.0.1/dialparties.agi completed, returning 0
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:8] GotoIf(“Local/8024@from-queue-000002c5;2”, “1?normdial”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx_builtins.c: Goto (macro-dial,s,11)
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:11] NoOp(“Local/8024@from-queue-000002c5;2”, “Returned from dialparties with groups to dial”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:12] NoOp(“Local/8024@from-queue-000002c5;2”, "ringall array ") in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:13] NoOp(“Local/8024@from-queue-000002c5;2”, "ds= PJSIP/8024/sip:[email protected]:56181;ob,35,HhtrM(auto-blkvm)I ") in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:14] NoOp(“Local/8024@from-queue-000002c5;2”, "dsextra= ") in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:15] Set(“Local/8024@from-queue-000002c5;2”, “ds=PJSIP/8024/sip:[email protected]:56181;ob,35,HhtrM(auto-blkvm)I”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:16] NoOp(“Local/8024@from-queue-000002c5;2”, “ds= PJSIP/8024/sip:[email protected]:56181;ob,35,HhtrM(auto-blkvm)I”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:17] Set(“Local/8024@from-queue-000002c5;2”, “__FMGL_DIAL=”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:18] Set(“Local/8024@from-queue-000002c5;2”, “LOOPCNT=1”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:19] Set(“Local/8024@from-queue-000002c5;2”, “ITER=1”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:20] Set(“Local/8024@from-queue-000002c5;2”, “__EXTTOCALL=8024”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:21] Set(“Local/8024@from-queue-000002c5;2”, “__MCEXTTOCALL=8024”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:22] NoOp(“Local/8024@from-queue-000002c5;2”, “Working with 8024”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:23] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:24] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:25] Set(“Local/8024@from-queue-000002c5;2”, “ITER=2”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:26] GotoIf(“Local/8024@from-queue-000002c5;2”, “0?ndloopbegin”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:27] Macro(“Local/8024@from-queue-000002c5;2”, “dial-ringall-predial-hook,”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit(“Local/8024@from-queue-000002c5;2”, “”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:28] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(CWRING=r(callwaiting)):Set(CWRING=)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:29] ExecIf(“Local/8024@from-queue-000002c5;2”, “0?Set(ds=PJSIP/8024/sip:[email protected]:56181;ob,35,HhtrM(auto-blkvm)Ig)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@macro-dial:30] Dial(“Local/8024@from-queue-000002c5;2”, “PJSIP/8024/sip:[email protected]:56181;ob,35,HhtrM(auto-blkvm)Ib(func-apply-sipheaders^s^1),”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(func-apply-sipheaders,s,1) start
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“PJSIP/8024-000001ba”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“PJSIP/8024-000001ba”, “Applying SIP Headers to channel PJSIP/8024-000001ba”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/8024-000001ba”, “localchan=8024-000001ba”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“PJSIP/8024-000001ba”, “DialMCEXT=8024”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:5] Set(“PJSIP/8024-000001ba”, “CHANNEL(hangup_handler_push)=app-missedcall-hangup,8024,1”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:6] Set(“PJSIP/8024-000001ba”, “TECH=PJSIP”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:7] Set(“PJSIP/8024-000001ba”, “SIPHEADERKEYS=”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:8] While(“PJSIP/8024-000001ba”, “0”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_while.c: Jumping to priority 14
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@func-apply-sipheaders:15] Return(“PJSIP/8024-000001ba”, “”) in new stack
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_stack.c: Spawn extension (from-internal, 8024, 1) exited non-zero on ‘PJSIP/8024-000001ba’
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_dial.c: Called PJSIP/8024/sip:[email protected]:56181;ob
[2024-08-12 16:37:37] VERBOSE[12633][C-000000ff] app_queue.c: Local/8024@from-queue-000002c5;1 is ringing
[2024-08-12 16:37:37] VERBOSE[11733] netsock2.c: Using SIP RTP Audio TOS bits 184
[2024-08-12 16:37:37] VERBOSE[11733] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2024-08-12 16:37:37] VERBOSE[11733] netsock2.c: Using SIP RTP Audio CoS mark 5
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_dial.c: Connected line update to Local/8024@from-queue-000002c5;2 prevented.
[2024-08-12 16:37:37] VERBOSE[12789][C-000000ff] app_dial.c: PJSIP/8024-000001ba is ringing
[2024-08-12 16:37:37] VERBOSE[12633][C-000000ff] app_queue.c: Local/8024@from-queue-000002c5;1 is ringing
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] res_musiconhold.c: Stopped music on hold on PJSIP/VIVO-000001b9
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_queue.c: – LazyMembers debugging - Numbusies: 0, Nummems: 3
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Spawn extension (ext-queues, 8090, 54) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [h@ext-queues:1] Macro(“PJSIP/VIVO-000001b9”, “hangupcall,”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:1] Set(“PJSIP/VIVO-000001b9”, “__MCVMSTATUS=”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:2] Gosub(“PJSIP/VIVO-000001b9”, “app-missedcall-hangup,s,1()”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp(“PJSIP/VIVO-000001b9”, “Dialed: s”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp(“PJSIP/VIVO-000001b9”, "Caller: ") in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf(“PJSIP/VIVO-000001b9”, “0?exit”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:4] Set(“PJSIP/VIVO-000001b9”, “EXTENNUM=s”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:5] Set(“PJSIP/VIVO-000001b9”, “FEXTENNUM=s”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:6] GotoIf(“PJSIP/VIVO-000001b9”, “0?exit”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:7] AGI(“PJSIP/VIVO-000001b9”, “agi://127.0.0.1/missedcallnotify.php,s,s,0,PJSIP/VIVO-000001b9,8090,”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(app-missedcall-hangup,8024,1) start
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:1] NoOp(“PJSIP/8024-000001ba”, “Dialed: 8024”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:2] NoOp(“PJSIP/8024-000001ba”, “Caller: +5579999122511”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:3] GotoIf(“PJSIP/8024-000001ba”, “0?exit”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:4] Set(“PJSIP/8024-000001ba”, “EXTENNUM=8024”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:5] Set(“PJSIP/8024-000001ba”, “FEXTENNUM=8024”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:6] GotoIf(“PJSIP/8024-000001ba”, “1?exit”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx_builtins.c: Goto (app-missedcall-hangup,8024,8)
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [8024@app-missedcall-hangup:8] Return(“PJSIP/8024-000001ba”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: Spawn extension (from-internal, 8024, 1) exited non-zero on ‘PJSIP/8024-000001ba’
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(app-missedcall-hangup,8024,1) complete GOSUB_RETVAL=
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(crm-hangup,s,1) start
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:1] NoOp(“PJSIP/8024-000001ba”, “Sending Hangup to CRM”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:2] NoOp(“PJSIP/8024-000001ba”, “HANGUP CAUSE: 16”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:3] ExecIf(“PJSIP/8024-000001ba”, “0?Set(__CRM_VOICEMAIL=)”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/8024-000001ba”, “MASTER CHANNEL: 1723491457.2836 = 1723491441.2829”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:5] GotoIf(“PJSIP/8024-000001ba”, “1?return”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx_builtins.c: Goto (crm-hangup,s,8)
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@crm-hangup:8] Return(“PJSIP/8024-000001ba”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: Spawn extension (from-internal, 8024, 1) exited non-zero on ‘PJSIP/8024-000001ba’
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: PJSIP/8024-000001ba Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_macro.c: Spawn extension (macro-dial, s, 30) exited non-zero on ‘Local/8024@from-queue-000002c5;2’ in macro ‘dial’
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Spawn extension (followme-sub, 8024, 42) exited non-zero on ‘Local/8024@from-queue-000002c5;2’
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: Local/8024@from-queue-000002c5;2 Internal Gosub(queueMemberCall-hangup,s,1(8024,1723491457.2835,8090)) start
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp(“Local/8024@from-queue-000002c5;2”, “8024”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent(“Local/8024@from-queue-000002c5;2”, “QueueMemberCallHangup,QAGENT:8024,UNIQ:1723491457.2835,Queue:8090,DIALSTATUS:CANCEL”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] pbx.c: Executing [s@queueMemberCall-hangup:3] Return(“Local/8024@from-queue-000002c5;2”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: Spawn extension (followme-sub, 8024, 42) exited non-zero on ‘Local/8024@from-queue-000002c5;2’
[2024-08-12 16:37:39] VERBOSE[12789][C-000000ff] app_stack.c: Local/8024@from-queue-000002c5;2 Internal Gosub(queueMemberCall-hangup,s,1(8024,1723491457.2835,8090)) complete GOSUB_RETVAL=
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] res_agi.c: <PJSIP/VIVO-000001b9>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@app-missedcall-hangup:8] Return(“PJSIP/VIVO-000001b9”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:3] UserEvent(“PJSIP/VIVO-000001b9”, “MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES: minrxmes=084.369352; maxrxmes=085.367289; avgrxmes=084.703327; stdevrxmes=000.004212; mintxmes=084.369352; maxtxmes=084.376124; avgtxmes=084.372938; stdevtxmes=000.002779;”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:4] GotoIf(“PJSIP/VIVO-000001b9”, “1?theend”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx_builtins.c: Goto (macro-hangupcall,s,6)
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:6] ExecIf(“PJSIP/VIVO-000001b9”, “0?Set(CDR(recordingfile)=)”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@macro-hangupcall:7] Hangup(“PJSIP/VIVO-000001b9”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/VIVO-000001b9’ in macro ‘hangupcall’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(queueCall-hangup,s,1(8090,1723491441.2829,PJSIP/VIVO-000001b9)) start
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:1] NoOp(“PJSIP/VIVO-000001b9”, “8090”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:2] UserEvent(“PJSIP/VIVO-000001b9”, “QueueCallHangup,Q:8090,UNIQ:1723491441.2829,CHAN:PJSIP/VIVO-000001b9,SCD_CONNECT_AGENT:”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:3] Return(“PJSIP/VIVO-000001b9”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(queueCall-hangup,s,1(8090,1723491441.2829,PJSIP/VIVO-000001b9)) complete GOSUB_RETVAL=
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(queueCall-hangup,s,1(8097,1723491441.2829,PJSIP/VIVO-000001b9)) start
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:1] NoOp(“PJSIP/VIVO-000001b9”, “8097”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:2] UserEvent(“PJSIP/VIVO-000001b9”, “QueueCallHangup,Q:8097,UNIQ:1723491441.2829,CHAN:PJSIP/VIVO-000001b9,SCD_CONNECT_AGENT:”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@queueCall-hangup:3] Return(“PJSIP/VIVO-000001b9”, “”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(queueCall-hangup,s,1(8097,1723491441.2829,PJSIP/VIVO-000001b9)) complete GOSUB_RETVAL=
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(crm-hangup,s,1) start
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:1] NoOp(“PJSIP/VIVO-000001b9”, “Sending Hangup to CRM”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:2] NoOp(“PJSIP/VIVO-000001b9”, “HANGUP CAUSE: 16”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:3] ExecIf(“PJSIP/VIVO-000001b9”, “0?Set(__CRM_VOICEMAIL=)”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/VIVO-000001b9”, “MASTER CHANNEL: 1723491441.2829 = 1723491441.2829”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:5] GotoIf(“PJSIP/VIVO-000001b9”, “0?return”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:6] Set(“PJSIP/VIVO-000001b9”, “__CRM_HANGUP=1”) in new stack
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:7] AGI(“PJSIP/VIVO-000001b9”, “agi://127.0.0.1/sangomacrm.agi”) in new stack
[2024-08-12 16:37:40] VERBOSE[12633][C-000000ff] res_agi.c: <PJSIP/VIVO-000001b9>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2024-08-12 16:37:40] VERBOSE[12633][C-000000ff] pbx.c: Executing [s@crm-hangup:8] Return(“PJSIP/VIVO-000001b9”, “”) in new stack
[2024-08-12 16:37:40] VERBOSE[12633][C-000000ff] app_stack.c: Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:40] VERBOSE[12633][C-000000ff] app_stack.c: PJSIP/VIVO-000001b9 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
that covers 3 seconds but 8024 rang for two seconds before hanging up
[2024-08-12 16:37:37] VERBOSE[12633][C-000000ff] app_queue.c: Local/8024@from-queue-000002c5;1 is ringing
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] res_musiconhold.c: Stopped music on hold on PJSIP/VIVO-000001b9
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] app_queue.c: – LazyMembers debugging - Numbusies: 0, Nummems: 3
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Spawn extension (ext-queues, 8090, 54) exited non-zero on ‘PJSIP/VIVO-000001b9’
[2024-08-12 16:37:39] VERBOSE[12633][C-000000ff] pbx.c: Executing [h@ext-queues:1] Macro(“PJSIP/VIVO-000001b9”, “hangupcall,”) in new stack\
Before extension 8024 rings, I selected option 2 from the queue in which extension 8024 is located as soon as the URA message started to ring. However, the call was only transferred during the start of the second playback of the message. What should I do to fix this issue?
We won’t guess, you will need to post a log of the the whole call, (use pastebin)
Please put the WHOLE call into pastebin. grep out C-00000136 for example.
I put the link you requested, would it be that way?
Looks fine but I can’t find a reference to 8024 in the log.
It’s because the extension that answered this call was 8009, can you identify something using this extension?
Yes 8009, was dialed at 4:59, answered at 5:03 and hungup 17 seconds later, I don’t see a problem.
That, in relation to the call, is really no problem. The problem is when the call starts, when we click on the desired option, the call is not transferred immediately, only after a few seconds when the URA message ends and starts again, only after the second attempt is the call transferred to the queue that was selected .
That would be the expected behavior. Playback () is ‘blocking’. Perhaps write a custom context using
This topic was automatically closed 31 days after the last reply. New replies are no longer allowed.