[vdr] Re: problems in (random) recordings

["Uwe Weissbach" <uwe.weissbach@web.de>]

> > Never had anything like that.
> > 
> > Are there any error messages in the log file that might tell us
> > what's wrong here?
> 
> unfortunatly I have deleted all this recordings, so it's hard to find
> the dependend logs, but I will carefully look about it in future
> and will tell you...

this was about the problem a recording of a 90min movie is only
30min and maybe lost 2/3 of the frames.
ok, it happens again and here comes the /var/log/messages
from the early beginning by booting via vdr-wakeup until 
the finally shutdown.
The only thing I notice is the "ERROR: channel 1 not sync'ed on DVB card 2!"
at Mar 18 00:35:38 and the retrying next line, maybe its the reason for this behavior 
but I'm absolutly knownless why this happens sometimes but mostly the box runs 
fine.

Any suggestions to fix this problems are welcome...



Mar 18 00:34:05 mmbox syslogd 1.4.1: restart.
Mar 18 00:34:06 mmbox apmd[424]: Version 3.0final (APM BIOS 1.2, Linux driver 
1.15)
Mar 18 00:34:07 mmbox in.identd[476]: started
Mar 18 00:34:07 mmbox apmd[424]: Charge: * * * (-1% unknown)
Mar 18 00:34:10 mmbox kernel: klogd 1.4.1, log source = /proc/kmsg started.
Mar 18 00:34:10 mmbox kernel: Inspecting /boot/System.map-2.4.16-4GB
Mar 18 00:34:10 mmbox kernel: Loaded 11710 symbols from /boot/System.map-
2.4.16-4GB.
Mar 18 00:34:10 mmbox kernel: Symbols match kernel version 2.4.16.
Mar 18 00:34:10 mmbox kernel: Loaded 299 symbols from 8 modules.
Mar 18 00:34:10 mmbox kernel: ip_tables: (c)2000 Netfilter core team
Mar 18 00:34:10 mmbox kernel: ip_conntrack (1023 buckets, 8184 max)
Mar 18 00:34:10 mmbox kernel: PCI: Found IRQ 10 for device 02:0e.0
Mar 18 00:34:10 mmbox kernel: 3c59x: Donald Becker and others. 
www.scyld.com/network/vortex.html
Mar 18 00:34:10 mmbox kernel: 02:0e.0: 3Com PCI 3c905C Tornado at 0xb800. Vers 
LK1.1.16
Mar 18 00:34:10 mmbox kernel: usb.c: registered new driver usbdevfs
Mar 18 00:34:10 mmbox kernel: usb.c: registered new driver hub
Mar 18 00:34:10 mmbox kernel: uhci.c: USB Universal Host Controller Interface 
driver v1.1
Mar 18 00:34:10 mmbox kernel: usb-uhci.c: $Revision: 1.268 $ time 09:18:52 Dec 19 
2001
Mar 18 00:34:10 mmbox kernel: usb-uhci.c: High bandwidth mode enabled
Mar 18 00:34:10 mmbox kernel: usb-uhci.c: v1.268:USB Universal Host Controller 
Interface driver
Mar 18 00:34:10 mmbox kernel: usb.c: deregistering driver usbdevfs
Mar 18 00:34:10 mmbox kernel: usb.c: deregistering driver hub
Mar 18 00:34:10 mmbox kernel: IPv6 v0.8 for NET4.0
Mar 18 00:34:10 mmbox kernel: IPv6 over IPv4 tunneling driver
Mar 18 00:34:12 mmbox rpc.statd[698]: Version 0.3.1 Starting
Mar 18 00:34:12 mmbox kernel: Installing knfsd (copyright (C) 1996 
okir@monad.swb.de).
Mar 18 00:34:15 mmbox kernel: eth0: no IPv6 routers present
Mar 18 00:34:14 mmbox ntpdate[769]: step time server 130.149.17.21 offset -
3.089604 sec
Mar 18 00:34:14 mmbox ntpd[775]: ntpd 4.1.0 Fri Sep 21 14:42:26 GMT 2001 (1)
Mar 18 00:34:14 mmbox ntpd[775]: signal_no_reset: signal 13 had flags 4000000
Mar 18 00:34:15 mmbox ntpd[775]: precision = 11 usec
Mar 18 00:34:15 mmbox ntpd[775]: kernel time discipline status 0040
Mar 18 00:34:15 mmbox /usr/sbin/cron[786]: (CRON) STARTUP (fork ok) 
Mar 18 00:34:15 mmbox ntpd[775]: frequency initialized 0.000 from /etc/ntp.drift
Mar 18 00:34:16 mmbox kernel: ALSA card-cmipci.c:2613: C-Media PCI soundcard 
not found or device busy
Mar 18 00:34:26 mmbox kernel: i2c-core.o: i2c core module version 2.6.2 (20011118)
Mar 18 00:34:26 mmbox kernel: Linux video capture interface: v1.00
Mar 18 00:34:27 mmbox kernel: i2c-core.o: driver VES1893 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver VES1820 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver L64781 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: init_SP8870:
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver SP8870 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver tda8083 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver stv0299 DVB demodulator 
registered.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: driver i2c TV tuner driver registered.
Mar 18 00:34:28 mmbox kernel: saa7146_core.o: saa7146(1): bus:2, rev:1, 
mem:0xcaa9c000.
Mar 18 00:34:28 mmbox kernel: i2c-core.o: client [VES1893] registered to adapter 
[saa7146(1)](pos. 0).
Mar 18 00:34:28 mmbox kernel: VES1893: attaching VES1893 at 0x10 to adapter 
saa7146(1)
Mar 18 00:34:28 mmbox kernel: SP8870: no SP8870 found ...
Mar 18 00:34:28 mmbox kernel: tuner: chip found @ 0x61
Mar 18 00:34:28 mmbox kernel: i2c-core.o: client [i2c tv tuner chip] registered to 
adapter [saa7146(1)](pos. 1).
Mar 18 00:34:29 mmbox kernel: i2c-core.o: adapter saa7146(1) registered as adapter 
0.
Mar 18 00:34:29 mmbox kernel: saa7146_core.o: saa7146(2): bus:2, rev:1, 
mem:0xcaf1f000.
Mar 18 00:34:29 mmbox kernel: i2c-core.o: client [VES1893] registered to adapter 
[saa7146(2)](pos. 0).
Mar 18 00:34:29 mmbox kernel: VES1893: attaching VES1893 at 0x10 to adapter 
saa7146(2)
Mar 18 00:34:29 mmbox kernel: SP8870: no SP8870 found ...
Mar 18 00:34:29 mmbox kernel: tuner: chip found @ 0x61
Mar 18 00:34:29 mmbox kernel: i2c-core.o: client [i2c tv tuner chip] registered to 
adapter [saa7146(2)](pos. 1).
Mar 18 00:34:29 mmbox kernel: i2c-core.o: adapter saa7146(2) registered as adapter 
1.
Mar 18 00:34:31 mmbox kernel: dvb0: AV7111 - firm f0240009, rtsl b0250018, vid 
71010068, app 00012119
Mar 18 00:34:34 mmbox kernel: dvb1: AV7111 - firm f0240009, rtsl b0250018, vid 
71010068, app 00012119
Mar 18 00:34:35 mmbox kernel: dvb: 2 dvb(s) found!
Mar 18 00:34:35 mmbox su: (to root) root on /dev/console
Mar 18 00:34:35 mmbox PAM-unix2[1100]: session started for user root, service su 
Mar 18 00:34:36 mmbox vdr[1101]: VDR version 1.0.0pre3 started
Mar 18 00:34:36 mmbox vdr[1101]: MP3 extention version 0.37
Mar 18 00:34:36 mmbox vdr[1101]: MPlayer extention version 0.37
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/setup.conf
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/channels.conf
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/timers.conf
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/commands.conf
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/svdrphosts.conf
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/mp3sources.conf
Mar 18 00:34:36 mmbox vdr[1101]: WARNING: source base /mnt/cdrom not 
found/permission denied
Mar 18 00:34:36 mmbox vdr[1101]: loading id3 cache from /video/id3info.cache
Mar 18 00:34:36 mmbox vdr[1101]: loading /etc/vdr/mplayersources.conf
Mar 18 00:34:36 mmbox vdr[1101]: WARNING: source base /mnt/cdrom not 
found/permission denied
Mar 18 00:34:36 mmbox vdr[1101]: probing /dev/ost/frontend0
Mar 18 00:34:36 mmbox vdr[1103]: EIT processing thread started (pid=1103) - 
master
Mar 18 00:34:36 mmbox vdr[1101]: probing /dev/ost/frontend1
Mar 18 00:34:36 mmbox vdr[1104]: EIT processing thread started (pid=1104)
Mar 18 00:34:36 mmbox vdr[1101]: probing /dev/ost/frontend2
Mar 18 00:34:36 mmbox vdr[1101]: found 2 video devices
Mar 18 00:34:36 mmbox vdr[1101]: setting primary DVB to 1
Mar 18 00:34:36 mmbox vdr[1101]: reading EPG data from /var/vdr/epg.data
Mar 18 00:34:37 mmbox vdr[1101]: switching to channel 5
Mar 18 00:34:37 mmbox vdr[1101]: ERROR: channel 5 not sync'ed on DVB card 1!
Mar 18 00:34:37 mmbox vdr[1101]: panic level: 0
Mar 18 00:34:37 mmbox vdr[1101]: retrying
Mar 18 00:34:37 mmbox vdr[1105]: LIRC remote control thread started (pid=1105)
Mar 18 00:34:37 mmbox vdr[1101]: SVDRP listening on port 2001
Mar 18 00:34:37 mmbox vdr[1101]: setting watchdog timer to 15 seconds
Mar 18 00:34:39 mmbox kernel: lirc_serial: auto-detected active low receiver
Mar 18 00:34:45 mmbox vdr[1101]: max. latency time 1 seconds
Mar 18 00:35:38 mmbox vdr[1101]: ERROR: channel 1 not sync'ed on DVB card 2!
Mar 18 00:35:38 mmbox vdr[1101]: retrying
Mar 18 00:36:23 mmbox vdr[1101]: max. latency time 3 seconds
Mar 18 00:38:00 mmbox vdr[1101]: timer 8 start
Mar 18 00:38:00 mmbox vdr[1101]: switching to channel 1
Mar 18 00:38:01 mmbox vdr[1101]: Title: 'Der Onkel vom Mars' Subtitle: ''
Mar 18 00:38:01 mmbox vdr[1101]: record /video/Der_Onkel_vom_Mars/2002-03-
18.00.38.50.50.rec
Mar 18 00:38:01 mmbox vdr[1101]: creating directory /video/Der_Onkel_vom_Mars
Mar 18 00:38:01 mmbox vdr[1101]: creating directory 
/video/Der_Onkel_vom_Mars/2002-03-18.00.38.50.50.rec
Mar 18 00:38:01 mmbox vdr[1101]: recording to '/video/Der_Onkel_vom_Mars/2002-
03-18.00.38.50.50.rec/001.vdr'
Mar 18 00:38:01 mmbox vdr[1110]: output thread started (pid=1110)
Mar 18 00:38:01 mmbox vdr[1111]: input thread started (pid=1111)
Mar 18 00:44:02 mmbox kernel: apm: set display: Power management disabled
Mar 18 00:54:02 mmbox -- MARK --
Mar 18 00:59:00 mmbox /USR/SBIN/CRON[1166]: (root) CMD ( rm -f 
/var/spool/cron/lastrun/cron.hourly) 
Mar 18 01:14:02 mmbox -- MARK --
Mar 18 01:34:02 mmbox -- MARK --
Mar 18 01:54:02 mmbox -- MARK --
Mar 18 01:59:00 mmbox /USR/SBIN/CRON[1339]: (root) CMD ( rm -f 
/var/spool/cron/lastrun/cron.hourly) 
Mar 18 02:14:02 mmbox -- MARK --
Mar 18 02:15:01 mmbox vdr[1110]: output thread ended (pid=1110)
Mar 18 02:15:01 mmbox vdr[1111]: input thread ended (pid=1111)
Mar 18 02:15:01 mmbox vdr[1101]: buffer stats: 97008 (9%) used
Mar 18 02:15:01 mmbox vdr[1101]: timer 8 stop
Mar 18 02:15:01 mmbox vdr[1101]: deleting timer 8
Mar 18 02:15:02 mmbox vdr[1101]: next timer event at Mon Mar 18 17:26:00 2002 
Mar 18 02:15:02 mmbox vdr[1101]: confirm: Taste drücken um Shutdown 
abzubrechen
Mar 18 02:20:04 mmbox vdr[1101]: confirmed
Mar 18 02:20:04 mmbox vdr[1101]: executing '/usr/bin/shutdown.sh 1016468760 
54658 26 "MacGyver" 0'
Mar 18 02:20:04 mmbox kernel: Non-volatile memory driver v1.1
Mar 18 02:20:04 mmbox init: Switching to runlevel: 0
Mar 18 02:20:04 mmbox vdr[1101]: max. latency time 15 seconds
Mar 18 02:20:04 mmbox PAM-unix2[1100]: session finished for user root, service su 
Mar 18 02:20:12 mmbox kernel: nfsd: last server has exited
Mar 18 02:20:12 mmbox kernel: nfsd: unexporting all filesystems
Mar 18 02:20:12 mmbox rpc.mountd: Caught signal 15, un-registering and exiting. 
Mar 18 02:20:13 mmbox apmd[424]: Exiting
Mar 18 02:20:18 mmbox sshd[349]: Received signal 15; terminating.
Mar 18 02:20:18 mmbox kernel: Kernel logging (proc) stopped.
Mar 18 02:20:18 mmbox kernel: Kernel log daemon terminating.
Mar 18 02:20:20 mmbox exiting on signal 15 


--

    _    _
   (o)--(o)     
  /.______.\    
  \________/    
 ./        \.  
( .        , )  
 \ \_\\//_/ /   
  ~~  ~~  ~~    
(see it with monospaced font)


 Uwe Weissbach, Leipzig

mail:   uwe.weissbach@web.de
pgp:    send mail with "pgp-request" in subject

-----BEGIN GEEK CODE BLOCK-----
Version: 3.1
GCS/CC/IT d- s+:- a C++(+++) UL++> P 
L+> E- W+++ N+ o-- K- w O- M !V-- PS+ 
PE+ Y+ PGP++ t+ 5@ X? R tv- b++(+++) 
DI-? D---- G++ e* h---- r- y++ 
------END GEEK CODE BLOCK------