Hello just zapped
from 1, to 2,3,4,5,6 "6" was not excuted and VDR seems to die.
What happend?
Too i see that VDR is getting the wrong time. Why?
vdr ... 19:50:06 vdr[1676]: channel 17 (KiKa) event 19:50 'Die Blechk÷pfe' status 4 19:51:43 vdr[1673]: channel 7 (MDR FERNSEHEN) event 19:30 'MDR aktuell' status 1 19:52:00 vdr[1670]: channel 7 (MDR FERNSEHEN) event 19:50 'Pi mal Daumen' status 4 19:53:18 vdr[1676]: channel 2 (ZDF) event 19:25 'Hallo Robbie!' status 3
19:53:27 vdr[1676]: System Time = Sat 19:53:27 2005 (1116698007) 19:53:27 vdr[1676]: Local Time = Sat 19:23:28 2005 (1116696208)
19:23:28 vdr[18967]: recording thread ended (pid=18967, tid=442380) 19:23:28 vdr[18969]: TS buffer on device 2 thread ended (pid=18969, tid=475150) 19:23:28 vdr[18968]: buffer stats: 105844 (5%) used 19:23:28 vdr[18968]: receiver on device 2 thread ended (pid=18968, tid=458765) 19:23:28 vdr[18966]: file writer thread ended (pid=18966, tid=425995)
19:23:28 vdr[1665]: cTS2PES got 0 TS errors, 1 TS continuity errors 19:23:28 vdr[1665]: cTS2PES got 0 TS errors, 1 TS continuity errors
19:23:28 vdr[1665]: buffer stats: 106220 (2%) used 19:23:28 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') stop 19:25:24 vdr[1676]: System Time = Sat 19:25:24 2005 (1116696324) 19:25:24 vdr[1676]: Local Time = Sat 19:55:22 2005 (1116698122) WARP 19:55:23 vdr[1665]: switching device 2 to channel 5 19:55:23 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') start 19:55:23 vdr[1665]: Title: 'Schleswig-Holstein-Magazin' Subtitle: '' 19:55:23 vdr[1665]: record /video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec 19:55:23 vdr[1665]: recording to '/video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec/002.vdr' 19:55:23 vdr[21300]: file writer thread started (pid=21300, tid=491531) 19:55:23 vdr[21301]: recording thread started (pid=21301, tid=507916) 19:55:23 vdr[21302]: receiver on device 2 thread started (pid=21302, tid=524301) 19:55:23 vdr[21303]: TS buffer on device 2 thread started (pid=21303, tid=540686)
19:56:20 vdr[1676]: System Time = Sat 19:56:20 2005 (1116698180) 19:56:20 vdr[1676]: Local Time = Sat 19:24:55 2005 (1116696295)
WARP back 19:24:55 vdr[21301]: recording thread ended (pid=21301, tid=507916) 19:24:55 vdr[21303]: TS buffer on device 2 thread ended (pid=21303, tid=540686) 19:24:55 vdr[21302]: buffer stats: 87232 (4%) used 19:24:55 vdr[21302]: receiver on device 2 thread ended (pid=21302, tid=524301) 19:24:55 vdr[21300]: file writer thread ended (pid=21300, tid=491531) 19:24:55 vdr[1665]: buffer stats: 87608 (1%) used 19:24:55 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') stop
19:25:24 vdr[1676]: System Time = Sat 19:25:24 2005 (1116696324) 19:25:24 vdr[1676]: Local Time = Sat 19:56:49 2005 (1116698209)
19:56:49 vdr[1665]: switching device 2 to channel 5 19:56:49 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') start 19:56:49 vdr[1665]: Title: 'Schleswig-Holstein-Magazin' Subtitle: '' 19:56:49 vdr[1665]: record /video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec What time stamp has the directory? 21:19?? 19:56:49 vdr[1665]: recording to '/video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec/003.vdr' 19:56:49 vdr[21438]: file writer thread started (pid=21438, tid=557067) 19:56:49 vdr[21439]: recording thread started (pid=21439, tid=573452) The recording should start at 19:30, not 19:56 19:56:49 vdr[21440]: receiver on device 2 thread started (pid=21440, tid=589837) 19:56:49 vdr[21441]: TS buffer on device 2 thread started (pid=21441, tid=606222) 19:58:59 vdr[1670]: changing pids of channel 15 from 301+301:302=deu:2404 to 2401+2401:2402=deu:2404 19:58:59 vdr[1673]: changing pids of channel 148 from 101+101:102=deu:2404 to 2401+2401:2402=deu:2404 19:59:00 vdr[21439]: recording thread ended (pid=21439, tid=573452) 19:59:00 vdr[21441]: TS buffer on device 2 thread ended (pid=21441, tid=606222) 19:59:00 vdr[1673]: changing pids of channel 150 from 201+201:202=deu:2404 to 2401+2401:2402=deu:2404 19:59:00 vdr[21440]: buffer stats: 76328 (3%) used 19:59:00 vdr[21440]: receiver on device 2 thread ended (pid=21440, tid=589837) 19:59:00 vdr[21438]: file writer thread ended (pid=21438, tid=557067) 19:59:00 vdr[1665]: buffer stats: 76704 (1%) used 19:59:00 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') stop 19:59:01 vdr[1670]: channel 5 (EinsFestival) event 19:30 'Schleswig-Holstein-Magazin' status 1 19:59:01 vdr[1670]: channel 6 (EinsExtra) event 19:30 'Hamburg Journal' status 1 19:59:01 vdr[1673]: channel 4 (EinsPlus) event 19:30 'Nordmagazin' status 1 19:59:03 vdr[1673]: channel 15 (NDR FS MV) event 19:30 'Nordmagazin' status 1 19:59:04 vdr[1676]: channel 2 (ZDF) event 19:25 'Hallo Robbie!' status 4 19:59:08 vdr[1676]: channel 3 (3sat) event 19:20 'FOYER - Das Theatermagazin' status 1 19:59:10 vdr[1673]: channel 6 (EinsExtra) event 19:59 'Heute Abend in EinsExtra' status 4 19:59:28 vdr[1673]: channel 6 (EinsExtra) event 19:59 'Heute Abend in EinsExtra' status 1 19:59:40 vdr[1676]: channel 20 (ZDFinfokanal) event 20:00 'AKTUELL - europa' status 4 19:59:55 vdr[1670]: changing pids of channel 8 from 501+501:502=deu:504 to 601+601:602=deu:604 19:59:59 vdr[1673]: channel 5 (EinsFestival) event 20:00 'Tagesschau' status 4 19:59:59 vdr[1670]: channel 6 (EinsExtra) event 20:00 'Tagesschau' status 4 19:59:59 vdr[1673]: channel 4 (EinsPlus) event 20:00 'Tagesschau' status 4 20:00:00 vdr[1670]: channel 8 (rbb Brandenburg) event 20:00 'Tagesschau' status 4 20:00:00 vdr[1670]: channel 9 (rbb Berlin) event 20:00 'Tagesschau' status 4 20:00:03 vdr[1670]: channel 15 (NDR FS MV) event 20:00 'Tagesschau' status 4 20:00:05 vdr[1676]: channel 3 (3sat) event 20:00 'Tagesschau' status 4 20:01:56 vdr[1676]: channel 17 (KiKa) event 19:50 'Die Blechk÷pfe' status 1 20:03:13 vdr[1676]: channel 17 (KiKa) event 20:00 'Nick & Perry' status 4 20:09:52 vdr[1676]: System Time = Sat 20:09:52 2005 (1116698992) 20:09:52 vdr[1676]: Local Time = Sat 19:38:27 2005 (1116697107) 19:38:27 vdr[1665]: next timer event at Sat 20:15:00 2005 19:38:27 vdr[1665]: confirm: Press any key to cancel shutdown 19:38:56 vdr[1676]: System Time = Sat 19:38:56 2005 (1116697136) 19:38:56 vdr[1676]: Local Time = Sat 20:10:21 2005 (1116699021) 20:10:21 vdr[1665]: confirmed 20:10:21 vdr[1665]: executing '/video0/pwroff 1116699300 279 18 "Brncken dieser Erde" 0' 20:10:21 pwroff: VDR shutdown 1:1116699300 2:279 3:18 4:Brncken dieser Erde 5:0 A:1116699300 279 18 Brncken dieser Erde 0 20:10:21 pwroff: 20:10:21 up 3:45, 1 user, load average: 0.25, 0.25, 0.26 pwroff is not executed when 1 user logged in. 20:12:00 vdr[1665]: switching to channel 1 20:12:00 vdr[1665]: creating directory /vtx/S19.2E-1-1101-28106 20:12:01 vdr[23110]: receiver on device 1 thread started (pid=23110, tid=638988) 20:12:01 vdr[23111]: TS buffer on device 1 thread started (pid=23111, tid=655373) 20:12:01 anacron[23117]: Anacron 2.3 started on 2005-05-21 20:12:01 anacron[23117]: Normal exit (0 jobs run) 20:12:02 vdr[1670]: channel 22 (Phoenix) event 20:00 'Tagesschau' status 4 20:12:02 vdr[1670]: channel 16 (BR-alpha) event 20:00 'Gernstl unterwegs' status 4 20:12:02 vdr[1670]: channel 12 (hr-fernsehen) event 20:00 'Tagesschau' status 4 20:12:02 vdr[1670]: channel 10 (S#DWEST BW) event 20:00 'Tagesschau' status 4 20:12:02 vdr[1670]: channel 14 (Bayerisches FS) event 19:45 'Kunst & Krempel' status 4 20:12:02 vdr[1670]: channel 11 (SR Fernsehen Sndwest) event 20:00 'Tagesschau' status 4 20:12:02 vdr[1670]: channel 1 (Das Erste) event 20:00 'Tagesschau' status 4 20:12:02 vdr[1670]: channel 18 (arte) event 20:00 'Filmfestival Cannes' status 4 20:12:02 vdr[1670]: channel 13 (WDR K÷ln) event 20:00 'Tagesschau' status 4 20:12:05 vdr[1670]: changing pids of channel 158 from 701+701:702:204 to 901+901:902:204 20:12:08 vdr[1665]: switching to channel 2 20:12:08 vdr[23111]: TS buffer on device 1 thread ended (pid=23111, tid=655373) 20:12:08 vdr[23110]: buffer stats: 4700 (0%) used 20:12:08 vdr[23110]: receiver on device 1 thread ended (pid=23110, tid=638988) 20:12:08 vdr[1665]: buffer stats: 0 (0%) used 20:12:08 vdr[1665]: creating directory /vtx/S19.2E-1-1079-28006 20:12:08 vdr[23129]: receiver on device 1 thread started (pid=23129, tid=688140) 20:12:08 vdr[23130]: TS buffer on device 1 thread started (pid=23130, tid=704525) 20:12:17 vdr[1676]: System Time = Sat 20:12:17 2005 (1116699137) 20:12:17 vdr[1676]: Local Time = Sat 19:40:52 2005 (1116697252) WARP 19:40:52 vdr[1665]: switching device 2 to channel 5 19:40:52 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') start 19:40:52 vdr[1665]: Title: 'Schleswig-Holstein-Magazin' Subtitle: '' 19:40:52 vdr[1665]: record /video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec 19:40:52 vdr[1665]: recording to '/video0/Schleswig-Holstein-Magazin/_/2005-05-21.19:29.50.03.rec/004.vdr' 19:40:52 vdr[23144]: file writer thread started (pid=23144, tid=720910) 19:40:52 vdr[23145]: recording thread started (pid=23145, tid=737295) 19:40:52 vdr[23146]: receiver on device 2 thread started (pid=23146, tid=753680) 19:40:52 vdr[23147]: TS buffer on device 2 thread started (pid=23147, tid=770065) 19:41:03 kernel: lirc_serial: AIEEEE: your clock just jumped backwards 19:41:03 kernel: lirc_serial: 0 1 428f72af 428f79f8 43599 39f45 19:41:09 vdr[1665]: switching to channel 3 19:41:09 vdr[23130]: TS buffer on device 1 thread ended (pid=23130, tid=704525) 19:41:09 vdr[23129]: buffer stats: 4136 (0%) used 19:41:09 vdr[23129]: receiver on device 1 thread ended (pid=23129, tid=688140) 19:41:09 vdr[1665]: buffer stats: 0 (0%) used 19:41:10 vdr[1665]: creating directory /vtx/S19.2E-1-1079-28007 19:41:10 vdr[23173]: receiver on device 1 thread started (pid=23173, tid=802828) 19:41:10 vdr[23174]: TS buffer on device 1 thread started (pid=23174, tid=819213) 19:41:15 vdr[1665]: switching to channel 4 19:41:15 vdr[23174]: TS buffer on device 1 thread ended (pid=23174, tid=819213) 19:41:15 vdr[23173]: buffer stats: 3948 (0%) used 19:41:15 vdr[23173]: receiver on device 1 thread ended (pid=23173, tid=802828) 19:41:15 vdr[1665]: buffer stats: 0 (0%) used 19:41:19 vdr[1665]: switching to channel 5 19:41:21 vdr[1676]: System Time = Sat 19:41:21 2005 (1116697281) 19:41:21 vdr[1676]: Local Time = Sat 20:12:46 2005 (1116699166) WARP 20:12:46 vdr[23144]: ERROR: video data stream broken 20:12:46 vdr[23144]: initiating emergency exit 20:12:46 vdr[23145]: recording thread ended (pid=23145, tid=737295) 20:12:46 vdr[23147]: TS buffer on device 2 thread ended (pid=23147, tid=770065) 20:12:46 vdr[23146]: buffer stats: 72568 (3%) used 20:12:46 vdr[23146]: receiver on device 2 thread ended (pid=23146, tid=753680) 20:12:46 vdr[23144]: file writer thread ended (pid=23144, tid=720910) 20:12:46 vdr[1665]: buffer stats: 72944 (1%) used 20:12:46 vdr[1665]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') stop 20:12:47 vdr[1665]: switching to channel 6 20:12:47 vdr[1665]: emergency exit requested - shutting down 20:12:47 vdr[1665]: stopping plugin: femon 20:12:47 vdr[1665]: stopping plugin: undelete 20:12:47 vdr[1665]: stopping plugin: osdteletext 20:12:47 vdr[1665]: saved setup to /video0/setup.conf 20:12:47 vdr[1680]: thread ended (pid=1680, tid=147466) 20:12:47 vdr[1669]: tuner on device 1 thread ended (pid=1669, tid=16386) 20:12:47 lircd 0.7.0[1324]: removed client 20:12:48 vdr[1670]: Section handler thread ended (pid=1670, tid=32771) 20:12:48 vdr[1672]: tuner on device 2 thread ended (pid=1672, tid=49156) 20:12:48 vdr[1673]: Section handler thread ended (pid=1673, tid=65541) 20:12:48 vdr[1675]: tuner on device 3 thread ended (pid=1675, tid=81926) 20:12:48 vdr[1676]: Section handler thread ended (pid=1676, tid=98311) 20:12:48 vdr[1678]: tuner on device 4 thread ended (pid=1678, tid=114696) 20:12:48 vdr[1679]: Section handler thread ended (pid=1679, tid=131081) 20:12:48 vdr[1665]: deleting plugin: femon 20:12:48 vdr[1665]: deleting plugin: undelete 20:12:48 vdr[1665]: undelete: cPluginUndelete::~cPluginUndelete 20:12:48 vdr[1665]: deleting plugin: osdteletext 20:12:48 vdr[1665]: ===================== 20:12:48 vdr[1665]: EPG bugfix statistics 20:12:48 vdr[1665]: ===================== 20:12:48 vdr[1665]: IF SOMEBODY WHO IS IN CHARGE OF THE EPG DATA FOR ONE OF THE LISTED 20:12:48 vdr[1665]: CHANNELS READS THIS: PLEASE TAKE A LOOK AT THE FUNCTION cEvent::FixEpgBugs() 20:12:48 vdr[1665]: IN VDR/epg.c TO LEARN WHAT'S WRONG WITH YOUR DATA, AND FIX IT! 20:12:48 vdr[1665]: ===================== 20:12:48 vdr[1665]: Fix^IHits^IChannels 20:12:48 vdr[1665]: 0^I8853^IS#DWEST RP, BR-alpha, WDR Wuppertal, WDR Siegen, WDR Dnsseldorf, WDR Bielefeld, ... 20:12:48 vdr[1665]: 2^I353^IBR-alpha, ZDFinfokanal 20:12:48 vdr[1665]: 3^I4697^IKiKa, SAT.1, ProSieben, N24, KABEL1 20:12:48 vdr[1665]: 4^I25^IPhoenix 20:12:48 vdr[1665]: 5^I218^I3sat, WDR 3, hr2, Phoenix, hr-klassik, KiKa, ZDF, ProSieben 20:12:48 vdr[1665]: 6^I13^IPhoenix, DKULTUR, Eurosport, EuroNews, hr-fernsehen 20:12:48 vdr[1665]: 7^I166515^IEinsFestival, NDR FS SH, NDR FS MV, EinsPlus, NDR FS HH, NDR FS NDS, S#DWEST RP, ... 20:12:48 vdr[1665]: ===================== 20:12:48 vdr[1665]: max. latency time 60 seconds 20:12:48 vdr[1665]: exiting 20:12:48 vdr[1665]: emergency exit! 20:12:48 logger[23195]: /root/video/VDR/runvdr restarting VDR 20:12:58 kernel: bt878(0): unloading 20:12:58 kernel: bt878_mem: 0xe1be1000. 20:12:58 kernel: i2c-core.o: driver unregistered: i2c TV tuner driver 20:12:58 kernel: bttv0: unloading 20:12:58 kernel: i2c-core.o: adapter unregistered: bt878 #0 [hw] 20:12:58 kernel: usb.c: deregistering driver ttusb-dec 20:12:58 kernel: usb.c: deregistering driver Technotrend/Hauppauge USB-Nova 20:12:58 kernel: saa7146: unregister extension 'dvb'. 20:13:05 kernel: bttv: driver version 0.9.15 loaded 20:13:05 kernel: bttv: using 8 buffers with 2080k (520 pages) each for capture 20:13:05 kernel: bttv: Bt8xx card found (0). 20:13:05 kernel: bttv0: Bt878 (rev 17) at 00:0a.0, irq: 10, latency: 64, mmio: 0xcfcfe000 20:13:05 kernel: bttv0: detected: AVermedia DVB-T 771 [card=121], PCI subsystem ID is 1461:0771 20:13:05 kernel: bttv0: using: AVerMedia AVerTV DVB-T 771 [card=121,autodetected] 20:13:05 kernel: bttv0: gpio: en=00000000, out=00000000 in=00d0e40f [init] 20:13:05 kernel: i2c-dev.o: Registered 'bt878 #0 [hw]' as minor 0 20:13:05 kernel: i2c-core.o: adapter bt878 #0 [hw] registered as adapter 0. 20:13:05 kernel: bttv0: using tuner=-1 20:13:05 kernel: bttv0: IRQ lockup, cleared int mask [bits: GPINT*] 20:13:05 kernel: bttv0: registered device video0 20:13:05 kernel: bttv0: registered device vbi0 20:13:05 kernel: bttv0: PLL: 28636363 => 35468950 . ok 20:13:05 kernel: i2c-core.o: driver i2c TV tuner driver registered. 20:13:05 kernel: bt878: AUDIO driver version 0.0.0 loaded 20:13:05 kernel: bt878: Bt878 AUDIO function found (0). 20:13:05 kernel: bt878(0): Bt878 (rev 17) at 00:0a.1, irq: 10, latency: 64, memory: 0xcfcff000 20:13:05 kernel: DVB: registering new adapter (Ave). 20:13:05 kernel: DVB: registering frontend 0:0 (DVB-T Zarlink MT352 demodulator driver)... 20:13:06 vdr[23255]: VDR version 1.3.24 started 20:13:06 vdr[23255]: loading plugin: ./PLUGINS/lib/libvdr-osdteletext.so.1.3.24 20:13:06 vdr[23255]: loading plugin: ./PLUGINS/lib/libvdr-undelete.so.1.3.24 20:13:06 vdr[23255]: Undelete: cPluginUndelete::cPluginUndelete 20:13:06 vdr[23255]: loading plugin: ./PLUGINS/lib/libvdr-femon.so.1.3.24 20:13:06 vdr[23255]: loading /video0/setup.conf 20:13:06 vdr[23255]: ERROR: unknown config parameter: AC3dynrng = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: AC3overDVB = 0 20:13:06 vdr[23255]: ERROR: unknown config parameter: AIOforAC3 = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: Card0usesLNBnr = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: dfProgressbar = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: divxbitrate = 8 20:13:06 vdr[23255]: ERROR: unknown config parameter: divxquality = 3 20:13:06 vdr[23255]: ERROR: unknown config parameter: divxrecord = 0 20:13:06 vdr[23255]: ERROR: unknown config parameter: divxx = 720 20:13:06 vdr[23255]: ERROR: unknown config parameter: divxy = 576 20:13:06 vdr[23255]: ERROR: unknown config parameter: DVDAudioLanguage = 0 20:13:06 vdr[23255]: ERROR: unknown config parameter: DVDMenuLanguage = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: DVDPlayerRCE = 2 20:13:06 vdr[23255]: ERROR: unknown config parameter: DVDShowSubtitles = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: DVDSpuLanguage = 0 20:13:06 vdr[23255]: ERROR: unknown config parameter: HiSNR = 18 20:13:06 vdr[23255]: ERROR: unknown config parameter: HiSS = 180 20:13:06 vdr[23255]: ERROR: unknown config parameter: LiveAC3 = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: LoSNR = -1 20:13:06 vdr[23255]: ERROR: unknown config parameter: LoSS = 0 20:13:06 vdr[23255]: ERROR: unknown config parameter: Progressbar = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: RecordDolbyDigital = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: ShowTech = 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: Streaming = 1 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: Streaming = 2 2 20:13:06 vdr[23255]: ERROR: unknown config parameter: Streaming = 3 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: Streaming = 4 1 20:13:06 vdr[23255]: ERROR: unknown config parameter: StreamTTL = 2 20:13:06 vdr[23255]: ERROR: unknown config parameter: Symbol = 1 20:13:06 vdr[23255]: undelete: Setupparameter verbose=1 20:13:06 vdr[23255]: undelete: Setupparameter visible=1 20:13:06 vdr[23255]: loading /video0/sources.conf 20:13:06 vdr[23255]: loading /video0/diseqc.conf 20:13:06 vdr[23255]: loading /video0/channels.conf 20:13:06 vdr[23255]: loading /video0/timers.conf 20:13:06 vdr[23255]: loading /video0/commands.conf 20:13:06 vdr[23255]: loading /video0/reccmds.conf 20:13:07 vdr[23255]: loading /video0/svdrphosts.conf 20:13:07 vdr[23255]: loading /video0/ca.conf 20:13:07 vdr[23255]: loading /video0/remote.conf 20:13:07 vdr[23255]: loading /video0/keymacros.conf 20:13:07 vdr[23255]: reading EPG data from /video0/epg.data 20:13:07 vdr[23255]: probing /dev/dvb/adapter0/frontend0 20:13:07 vdr[23260]: tuner on device 1 thread started (pid=23260, tid=16386) 20:13:07 vdr[23261]: Section handler thread started (pid=23261, tid=32771) 20:13:07 vdr[23255]: probing /dev/dvb/adapter1/frontend0 20:13:07 vdr[23255]: found 1 video device 20:13:07 vdr[23255]: initializing plugin: osdteletext (0.5): Displays teletext on the OSD 20:13:07 vdr[23255]: initializing plugin: undelete (0.0.2): undelete for recordings 20:13:07 vdr[23255]: initializing plugin: femon (0.8.9): DVB Signal Information Monitor (OSD) 20:13:07 vdr[23255]: setting primary device to 1 20:13:07 vdr[23255]: device 1 has no MPEG decoder 20:13:07 vdr[23255]: SVDRP listening on port 2001 20:13:07 vdr[23255]: loading /video0/themes/sttng-default.theme 20:13:07 vdr[23255]: starting plugin: osdteletext 20:13:07 vdr[23255]: starting plugin: undelete 20:13:07 vdr[23255]: undelete: cPluginUndelete::Start undeleteconfigfile=undelete.conf 20:13:07 vdr[23255]: undelete: INFO: config file not found: [/video0/plugins/]undelete.conf 20:13:07 vdr[23255]: undelete: Start 20:13:07 vdr[23255]: undelete: commandline_preference = [ * ] yes 20:13:07 vdr[23255]: undelete: mainmenu_visible = [ r ] yes 20:13:07 vdr[23255]: undelete: mainmenu_name = [ * ] Undelete recordings 20:13:07 vdr[23255]: undelete: confirm undelete = [ * ] yes 20:13:07 vdr[23255]: undelete: confirm undelete directory = [ * ] yes 20:13:07 vdr[23255]: undelete: confirm delete = [ * ] yes 20:13:07 vdr[23255]: undelete: confirm delete directory = [ * ] yes 20:13:07 vdr[23255]: undelete: verbose = [ r ] yes 20:13:07 vdr[23255]: starting plugin: femon 20:13:07 vdr[23255]: loading /video0/themes/sttng-default.theme 20:13:07 lircd 0.7.0[1324]: accepted new client on /dev/lircd 20:13:07 vdr[23255]: remote control LIRC - keys known 20:13:07 vdr[23262]: LIRC remote control thread started (pid=23262, tid=49156) 20:13:07 vdr[23255]: switching to channel 6 20:13:07 vdr[23255]: info: Channel not available! 20:13:07 vdr[23255]: ERROR: no OSD provider available - using dummy OSD! 20:13:11 vdr[23255]: setting watchdog timer to 60 seconds 20:13:11 vdr[23255]: ERROR: no OSD provider available - using dummy OSD! 20:13:11 vdr[23255]: timer 14 (18 2015-2044 'Brncken dieser Erde') set to event Sat 21.05.2005 20:40-20:45 (VPS: 21.05 20:40) 'ARTE Meteo' 20:13:11 vdr[23255]: timer 15 (6 2229-2259 'Profile') set to event Sat 21.05.2005 22:30-23:00 (VPS: 21.05 22:30) 'Die Reportage' 20:13:11 vdr[23255]: timer 93 (11 2219-2323 'Frank Elstner: Menschen der Woche') set to event Sat 21.05.2005 22:20-23:30 (VPS: 21.05 22:20) 'Frank Elstner: Menschen der Woche' 20:13:11 vdr[23255]: timer 118 (18 2044-2143 'Evolution') set to event Sat 21.05.2005 20:45-21:40 (VPS: 21.05 20:45) 'Basilio und der Berg des Teufels' 20:13:17 vdr[23255]: max. latency time 1 seconds
20:15:00 vdr[23255]: no free DVB device to record channel 18!
I had to reboot the box.
Some time later a recording crashes:
20:24:08 vdr[1671]: timer 14 (18 2015-2044 'Brücken dieser Erde') start 20:24:08 vdr[1671]: record /video0/Brücken_dieser_Erde/_/2005-05-21.20:15.50.07.rec
20:42:18 kernel: av7110_send_fw_cmd error 20:42:18 kernel: av7110_fw_cmd error 20:42:19 kernel: av7110_send_fw_cmd error 20:42:19 kernel: av7110_fw_cmd error That clock was OK now.
Rainer---<=====> Vertraulich // // <=====>--------------ocholl, Kiel, Germany ------------
1.3.24 2.4.28 kernel 3 FF cards
The box again died. Similar to the log in the previous mail. Is that hard reaction really still required? I don't think that all card died.
A recording was running and a second should be started:
01:00 vdr[1666]: record /video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec 01:00 vdr[1666]: creating directory /video0/ARD-Ratgeber/_ 01:00 vdr[1666]: creating directory /video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec 01:00 vdr[1666]: recording to '/video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec/001.vdr' 01:00 vdr[1967]: file writer thread started (pid=1967, tid=213006) 01:00 vdr[1968]: recording thread started (pid=1968, tid=229391) 01:00 vdr[1969]: receiver on device 2 thread started (pid=1969, tid=245776) 01:00 vdr[1970]: TS buffer on device 2 thread started (pid=1970, tid=262161) 01:50 vdr[1671]: changing pids of channel 158 from 701+701:702:204 to 901+901:902:204 ... 25:52 vdr[1674]: changing pids of channel 158 from 701+701:702:204 to 901+901:902:204 26:51 vdr[1671]: changing pids of channel 158 from 901+901:902:204 to 701+701:702:204 27:52 vdr[1677]: changing pids of channel 158 from 701+701:702:204 to 901+901:902:204 28:50 vdr[1671]: changing pids of channel 158 from 901+901:902:204 to 701+701:702:204 29:00 vdr[1666]: switching device 3 to channel 3 29:00 vdr[1666]: timer 26 (3 1729-1800 'Teletipps vom Hausarzt') start 29:00 vdr[1666]: Title: 'Teletipps vom Hausarzt' Subtitle: '' 29:00 vdr[1666]: record /video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec 29:00 vdr[1666]: creating directory /video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec 29:00 vdr[1666]: recording to '/video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec/001.vdr' 29:01 vdr[4765]: file writer thread started (pid=4765, tid=278546) 29:01 vdr[4766]: recording thread started (pid=4766, tid=294931) 29:01 vdr[4767]: receiver on device 3 thread started (pid=4767, tid=311316) 29:01 vdr[4768]: TS buffer on device 3 thread started (pid=4768, tid=327701) 29:32 vdr[4765]: ERROR: video data stream broken 29:32 vdr[4765]: initiating emergency exit 29:32 vdr[1666]: emergency exit requested - shutting down 29:32 vdr[1666]: stopping plugin: femon 29:32 vdr[1666]: stopping plugin: undelete 29:32 vdr[1666]: stopping plugin: osdteletext 29:32 vdr[1968]: recording thread ended (pid=1968, tid=229391) 29:32 vdr[1970]: TS buffer on device 2 thread ended (pid=1970, tid=262161) 29:32 vdr[1969]: buffer stats: 109416 (5%) used 29:32 vdr[1969]: receiver on device 2 thread ended (pid=1969, tid=245776) 29:32 vdr[1967]: file writer thread ended (pid=1967, tid=213006) 29:32 vdr[1666]: buffer stats: 173336 (3%) used 29:32 vdr[1666]: timer 25 (1 1701-1731 'ARD-Ratgeber') stop 29:32 vdr[4766]: recording thread ended (pid=4766, tid=294931) 29:33 vdr[4768]: TS buffer on device 3 thread ended (pid=4768, tid=327701) 29:33 vdr[4767]: buffer stats: 20680 (0%) used 29:33 vdr[4767]: receiver on device 3 thread ended (pid=4767, tid=311316) 29:33 vdr[4765]: file writer thread ended (pid=4765, tid=278546) 29:33 vdr[1666]: cTS2PES got 1 TS errors, 2 TS continuity errors 29:33 vdr[1666]: buffer stats: 21056 (0%) used 29:33 vdr[1666]: timer 26 (3 1729-1800 'Teletipps vom Hausarzt') stop 29:33 lircd 0.7.0[1351]: removed client 29:33 vdr[1666]: saved setup to /video0/setup.conf 29:33 vdr[1670]: tuner on device 1 thread ended (pid=1670, tid=16386) 29:33 vdr[1688]: receiver on device 1 thread ended (pid=1688, tid=180236) 29:33 vdr[1671]: Section handler thread ended (pid=1671, tid=32771) 29:33 vdr[1673]: tuner on device 2 thread ended (pid=1673, tid=49156) 29:33 vdr[1674]: Section handler thread ended (pid=1674, tid=65541) 29:33 vdr[1676]: tuner on device 3 thread ended (pid=1676, tid=81926) 29:34 vdr[1677]: Section handler thread ended (pid=1677, tid=98311) ... 29:34 vdr[1666]: max. latency time 3 seconds 29:34 vdr[1666]: exiting 29:34 vdr[1666]: emergency exit! 29:34 logger[4818]: /root/video/VDR/runvdr restarting VDR 29:44 kernel: bt878(0): unloading 29:44 kernel: bt878_mem: 0xe1be1000. 29:44 kernel: i2c-core.o: driver unregistered: i2c TV tuner driver 29:44 kernel: bttv0: unloading 29:44 kernel: i2c-core.o: adapter unregistered: bt878 #0 [hw] 29:44 kernel: usb.c: deregistering driver ttusb-dec 29:44 kernel: usb.c: deregistering driver Technotrend/Hauppauge USB-Nova 29:44 kernel: saa7146: unregister extension 'dvb'. 29:50 kernel: bttv: driver version 0.9.15 loaded 29:50 kernel: bttv: using 8 buffers with 2080k (520 pages) each for capture 29:50 kernel: bttv: Bt8xx card found (0). 29:50 kernel: bttv0: Bt878 (rev 17) at 00:0a.0, irq: 10, latency: 64, mmio: 0xcfcfe000 29:50 kernel: bttv0: detected: AVermedia DVB-T 771 [card=121], PCI subsystem ID is 1461:0771 29:50 kernel: bttv0: using: AVerMedia AVerTV DVB-T 771 [card=121,autodetected] 29:50 kernel: bttv0: gpio: en=00000000, out=00000000 in=0090000f [init] 29:50 kernel: i2c-dev.o: Registered 'bt878 #0 [hw]' as minor 0 29:50 kernel: i2c-core.o: adapter bt878 #0 [hw] registered as adapter 0. 29:50 kernel: bttv0: using tuner=-1 29:50 kernel: bttv0: registered device video0 29:50 kernel: bttv0: registered device vbi0 29:50 kernel: bttv0: PLL: 28636363 => 35468950 . ok 29:50 kernel: i2c-core.o: driver i2c TV tuner driver registered. 29:50 kernel: bt878: AUDIO driver version 0.0.0 loaded 29:50 kernel: bt878: Bt878 AUDIO function found (0). 29:50 kernel: bt878(0): Bt878 (rev 17) at 00:0a.1, irq: 10, latency: 64, memory: 0xcfcff000 29:50 kernel: DVB: registering new adapter (Ave). 29:50 kernel: DVB: registering frontend 0:0 (DVB-T Zarlink MT352 demodulator driver)... 29:51 vdr[4877]: VDR version 1.3.24 started 29:51 vdr[4877]: loading plugin: ./PLUGINS/lib/libvdr-osdteletext.so.1.3.24 29:51 vdr[4877]: loading plugin: ./PLUGINS/lib/libvdr-undelete.so.1.3.24 29:51 vdr[4877]: Undelete: cPluginUndelete::cPluginUndelete 29:51 vdr[4877]: loading plugin: ./PLUGINS/lib/libvdr-femon.so.1.3.24 29:51 vdr[4877]: loading /video0/setup.conf 29:51 vdr[4877]: ERROR: unknown config parameter: AC3dynrng = 1 ... 29:51 vdr[4877]: undelete: Setupparameter verbose=1 29:51 vdr[4877]: undelete: Setupparameter visible=1 29:51 vdr[4877]: loading /video0/sources.conf 29:51 vdr[4877]: loading /video0/diseqc.conf 29:51 vdr[4877]: loading /video0/channels.conf 29:51 vdr[4877]: loading /video0/timers.conf 29:51 vdr[4877]: loading /video0/commands.conf 29:51 vdr[4877]: loading /video0/reccmds.conf 29:51 vdr[4877]: loading /video0/svdrphosts.conf 29:51 vdr[4877]: loading /video0/ca.conf 29:51 vdr[4877]: loading /video0/remote.conf 29:51 vdr[4877]: loading /video0/keymacros.conf 29:51 vdr[4877]: reading EPG data from /video0/epg.data 29:52 vdr[4877]: probing /dev/dvb/adapter0/frontend0 29:52 vdr[4881]: tuner on device 1 thread started (pid=4881, tid=16386) 29:52 vdr[4877]: probing /dev/dvb/adapter1/frontend0 29:52 vdr[4877]: found 1 video device 29:52 vdr[4877]: initializing plugin: osdteletext (0.5): Displays teletext on the OSD 29:52 vdr[4877]: initializing plugin: undelete (0.0.2): undelete for recordings 29:52 vdr[4877]: initializing plugin: femon (0.8.9): DVB Signal Information Monitor (OSD) 29:52 vdr[4877]: setting primary device to 1 29:52 vdr[4877]: device 1 has no MPEG decoder 29:52 vdr[4877]: SVDRP listening on port 2001 29:52 vdr[4877]: loading /video0/themes/sttng-default.theme 29:52 vdr[4877]: starting plugin: osdteletext 29:52 vdr[4877]: starting plugin: undelete 29:52 vdr[4877]: undelete: cPluginUndelete::Start undeleteconfigfile=undelete.conf 29:52 vdr[4877]: undelete: INFO: config file not found: [/video0/plugins/]undelete.conf 29:52 vdr[4882]: Section handler thread started (pid=4882, tid=32771) 29:52 vdr[4877]: undelete: Start 29:52 vdr[4877]: undelete: commandline_preference = [ * ] yes 29:52 vdr[4877]: undelete: mainmenu_visible = [ r ] yes 29:52 vdr[4877]: undelete: mainmenu_name = [ * ] Undelete recordings 29:52 vdr[4877]: undelete: confirm undelete = [ * ] yes 29:52 vdr[4877]: undelete: confirm undelete directory = [ * ] yes 29:52 vdr[4877]: undelete: confirm delete = [ * ] yes 29:52 vdr[4877]: undelete: confirm delete directory = [ * ] yes 29:52 vdr[4877]: undelete: verbose = [ r ] yes 29:52 vdr[4877]: starting plugin: femon 29:52 vdr[4877]: loading /video0/themes/sttng-default.theme 29:52 lircd 0.7.0[1351]: accepted new client on /dev/lircd 29:52 vdr[4883]: LIRC remote control thread started (pid=4883, tid=49156) 29:52 vdr[4877]: remote control LIRC - keys known 29:52 vdr[4877]: switching to channel 1 29:52 vdr[4877]: info: Channel not available! 29:52 vdr[4877]: ERROR: no OSD provider available - using dummy OSD! 29:54 vdr[4877]: setting watchdog timer to 60 seconds 29:54 vdr[4877]: ERROR: no OSD provider available - using dummy OSD! 29:54 vdr[4877]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') set to event Sun 22.05.2005 19:30-20:00 (VPS: 22.05 19:30) 'Schleswig-Holstein-Magazin' ... 29:54 vdr[4877]: no free DVB device to record channel 1! 29:57 vdr[4877]: switching to channel 111 29:57 vdr[4877]: info: Channel not available! 29:59 vdr[4877]: max. latency time 2 seconds 31:00 vdr[4877]: no free DVB device to record channel 3! 32:17 init: Switching to runlevel: 6
Rainer---<=====> Vertraulich // // <=====>--------------ocholl, Kiel, Germany ------------
Hi,
I have encountered similar behaviour. My setup is:
1.3.24 2.4.26 kernel linuxtv-dvb-1.1.1 Two TT DVB-C cards (one FF, one Budget)
May 22 19:59:00 play vdr[3538]: timer 9 (7 1959-2102 'Maison Bing ja Art Nouveau') start May 22 19:59:00 play vdr[3538]: record /video/Maison_Bing_ja_Art_Nouveau/2005-05-22.19:59.50.99.rec May 22 19:59:32 play vdr[3551]: ERROR: video data stream broken May 22 19:59:32 play vdr[3551]: initiating emergency exit
It is interesting to see, that I too have exactly 32 seconds between the timer start and "ERROR: video data stream broken". Is this a timer, or something?
There is some old discussion a similar issue on vdrportal http://www.vdrportal.de/board/thread.php?threadid=6700&page=2
From what I'm able to figure out with my not so good German langue skills,
people are "initializing" their tuners with czap prior loading vdr!?! Is there any sense in this?
Regards, Mika Lehtinen
1.3.24 2.4.28 kernel 3 FF cards
The box again died. Similar to the log in the previous mail. Is that hard reaction really still required? I don't think that all card died.
A recording was running and a second should be started:
01:00 vdr[1666]: record /video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec 01:00 vdr[1666]: creating directory /video0/ARD-Ratgeber/_ 01:00 vdr[1666]: creating directory
/video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec
01:00 vdr[1666]: recording to
'/video0/ARD-Ratgeber/_/2005-05-22.17:01.50.06.rec/001.vdr'
01:00 vdr[1967]: file writer thread started (pid=1967, tid=213006) 01:00 vdr[1968]: recording thread started (pid=1968, tid=229391) 01:00 vdr[1969]: receiver on device 2 thread started (pid=1969,
tid=245776)
01:00 vdr[1970]: TS buffer on device 2 thread started (pid=1970,
tid=262161)
01:50 vdr[1671]: changing pids of channel 158 from 701+701:702:204 to
901+901:902:204
... 25:52 vdr[1674]: changing pids of channel 158 from 701+701:702:204 to
901+901:902:204
26:51 vdr[1671]: changing pids of channel 158 from 901+901:902:204 to
701+701:702:204
27:52 vdr[1677]: changing pids of channel 158 from 701+701:702:204 to
901+901:902:204
28:50 vdr[1671]: changing pids of channel 158 from 901+901:902:204 to
701+701:702:204
29:00 vdr[1666]: switching device 3 to channel 3 29:00 vdr[1666]: timer 26 (3 1729-1800 'Teletipps vom Hausarzt') start 29:00 vdr[1666]: Title: 'Teletipps vom Hausarzt' Subtitle: '' 29:00 vdr[1666]: record
/video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec
29:00 vdr[1666]: creating directory
/video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec
29:00 vdr[1666]: recording to
'/video0/Teletipps_vom_Hausarzt/_/2005-05-22.17:29.50.15.rec/001.vdr'
29:01 vdr[4765]: file writer thread started (pid=4765, tid=278546) 29:01 vdr[4766]: recording thread started (pid=4766, tid=294931) 29:01 vdr[4767]: receiver on device 3 thread started (pid=4767,
tid=311316)
29:01 vdr[4768]: TS buffer on device 3 thread started (pid=4768,
tid=327701)
29:32 vdr[4765]: ERROR: video data stream broken 29:32 vdr[4765]: initiating emergency exit 29:32 vdr[1666]: emergency exit requested - shutting down 29:32 vdr[1666]: stopping plugin: femon 29:32 vdr[1666]: stopping plugin: undelete 29:32 vdr[1666]: stopping plugin: osdteletext 29:32 vdr[1968]: recording thread ended (pid=1968, tid=229391) 29:32 vdr[1970]: TS buffer on device 2 thread ended (pid=1970, tid=262161) 29:32 vdr[1969]: buffer stats: 109416 (5%) used 29:32 vdr[1969]: receiver on device 2 thread ended (pid=1969, tid=245776) 29:32 vdr[1967]: file writer thread ended (pid=1967, tid=213006) 29:32 vdr[1666]: buffer stats: 173336 (3%) used 29:32 vdr[1666]: timer 25 (1 1701-1731 'ARD-Ratgeber') stop 29:32 vdr[4766]: recording thread ended (pid=4766, tid=294931) 29:33 vdr[4768]: TS buffer on device 3 thread ended (pid=4768, tid=327701) 29:33 vdr[4767]: buffer stats: 20680 (0%) used 29:33 vdr[4767]: receiver on device 3 thread ended (pid=4767, tid=311316) 29:33 vdr[4765]: file writer thread ended (pid=4765, tid=278546) 29:33 vdr[1666]: cTS2PES got 1 TS errors, 2 TS continuity errors 29:33 vdr[1666]: buffer stats: 21056 (0%) used 29:33 vdr[1666]: timer 26 (3 1729-1800 'Teletipps vom Hausarzt') stop 29:33 lircd 0.7.0[1351]: removed client 29:33 vdr[1666]: saved setup to /video0/setup.conf 29:33 vdr[1670]: tuner on device 1 thread ended (pid=1670, tid=16386) 29:33 vdr[1688]: receiver on device 1 thread ended (pid=1688, tid=180236) 29:33 vdr[1671]: Section handler thread ended (pid=1671, tid=32771) 29:33 vdr[1673]: tuner on device 2 thread ended (pid=1673, tid=49156) 29:33 vdr[1674]: Section handler thread ended (pid=1674, tid=65541) 29:33 vdr[1676]: tuner on device 3 thread ended (pid=1676, tid=81926) 29:34 vdr[1677]: Section handler thread ended (pid=1677, tid=98311) ... 29:34 vdr[1666]: max. latency time 3 seconds 29:34 vdr[1666]: exiting 29:34 vdr[1666]: emergency exit! 29:34 logger[4818]: /root/video/VDR/runvdr restarting VDR 29:44 kernel: bt878(0): unloading 29:44 kernel: bt878_mem: 0xe1be1000. 29:44 kernel: i2c-core.o: driver unregistered: i2c TV tuner driver 29:44 kernel: bttv0: unloading 29:44 kernel: i2c-core.o: adapter unregistered: bt878 #0 [hw] 29:44 kernel: usb.c: deregistering driver ttusb-dec 29:44 kernel: usb.c: deregistering driver Technotrend/Hauppauge USB-Nova 29:44 kernel: saa7146: unregister extension 'dvb'. 29:50 kernel: bttv: driver version 0.9.15 loaded 29:50 kernel: bttv: using 8 buffers with 2080k (520 pages) each for
capture
29:50 kernel: bttv: Bt8xx card found (0). 29:50 kernel: bttv0: Bt878 (rev 17) at 00:0a.0, irq: 10, latency: 64,
mmio: 0xcfcfe000
29:50 kernel: bttv0: detected: AVermedia DVB-T 771 [card=121], PCI
subsystem ID is 1461:0771
29:50 kernel: bttv0: using: AVerMedia AVerTV DVB-T 771
[card=121,autodetected]
29:50 kernel: bttv0: gpio: en=00000000, out=00000000 in=0090000f [init] 29:50 kernel: i2c-dev.o: Registered 'bt878 #0 [hw]' as minor 0 29:50 kernel: i2c-core.o: adapter bt878 #0 [hw] registered as adapter 0. 29:50 kernel: bttv0: using tuner=-1 29:50 kernel: bttv0: registered device video0 29:50 kernel: bttv0: registered device vbi0 29:50 kernel: bttv0: PLL: 28636363 => 35468950 . ok 29:50 kernel: i2c-core.o: driver i2c TV tuner driver registered. 29:50 kernel: bt878: AUDIO driver version 0.0.0 loaded 29:50 kernel: bt878: Bt878 AUDIO function found (0). 29:50 kernel: bt878(0): Bt878 (rev 17) at 00:0a.1, irq: 10, latency: 64,
memory: 0xcfcff000
29:50 kernel: DVB: registering new adapter (Ave). 29:50 kernel: DVB: registering frontend 0:0 (DVB-T Zarlink MT352
demodulator driver)...
29:51 vdr[4877]: VDR version 1.3.24 started 29:51 vdr[4877]: loading plugin:
./PLUGINS/lib/libvdr-osdteletext.so.1.3.24
29:51 vdr[4877]: loading plugin: ./PLUGINS/lib/libvdr-undelete.so.1.3.24 29:51 vdr[4877]: Undelete: cPluginUndelete::cPluginUndelete 29:51 vdr[4877]: loading plugin: ./PLUGINS/lib/libvdr-femon.so.1.3.24 29:51 vdr[4877]: loading /video0/setup.conf 29:51 vdr[4877]: ERROR: unknown config parameter: AC3dynrng = 1 ... 29:51 vdr[4877]: undelete: Setupparameter verbose=1 29:51 vdr[4877]: undelete: Setupparameter visible=1 29:51 vdr[4877]: loading /video0/sources.conf 29:51 vdr[4877]: loading /video0/diseqc.conf 29:51 vdr[4877]: loading /video0/channels.conf 29:51 vdr[4877]: loading /video0/timers.conf 29:51 vdr[4877]: loading /video0/commands.conf 29:51 vdr[4877]: loading /video0/reccmds.conf 29:51 vdr[4877]: loading /video0/svdrphosts.conf 29:51 vdr[4877]: loading /video0/ca.conf 29:51 vdr[4877]: loading /video0/remote.conf 29:51 vdr[4877]: loading /video0/keymacros.conf 29:51 vdr[4877]: reading EPG data from /video0/epg.data 29:52 vdr[4877]: probing /dev/dvb/adapter0/frontend0 29:52 vdr[4881]: tuner on device 1 thread started (pid=4881, tid=16386) 29:52 vdr[4877]: probing /dev/dvb/adapter1/frontend0 29:52 vdr[4877]: found 1 video device 29:52 vdr[4877]: initializing plugin: osdteletext (0.5): Displays teletext
on the OSD
29:52 vdr[4877]: initializing plugin: undelete (0.0.2): undelete for
recordings
29:52 vdr[4877]: initializing plugin: femon (0.8.9): DVB Signal
Information Monitor (OSD)
29:52 vdr[4877]: setting primary device to 1 29:52 vdr[4877]: device 1 has no MPEG decoder 29:52 vdr[4877]: SVDRP listening on port 2001 29:52 vdr[4877]: loading /video0/themes/sttng-default.theme 29:52 vdr[4877]: starting plugin: osdteletext 29:52 vdr[4877]: starting plugin: undelete 29:52 vdr[4877]: undelete: cPluginUndelete::Start
undeleteconfigfile=undelete.conf
29:52 vdr[4877]: undelete: INFO: config file not found:
[/video0/plugins/]undelete.conf
29:52 vdr[4882]: Section handler thread started (pid=4882, tid=32771) 29:52 vdr[4877]: undelete: Start 29:52 vdr[4877]: undelete: commandline_preference = [ * ] yes 29:52 vdr[4877]: undelete: mainmenu_visible = [ r ] yes 29:52 vdr[4877]: undelete: mainmenu_name = [ * ] Undelete
recordings
29:52 vdr[4877]: undelete: confirm undelete = [ * ] yes 29:52 vdr[4877]: undelete: confirm undelete directory = [ * ] yes 29:52 vdr[4877]: undelete: confirm delete = [ * ] yes 29:52 vdr[4877]: undelete: confirm delete directory = [ * ] yes 29:52 vdr[4877]: undelete: verbose = [ r ] yes 29:52 vdr[4877]: starting plugin: femon 29:52 vdr[4877]: loading /video0/themes/sttng-default.theme 29:52 lircd 0.7.0[1351]: accepted new client on /dev/lircd 29:52 vdr[4883]: LIRC remote control thread started (pid=4883, tid=49156) 29:52 vdr[4877]: remote control LIRC - keys known 29:52 vdr[4877]: switching to channel 1 29:52 vdr[4877]: info: Channel not available! 29:52 vdr[4877]: ERROR: no OSD provider available - using dummy OSD! 29:54 vdr[4877]: setting watchdog timer to 60 seconds 29:54 vdr[4877]: ERROR: no OSD provider available - using dummy OSD! 29:54 vdr[4877]: timer 13 (5 1929-1959 'Schleswig-Holstein-Magazin') set
to event Sun 22.05.2005 19:30-20:00 (VPS: 22.05 19:30) 'Schleswig-Holstein-Magazin'
... 29:54 vdr[4877]: no free DVB device to record channel 1! 29:57 vdr[4877]: switching to channel 111 29:57 vdr[4877]: info: Channel not available! 29:59 vdr[4877]: max. latency time 2 seconds 31:00 vdr[4877]: no free DVB device to record channel 3! 32:17 init: Switching to runlevel: 6
Rainer---<=====> Vertraulich // // <=====>--------------ocholl, Kiel, Germany ------------
vdr mailing list vdr@linuxtv.org http://www.linuxtv.org/cgi-bin/mailman/listinfo/vdr
Mika Lehtinen wrote:
Hi,
I have encountered similar behaviour. My setup is:
1.3.24 2.4.26 kernel linuxtv-dvb-1.1.1 Two TT DVB-C cards (one FF, one Budget)
May 22 19:59:00 play vdr[3538]: timer 9 (7 1959-2102 'Maison Bing ja Art Nouveau') start May 22 19:59:00 play vdr[3538]: record /video/Maison_Bing_ja_Art_Nouveau/2005-05-22.19:59.50.99.rec May 22 19:59:32 play vdr[3551]: ERROR: video data stream broken May 22 19:59:32 play vdr[3551]: initiating emergency exit
It is interesting to see, that I too have exactly 32 seconds between the timer start and "ERROR: video data stream broken". Is this a timer, or something?
Do you have NPTL enabled? I have the same problem if I enable NPTL. NPTL works fine, except, after vdr has been running for a few hours, and a timer goes off, thats what causes the VDSB. It seems that NPTL and timers dont work well with eachother.
Best Regards,
----- Original Message ----- From: "C.Y.M" syphyr@gmail.com To: "Klaus Schmidinger's VDR" vdr@linuxtv.org Sent: Sunday, May 22, 2005 11:05 PM Subject: [vdr] Re: 1.3.24 dying on second recording start
Do you have NPTL enabled? I have the same problem if I enable NPTL. NPTL
works
fine, except, after vdr has been running for a few hours, and a timer goes
off,
thats what causes the VDSB. It seems that NPTL and timers dont work well
with
eachother.
Best Regards,
Hi,
Err.. I think, not. I do have VDR running on a Fedoa Core 1 system, but with a stock kernel, and not a RH one. I thought NPTL was something, that RH backported to their own kernel releases. Is this the case, or is NPTL present in the "vanilla" 2.4.26 kernel too? Should I set the LD_ASSUME_KERNEL=2.4.1 environment variable?
Thanks, Mika Lehtinen
Mika Lehtinen wrote:
----- Original Message ----- From: "C.Y.M" syphyr@gmail.com To: "Klaus Schmidinger's VDR" vdr@linuxtv.org Sent: Sunday, May 22, 2005 11:05 PM Subject: [vdr] Re: 1.3.24 dying on second recording start
Do you have NPTL enabled? I have the same problem if I enable NPTL. NPTL
works
fine, except, after vdr has been running for a few hours, and a timer goes
off,
thats what causes the VDSB. It seems that NPTL and timers dont work well
with
eachother.
Best Regards,
Hi,
Err.. I think, not. I do have VDR running on a Fedoa Core 1 system, but with a stock kernel, and not a RH one. I thought NPTL was something, that RH backported to their own kernel releases. Is this the case, or is NPTL present in the "vanilla" 2.4.26 kernel too? Should I set the LD_ASSUME_KERNEL=2.4.1 environment variable?
I thought that NPTL support is contained within glibc, not the kernel. Maybe I'm wrong.
Best Regards,
Hi,
I guess, NPTL needs both kernel and library support to work and hope that using a vanilla kernel with FC1 glibc does not fundamentaly break things. By saying "guess" and "hope" you can see, I'm on thin ice here.
I've been running a vdr system for a about a year now. Previously vdr-1.3.12 with a TT Budget card and DXR3. I recently installed a FF card to replace the DXR3 and almost simultaniously upgraded from vdr-1.3.12 to vdr-1.3.24. As usual, doing two major upgrades at the same time has a tendency to backfire;) It is now pretty difficult to determine, is the source of the VDSB issue related to the vdr upgrade, or the two-tuner setup. What I do know is, that it did not exist in the old setup.
Regards, Mika
On 5/23/05, C.Y.M syphyr@gmail.com wrote:
I thought that NPTL support is contained within glibc, not the kernel. Maybe I'm wrong.
Best Regards,
vdr mailing list vdr@linuxtv.org http://www.linuxtv.org/cgi-bin/mailman/listinfo/vdr
syphyr@gmail.com(C.Y.M) 22.05.05 13:05
Mika Lehtinen wrote:
Hi,
I have encountered similar behaviour. My setup is:
1.3.24 2.4.26 kernel linuxtv-dvb-1.1.1 Two TT DVB-C cards (one FF, one Budget)
May 22 19:59:00 play vdr[3538]: timer 9 (7 1959-2102 'Maison Bing ja Art Nouveau') start May 22 19:59:00 play vdr[3538]: record /video/Maison_Bing_ja_Art_Nouveau/2005-05-22.19:59.50.99.rec May 22 19:59:32 play vdr[3551]: ERROR: video data stream broken May 22 19:59:32 play vdr[3551]: initiating emergency exit
It is interesting to see, that I too have exactly 32 seconds between the timer start and "ERROR: video data stream broken". Is this a timer, or something?
Do you have NPTL enabled?
I don't know, but that's no issue for 2.4. kernels IIRC. (We had that discussing 4 month back ("thread save/safe")
Doesn't VDR really not drop a line into syslog if it is running under NPTL or not? That seems to be very very important to know.
I have the same problem if I enable NPTL. NPTL works fine, except, after vdr has been running for a few hours, and a timer goes off, thats what causes the VDSB. It seems that NPTL and timers dont work well with eachother.
I had run 1.3.18 for month without any such problems. I only changed the VDR binary, nothing else. (I copied "my" runvdr) OK, i upgraded OSD-teletext to 0.5, but i assume taht should not matter.
The "responsiveness" of VDR to LIRC keys is signifcantly better, but sometimes it still hangs. (I'll note when).
Rainer Zocholl wrote:
syphyr@gmail.com(C.Y.M) 22.05.05 13:05
Mika Lehtinen wrote:
Hi,
I have encountered similar behaviour. My setup is:
1.3.24 2.4.26 kernel linuxtv-dvb-1.1.1 Two TT DVB-C cards (one FF, one Budget)
May 22 19:59:00 play vdr[3538]: timer 9 (7 1959-2102 'Maison Bing ja Art Nouveau') start May 22 19:59:00 play vdr[3538]: record /video/Maison_Bing_ja_Art_Nouveau/2005-05-22.19:59.50.99.rec May 22 19:59:32 play vdr[3551]: ERROR: video data stream broken May 22 19:59:32 play vdr[3551]: initiating emergency exit
It is interesting to see, that I too have exactly 32 seconds between the timer start and "ERROR: video data stream broken". Is this a timer, or something?
Do you have NPTL enabled?
I don't know, but that's no issue for 2.4. kernels IIRC. (We had that discussing 4 month back ("thread save/safe")
Whoops, I did not read close enough to notice you are running a 2.4 kernel.. sorry.
Doesn't VDR really not drop a line into syslog if it is running under NPTL or not? That seems to be very very important to know.
Yes, VDR will notify you and not even start if it detects NPTL. I just assumed that the NPTL check was disabled was being tested for some reason. :)
Best Regards, C.Y.M.
Hi,
This "1.3.24 dying on second recording start" -like issue seems to persist. I have not been able to reproduce it in a controlled manner. I have noticed some patterns however.
-The reason for the dying from vdr point of view is "ERROR: video data stream broken" -Unloadind and reloading the DVB drivers does not restore the system in functional state -The situation happens more propably when VDR has been running for a long time than when when it has been running for a short time -A typical case triggering the situation: A timer starts in the background on another mux, than the one of currently viewed channel
This lead me into the following speculation (I'm not at all deeply familliar with the details of vdr architecture). Anyway, it would be great if someone who knows better could comment if the following scenario might be the source of the problem in a two tuner setup with one budget and one FF card?
1. vdr starts
2. First recording starts on the budget card. (HISTORY file for 1.3.24 says "Now preferring budget cards when selecting a DVB device for recording")
3. If the current viewed channel is on the same mux as the channel being recorded, the FF card becomes "idle" and available to be used to perform background tasks, like EPG scanning and scanning for new and changed channels.
4. The FF cards tuner comes accross a HDTV feed while scanning for channel updates, causing some part of the card to crash or halt. (could this be?)
5. A timer starts a second recording, on the "idle" FF card's tuner.
6. The tuner is alive and locks to a channel, but some part of the FF card is not functioning and does not deliver data to the dvb driver and vdr
7. 30 seconds after the start of the second recording vdr throws in the towel, a "ERROR: video data stream broken" message and triggers an emergency exit.
Am I totally in the woods here? I know, the the cable TV provider in Helsinki (HTV) has done some HDTV pilots in the past, but don't know if there is a feed present at the moment. Does someone in the Helsiki area have better knowlege? Also I don't know if the above behaviour of a FF card when tuning to a HDTV channel is possible in this case, when the stream being decoded by the card is not coming directly from it's local tuner, but from the budget card's tuner via vdr.
Any comments?
I guess I have to try to do some systematic testing when I have the time and can agree on a suitable vdr mainanance window with my girlfriend;)
Regards, Mika
hi,
This "1.3.24 dying on second recording start" -like issue seems to persist. I have not been able to reproduce it in a controlled manner. I have noticed some patterns however.
This sounds like a problem in the older versions of DVB drivers that I also had. You could try updating drivers to the ones that are at least from Feb this year.
yours, Jouni
-
Anssi Hannula -
C.Y.M -
Jouni Karvo -
Mika Lehtinen -
Rainer Zocholl