Hi
I'm start to test my system - dvb-s2 card hvr4000 (with latest multiproto_plus + hvr4000 patch from Gregoire Favre) + VDR 1.7.0 + xine-plugin 0.8.2 + xine-lib-1.2 from HG + xine-ui from CVS + ffmpeg from SVN (I didn't test dvb-s2 yet, but it seems to me - the dvb-s works well)
But if I disconnect from the card the antenna I will have this problem
goga@goga:/usr/src/VDR$ ./vdr -c /etc/vdr -P "xine -r" ------------------------- MakePrimaryDevice: 1 ========================= SetVideoFormat: 0 SetVolumeDevice: 255 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetVolumeDevice: 255 SetPlayMode: 1 frame: (0, 0)-(-1, -1), zoom: (1.00, 1.00) vdr-xine: Client connecting ... vdr-xine: Client connected! frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) video: synced early [VMA]buffered 8.2 frames (v:20.1, a:8.2) buffered 9.5 frames (v:18.8, a:9.5) SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 [vVMA]buffered 8.5 frames (v:14.8, a:8.5) buffered 6.6 frames (v:15.3, a:6.6) <<<<< frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) audio: synced early [AMvV]buffered 12.2 frames (v:20.9, a:12.2) SetPlayMode: 0 frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0
=========skipped============
frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 SetPlayMode: 0 SetAudioChannelDevice: 0 SetDigitalAudioDevice: 0 SetAudioChannelDevice: 0 SetPlayMode: 1 frame: (0, 0)-(720, 576), zoom: (1.00, 1.00) vdr-xine: Client disconnected! #!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!1 SetPlayMode: 0 goga@goga:/usr/src/VDR$
let's see in the xine output
input_cache: read calls: 0, main input read calls: 0 input_cache: seek_calls: 0, main input seek calls: 0 input_vdr: shutting down rpc thread (timeout: 10000 ms) ... input_vdr: joining rpc thread ... input_vdr: rpc thread joined. xine: found input plugin : file input plugin load_plugins: probing demux 'anx' load_plugins: probing demux 'image' load_plugins: probing demux 'wve' load_plugins: probing demux 'idcin' load_plugins: probing demux 'ipmovie' load_plugins: probing demux 'vqa' load_plugins: probing demux 'wc3movie' load_plugins: probing demux 'roq' load_plugins: probing demux 'str' load_plugins: probing demux 'film' load_plugins: probing demux 'smjpeg' load_plugins: probing demux 'fourxm' load_plugins: probing demux 'vmd' load_plugins: probing demux 'aiff' load_plugins: probing demux 'flac' load_plugins: probing demux 'realaudio' load_plugins: probing demux 'snd' load_plugins: probing demux 'tta' load_plugins: probing demux 'voc' load_plugins: probing demux 'vox' load_plugins: probing demux 'mpeg-ts' load_plugins: probing demux 'avi' load_plugins: probing demux 'mpeg_block' load_plugins: probing demux 'mpeg_pes' load_plugins: probing demux 'quicktime' load_plugins: probing demux 'fli' load_plugins: probing demux 'yuv4mpeg2' load_plugins: probing demux 'real' load_plugins: probing demux 'pva' load_plugins: probing demux 'slave' load_plugins: probing demux 'nsv' load_plugins: probing demux 'matroska' ebml: invalid EBML ID size (0x0) at position 1 ebml: invalid master element load_plugins: probing demux 'iff' load_plugins: probing demux 'flashvideo' load_plugins: probing demux 'playlist' load_plugins: probing demux 'nsfdemux' load_plugins: probing demux 'ogg' load_plugins: probing demux 'asf' load_plugins: probing demux 'mpeg' load_plugins: probing demux 'dts' demux_dts: unsupported DTS stream type, or not a DTS stream load_plugins: probing demux 'ac3' load_plugins: probing demux 'wav' load_plugins: probing demux 'cdda' load_plugins: probing demux 'rawdv' load_plugins: probing demux 'mpc' load_plugins: probing demux 'mp3' load_plugins: probing demux 'shn' load_plugins: probing demux 'elem' xine: found demuxer plugin: Elementary MPEG stream demux plugin load_plugins: plugin mpeg2 will be used for video streamtype 00. av_offset=0 pts spu_offset=0 pts xine_play play_internal ...done video_out: throwing away image with pts 96108366 because it's too old (diff : 434402). video_out: throwing away image with pts 96111366 because it's too old (diff : 431402). video_out: throwing away image with pts 96114366 because it's too old (diff : 428402). video_out: throwing away image with pts 96117366 because it's too old (diff : 425402). video_out: throwing away image with pts 96120366 because it's too old (diff : 422402). video_out: throwing away image with pts 96123366 because it's too old (diff : 419402). video_out: throwing away image with pts 96126366 because it's too old (diff : 416402). video_out: throwing away image with pts 96129366 because it's too old (diff : 413402). video_out: throwing away image with pts 96132366 because it's too old (diff : 410402). video_out: throwing away image with pts 96135366 because it's too old (diff : 407402). video_out: throwing away image with pts 96138366 because it's too old (diff : 404402). video_out: throwing away image with pts 96141366 because it's too old (diff : 401531). video_out: throwing away image with pts 96144366 because it's too old (diff : 398630). video_out: throwing away image with pts 96147366 because it's too old (diff : 395630).
Let's see in the syslog (after anteenna's disconnecting)
Apr 27 13:21:41 localhost vdr: [4997] switching to channel 79 Apr 27 13:21:41 localhost vdr: [5515] transfer thread ended (pid=4997, tid=5515) Apr 27 13:21:41 localhost vdr: [4997] buffer stats: 0 (0%) used Apr 27 13:21:41 localhost vdr: [5519] transfer thread started (pid=4997, tid=5519) Apr 27 13:21:41 localhost vdr: [4997] switching to channel 78 Apr 27 13:21:41 localhost vdr: [5519] transfer thread ended (pid=4997, tid=5519) Apr 27 13:21:41 localhost vdr: [4997] buffer stats: 0 (0%) used Apr 27 13:21:41 localhost vdr: [5520] transfer thread started (pid=4997, tid=5520) Apr 27 13:21:42 localhost vdr: [4997] switching to channel 77 Apr 27 13:21:42 localhost vdr: [5520] transfer thread ended (pid=4997, tid=5520) Apr 27 13:21:42 localhost vdr: [4997] buffer stats: 0 (0%) used Apr 27 13:21:42 localhost vdr: [5521] transfer thread started (pid=4997, tid=5521) Apr 27 13:21:42 localhost vdr: [4997] switching to channel 76 Apr 27 13:21:42 localhost vdr: [5521] transfer thread ended (pid=4997, tid=5521) Apr 27 13:21:42 localhost vdr: [4997] buffer stats: 0 (0%) used Apr 27 13:21:42 localhost vdr: [5522] transfer thread started (pid=4997, tid=5522) Apr 27 13:21:47 localhost vdr: [5466] ERROR: video data stream broken Apr 27 13:21:47 localhost vdr: [5466] initiating emergency exit Apr 27 13:21:47 localhost vdr: [4997] emergency exit requested - shutting down Apr 27 13:21:47 localhost vdr: [4997] stopping plugin: xine Apr 27 13:21:47 localhost vdr: [5467] recording thread ended (pid=4997, tid=5467) Apr 27 13:21:47 localhost vdr: [5466] file writer thread ended (pid=4997, tid=5466) Apr 27 13:21:47 localhost vdr: [4997] cTS2PES got 0 TS errors, 2 TS continuity errors Apr 27 13:21:47 localhost vdr: [4997] cTS2PES got 0 TS errors, 1 TS continuity errors Apr 27 13:21:47 localhost vdr: [4997] buffer stats: 97196 (1%) used Apr 27 13:21:47 localhost vdr: [4997] timer 1 (88 1318-1618 '@Das gemütliche Schlafzimmer') stop Apr 27 13:21:47 localhost vdr: [5522] transfer thread ended (pid=4997, tid=5522) Apr 27 13:21:48 localhost vdr: [4997] buffer stats: 0 (0%) used Apr 27 13:21:48 localhost vdr: [5003] Leaving cXineRemote thread Apr 27 13:21:48 localhost vdr: [5003] XineRemote control thread ended (pid=4997, tid=5003) Apr 27 13:21:48 localhost vdr: [5006] KBD remote control thread ended (pid=4997, tid=5006) Apr 27 13:21:48 localhost vdr: [4997] saved setup to /etc/vdr/setup.conf Apr 27 13:21:48 localhost vdr: [5002] section handler thread ended (pid=4997, tid=5002) Apr 27 13:21:48 localhost vdr: [5468] TS buffer on device 1 thread ended (pid=4997, tid=5468) Apr 27 13:21:48 localhost vdr: [5465] buffer stats: 66364 (3%) used Apr 27 13:21:48 localhost vdr: [5465] receiver on device 1 thread ended (pid=4997, tid=5465) Apr 27 13:21:51 localhost vdr: [4997] ERROR: tuner on device 1 thread 5001 won't end (waited 3 seconds) - canceling it... Apr 27 13:21:51 localhost vdr: [4997] deleting plugin: xine
Apr 27 13:21:51 localhost vdr: [4997] ===================== Apr 27 13:21:51 localhost vdr: [4997] EPG bugfix statistics Apr 27 13:21:51 localhost vdr: [4997] ===================== Apr 27 13:21:51 localhost vdr: [4997] IF SOMEBODY WHO IS IN CHARGE OF THE EPG DATA FOR ONE OF THE LISTED Apr 27 13:21:51 localhost vdr: [4997] CHANNELS READS THIS: PLEASE TAKE A LOOK AT THE FUNCTIONcEvent::FixEpgBugs() Apr 27 13:21:51 localhost vdr: [4997] IN VDR/epg.c TO LEARN WHAT'S WRONG WITH YOUR DATA, AND FIX IT! Apr 27 13:21:51 localhost vdr: [4997] ===================== Apr 27 13:21:51 localhost vdr: [4997]Fix^IHits^IChannels Apr 27 13:21:51 localhost vdr: [4997] 1^I22^IRTL Tele Letzebuerg, TV5MONDE EUROPE,TV5MONDE, RAI 1, RTPI Apr 27 13:21:51 localhost vdr: [4997] 3^I1437^ISAT.1, ProSieben, kabel eins, N24,9Live, DW 1, DASDING, SWR4 RP, Dok&Deb,DS Apr 27 13:21:51 localhost vdr: [4997] 4^I10^ISWR Fernsehen BW,SR Fernsehen, ZDFtheaterkanal, SWR2, SWR2,SWR FernsehenRP, Apr 27 13:21:51 localhost vdr: [4997]6^I1992^IBayerisches FS Süd, BR-alpha*, 3sat, NDR FS MV,hr-fernsehen, Das Erste,WDR Apr 27 13:21:51localhost vdr: [4997] 7^I60^IKiKa, alt (MDR FERNSEHEN), rbb Berlin, rbb Brandenburg, LACHAINEMETEO,PARIS Apr 27 13:21:51 localhost vdr: [4997] 8^I1863^ISAT.1, ProSieben, kabel eins, N24, 9Live, Sat.1Comedy,kabeleins classics, Apr 27 13:21:51 localhost vdr: [4997] 9^I2204^ISAT.1, ProSieben, kabel eins,N24, 9Live, Sat.1 Comedy,kabeleins classics, Apr 27 13:21:51 localhost vdr: [4997] 10^I164^IHSE24,1-2-3.tv, Sonnenklar TV, FRANCE 5, Cartoon Network,LCP, CNN Int., EUR Apr 27 13:21:51 localhost vdr:[4997] 11^I505^IHSE24, 1-2-3.tv, Sonnenklar TV, BVN, Bloomberg TVGermany, FRANCE 5, RTL Tele Apr 2713:21:51 localhost vdr: [4997] ===================== Apr 27 13:21:51 localhost vdr: [4997] exiting, exitcode 1 Apr 27 13:21:51 localhost vdr: [4997] emergency exit!
If I will start vdr with disconnected antenna I will have the same problem
Apr 27 13:37:31 localhost vdr: [5732] cTimeMs: using monotonic clock (resolution is 1 ns) Apr 27 13:37:31 localhost vdr: [5732] VDR version 1.7.0 started Apr 27 13:37:31 localhost vdr: [5732] codeset is 'UTF-8' - known Apr 27 13:37:31 localhost vdr: [5732] found 23 locales in ./locale Apr 27 13:37:31 localhost vdr: [5732] loading plugin: ./PLUGINS/lib/libvdr-xine.so.1.7.0 Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/setup.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/sources.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/diseqc.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/channels.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/timers.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/svdrphosts.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/remote.conf Apr 27 13:37:31 localhost vdr: [5732] loading /etc/vdr/keymacros.conf Apr 27 13:37:31 localhost vdr: [5732] reading EPG data from /video/epg.data Apr 27 13:37:31 localhost vdr: [5734] video directory scanner thread started (pid=5732, tid=5734) Apr 27 13:37:31 localhost vdr: [5733] video directory scanner thread started (pid=5732, tid=5733) Apr 27 13:37:31 localhost vdr: [5734] video directory scanner thread ended (pid=5732, tid=5734) Apr 27 13:37:31 localhost vdr: [5733] video directory scanner thread ended (pid=5732, tid=5733) Apr 27 13:37:32 localhost vdr: [5732] probing /dev/dvb/adapter0/frontend0 Apr 27 13:37:32 localhost vdr: [5732] device 1 provides: DVBS DVBS2 Apr 27 13:37:32 localhost vdr: [5732] found 1 video device Apr 27 13:37:32 localhost vdr: [5732] initializing plugin: xine (0.8.2): Software based playback using xine Apr 27 13:37:32 localhost vdr: [5732] setting primary device to 2 Apr 27 13:37:32 localhost vdr: [5732] assuming manual start of VDR Apr 27 13:37:32 localhost vdr: [5732] SVDRP listening on port 2001 Apr 27 13:37:32 localhost vdr: [5732] setting current skin to "sttng" Apr 27 13:37:32 localhost vdr: [5732] loading /etc/vdr/themes/sttng-default.theme Apr 27 13:37:32 localhost vdr: [5732] starting plugin: xine Apr 27 13:37:32 localhost vdr: [5736] tuner on device 1 thread started (pid=5732, tid=5736) Apr 27 13:37:32 localhost vdr: [5737] section handler thread started (pid=5732, tid=5737) Apr 27 13:37:32 localhost vdr: [5738] XineRemote control thread started (pid=5732, tid=5738) Apr 27 13:37:32 localhost vdr: [5738] Entering cXineRemote thread Apr 27 13:37:32 localhost vdr: [5732] ERROR: remote control XineRemote not ready! Apr 27 13:37:32 localhost vdr: [5732] remote control KBD - keys known Apr 27 13:37:32 localhost vdr: [5732] switching to channel 76 Apr 27 13:37:32 localhost vdr: [5741] KBD remote control thread started (pid=5732, tid=5741) Apr 27 13:37:32 localhost vdr: [5743] transfer thread started (pid=5732, tid=5743) Apr 27 13:37:32 localhost vdr: [5744] receiver on device 1 thread started (pid=5732, tid=5744) Apr 27 13:37:32 localhost vdr: [5745] TS buffer on device 1 thread started (pid=5732, tid=5745) Apr 27 13:37:32 localhost vdr: [5732] timer 1 (88 1318-1618 '@Das gemütliche Schlafzimmer') set to event Sun 27.04.2008 14:0 Apr 27 13:37:32 localhost vdr: [5732] switching device 1 to channel 88 Apr 27 13:37:32 localhost vdr: [5732] timer 1 (88 1318-1618 '@Das gemütliche Schlafzimmer') start Apr 27 13:37:32 localhost vdr: [5732] Title: 'Das gemütliche Schlafzimmer' Subtitle: '(null)' Apr 27 13:37:32 localhost vdr: [5732] record /video/@Das_gemütliche_Schlafzimmer/2008-04-27.13.18.50.99.rec Apr 27 13:37:32 localhost vdr: [5732] recording to'/video/@Das_gemütliche_Schlafzimmer/2008-04-27.13.18.50.99.rec/003.vdr' Apr 27 13:37:32 localhost vdr:[5746] file writer thread started (pid=5732, tid=5746) Apr 27 13:37:32 localhost vdr: [5747] recordingthread started (pid=5732, tid=5747) Apr 27 13:37:32 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE:fepriv->state=2 Apr 27 13:37:42 localhost vdr: [5736] frontend 0 timed out while tuning to channel 88, tp212551 Apr 27 13:37:42 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 2713:37:52 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 27 13:38:03 localhost vdr: [5746] ERROR: video data stream broken Apr 27 13:38:03 localhost vdr:[5746] initiating emergency exit Apr 27 13:38:03 localhost vdr: [5732] emergency exit requested - shuttingdown Apr 27 13:38:03 localhost vdr: [5732] stopping plugin: xine Apr 27 13:38:03 localhost vdr: [5747] recording thread ended (pid=5732, tid=5747) Apr 27 13:38:03 localhost vdr: [5746] file writer thread ended (pid=5732, tid=5746) Apr 27 13:38:03 localhost vdr: [5732] buffer stats: 0 (0%) used Apr 27 13:38:03 localhost vdr: [5732] timer 1 (88 1318-1618 '@Das gemütliche Schlafzimmer') stop Apr 27 13:38:03 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 27 13:38:03 localhost vdr: [5743] transfer thread ended (pid=5732, tid=5743) Apr 27 13:38:03 localhost vdr: [5732] buffer stats: 0 (0%) used Apr 27 13:38:03 localhost vdr: [5738] Leaving cXineRemote thread Apr 27 13:38:03 localhost vdr: [5738] XineRemote control thread ended (pid=5732, tid=5738) Apr 27 13:38:03 localhost vdr: [5741] KBD remote control thread ended (pid=5732, tid=5741) Apr 27 13:38:03 localhost vdr: [5732] saved setup to /etc/vdr/setup.conf Apr 27 13:38:03 localhost vdr: [5745] TS buffer on device 1 thread ended (pid=5732, tid=5745) Apr 27 13:38:03 localhost vdr: [5744] buffer stats: 0 (0%) used Apr 27 13:38:03 localhost vdr: [5744] receiver on device 1 thread ended (pid=5732, tid=5744) Apr 27 13:38:04 localhost vdr: [5737] section handler thread ended (pid=5732, tid=5737) Apr 27 13:38:06 localhost vdr: [5736] tuner on device 1 thread ended (pid=5732, tid=5736) Apr 27 13:38:06 localhost vdr: [5732] deleting plugin: xine Apr 27 13:38:06 localhost vdr: [5732] exiting, exit code 1 Apr 27 13:38:06 localhost vdr: [5732] emergency exit!
Igor
Hi,
Igor Nikanov schrieb:
But if I disconnect from the card the antenna I will have this problem
[snip]
[snip]
[snip]
Apr 27 13:38:06 localhost vdr: [5732] exiting, exit code 1 Apr 27 13:38:06 localhost vdr: [5732] emergency exit!
When there is a recording going on and no more data comes in (due to the disconnected antenna cable), then VDR assumes a buggy driver/card, requests an emergency exit which will then reload the driver.
In the case where this doesn't fix the problem (i. e. it won't help if you disconnected the antenna cable), VDR will continue to record but still sees no data. The result is, it will again request an emergency exit. This scenario will go on until either the timer(s) get(s) outdated or the signal comes back (by having someone connect the antenna cable again).
There has been a discussion regarding pro and cons of emergency exit and the result is that at least from VDR-1.5.18 on you can disable this "feature" in VDR's setup/miscellaneous menu.
Bye.
Hi,
Igor Nikanov schrieb:
But if I disconnect from the card the antenna I will have this problem
[snip]
let's see in the xine output
[snip]
When you disconnect the antenna cable for a certain amount of time, there will be a gap in presentation time stamps (PTS). This will cause xine to jump over the gap with the result that the previously established buffer will run empty immediately. Any further received images will therefore arrive to late at xine and cause the above messages.
Maybe I can find a solution for vdr-xine to detect this issue and reestablish a suitable buffer in this case.
Bye.
today I disconnected the antenna cable again and didn't discover this problem (I don't know why)
Apr 28 09:54:29 localhost vdr: [6060] switching to channel 2 Apr 28 09:54:29 localhost vdr: [6060] buffer stats: 0 (0%) used Apr 28 09:54:29 localhost vdr: [6126] transfer thread started (pid=6060, tid=6126) Apr 28 09:54:29 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 28 09:54:30 localhost vdr: [6124] TS buffer on device 1 thread ended (pid=6060, tid=6124) Apr 28 09:54:30 localhost vdr: [6123] buffer stats: 0 (0%) used Apr 28 09:54:30 localhost vdr: [6123] receiver on device 1 thread ended (pid=6060, tid=6123) Apr 28 09:54:30 localhost vdr: [6127] receiver on device 1 thread started (pid=6060, tid=6127) Apr 28 09:54:30 localhost vdr: [6128] TS buffer on device 1 thread started (pid=6060, tid=6128) Apr 28 09:54:40 localhost vdr: [6064] frontend 0 timed out while tuning to channel 2, tp 111953 Apr 28 09:54:40 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 28 09:55:11 localhost last message repeated 3 times Apr 28 09:55:32 localhost last message repeated 2 times Apr 28 09:55:42 localhost vdr: [6064] frontend 0 timed out while tuning to channel 2, tp 111953 Apr 28 09:55:42 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2 Apr 28 09:56:13 localhost last message repeated 3 times Apr 28 09:56:34 localhost last message repeated 2 times Apr 28 09:56:45 localhost vdr: [6064] frontend 0 timed out while tuning to channel 2, tp 111953 Apr 28 09:56:45 localhost kernel: dvb_frontend_ioctl: FESTATE_RETUNE: fepriv->state=2
Maybe I can find a solution for vdr-xine to detect this issue and reestablish a suitable buffer in this case.
fine :)
Igor
-
Igor -
Igor Nikanov
-
Reinhard Nissl