[vdr] Re: Channel not sync'ed -> driver reload

To: vdr@linuxtv.org
Subject: [vdr] Re: Channel not sync'ed -> driver reload
From: Klaus Schmidinger <Klaus.Schmidinger@cadsoft.de>
Date: Wed, 02 Jan 2002 12:29:06 +0100
Content-Transfer-Encoding: 7bit
Content-Type: text/plain; charset=us-ascii
Delivered-To: mhonarc@limes.convergence.de
Organization: CadSoft Computer GmbH
References: <3C30375C.3974A84C@t-online.de>
Reply-to: vdr@linuxtv.org
Sender: kls@cadsoft.de
Sender: vdr-bounce@linuxtv.org

Ansgar Jonietz wrote:
> 
> Hi,
> 
> in the time I was in holidays my VDR had a problem: for ca. 50 minutes
> he makes one driver reload after another, the error message: Channel not
> snc'ed.
> 
> The log:
> 
> Recording starts, all OK:
> Dec 27 20:14:00 ophelia vdr[1150]: timer 3 start
> Dec 27 20:14:00 ophelia vdr[1150]: switching to channel 2
> Dec 27 20:14:00 ophelia vdr[1150]: Title: 'Marlene' Subtitle:
> 'Filmbiographie, D 1999 Regie: Joseph Vilsmaier'
> Dec 27 20:14:00 ophelia vdr[1150]: record
> /video/ZDF/2001-12-27.20:14.50.99.rec
> Dec 27 20:14:00 ophelia vdr[1150]: creating directory /video/ZDF
> Dec 27 20:14:00 ophelia vdr[1150]: creating directory
> /video/ZDF/2001-12-27.20:14.50.99.rec
> Dec 27 20:14:01 ophelia vdr[1150]: recording to
> '/video/ZDF/2001-12-27.20:14.50.99.rec/001.vdr'
> Dec 27 20:14:01 ophelia vdr[1741]: output thread started (pid=1741)
> Dec 27 20:14:01 ophelia vdr[1742]: input thread started (pid=1742)
> 
> Then, later: (that's not unusual, I have often Can't record MPEG1!)
> Dec 27 21:13:03 ophelia vdr[1741]: ERROR: can't record MPEG1!
> Dec 27 21:13:39 ophelia last message repeated 2 times
> Dec 27 21:13:45 ophelia vdr[1741]: ERROR: can't record MPEG1!
> Dec 27 21:15:03 ophelia vdr[1742]: ERROR: video data stream broken
> Dec 27 21:15:03 ophelia vdr[1742]: initiating emergency exit
> Dec 27 21:15:03 ophelia vdr[1150]: emergency exit requested - shutting
> down
> Dec 27 21:15:04 ophelia vdr[1150]: saved setup to /video/setup.conf
> Dec 27 21:15:04 ophelia vdr[1152]: EIT processing thread ended
> (pid=1152) - master
> Dec 27 21:15:04 ophelia vdr[1153]: EIT processing thread ended
> (pid=1153)
> Dec 27 21:15:07 ophelia vdr[1150]: buffer stats: 34780 (3%) used
> Dec 27 21:15:07 ophelia vdr[1150]: max. latency time 5 seconds
> Dec 27 21:15:07 ophelia vdr[1150]: exiting
> Dec 27 21:15:07 ophelia vdr[1150]: emergency exit!
> 
> <first driver reload>
> VDR starts:
> Dec 27 21:15:28 ophelia vdr[2094]: VDR version 0.99 started
> Dec 27 21:15:28 ophelia vdr[2094]: MP3 extention version 0.27 enabled
> Dec 27 21:15:28 ophelia vdr[2094]: MPlayer extention version 0.3 enabled
> Dec 27 21:15:28 ophelia vdr[2094]: loading /video/setup.conf
> Dec 27 21:15:28 ophelia vdr[2094]: loading /video/channels.conf
> Dec 27 21:15:30 ophelia vdr[2094]: loading /video/timers.conf
> Dec 27 21:15:30 ophelia vdr[2094]: loading /video/commands.conf
> Dec 27 21:15:30 ophelia vdr[2094]: loading /video/mp3sources.conf
> Dec 27 21:15:30 ophelia vdr[2094]: loading /video/mplayersources.conf
> Dec 27 21:15:30 ophelia vdr[2094]: probing /dev/ost/frontend0
> Dec 27 21:15:30 ophelia vdr[2096]: EIT processing thread started
> (pid=2096) - master
> Dec 27 21:15:30 ophelia vdr[2094]: probing /dev/ost/frontend1
> Dec 27 21:15:30 ophelia vdr[2097]: EIT processing thread started
> (pid=2097)
> Dec 27 21:15:30 ophelia vdr[2094]: probing /dev/ost/frontend2
> Dec 27 21:15:30 ophelia vdr[2094]: found 2 video devices
> Dec 27 21:15:30 ophelia vdr[2094]: setting primary DVB to 1
> Dec 27 21:15:30 ophelia vdr[2094]: switching to channel 9
> Dec 27 21:15:30 ophelia vdr[2094]: ERROR: channel 9 not sync'ed on DVB
> card 1!
> Dec 27 21:15:30 ophelia vdr[2094]: panic level: 0
> Dec 27 21:15:30 ophelia vdr[2094]: retrying
> Dec 27 21:15:30 ophelia vdr[2098]: LIRC remote control thread started
> (pid=2098)
> Dec 27 21:15:30 ophelia vdr[2094]: SVDRP listening on port 2001
> Dec 27 21:15:30 ophelia vdr[2094]: setting watchdog timer to 60 seconds
> Dec 27 21:15:36 ophelia vdr[2094]: timer 3 start
> Dec 27 21:15:36 ophelia vdr[2094]: switching to channel 2
> Dec 27 21:15:36 ophelia vdr[2094]: ERROR: channel 2 not sync'ed on DVB
> card 2!
> Dec 27 21:15:36 ophelia vdr[2094]: retrying
> Dec 27 21:15:37 ophelia vdr[2094]: waiting for EPG info...
> Dec 27 21:15:48 ophelia vdr[2094]: no EPG info available
> Dec 27 21:15:48 ophelia vdr[2094]: record
> /video/ZDF/2001-12-27.20:14.50.99.rec
> Dec 27 21:15:48 ophelia vdr[2094]: recording to
> '/video/ZDF/2001-12-27.20:14.50.99.rec/002.vdr'
> Dec 27 21:15:51 ophelia vdr[2102]: output thread started (pid=2102)
> Dec 27 21:15:51 ophelia vdr[2103]: input thread started (pid=2103)
> Dec 27 21:15:52 ophelia vdr[2094]: max. latency time 15 seconds
> Dec 27 21:15:54 ophelia kernel: dvb1: ARM crashed!
> Dec 27 21:16:59 ophelia vdr[2103]: ERROR: video data stream broken
> Dec 27 21:16:59 ophelia vdr[2103]: initiating emergency exit
> Dec 27 21:16:59 ophelia vdr[2094]: emergency exit requested - shutting
> down
> Dec 27 21:16:59 ophelia vdr[2094]: saved setup to /video/setup.conf
> Dec 27 21:16:59 ophelia vdr[2096]: EIT processing thread ended
> (pid=2096) - master
> Dec 27 21:16:59 ophelia vdr[2097]: EIT processing thread ended
> (pid=2097)
> Dec 27 21:17:03 ophelia vdr[2103]: ERROR (dvbapi.c,574): Bad file
> descriptor
> Dec 27 21:17:03 ophelia vdr[2103]: input thread ended (pid=2103)
> Dec 27 21:17:03 ophelia vdr[2094]: buffer stats: 2256 (0%) used
> Dec 27 21:17:03 ophelia vdr[2094]: max. latency time 15 seconds
> Dec 27 21:17:03 ophelia vdr[2094]: exiting
> Dec 27 21:17:03 ophelia vdr[2094]: emergency exit!
> 
> and so on...
> later a second recording starts, same error message pn another channel:
> 
> Dec 27 21:18:52 ophelia vdr[2737]: setting primary DVB to 1
> Dec 27 21:18:52 ophelia vdr[2737]: switching to channel 9
> Dec 27 21:18:52 ophelia vdr[2740]: EIT processing thread started
> (pid=2740)
> Dec 27 21:18:55 ophelia vdr[2737]: ERROR: channel 9 not sync'ed on DVB
> card 1!
> Dec 27 21:18:55 ophelia vdr[2737]: panic level: 0
> Dec 27 21:18:55 ophelia vdr[2737]: retrying
> Dec 27 21:18:57 ophelia vdr[2737]: ERROR: channel 9 not sync'ed on DVB
> card 1!
> Dec 27 21:18:57 ophelia vdr[2737]: panic level: 1
> Dec 27 21:18:57 ophelia vdr[2737]: retrying
> Dec 27 21:18:59 ophelia vdr[2737]: ERROR: channel 9 not sync'ed on DVB
> card 1!
> Dec 27 21:18:59 ophelia vdr[2737]: panic level: 2
> Dec 27 21:18:59 ophelia vdr[2737]: retrying
> Dec 27 21:18:59 ophelia vdr[2741]: LIRC remote control thread started
> (pid=2741)
> Dec 27 21:18:59 ophelia vdr[2737]: SVDRP listening on port 2001
> Dec 27 21:18:59 ophelia vdr[2737]: setting watchdog timer to 60 seconds
> Dec 27 21:19:04 ophelia vdr[2737]: timer 3 start
> Dec 27 21:19:04 ophelia vdr[2737]: switching to channel 2
> Dec 27 21:19:04 ophelia vdr[2737]: ERROR: channel 2 not sync'ed on DVB
> card 2!
> Dec 27 21:19:04 ophelia vdr[2737]: retrying
> Dec 27 21:19:07 ophelia vdr[2737]: ERROR: channel 2 not sync'ed on DVB
> card 2!
> Dec 27 21:19:07 ophelia vdr[2737]: retrying
> Dec 27 21:19:09 ophelia vdr[2737]: ERROR: channel 2 not sync'ed on DVB
> card 2!
> Dec 27 21:19:09 ophelia vdr[2737]: retrying
> Dec 27 21:19:09 ophelia vdr[2737]: initiating emergency exit
> Dec 27 21:19:10 ophelia vdr[2737]: emergency exit requested - shutting
> down
> Dec 27 21:19:10 ophelia vdr[2737]: saved setup to /video/setup.conf
> Dec 27 21:19:10 ophelia vdr[2739]: EIT processing thread ended
> (pid=2739) - master
> Dec 27 21:19:10 ophelia vdr[2740]: EIT processing thread ended
> (pid=2740)
> Dec 27 21:19:10 ophelia vdr[2737]: max. latency time 0 seconds
> Dec 27 21:19:10 ophelia vdr[2737]: exiting
> Dec 27 21:19:10 ophelia vdr[2737]: emergency exit!
> 
> Then, after *many* driver reloads, a last one...
> Dec 27 22:04:37 ophelia vdr[14794]: VDR version 0.99 started
> Dec 27 22:04:37 ophelia vdr[14794]: MP3 extention version 0.27 enabled
> Dec 27 22:04:37 ophelia vdr[14794]: MPlayer extention version 0.3
> enabled
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/setup.conf
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/channels.conf
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/timers.conf
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/commands.conf
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/mp3sources.conf
> Dec 27 22:04:37 ophelia vdr[14794]: loading /video/mplayersources.conf
> Dec 27 22:04:37 ophelia vdr[14794]: probing /dev/ost/frontend0
> Dec 27 22:04:37 ophelia vdr[14796]: EIT processing thread started
> (pid=14796) - master
> Dec 27 22:04:37 ophelia vdr[14794]: probing /dev/ost/frontend1
> Dec 27 22:04:37 ophelia vdr[14797]: EIT processing thread started
> (pid=14797)
> Dec 27 22:04:37 ophelia vdr[14794]: probing /dev/ost/frontend2
> Dec 27 22:04:37 ophelia vdr[14794]: found 2 video devices
> Dec 27 22:04:37 ophelia vdr[14794]: setting primary DVB to 1
> Dec 27 22:04:37 ophelia vdr[14794]: switching to channel 9
> Dec 27 22:04:42 ophelia kernel: dvb0: ARM crashed!
> Dec 27 22:04:42 ophelia vdr[14798]: LIRC remote control thread started
> (pid=14798)
> Dec 27 22:04:43 ophelia vdr[14794]: SVDRP listening on port 2001
> Dec 27 22:04:43 ophelia vdr[14794]: setting watchdog timer to 60 seconds
> 
> When I came home three days later ;-( VDR was dead, I started it and
> it's working now.
> 
> Any ideas what the problem was?

Could it be that your satellite dish was full of snow at that time?

> And why didn't runvdr reload the driver after 22:04?

That's probably due to the ARM crash at 22:04:42. Maybe Carsten's patch (posted earlier on this
list) will fix this:

--- dvbosd.c.orig       Mon Dec 31 18:19:16 2001
+++ dvbosd.c    Mon Dec 31 18:25:47 2001
@@ -347,6 +347,7 @@
      // must block all signals, otherwise the command might not be fully executed
      sigset_t set, oldset;
      sigfillset(&set);
+     sigdelset(&set, SIGALRM);
      sigprocmask(SIG_BLOCK, &set, &oldset);
      ioctl(videoDev, OSD_SEND_CMD, &dc);
      usleep(5000); // XXX Workaround for a driver bug (cInterface::DisplayChannel() displayed texts at wrong places

Klaus
-- 
_______________________________________________________________

Klaus Schmidinger                       Phone: +49-8635-6989-10
CadSoft Computer GmbH                   Fax:   +49-8635-6989-40
Hofmark 2                               Email:   kls@cadsoft.de
D-84568 Pleiskirchen, Germany           URL:     www.cadsoft.de
_______________________________________________________________

Follow-Ups:
- [vdr] Re: Channel not sync'ed -> driver reload
  - From: Jonietz <jjonietz@t-online.de>

References:
- [vdr] Channel not sync'ed -> driver reload
  - From: Ansgar Jonietz <ansgar@jonietz.de>

Prev by Date: [vdr] Re: More about free space on hd
Next by Date: [vdr] Re: Channel/Recording Security on VDR
Prev by thread: [vdr] Re: Channel not sync'ed -> driver reload
Next by thread: [vdr] Re: Channel not sync'ed -> driver reload
Index(es):
- Date
- Thread

Home | Main Index | Thread Index