vicidial.org

by **elondoninc** » Sun Dec 31, 2017 2:29 pm

ISO: Vicibox 8.0.1
VERSION: 2.14-632a
BUILD: 170930-0853

Happy new year everyone!

Looking for some help with an issue I am encountering, here is the scenario:

DID -> Ingroup with Remote Agents that correspond to internal extensions on the same telephony server. (Hard Phones - Yealink T-21) - They are an office environment with a separate call center that is doing blended outbound autodialing and inbound call fielding. The office environment doesnt want to be logging in as agents through agent screen... They just want to use their phones like a normal PBX (Like Freepbx or another asterisk distro). In the past I would segregate these people into a separate FPBX deployment and allow them to transfer to vicidial using a trunk between them. After MANY consulting calls over the past couple of years with our good friend Bill (William Conley), he gently hammered into my brain that there is no need for that as vicidial can do it all. So i'm taking that advice.

The remote agents are simply pointing to the extensions ie: remote agent, 1 line, user id 1001, External Extension: 1001 .

Ok Here is the issue:

When call comes into the ingroup, it wont call the extensions if they are set as on hook agents whether at the phone setting level in admin panel of vicidial, or at the remote agent level. If they are set to on-hook - off, and I have it handle call distribution as random, campaign rank, inbound group rank, etc., it will go to one of the extensions, but in reality, that doesnt work for me because we want to be able to have it give the agent the opportunity to pick up the call or not, and I can have it fail over to a different extension, or ingroup, or go to a call menu.

So the main problem here, is that It just wont ring the extensions if they are set as on hook. I see the call come in on realtime, but it just sits there, while I listen to the stock music, but it doesnt ring anyone.

What am I missing here? Im sure something simple I overlooked.

Thanks

by **elondoninc** » Wed Jan 03, 2018 7:03 pm

Was Hoping Someone could give me a hand here? Anyone out there?

by **mflorell** » Wed Jan 03, 2018 7:42 pm

Post some Asterisk cli output of this happening with the AGI output for the server set to BOTH.

by **elondoninc** » Fri Jan 05, 2018 5:15 pm

Oh yes of course. Thanks Matt. Here you go.

Code: Select all: [Jan 5 14:12:13] == Using SIP RTP CoS mark 5 [Jan 5 14:12:13] > 0x7faa402569c0 -- Strict RTP learning after remote address set to: 208.8.8.8:9190 [Jan 5 14:12:13] -- Executing [18055551212@trunkinbound:1] AGI("SIP/SB-0000366c", "agi-DID_route.agi") in new stack [Jan 5 14:12:13] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi [Jan 5 14:12:13] -- <SIP/SB-0000366c>AGI Script agi-DID_route.agi completed, returning 0 [Jan 5 14:12:13] -- Executing [99909*5***DID@default:1] Answer("SIP/SB-0000366c", "") in new stack [Jan 5 14:12:14] -- Executing [99909*5***DID@default:2] AGI("SIP/SB-0000366c", "agi-VDAD_ALL_inbound.agi") in new stack [Jan 5 14:12:14] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi [Jan 5 14:12:14] -- <SIP/SB-0000366c> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:14] > 0x7faa402569c0 -- Strict RTP switching to RTP remote address 208.93.226.5:9190 as source [Jan 5 14:12:14] -- <SIP/SB-0000366c> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:14] == Manager 'sendcron' logged on from 127.0.0.1 [Jan 5 14:12:14] == Manager 'sendcron' logged on from 127.0.0.1 [Jan 5 14:12:15] > 0x7faa402569c0 -- Strict RTP learning complete - Locking on source address 208.8.8.8:9190 [Jan 5 14:12:15] == Manager 'sendcron' logged off from 127.0.0.1 [Jan 5 14:12:15] == Manager 'sendcron' logged off from 127.0.0.1 [Jan 5 14:12:16] -- Started music on hold, class 'default', on SIP/SB-0000366c [Jan 5 14:12:19] -- Stopped music on hold on SIP/SB-0000366c [Jan 5 14:12:19] -- <SIP/SB-0000366c> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:19] -- <SIP/SB-0000366c> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:19] -- <SIP/SB-0000366c> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:19] -- <SIP/SB-0000366c> Playing 'generic_hold.gsm' (escape_digits=) (sample_offset 0) (language 'en') [Jan 5 14:12:25] -- Started music on hold, class 'default', on SIP/SB-0000366c

