I have upgraded a Vicidial server which had asterisk 11 and was working fine to asterisk 13.21-vici and the agent alert does not work consistently. It may work for a few calls then stop working for while.
I have been doing a lot of different tests to try to find where the problem is but I'm out of idea and would appreciate any help. Is anyone running Asterisk 13.21-vici in their test environment or production? Does anyone have the issue with the agent alert?
Thanks for your help!
My configuration is as follow:
. CentOS 7
. Vicidial 2.14b0.5 (latest trunk available)
. Asterisk 13.21-vici
here is the log when the agent alert works:
- Code: Select all
[Jul 31 14:33:59] -- Called 172*023*008*012*78600052@default
[Jul 31 14:33:59] -- Executing [172*023*008*012*78600052@default:1] Goto("Local/172*023*008*012*78600052@default-00000004;2", "default,78600052,1") in new stack
[Jul 31 14:33:59] -- Goto (default,78600052,1)
[Jul 31 14:33:59] -- Executing [78600052@default:1] NoOp("Local/172*023*008*012*78600052@default-00000004;2", ""Test"") in new stack
[Jul 31 14:33:59] -- Executing [78600052@default:2] NoOp("Local/172*023*008*012*78600052@default-00000004;2", "8600052") in new stack
[Jul 31 14:33:59] -- Executing [78600052@default:3] MeetMe("Local/172*023*008*012*78600052@default-00000004;2", "8600052,Fq") in new stack
[Jul 31 14:33:59] -- Local/172*023*008*012*78600052@default-00000004;1 answered
[Jul 31 14:33:59] -- Executing [83047777777777@vicidial-auto:1] Answer("Local/172*023*008*012*78600052@default-00000004;1", "") in new stack
[Jul 31 14:33:59] -- Executing [83047777777777@vicidial-auto:2] Playback("Local/172*023*008*012*78600052@default-00000004;1", "vm-sorry") in new stack
[Jul 31 14:33:59] -- <Local/172*023*008*012*78600052@default-00000004;1> Playing 'vm-sorry.slin' (language 'en')
And when it is not working:
- Code: Select all
[Jul 31 14:35:43] == Manager 'sendcron' logged on from 127.0.0.1
[Jul 31 14:35:43] -- Called 172*023*008*012*78600052@default
[Jul 31 14:35:43] -- Executing [172*023*008*012*78600052@default:1] Goto("Local/172*023*008*012*78600052@default-00000006;2", "default,78600052,1") in new stack
[Jul 31 14:35:43] -- Goto (default,78600052,1)
[Jul 31 14:35:43] WARNING[2919][C-0000000f]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Jul 31 14:35:43] -- Executing [h@default:1] AGI("Local/172*023*008*012*78600052@default-00000006;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------------)") in new stack
[Jul 31 14:35:43] -- <Local/172*023*008*012*78600052@default-00000006;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------------) completed, returning 0
[Jul 31 14:35:43] > 0x7f1990009cd0 -- Strict RTP learning complete - Locking on source address 54.172.60.76:16616
I tried to change the extensions-vicidial.conf to have a couple of NoOp to try to see where the channel hangs up and below you can see the first NoOp but then it appears like the channel is hung up however towards the end of the log you can see the same dialplan being executed and the 2 NoOp being displayed before the inbound caller is put into the meetme room.
- Code: Select all
[Jul 31 15:24:59] -- Called 172*023*008*012*78600052@default
[Jul 31 15:24:59] -- Executing [172*023*008*012*78600052@default:1] NoOp("Local/172*023*008*012*78600052@default-00000018;2", "Test1") in new stack
[Jul 31 15:24:59] WARNING[9141][C-00000034]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Jul 31 15:24:59] -- Executing [h@default:1] AGI("Local/172*023*008*012*78600052@default-00000018;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------------)") in new stack
[Jul 31 15:24:59] -- <Local/172*023*008*012*78600052@default-00000018;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------------) completed, returning 0
[Jul 31 15:24:59] > 0x7f1990009810 -- Strict RTP learning complete - Locking on source address 34.203.251.245:16160
[Jul 31 15:25:00] == Manager 'sendcron' logged off from 127.0.0.1
[Jul 31 15:25:00] == Manager 'sendcron' logged on from 127.0.0.1
[Jul 31 15:25:00] -- Called 58600052@default
[Jul 31 15:25:00] -- Executing [58600052@default:1] MeetMe("Local/58600052@default-00000019;2", "8600052,Fmq") in new stack
[Jul 31 15:25:00] -- Local/58600052@default-00000019;1 answered
[Jul 31 15:25:00] -- Executing [8309@default:1] Answer("Local/58600052@default-00000019;1", "") in new stack
[Jul 31 15:25:00] -- Executing [8309@default:2] Monitor("Local/58600052@default-00000019;1", "wav,20180731-132459_7023734037") in new stack
[Jul 31 15:25:00] -- Executing [8309@default:3] Wait("Local/58600052@default-00000019;1", "3600") in new stack
[Jul 31 15:25:01] == Manager 'sendcron' logged off from 127.0.0.1
[Jul 31 15:25:01] == Manager 'sendcron' logged on from 127.0.0.1
[Jul 31 15:25:01] == Manager 'sendcron' logged off from 127.0.0.1
2018-07-31 15:24:55|15:25:04|agi-VDAD_ALL_inbound.agi|exiting VDAD app, transferring call to 172*023*008*012*8600052
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
2018-07-31 15:24:55|15:25:04|agi-VDAD_ALL_inbound.agi||SELECT calls_today from vicidial_inbound_group_agents WHERE user='100502' and group_id='TEST_INBOUND';|
2018-07-31 15:24:55|15:25:04|agi-VDAD_ALL_inbound.agi|-- VDLIA agent calls: |51|100502|TEST_INBOUND|
2018-07-31 15:24:55|15:25:04|agi-VDAD_ALL_inbound.agi|-- VDCL vcl update: |1|10|
|UPDATE vicidial_closer_log set queue_seconds='0' where lead_id = '10' and call_date='2018-07-31 15:24:55' order by closecallid desc limit 1;|
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Jul 31 15:25:04] -- <SIP/twilio1-00000011> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
DBI::db=HASH(0xd44da8)->disconnect invalidates 1 active statement handle (either destroy statement handles or call finish on them before disconnecting) at /var/lib/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi line 4121, <STDIN> line 38.
2018-07-31 15:25:04|15:25:04|agi-VDAD_ALL_inbound.agi|XXXXX VDAD transferred: start|stop 2018-07-31 15:24:55|2018-07-31 15:25:04|172*023*008*012*8600052
[Jul 31 15:25:04] -- <SIP/twilio1-00000011>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[Jul 31 15:25:04] -- Executing [172*023*008*012*8600052@default:1] NoOp("SIP/twilio1-00000011", "Test1") in new stack
[Jul 31 15:25:04] -- Executing [172*023*008*012*8600052@default:2] NoOp("SIP/twilio1-00000011", "Test2") in new stack
[Jul 31 15:25:04] -- Executing [172*023*008*012*8600052@default:3] Goto("SIP/twilio1-00000011", "default,8600052,1") in new stack
[Jul 31 15:25:04] -- Goto (default,8600052,1)
[Jul 31 15:25:04] -- Executing [8600052@default:1] MeetMe("SIP/twilio1-00000011", "8600052,F") in new stack