Page 1 of 1
live transfer sticks and calls overlap

Posted:
Mon Aug 03, 2009 6:24 pm
by lerroux
i dont know if this should be posted in the vicibox threads but this is not an installation issue. i installed vicibox, as simple as 123. and i got it working. thanks by the way.
my problem is, i have to closer agents in a closer type campaign, the other is a local closer agent, the other is a remote agent.
and i have agents on another campaign transfering to both. but some of my agents, when they try to transfer, it doesnt get transfered and the next call comes in and the calls overlap.
i always solve the issue by letting the agent log out the login again, or delete their usernames and creating them new ones. i can't figure out the problem.
can anyone help me? can't let agetns logout and login all the time and sales go down because of this...

Posted:
Tue Aug 04, 2009 6:57 am
by mflorell
Please detail step-by-step exactly how you are doing transfers.

Posted:
Tue Aug 04, 2009 1:30 pm
by lerroux
agent click transfer, then choose the transfer group, then local transfer.
basically that's it. it works on most agents but some of them just fails.

Posted:
Tue Aug 04, 2009 6:51 pm
by mflorell
Is this something that you can repeat on demand?
Does this happen to the same agents more often than others?

Posted:
Tue Aug 04, 2009 7:12 pm
by williamconley
We're all ready to help, but we have no idea what you have installed or what your problem could be unless someone just happens to have had the exact problem you have.
So: please post your complete setup (hardware, software with versions including vicidial version, other software installed in the box) and please put this into your signature for future use so you don't have to repeat yourself later.
I have noticed that you have been very helpful on the site, we need more people like you to jump in. That's way cool.
Does this issue ONLY happen when an agents was "in a call" with another client or paused for some other reason when the initial transfer should occur? If so, does logging out and logging right back in resolve the issue? (allow the transfer?)
Give us some details like that and see if you can reproduce the issue cleanly to help locate the issue. But: REMEMBER to always list your configuration when asking a question. Often just listing the configuration will resolve your issue before you ask your question ("I'm running VMWare with ubuntu ...") LOL

Posted:
Wed Aug 05, 2009 12:23 pm
by lerroux
hi all, thanks for the help....
matt, nope, this happens at random. but at specific agents only. all agents, have the same pc's and settings as they are all cloned.
william, thanks, always glad to be of help. im using vicibox with vicidial version 2.0.5.
nothing else is installed on the box. and it happens when an agent is on a call... no specific pattern. sometimes, logging in and out resolves the issue. sometimes, i have to delete the user and create it again.

Posted:
Wed Aug 05, 2009 2:44 pm
by williamconley
Your next step would be to investigate /var/log/astguiclient at the moment of the error. Find out what sql call is coming back with the wrong information and why. Why is the agi script misinformed about an agent's availability.
Often we also look at the CLI, but this case would appear to be a "Vicidial Logic" issue, which can be had by the log output. If you read the manual, you can also affect the logging level for more detail if you like.
Your first goal should be to see if you can reproduce the error on demand. That will make life MUCH easier (you can then delete all the logs and reproduce the error and have much less sifting to do to find your error).

Posted:
Wed Aug 05, 2009 3:06 pm
by lerroux
ok, i'll try to look at the logs but there are a lot of logs in there, may i know which log to look into for the transfer script?

Posted:
Wed Aug 05, 2009 3:48 pm
by lerroux
found this for a successful transfer i had:
- Code: Select all
2009-08-05 13:27:32|Event: MeetmeLeave
Privilege: call,all
Channel: SIP/a7472sY42RMEZR8T-b700ef38
Uniqueid: 1249503986.12074
Meetme: 8600053
Usernum: 3
|
2009-08-05 13:27:32|Event: Newexten
Privilege: call,all
Channel: SIP/a7472sY42RMEZR8T-b700ef38
Context: default
Extension: 990009*closers**330594**8665544795*paul2**
Priority: 1
Application: Answer
AppData:
Uniqueid: 1249503986.12074
Event: Newexten
Privilege: call,all
Channel: SIP/a7472sY42RMEZR8T-b700ef38
Context: default
Extension: 990009*closers**330594**8665544795*paul2**
Priority: 2
Application: AGI
AppData: agi-VDAD_ALL_inbound.agi|CLOSER-----LB-----closers-----18666034799-----Closer-----park----------999-----1
Uniqueid: 1249503986.12074

Posted:
Wed Aug 05, 2009 5:27 pm
by lerroux
i noticed that if the transfer to local closer doesnt work, i dont see anything like the log i poseted above. i can only see that if the transfer work.

