Vicidial Shows Dialing 200 calls | But no calls

[vkad]

-- Unit vicidial.service has begun starting up.
May 16 13:07:26 dialsf vicidial[21482]: Starting ViciDial Telephony Server...
May 16 13:07:26 dialsf vicidial[21482]: DAHDI already loaded, skipping.
May 16 13:07:28 dialsf kernel: SFW2-INext-DROP-DEFLT IN=eth1 OUT= MAC=0c:c4:7a:82:4b:17:80:ac:ac:b9:33:40:08:00 SRC=45.60.
May 16 13:07:31 dialsf vicidial[21482]: Initializing DAHDI Hardware... done.
May 16 13:07:31 dialsf vicidial[21482]: Resetting vars and rolling logs... done.
May 16 13:07:33 dialsf kernel: SFW2-INext-ACC IN=eth1 OUT= MAC=0c:c4:7a:82:4b:17:80:ac:ac:b9:33:40:08:00 SRC=49.145.29.252
May 16 13:07:33 dialsf kernel: SFW2-INext-DROP-DEFLT IN=eth1 OUT= MAC=0c:c4:7a:82:4b:17:80:ac:ac:b9:33:40:08:00 SRC=82.202
May 16 13:07:36 dialsf vicidial[21482]: Starting Asterisk... Failed! Check /var/log/vicidial.log
May 16 13:07:36 dialsf systemd[1]: vicidial.service: Control process exited, code=exited status=5
May 16 13:07:36 dialsf systemd[1]: Failed to start LSB: ViciDial Telephony Server.
-- Subject: Unit vicidial.service has failed
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/li ... temd-devel
--
-- Unit vicidial.service has failed.
--
-- The result is failed.
May 16 13:07:36 dialsf systemd[1]: vicidial.service: Unit entered failed state.
May 16 13:07:36 dialsf systemd[1]: vicidial.service: Failed with result 'exit-code'.

[vkad]

dialsf:~ # tail -f /var/log/vicidial.log
- vicidial_live_agents delete
- vicidial__users delete
- vicidial_campaign_server_stats delete
- vicidial_hopper delete
started screen
changed directory
started new screen session
detached screens
raised ulimit open files
Asterisk started... screen logging on

[vkad]

Anyone able to help on this issue or request more information needed?

[lmoreira]

What is on Asterisk logs?

[vkad]

What should I look out for in logs because I don't see anything unusual there?

[vkad]

viewtopic.php?f=4&t=38387

This is more detailed here version of the symptoms and diagnosis

[thephaseusa]

Have you looked at your journal logs at the time this issue is happening?
journalctl -u asterisk.service --since '2018-05-28 13:00:00'

When it happens what does systemctl status asterisk give? Is it failed or stopped?

John

[vkad]

no it is not failed or stopped


the vicidial_auto_calls table has all calls with "null" channel when this happens. could this be the reason?

if i wanted to make sure that all invalid calls or calls longer than lets say 60 seconds ended from this table, how can i do that.

