I'm having an issue testing with an on-hook in-group. Whenever the agent answer the phone (xlite softphone) the call gets hung up on the agent side ( the customer side still has the moh playing ).
In the asterisk console, I get the following error when the agent answer the phone:
- Code: Select all
SELECT dest_channel FROM cid_channels_recent where (caller_id_name = 'Test Agent' or connected_line_name = '7023734037' or caller_id_name = '7023734037' or connected_line_name = 'Test Agent') and ( linkedid = '1537969370.52' or dest_uniqueid = '1537969370.52' or uniqueid = '1537969370.52') and call_date > '2018-09-26 08:40:57'
NO DestChannel for callid Test Agent|Local/172*024*000*088*100502@default-00000009;1!!!
Looking into the table, there is no record of the incoming call.
OS: Centos 7
Vicidial: 2.14b0.5
Asterisk: 13.21-vici
Here's the complete log:
- Code: Select all
[Sep 26 08:42:49] == Using SIP RTP CoS mark 5
[Sep 26 08:42:49] > 0x7ff6c4010f30 -- Strict RTP learning after remote address set to: 34.203.250.214:13918
[Sep 26 08:42:49] -- Executing [+16178198367@trunkinbound:1] Goto("SIP/twilio2-0000000d", "trunkinbound,6178198367,1") in new stack
[Sep 26 08:42:49] -- Goto (trunkinbound,6178198367,1)
[Sep 26 08:42:49] -- Executing [6178198367@trunkinbound:1] AGI("SIP/twilio2-0000000d", "agi-DID_route.agi") in new stack
[Sep 26 08:42:49] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-DID_route.agi
2018-09-26 08:42:49|agi-DID_route.agi||INSERT INTO vicidial_did_log SET uniqueid='1537969369.51',channel='SIP/twilio2-0000000d',server_ip='172.24.0.88',caller_id_number='17023734037',caller_id_name='',extension='6178198367',call_date='2018-09-26 08:42:49',did_id='892',did_route='IN_GROUP';|
2018-09-26 08:42:49|agi-DID_route.agi|-- DID LOG : |1|INSERT INTO vicidial_did_log SET uniqueid='1537969369.51',channel='SIP/twilio2-0000000d',server_ip='172.24.0.88',caller_id_number='17023734037',caller_id_name='',extension='6178198367',call_date='2018-09-26 08:42:49',did_id='892',did_route='IN_GROUP';|
2018-09-26 08:42:49|agi-DID_route.agi|-- CALL LOG : |1|INSERT INTO call_log SET uniqueid='1537969369.51', channel='SIP/twilio2-0000000d', channel_group='DID_INBOUND', server_ip='172.24.0.88', type='SIP', extension='6178198367', number_dialed='6178198367', caller_code='17023734037', start_time='2018-09-26 08:42:49', start_epoch='1537969369';|
2018-09-26 08:42:49|agi-DID_route.agi|-- DID AGENT LOG : |1|INSERT INTO vicidial_did_agent_log SET uniqueid='1537969369.51',server_ip='172.24.0.88',caller_id_number='17023734037',caller_id_name='',extension='6178198367',call_date='2018-09-26 08:42:49',did_id='892',did_route='IN_GROUP',user='VDCL',group_id='SCHED_MAN',did_description='Matt Test';|
2018-09-26 08:42:49|agi-DID_route.agi|exiting the DID app, transferring call to 99909*892***DID @ default
[Sep 26 08:42:49] -- <SIP/twilio2-0000000d>AGI Script agi-DID_route.agi completed, returning 0
[Sep 26 08:42:49] -- Executing [99909*892***DID@default:1] Answer("SIP/twilio2-0000000d", "") in new stack
[Sep 26 08:42:50] -- Executing [99909*892***DID@default:2] AGI("SIP/twilio2-0000000d", "agi-VDAD_ALL_inbound.agi") in new stack
[Sep 26 08:42:50] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|North America CID Check: 1|7023734037|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- accountcode =
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- callerid = +17023734037
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- calleridname = unknown
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- callingani2 = 62
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- callingpres = 0
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- callingtns = 0
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- callington = 0
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- channel = SIP/twilio2-0000000d
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- context = default
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- dnid = +16178198367
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- enhanced = 0.0
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- extension = 99909*892***DID
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- language = en
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- priority = 2
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- rdnis = +16178198367
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- request = agi-VDAD_ALL_inbound.agi
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- threadid = 140698442274560
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- type = SIP
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- uniqueid = 1537969369.51
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi| -- version = 13.17.2-vici
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|AGI Variables: |1537969369.51|SIP/twilio2-0000000d|99909*892***DID|SIP|7023734037|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|+++++ INBOUND CALL VDCL STARTED : |SCHED_MAN|7023734037-6178198367|2018-09-26 08:42:50
[Sep 26 08:42:50] -- <SIP/twilio2-0000000d> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Sep 26 08:42:50] > 0x7ff6c4010f30 -- Strict RTP switching to RTP target address 34.203.250.214:13918 as source
[Sep 26 08:42:50] -- <SIP/twilio2-0000000d> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|VDAD vicidial_list search |7023734037|SELECT lead_id,called_count from vicidial_list where phone_number='7023734037' order by last_local_call_time desc limit 1;|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|VDAD vicidial_list found |12|SELECT lead_id,called_count from vicidial_list where phone_number='7023734037' order by last_local_call_time desc limit 1;|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi||SELECT campaign_id FROM vicidial_campaigns where active='Y' and campaign_allow_inbound='Y';|12|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|callerID changed: "Y9260842500000000012 <7023734037>"
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT auto_call_id from vicidial_auto_calls where uniqueid='1537969369.51' and server_ip='172.24.0.88';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_auto_calls SET server_ip='172.24.0.88', campaign_id='SCHED_MAN', status='LIVE', lead_id='12', uniqueid='1537969369.51', callerid='Y9260842500000000012', channel='SIP/twilio2-0000000d', phone_code='1', phone_number='7023734037', call_time='2018-09-26 08:42:50', call_type='IN', stage='LIVE-0', queue_priority='0' ;|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|1|SELECT count(*) from vicidial_auto_calls where status = 'LIVE' and campaign_id='SCHED_MAN';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|1|UPDATE vicidial_auto_calls SET queue_position='1' WHERE auto_call_id='8';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_closer_log SET lead_id='12', campaign_id='SCHED_MAN', call_date='2018-09-26 08:42:50', start_epoch='1537969370', status='QUEUE', phone_code='1', phone_number='7023734037', user='VDCL', processed='N', xfercallid='0', uniqueid='1537969369.51', queue_position='1',called_count='1',list_id='999' ;|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|-- VDCL : |12|0|567|insert to vicidial_closer_log
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|-- ENTER QUEUE VLE insert: |1|
|INSERT INTO vicidial_log_extended set uniqueid='1537969369.51',server_ip='172.24.0.88',call_date='2018-09-26 08:42:50',lead_id = '12',caller_code='Y9260842500000000012',custom_call_id='';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|DID IVR time logged: 2018-09-26 08:42:50|1537969370|1|UPDATE call_log set end_time='2018-09-26 08:42:50',end_epoch='1537969370',length_in_sec=1,length_in_min=' 0.02',extension='Y9260842500000000012' where uniqueid='1537969369.51'|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|RING-AGENT CALL SENT: |7023734037|138331*8*Y9260842500000000012*100502*100502|0|30|CUSTOMER_PHONE|CUSTOMER| SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0|50|60|0|0||0|update of vla table: SCHED_MAN|
|INSERT INTO vicidial_manager values('','','2018-09-26 08:42:50','NEW','N','172.24.0.88','','Originate','7023734037','Exten: 138331*8*Y9260842500000000012*100502*100502','Context: default','Channel: Local/172*024*000*088*100502@default','Priority: 1','Callerid: "7023734037" <7023734037>','Timeout: 29000','','','','')|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
[Sep 26 08:42:50] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 26 08:42:50] -- Called 172*024*000*088*100502@default
[Sep 26 08:42:50] -- Executing [172*024*000*088*100502@default:1] Goto("Local/172*024*000*088*100502@default-00000009;2", "default,100502,1") in new stack
[Sep 26 08:42:50] -- Goto (default,100502,1)
[Sep 26 08:42:50] -- Executing [100502@default:1] Dial("Local/172*024*000*088*100502@default-00000009;2", "SIP/100502,60,") in new stack
[Sep 26 08:42:50] == Using SIP RTP CoS mark 5
[Sep 26 08:42:50] -- Called SIP/100502
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 29.75|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.25|51|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:50|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 29.5|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.5|52|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
[Sep 26 08:42:51] > 0x7ff6c4010f30 -- Strict RTP learning complete - Locking on source address 34.203.250.214:13918
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 29.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.75|53|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
[Sep 26 08:42:51] -- SIP/100502-0000000e is ringing
[Sep 26 08:42:51] -- Local/172*024*000*088*100502@default-00000009;1 is ringing
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 29|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1|54|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 28.75|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.25|55|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:51|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 28.5|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.5|56|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 28.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.75|57|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 27.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|2|58|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:52|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
[Sep 26 08:42:52] -- Started music on hold, class 'default', on channel 'SIP/twilio2-0000000d'
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 26.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|3|59|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:53|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 25.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|4|60|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:54|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'SCHED_MAN' and call_time < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0' and agent_only='';|
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and group_id='SCHED_MAN' and call_date < "2018-09-26 08:42:50" and lead_id != '12' and queue_priority >= '0';|
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '12' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 24.25|30|30 SIP/twilio2-0000000d|Y9260842500000000012
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|5|61|60|0|0||0|update of vla table: SCHED_MAN|
|SELECT count(*) FROM vicidial_inbound_callback_queue where icbq_status IN('LIVE','SENDING') and lead_id != '12' and ( (queue_priority > '0') or (queue_priority = '0' and call_date < "2018-09-26 08:42:50") );|
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2018-09-26 08:42:50|08:42:55|agi-VDAD_ALL_inbound.agi|-- VDAC posttime record: |1|20180926084304|Y9260842500000000012||
[Sep 26 08:42:55] -- Stopped music on hold on SIP/twilio2-0000000d
[Sep 26 08:42:55] -- <SIP/twilio2-0000000d> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Sep 26 08:42:55] -- <SIP/twilio2-0000000d> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Sep 26 08:42:55] -- <SIP/twilio2-0000000d> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Sep 26 08:42:55] -- <SIP/twilio2-0000000d> Playing 'generic_hold.slin' (escape_digits=) (sample_offset 0) (language 'en')
[Sep 26 08:42:57] > 0x7ff6c0018b90 -- Strict RTP learning after remote address set to: 68.227.14.30:58228
[Sep 26 08:42:57] -- SIP/100502-0000000e answered Local/172*024*000*088*100502@default-00000009;2
[Sep 26 08:42:57] -- Local/172*024*000*088*100502@default-00000009;1 answered
[Sep 26 08:42:57] -- Executing [138331*8*Y9260842500000000012*100502*100502@default:1] AGI("Local/172*024*000*088*100502@default-00000009;1", "agi-VDAD_local_optimize.agi,7023734037") in new stack
[Sep 26 08:42:57] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_local_optimize.agi
[Sep 26 08:42:57] -- Channel SIP/100502-0000000e joined 'simple_bridge' basic-bridge <34762d3b-07dc-46a1-a097-2c2ce5615109>
[Sep 26 08:42:57] -- Channel Local/172*024*000*088*100502@default-00000009;2 joined 'simple_bridge' basic-bridge <34762d3b-07dc-46a1-a097-2c2ce5615109>
1537969377.430476
SELECT dest_channel FROM cid_channels_recent where (caller_id_name = 'Test Agent' or connected_line_name = '7023734037' or caller_id_name = '7023734037' or connected_line_name = 'Test Agent') and ( linkedid = '1537969370.52' or dest_uniqueid = '1537969370.52' or uniqueid = '1537969370.52') and call_date > '2018-09-26 08:40:57'
NO DestChannel for callid Test Agent|Local/172*024*000*088*100502@default-00000009;1!!!
[Sep 26 08:42:57] -- <Local/172*024*000*088*100502@default-00000009;1>AGI Script agi-VDAD_local_optimize.agi completed, returning 0
[Sep 26 08:42:57] -- Executing [138331*8*Y9260842500000000012*100502*100502@default:2] Wait("Local/172*024*000*088*100502@default-00000009;1", "2") in new stack
[Sep 26 08:42:58] > 0x7ff6c0018b90 -- Strict RTP switching to RTP target address 68.227.14.30:58228 as source
[Sep 26 08:42:58] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 26 08:42:58] > 0x7ff6c0018b90 -- Strict RTP learning complete - Locking on source address 68.227.14.30:58228
[Sep 26 08:42:59] -- Executing [138331*8*Y9260842500000000012*100502*100502@default:3] Hangup("Local/172*024*000*088*100502@default-00000009;1", "") in new stack
[Sep 26 08:42:59] == Spawn extension (default, 138331*8*Y9260842500000000012*100502*100502, 3) exited non-zero on 'Local/172*024*000*088*100502@default-00000009;1'
[Sep 26 08:42:59] WARNING[10024][C-00000018]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Sep 26 08:42:59] -- Executing [h@default:1] AGI("Local/172*024*000*088*100502@default-00000009;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[Sep 26 08:42:59] -- <Local/172*024*000*088*100502@default-00000009;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------) completed, returning 0
[Sep 26 08:42:59] -- Channel Local/172*024*000*088*100502@default-00000009;2 left 'simple_bridge' basic-bridge <34762d3b-07dc-46a1-a097-2c2ce5615109>
[Sep 26 08:42:59] == Spawn extension (default, 100502, 1) exited non-zero on 'Local/172*024*000*088*100502@default-00000009;2'
[Sep 26 08:42:59] -- Executing [h@default:1] AGI("Local/172*024*000*088*100502@default-00000009;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----8-----2-----SIP 200 OK)") in new stack
[Sep 26 08:42:59] -- Channel SIP/100502-0000000e left 'simple_bridge' basic-bridge <34762d3b-07dc-46a1-a097-2c2ce5615109>
[Sep 26 08:42:59] -- <Local/172*024*000*088*100502@default-00000009;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----8-----2-----SIP 200 OK) completed, returning 0
[Sep 26 08:43:01] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 26 08:43:01] == Manager 'sendcron' logged off from 127.0.0.1