by **mflorell** » Fri Jan 05, 2018 8:33 pm

Please confirm that you have the AGI output for this server set to BOTH, the output you posted is not showing any of it.

by **elondoninc** » Sun Jan 07, 2018 12:13 pm

mflorell wrote:Please confirm that you have the AGI output for this server set to BOTH, the output you posted is not showing any of it.

That's the thing, I definitely do have it set to both, I found it odd as well.

by **mflorell** » Sun Jan 07, 2018 2:05 pm

Are you connected to the asterisk original screen? ("screen -r asterisk")

by **elondoninc** » Fri Mar 02, 2018 3:35 pm

Sorry, I wasn't here you go, thanks for the help Matt

Code: Select all: call_time < "2018-03-02 12:27:48" and lead_id != '126273' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:27:48|12:28:02|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126273' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:27:48") );| 2018-03-02 12:27:48|12:28:02|agi-VDAD_ALL_inbound.agi|||SELECT conf_exten,user,extension,server_ip,last_call_time,ra_user,campaign_id,on_hook_agent,on_hook_ring_time FROM vicidial_live_agents where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('IG1','Office','2000','2001','2002','2003','IG2','Test','2005','INBRAD','INSTEVE') and closer_campaigns LIKE "% INBOUNDSTEVE2ND %" and last_update_time > '20180302122741' and vicidial_live_agents.user NOT IN('','') order by random_id limit 1;| 2018-03-02 12:27:48|12:28:02|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |15|14|3|60|0|0|0|0|update of vla table: INBOUNDSTEVE2ND| |UNLOCK TABLES;| 2018-03-02 12:27:48|12:28:02|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:27:48|12:28:02|agi-VDAD_ALL_inbound.agi|ring_no_answer_agents reset == [Mar 2 12:28:03] == Manager 'sendcron' logged off from 127.0.0.1 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDSTEVE2ND' and call_time < "2018-03-02 12:27:48" and lead_id != '126273' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126273' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:27:48") );| 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|||SELECT conf_exten,user,extension,server_ip,last_call_time,ra_user,campaign_id,on_hook_agent,on_hook_ring_time FROM vicidial_live_agents where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('IG1','Office','2000','2001','2002','2003','IG2','Test','2005','INBRAD','INSTEVE') and closer_campaigns LIKE "% INBOUNDSTEVE2ND %" and last_update_time > '20180302122741' and vicidial_live_agents.user NOT IN('','') order by random_id limit 1;| 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |15|15|4|60|0|0|0|0|update of vla table: INBOUNDSTEVE2ND| |UNLOCK TABLES;| 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:27:48|12:28:03|agi-VDAD_ALL_inbound.agi|ring_no_answer_agents reset Setting CID ""Y3021227480000126273 <8185551212>"" 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|callerID changed: "Y3021227480000126273 <8185551212>" 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|-- VDCL DROP: |VOICEMAIL|85026666666666007|default| 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|-- VDCL vac record deleted: |1| INBOUNDSTEVE2ND| 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|-- VDCL vcl update: |1|126273| |UPDATE vicidial_closer_log set status='TIMEOT',end_epoch='1520022484',length_in_sec='15',queue_seconds='15',term_reason='QUEUETIMEOUT' where lead_id='126273' order by closecallid desc limit 1;| 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|-- vicidial_drop_log insert: |1|1520022468.354|126273|TIMEOT| 2018-03-02 12:28:04|12:28:04|agi-VDAD_ALL_inbound.agi|-- VDCL vl update: |1|126273| |UPDATE vicidial_list set status='TIMEOT' where lead_id = '126273';| -- [Mar 2 12:28:04] -- Stopped music on hold on IAX2/ASTloop-11312 -- [Mar 2 12:28:04] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:28:04] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:28:05] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:28:05] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:28:05] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:28:05] -- <IAX2/ASTloop-11312> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') 2018-03-02 12:28:04|12:28:05|agi-VDAD_ALL_inbound.agi|exiting the VDAD app, transferring call to 85026666666666007 DBI::db=HASH(0x172d320)->disconnect invalidates 1 active statement handle (either destroy statement handles or call finish on them before disconnecting) at /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi line 5912, <STDIN> line 61. -- [Mar 2 12:28:05] -- <IAX2/ASTloop-11312>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0 -- [Mar 2 12:28:05] -- Executing [85026666666666007@default:1] Wait("IAX2/ASTloop-11312", "1") in new stack == [Mar 2 12:28:06] == Manager 'sendcron' logged on from 127.0.0.1 == [Mar 2 12:28:06] == Manager 'sendcron' logged off from 127.0.0.1 -- [Mar 2 12:28:06] -- Executing [85026666666666007@default:2] VoiceMail("IAX2/ASTloop-11312", "007,u") in new stack -- [Mar 2 12:28:06] -- <IAX2/ASTloop-11312> Playing 'vm-theperson.gsm' (language 'en') -- [Mar 2 12:28:08] -- <IAX2/ASTloop-11312> Playing 'digits/0.gsm' (language 'en') -- [Mar 2 12:28:09] -- <IAX2/ASTloop-11312> Playing 'digits/0.gsm' (language 'en') -- [Mar 2 12:28:10] -- <IAX2/ASTloop-11312> Playing 'digits/7.gsm' (language 'en') -- [Mar 2 12:28:11] -- <IAX2/ASTloop-11312> Playing 'vm-isunavail.gsm' (language 'en') -- [Mar 2 12:28:12] -- <IAX2/ASTloop-11312> Playing 'vm-intro.gsm' (language 'en') -- [Mar 2 12:28:13] -- Executing [h@default:1] AGI("SIP/SPP2-000000b4", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----38-----25") in new stack -- [Mar 2 12:28:13] -- <SIP/SPP2-000000b4>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----38-----25 completed, returning 0 -- [Mar 2 12:28:13] -- Hungup 'IAX2/127.0.0.1:40569-6391' == [Mar 2 12:28:13] == Spawn extension (default, 85026666666666007, 2) exited non-zero on 'IAX2/ASTloop-11312' -- [Mar 2 12:28:13] -- Executing [h@default:1] AGI("IAX2/ASTloop-11312", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack == [Mar 2 12:28:13] == Spawn extension (default, 90009*INBOUNDSTEVE2ND**126273**8185551212*18182132958*, 2) exited non-zero on 'SIP/SPP2-000000b4' -- [Mar 2 12:28:13] -- <IAX2/ASTloop-11312>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0 -- [Mar 2 12:28:13] -- Hungup 'IAX2/ASTloop-11312' == [Mar 2 12:29:01] == Manager 'sendcron' logged on from 127.0.0.1 == [Mar 2 12:29:01] == Manager 'sendcron' logged on from 127.0.0.1 == [Mar 2 12:29:01] == Manager 'sendcron' logged off from 127.0.0.1 == [Mar 2 12:29:03] == Manager 'sendcron' logged off from 127.0.0.1 -- [Mar 2 12:29:06] -- Remote UNIX connection disconnected == [Mar 2 12:29:06] == Manager 'sendcron' logged on from 127.0.0.1 == [Mar 2 12:29:06] == Manager 'sendcron' logged off from 127.0.0.1 == [Mar 2 12:29:16] == Using SIP RTP CoS mark 5 > [Mar 2 12:29:16] > 0x7fa01c090d00 -- Strict RTP learning after remote address set to: 67.231.1.75:34438 -- [Mar 2 12:29:16] -- Executing [18182132958@trunkinbound:1] AGI("SIP/SPP2-000000b5", "agi-DID_route.agi") in new stack -- [Mar 2 12:29:16] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi 2018-03-02 12:29:16|agi-DID_route.agi||INSERT INTO vicidial_did_log SET uniqueid='1520022556.355',channel='SIP/SPP2-000000b5',server_ip='192.168.1.107',caller_id_number='8185551212',caller_id_name='',extension='18182132958',call_date='2018-03-02 12:29:16',did_id='12',did_route='IN_GROUP';| 2018-03-02 12:29:16|agi-DID_route.agi|-- DID LOG : |1|INSERT INTO vicidial_did_log SET uniqueid='1520022556.355',channel='SIP/SPP2-000000b5',server_ip='192.168.1.107',caller_id_number='8185551212',caller_id_name='',extension='18182132958',call_date='2018-03-02 12:29:16',did_id='12',did_route='IN_GROUP';| 2018-03-02 12:29:16|agi-DID_route.agi|-- CALL LOG : |1|INSERT INTO call_log SET uniqueid='1520022556.355', channel='SIP/SPP2-000000b5', channel_group='DID_INBOUND', server_ip='192.168.1.107', type='SIP', extension='18182132958', number_dialed='18182132958', caller_code='8185551212', start_time='2018-03-02 12:29:16', start_epoch='1520022556';| 2018-03-02 12:29:16|agi-DID_route.agi|exiting the DID app, transferring call to 99909*12***DID @ default -- [Mar 2 12:29:16] -- <SIP/SPP2-000000b5>AGI Script agi-DID_route.agi completed, returning 0 -- [Mar 2 12:29:16] -- Executing [99909*12***DID@default:1] Answer("SIP/SPP2-000000b5", "") in new stack -- [Mar 2 12:29:17] -- Executing [99909*12***DID@default:2] AGI("SIP/SPP2-000000b5", "agi-VDAD_ALL_inbound.agi") in new stack -- [Mar 2 12:29:17] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- accountcode = 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- callerid = 8185551212 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- calleridname = unknown 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- callingani2 = 0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- callingpres = 0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- callingtns = 0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- callington = 0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- channel = SIP/SPP2-000000b5 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- context = default 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- dnid = 18182132958 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- enhanced = 0.0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- extension = 99909*12***DID 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- language = en 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- priority = 2 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- rdnis = unknown 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- request = agi-VDAD_ALL_inbound.agi 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- threadid = 140327423436544 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- type = SIP 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- uniqueid = 1520022556.355 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi| -- version = 11.25.3-vici 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|AGI Variables: |1520022556.355|SIP/SPP2-000000b5|99909*12***DID|SIP|8185551212| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|+++++ INBOUND CALL VDCL STARTED : |INBOUNDBRAD|8185551212-18182132958|2018-03-02 12:29:17 -- [Mar 2 12:29:17] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') > [Mar 2 12:29:17] > 0x7fa01c090d00 -- Strict RTP switching to RTP remote address 67.231.1.75:34438 as source -- [Mar 2 12:29:17] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi||SELECT campaign_id FROM vicidial_campaigns where active='Y' and campaign_allow_inbound='Y';|126274| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|callerID changed: "Y3021229170000126274 <8185551212>" 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|SELECT auto_call_id from vicidial_auto_calls where uniqueid='1520022556.355' and server_ip='192.168.1.107';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_auto_calls SET server_ip='192.168.1.107', campaign_id='INBOUNDBRAD', status='LIVE', lead_id='126274', uniqueid='1520022556.355', callerid='Y3021229170000126274', channel='SIP/SPP2-000000b5', phone_code='1', phone_number='8185551212', call_time='2018-03-02 12:29:17', call_type='IN', stage='LIVE-0', queue_priority='0' ;| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|1|SELECT count(*) from vicidial_auto_calls where status = 'LIVE' and campaign_id='INBOUNDBRAD';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|1|UPDATE vicidial_auto_calls SET queue_position='1' WHERE auto_call_id='1469';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_closer_log SET lead_id='126274', campaign_id='INBOUNDBRAD', call_date='2018-03-02 12:29:17', start_epoch='1520022557', status='QUEUE', phone_code='1', phone_number='8185551212', user='VDCL', processed='N', xfercallid='0', uniqueid='1520022556.355', queue_position='1',called_count='1',list_id='999' ;| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|-- VDCL : |126274|0|866|insert to vicidial_closer_log 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|-- ENTER QUEUE VLE insert: |1| |INSERT INTO vicidial_log_extended set uniqueid='1520022556.355',server_ip='192.168.1.107',call_date='2018-03-02 12:29:17',lead_id = '126274',caller_code='Y3021229170000126274',custom_call_id='';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|DID IVR time logged: 2018-03-02 12:29:17|1520022557|1|UPDATE call_log set end_time='2018-03-02 12:29:17',end_epoch='1520022557',length_in_sec=1,length_in_min=' 0.02',extension='Y3021229170000126274' where uniqueid='1520022556.355'| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|2005|2018-03-02 12:27:14|SELECT conf_exten,user,extension,server_ip,last_call_time,ra_user,campaign_id,on_hook_agent,on_hook_ring_time FROM vicidial_live_agents where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('IG1','Office','2000','2001','2002','2003','IG2','Test','2005','INBRAD','INSTEVE') and closer_campaigns LIKE "% INBOUNDBRAD %" and last_update_time > '20180302122910' and vicidial_live_agents.user NOT IN('','') order by vicidial_live_agents.last_inbound_call_finish limit 1;| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|ON-HOOK-AGENT UPDATE: |UPDATE vicidial_live_agents set ring_callerid='Y3021229170000126274' where user='2005';|1|Y|0 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|RING-AGENT CALL SENT: |8185551212|138331*1469*Y3021229170000126274*2005*|0|4|CUSTOMER_PHONE|| SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|0|50|60|0|0||0|update of vla table: INBOUNDBRAD| |INSERT INTO vicidial_manager values('','','2018-03-02 12:29:17','NEW','N','192.168.1.107','','Originate','8185551212','Exten: 138331*1469*Y3021229170000126274*2005*','Context: default','Channel: Local/192*168*001*107*2005@default','Priority: 1','Callerid: 8185551212','Timeout: 3000','','','','')| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found == [Mar 2 12:29:17] == Manager 'sendcron' logged on from 127.0.0.1 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 3.75|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|0.25|51|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 3.5|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|0.5|52|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:17|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found > [Mar 2 12:29:18] > 0x7fa01c090d00 -- Strict RTP learning complete - Locking on source address 67.231.1.75:34438 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 3.25|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|0.75|53|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 3|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|1|54|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found == [Mar 2 12:29:18] == Manager 'sendcron' logged off from 127.0.0.1 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 2.75|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|1.25|55|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 2.5|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|1.5|56|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:18|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 2.25|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|1.75|57|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 1.25|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|2|58|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:19|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found -- [Mar 2 12:29:19] -- Started music on hold, class 'default', on SIP/SPP2-000000b5 2018-03-02 12:29:17|12:29:20|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:20|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:20|agi-VDAD_ALL_inbound.agi|RING-AGENT TIMER: 0.25|4|4 SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:20|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|3|59|60|0|0||0|update of vla table: INBOUNDBRAD| |UPDATE vicidial_live_agents SET ring_callerid='' where ring_callerid='Y3021229170000126274';| 2018-03-02 12:29:17|12:29:20|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi||2018-03-02 12:27:14|SELECT conf_exten,user,extension,server_ip,last_call_time,ra_user,campaign_id,on_hook_agent,on_hook_ring_time FROM vicidial_live_agents where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('IG1','Office','2000','2001','2002','2003','IG2','Test','2005','INBRAD','INSTEVE') and closer_campaigns LIKE "% INBOUNDBRAD %" and last_update_time > '20180302122910' and vicidial_live_agents.user NOT IN('','2005','') order by vicidial_live_agents.last_inbound_call_finish limit 1;| 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|4|60|60|0|0||0|update of vla table: INBOUNDBRAD| |UNLOCK TABLES;| 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:21|agi-VDAD_ALL_inbound.agi|ring_no_answer_agents reset 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDBRAD' and call_time < "2018-03-02 12:29:17" and lead_id != '126274' and queue_priority >= '0' and agent_only='';| 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '126274' and agent_only='' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2018-03-02 12:29:17") );| 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|2005|2018-03-02 12:27:14|SELECT conf_exten,user,extension,server_ip,last_call_time,ra_user,campaign_id,on_hook_agent,on_hook_ring_time FROM vicidial_live_agents where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('IG1','Office','2000','2001','2002','2003','IG2','Test','2005','INBRAD','INSTEVE') and closer_campaigns LIKE "% INBOUNDBRAD %" and last_update_time > '20180302122910' and vicidial_live_agents.user NOT IN('','') order by vicidial_live_agents.last_inbound_call_finish limit 1;| 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|ON-HOOK-AGENT UPDATE: |UPDATE vicidial_live_agents set ring_callerid='Y3021229170000126274' where user='2005';|1|Y|0 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|RING-AGENT CALL SENT: |8185551212|138331*1469*Y3021229170000126274*2005*|0|4|CUSTOMER_PHONE|| SIP/SPP2-000000b5|Y3021229170000126274 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |10|5|61|60|0|0||0|update of vla table: INBOUNDBRAD| |INSERT INTO vicidial_manager values('','','2018-03-02 12:29:17','NEW','N','192.168.1.107','','Originate','8185551212','Exten: 138331*1469*Y3021229170000126274*2005*','Context: default','Channel: Local/192*168*001*107*2005@default','Priority: 1','Callerid: 8185551212','Timeout: 3000','','','','')| 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found 2018-03-02 12:29:17|12:29:22|agi-VDAD_ALL_inbound.agi|-- VDAC posttime record: |1|20180302122931|Y3021229170000126274|| -- [Mar 2 12:29:22] -- Stopped music on hold on SIP/SPP2-000000b5 -- [Mar 2 12:29:22] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:22] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:22] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:22] -- <SIP/SPP2-000000b5> Playing 'generic_hold.gsm' (escape_digits=) (sample_offset 0) (language 'en') == [Mar 2 12:29:22] == Manager 'sendcron' logged on from 127.0.0.1 == [Mar 2 12:29:23] == Manager 'sendcron' logged off from 127.0.0.1 2018-03-02 12:29:28|12:29:28|agi-VDAD_ALL_inbound.agi|-- VDCL DROP: |IN_GROUP|90009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*|default| 2018-03-02 12:29:28|12:29:28|agi-VDAD_ALL_inbound.agi|-- VDCL vac record deleted: |1| INBOUNDBRAD| 2018-03-02 12:29:28|12:29:28|agi-VDAD_ALL_inbound.agi|-- VDCL vcl update: |1|126274| |UPDATE vicidial_closer_log set status='TIMEOT',end_epoch='1520022568',length_in_sec='10',queue_seconds='10',term_reason='QUEUETIMEOUT' where lead_id='126274' order by closecallid desc limit 1;| 2018-03-02 12:29:28|12:29:28|agi-VDAD_ALL_inbound.agi|-- vicidial_drop_log insert: |1|1520022556.355|126274|TIMEOT| 2018-03-02 12:29:28|12:29:28|agi-VDAD_ALL_inbound.agi|-- VDCL vl update: |1|126274| |UPDATE vicidial_list set status='TIMEOT' where lead_id = '126274';| -- [Mar 2 12:29:28] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:28] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:29] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:29] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:29] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:29] -- <SIP/SPP2-000000b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') 2018-03-02 12:29:28|12:29:29|agi-VDAD_ALL_inbound.agi|exiting the VDAD app, transferring call to 90009*INBOUNDSTEVE2ND**126274**8185551212*18182132958* DBI::db=HASH(0x2569248)->disconnect invalidates 1 active statement handle (either destroy statement handles or call finish on them before disconnecting) at /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi line 5912, <STDIN> line 52. -- [Mar 2 12:29:29] -- <SIP/SPP2-000000b5>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0 -- [Mar 2 12:29:29] -- Executing [90009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*@default:1] Answer("SIP/SPP2-000000b5", "") in new stack -- [Mar 2 12:29:29] -- Executing [90009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*@default:2] Dial("SIP/SPP2-000000b5", "IAX2/ASTloop:TPLe3V3NnvzhOkf@127.0.0.1:40569/990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*,,to") in new stack -- [Mar 2 12:29:29] -- Called IAX2/ASTloop:TPLe3V3NnvzhOkf@127.0.0.1:40569/990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958* -- [Mar 2 12:29:29] -- Accepting AUTHENTICATED call from 127.0.0.1: -- [Mar 2 12:29:29] -- > requested format = ulaw, -- [Mar 2 12:29:29] -- > requested prefs = (ulaw|gsm), -- [Mar 2 12:29:29] -- > actual format = ulaw, -- [Mar 2 12:29:29] -- > host prefs = (ulaw), -- [Mar 2 12:29:29] -- > priority = mine -- [Mar 2 12:29:29] -- Call accepted by 127.0.0.1 (format ulaw) -- [Mar 2 12:29:29] -- Format for call is (ulaw) -- [Mar 2 12:29:29] -- Executing [990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*@default:1] Answer("IAX2/ASTloop-12870", "") in new stack -- [Mar 2 12:29:29] -- IAX2/127.0.0.1:40569-4841 answered SIP/SPP2-000000b5 -- [Mar 2 12:29:29] -- Executing [990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*@default:2] AGI("IAX2/ASTloop-12870", "agi-VDAD_ALL_inbound.agi,CLOSER-----LB-----CL_TESTCAMP-----7275551212-----Closer-----park----------999-----1") in new stack -- [Mar 2 12:29:29] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|Perl Environment Dump: 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|0|CLOSER-----LB-----CL_TESTCAMP-----7275551212-----Closer-----park----------999-----1 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|callerID changed: "J3021229290000126274 <8185551212>" 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- accountcode = ASTloop 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- arg_1 = CLOSER-----LB-----CL_TESTCAMP-----7275551212-----Closer-----park----------999-----1 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- callerid = 8185551212 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- calleridname = Y3021229170000126274 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- callingani2 = 0 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- callingpres = 0 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- callingtns = 0 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- callington = 0 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- channel = IAX2/ASTloop-12870 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- context = default 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- dnid = unknown 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- enhanced = 0.0 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- extension = 990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958* 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- language = en 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- priority = 2 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- rdnis = unknown 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- request = agi-VDAD_ALL_inbound.agi 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- threadid = 140327421912832 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- type = IAX2 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- uniqueid = 1520022569.357 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi| -- version = 11.25.3-vici 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|AGI Variables: |1520022569.357|IAX2/ASTloop-12870|990009*INBOUNDSTEVE2ND**126274**8185551212*18182132958*|IAX2|J3021229290000126274| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|+++++ INBOUND CALL VDCL STARTED : |INBOUNDSTEVE2ND|J3021229290000126274-|2018-03-02 12:29:29 -- [Mar 2 12:29:29] -- <IAX2/ASTloop-12870> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') -- [Mar 2 12:29:29] -- <IAX2/ASTloop-12870> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en') 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi||SELECT campaign_id FROM vicidial_campaigns where active='Y' and campaign_allow_inbound='Y';|126274| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|callerID changed: "Y3021229290000126274 <8185551212>" 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_xfer_log (lead_id,campaign_id,call_date,phone_code,phone_number,user,closer,list_id,front_uniqueid,close_uniqueid) values('126274','INBOUNDSTEVE2ND','2018-03-02 12:29:29','1','8185551212','18182132958','VDXL','999','1520022556.355','1520022569.357')| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|-- VDXL : |126274|22|insert to vicidial_xfer_log 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|0|SELECT auto_call_id from vicidial_auto_calls where uniqueid='1520022569.357' and server_ip='192.168.1.107';| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_auto_calls SET server_ip='192.168.1.107', campaign_id='INBOUNDSTEVE2ND', status='LIVE', lead_id='126274', uniqueid='1520022569.357', callerid='Y3021229290000126274', channel='IAX2/ASTloop-12870', phone_code='1', phone_number='8185551212', call_time='2018-03-02 12:29:29', call_type='IN', stage='LIVE-0', queue_priority='0' ;| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|1|SELECT count(*) from vicidial_auto_calls where status = 'LIVE' and campaign_id='INBOUNDSTEVE2ND';| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|1|UPDATE vicidial_auto_calls SET queue_position='1' WHERE auto_call_id='1470';| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_closer_log SET lead_id='126274', campaign_id='INBOUNDSTEVE2ND', call_date='2018-03-02 12:29:29', start_epoch='1520022569', status='QUEUE', phone_code='1', phone_number='8185551212', user='VDCL', processed='N', xfercallid='22', uniqueid='1520022569.357', queue_position='1',called_count='1',list_id='999' ;| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|-- VDCL : |126274|22|867|insert to vicidial_closer_log 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|-- ENTER QUEUE VLE insert: |1| |INSERT INTO vicidial_log_extended set uniqueid='1520022569.357',server_ip='192.168.1.107',call_date='2018-03-02 12:29:29',lead_id = '126274',caller_code='Y3021229290000126274',custom_call_id='';| 2018-03-02 12:29:29|12:29:29|agi-VDAD_ALL_inbound.agi|0|0|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'INBOUNDSTEVE2ND' and call_time < "2018-03-02 12:29:29" and lead_id != '126274' and queue_priority >= '0' and agent_only='';|

