Page 1 of 1

agi-VDADcloser_inbound Scripts

PostPosted: Fri Aug 11, 2006 1:44 pm
by MoutaPT
Hi all,

I'm learning the use of Vicidial, i've it installed and seems to be everything ok.

My problem now is to be sure how to use this Inbound Agi Scripts:

agi-VDADcloser_inbound.agi
agi-VDADcloser_inboundANI.agi
agi-VDADcloser_inboundCID.agi
agi-VDADcloser_inboundCIDlookup.agi
agi-VDADcloser_inbound_5ID.agi
agi-VDADcloser_inbound_NOCID.agi

Do i have to make my diaplan with :

exten=>s,1,agi-VDADcloser_inbound_NOCID.agi

exten=_X,1,agi-VDADcloser_inboundCID.agi


so Vicidial could handle correctly caller ID and fill my customer details in Vicidial panel?

I've tried agi-VDADcloser_inboundCID.agi and agi-VDADcloser_inboundCIDlookup.agi and then make a call to vicial two times with same caller id.

On first call i've full filled all customers details, but when i call for the 2nd time i still get no details....

Am I doing something wrong? Isn't suposed to retrieve customer details from vicidial tables?

Best regards,
Marco Mouta

ps. Some times i seem to get lost in logins with my agents, they log correctly but they don't receive calls.

Also i've already found more than once:

Aug 10 18:39:52 WARNING[1650]: channel.c:787 channel_find_locked: Avoided initial deadlock for '0x81b8500', 10 retries!

What does this means?

PostPosted: Fri Aug 11, 2006 1:57 pm
by mflorell
There are somments at the top of most of the inbound scripts describing their use and you can always look in the code to see how it's supposed to work. The CID lookup script has full instructions on it's setup in the header of the file.

As for problems, can you post the Real Asterisk CLI output(not asterisk -r) when you try to call twice from the same number?


As for your deadlock issue, that's just a problem with resources on yoru machine, whether it be netowrk connectivity or hard drive speed.

Are you recording?

Are you using VOIP over the internet?

What are the specs on your machine?

agi-VDADcloser_inbound Scripts

PostPosted: Fri Aug 11, 2006 8:38 pm
by MoutaPT
Hi Matt,

In fact, my architecture is:

PSTN--E1---Leg.Pbx--E1--Asterisk---IAXtrunking---AsteriskVicidial
|
X100P


So i've three ways to dial calls to Vicidial:

Outsideworld calling legacy pbx , then asterisk---Iax trunk --->Vicidial
Voipextension---SIP-----Asterisk -----IAX trunk ---->Vicidial
X100P to Vicidial

I'm not sure where do i get the deadlock, but i think it's for cal from x100p or calls from IAX trunking, i will review this...

My hardware is Pentium 4 , 1GRAM and one x100p only for timer and simple tests.


What could take me to a channel.c deadlock?
ps. agi-VDADcloser_inboundCIDlookup.agi seems to have the same comments of ADcloser_inboundCID.agi. I will get deep in my code watch/learn.

Do you use this kind of db retrieve? i mean on second call, fullfill customer fields=?

MoutaPT

PostPosted: Fri Aug 11, 2006 8:52 pm
by mflorell
yes we do use CID inbound script regularly, although I haven't touched that specific installation in some time, as I am in the AGI code in the next couple weeks I will do some additional tests with it.

Sometimes the CID is delivered differently from one call to another I have noticed on a few carriers which has given me headaches before.

agi-VDADcloser_inbound Scripts

PostPosted: Fri Aug 11, 2006 9:41 pm
by MoutaPT
Hi Matt,

Isn't that enough that $CALLERID be the same in two calls, to get things working fine on the second call? I mean details retrieved correctly from db?

Most of my tests were with VoIPext---Asteriskpbx----IAX---AsteriskVicidial.

I can't understand what is the channel deadlock... so i can't figure out how to debug or avoid it, could you explain me that?

By the way, what is a CLOSER in Vicidial World.

Best regards,
Marco Mouta

PostPosted: Sat Aug 12, 2006 5:23 am
by mflorell
yes, CID should be enough to have it working properly. If it does not please post Real Asterisk CLI output(not asterisk -r) of when both calls come in so that I can debug.

channel deadlock is just a resource allocation issue, sadly Asterisk doesn't tell you what resource. It's usually either bandwidth related for VOIP channels or hard drive related for recordings.

CLOSER campaigns allow you to take inbound calls or do blended in/outbound calling in a campaign.

Retrieving Customer details from db - config problems?

PostPosted: Mon Aug 14, 2006 4:56 am
by MoutaPT
Hi Matt,

my sip.conf for this user is:

[spa2000]
disallow=all
allow=ulaw
allow=alaw
type=friend
username=spa2000
secret=test
host=dynamic
dtmfmode=rfc2833
;dtmfmode=inband
;defaultip=10.10.10.17
qualify=1000
mailbox=2000
callerid="Jane Smith" <5678>


Here is screen -r from my * box:

-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = SIP
-- uniqueid = 1155549021.96

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155549021.96|SALESLINE|SIP/spa2000-081c0dc0|7777|SIP|Jane Smith-7777--x---Closer|2006-08-14 10:50:22
AGI Environment Dump: |1155549021.96|SIP/spa2000-081c0dc0|7777|SIP|Jane Smith|

INBOUND CALL RECEIVED IN FROM VDCL: Jane Smith SIP/spa2000-081c0dc0
+++++ INBOUND VDCL START : |1155549021.96|SIP/spa2000-081c0dc0|7777|SIP|2006-08-14 10:50:22

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 10:50:22','20060814105022','INBND','7777--x---Closer','SALESLINE','VDCL','1','Y','','Jane Smith','SALESLINE','1','-5.00','Jane Smith');|130|
FAIL (unexpected result '')
callerID changed: Y0814105022000000130

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','130','1155549021.96','Y0814105022000000130','SIP/spa2000-081c0dc0','','Jane Smith','2006-08-14 10:50:22','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('130','SALESLINE','2006-08-14 10:50:22','1155549022','QUEUE','','Jane Smith','VDCL','N')|
-- VDCL : |130|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 10:50:22" and lead_id != '130';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='130',uniqueid='1155549021.96', channel='SIP/spa2000-081c0dc0', callerid='Y0814105022000000130' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814105022000000130' and channel='SIP/spa2000-081c0dc0' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814105022000000130
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814105022000000130';|
-- closer log : |1|update of vcl table: 130
|UPDATE vicidial_closer_log set user='12345678' where lead_id='130' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
FAIL (unexpected result '')
FAIL (unexpected result '')
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 10:50:22|2006-08-14 10:50:22
-- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0
-- Executing MeetMe("SIP/spa2000-081c0dc0", "8600051") in new stack

As you can see, probably i'm doing something wrong and that's why i get:

callerID changed: Y0814105022000000130

So this happens in every call, so no way to repeat a 2nd call with same callerid.

Can you guess where is the problem?
Also by the end of screen-r you will find FAIL (unexpected result '').

hope u can help me.

Best regards,
Marco Mouta

PostPosted: Mon Aug 14, 2006 6:12 am
by mflorell
Jane Smith-7777 is not a valid callerID from the PSTN, you should be testing this with inbound callerID delivery that will output 10 digits.