Posted:
Wed Aug 05, 2009 6:14 pm
by lerroux
ok, managed to catch a non working transfer, and i looked into the CLI.... here's what i got:
here's the comparison:
working transfer:
- Code: Select all
[1;30;40m == [0;37;40mSpawn extension (default, 990009*closers**330614**8665544795*edward**, 0) exited non-zero on 'SIP/a7472sY42RMEZR8T-b64265d0'
[1;30;40m == [0;37;40mSpawn extension (default, 58600058, 1) exited non-zero on 'Local/58600058@default-ba0a,2'
[1;30;40m -- [0;37;40mExecuting [1;36;40mAnswer[0;37;40m("[1;35;40mSIP/a7472sY42RMEZR8T-b64265d0[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[1;30;40m -- [0;37;40mExecuting [1;36;40mDeadAGI[0;37;40m("[1;35;40mLocal/58600058@default-ba0a,2[0;37;40m", "[1;35;40magi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------[0;37;40m") in new stack
[1;30;40m -- [0;37;40mExecuting [1;36;40mAGI[0;37;40m("[1;35;40mSIP/a7472sY42RMEZR8T-b64265d0[0;37;40m", "[1;35;40magi-VDAD_ALL_inbound.agi|CLOSER-----LB-----closers-----18666034799-----Closer-----park----------999-----1[0;37;40m") in new stack
[1;30;40m -- [0;37;40mLaunched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[1;30;40m -- [0;37;40mAGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
[1;30;40m == [0;37;40mSpawn extension (default, 8309, 3) exited non-zero on 'Local/58600058@default-ba0a,1'
[1;30;40m -- [0;37;40mExecuting [1;36;40mDeadAGI[0;37;40m("[1;35;40mLocal/58600058@default-ba0a,1[0;37;40m", "[1;35;40magi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------[0;37;40m") in new stack
[1;30;40m -- [0;37;40mAGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
non working transfer:
- Code: Select all
[1;30;40m == [0;37;40mSpawn extension (default, 990009*closers**330619**8665544795*Miguel**, 0) exited non-zero on 'SIP/gafachi-0827cc38'
[1;30;40m -- [0;37;40mExecuting [1;36;40mAnswer[0;37;40m("[1;35;40mSIP/gafachi-0827cc38[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[1;30;40m -- [0;37;40mExecuting [1;36;40mAGI[0;37;40m("[1;35;40mSIP/gafachi-0827cc38[0;37;40m", "[1;35;40magi-VDAD_ALL_inbound.agi|CLOSER-----LB-----closers-----18666034799-----Closer-----park----------999-----1[0;37;40m") in new stack
[1;30;40m -- [0;37;40mLaunched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[1;30;40m == [0;37;40mSpawn extension (default, 58600056, 1) exited non-zero on 'Local/58600056@default-aa9b,2'
[1;30;40m -- [0;37;40mExecuting [1;36;40mDeadAGI[0;37;40m("[1;35;40mLocal/58600056@default-aa9b,2[0;37;40m", "[1;35;40magi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------[0;37;40m") in new stack
[1;30;40m -- [0;37;40mAGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
[1;30;40m == [0;37;40mSpawn extension (default, 8309, 3) exited non-zero on 'Local/58600056@default-aa9b,1'
[1;30;40m -- [0;37;40mExecuting [1;36;40mDeadAGI[0;37;40m("[1;35;40mLocal/58600056@default-aa9b,1[0;37;40m", "[1;35;40magi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------[0;37;40m") in new stack
[1;30;40m -- [0;37;40mAGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
i can't understand how this works. can someone explain it for me?

Posted:
Wed Aug 05, 2009 10:16 pm
by williamconley
is this on inbound only? (have you TESTED, not with a "running room" but tested carefully with one call on the system ...)

Posted:
Thu Aug 06, 2009 9:14 am
by lerroux
that's one of the problems. its both on inbound and outbound.
can't test with one call on the system as all my servers are live. never had this problem before.

Posted:
Thu Aug 06, 2009 1:08 pm
by lerroux
ok.... got the logs.... dont know if this is it but i found something here. i tried dialling in the system 2 times, i asked both agents to transfer me.
first time it worked..... here's the logs:
- Code: Select all
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|Perl Environment Dump:
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|0|CID-----LB-----debtsettlement-----18666034799-----CID---------------0002-----
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- accountcode =
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- callerid = 8665544795
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- calleridname = unknown
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- callingani2 = 0
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- callingpres = 0
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- callingtns = 0
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- callington = 0
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- channel = SIP/a7472sY42RMEZR8T-b700ef38
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- context = gafachi-incoming
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- dnid = 18666034799
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- enhanced = 0.0
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- extension = 18666034799
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- language = en
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- priority = 7
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- rdnis = unknown
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- request = agi-VDAD_ALL_inbound.agi
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- type = SIP
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi| -- uniqueid = 1249504247.12320
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|AGI Variables: |1249504247.12320|SIP/a7472sY42RMEZR8T-b700ef38|18666034799|SIP|8665544795|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|+++++ INBOUND CALL VDCL STARTED : |debtsettlement|8665544795-18666034799|2009-08-05 13:31:22
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||SELECT campaign_id FROM vicidial_campaigns where active='Y' and campaign_allow_inbound='Y';|330595|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|callerID changed: Y0805133122000330595
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_auto_calls SET server_ip='192.168.10.2', campaign_id='debtsettlement', status='LIVE', lead_id='330595', uniqueid='1249504247.12320', callerid='Y0805133122000330595', channel='SIP/a7472sY42RMEZR8T-b700ef38', phone_code='', phone_number='8665544795', call_time='2009-08-05 13:31:22', call_type='IN', stage='LIVE-0', queue_priority='0' ;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_closer_log SET lead_id='330595', campaign_id='debtsettlement', call_date='2009-08-05 13:31:22', start_epoch='1249504282', status='QUEUE', phone_code='', phone_number='8665544795', user='VDCL', processed='N', xfercallid='0', uniqueid='1249504247.12320' ;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDCL : |330595|0|2771|insert to vicidial_closer_log
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:31:22" and lead_id != '330595' ;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330595' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:31:22") );|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|1|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330595',uniqueid='1249504247.12320', channel='SIP/a7472sY42RMEZR8T-b700ef38', callerid='Y0805133122000330595', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805133117' order by random_id limit 1;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0|1|1|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330595',uniqueid='1249504247.12320', channel='SIP/a7472sY42RMEZR8T-b700ef38', callerid='Y0805133122000330595', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805133117' order by random_id limit 1;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|neridie|2009-08-05 13:30:57|SELECT conf_exten,user,extension,server_ip,last_call_time FROM vicidial_live_agents where status IN('QUEUE','INCALL') and campaign_id IN('0002','0003') and callerid='Y0805133122000330595' and channel='SIP/a7472sY42RMEZR8T-b700ef38' order by last_call_time limit 1;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDCL XFER REMOTE: |1|update of vac table: Y0805133122000330595
|UPDATE vicidial_auto_calls set status='CLOSER', stage='CLOSER-0' where callerid='Y0805133122000330595';|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDXL vicidial_xfer_log update: |0E0|330595|neridie
|UPDATE vicidial_xfer_log set closer='neridie' where lead_id = '330595' order by call_date desc limit 1;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- closer log : |1|update of vcl table: 330595
|UPDATE vicidial_closer_log set user='neridie' where lead_id='330595' order by call_date desc limit 1;|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDCL agent alert: |VH08051331228600054|192*168*010*002*78600054|SIP/a7472sY42RMEZR8T-b700ef38|insert to vicidial_manager
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|exiting VDAD app, transferring call to 192*168*010*002*8600054
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi||SELECT calls_today from vicidial_inbound_group_agents WHERE user='neridie' and group_id='debtsettlement';|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDLIA agent calls: |6|neridie|debtsettlement|
2009-08-05 13:31:22|agi-VDAD_ALL_inbound.agi|-- VDCL vcl update: |1|330595|
|UPDATE vicidial_closer_log set queue_seconds='0' where lead_id = '330595' and call_date='2009-08-05 13:31:22';|
2009-08-05 13:31:23|agi-VDAD_ALL_inbound.agi|XXXXX VDAD transferred: start|stop 2009-08-05 13:31:22|2009-08-05 13:31:23
the second times, it didnt went through... dont know if this is the correct log, but here it is:
- Code: Select all
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|Perl Environment Dump:
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0|CID-----LB-----debtsettlement-----18666034799-----CID---------------0002-----
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- accountcode =
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- callerid = 8665544795
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- calleridname = unknown
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- callingani2 = 0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- callingpres = 0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- callingtns = 0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- callington = 0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- channel = SIP/a7472sY42RMEZR8T-b642d3b0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- context = gafachi-incoming
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- dnid = 18666034799
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- enhanced = 0.0
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- extension = 18666034799
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- language = en
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- priority = 7
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- rdnis = unknown
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- request = agi-VDAD_ALL_inbound.agi
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- type = SIP
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi| -- uniqueid = 1249504804.12818
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|AGI Variables: |1249504804.12818|SIP/a7472sY42RMEZR8T-b642d3b0|18666034799|SIP|8665544795|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|+++++ INBOUND CALL VDCL STARTED : |debtsettlement|8665544795-18666034799|2009-08-05 13:40:38
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT campaign_id FROM vicidial_campaigns where active='Y' and campaign_allow_inbound='Y';|330598|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|callerID changed: Y0805134038000330598
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_auto_calls SET server_ip='192.168.10.2', campaign_id='debtsettlement', status='LIVE', lead_id='330598', uniqueid='1249504804.12818', callerid='Y0805134038000330598', channel='SIP/a7472sY42RMEZR8T-b642d3b0', phone_code='', phone_number='8665544795', call_time='2009-08-05 13:40:38', call_type='IN', stage='LIVE-0', queue_priority='0' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||INSERT INTO vicidial_closer_log SET lead_id='330598', campaign_id='debtsettlement', call_date='2009-08-05 13:40:38', start_epoch='1249504838', status='QUEUE', phone_code='', phone_number='8665544795', user='VDCL', processed='N', xfercallid='0', uniqueid='1249504804.12818' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDCL : |330598|0|2775|insert to vicidial_closer_log
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.25|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.5|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|0.75|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.25|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.5|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|1.75|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|2|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|2.25|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|2.5|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and campaign_id = 'debtsettlement' and call_time < "2009-08-05 13:40:38" and lead_id != '330598' ;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi||SELECT count(*) FROM vicidial_auto_calls where status = 'LIVE' and lead_id != '330598' and ( (queue_priority > '0') or (queue_priority = '0' and call_time < "2009-08-05 13:40:38") );|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|0E0|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAD get agent: |360|2.75|0E0|0E0|update of vla table: debtsettlement|
|UPDATE vicidial_live_agents set status='QUEUE',lead_id='330598',uniqueid='1249504804.12818', channel='SIP/a7472sY42RMEZR8T-b642d3b0', callerid='Y0805134038000330598', call_server_ip='192.168.10.2',comments='INBOUND' where status IN('CLOSER','READY') and lead_id<1 and campaign_id IN('0002','0003') and closer_campaigns LIKE "% debtsettlement %" and last_update_time > '20090805134033' order by random_id limit 1;|
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|NNNNN No available balance agent found
2009-08-05 13:40:38|agi-VDAD_ALL_inbound.agi|-- VDAC posttime record: |1|20090805134051|Y0805134038000330598|

Posted:
Thu Aug 06, 2009 6:39 pm
by lerroux
can anyone help me?

Posted:
Thu Aug 06, 2009 9:46 pm
by mflorell
It's hard to tell from your logs exactly what is going on. But just by the fact that we have dozens of clients that are doing multi-server agent to agent transfers without these issues, I am going to guess that something is misconfigured somewhere, or there is some other kind of issue on your system that is causing this.

Posted:
Thu Aug 06, 2009 10:43 pm
by williamconley
1) the next time you have to "delete the user and create it again" i will ASSUME that means the this user is no longer capable of getting a call transferred to or from ... which means you can generate the issue AT WILL. This is cool, actually. Next time, do not delete the user, just create a new one. After you've done that, set yourself up to duplicate the issue, delete all the logs, duplicate the issue and copy all your logs immediately elsewhere for review. This should give you a much shorter reading run. You may also want to record all the sql queries running through the system because somewhere in the logic of asking for data or in the resulting data set is your flaw.
2) your system is up 24/7? You have NO moment that you can have just one call on your box? that's a shame, because it would make troubleshooting this much easier for someone with limited experience.
3) have you tested this against more than one Carrier?

Posted:
Fri Aug 07, 2009 2:03 pm
by lerroux
hi all, found something, here's my script for the transfers im making:
- Code: Select all
exten => _90009.,1,Answer ; Answer the line
exten => _90009.,2,Dial(${TRUNKloop}/9${EXTEN},,to)
exten => _90009.,3,Hangup
exten => _990009.,1,Answer ; Answer the line
exten => _990009.,2,AGI(agi-VDAD_ALL_inbound.agi,CLOSER-----LB-----closers_new-----18666034799-----Closer-----park----------999-----1)
think the problem is its missing one line here:
- Code: Select all
exten => _990009.,3,Hangup
though im not so sure, i think this is the reason the call stays on the channel since the system didnt hangup the call....
wat you think? im testing this now with Hangup. seems to be working so far, though still looking at it if the problem pops out again.