Ingroup call hanged up after dtmf
Posted: Thu Oct 27, 2016 5:30 pm
Hi,
I seted up an inboiund campaign to receive call from a 800 line. Everything works fine for more than a year, but since last Monday calls hang up after customer press IVR option. We tested with other options like to send calls straihght to the agent phone and works fine, but if I send call through ingroup agi stop ant hang up the call. I was giving a lot of rounds to this but no succes at this time.
I'm using Vicibox Express Instalation V6 over Quadcore Stand ALone server, with just 5 agents.
This is my Agi Debug
== Using SIP RTP CoS mark 5
-- Executing [92225696791@default:1] AGI("SIP/666-00000025", "agi://127.0.0.1:4577/call_log") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log
<SIP/666-00000025>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
<SIP/666-00000025>AGI Tx >> agi_channel: SIP/666-00000025
<SIP/666-00000025>AGI Tx >> agi_language: en
<SIP/666-00000025>AGI Tx >> agi_type: SIP
<SIP/666-00000025>AGI Tx >> agi_uniqueid: 1477607268.37
<SIP/666-00000025>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/666-00000025>AGI Tx >> agi_callerid: 666
<SIP/666-00000025>AGI Tx >> agi_calleridname: unknown
<SIP/666-00000025>AGI Tx >> agi_callingpres: 0
<SIP/666-00000025>AGI Tx >> agi_callingani2: 0
<SIP/666-00000025>AGI Tx >> agi_callington: 0
<SIP/666-00000025>AGI Tx >> agi_callingtns: 0
<SIP/666-00000025>AGI Tx >> agi_dnid: 92225696791
<SIP/666-00000025>AGI Tx >> agi_rdnis: unknown
<SIP/666-00000025>AGI Tx >> agi_context: default
<SIP/666-00000025>AGI Tx >> agi_extension: 92225696791
<SIP/666-00000025>AGI Tx >> agi_priority: 1
<SIP/666-00000025>AGI Tx >> agi_enhanced: 0.0
<SIP/666-00000025>AGI Tx >> agi_accountcode: 666
<SIP/666-00000025>AGI Tx >> agi_threadid: 140172132808448
<SIP/666-00000025>AGI Tx >>
-- <SIP/666-00000025>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
<SIP/666-00000025>AGI Tx >> HANGUP
-- Executing [92225696791@default:2] Dial("SIP/666-00000025", "SIP/abastible/225696791,,tTor") in new stack
== Using SIP RTP CoS mark 5
-- Called SIP/abastible/225696791
== Using SIP RTP CoS mark 5
-- Executing [101@trunkinbound:1] AGI("SIP/abastible-00000027", "agi-DID_route.agi") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-DID_route.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: trunkinbound
<SIP/abastible-00000027>AGI Tx >> agi_extension: 101
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << EXEC Monitor wav,/var/spool/asterisk/monitor/MIX/20161027192748_101_226924700
-- AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/20161027192748_101_226924700)
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET CONTEXT BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET EXTENSION s
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET PRIORITY 1
<SIP/abastible-00000027>AGI Tx >> 200 result=0
-- <SIP/abastible-00000027>AGI Script agi-DID_route.agi completed, returning 0
-- Executing [s@BIENVENIDA_AUTOGAS:1] Answer("SIP/abastible-00000027", "") in new stack
-- SIP/abastible-00000026 answered SIP/666-00000025
-- Executing [s@BIENVENIDA_AUTOGAS:2] AGI("SIP/abastible-00000027", "agi-VDAD_inbound_calltime_check.agi,CALLMENU-----YES-----BIENVENIDA_AUTOGAS-------------------------NO") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_inbound_calltime_check.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-VDAD_inbound_calltime_check.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: s
<SIP/abastible-00000027>AGI Tx >> agi_priority: 2
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CALLMENU-----YES-----BIENVENIDA_AUTOGAS-------------------------NO
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
-- <SIP/abastible-00000027>AGI Script agi-VDAD_inbound_calltime_check.agi completed, returning 0
-- Executing [s@BIENVENIDA_AUTOGAS:3] Set("SIP/abastible-00000027", "INVCOUNT=0") in new stack
-- Executing [s@BIENVENIDA_AUTOGAS:4] BackGround("SIP/abastible-00000027", "bienvenida") in new stack
-- <SIP/abastible-00000027> Playing 'bienvenida.slin' (language 'en')
[Oct 27 19:27:52] DTMF[14509]: channel.c:4194 __ast_read: DTMF begin '3' received on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14509]: channel.c:4204 __ast_read: DTMF begin passthrough '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14511]: channel.c:4194 __ast_read: DTMF begin '3' received on SIP/abastible-00000027
[Oct 27 19:27:52] DTMF[14511]: channel.c:4198 __ast_read: DTMF begin ignored '3' on SIP/abastible-00000027
[Oct 27 19:27:52] DTMF[14509]: channel.c:4109 __ast_read: DTMF end '3' received on SIP/666-00000025, duration 120 ms
[Oct 27 19:27:52] DTMF[14509]: channel.c:4149 __ast_read: DTMF end accepted with begin '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14509]: channel.c:4178 __ast_read: DTMF end passthrough '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14511]: channel.c:4109 __ast_read: DTMF end '3' received on SIP/abastible-00000027, duration 160 ms
[Oct 27 19:27:52] DTMF[14511]: channel.c:4178 __ast_read: DTMF end passthrough '3' on SIP/abastible-00000027
-- Executing [3@BIENVENIDA_AUTOGAS:1] AGI("SIP/abastible-00000027", "cm.agi,CALLMENU-----3-----NONE") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/cm.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: cm.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: 3
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CALLMENU-----3-----NONE
<SIP/abastible-00000027>AGI Tx >>
-- <SIP/abastible-00000027>AGI Script cm.agi completed, returning 0
-- Executing [3@BIENVENIDA_AUTOGAS:2] AGI("SIP/abastible-00000027", "agi-VDAD_ALL_inbound.agi,CID-----LB-----IN_AUTOGAS-----BIENVENIDA_AUTOGAS--------------------998-----1-----INBOUND------------------------------") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-VDAD_ALL_inbound.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: 3
<SIP/abastible-00000027>AGI Tx >> agi_priority: 2
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CID-----LB-----IN_AUTOGAS-----BIENVENIDA_AUTOGAS--------------------998-----1-----INBOUND------------------------------
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
-- <SIP/abastible-00000027>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
-- Executing [3@BIENVENIDA_AUTOGAS:3] Hangup("SIP/abastible-00000027", "") in new stack
== Spawn extension (BIENVENIDA_AUTOGAS, 3, 3) exited non-zero on 'SIP/abastible-00000027'
-- Executing [h@BIENVENIDA_AUTOGAS:1] AGI("SIP/abastible-00000027", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16---------------
<SIP/abastible-00000027>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses ... ----------
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: h
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >>
-- <SIP/abastible-00000027>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
<SIP/abastible-00000027>AGI Tx >> HANGUP
-- Executing [h@default:1] AGI("SIP/666-00000025", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----4-----4") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----4-----4
<SIP/666-00000025>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses ... ---4-----4
<SIP/666-00000025>AGI Tx >> agi_channel: SIP/666-00000025
<SIP/666-00000025>AGI Tx >> agi_language: en
<SIP/666-00000025>AGI Tx >> agi_type: SIP
<SIP/666-00000025>AGI Tx >> agi_uniqueid: 1477607268.37
<SIP/666-00000025>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/666-00000025>AGI Tx >> agi_callerid: 666
<SIP/666-00000025>AGI Tx >> agi_calleridname: unknown
<SIP/666-00000025>AGI Tx >> agi_callingpres: 0
<SIP/666-00000025>AGI Tx >> agi_callingani2: 0
<SIP/666-00000025>AGI Tx >> agi_callington: 0
<SIP/666-00000025>AGI Tx >> agi_callingtns: 0
<SIP/666-00000025>AGI Tx >> agi_dnid: 92225696791
<SIP/666-00000025>AGI Tx >> agi_rdnis: unknown
<SIP/666-00000025>AGI Tx >> agi_context: default
<SIP/666-00000025>AGI Tx >> agi_extension: h
<SIP/666-00000025>AGI Tx >> agi_priority: 1
<SIP/666-00000025>AGI Tx >> agi_enhanced: 0.0
<SIP/666-00000025>AGI Tx >> agi_accountcode: 666
<SIP/666-00000025>AGI Tx >> agi_threadid: 140172132808448
<SIP/666-00000025>AGI Tx >>
-- <SIP/666-00000025>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---4-----4 completed, returning 0
<SIP/666-00000025>AGI Tx >> HANGUP
== Spawn extension (default, 92225696791, 2) exited non-zero on 'SIP/666-00000025'
I hope you can give me a hand with this. Thanks in advanced
I seted up an inboiund campaign to receive call from a 800 line. Everything works fine for more than a year, but since last Monday calls hang up after customer press IVR option. We tested with other options like to send calls straihght to the agent phone and works fine, but if I send call through ingroup agi stop ant hang up the call. I was giving a lot of rounds to this but no succes at this time.
I'm using Vicibox Express Instalation V6 over Quadcore Stand ALone server, with just 5 agents.
This is my Agi Debug
== Using SIP RTP CoS mark 5
-- Executing [92225696791@default:1] AGI("SIP/666-00000025", "agi://127.0.0.1:4577/call_log") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log
<SIP/666-00000025>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
<SIP/666-00000025>AGI Tx >> agi_channel: SIP/666-00000025
<SIP/666-00000025>AGI Tx >> agi_language: en
<SIP/666-00000025>AGI Tx >> agi_type: SIP
<SIP/666-00000025>AGI Tx >> agi_uniqueid: 1477607268.37
<SIP/666-00000025>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/666-00000025>AGI Tx >> agi_callerid: 666
<SIP/666-00000025>AGI Tx >> agi_calleridname: unknown
<SIP/666-00000025>AGI Tx >> agi_callingpres: 0
<SIP/666-00000025>AGI Tx >> agi_callingani2: 0
<SIP/666-00000025>AGI Tx >> agi_callington: 0
<SIP/666-00000025>AGI Tx >> agi_callingtns: 0
<SIP/666-00000025>AGI Tx >> agi_dnid: 92225696791
<SIP/666-00000025>AGI Tx >> agi_rdnis: unknown
<SIP/666-00000025>AGI Tx >> agi_context: default
<SIP/666-00000025>AGI Tx >> agi_extension: 92225696791
<SIP/666-00000025>AGI Tx >> agi_priority: 1
<SIP/666-00000025>AGI Tx >> agi_enhanced: 0.0
<SIP/666-00000025>AGI Tx >> agi_accountcode: 666
<SIP/666-00000025>AGI Tx >> agi_threadid: 140172132808448
<SIP/666-00000025>AGI Tx >>
-- <SIP/666-00000025>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
<SIP/666-00000025>AGI Tx >> HANGUP
-- Executing [92225696791@default:2] Dial("SIP/666-00000025", "SIP/abastible/225696791,,tTor") in new stack
== Using SIP RTP CoS mark 5
-- Called SIP/abastible/225696791
== Using SIP RTP CoS mark 5
-- Executing [101@trunkinbound:1] AGI("SIP/abastible-00000027", "agi-DID_route.agi") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-DID_route.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: trunkinbound
<SIP/abastible-00000027>AGI Tx >> agi_extension: 101
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << EXEC Monitor wav,/var/spool/asterisk/monitor/MIX/20161027192748_101_226924700
-- AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/20161027192748_101_226924700)
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET CONTEXT BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET EXTENSION s
<SIP/abastible-00000027>AGI Tx >> 200 result=0
<SIP/abastible-00000027>AGI Rx << SET PRIORITY 1
<SIP/abastible-00000027>AGI Tx >> 200 result=0
-- <SIP/abastible-00000027>AGI Script agi-DID_route.agi completed, returning 0
-- Executing [s@BIENVENIDA_AUTOGAS:1] Answer("SIP/abastible-00000027", "") in new stack
-- SIP/abastible-00000026 answered SIP/666-00000025
-- Executing [s@BIENVENIDA_AUTOGAS:2] AGI("SIP/abastible-00000027", "agi-VDAD_inbound_calltime_check.agi,CALLMENU-----YES-----BIENVENIDA_AUTOGAS-------------------------NO") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_inbound_calltime_check.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-VDAD_inbound_calltime_check.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: s
<SIP/abastible-00000027>AGI Tx >> agi_priority: 2
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CALLMENU-----YES-----BIENVENIDA_AUTOGAS-------------------------NO
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
-- <SIP/abastible-00000027>AGI Script agi-VDAD_inbound_calltime_check.agi completed, returning 0
-- Executing [s@BIENVENIDA_AUTOGAS:3] Set("SIP/abastible-00000027", "INVCOUNT=0") in new stack
-- Executing [s@BIENVENIDA_AUTOGAS:4] BackGround("SIP/abastible-00000027", "bienvenida") in new stack
-- <SIP/abastible-00000027> Playing 'bienvenida.slin' (language 'en')
[Oct 27 19:27:52] DTMF[14509]: channel.c:4194 __ast_read: DTMF begin '3' received on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14509]: channel.c:4204 __ast_read: DTMF begin passthrough '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14511]: channel.c:4194 __ast_read: DTMF begin '3' received on SIP/abastible-00000027
[Oct 27 19:27:52] DTMF[14511]: channel.c:4198 __ast_read: DTMF begin ignored '3' on SIP/abastible-00000027
[Oct 27 19:27:52] DTMF[14509]: channel.c:4109 __ast_read: DTMF end '3' received on SIP/666-00000025, duration 120 ms
[Oct 27 19:27:52] DTMF[14509]: channel.c:4149 __ast_read: DTMF end accepted with begin '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14509]: channel.c:4178 __ast_read: DTMF end passthrough '3' on SIP/666-00000025
[Oct 27 19:27:52] DTMF[14511]: channel.c:4109 __ast_read: DTMF end '3' received on SIP/abastible-00000027, duration 160 ms
[Oct 27 19:27:52] DTMF[14511]: channel.c:4178 __ast_read: DTMF end passthrough '3' on SIP/abastible-00000027
-- Executing [3@BIENVENIDA_AUTOGAS:1] AGI("SIP/abastible-00000027", "cm.agi,CALLMENU-----3-----NONE") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/cm.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: cm.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: 3
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CALLMENU-----3-----NONE
<SIP/abastible-00000027>AGI Tx >>
-- <SIP/abastible-00000027>AGI Script cm.agi completed, returning 0
-- Executing [3@BIENVENIDA_AUTOGAS:2] AGI("SIP/abastible-00000027", "agi-VDAD_ALL_inbound.agi,CID-----LB-----IN_AUTOGAS-----BIENVENIDA_AUTOGAS--------------------998-----1-----INBOUND------------------------------") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
<SIP/abastible-00000027>AGI Tx >> agi_request: agi-VDAD_ALL_inbound.agi
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: 3
<SIP/abastible-00000027>AGI Tx >> agi_priority: 2
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >> agi_arg_1: CID-----LB-----IN_AUTOGAS-----BIENVENIDA_AUTOGAS--------------------998-----1-----INBOUND------------------------------
<SIP/abastible-00000027>AGI Tx >>
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
<SIP/abastible-00000027>AGI Rx << STREAM FILE sip-silence ""
-- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
<SIP/abastible-00000027>AGI Tx >> 200 result=0 endpos=160
-- <SIP/abastible-00000027>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
-- Executing [3@BIENVENIDA_AUTOGAS:3] Hangup("SIP/abastible-00000027", "") in new stack
== Spawn extension (BIENVENIDA_AUTOGAS, 3, 3) exited non-zero on 'SIP/abastible-00000027'
-- Executing [h@BIENVENIDA_AUTOGAS:1] AGI("SIP/abastible-00000027", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16---------------
<SIP/abastible-00000027>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses ... ----------
<SIP/abastible-00000027>AGI Tx >> agi_channel: SIP/abastible-00000027
<SIP/abastible-00000027>AGI Tx >> agi_language: en
<SIP/abastible-00000027>AGI Tx >> agi_type: SIP
<SIP/abastible-00000027>AGI Tx >> agi_uniqueid: 1477607268.39
<SIP/abastible-00000027>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/abastible-00000027>AGI Tx >> agi_callerid: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_calleridname: 226924700
<SIP/abastible-00000027>AGI Tx >> agi_callingpres: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingani2: 0
<SIP/abastible-00000027>AGI Tx >> agi_callington: 0
<SIP/abastible-00000027>AGI Tx >> agi_callingtns: 0
<SIP/abastible-00000027>AGI Tx >> agi_dnid: 101
<SIP/abastible-00000027>AGI Tx >> agi_rdnis: unknown
<SIP/abastible-00000027>AGI Tx >> agi_context: BIENVENIDA_AUTOGAS
<SIP/abastible-00000027>AGI Tx >> agi_extension: h
<SIP/abastible-00000027>AGI Tx >> agi_priority: 1
<SIP/abastible-00000027>AGI Tx >> agi_enhanced: 0.0
<SIP/abastible-00000027>AGI Tx >> agi_accountcode:
<SIP/abastible-00000027>AGI Tx >> agi_threadid: 140172129646336
<SIP/abastible-00000027>AGI Tx >>
-- <SIP/abastible-00000027>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
<SIP/abastible-00000027>AGI Tx >> HANGUP
-- Executing [h@default:1] AGI("SIP/666-00000025", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----4-----4") in new stack
AGI Tx >> agi_network: yes
AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----4-----4
<SIP/666-00000025>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses ... ---4-----4
<SIP/666-00000025>AGI Tx >> agi_channel: SIP/666-00000025
<SIP/666-00000025>AGI Tx >> agi_language: en
<SIP/666-00000025>AGI Tx >> agi_type: SIP
<SIP/666-00000025>AGI Tx >> agi_uniqueid: 1477607268.37
<SIP/666-00000025>AGI Tx >> agi_version: 1.8.32.3-vici
<SIP/666-00000025>AGI Tx >> agi_callerid: 666
<SIP/666-00000025>AGI Tx >> agi_calleridname: unknown
<SIP/666-00000025>AGI Tx >> agi_callingpres: 0
<SIP/666-00000025>AGI Tx >> agi_callingani2: 0
<SIP/666-00000025>AGI Tx >> agi_callington: 0
<SIP/666-00000025>AGI Tx >> agi_callingtns: 0
<SIP/666-00000025>AGI Tx >> agi_dnid: 92225696791
<SIP/666-00000025>AGI Tx >> agi_rdnis: unknown
<SIP/666-00000025>AGI Tx >> agi_context: default
<SIP/666-00000025>AGI Tx >> agi_extension: h
<SIP/666-00000025>AGI Tx >> agi_priority: 1
<SIP/666-00000025>AGI Tx >> agi_enhanced: 0.0
<SIP/666-00000025>AGI Tx >> agi_accountcode: 666
<SIP/666-00000025>AGI Tx >> agi_threadid: 140172132808448
<SIP/666-00000025>AGI Tx >>
-- <SIP/666-00000025>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---4-----4 completed, returning 0
<SIP/666-00000025>AGI Tx >> HANGUP
== Spawn extension (default, 92225696791, 2) exited non-zero on 'SIP/666-00000025'
I hope you can give me a hand with this. Thanks in advanced