viewtopic.php?t=4627#
I want to add this to the dialplan to catch any invalid numbers (is this a valid rule?), and if it is valid where should it be added?
exten => _X.,1,AGI(agi://127.0.0.1:4577/call_log)
exten => _X.,2,Playback(please-contact-tech-supt)
exten => _X.,3,Hangup

[vkad]

Have you looked at your journal logs at the time this issue is happening?
journalctl -u asterisk.service --since '2018-05-28 13:00:00'

When it happens what does systemctl status asterisk give? Is it failed or stopped?

John

problem connecting to "localhost", port 5038: Connection refused at /usr/share/astguiclient/AST_vm_update.pl line 222


just got this error in my root mail

[vkad]

Also, another issue I noticed was when this event happens, and if I login as an agent and try to "call agent webphone" nothing happens....

[lmoreira]

Asterisk needs to run properly under vicidial service (with all screen stances) to communicate back and forth with vicidial scripts. If your asterisk service went down and it restarts from safe_asterisk script, it's a problem.

[blackbird2306]

problem connecting to "localhost", port 5038: Connection refused at /usr/share/astguiclient/AST_vm_update.pl line 222

Vicidial communicates with Asterisk through Asterisk Manager Interface API. AMI listens at port 5038 and this connection doesn't work (Connection refused).

Some reasons for your problem:
1. Firewall / iptables doesn't allow connection to port 5038 (e.g. try from linux cli: telnet localhost 5038 (on dialer server))
2. You made changes in manager.conf file in "/etc/asterisk" directory. Is bindaddr = 0.0.0.0 ? Did you change the default secret "1234" ?
3. You changed in admin --> servers --> Manager User (default: cron) and Manager Secret (default: 1234)

[vkad]

[May 29 16:09:51] ERROR[2784]: tcptls.c:447 tcptls_stream_close: SSL_shutdown() failed: error:00000005:lib(0):func(0):DH lib, Underlying BIO error: Broken pipe


Also this error is present....

1. localhost (shouldn't go through firewall, right?). Also, why does it work and then all of sudden stop working randomly...
2. no changes to managerconf
port = 5038
bindaddr = 0.0.0.0
secret=1234
3. No changes here either.

[vkad]

From root@localhost Tue May 29 16:07:06 2018
Return-Path: <root@localhost>
X-Original-To: root
Delivered-To: root@localhost
Received: by localhost (Postfix, from userid 0)
id C31AC400BD3; Tue, 29 May 2018 16:07:06 -0400 (EDT)
From: "(Cron Daemon)" <root@localhost>
To: root@localhost
Subject: Cron <root@dialsf> /usr/share/astguiclient/AST_CRON_audio_3_ftp.pl --MP3
Content-Type: text/plain; charset=UTF-8
Auto-Submitted: auto-generated
Precedence: bulk
X-Cron-Env: <XDG_SESSION_ID=677>
X-Cron-Env: <XDG_RUNTIME_DIR=/run/user/0>
X-Cron-Env: <LC_CTYPE=en_US.UTF-8>
X-Cron-Env: <SHELL=/bin/sh>
X-Cron-Env: <HOME=/root>
X-Cron-Env: <PATH=/usr/bin:/bin>
X-Cron-Env: <LOGNAME=root>
X-Cron-Env: <USER=root>
Message-Id: <20180529200706.C31AC400BD3@localhost>
Date: Tue, 29 May 2018 16:06:27 -0400 (EDT)

Cannot open Local file /var/spool/asterisk/monitorDONE/MP3/OUTUSA_jmartin_20180529-155815_205675xxx-all.mp3: No such file or directory
at /usr/share/astguiclient/AST_CRON_audio_3_ftp.pl line 534.
mv: cannot stat '/var/spool/asterisk/monitorDONE/MP3/OUTUSA_jmartin_20180529-155815_205675xxx-all.mp3': No such file or directory
Cannot open Local file /var/spool/asterisk/monitorDONE/MP3/OUTUSA_cerenea_20180529-155656_210416xxx-all.mp3: No such file or directory
at /usr/share/astguiclient/AST_CRON_audio_3_ftp.pl line 534.
mv: cannot stat '/var/spool/asterisk/monitorDONE/MP3/OUTUSA_cerenea_20180529-155656_2104165xxx-all.mp3': No such file or directory
mv: cannot stat '/var/spool/asterisk/monitorDONE/MP3/OUTUSA_jtanduyan_20180529-155800_7135942xxx-all.mp3': No such file or directory
mv: cannot stat '/var/spool/asterisk/monitorDONE/MP3/OUTUSA_dferrer_20180529-155814_3148257xxx-all.mp3': No such file or directory
mv: cannot stat '/var/spool/asterisk/monitorDONE/MP3/OUTUSA_cerenea_20180529-155724_7732511xxx-all.mp3': No such file or directory


Phone numbers are hidden for security...
This event also coincides with the paused dialing. I don't know if this affects auto dialing at all...

[vkad]

I guess the recordings issue would happen after the event as something must have gone wrong in the system...(this indicates something went wrong rather than actually causing any issues)

[blackbird2306]

Vicidial "thinks" these files were recorded, but asterisk didn't generate them. Again I think there is a problem with your asterisk manager connection. What is output of telnet connection?

[vkad]

May 29 16:50:33 dialsf mysql-systemd-helper[1518]: 2018-05-29 16:50:33 140693801236224 [ERROR] mysqld: The table 'vicidial_manager' is full

This came up in the journalctl this time dialling stopped.

How can I test for asterisk manager connection?

[vkad]

telnet 127.0.0.1 5038 is able to connect fine on all diallers back and forth with each other.

[thephaseusa]

Check journalctl -u mysql.service --since ' 2018-05-29 16:50:25' look at that table full issue.
I'm not sure but if the table is filling up you might be to adjust /etc/my.cnf to increase its limits.

John

[vkad]

Yes, it is the issue of vicidial_manager table. Fixed temporarily by increasing the ram....But might convert it from memory to myisam.