[App_rpt-users] Voter error/lockup on DIAL

Tue Apr 19 21:04:36 UTC 2016

I'm running a DIAL box with 3 nodes on it.  Two are pciradio nodes and one is
using a RTCM over IP.  The server is not connected to the network just yet as
we are waiting on fusion splicers to connect our fiber drop.

The three nodes are linked in box via asterisk, and everything has been
working for about a month so far.

Today at around 11am I noticed the RTCM based node was not linked.  Turns out
it actually was linked but the audio was really laggy and locking up.  I'm
talking like events and audio going to it being 30 min or more delayed.  Very
strange stuff.

As I don't have internet at the site just yet, it meant a trip up there to
kick the server (I've since added a reboot macro).  While doing this I pulled
the logs and saw the following errors repeating fast enough to grow a 40 MB
log file.

> [Apr 19 11:32:47] WARNING[2735] file.c: File none does not exist in any format
> [Apr 19 11:32:47] WARNING[2735] file.c: Unable to open none (format 0x44 (ulaw|slin)): No such file or directory
> [Apr 19 11:32:47] WARNING[2735] app_rpt.c: ast_streamfile none failed on DAHDI/pseudo-1041225595
> [Apr 19 11:33:15] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:15] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:15] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:16] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[2756] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 11:33:17] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?

> [Apr 19 15:13:02] NOTICE[2776] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:02] NOTICE[4417] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[4416] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[4417] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[2776] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[4416] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[2756] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] WARNING[820] chan_iax2.c: Max retries exceeded to host 127.0.0.1 on IAX2/127.0.0.1:4569-2774 (type = 6, subclass = 11, ts=7900005, seqno=142)
> [Apr 19 15:13:03] WARNING[824] chan_iax2.c: Max retries exceeded to host 127.0.0.1 on IAX2/127.0.0.1:4569-85 (type = 6, subclass = 11, ts=7900034, seqno=142)
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[2776] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] WARNING[2776] channel.c: Exception flag set on 'voter/1234', but no exception handler
> [Apr 19 15:13:03] WARNING[821] chan_iax2.c: Max retries exceeded to host 127.0.0.1 on IAX2/127.0.0.1:4569-7422 (type = 6, subclass = 11, ts=13156197, seqno=132)
> [Apr 19 15:13:03] WARNING[818] chan_iax2.c: Max retries exceeded to host 127.0.0.1 on IAX2/127.0.0.1:4569-2485 (type = 6, subclass = 11, ts=13122517, seqno=128)
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?
> [Apr 19 15:13:03] NOTICE[832] channel.c: No/unknown event '0' on timer for 'voter/1234'?

Anyone know what this could be?  It's a stock DIAL install with very little in
the way of customizations, no announcements/modes/etc.

73's
-- 
Bryan Fields

727-409-1194 - Voice
727-214-2508 - Fax
http://bryanfields.net