by **mflorell** » Fri Mar 02, 2018 4:55 pm

Did you try upgrading this server to Asterisk 13 at some point?

Can you confirm that the Asterisk version in the Modify Server page is set correctly?

by **elondoninc** » Sun Mar 04, 2018 9:57 pm

I didn't try to upgrade the version of asterisk no. It is set to 11.25.3-vici which is what shows up in the cli when I enter asterisk -r without any verbose. Should I upgrade to Asterisk v13? I will say that I noticed that the SVN Versions for DB and the Telephony server are not the same. DB Server showing VER: 2823 and Telephony Server is Showing Ver: 2829. Strangely, I did run the SVN Checkout a couple of days ago, and yet it still shows them on different SVN Versions nonetheless. Is that normal behavior? Another mention I should add is that this is a cluster, However in the attempt to make this as "Multi-Tenant" as possible, - Each Telephony server (we have 10 of them, not all in production, but setup and ready to go) are pointing to their own individual database on the database server as opposed to "asterisk" being the db to point to. The astguiclient.conf on the telephony server is pointing to the proper database on the server, and autodialing works great, as do all of the other features. I have the propper scripts running on the telephony servers crontab's respectively. I wonder if this could have something to do with it?

by **mflorell** » Mon Mar 05, 2018 6:10 am

Looks like there was actually a bug in that version of the inbound AGI script, so you'll have to upgrade to a more recent svn/trunk to fix this.

by **elondoninc** » Thu Mar 08, 2018 1:57 pm

Yup, I did an SVN Checkout and upgraded the schema for the DB, and now its working. Was definitely a bug. Thanks Matt. On another note, upgrading to asterisk 13 totally screws up the telephony servers on my end, and I followed your instructions to a T on your sticky, was already upgraded to most recent svn/trunk before upgrade. And by screwed up, I mean it makes calls but caller just gets hung up on. Will open a new thread for that, so that we can test around with it and contribute to others here.

vicidial.org

Ingroup Remote Agents on-hook - not ringing agents

Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Re: Ingroup Remote Agents on-hook - not ringing agents

Who is online