PostPosted: Mon Aug 14, 2006 6:28 am
by MoutaPT
Hi Matt,

I've changed caller id to 1234567890 and still not working, also i've notice that after hanging up call from softphone , the callerid variable has been changed to "unknown"

Here are screen -r from all the call:

-- dnid = 7777
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 5
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = SIP
-- uniqueid = 1155554622.117

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155554622.117|SALESLINE|SIP/spa2000-0819e950|7777|SIP|1234567890-7777|2006-08-14 12:23:43
AGI Environment Dump: |1155554622.117|SIP/spa2000-0819e950|7777|SIP|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 SIP/spa2000-0819e950
+++++ INBOUND VDCL START : |1155554622.117|SIP/spa2000-0819e950|7777|SIP|2006-08-14 12:23:43

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 12:23:43','20060814122343','INBND','7777','SALESLINE','VDCL','1','Y','','1234567890','SALESLINE','1','-5.00','Marco Mouta');|148|
FAIL (unexpected result '')
callerID changed: Y0814122343000000148

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','148','1155554622.117','Y0814122343000000148','SIP/spa2000-0819e950','','1234567890','2006-08-14 12:23:43','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('148','SALESLINE','2006-08-14 12:23:43','1155554623','QUEUE','','1234567890','VDCL','N')|
-- VDCL : |148|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:23:43" and lead_id != '148';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='148',uniqueid='1155554622.117', channel='SIP/spa2000-0819e950', callerid='Y0814122343000000148' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814122343000000148' and channel='SIP/spa2000-0819e950' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814122343000000148
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814122343000000148';|
-- closer log : |1|update of vcl table: 148
|UPDATE vicidial_closer_log set user='12345678' where lead_id='148' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
FAIL (unexpected result '')
FAIL (unexpected result '')
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 12:23:43|2006-08-14 12:23:43
-- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0
-- Executing MeetMe("SIP/spa2000-0819e950", "8600051") in new stack



--------- then i've made Caller Hangup from oftphone-------------------

+++++ CALL LOG HUNGUP: |1155554622.117|SIP/spa2000-0819e950|h|2006-08-14 12:24:19|min: |
-- AGI Script call_log.agi completed, returning 0
-- Executing DeadAGI("SIP/spa2000-0819e950", "VD_hangup.agi|PRI-----NODEBUG-----0---------------") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi
Perl Environment Dump:
0|PRI-----NODEBUG-----0---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = unknown
-- calleridname = Y0814122343000000148
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = SIP/spa2000-0819e950
-- context = default
-- dnid = 7777
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = SIP
-- uniqueid = 1155554622.117
AGI Environment Dump: |1155554622.117|SIP/spa2000-0819e950|h|SIP|Y0814122343000000148|Y0814122343000000148|2|

DEBUG: NODEBUG

VD_hangup : Y0814122343000000148 SIP/spa2000-0819e950 2
+++++ VD hangup START : |1155554622.117|SIP/spa2000-0819e950|h|SIP|Y0814122343000000148|148|2006-08-14 12:24:19||2|Y0814122343000000148|


|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155554622.117' limit 1;|
-- VDAC record deleted: |1| |148|1155554622.117|Y0814122343000000148|192.168.34.6


|SELECT start_epoch,status FROM vicidial_log where uniqueid='1155554622.117' and lead_id='148' limit 1;|

VD hangup: no VDL record found: 1155554622.117 Y0814122343000000148 148 1155554622.117


|SELECT start_epoch,status,closecallid FROM vicidial_closer_log where lead_id = '148' and call_date > "2006-08-14 06:24:19" order by call_date desc limit 1;|


|UPDATE vicidial_log set end_epoch='1155554659',length_in_sec='36' where uniqueid = '1155554622.117';|
-- VDAD vicidial_log update: |0|1155554622.117|


|UPDATE vicidial_closer_log set status='DROP',end_epoch='1155554659',length_in_sec='36' where closecallid = '142';|
-- VDCL update: |1|1155554622.117|142|
-- AGI Script VD_hangup.agi completed, returning 0


Would it be hard for you just to post here 1 sip account correctly made as well as a small dialplan invoking correctly the agi script?

my extensions.conf is :
exten => 7777,1,Ringing ; call ringing
exten => 7777,n,Wait(1) ; Wait 1 second for CID delivery from PRI
exten => 7777,n,Answer ; Answer the line
exten => 7777,n,NoOp(TESTE!)
exten =>7777,n,AGI(agi-VDADcloser_inboundCID.agi,SALESLINE-----7777-----Closer-----park---------999-----1)
exten => 7777,n,Hangup

PostPosted: Mon Aug 14, 2006 6:37 am
by mflorell
You cannot test VICIDIAL accurately with and internal account, you need to test throught a SIP/IAX trunk or a PSTN line of some kind.

PostPosted: Mon Aug 14, 2006 6:59 am
by MoutaPT
hi Matt,

Sorry to bother u so much, keeps the same problem and now i'm testing from IAX trunk from another * box.

"FAIL (unexpected result '')
callerID changed: Y0814125814000000161"

What does this means?
Hope u can help me.

here is the post of screen -r




