Ingroup call hanged up after dtmf

[asincom]

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

[asincom]

Please, any help will be apreciated. Thanks in advanced.

[mflorell]

Asterisk version?
Vicidial version and build?
Installation method?
Have you tried another carrier?

[asincom]

Hi,
Asterisk Version 1.8
ViciBox Redux v.6.0.3-141118
VERSION: 2.12-485a
BUILD: 150512-2225
Installation Method: Vicibox Express install on single stand alone server.

Thanks in advanced for your help

[mflorell]

Have you tried another carrier?

[asincom]

No i didn´t but it was working fine since last year.
Could be something with CID, ANI, DNID ore something like that?
I've seted up to receive calls straight to the agent calls, and work ok... bit if I set up IVR to Inbound campaign, clls missed up...
Thanks for your support..
Cheers
Aldo

[mflorell]

If your configuration hasn't changed, then the problem is most likely with the carrier. We have seen something like this happen before.

[asincom]

Thanks Matt for your help.
I suspect the same thing, but could you tell me, on your experience, which kind of parameters could change from carrier side ir order to talk with them and put campaign on run again??
I know there use UDP protocol. They send me parameters to config asterisk on my side, but they didn't inform any changes in there system or anything, they just said is Vicidial fault.
Thanks in advanced.

[mflorell]

It's usually a carrier equipment issue, or something on an upstream carrier, not directly in the control of your carrier.

[asincom]

Company use a Mediant 1000 with several E1 on it. I receive the calls from Mediant as UDP trunk. They send me the calls to a pre defined extension (101, as you can see on Agi debug).
Calls from PSTN came through an 800 number.
Of course they say the didn't make any changes than could afect the call to Vicidial.
The strange thing is, all other features works in call menu, as receive the call to a phone on vicidial, but if I select to receive calls to an ingroup, the call hang up. Mediant admin said how can I receive the call in one way and not in another.
Thanks again.

[asincom]

Just in case, this my carrier config

[xxxxxxxxx]
disallow=all
allow=ulaw,alaw
transport=tcp,udp
type=peer
host=10.252.x.xx
port=5066
dtmfmode=rfc2833
context=trunkinbound
qualify=yes
nat=yes
insecure=invite,port

Dial Plan Entry

exten => _X.,1,AGI(agi://127.0.0.1:4577/call_log)
exten => _X.,2,Dial(${TESTSIPTRUNK}/${EXTEN:2},,tTor)
exten => _X.,3,Hangup

Thanks for any help

[Eugene]

Hello,

You might want to try different DTMF modes. In a similar situation inband DTMF mode helped us to get rid of irregular DTMF errors.

Regards,
Gene

[asincom]

Hi Gene,
Dtmf works fine. My problem is AGI stopped without warning and call hang up and only happen with if I select Ingroup in call menu.
Thanks any way.
Regards
Aldo