Vicidial agents and calls not connected

[euridium]

Dear forum users,

I hope you can help us with a problem. We are trying to set up Astguiclient/Vicidial from SVN on a Debian 5 System. Currently we use version 2.2.0-194 with asterisk 1.4.21.2~dfsg-3 (debian version). Our problem is that predictive mode does not work. Calls are made but not connected to the agents.

The Real-Time Report shows the agent waiting even when a call is waiting for an agent:
3 calls being placed 2 calls ringing 1 calls waiting for agents
1 agents logged in 0 agents in calls 1 agents waiting 0 paused agents

Greetings,

T. B.

[mflorell]

You need to post Asterisk CLI output of a few of these calls.

[euridium]

Hi Matt,

thanks for your reply.

Code: Select all

[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [90049xxxxxxx@default:1] AGI("Local/90049xxxxxxxx@default-cc8f,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxx@default:2] Dial("Local/90049xxxxxxxxx@default-cc8f,2", "SIP/0049xxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxx@SIPtrunk
[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [90049xxxxxx@default:1] AGI("Local/90049xxxxxxx@default-f27d,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxxx@default:2] Dial("Local/90049xxxxxxx@default-f27d,2", "SIP/0049xxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxxx@SIPtrunk
[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [90049xxxxxxxxx@default:1] AGI("Local/90049xxxxxxxx@default-fbdc,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxxxxxx@default:2] Dial("Local/90049xxxxxxxx@default-fbdc,2", "SIP/0049xxxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxxx@SIPtrunk
[Jun 25 17:25:40]     -- SIP/SIPtrunk-01045ac0 is making progress passing it to Local/90049xxxxxxxxx@default-cc8f,2
[Jun 25 17:25:40]     -- SIP/SIPtrunk-0108cf90 is making progress passing it to Local/90049xxxxxxxx@default-f27d,2
[Jun 25 17:25:41]     -- SIP/SIPtrunk-010f2bc0 is making progress passing it to Local/90049xxxxxxxxxx@default-fbdc,2



[williamconley]

-- SIP/SIPtrunk-010f2bc0 is making progress passing it to Local/90049xxxxxxxxxx@default-fbdc,2

That's nice, but I don't see the calls being answered. If they aren't answered there's no reason to pass the call to an agent.

Are the calls being answered?

[euridium]

ok, here ist my completely CLI from call testing with "answer":

Code: Select all

[Jun 25 17:25:38]     -- Executing [h@default:1] DeadAGI("Local/90049xxxxxx@default-f778,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----6-----0") in new stack
[Jun 25 17:25:38]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:38]     -- Executing [8368@default:2] AGI("SIP/SIPtrunk-0108cf90", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:38]     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----6-----0 completed, returning 0
[Jun 25 17:25:38]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
DBD::mysql::st execute failed: Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
executing: SELECT drop_call_seconds,safe_harbor_message,safe_harbor_exten,concurrent_transfers FROM vicidial_campaigns where campaign_id = '110609'; Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
[Jun 25 17:25:38]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:38]     -- Executing [8368@default:3] AGI("SIP/SIPtrunk-0108cf90", "agi-VDAD_LB_transfer.agi|8368") in new stack
DBD::mysql::st execute failed: Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
executing: SELECT drop_call_seconds,safe_harbor_message,safe_harbor_exten,concurrent_transfers FROM vicidial_campaigns where campaign_id = '110609'; Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
[Jun 25 17:25:38]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:39]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:39]     -- Executing [8368@default:4] AGI("SIP/SIPtrunk-5c0393b0", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:39]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:39]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:39]     -- Executing [8368@default:4] AGI("SIP/SIPtrunk-0108cf90", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:39]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:39]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:39]     -- Executing [8368@default:5] Hangup("SIP/SIPtrunk-5c0393b0", "") in new stack
[Jun 25 17:25:39]   == Spawn extension (default, 8368, 5) exited non-zero on 'SIP/SIPtrunk-5c0393b0'
[Jun 25 17:25:39]     -- Executing [h@default:1] DeadAGI("SIP/SIPtrunk-5c0393b0", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Jun 25 17:25:39]     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Jun 25 17:25:39]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:39]     -- Executing [8368@default:5] Hangup("SIP/SIPtrunk-0108cf90", "") in new stack
[Jun 25 17:25:39]   == Spawn extension (default, 8368, 5) exited non-zero on 'SIP/SIPtrunk-0108cf90'
[Jun 25 17:25:39]     -- Executing [h@default:1] DeadAGI("SIP/SIPtrunk-0108cf90", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Jun 25 17:25:39]     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [9004985554446@default:1] AGI("Local/90049xxxxxx@default-cc8f,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxxx@default:2] Dial("Local/90049xxxxxxxx@default-cc8f,2", "SIP/0049xxxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxxx@SIPtrunk
[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [9004985551388@default:1] AGI("Local/90049xxxxxxxxx@default-f27d,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxxxxxx@default:2] Dial("Local/90049xxxxxxxxx@default-f27d,2", "SIP/0049xxxxxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxxx@SIPtrunk
[Jun 25 17:25:40]   == Parsing '/etc/asterisk/manager.conf': [Jun 25 17:25:40] Found
[Jun 25 17:25:40]   == Manager 'sendcron' logged on from 127.0.0.1
[Jun 25 17:25:40]     -- Executing [90049xxxxxxxxx@default:1] AGI("Local/90049xxxxxxxxx@default-fbdc,2", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:40]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:40]     -- Executing [90049xxxxxxxxxxx@default:2] Dial("Local/90049xxxxxxxxxx@default-fbdc,2", "SIP/0049xxxxxxxxxxx@SIPtrunk|55|tTo") in new stack
[Jun 25 17:25:40]     -- Called 0049xxxxxxxxxxxxx@SIPtrunk
[Jun 25 17:25:40]     -- SIP/SIPtrunk-01045ac0 is making progress passing it to Local/90049xxxxxxxxxxx@default-cc8f,2
[Jun 25 17:25:40]     -- SIP/SIPtrunk-0108cf90 is making progress passing it to Local/90049xxxxxxxxxxxxx@default-f27d,2
[Jun 25 17:25:41]     -- SIP/SIPtrunk-010f2bc0 is making progress passing it to Local/90049xxxxxxxxxxxxxx@default-fbdc,2
exit
No such command 'exit' (type 'help exit' for other possible commands)
*CLI> [Jun 25 17:25:45]     -- SIP/SIPtrunk-01045ac0 answered Local/90049xxxxxxxxxxxx@default-cc8f,2
[Jun 25 17:25:45]        > Channel Local/90049xxxxxxxxx@default-cc8f,1 was answered.
[Jun 25 17:25:45]     -- Executing [8368@default:1] AGI("Local/90049xxxxxxxxx@default-cc8f,1", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:45]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:45]     -- Executing [8368@default:2] AGI("Local/90049xxxxxxxxxxxxxxx@default-cc8f,1", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:45]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:45]   == Manager 'sendcron' logged off from 127.0.0.1
[Jun 25 17:25:45]   == Spawn extension (default, 90049xxxxxxxxxx, 2) exited non-zero on 'Local/90049xxxxxxxxxxxxxxxxx@default-cc8f,2'
[Jun 25 17:25:45]     -- Executing [h@default:1] DeadAGI("Local/9004985554446@default-cc8f,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----5-----0") in new stack
[Jun 25 17:25:45]     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----5-----0 completed, returning 0
[Jun 25 17:25:46]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:46]     -- Executing [8368@default:3] AGI("SIP/SIPtrunk-01045ac0", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:46]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:46]     -- SIP/SIPtrunk-0108cf90 answered Local/90049xxxxxxxxxxxxxxxxx@default-f27d,2
[Jun 25 17:25:46]        > Channel Local/90049xxxxxxxxxxxxxxxx@default-f27d,1 was answered.
[Jun 25 17:25:46]     -- Executing [8368@default:1] AGI("Local/90049xxxxxxxxxxxxxxxxxx@default-f27d,1", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:46]     -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Jun 25 17:25:46]     -- Executing [8368@default:2] AGI("SIP/SIPtrunk-0108cf90", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:46]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:46]   == Spawn extension (default, 90049xxxxxxxxxxxxxx, 2) exited non-zero on 'Local/90049xxxxxxxxxxxxxx@default-f27d,2'
[Jun 25 17:25:46]     -- Executing [h@default:1] DeadAGI("Local/90049xxxxxxxxxxx@default-f27d,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----6-----0") in new stack
[Jun 25 17:25:46]   == Manager 'sendcron' logged off from 127.0.0.1
[Jun 25 17:25:46]     -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----6-----0 completed, returning 0
DBD::mysql::st execute failed: Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
executing: SELECT drop_call_seconds,safe_harbor_message,safe_harbor_exten,concurrent_transfers FROM vicidial_campaigns where campaign_id = '110609'; Unknown column 'safe_harbor_message' in 'field list' at /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi line 339, <STDIN> line 19.
[Jun 25 17:25:46]     -- AGI Script agi-VDAD_LB_transfer.agi completed, returning 0
[Jun 25 17:25:46]     -- Executing [8368@default:4] AGI("SIP/SIPtrunk-01045ac0", "agi-VDAD_LB_transfer.agi|8368") in new stack
[Jun 25 17:25:46]     -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_LB_transfer.agi
[Jun 25 17:25:46]     -- SIP/SIPtrunk-010f2bc0 answered Local/90049xxxxxxxxxxxxx@default-fbdc,2
[Jun 25 17:25:46]        > Channel Local/90049xxxxxxxxxxxxx@default-fbdc,1 was answered.
[Jun 25 17:25:46]     -- Executing [8368@default:1] AGI("Local/90049xxxxxxxxxxxxxxx@default-fbdc,1", "agi://127.0.0.1:4577/call_log") in new stack
[Jun 25 17:25:46]   == Manager 'sendcron' logged off from 127.0.0.1



[mflorell]

Looks like you need to update at least your dialplan, agi-VDAD_LB_transfer.agi is not compatible with the 2.2.0 codebase.