-- Executing AGI("IAX2/dmztocallcenter-9", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer----------999-----1") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi
Perl Environment Dump:
0|SALESLINE-----7777-----Closer----------999-----1|
AGI Environment Dump:
-- accountcode =
-- callerid = 1234567890
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-9
-- context = from-dmz
-- dnid = unknown
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = IAX2
-- uniqueid = 1155556693.132

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155556693.132|SALESLINE|IAX2/dmztocallcenter-9|7777|IAX2|1234567890-7777|2006-08-14 12:58:14
AGI Environment Dump: |1155556693.132|IAX2/dmztocallcenter-9|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-9
+++++ INBOUND VDCL START : |1155556693.132|IAX2/dmztocallcenter-9|7777|IAX2|2006-08-14 12:58:14

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 12:58:14','20060814125814','INBND','7777','SALESLINE','VDCL','1','Y','','1234567890','SALESLINE','1','-5.00','');|161|
FAIL (unexpected result '')
callerID changed: Y0814125814000000161

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','161','1155556693.132','Y0814125814000000161','IAX2/dmztocallcenter-9','','1234567890','2006-08-14 12:58:14','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('161','SALESLINE','2006-08-14 12:58:14','1155556694','QUEUE','','1234567890','VDCL','N')|
-- VDCL : |161|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:58:14" and lead_id != '161';|
WWWWWWWW VDAD XFER WAIT: |3|SALESLINE|IAX2/dmztocallcenter-9|Y0814125814000000161|1155556693.132|


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:58:14" and lead_id != '161';|
WWWWWWWW VDAD XFER WAIT: |3|SALESLINE|IAX2/dmztocallcenter-9|Y0814125814000000161|1155556693.132|



INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155556663.131|SALESLINE|IAX2/dmztocallcenter-2|7777|IAX2|1234567890-7777|2006-08-14 12:57:44
AGI Environment Dump: |1155556663.131|IAX2/dmztocallcenter-2|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-2
+++++ INBOUND VDCL START : |1155556663.131|IAX2/dmztocallcenter-2|7777|IAX2|2006-08-14 12:57:44

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 12:57:44','20060814125744','INBND','7777','SALESLINE','VDCL','1','Y','','1234567890','SALESLINE','1','-5.00','');|160|
FAIL (unexpected result '')
callerID changed: Y0814125744000000160

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','160','1155556663.131','Y0814125744000000160','IAX2/dmztocallcenter-2','','1234567890','2006-08-14 12:57:44','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('160','SALESLINE','2006-08-14 12:57:44','1155556664','QUEUE','','1234567890','VDCL','N')|
-- VDCL : |160|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:57:44" and lead_id != '160';|
WWWWWWWW VDAD XFER WAIT: |2|SALESLINE|IAX2/dmztocallcenter-2|Y0814125744000000160|1155556663.131|


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:57:44" and lead_id != '160';|
WWWWWWWW VDAD XFER WAIT: |2|SALESLINE|IAX2/dmztocallcenter-2|Y0814125744000000160|1155556663.131|


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:57:44" and lead_id != '160';|
WWWWWWWW VDAD XFER WAIT: |2|SALESLINE|IAX2/dmztocallcenter-2|Y0814125744000000160|1155556663.131|


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 12:57:44" and lead_id != '160';|
WWWWWWWW VDAD XFER WAIT: |2|SALESLINE|IAX2/dmztocallcenter-2|Y0814125744000000160|1155556663.131|

$result seems to be empty...

PostPosted: Mon Aug 14, 2006 9:36 am
by MoutaPT
Hi Matt,

I really am a newbie in Vicidial world, so probably is my mistake, but i've found that in :agi-VDADcloser_inboundCID.agi you have:

print "SET CALLERID $YqueryCID\n";
checkresult($result);
print STDERR "callerID changed: $YqueryCID\n";

And it seems to me my problem is there, because checkresult is returning FAIL message.

My doubt is about $result, i couldn't find this variable being set in the script, is this variable loaded from asterisk?

I've printed it to STDERR and i keep this variable always empty, before and after executing checkresult.

Am I going in wrong way to debug this?

Best regards,
Marco Mouta

PostPosted: Mon Aug 14, 2006 10:28 am
by mflorell
Yes, that is a bug, but it is not a cause of a functional problem. The callerID is reset after it has already gotten the callerID from the inbound call. It needs to be changed so that VICIDIAL can track the call's progress throughout the call's life.

You need to be testing this through an outside line or a line coming from another Asterisk server for it to work properly.

PostPosted: Mon Aug 14, 2006 10:39 am
by MoutaPT
Hi Matt,

I'm already testing using this architecture:

VoIPextens---->Asterisk-----IAXtrunk-----AsteriskVicidial

And i get the caller id in Vicidial Agent Web interface, the problem, is that this is not retrieving correctly customers details from previous calls with the same callerID.

I've been reading and I found $result is returned from ASterisk after AGI script
print "SET CALLERID $YqueryCID\n";

Googling this command i found:

SET CALLERID <caller ID specification>
Purpose
Changes the caller ID of the current channel
Returns
Always returns 200 result=1


And as I can see i'm not getting result=1 ...

What should i be doing wrong?

I've also made the outbound CID from the trunk that connects my Asterisk to AsteriskVicidial server something like <1234567890> and i test with and without "<>".


Is there something obviously you can tell me doing wrong?

Best regards,
Marco Mouta

PostPosted: Mon Aug 14, 2006 10:49 am
by mflorell
Please post the Asterisk CLI output of a call.

PostPosted: Mon Aug 14, 2006 10:55 am
by MoutaPT
Here you have my Asterisk CLI

-- Accepting AUTHENTICATED call from 19X.XXX.XXX.XX:
> requested format = alaw,
> requested prefs = (gsm|alaw),
> actual format = alaw,
> host prefs = (alaw),
> priority = mine
-- Executing Ringing("IAX2/dmztocallcenter-5", "") in new stack
-- Executing Wait("IAX2/dmztocallcenter-5", "1") in new stack
-- Executing Answer("IAX2/dmztocallcenter-5", "") in new stack
-- Executing AGI("IAX2/dmztocallcenter-5", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer----------999-----1") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi
AGI Tx >> agi_request: agi-VDADcloser_inboundCID.agi
AGI Tx >> agi_channel: IAX2/dmztocallcenter-5
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1155570826.180
AGI Tx >> agi_callerid: 1234567890
AGI Tx >> agi_calleridname: unknown
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: from-dmz
AGI Tx >> agi_extension: 7777
AGI Tx >> agi_priority: 4
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << STREAM FILE beep ""
AGI Tx >> 200 result=0 endpos=3520
AGI Rx << SET CALLERID <Y0814165347000000186>
AGI Tx >> 200 result=1
AGI Rx << CHANNEL STATUS IAX2/dmztocallcenter-5
AGI Tx >> 200 result=6
AGI Rx << SET CONTEXT default
AGI Tx >> 200 result=0
AGI Rx << SET EXTENSION 8600051
AGI Tx >> 200 result=0
AGI Rx << SET PRIORITY 1
AGI Tx >> 200 result=0
-- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0
-- Executing MeetMe("IAX2/dmztocallcenter-5", "8600051") in new stack


I've just change our publicIP from main *Box

Thanks for your availability

PostPosted: Mon Aug 14, 2006 11:21 am
by mflorell
Please post Real Asterisk CLI output not asterisk -r output

PostPosted: Mon Aug 14, 2006 11:53 am
by MoutaPT
Hi Matt,

I've made screen -r -L from my ASterisk Vicidial, and the paste the call arriving at vicidial and then caller hanging up, i hope there's no problem pasting this ^M characters

^M^[[1;30;40m -- ^[[0;37;40mAccepting AUTHENTICATED call from 19X.XXX.XX.XX:^M
> requested format = alaw,^M
> requested prefs = (gsm|alaw),^M
> actual format = alaw,^M
> host prefs = (alaw),^M
> priority = mine^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mRinging^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40m^[[0
;37;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mWait^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40m1^[[0;3
7;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mAnswer^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40m^[[0;
37;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mAGI^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40magi-VDAD
closer_inboundCID.agi|SALESLINE-----7777-----Closer----------999-----1^[[0;37;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mLaunched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi^M
^MAGI Tx >> agi_request: agi-VDADcloser_inboundCID.agi^M
^MAGI Tx >> agi_channel: IAX2/dmztocallcenter-1^M
^MAGI Tx >> agi_language: en^M
^MAGI Tx >> agi_type: IAX2^M
^MAGI Tx >> agi_uniqueid: 1155573949.194^M
^MAGI Tx >> agi_callerid: 1234567890^M
^MAGI Tx >> agi_calleridname: unknown^M
^MAGI Tx >> agi_callingpres: 0^M
^MAGI Tx >> agi_callingani2: 0^M
^MAGI Tx >> agi_callington: 0^M
^MAGI Tx >> agi_callingtns: 0^M
^MAGI Tx >> agi_dnid: unknown^M
^MAGI Tx >> agi_rdnis: unknown^M
^MAGI Tx >> agi_context: from-dmz^M
^MAGI Tx >> agi_extension: 7777^M
^MAGI Tx >> agi_priority: 4^M
^MAGI Tx >> agi_enhanced: 0.0^M
^MAGI Tx >> agi_accountcode: ^M
^MAGI Tx >> ^M
Perl Environment Dump:^M
0|SALESLINE-----7777-----Closer----------999-----1|^M
AGI Environment Dump:^M
-- accountcode = ^M
-- callerid = 1234567890^M
-- calleridname = unknown^M
-- callingani2 = 0^M
-- callingpres = 0^M
-- callingtns = 0^M
-- callington = 0^M
-- channel = IAX2/dmztocallcenter-1^M
-- context = from-dmz^M
-- dnid = unknown^M
-- enhanced = 0.0^M
-- extension = 7777^M
-- language = en^M
-- priority = 4^M
-- rdnis = unknown^M
-- request = agi-VDADcloser_inboundCID.agi^M
-- type = IAX2^M
-- uniqueid = 1155573949.194^M
^MAGI Rx << STREAM FILE beep ""^M
^MAGI Tx >> 200 result=0 endpos=3520^M
^M
INBOUND CALL VDCL STARTED^M
+++++ INBOUND CALL VDCL STARTED : |1155573949.194|SALESLINE|IAX2/dmztocallcenter-1|7777|IAX2|1234567890-7777|2006-08-14 17:45:50^M
AGI Environment Dump: |1155573949.194|IAX2/dmztocallcenter-1|7777|IAX2|1234567890|^M
^M
INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-1^M
+++++ INBOUND VDCL START : |1155573949.194|IAX2/dmztocallcenter-1|7777|IAX2|2006-08-14 17:45:50^M
^M
|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,ph
one_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 17:45:50','20060814174550','INBND','7777','SALESLIN
E','VDCL','1','Y','','1234567890','SALESLINE','1','-5.00','');|200|^M
^MAGI Rx << SET CALLERID <Y0814174550000000200>^M
^MAGI Tx >> 200 result=1^M
checkResult has res:^M
FAIL (unexpected result '')^M
callerID changed: Y0814174550000000200^M
^M
|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','200','1155573949.194','Y0814174550000000200','IAX2/dmztoc
allcenter-1','','1234567890','2006-08-14 17:45:50','IN')|^M
^M
|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('200'
,'SALESLINE','2006-08-14 17:45:50','1155573950','QUEUE','','1234567890','VDCL','N')|^M
-- VDCL : |200|insert to vicidial_closer_log^M
^MAGI Rx << CHANNEL STATUS IAX2/dmztocallcenter-1^M
^MAGI Tx >> 200 result=6^M
^M
^M
|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_tim
e < "2006-08-14 17:45:50" and lead_id != '200';|^M
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6^M
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='200',uniqueid='1155573949.194', channel='IAX2/dmztocallcenter-1', callerid='Y0
814174550000000200' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns
LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|^M
^M
|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%
CLOSER%" and callerid='Y0814174550000000200' and channel='IAX2/dmztocallcenter-1' order by last_call_time limit 1;|^M
-- VDCL XFER : |1|update of vac table: Y0814174550000000200^M
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814174550000000200';|^M
-- closer log : |1|update of vcl table: 200^M
|UPDATE vicidial_closer_log set user='12345678' where lead_id='200' order by call_date desc limit 1;|^M
^M
exiting the VDAD app, transferring call to 8600051^M
^MAGI Rx << SET CONTEXT default^M
^MAGI Tx >> 200 result=0^M
checkResult has res:^M
FAIL (unexpected result '')^M
^MAGI Rx << SET EXTENSION 8600051^M
^MAGI Tx >> 200 result=0^M
checkResult has res:^M
FAIL (unexpected result '')^M
^MAGI Rx << SET PRIORITY 1^M
^MAGI Tx >> 200 result=0^M
checkResult has res:^M
FAIL (unexpected result '')^M
^M
XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 17:45:50|2006-08-14 17:45:50^M
^M^[[1;30;40m -- ^[[0;37;40mAGI Script agi-VDADcloser_inboundCID.agi completed, returning 0^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mMeetMe^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40m86000
51^[[0;37;40m") in new stack^M
^M^[[1;30;40m == ^[[0;37;40mSpawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-1'^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mDeadAGI^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40mcall
_log.agi|h^[[0;37;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mLaunched AGI Script /var/lib/asterisk/agi-bin/call_log.agi^M
^MAGI Tx >> agi_request: call_log.agi^M
^MAGI Tx >> agi_channel: IAX2/dmztocallcenter-1^M
^MAGI Tx >> agi_language: en^M
^MAGI Tx >> agi_type: IAX2^M
^MAGI Tx >> agi_uniqueid: 1155573949.194^M
^MAGI Tx >> agi_callerid: Y0814174550000000200^M
^MAGI Tx >> agi_calleridname: unknown^M
^MAGI Tx >> agi_callingpres: 0^M
^MAGI Tx >> agi_callingani2: 0^M
^MAGI Tx >> agi_callington: 0^M
^MAGI Tx >> agi_callingtns: 0^M
^MAGI Tx >> agi_dnid: unknown^M
^MAGI Tx >> agi_rdnis: unknown^M
^MAGI Tx >> agi_context: default^M
^MAGI Tx >> agi_extension: h^M
^MAGI Tx >> agi_priority: 1^M
^MAGI Tx >> agi_enhanced: 0.0^M
^MAGI Tx >> agi_accountcode: ^M
^MAGI Tx >> ^M
+++++ CALL LOG HUNGUP: |1155573949.194|IAX2/dmztocallcenter-1|h|2006-08-14 17:45:53|min: |^M
^M^[[1;30;40m -- ^[[0;37;40mAGI Script call_log.agi completed, returning 0^M
^M^[[1;30;40m -- ^[[0;37;40mExecuting ^[[1;36;40mDeadAGI^[[0;37;40m("^[[1;35;40mIAX2/dmztocallcenter-1^[[0;37;40m", "^[[1;35;40mVD_h
angup.agi|PRI-----NODEBUG-----16---------------^[[0;37;40m") in new stack^M
^M^[[1;30;40m -- ^[[0;37;40mLaunched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi^M
^MAGI Tx >> agi_request: VD_hangup.agi^M
MAGI Tx >> agi_channel: IAX2/dmztocallcenter-1^M
^MAGI Tx >> agi_language: en^M
^MAGI Tx >> agi_type: IAX2^M
^MAGI Tx >> agi_uniqueid: 1155573949.194^M
^MAGI Tx >> agi_callerid: Y0814174550000000200^M
^MAGI Tx >> agi_calleridname: unknown^M
^MAGI Tx >> agi_callingpres: 0^M
^MAGI Tx >> agi_callingani2: 0^M
^MAGI Tx >> agi_callington: 0^M
^MAGI Tx >> agi_callingtns: 0^M
^MAGI Tx >> agi_dnid: unknown^M
^MAGI Tx >> agi_rdnis: unknown^M
^MAGI Tx >> agi_context: default^M
^MAGI Tx >> agi_extension: h^M
^MAGI Tx >> agi_priority: 2^M
^MAGI Tx >> agi_enhanced: 0.0^M
^MAGI Tx >> agi_accountcode: ^M
^MAGI Tx >> ^M
Perl Environment Dump:^M
0|PRI-----NODEBUG-----16---------------|^M
AGI Environment Dump:^M
-- accountcode = ^M
-- callerid = Y0814174550000000200^M
-- calleridname = unknown^M
-- callingani2 = 0^M
-- callingpres = 0^M
-- callingtns = 0^M
-- callington = 0^M
-- channel = IAX2/dmztocallcenter-1^M
-- context = default^M
-- dnid = unknown^M
-- enhanced = 0.0^M
-- extension = h^M
-- language = en^M
-- priority = 2^M
-- rdnis = unknown^M
-- request = VD_hangup.agi^M
-- type = IAX2^M
-- uniqueid = 1155573949.194^M
AGI Environment Dump: |1155573949.194|IAX2/dmztocallcenter-1|h|IAX2|Y0814174550000000200|unknown|2|^M
^M
DEBUG: NODEBUG^M
^M
VD_hangup : Y0814174550000000200 IAX2/dmztocallcenter-1 2^M
+++++ VD hangup START : |1155573949.194|IAX2/dmztocallcenter-1|h|IAX2|Y0814174550000000200|200|2006-08-14 17:45:53||2|unknown|^M
^M
^M
|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155573949.194' limit 1;|^M
^M
^M
|SELECT start_epoch,status FROM vicidial_log where uniqueid='1155573949.194' and lead_id='200' limit 1;|^M
^M
VD hangup: no VDL record found: 1155573949.194 unknown 200 1155573949.194^M
^M
^M
|SELECT start_epoch,status,closecallid FROM vicidial_closer_log where lead_id = '200' and call_date > "2006-08-14 11:45:53" order by ca
ll_date desc limit 1;|^M
^M
^M
|UPDATE vicidial_log set end_epoch='1155573953',length_in_sec='3' where uniqueid = '1155573949.194';|^M
-- VDAD vicidial_log update: |0|1155573949.194|^M
^M
^M
|UPDATE vicidial_closer_log set status='DROP',end_epoch='1155573953',length_in_sec='3' where closecallid = '194';|^M
-- VDCL update: |1|1155573949.194|194|^M
^M^[[1;30;40m -- ^[[0;37;40mAGI Script VD_hangup.agi completed, returning 0^M
^M^[[1;30;40m -- ^[[0;37;40mHungup 'IAX2/dmztocallcenter-1'^M
^M^[[1;30;40m == ^[[0;37;40mParsing '/etc/asterisk/manager.conf': Found^M
^M^[[1;30;40m == ^[[0;37;40mManager 'sendcron' logged on from 127.0.0.1^M
^M^[[1;30;40m == ^[[0;37;40mParsing '/etc/asterisk/manager.conf': Found^M
^M^[[1;30;40m == ^[[0;37;40mManager 'sendcron' logged on from 127.0.0.1^M
^M^[[1;30;40m == ^[[0;37;40mManager 'sendcron' logged off from 127.0.0.1^M
^M^[[1;30;40m == ^[[0;37;40mManager 'sendcron' logged off from 127.0.0.1^M


Best regards,
Marco Mouta

PostPosted: Mon Aug 14, 2006 12:03 pm
by mflorell
One problem is that you do not have 7 fields in your AGI arguments, you only have 6:

exten => 1234,4,AGI(agi-VDADcloser_inboundCID.agi,CL_GALLERIA-----7275555134-----Closer-----park----------999-----1)

you have:
SALESLINE-----7777-----Closer----------999-----1

should be:
SALESLINE-----7777-----Closer---------------999-----1

PostPosted: Mon Aug 14, 2006 12:19 pm
by MoutaPT
hi Matt,

i've made your changes but i keep with the same problems:
here is asterisk CLI:

 -- Accepting AUTHENTICATED call from 1XX.XXX.XX.XX:
> requested format = alaw,
> requested prefs = (gsm|alaw),
> actual format = alaw,
> host prefs = (alaw),
> priority = mine

 -- Executing Ringing("IAX2/dmztocallcenter-3", "") in new stack

 -- Executing Wait("IAX2/dmztocallcenter-3", "1") in new stack

 -- Executing Answer("IAX2/dmztocallcenter-3", "") in new stack

 -- Executing AGI("IAX2/dmztocallcenter-3", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer----------999-----1") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi

AGI Tx >> agi_request: agi-VDADcloser_inboundCID.agi

AGI Tx >> agi_channel: IAX2/dmztocallcenter-3

AGI Tx >> agi_language: en

AGI Tx >> agi_type: IAX2

AGI Tx >> agi_uniqueid: 1155575682.198

AGI Tx >> agi_callerid: 1234567890

AGI Tx >> agi_calleridname: unknown

AGI Tx >> agi_callingpres: 0

AGI Tx >> agi_callingani2: 0

AGI Tx >> agi_callington: 0

AGI Tx >> agi_callingtns: 0

AGI Tx >> agi_dnid: unknown

AGI Tx >> agi_rdnis: unknown

AGI Tx >> agi_context: from-dmz

AGI Tx >> agi_extension: 7777

AGI Tx >> agi_priority: 4

AGI Tx >> agi_enhanced: 0.0

AGI Tx >> agi_accountcode:

AGI Tx >>
Perl Environment Dump:
0|SALESLINE-----7777-----Closer----------999-----1|
AGI Environment Dump:
-- accountcode =
-- callerid = 1234567890
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-3
-- context = from-dmz
-- dnid = unknown
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = IAX2
-- uniqueid = 1155575682.198

AGI Rx << STREAM FILE beep ""

AGI Tx >> 200 result=0 endpos=3520

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155575682.198|SALESLINE|IAX2/dmztocallcenter-3|7777|IAX2|1234567890-7777|2006-08-14 18:14:43
AGI Environment Dump: |1155575682.198|IAX2/dmztocallcenter-3|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-3
+++++ INBOUND VDCL START : |1155575682.198|IAX2/dmztocallcenter-3|7777|IAX2|2006-08-14 18:14:43

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 18:14:43','20060814181443','INBND','7777','SALESLINE','VDCL','1','Y','','1234567890','SALESLINE','1','-5.00','');|204|
checkResult has res:
FAIL (unexpected result '')
callerID changed: Y0814181443000000204

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','204','1155575682.198','Y0814181443000000204','IAX2/dmztocallcenter-3','','1234567890','2006-08-14 18:14:43','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('204','SALESLINE','2006-08-14 18:14:43','1155575683','QUEUE','','1234567890','VDCL','N')|
-- VDCL : |204|insert to vicidial_closer_log

AGI Rx << SET CALLERID <Y0814181443000000204>

AGI Tx >> 200 result=1


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 18:14:43" and lead_id != '204';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='204',uniqueid='1155575682.198', channel='IAX2/dmztocallcenter-3', callerid='Y0814181443000000204' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814181443000000204' and channel='IAX2/dmztocallcenter-3' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814181443000000204
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814181443000000204';|
-- closer log : |1|update of vcl table: 204
|UPDATE vicidial_closer_log set user='12345678' where lead_id='204' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 18:14:43|2006-08-14 18:14:44

AGI Rx << CHANNEL STATUS IAX2/dmztocallcenter-3

AGI Tx >> 200 result=6

AGI Rx << SET CONTEXT default

AGI Tx >> 200 result=0

AGI Rx << SET EXTENSION 8600051

AGI Tx >> 200 result=0

AGI Rx << SET PRIORITY 1

AGI Tx >> 200 result=0

 -- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0

 -- Executing MeetMe("IAX2/dmztocallcenter-3", "8600051") in new stack

 == Spawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-3'

 -- Executing DeadAGI("IAX2/dmztocallcenter-3", "call_log.agi|h") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/call_log.agi

AGI Tx >> agi_request: call_log.agi

AGI Tx >> agi_channel: IAX2/dmztocallcenter-3

AGI Tx >> agi_language: en

AGI Tx >> agi_type: IAX2

AGI Tx >> agi_uniqueid: 1155575682.198

AGI Tx >> agi_callerid: Y0814181443000000204

AGI Tx >> agi_calleridname: unknown

AGI Tx >> agi_callingpres: 0

AGI Tx >> agi_callingani2: 0

AGI Tx >> agi_callington: 0

AGI Tx >> agi_callingtns: 0

AGI Tx >> agi_dnid: unknown

AGI Tx >> agi_rdnis: unknown

AGI Tx >> agi_context: default

AGI Tx >> agi_extension: h

AGI Tx >> agi_priority: 1

AGI Tx >> agi_enhanced: 0.0

AGI Tx >> agi_accountcode:

AGI Tx >>
+++++ CALL LOG HUNGUP: |1155575682.198|IAX2/dmztocallcenter-3|h|2006-08-14 18:14:50|min: |

 -- AGI Script call_log.agi completed, returning 0

 -- Executing DeadAGI("IAX2/dmztocallcenter-3", "VD_hangup.agi|PRI-----NODEBUG-----16---------------") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi

AGI Tx >> agi_request: VD_hangup.agi

AGI Tx >> agi_channel: IAX2/dmztocallcenter-3

AGI Tx >> agi_language: en

AGI Tx >> agi_type: IAX2

AGI Tx >> agi_uniqueid: 1155575682.198

AGI Tx >> agi_callerid: Y0814181443000000204

AGI Tx >> agi_calleridname: unknown

AGI Tx >> agi_callingpres: 0

AGI Tx >> agi_callingani2: 0

AGI Tx >> agi_callington: 0

AGI Tx >> agi_callingtns: 0

AGI Tx >> agi_dnid: unknown

AGI Tx >> agi_rdnis: unknown

AGI Tx >> agi_context: default

AGI Tx >> agi_extension: h

AGI Tx >> agi_priority: 2

AGI Tx >> agi_enhanced: 0.0

AGI Tx >> agi_accountcode:

AGI Tx >>
Perl Environment Dump:
0|PRI-----NODEBUG-----16---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = Y0814181443000000204
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-3
-- context = default
-- dnid = unknown
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = IAX2
-- uniqueid = 1155575682.198
AGI Environment Dump: |1155575682.198|IAX2/dmztocallcenter-3|h|IAX2|Y0814181443000000204|unknown|2|

DEBUG: NODEBUG

VD_hangup : Y0814181443000000204 IAX2/dmztocallcenter-3 2
+++++ VD hangup START : |1155575682.198|IAX2/dmztocallcenter-3|h|IAX2|Y0814181443000000204|204|2006-08-14 18:14:50||2|unknown|


|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155575682.198' limit 1;|
-- VDAC record deleted: |1| |204|1155575682.198|Y0814181443000000204|192.168.34.6


|SELECT start_epoch,status FROM vicidial_log where uniqueid='1155575682.198' and lead_id='204' limit 1;|

VD hangup: no VDL record found: 1155575682.198 unknown 204 1155575682.198


|SELECT start_epoch,status,closecallid FROM vicidial_closer_log where lead_id = '204' and call_date > "2006-08-14 12:14:50" order by call_date desc limit 1;|


|UPDATE vicidial_log set end_epoch='1155575690',length_in_sec='7' where uniqueid = '1155575682.198';|
-- VDAD vicidial_log update: |0|1155575682.198|


|UPDATE vicidial_closer_log set status='DROP',end_epoch='1155575690',length_in_sec='7' where closecallid = '198';|
-- VDCL update: |1|1155575682.198|198|

 -- AGI Script VD_hangup.agi completed, returning 0

 -- Hungup 'IAX2/dmztocallcenter-3'

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

PostPosted: Mon Aug 14, 2006 12:25 pm
by mflorell
did you reload asterisk after modifying extensions.conf?

The changes are not in the CLI output you posted.

PostPosted: Mon Aug 14, 2006 12:39 pm
by MoutaPT
Hi Matt,

My fault, i forgot the reload, unfortunately i've made reload and test with 3 calls from same VoIP ext and keeps the problem, i hope this Asterisk CLI helps you.

Once more thank your for all your realtime availability!!

Big Thanks!

Aug 14 18:34:35 WARNING[2070]: chan_sip.c:10026 handle_response: Host '192.168.3.71' does not implement 'NOTIFY'

 -- Remote UNIX connection

 -- Remote UNIX connection disconnected

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Spawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-1'

 -- Executing DeadAGI("IAX2/dmztocallcenter-1", "call_log.agi|h") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/call_log.agi
+++++ CALL LOG HUNGUP: |1155576852.205|IAX2/dmztocallcenter-1|h|2006-08-14 18:34:50|min: |

 -- AGI Script call_log.agi completed, returning 0

 -- Executing DeadAGI("IAX2/dmztocallcenter-1", "VD_hangup.agi|PRI-----NODEBUG-----0---------------") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi
Perl Environment Dump:
0|PRI-----NODEBUG-----0---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = Y0814183413000000211
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-1
-- context = default
-- dnid = unknown
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = IAX2
-- uniqueid = 1155576852.205
AGI Environment Dump: |1155576852.205|IAX2/dmztocallcenter-1|h|IAX2|Y0814183413000000211|unknown|2|

DEBUG: NODEBUG

VD_hangup : Y0814183413000000211 IAX2/dmztocallcenter-1 2
+++++ VD hangup START : |1155576852.205|IAX2/dmztocallcenter-1|h|IAX2|Y0814183413000000211|211|2006-08-14 18:34:51||2|unknown|


|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155576852.205' limit 1;|

VD hangup: no VDAC record found: 1155576852.205 unknown

 -- AGI Script VD_hangup.agi completed, returning 0

 -- Hungup 'IAX2/dmztocallcenter-1'

 == Manager 'sendcron' logged off from 127.0.0.1

 -- Accepting AUTHENTICATED call from XXX.XXX.XX.XX:
> requested format = alaw,
> requested prefs = (gsm|alaw),
> actual format = alaw,
> host prefs = (alaw),
> priority = mine

 -- Executing Ringing("IAX2/dmztocallcenter-4", "") in new stack

 -- Executing Wait("IAX2/dmztocallcenter-4", "1") in new stack

 -- Executing Answer("IAX2/dmztocallcenter-4", "") in new stack

 -- Executing AGI("IAX2/dmztocallcenter-4", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer---------------999-----1") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi
Perl Environment Dump:
0|SALESLINE-----7777-----Closer---------------999-----1|
AGI Environment Dump:
-- accountcode =
-- callerid = 1234567890
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-4
-- context = from-dmz
-- dnid = unknown
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = IAX2
-- uniqueid = 1155576897.206

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155576897.206|SALESLINE|IAX2/dmztocallcenter-4|7777|IAX2|1234567890-7777|2006-08-14 18:34:58
AGI Environment Dump: |1155576897.206|IAX2/dmztocallcenter-4|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-4
+++++ INBOUND VDCL START : |1155576897.206|IAX2/dmztocallcenter-4|7777|IAX2|2006-08-14 18:34:58

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 18:34:58','20060814183458','INBND','7777','SALESLINE','VDCL','999','Y','1','1234567890','SALESLINE','1','-5.00','');|212|
checkResult has res:
FAIL (unexpected result '')
callerID changed: Y0814183458000000212

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','212','1155576897.206','Y0814183458000000212','IAX2/dmztocallcenter-4','1','1234567890','2006-08-14 18:34:58','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('212','SALESLINE','2006-08-14 18:34:58','1155576898','QUEUE','1','1234567890','VDCL','N')|
-- VDCL : |212|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 18:34:58" and lead_id != '212';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='212',uniqueid='1155576897.206', channel='IAX2/dmztocallcenter-4', callerid='Y0814183458000000212' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814183458000000212' and channel='IAX2/dmztocallcenter-4' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814183458000000212
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814183458000000212';|
-- closer log : |1|update of vcl table: 212
|UPDATE vicidial_closer_log set user='12345678' where lead_id='212' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 18:34:58|2006-08-14 18:34:58

 -- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0

 -- Executing MeetMe("IAX2/dmztocallcenter-4", "8600051") in new stack

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Manager 'sendcron' logged off from 127.0.0.1

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Spawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-4'

 -- Executing DeadAGI("IAX2/dmztocallcenter-4", "call_log.agi|h") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/call_log.agi
+++++ CALL LOG HUNGUP: |1155576897.206|IAX2/dmztocallcenter-4|h|2006-08-14 18:35:16|min: |

 -- AGI Script call_log.agi completed, returning 0

 -- Executing DeadAGI("IAX2/dmztocallcenter-4", "VD_hangup.agi|PRI-----NODEBUG-----0---------------") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi
Perl Environment Dump:
0|PRI-----NODEBUG-----0---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = Y0814183458000000212
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-4
-- context = default
-- dnid = unknown
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = IAX2
-- uniqueid = 1155576897.206
AGI Environment Dump: |1155576897.206|IAX2/dmztocallcenter-4|h|IAX2|Y0814183458000000212|unknown|2|

DEBUG: NODEBUG

VD_hangup : Y0814183458000000212 IAX2/dmztocallcenter-4 2
+++++ VD hangup START : |1155576897.206|IAX2/dmztocallcenter-4|h|IAX2|Y0814183458000000212|212|2006-08-14 18:35:16||2|unknown|


|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155576897.206' limit 1;|

VD hangup: no VDAC record found: 1155576897.206 unknown

 -- AGI Script VD_hangup.agi completed, returning 0

 -- Hungup 'IAX2/dmztocallcenter-4'

 == Manager 'sendcron' logged off from 127.0.0.1

 -- Accepting AUTHENTICATED call from XXX.XXX.XX.X:
> requested format = alaw,
> requested prefs = (gsm|alaw),
> actual format = alaw,
> host prefs = (alaw),
> priority = mine

 -- Executing Ringing("IAX2/dmztocallcenter-7", "") in new stack

 -- Executing Wait("IAX2/dmztocallcenter-7", "1") in new stack

 -- Executing Answer("IAX2/dmztocallcenter-7", "") in new stack

 -- Executing AGI("IAX2/dmztocallcenter-7", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer---------------999-----1") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi
Perl Environment Dump:
0|SALESLINE-----7777-----Closer---------------999-----1|
AGI Environment Dump:
-- accountcode =
-- callerid = 1234567890
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-7
-- context = from-dmz
-- dnid = unknown
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = IAX2
-- uniqueid = 1155576924.207

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155576924.207|SALESLINE|IAX2/dmztocallcenter-7|7777|IAX2|1234567890-7777|2006-08-14 18:35:25
AGI Environment Dump: |1155576924.207|IAX2/dmztocallcenter-7|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-7
+++++ INBOUND VDCL START : |1155576924.207|IAX2/dmztocallcenter-7|7777|IAX2|2006-08-14 18:35:25

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 18:35:25','20060814183525','INBND','7777','SALESLINE','VDCL','999','Y','1','1234567890','SALESLINE','1','-5.00','');|213|
checkResult has res:
FAIL (unexpected result '')
callerID changed: Y0814183525000000213

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','213','1155576924.207','Y0814183525000000213','IAX2/dmztocallcenter-7','1','1234567890','2006-08-14 18:35:25','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('213','SALESLINE','2006-08-14 18:35:25','1155576925','QUEUE','1','1234567890','VDCL','N')|
-- VDCL : |213|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 18:35:25" and lead_id != '213';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='213',uniqueid='1155576924.207', channel='IAX2/dmztocallcenter-7', callerid='Y0814183525000000213' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814183525000000213' and channel='IAX2/dmztocallcenter-7' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814183525000000213
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814183525000000213';|
-- closer log : |1|update of vcl table: 213
|UPDATE vicidial_closer_log set user='12345678' where lead_id='213' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 18:35:25|2006-08-14 18:35:26

 -- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0

 -- Executing MeetMe("IAX2/dmztocallcenter-7", "8600051") in new stack

 == Parsing '/etc/asterisk/manager.conf': Found

 == Manager 'sendcron' logged on from 127.0.0.1

 == Spawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-7'

 -- Executing DeadAGI("IAX2/dmztocallcenter-7", "call_log.agi|h") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/call_log.agi
+++++ CALL LOG HUNGUP: |1155576924.207|IAX2/dmztocallcenter-7|h|2006-08-14 18:35:33|min: |

 -- AGI Script call_log.agi completed, returning 0

 -- Executing DeadAGI("IAX2/dmztocallcenter-7", "VD_hangup.agi|PRI-----NODEBUG-----0---------------") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi
Perl Environment Dump:
0|PRI-----NODEBUG-----0---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = Y0814183525000000213
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-7
-- context = default
-- dnid = unknown
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = IAX2
-- uniqueid = 1155576924.207
AGI Environment Dump: |1155576924.207|IAX2/dmztocallcenter-7|h|IAX2|Y0814183525000000213|unknown|2|

DEBUG: NODEBUG

VD_hangup : Y0814183525000000213 IAX2/dmztocallcenter-7 2
+++++ VD hangup START : |1155576924.207|IAX2/dmztocallcenter-7|h|IAX2|Y0814183525000000213|213|2006-08-14 18:35:33||2|unknown|


|SELECT lead_id,callerid FROM vicidial_auto_calls where uniqueid = '1155576924.207' limit 1;|

VD hangup: no VDAC record found: 1155576924.207 unknown

 -- AGI Script VD_hangup.agi completed, returning 0

 -- Hungup 'IAX2/dmztocallcenter-7'

 == Manager 'sendcron' logged off from 127.0.0.1

 -- Accepting AUTHENTICATED call from XXX.XXX.XX.X:
> requested format = alaw,
> requested prefs = (gsm|alaw),
> actual format = alaw,
> host prefs = (alaw),
> priority = mine

 -- Executing Ringing("IAX2/dmztocallcenter-9", "") in new stack

 -- Executing Wait("IAX2/dmztocallcenter-9", "1") in new stack

 -- Executing Answer("IAX2/dmztocallcenter-9", "") in new stack

 -- Executing AGI("IAX2/dmztocallcenter-9", "agi-VDADcloser_inboundCID.agi|SALESLINE-----7777-----Closer---------------999-----1") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDADcloser_inboundCID.agi
Perl Environment Dump:
0|SALESLINE-----7777-----Closer---------------999-----1|
AGI Environment Dump:
-- accountcode =
-- callerid = 1234567890
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-9
-- context = from-dmz
-- dnid = unknown
-- enhanced = 0.0
-- extension = 7777
-- language = en
-- priority = 4
-- rdnis = unknown
-- request = agi-VDADcloser_inboundCID.agi
-- type = IAX2
-- uniqueid = 1155576938.208

INBOUND CALL VDCL STARTED
+++++ INBOUND CALL VDCL STARTED : |1155576938.208|SALESLINE|IAX2/dmztocallcenter-9|7777|IAX2|1234567890-7777|2006-08-14 18:35:39
AGI Environment Dump: |1155576938.208|IAX2/dmztocallcenter-9|7777|IAX2|1234567890|

INBOUND CALL RECEIVED IN FROM VDCL: 1234567890 IAX2/dmztocallcenter-9
+++++ INBOUND VDCL START : |1155576938.208|IAX2/dmztocallcenter-9|7777|IAX2|2006-08-14 18:35:39

|INSERT INTO vicidial_list (entry_date,modify_date,status,user,vendor_lead_code,source_id,list_id,called_since_last_reset,phone_code,phone_number,security_phrase,called_count,gmt_offset_now,comments) values('2006-08-14 18:35:39','20060814183539','INBND','7777','SALESLINE','VDCL','999','Y','1','1234567890','SALESLINE','1','-5.00','');|214|
checkResult has res:
FAIL (unexpected result '')
callerID changed: Y0814183539000000214

|INSERT INTO vicidial_auto_calls values('','192.168.34.6','SALESLINE','LIVE','214','1155576938.208','Y0814183539000000214','IAX2/dmztocallcenter-9','1','1234567890','2006-08-14 18:35:39','IN')|

|INSERT INTO vicidial_closer_log (lead_id,campaign_id,call_date,start_epoch,status,phone_code,phone_number,user,processed) values('214','SALESLINE','2006-08-14 18:35:39','1155576939','QUEUE','1','1234567890','VDCL','N')|
-- VDCL : |214|insert to vicidial_closer_log


|SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and server_ip='192.168.34.6' and campaign_id = 'SALESLINE' and call_time < "2006-08-14 18:35:39" and lead_id != '214';|
-- VDAD get agent: |360|0|1|update of vla table: SALESLINE|192.168.34.6
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='214',uniqueid='1155576938.208', channel='IAX2/dmztocallcenter-9', callerid='Y0814183539000000214' where status IN('CLOSER','READY') and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and closer_campaigns LIKE "% SALESLINE %" and last_update_time > '19700101005955' order by random_id limit 1;|


|SELECT conf_exten,user,extension FROM vicidial_live_agents where status = 'QUEUE' and server_ip='192.168.34.6' and campaign_id LIKE "%CLOSER%" and callerid='Y0814183539000000214' and channel='IAX2/dmztocallcenter-9' order by last_call_time limit 1;|
-- VDCL XFER : |1|update of vac table: Y0814183539000000214
|UPDATE vicidial_auto_calls set status='CLOSER' where callerid='Y0814183539000000214';|
-- closer log : |1|update of vcl table: 214
|UPDATE vicidial_closer_log set user='12345678' where lead_id='214' order by call_date desc limit 1;|

exiting the VDAD app, transferring call to 8600051
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')
checkResult has res:
FAIL (unexpected result '')

XXXXXXXXXX VDAD transferred: start|stop 2006-08-14 18:35:39|2006-08-14 18:35:40

 -- AGI Script agi-VDADcloser_inboundCID.agi completed, returning 0

 -- Executing MeetMe("IAX2/dmztocallcenter-9", "8600051") in new stack

 == Spawn extension (default, 8600051, 1) exited non-zero on 'IAX2/dmztocallcenter-9'

 -- Executing DeadAGI("IAX2/dmztocallcenter-9", "call_log.agi|h") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/call_log.agi
+++++ CALL LOG HUNGUP: |1155576938.208|IAX2/dmztocallcenter-9|h|2006-08-14 18:35:44|min: |

 -- AGI Script call_log.agi completed, returning 0

 -- Executing DeadAGI("IAX2/dmztocallcenter-9", "VD_hangup.agi|PRI-----NODEBUG-----16---------------") in new stack

 -- Launched AGI Script /var/lib/asterisk/agi-bin/VD_hangup.agi
Perl Environment Dump:
0|PRI-----NODEBUG-----16---------------|
AGI Environment Dump:
-- accountcode =
-- callerid = Y0814183539000000214
-- calleridname = unknown
-- callingani2 = 0
-- callingpres = 0
-- callingtns = 0
-- callington = 0
-- channel = IAX2/dmztocallcenter-9
-- context = default
-- dnid = unknown
-- enhanced = 0.0
-- extension = h
-- language = en
-- priority = 2
-- rdnis = unknown
-- request = VD_hangup.agi
-- type = IAX2
-- uniqueid = 1155576938.208
AGI Environment Dump: |1155576938.208|IAX2/dmztocallcenter-9|h|IAX2|Y0814183539000000214|unknown|2|

DEBUG: NODEBUG

PostPosted: Mon Aug 14, 2006 12:45 pm
by mflorell
Have you tried the agi-VDADcloser_inboundCIDlookup.agi script instead?

PostPosted: Mon Aug 14, 2006 1:04 pm
by MoutaPT
Finally working!!!

But there's a bug in line 271, missing ";" in "select...." ;

Just one question, why there are all these scripts, wouldn't be more logical to run one after another or simply the agi-VDADcloser_inboundCIDlookup.agi

Does not all the people want to retrieve data from previous calls

Could you just summary explain why so different agi-VDADcloser_inbound scripts?

Thanks Matt for all your kindness!

Best regards
MoutaPT

PostPosted: Mon Aug 14, 2006 1:26 pm
by mflorell
It is more efficient to only run one AGI script especially on heavy-loaded systems. As for the different versions, there are several CallerID delivery methods for different cirsuit types like RBS and PRI are different. Not all users want to do a lookup of customers on different campaigns.

PostPosted: Mon Aug 14, 2006 1:42 pm
by MoutaPT
Hi Matt,

I've noticed and this customer details retrieved from db doesn't work ok everytime.

I mean, i'm dialing always from the same VoIPexten-->*box---IAX---*vicidial

And some times i get my customers details ok, and sometimes they are empty...

Could this be happening because while making all this tests i got in my table many entries with the same caller id, and most of them have customer details empty?

Do you recomend me do clean my table?

PostPosted: Mon Aug 14, 2006 2:07 pm
by mflorell
That could be a cause. I would recommend:

DELETE from vicidial_list where phone_number='1234567890';

or whatever you had as the phone number then see what happens.