Sundtek Support Forum

Deutsch => Sundtek MediaTV Pro => Thema gestartet von: Muschimann am September 23, 2010, 09:44:56 Nachmittag

Titel: merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am September 23, 2010, 09:44:56 Nachmittag
Hallo,

seit einigen Tagen habe ich das Problem das ich nicht mehrere Aufnahmen zeitgleich machen kann. Ich habe an meinem VDR-Server 2 Sundtek Sticks die ich mit DVB-C betreibe. Wenn ich zwei Aufnahmen von verschiedenen Transpondern machen möchte, dann knallt mir der VDR weg. Im Syslog steht leider nur:

Sep 23 19:37:00 ramsdorf-srv01 vdr: [5819] executing '/usr/lib/vdr/vdr-recordingaction before "/media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec"'
Sep 23 19:38:00 ramsdorf-srv01 vdr: [5819] PANIC: watchdog timer expired - exiting!

Messages sagt nur:

Sep 23 19:38:01 ramsdorf-srv01 runvdr: restarting VDR

Und im Mediasrv.log steht nix weiter außer dem was da immer steht, also:

2010-09-23 18:38:00 [1069] =============
2010-09-23 18:38:00 [1069] Symbol rate: 6899939
2010-09-23 18:38:00 [1069] Constellation: QAM256
2010-09-23 18:38:00 [1069] Mirroring: Mirrored
2010-09-23 18:38:01 [1069] Channel found (786000000)
2010-09-23 18:38:01 [1069] =============

Treiber habe ich den Neuesten, hatte die Probleme jedoch auch mit älteren Versionen.

System ist Ubuntu 10.04 Server mit YaVDR Quellen, also VDR 1.7.15 + EPGSearch + Streamdev-Server - mehr nicht.

Das Problem äußert sich wie folgt, der VDR knallt komplett weg, die erste Aufnahme wird jedoch weiter gemacht und die Zweite nimmt auch irgendwie auch, jedoch nicht brauchbar und in ~ 30 MB Stücken. Wenn die erste Aufnahme beendet ist nimmt er die Zweite (defekte) jedoch anstandslos bis zum Schluß an einem Stück auf.

Zur Verdeutlichung mal ls -lh:

-rw-r--r-- 1 vdr vdr  35M 2010-09-23 19:39 00001.ts
-rw-r--r-- 1 vdr vdr  30M 2010-09-23 19:40 00002.ts
-rw-r--r-- 1 vdr vdr  36M 2010-09-23 19:43 00003.ts
-rw-r--r-- 1 vdr vdr  30M 2010-09-23 19:44 00004.ts
-rw-r--r-- 1 vdr vdr  30M 2010-09-23 19:45 00005.ts
-rw-r--r-- 1 vdr vdr  31M 2010-09-23 19:47 00006.ts
-rw-r--r-- 1 vdr vdr  34M 2010-09-23 19:49 00007.ts
-rw-r--r-- 1 vdr vdr  32M 2010-09-23 19:50 00008.ts
-rw-r--r-- 1 vdr vdr  31M 2010-09-23 19:52 00009.ts
-rw-r--r-- 1 vdr vdr  35M 2010-09-23 19:54 00010.ts
-rw-r--r-- 1 vdr vdr  41M 2010-09-23 19:57 00011.ts
-rw-r--r-- 1 vdr vdr  32M 2010-09-23 19:58 00012.ts
-rw-r--r-- 1 vdr vdr  32M 2010-09-23 20:00 00013.ts
-rw-r--r-- 1 vdr vdr  32M 2010-09-23 20:02 00014.ts
-rw-r--r-- 1 vdr vdr  34M 2010-09-23 20:04 00015.ts
-rw-r--r-- 1 vdr vdr  32M 2010-09-23 20:05 00016.ts
-rw-r--r-- 1 vdr vdr  34M 2010-09-23 20:07 00017.ts
-rw-r--r-- 1 vdr vdr  38M 2010-09-23 20:09 00018.ts
-rw-r--r-- 1 vdr vdr  31M 2010-09-23 20:10 00019.ts
-rw-r--r-- 1 vdr vdr  34M 2010-09-23 20:12 00020.ts
-rw-r--r-- 1 vdr vdr  40M 2010-09-23 20:14 00021.ts
-rw-r--r-- 1 vdr vdr 1,9G 2010-09-23 21:05 00022.ts
-rw-r--r-- 1 vdr vdr 792K 2010-09-23 21:05 index
-rw-r--r-- 1 vdr vdr  328 2010-09-23 20:15 info

Hat jemand ne Idee woran das liegen kann? Evtl. ein Tuner defekt!?
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am September 23, 2010, 10:05:29 Nachmittag
Zitat
Sep 23 19:37:00 ramsdorf-srv01 vdr: [5819] executing '/usr/lib/vdr/vdr-recordingaction before "/media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec"'
Sep 23 19:38:00 ramsdorf-srv01 vdr: [5819] PANIC: watchdog timer expired - exiting!

dort sollte noch etwas mehr ueberhalb dieser Nachricht stehen bitte mehr Loginformationen posten oder an kontakt at sundtek de schicken.
Ein aehnliches Thema wurde bereits auf vdr-portal.de behandelt.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am September 23, 2010, 10:21:43 Nachmittag
Also darunter steht eigentlich nur der log das der VDR halt neu startet und das wird dann 'ne Endlosschleife bis ich es mal bemerke und stoppe.

Sep 23 19:38:00 ramsdorf-srv01 vdr: [5819] PANIC: watchdog timer expired - exiting!
Sep 23 19:38:01 ramsdorf-srv01 runvdr: restarting VDR
Sep 23 19:38:01 ramsdorf-srv01 kernel: [560853.080490] saa7146: unregister extension 'dvb'.
Sep 23 19:38:03 ramsdorf-srv01 kernel: [560855.463117] saa7146: register extension 'dvb'.
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] cTimeMs: using monotonic clock (resolution is 1 ns)
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] VDR version 1.7.15 started
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] switched to user 'vdr'
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] codeset is 'UTF-8' - known
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] found 26 locales in /usr/share/locale
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading plugin: /usr/lib/vdr/plugins/libvdr-streamdev-server.so.1.7.15
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading plugin: /usr/lib/vdr/plugins/libvdr-epgsearch.so.1.7.15
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/setup.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/sources.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/diseqc.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/channels.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/timers.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/commands.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/reccmds.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/svdrphosts.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/keymacros.conf
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7891] video directory scanner thread started (pid=7890, tid=7891)
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7890] reading EPG data from /var/cache/vdr/epg.data
Sep 23 19:38:19 ramsdorf-srv01 vdr: [7892] video directory scanner thread started (pid=7890, tid=7892)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7892] video directory scanner thread ended (pid=7890, tid=7892)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7891] video directory scanner thread ended (pid=7890, tid=7891)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] registered source parameters for 'A - ATSC'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] registered source parameters for 'C - DVB-C'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] registered source parameters for 'S - DVB-S'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] registered source parameters for 'T - DVB-T'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] probing /dev/dvb/adapter0/frontend0
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] creating cDvbDevice
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] new device number 1
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] LNB-sharing: setting device 0 to use LNB 1
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] frontend 0/0 provides DVB-C with QAM64,QAM128,QAM256 ("Sundtek DVB-C")
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7893] tuner on frontend 0/0 thread started (pid=7890, tid=7893)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7894] section handler thread started (pid=7890, tid=7894)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] probing /dev/dvb/adapter1/frontend0
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] creating cDvbDevice
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] new device number 2
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] LNB-sharing: setting device 1 to use LNB 2
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] frontend 1/0 provides DVB-C with QAM64,QAM128,QAM256 ("Sundtek DVB-C")
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] found 2 DVB devices
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7896] section handler thread started (pid=7890, tid=7896)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7895] tuner on frontend 1/0 thread started (pid=7890, tid=7895)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] initializing plugin: streamdev-server (0.5.0-pre): VDR Streaming Server
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] initializing plugin: epgsearch (0.9.25.beta17): Suche im EPG nach Wiederholungen und anderem
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] ERROR: invalid primary device number: 3
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] ERROR: no primary device found - using first device!
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] setting primary device to 1
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] assuming manual start of VDR
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] SVDRP listening on port 6419
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] setting current skin to "sttng"
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/themes/sttng-default.theme
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] starting plugin: streamdev-server
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/plugins/streamdev/streamdevhosts.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] starting plugin: epgsearch
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7897] streamdev server thread started (pid=7890, tid=7897)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7897] Streamdev: Couldn't listen (VTP) 0.0.0.0:2004: Address already in use
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7897] Streamdev: Couldn't listen (HTTP) 0.0.0.0:3000: Address already in use
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7897] ERROR: no streamdev server activated, exiting
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7897] streamdev server thread ended (pid=7890, tid=7897)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/plugins/epgsearch/epgsearchcats.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/plugins/epgsearch/epgsearchmenu.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] EPGSearch: loading /var/lib/vdr/plugins/epgsearch/epgsearch.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] EPGSearch: loading /var/lib/vdr/plugins/epgsearch/epgsearchtemplates.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] EPGSearch: loading /var/lib/vdr/plugins/epgsearch/epgsearchdone.data
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] loading /var/lib/vdr/plugins/epgsearch/timersdone.conf
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] EPGSearch: loading /var/lib/vdr/plugins/epgsearch/epgsearchupdmail.templ
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7898] EPGSearch: searchtimer thread started (pid=7890, tid=7898)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] ERROR: /dev/lircd: No such file or directory
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] ERROR: remote control LIRC not ready!
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7899] EPGSearch: conflictcheck thread started (pid=7890, tid=7899)
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] switching to channel 51
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] setting watchdog timer to 60 seconds
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] OSD size changed to 720x480 @ 1
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] ERROR: no OSD provider available - using dummy OSD!
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 1 (5 2255-0015 'Harald Schmidt') set to event Don 23.09.2010 23:00-23:45 (VPS: 23.09 23:00) 'Harald Schmidt'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 2 (7 1237-1325 'c't magazin') set to event Sam 25.09.2010 12:40-13:10 (VPS: 25.09 12:40) 'c't magazin'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 3 (25 2242-2325 'extra 3') set to event Son 26.09.2010 22:45-23:15 (VPS: 26.09 22:45) 'extra 3'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 4 (43 1628-1710 'neues') set to event Son 26.09.2010 16:30-17:00 (VPS: 26.09 16:30) 'neues'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 5 (51 2312-0025 'Die Oliver Pocher Show') set to event Fre 24.09.2010 23:15-00:10 'Die Oliver Pocher Show'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 6 (42 1937-2105 'Georg Schramm: "Thomas Bernhard hätte ge') set to event Don 23.09.2010 19:40-20:55 (VPS: 23.09 19:40) 'Georg Schramm: "Thomas Bernhard hätte geschossen"'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 7 (45 1845-2015 'Zeuch') set to event Don 23.09.2010 19:05-19:40 'Alles was zählt'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] switching device 2 to channel 42
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] timer 6 (42 1937-2105 'Georg Schramm: "Thomas Bernhard hätte ge') start
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] Title: 'Georg Schramm: "Thomas Bernhard hätte geschossen"' Subtitle: '(null)'
Sep 23 19:38:20 ramsdorf-srv01 vdr: [7890] executing '/usr/lib/vdr/vdr-recordingaction before "/media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec"'
Sep 23 19:38:20 ramsdorf-srv01 recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec as shell script
Sep 23 19:38:21 ramsdorf-srv01 vdr: [7894] channel 51 (SAT.1) event Don 23.09.2010 19:30-20:00 'K 11 - Kommissare im Einsatz' status 4
Sep 23 19:38:21 ramsdorf-srv01 vdr: [7896] changing pids of channel 39 from 110+110=2:120=deu@3,121=2ch@3;125=deu@106:0:130 to 110+110=2:120=deu@3,121=2ch@3;125=deu@106:131=deu:130
Sep 23 19:38:21 ramsdorf-srv01 vdr: [7896] channel 42 (ZDFtheaterkanal) event Don 23.09.2010 19:00-19:40 (VPS: 23.09 19:00) 'Foyer' status 4
Sep 23 19:38:22 ramsdorf-srv01 vdr: [7896] channel 43 (3sat) event Don 23.09.2010 19:20-20:00 (VPS: 23.09 19:20) 'Kulturzeit' status 4
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7890] record /media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7890] creating directory /media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7890] creating directory /media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7890] recording to '/media/vdr/Georg_Schramm#3A_#22Thomas_Bernhard_hätte_ge/2010-09-23.19.37.42-0.rec/00001.ts'
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7909] recording thread started (pid=7890, tid=7909)
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7910] receiver on device 2 thread started (pid=7890, tid=7910)
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7890] switching device 1 to channel 45
Sep 23 19:38:30 ramsdorf-srv01 vdr: [7911] TS buffer on device 2 thread started (pid=7890, tid=7911)
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] ERROR (svdrp.c,84): Address already in use
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] max. latency time 10 seconds
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] switching device 1 to channel 45
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] timer 7 (45 1845-2015 'Zeuch') start
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] Title: 'Alles was zählt' Subtitle: '(null)'
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7890] executing '/usr/lib/vdr/vdr-recordingaction before "/media/vdr/Zeuch/2010-09-23.18.45.45-0.rec"'
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7898] EPGSearch: search timer update started
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7899] EPGSearch: timer conflict check started
Sep 23 19:38:31 ramsdorf-srv01 vdr: [7899] EPGSearch: timer conflict check finished
Sep 23 19:38:32 ramsdorf-srv01 vdr: [7894] channel 45 (RTL Television) event Don 23.09.2010 19:05-19:40 'Alles was zählt' status 4
Sep 23 19:39:01 ramsdorf-srv01 CRON[7915]: (root) CMD (  [ -x /usr/lib/php5/maxlifetime ] && [ -d /var/lib/php5 ] && find /var/lib/php5/ -type f -cmin +$(/usr/lib/php5/maxlifetime) -print0 | xargs -n 200 -r -0 rm)
Sep 23 19:39:08 ramsdorf-srv01 vdr: [7896] channel 42 (ZDFtheaterkanal) event Don 23.09.2010 19:00-19:40 (VPS: 23.09 19:00) 'Foyer' status 1
Sep 23 19:39:09 ramsdorf-srv01 vdr: [7896] channel 42 (ZDFtheaterkanal) event Don 23.09.2010 19:40-20:55 (VPS: 23.09 19:40) 'Georg Schramm: "Thomas Bernhard hätte geschossen"' status 2
Sep 23 19:39:31 ramsdorf-srv01 vdr: [7890] PANIC: watchdog timer expired - exiting!
Sep 23 19:39:31 ramsdorf-srv01 runvdr: restarting VDR
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am September 23, 2010, 11:48:10 Nachmittag
Wie sieht es denn ohne Streamdev aus? Es werden ja Fehler insbesondere bezueglich Streamdev in der Logfile angegeben.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am September 24, 2010, 08:30:58 Vormittag
Hab Streamdev mal raus genommen und über den Tag so an die 30 Aufnahmen programmiert, teilweise gleich 4 nebeneinander. :)

Wenn es wirklich daran liegt ist das allerdings doof, da ich das Plugin nutze um das Signal zu den Endgeräten zu verteilen.

Naja, mal sehen. Ich meld mich heut Abend mit den Resultaten.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am September 27, 2010, 05:57:25 Vormittag
Also an Streamdev scheints nicht zu liegen, denn ohne passiert leider genau das selbe. :(

Die einzigen Fehler die ich dann im Log finde ist das hier:

Sep 27 01:57:54 ramsdorf-srv01 vdr: [21063] ERROR (svdrp.c,84): Address already in use
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am September 27, 2010, 06:45:14 Vormittag
Funktionieren die Sticks denn beide einzeln, oder gibt es mit einem ein Problem?
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am Oktober 09, 2010, 08:24:33 Vormittag
So, ich war jetzt mal ne Weile nicht zu Hause und konnte daher nicht weiter testen. Was ich jedoch heraus gefunden habe ist, dass der VDR nach einem Absturz zwei neue Instanzen startet und das genau ist mein Problem. Da muß ich mich mal durch die Konfigurationen wurschteln und gucken warum der das macht. Bei einer zweiten Instanz ist natürlich klar das der nicht per SVDRP zugreifen kann und das erklärt auch weshalb die normalen Aufnahmen weiter gehen. Scheinbar bekommt jeder Stick eine Instanz zugewiesen, bzw. läuft eine Instanz ja "stabil" und die zweite startet sich permanent neu.

Naja, mal gucken was da los ist...
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 21, 2010, 08:19:35 Vormittag
Hi, wurde der Auslöser inzwischen gefunden?
Habe noch keine Ahnung wo ich suchen könnte.

Habe vermutlich das selbe Problem, allerdings obwohl ich nur einen Stick habe und die 2 Aufnahmen sogar auf dem selben Kanal lagen.

VDR ist yaVDR 0.3

fehler ist:
...

Oct 20 22:17:01 udattsvdr CRON[1624]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 20 22:17:01 udattsvdr vdr: [1487] ERROR (svdrp.c,84): Address already in use
Oct 20 22:18:01 udattsvdr vdr: last message repeated 59 times
Oct 20 22:19:01 udattsvdr vdr: last message repeated 60 times
Oct 20 22:20:00 udattsvdr vdr: last message repeated 59 times
Oct 20 22:20:00 udattsvdr vdr: [1609] recording thread ended (pid=1487, tid=1609)
Oct 20 22:20:01 udattsvdr vdr: [1487] buffer stats: 247220 (4%) used
Oct 20 22:20:01 udattsvdr vdr: [1487] timer 8 (4 2013-2220 'Eiskalte Engel') stop
Oct 20 22:20:01 udattsvdr vdr: [1487] executing '/usr/lib/vdr/vdr-recordingaction after "/srv/vdr/video.00/Eiskalte_Engel/2010-10-20.20.13.4-0.rec"'
Oct 20 22:21:00 udattsvdr vdr: [1487] PANIC: watchdog timer expired - exiting!
Oct 20 22:21:00 udattsvdr vdr: [1487] radio: delete cRadioAudio
Oct 20 22:21:01 udattsvdr vdr: [1564] radiocheck thread ended (pid=1487, tid=1564)
Oct 20 22:21:01 udattsvdr vdr: [1563] radioimage thread ended (pid=1487, tid=1563)
Oct 20 22:21:01 udattsvdr vdr: [1587] osdteletext-receiver thread ended (pid=1487, tid=1587)
Oct 20 22:21:01 udattsvdr kernel: [ 7969.197111] vdr[1487]: segfault at 6c00302f ip 0080a81b sp bf918100 error 4 in libstdc++.so.6.0.13[74f000+e9000]
Oct 20 22:21:01 udattsvdr init: vdr main process (1487) killed by SEGV signal
Oct 20 22:21:01 udattsvdr vdr-sxfe[1560]: [1560] [vdr-fe]    caught signal 15
Oct 20 22:21:03 udattsvdr init: vdr-frontend main process (1543) terminated with status 255
Oct 20 22:21:04 udattsvdr vdr-crash: vdr exit with exit status  . Restarting
...
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 21, 2010, 12:15:12 Nachmittag
Das sollte etwas anderes sein - werden wir morgen gleich überprüfen. Bitte auch immer den aktuellen Beta Treiber verwenden wenn solche Reports gemacht werden.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 21, 2010, 08:34:04 Nachmittag
Ich weiß halt nicht ob es mit dem Stick oder mit dem VDR zutun hat. Hab zZ den Treiber aus den yaVDR Repos installiert:

:~$ /opt/bin/mediaclient --build
Build date: Oct 13 2010

:~$ /opt/bin/mediasrv --build
Build date: Oct 13 2010

Gerade eben hat sich mein VDR wieder aufgehangen nachdem er eine Aufnahme starten wollte.

VDR war auf Kabel1 und soll auf RTL schalten. DVB-C mit KDG.
Oct 21 20:14:12 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] wait_stream_sync: discard_index 3080776492 != curpos 3080742652 ! (diff 33840)
Oct 21 20:14:12 udattsvdr vdr: [1469] osdteletext-receiver thread ended (pid=1265, tid=1469)
Oct 21 20:14:12 udattsvdr vdr: [1265] switching device 1 to channel 5
Oct 21 20:14:12 udattsvdr vdr: [1467] TS buffer on device 1 thread ended (pid=1265, tid=1467)
Oct 21 20:14:12 udattsvdr vdr: [1466] buffer stats: 369420 (8%) used
Oct 21 20:14:12 udattsvdr vdr: [1466] receiver on device 1 thread ended (pid=1265, tid=1466)
Oct 21 20:14:12 udattsvdr vdr: [1265] timer 6 (5 2010-2125 'Lasko - Die Faust Gottes') start
Oct 21 20:14:12 udattsvdr vdr: [1265] Title: 'Lasko - Die Faust Gottes' Subtitle: ''
Oct 21 20:14:12 udattsvdr vdr: [1265] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video.00/Lasko_-_Die_Faust_Gottes/2010-10-21.20.10.5-0.rec"'
Oct 21 20:14:20 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:14:20 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:14:28 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:14:28 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:14:37 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:14:37 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:14:45 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:14:45 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:14:54 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:14:54 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:15:02 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:15:02 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:15:10 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] No data in 8 seconds, queuing no signal image
Oct 21 20:15:10 udattsvdr vdr-sxfe[1380]: [1400] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Oct 21 20:15:12 udattsvdr vdr: [1265] PANIC: watchdog timer expired - exiting!
Oct 21 20:15:12 udattsvdr lircd-0.8.6[1249]: removed client
Oct 21 20:15:12 udattsvdr vdr: [1265] buffer stats: 0 (0%) used
Oct 21 20:15:12 udattsvdr init: vdr main process (1265) terminated with status 1
Oct 21 20:15:12 udattsvdr vdr-sxfe[1380]: [1380] [vdr-fe]    caught signal 15
Oct 21 20:15:12 udattsvdr vdr-sxfe[1380]: [1380] [input_vdr] Connections closed.
Oct 21 20:15:12 udattsvdr vdr-sxfe[1380]: [1380] [vdr-fe]    Failed to open connection to bus: /bin/dbus-launch terminated abnormally without any error message
Oct 21 20:15:12 udattsvdr vdr-sxfe[1380]: [1380] [vdr-fe]       (ERROR (tools/gnome_screensaver.c,61): Resource temporarily unavailable)
Oct 21 20:15:14 udattsvdr init: vdr-frontend main process (1368) terminated with status 255
Oct 21 20:15:14 udattsvdr init: logo-stop main process (1564) killed by TERM signal
Oct 21 20:15:14 udattsvdr init: logo-start main process (1601) killed by TERM signal
Oct 21 20:15:14 udattsvdr vdr: [1614] cTimeMs: using monotonic clock (resolution is 1 ns)
Oct 21 20:15:14 udattsvdr vdr: [1602] cTimeMs: using monotonic clock (resolution is 1 ns)
Oct 21 20:15:14 udattsvdr vdr: [1602] VDR version 1.7.16 started
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 21, 2010, 09:23:43 Nachmittag
Wir haben heute den Tipp bekommen das es sich wirklich um ein Umschaltproblem handeln koennte. Vielleicht kommen sich hierbei tatsaechlich 2 Plugins in die Quere.

Bitte auch den Auszug aus /var/log/mediasrv.log fuer diesen Zeitraum angeben +/-15 Minuten.

Es ist schon eine weile her als wir Aufnahmen getestet haben jedoch hatte es zu diesem Zeitpunkt problemlos funktioniert.

Die VDR Logfile laesst darauf schliessen das keine Daten mehr vorhanden sind.

Dieses Problem tritt ja auch nicht bei allen auf ansonsten haetten wir hier wohl schon viel mehr Benachrichtigungen bekommen.

Ab dem morgigen Update wird es ein weiteres Feature geben:
Zitat
./mediaclient --cat /dev/dvb/adapter0/dvr0 | ./mediaclient --pipecount=100
[2010-10-21 21:22:41]          0 bytes |       0.00 kb |       0.00 mb transferred
[2010-10-21 21:22:41]          0 bytes |       0.00 kb |       0.00 mb transferred
[2010-10-21 21:22:41]          0 bytes |       0.00 kb |       0.00 mb transferred
[2010-10-21 21:22:41]          0 bytes |       0.00 kb |       0.00 mb transferred
[2010-10-21 21:22:42]          0 bytes |       0.00 kb |       0.00 mb transferred
[2010-10-21 21:22:42]          0 bytes |       0.00 kb |       0.00 mb transferred

--pipecount zaehlt wieviele Bytes uebertragen wurden, in dem Fall in 100 Millisekunden.

Diese Informationen haetten wir dann auch noch gerne, damit sollte sich dann herausfinden lassen ob die Videodaten nicht mehr an's System geliefert werden wenn so ein Problem auftritt -- oder ob ein anderer Sender konfiguriert wurde und es aus diesem Grund zu einem Stillstand kommt.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 28, 2010, 07:15:34 Vormittag
Bitte mit dem aktuellen Entwicklungstreiber erneut testen, Aufgrund der anderen Beschreibung konnten wir ein aehnliches Problem reproduzieren und loesen.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 28, 2010, 08:07:50 Nachmittag
Hab den aktuellen Treiber von heute installiert. Hatte allerdings eben wieder einen totalcrash nachdem der VDR zum aufnehmen aufgewacht ist.
Der VDR lies sich erst wieder starten als ich alle Einträge aus der timers.conf gelöscht habe.

Kann man den oben genannten Befehl "./mediaclient --cat /dev/dvb/adapter0/dvr0 | ./mediaclient --pipecount=100" irgendwie in ein Skript bekommen und dauerhaft mitloggen lassen mit Zeitangabe, damit ich nachvollziehen kann ob es daran hing?

Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 28, 2010, 08:54:19 Nachmittag
Sind da sicherlich die aktuellen Treiber installiert?

/opt/bin/mediasrv --build

Bitte aktuelle Logfiles anfuegen, und falls moeglich eine genaue Beschreibung wie wir das nachstellen koennen.

Wir hatten das ganze jetzt mit 2 Sticks getestet und es laeuft seit heute morgen problemlos.

Sie schreiben nach dem Aufwachen, wie schlaeft vdr denn? Eventuell ist dies ein logisches Problem von der Anwendung her.

Wenn der komplette PC schlaeft muss VDR zuvor beendet werden und danach wieder gestartet. Nach dem jeweiligen Aufwachen muss das Geraet ordnungsgemaesz konfiguriert werden.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 28, 2010, 09:35:26 Nachmittag
Treiber:
/opt/bin/mediaclient --build
Build date: Oct 28 2010
/opt/bin/mediasrv --build
Build date: Oct 28 2010

-syslog:
-mediasrv
http://rapidshare.com/files/427664288/logs.zip (http://rapidshare.com/files/427664288/logs.zip)

Das ist ja mein Problem, irgendwie tritt es total sporadisch auf und ich weiß nicht wo ich anfangen soll zu suchen.
Hatte erst das Gefühl dass es hautpsächlich bei Aufnahmen von epgsearch passiert, aber als ich eben wieder eine gesetzt hatte lief es einwandfrei. Daher wollte ich mal den log von piepcount kontrollieren.

Mit schlafen meine ich, ich habe den VDR per Powertaste auf der FB oder per Sleeptimer in S5 herunter gefahren und er wacht durch acpi-wakeup wieder auf.


Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 28, 2010, 10:02:11 Nachmittag
schon mal ohne sleep mit dem aktuellen Treiber getestet, Standby mit dem aktuellen Treiber kann durchaus Probleme bereiten wenn Standby nicht ordentlich vom System unterstuetzt wird (fuer uns bedeutet in dem Fall ordentlich VDR wird heruntergefahren, der Treiber gestoppt und beim Aufwachen der Treiber wieder gestartet und anschliessend VDR starten).

Wenn VDR an bleibt und eine Verbindung zum Treiber hat ist das eine sehr gute Fehlerquelle, da nach dem Standby die Status-Synchronisierung zum Stick verlieren koennte und der Treiber auch nicht mehr bescheid wissen wuerde wie die Hardware konfiguriert ist.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 28, 2010, 10:29:53 Nachmittag
Aber ich fahre den PC doch runter und versetze ihn nicht in den Standby,da der Standbymodus des PC immer zu Problemen führte.

Mit schlafen meinte ich PC herunter fahren.
Mit aufwecken PC wird durch acpi-wakeup gestartet/angeschaltet.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: 106060 am Oktober 29, 2010, 01:01:03 Vormittag
Nebenbei, auch wenn sundown kein suspend/resume nutzt, hier mein script, welches ich bisher problemlos unter Debian Squeeze nutze. Vlt. hilft es dem einen oder anderen hier:

/etc/pm/sleep.d/05vdr_sundtek
#!/bin/bash
case $1 in
    suspend|hibernate)
echo "----- $(date)  Stopping daemons -----" >>/var/log/pm-suspend.log
/etc/init.d/vdrdevel stop
# mediasrv will be stopped lateron from 10mediasrv
/etc/init.d/lirc stop
/etc/init.d/sensord stop
/etc/init.d/lm-sensors stop
# enable wake on LAN
ethtool -s eth0 wol g
if (grep PCI0 /proc/acpi/wakeup | grep disabled 2>&1 >> /dev/null) ; then
echo -n PCI0 > /proc/acpi/wakeup
fi
if (grep PS2K /proc/acpi/wakeup | grep disabled 2>&1 >> /dev/null) ; then
echo -n PS2K > /proc/acpi/wakeup
fi
;;
resume|thaw)
echo "----- $(date)  Configuring DVB Adapter -----" >>/var/log/pm-suspend.log
# mediasrv already started from 10mediasrv
/opt/bin/mediaclient -D DVBC -d /dev/dvb/adapter0/frontend0
echo "----- $(date)  Starting daemons -----" >>/var/log/pm-suspend.log
/etc/init.d/lm-sensors start
/etc/init.d/sensord start
/etc/init.d/lirc start
/etc/init.d/vdrdevel start
;;
*)
echo "Unknown trigger: $1 received" >>/var/log/pm-suspend.log
;;
esac

Die Zahl am Anfang des Scriptnamens muss <10 sein, damit es beim suspend nach 10mediasrv ausgeführt wird, ansonsten stimmt die Reihenfolge nicht mehr.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 29, 2010, 03:43:42 Vormittag
Sollte das Problem nocheinmal auftreten waere es sinnvoll uns Zugang zu diesem Rechner zu geben damit wir dies direkt nachvollziehen koennen.

Laut Logfiles sieht das Problem eventuell aus als ob sich etwas in die quere kommt bei der Initialisierung von VDR. Sollte relativ einfach zu finden sein da es anscheinend immer das selbe Muster aufweist. Bei unseren Tests konnten wir dies soweit noch nicht nachvollziehen (wir verwenden zum Testen mittlerweile hauptsaechlich yaVDR). Mehrfache Restarts haben soweit problemlos funktioniert.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am Oktober 29, 2010, 07:28:29 Vormittag
Ich nutzte auch yaVDR,zZ 0.3.

Wie soll ich da vorgehen wennn es nochmal passiert?. Den VDR in dieser Endlosschleife aus Restarts(Des VDR Programms, nicht des PCs!) lassen und hier melden?

Das Problem ist ja,dass es sporadisch auftaucht. So kann ich es nicht provozieren während eines Zugangs.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 29, 2010, 10:14:55 Vormittag
Hier im Forum oder via Skype (sundtek) oder einfach telefonisch melden dann würden wir uns dies ansehen. Soweit wir verstanden haben tritt dies permanent auf sobald VDR bestimmte Timereinträge hat? Und dieser Zustand bleibt bei Ihnen solange bis die Timer entfernt werden?
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Hergorn am Oktober 30, 2010, 11:03:39 Vormittag
Hallo Sundtek Team,

ich habe nach dem Umstieg auf yavdr 0.3 mit dem yavdr Treiber fuer den Sundtek auch staendig Probleme:
- Umschalten kein Bild
- vdr haengt...

Ich habe auf einen Stick abgespeckt.  Damit ist es etwas bessser.  vdr laeuft 24 h durch, bzw jetzt nicht mehr.

Ich sammel mal logs.



Cu

hergorn

sig passe ich auch noch an ;-)
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am Oktober 30, 2010, 01:07:04 Nachmittag
wird denn der aktuelle Treiber verwendet? mit dem aelteren Treiber als vor dem 28. ist dies durchaus moeglich?
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am November 01, 2010, 06:05:49 Nachmittag
Hallo,

also ich habe zwischenzeitlich nichts neues zu berichten, da ich gerade zu viel um die Ohren habe um mich darum zu kümmern. Zum Glück haben meine Fernseher alle auch einen DVB-C Tuner, von daher kann man auch so erstmal Fern sehen.

An dem Umschaltproblem könnte etwas dran sein. Ich hatte das auch oft das über Streamdev keine Daten kamen und dann nach paar mal hin und her schalten kam endlich was.

Ich werde den neuen Treiber jetzt mal eben installieren und dann mal ca. 30 Testaufnahmen programmieren. Wenn der VDR dann am Freitag noch läuft bin icvh glücklich.

Btw: Mein eigentliches Problem ist jedoch das er nach einem Absturz 2x läuft und sich die beiden Instanzen ins Gehege kommen, dazu müsste ich mal die runvdr bissl modifizieren damit das da abgefangen wird.

/opt/bin/mediasrv --build
Build date: Nov  1 2010

Läuft....noch...  8)
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am November 01, 2010, 06:45:40 Nachmittag
Der Treiber vom 1. ist derzeit noch sehr experimentell - sollte derzeit auch nicht verwendet werden.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am November 01, 2010, 07:20:54 Nachmittag
Wo bekomme ich denn dann den vom 28.10. her?
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am November 01, 2010, 08:33:10 Nachmittag
http://www.sundtek.de/media ganz unten (aber nicht 101101)

Der naechste Treiber sollte bald soweit sein.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am November 02, 2010, 04:00:43 Nachmittag
So mittlerweile kann http://www.sundtek.de/media/sundtek_installer_development.sh verwendet werden.

Sollte es irgendwelche Probleme geben bitte melden.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am November 03, 2010, 07:03:45 Nachmittag
Hab eben mal ein upgrade gemacht. Aus Faulheit hatte ich den vom 01.10. drauf gelassen, der lief allerdings schon stabil durch bis eben mit 23 Aufnahmen (so viel hat noch keiner geschafft). :)
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am November 03, 2010, 07:38:23 Nachmittag
Kann ich bei mir nicht bestätigen.

Gerade EinsExtra geschaut dann springt der Timer an um Pro7 aufzunehmen.

syslog:
Nov  3 18:09:00 udattsvdr vdr: [1349] switching device 1 to channel 2
Nov  3 18:09:00 udattsvdr vdr: [1349] timer 3 (2 1809-1848 'Die Simpsons') start
Nov  3 18:09:00 udattsvdr vdr: [1349] Title: 'Die Simpsons' Subtitle: '(null)'
Nov  3 18:09:00 udattsvdr vdr: [1349] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"'
Nov  3 18:09:00 udattsvdr vdr: [1497] TS buffer on device 1 thread ended (pid=1349, tid=1497)
Nov  3 18:09:00 udattsvdr vdr: [1496] buffer stats: 124644 (2%) used
Nov  3 18:09:01 udattsvdr vdr: [1496] receiver on device 1 thread ended (pid=1349, tid=1496)
Nov  3 18:09:01 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] wait_stream_sync: discard_index 1624479048 != curpos 1624435808 ! (diff 43240)
Nov  3 18:09:01 udattsvdr recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec as shell script
Nov  3 18:09:01 udattsvdr vdr: [1349] record /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:09:01 udattsvdr vdr: [1349] creating directory /srv/vdr/video.00/Die_Simpsons
Nov  3 18:09:01 udattsvdr vdr: [1349] creating directory /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:09:01 udattsvdr vdr: [1349] recording to '/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec/00001.ts'
Nov  3 18:09:01 udattsvdr vdr: [1609] recording thread started (pid=1349, tid=1609)
Nov  3 18:09:01 udattsvdr vdr: [1610] ecmhandler 0 filter thread started (pid=1349, tid=1610)
Nov  3 18:09:01 udattsvdr vdr: [1611] receiver on device 1 thread started (pid=1349, tid=1611)
Nov  3 18:09:01 udattsvdr vdr: [1349] markad: executing "/usr/bin"/markad  -v  -B  -G  -O  -a  -r 2 -l "/var/lib/markad" --online=2 before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"
Nov  3 18:09:01 udattsvdr vdr: [1613] TS buffer on device 1 thread started (pid=1349, tid=1613)
Nov  3 18:09:02 udattsvdr vdr: [1433] channel 2 (ProSieben) event Mit 03.11.2010 18:01-18:11 'NEWSTIME' status 4
Nov  3 18:09:02 udattsvdr vdr: [1433] channel 4 (kabel eins) event Mit 03.11.2010 17:53-18:46 'Abenteuer Leben - täglich Wissen' status 4
Nov  3 18:09:09 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:09 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:17 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:17 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:25 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:25 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:34 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:34 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:42 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:42 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:51 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:51 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:09:59 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] No data in 8 seconds, queuing no signal image
Nov  3 18:09:59 udattsvdr vdr-sxfe[1439]: [1464] [input_vdr] using custom "no signal" image /usr/share/libxine1-xvdr/nosignal.mpg
Nov  3 18:10:00 udattsvdr vdr: [1349] PANIC: watchdog timer expired - exiting!
Nov  3 18:10:01 udattsvdr init: vdr main process (1349) terminated with status 1
Nov  3 18:10:01 udattsvdr vdr-sxfe[1439]: [1439] [vdr-fe]    caught signal 15
Nov  3 18:10:01 udattsvdr init: pipecountlog main process (1400) killed by TERM signal
Nov  3 18:10:01 udattsvdr vdr-sxfe[1439]: [1439] [input_vdr] Connections closed.
Nov  3 18:10:01 udattsvdr vdr-sxfe[1439]: [1439] [vdr-fe]    Failed to open connection to bus: /bin/dbus-launch terminated abnormally without any error message
Nov  3 18:10:01 udattsvdr vdr-sxfe[1439]: [1439] [vdr-fe]       (ERROR (tools/gnome_screensaver.c,61): Resource temporarily unavailable)
Nov  3 18:10:03 udattsvdr init: vdr-frontend main process (1399) terminated with status 255
Nov  3 18:10:03 udattsvdr init: logo-stop main process (1619) killed by TERM signal
Nov  3 18:10:03 udattsvdr vdr: [1671] cTimeMs: using monotonic clock (resolution is 1 ns)
Nov  3 18:10:03 udattsvdr init: logo-start main process (1658) killed by TERM signal
Nov  3 18:10:03 udattsvdr vdr: [1659] cTimeMs: using monotonic clock (resolution is 1 ns)
Nov  3 18:10:03 udattsvdr vdr: [1659] VDR version 1.7.16 started

nachdem ich kein sudo stop vdr mehr half, musste man den vdr mit killall -9 vdr beenden und wieder mit sudo start vdr starten.

Dann sah Syslog wie folgt aus.
Nov  3 18:11:20 udattsvdr vdr-sxfe[2347]: [2372] [demux_vdr] PMT changed, resetting demuxer
Nov  3 18:11:20 udattsvdr vdr: [2270] switching device 1 to channel 2
Nov  3 18:11:21 udattsvdr vdr: [2270] timer 3 (2 1809-1848 'Die Simpsons') start
Nov  3 18:11:21 udattsvdr vdr: [2270] Title: 'Die Simpsons' Subtitle: '(null)'
Nov  3 18:11:21 udattsvdr vdr: [2270] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"'
Nov  3 18:11:21 udattsvdr recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec as shell script
Nov  3 18:11:21 udattsvdr vdr: [2270] record /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:11:21 udattsvdr vdr: [2270] recording to '/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec/00002.ts'
Nov  3 18:11:21 udattsvdr vdr: [2388] recording thread started (pid=2270, tid=2388)
Nov  3 18:11:21 udattsvdr vdr: [2270] markad: executing "/usr/bin"/markad  -v  -B  -G  -O  -a  -r 2 -l "/var/lib/markad" --online=2 before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"
Nov  3 18:11:21 udattsvdr markad: [2390] starting v0.0.7
Nov  3 18:11:21 udattsvdr markad: [2390] on /video/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:11:21 udattsvdr vdr: [2270] max. latency time 1 seconds
Nov  3 18:11:21 udattsvdr vdr: [2349] EPGSearch: search timer update started
Nov  3 18:11:21 udattsvdr vdr: [2350] EPGSearch: timer conflict check started
Nov  3 18:11:22 udattsvdr vdr: [2341] channel 2 (ProSieben) event Mit 03.11.2010 18:11-18:38 'Die Simpsons' status 4
Nov  3 18:11:22 udattsvdr vdr: [2341] channel 4 (kabel eins) event Mit 03.11.2010 17:53-18:46 'Abenteuer Leben - täglich Wissen' status 4
Nov  3 18:11:22 udattsvdr vdr: [2350] EPGSearch: timer conflict check finished
Nov  3 18:11:22 udattsvdr vdr: [2349] EPGSearch: search timer update finished
Nov  3 18:11:23 udattsvdr vdr: [2270] stopping recording due to modification of channel 2
Nov  3 18:11:23 udattsvdr vdr: [2388] recording thread ended (pid=2270, tid=2388)
Nov  3 18:11:23 udattsvdr vdr: [2270] buffer stats: 35532 (0%) used
Nov  3 18:11:23 udattsvdr vdr: [2270] timer 3 (2 1809-1848 'Die Simpsons') stop
Nov  3 18:11:23 udattsvdr vdr: [2270] executing '/usr/lib/vdr/vdr-recordingaction after "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"'
Nov  3 18:11:24 udattsvdr recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom after recording /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec as shell script
Nov  3 18:11:24 udattsvdr vdr: [2270] retuning due to modification of channel 2
Nov  3 18:11:24 udattsvdr vdr: [2270] switching to channel 2
Nov  3 18:11:24 udattsvdr vdr-sxfe[2347]: [2371] [input_vdr] vdr_flush_engine: playback is paused <0>
Nov  3 18:11:24 udattsvdr vdr-sxfe[2347]: [2372] [input_vdr] wait_stream_sync: discard_index 756136 != curpos 739216 ! (diff 16920)
Nov  3 18:11:24 udattsvdr vdr: [2270] switching device 1 to channel 2
Nov  3 18:11:24 udattsvdr vdr: [2270] timer 3 (2 1809-1848 'Die Simpsons') start
Nov  3 18:11:24 udattsvdr vdr: [2270] Title: 'Die Simpsons' Subtitle: '(null)'
Nov  3 18:11:24 udattsvdr vdr: [2270] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"'
Nov  3 18:11:24 udattsvdr recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec as shell script
Nov  3 18:11:24 udattsvdr vdr: [2270] record /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:11:24 udattsvdr vdr: [2270] cFileName::SetOffset: removing zero-sized file /srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec/00002.ts
Nov  3 18:11:24 udattsvdr vdr: [2270] recording to '/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec/00002.ts'
Nov  3 18:11:24 udattsvdr vdr: [2403] recording thread started (pid=2270, tid=2403)
Nov  3 18:11:24 udattsvdr vdr: [2270] markad: executing "/usr/bin"/markad  -v  -B  -G  -O  -a  -r 2 -l "/var/lib/markad" --online=2 before "/srv/vdr/video.00/Die_Simpsons/2010-11-03.18.09.2-0.rec"
Nov  3 18:11:24 udattsvdr markad: [2405] starting v0.0.7
Nov  3 18:11:24 udattsvdr markad: [2405] on /video/Die_Simpsons/2010-11-03.18.09.2-0.rec
Nov  3 18:11:24 udattsvdr markad: [2405] another instance is running on this recording
Nov  3 18:11:24 udattsvdr vdr-sxfe[2347]: [2372] [demux_vdr] PMT changed, resetting demuxer
Nov  3 18:11:25 udattsvdr vdr: [2378] [xine..put] Detected video size 720x576
Nov  3 18:11:25 udattsvdr vdr: [2381] Text2Skin: channelInfo display update thread ended (pid=2270, tid=2381)
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: sundown am November 03, 2010, 07:40:19 Nachmittag
mediasrv dazu:
2010-11-03 18:08:58 [1039] Symbol rate: 6899887
2010-11-03 18:08:58 [1039] Constellation: QAM64
2010-11-03 18:08:58 [1039] Mirroring: Mirrored
2010-11-03 18:08:59 [1039] Channel found (458000000)
2010-11-03 18:08:59 [1039] =============
2010-11-03 18:08:59 [1039] Symbol rate: 6899887
2010-11-03 18:08:59 [1039] Constellation: QAM64
2010-11-03 18:08:59 [1039] Mirroring: Mirrored
2010-11-03 18:09:00 [1039] Channel found (458000000)
2010-11-03 18:09:00 [1039] =============
2010-11-03 18:09:00 [1039] Symbol rate: 6899889
2010-11-03 18:09:00 [1039] Constellation: QAM64
2010-11-03 18:09:00 [1039] Mirroring: Mirrored
2010-11-03 18:09:01 [1039] Channel found (458000000)
2010-11-03 18:09:01 [1039] =============
2010-11-03 18:09:01 [1039] Symbol rate: 6899887
2010-11-03 18:09:01 [1039] Constellation: QAM64
2010-11-03 18:09:01 [1039] Mirroring: Mirrored
2010-11-03 18:09:01 [1039] Setting Frequency: 330000000
2010-11-03 18:09:01 [1039] Setting Symbolrate: 6900000
2010-11-03 18:09:01 [1039] Setting Modulation: 5
2010-11-03 18:09:01 [1039] Channel found (330000000)
2010-11-03 18:09:01 [1039] =============
2010-11-03 18:09:01 [1039] Symbol rate: 6899932
2010-11-03 18:09:01 [1039] Constellation: QAM256
2010-11-03 18:09:01 [1039] Mirroring: Mirrored
2010-11-03 18:09:01 [1039] Channel found (330000000)
2010-11-03 18:09:01 [1039] =============
2010-11-03 18:09:01 [1039] Symbol rate: 6899935
2010-11-03 18:09:01 [1039] Constellation: QAM256
2010-11-03 18:09:01 [1039] Mirroring: Mirrored
2010-11-03 18:09:02 [1039] Channel found (330000000)
2010-11-03 18:09:02 [1039] =============
2010-11-03 18:09:02 [1039] Symbol rate: 6899934
2010-11-03 18:09:02 [1039] Constellation: QAM256
2010-11-03 18:09:02 [1039] Mirroring: Mirrored
2010-11-03 18:09:03 [1039] Channel found (330000000)
2010-11-03 18:09:03 [1039] =============
2010-11-03 18:09:03 [1039] Symbol rate: 6899931
2010-11-03 18:09:03 [1039] Constellation: QAM256
2010-11-03 18:09:03 [1039] Mirroring: Mirrored
2010-11-03 18:09:04 [1039] Channel found (330000000)
2010-11-03 18:09:04 [1039] =============
2010-11-03 18:09:04 [1039] Symbol rate: 6899934
2010-11-03 18:09:04 [1039] Constellation: QAM256
2010-11-03 18:09:04 [1039] Mirroring: Mirrored
2010-11-03 18:09:06 [1039] Channel found (330000000)
2010-11-03 18:09:06 [1039] =============
2010-11-03 18:09:06 [1039] Symbol rate: 6899936
2010-11-03 18:09:06 [1039] Constellation: QAM256
2010-11-03 18:09:06 [1039] Mirroring: Mirrored
2010-11-03 18:11:20 [1039] Channel found (330000000)
2010-11-03 18:11:20 [1039] =============
2010-11-03 18:11:20 [1039] Symbol rate: 6899934
2010-11-03 18:11:20 [1039] Constellation: QAM256
2010-11-03 18:11:20 [1039] Mirroring: Mirrored
2010-11-03 18:11:20 [1039] Setting Frequency: 330000000
2010-11-03 18:11:20 [1039] Setting Symbolrate: 6900000
2010-11-03 18:11:20 [1039] Setting Modulation: 5
2010-11-03 18:11:20 [1039] Channel found (330000000)
2010-11-03 18:11:20 [1039] =============
2010-11-03 18:11:20 [1039] Symbol rate: 6899933
2010-11-03 18:11:20 [1039] Constellation: QAM256
2010-11-03 18:11:20 [1039] Mirroring: Mirrored
2010-11-03 18:11:20 [1039] Channel found (330000000)
2010-11-03 18:11:20 [1039] =============
2010-11-03 18:11:20 [1039] Symbol rate: 6899932
2010-11-03 18:11:20 [1039] Constellation: QAM256
2010-11-03 18:11:20 [1039] Mirroring: Mirrored
2010-11-03 18:11:21 [1039] Channel found (330000000)
2010-11-03 18:11:21 [1039] =============
2010-11-03 18:11:21 [1039] Symbol rate: 6899933
2010-11-03 18:11:21 [1039] Constellation: QAM256
2010-11-03 18:11:21 [1039] Mirroring: Mirrored
2010-11-03 18:11:22 [1039] Channel found (330000000)
2010-11-03 18:11:22 [1039] =============
2010-11-03 18:11:22 [1039] Symbol rate: 6899934
2010-11-03 18:11:22 [1039] Constellation: QAM256
2010-11-03 18:11:22 [1039] Mirroring: Mirrored
2010-11-03 18:11:23 [1039] Channel found (330000000)
2010-11-03 18:11:23 [1039] =============
2010-11-03 18:11:23 [1039] Symbol rate: 6899935
2010-11-03 18:11:23 [1039] Constellation: QAM256
2010-11-03 18:11:23 [1039] Mirroring: Mirrored
2010-11-03 18:11:24 [1039] Channel found (330000000)
2010-11-03 18:11:24 [1039] =============
2010-11-03 18:11:24 [1039] Symbol rate: 6899934
2010-11-03 18:11:24 [1039] Constellation: QAM256
2010-11-03 18:11:24 [1039] Mirroring: Mirrored
2010-11-03 18:11:24 [1039] Channel found (330000000)
2010-11-03 18:11:24 [1039] =============
2010-11-03 18:11:24 [1039] Symbol rate: 6899935
2010-11-03 18:11:24 [1039] Constellation: QAM256
2010-11-03 18:11:24 [1039] Mirroring: Mirrored
2010-11-03 18:11:25 [1039] Channel found (330000000)
2010-11-03 18:11:25 [1039] =============
2010-11-03 18:11:25 [1039] Symbol rate: 6899934
2010-11-03 18:11:25 [1039] Constellation: QAM256
2010-11-03 18:11:25 [1039] Mirroring: Mirrored
2010-11-03 18:11:26 [1039] Channel found (330000000)
2010-11-03 18:11:26 [1039] =============
2010-11-03 18:11:26 [1039] Symbol rate: 6899935
2010-11-03 18:11:26 [1039] Constellation: QAM256
2010-11-03 18:11:26 [1039] Mirroring: Mirrored
2010-11-03 18:11:27 [1039] Channel found (330000000)
2010-11-03 18:11:27 [1039] =============
2010-11-03 18:11:27 [1039] Symbol rate: 6899935
2010-11-03 18:11:27 [1039] Constellation: QAM256
2010-11-03 18:11:27 [1039] Mirroring: Mirrored
2010-11-03 18:11:28 [1039] Channel found (330000000)
2010-11-03 18:11:28 [1039] =============
2010-11-03 18:11:28 [1039] Symbol rate: 6899935
2010-11-03 18:11:28 [1039] Constellation: QAM256
2010-11-03 18:11:28 [1039] Mirroring: Mirrored
2010-11-03 18:11:29 [1039] Channel found (330000000)
2010-11-03 18:11:29 [1039] =============
2010-11-03 18:11:29 [1039] Symbol rate: 6899933
2010-11-03 18:11:29 [1039] Constellation: QAM256
2010-11-03 18:11:29 [1039] Mirroring: Mirrored
2010-11-03 18:11:31 [1039] Channel found (330000000)
2010-11-03 18:11:31 [1039] =============
2010-11-03 18:11:31 [1039] Symbol rate: 6899935
2010-11-03 18:11:31 [1039] Constellation: QAM256
2010-11-03 18:11:31 [1039] Mirroring: Mirrored
2010-11-03 18:11:32 [1039] Channel found (330000000)
2010-11-03 18:11:32 [1039] =============
2010-11-03 18:11:32 [1039] Symbol rate: 6899934
2010-11-03 18:11:32 [1039] Constellation: QAM256
2010-11-03 18:11:32 [1039] Mirroring: Mirrored
2010-11-03 18:11:33 [1039] Channel found (330000000)
2010-11-03 18:11:33 [1039] =============
2010-11-03 18:11:33 [1039] Symbol rate: 6899934
2010-11-03 18:11:33 [1039] Constellation: QAM256
2010-11-03 18:11:33 [1039] Mirroring: Mirrored
2010-11-03 18:11:34 [1039] Channel found (330000000)
2010-11-03 18:11:34 [1039] =============
2010-11-03 18:11:34 [1039] Symbol rate: 6899935
2010-11-03 18:11:34 [1039] Constellation: QAM256
2010-11-03 18:11:34 [1039] Mirroring: Mirrored
2010-11-03 18:11:35 [1039] Channel found (330000000)
2010-11-03 18:11:35 [1039] =============
2010-11-03 18:11:35 [1039] Symbol rate: 6899934
2010-11-03 18:11:35 [1039] Constellation: QAM256
2010-11-03 18:11:35 [1039] Mirroring: Mirrored
2010-11-03 18:11:36 [1039] Channel found (330000000)
2010-11-03 18:11:36 [1039] =============
2010-11-03 18:11:36 [1039] Symbol rate: 6899934
2010-11-03 18:11:36 [1039] Constellation: QAM256
2010-11-03 18:11:36 [1039] Mirroring: Mirrored
2010-11-03 18:11:37 [1039] Channel found (330000000)
2010-11-03 18:11:37 [1039] =============
2010-11-03 18:11:37 [1039] Symbol rate: 6899934
2010-11-03 18:11:37 [1039] Constellation: QAM256
2010-11-03 18:11:37 [1039] Mirroring: Mirrored
2010-11-03 18:11:38 [1039] Channel found (330000000)
2010-11-03 18:11:38 [1039] =============
2010-11-03 18:11:38 [1039] Symbol rate: 6899935
2010-11-03 18:11:38 [1039] Constellation: QAM256
2010-11-03 18:11:38 [1039] Mirroring: Mirrored
2010-11-03 18:11:39 [1039] Channel found (330000000)
2010-11-03 18:11:39 [1039] =============
2010-11-03 18:11:39 [1039] Symbol rate: 6899934
2010-11-03 18:11:39 [1039] Constellation: QAM256
2010-11-03 18:11:39 [1039] Mirroring: Mirrored
2010-11-03 18:11:40 [1039] Channel found (330000000)
2010-11-03 18:11:40 [1039] =============
2010-11-03 18:11:40 [1039] Symbol rate: 6899933
2010-11-03 18:11:40 [1039] Constellation: QAM256
2010-11-03 18:11:40 [1039] Mirroring: Mirrored
2010-11-03 18:11:41 [1039] Channel found (330000000)
2010-11-03 18:11:41 [1039] =============
2010-11-03 18:11:41 [1039] Symbol rate: 6899934
2010-11-03 18:11:41 [1039] Constellation: QAM256
2010-11-03 18:11:41 [1039] Mirroring: Mirrored
2010-11-03 18:11:43 [1039] Channel found (330000000)
2010-11-03 18:11:43 [1039] =============
2010-11-03 18:11:43 [1039] Symbol rate: 6899936
2010-11-03 18:11:43 [1039] Constellation: QAM256
2010-11-03 18:11:43 [1039] Mirroring: Mirrored
2010-11-03 18:11:44 [1039] Channel found (330000000)
2010-11-03 18:11:44 [1039] =============
2010-11-03 18:11:44 [1039] Symbol rate: 6899934
2010-11-03 18:11:44 [1039] Constellation: QAM256
2010-11-03 18:11:44 [1039] Mirroring: Mirrored
2010-11-03 18:11:45 [1039] Channel found (330000000)
2010-11-03 18:11:45 [1039] =============
2010-11-03 18:11:45 [1039] Symbol rate: 6899935
2010-11-03 18:11:45 [1039] Constellation: QAM256
2010-11-03 18:11:45 [1039] Mirroring: Mirrored
2010-11-03 18:11:46 [1039] Channel found (330000000)
2010-11-03 18:11:46 [1039] =============
2010-11-03 18:11:46 [1039] Symbol rate: 6899935
2010-11-03 18:11:46 [1039] Constellation: QAM256
2010-11-03 18:11:46 [1039] Mirroring: Mirrored
2010-11-03 18:11:47 [1039] Channel found (330000000)
2010-11-03 18:11:47 [1039] =============
2010-11-03 18:11:47 [1039] Symbol rate: 6899935
2010-11-03 18:11:47 [1039] Constellation: QAM256
2010-11-03 18:11:47 [1039] Mirroring: Mirrored
2010-11-03 18:11:48 [1039] Channel found (330000000)
2010-11-03 18:11:48 [1039] =============
2010-11-03 18:11:48 [1039] Symbol rate: 6899936
2010-11-03 18:11:48 [1039] Constellation: QAM256
2010-11-03 18:11:48 [1039] Mirroring: Mirrored
2010-11-03 18:11:49 [1039] Channel found (330000000)
2010-11-03 18:11:49 [1039] =============
2010-11-03 18:11:49 [1039] Symbol rate: 6899936
2010-11-03 18:11:49 [1039] Constellation: QAM256
2010-11-03 18:11:49 [1039] Mirroring: Mirrored
2010-11-03 18:11:50 [1039] Channel found (330000000)
2010-11-03 18:11:50 [1039] =============
2010-11-03 18:11:50 [1039] Symbol rate: 6899935
2010-11-03 18:11:50 [1039] Constellation: QAM256
2010-11-03 18:11:50 [1039] Mirroring: Mirrored
2010-11-03 18:11:51 [1039] Channel found (330000000)
2010-11-03 18:11:51 [1039] =============
2010-11-03 18:11:51 [1039] Symbol rate: 6899934
2010-11-03 18:11:51 [1039] Constellation: QAM256
2010-11-03 18:11:51 [1039] Mirroring: Mirrored
2010-11-03 18:11:52 [1039] Channel found (330000000)
2010-11-03 18:11:52 [1039] =============
2010-11-03 18:11:52 [1039] Symbol rate: 6899934
2010-11-03 18:11:52 [1039] Constellation: QAM256
2010-11-03 18:11:52 [1039] Mirroring: Mirrored
2010-11-03 18:11:53 [1039] Channel found (330000000)
2010-11-03 18:11:53 [1039] =============
2010-11-03 18:11:53 [1039] Symbol rate: 6899936
2010-11-03 18:11:53 [1039] Constellation: QAM256
2010-11-03 18:11:53 [1039] Mirroring: Mirrored
2010-11-03 18:11:55 [1039] Channel found (330000000)
2010-11-03 18:11:55 [1039] =============
2010-11-03 18:11:55 [1039] Symbol rate: 6899935
2010-11-03 18:11:55 [1039] Constellation: QAM256
2010-11-03 18:11:55 [1039] Mirroring: Mirrored
2010-11-03 18:11:56 [1039] Channel found (330000000)
2010-11-03 18:11:56 [1039] =============
2010-11-03 18:11:56 [1039] Symbol rate: 6899933
2010-11-03 18:11:56 [1039] Constellation: QAM256
2010-11-03 18:11:56 [1039] Mirroring: Mirrored
2010-11-03 18:11:57 [1039] Channel found (330000000)
2010-11-03 18:11:57 [1039] =============
2010-11-03 18:11:57 [1039] Symbol rate: 6899935
2010-11-03 18:11:57 [1039] Constellation: QAM256
2010-11-03 18:11:57 [1039] Mirroring: Mirrored
2010-11-03 18:11:58 [1039] Channel found (330000000)
2010-11-03 18:11:58 [1039] =============
2010-11-03 18:11:58 [1039] Symbol rate: 6899935
2010-11-03 18:11:58 [1039] Constellation: QAM256
2010-11-03 18:11:58 [1039] Mirroring: Mirrored
2010-11-03 18:11:59 [1039] Channel found (330000000)
2010-11-03 18:11:59 [1039] =============
2010-11-03 18:11:59 [1039] Symbol rate: 6899934
2010-11-03 18:11:59 [1039] Constellation: QAM256
2010-11-03 18:11:59 [1039] Mirroring: Mirrored
2010-11-03 18:12:00 [1039] Channel found (330000000)
2010-11-03 18:12:00 [1039] =============
2010-11-03 18:12:00 [1039] Symbol rate: 6899935
2010-11-03 18:12:00 [1039] Constellation: QAM256
2010-11-03 18:12:00 [1039] Mirroring: Mirrored
2010-11-03 18:12:01 [1039] Channel found (330000000)
2010-11-03 18:12:01 [1039] =============
2010-11-03 18:12:01 [1039] Symbol rate: 6899935
2010-11-03 18:12:01 [1039] Constellation: QAM256
2010-11-03 18:12:01 [1039] Mirroring: Mirrored
2010-11-03 18:12:02 [1039] Channel found (330000000)
2010-11-03 18:12:02 [1039] =============
2010-11-03 18:12:02 [1039] Symbol rate: 6899935
2010-11-03 18:12:02 [1039] Constellation: QAM256
2010-11-03 18:12:02 [1039] Mirroring: Mirrored
2010-11-03 18:12:03 [1039] Channel found (330000000)
2010-11-03 18:12:03 [1039] =============
2010-11-03 18:12:03 [1039] Symbol rate: 6899936
2010-11-03 18:12:03 [1039] Constellation: QAM256
2010-11-03 18:12:03 [1039] Mirroring: Mirrored
2010-11-03 18:12:04 [1039] Channel found (330000000)
2010-11-03 18:12:04 [1039] =============
2010-11-03 18:12:04 [1039] Symbol rate: 6899933
2010-11-03 18:12:04 [1039] Constellation: QAM256
2010-11-03 18:12:04 [1039] Mirroring: Mirrored
2010-11-03 18:12:05 [1039] Channel found (330000000)
2010-11-03 18:12:05 [1039] =============
2010-11-03 18:12:05 [1039] Symbol rate: 6899936
2010-11-03 18:12:05 [1039] Constellation: QAM256
2010-11-03 18:12:05 [1039] Mirroring: Mirrored
2010-11-03 18:12:07 [1039] Channel found (330000000)
2010-11-03 18:12:07 [1039] =============
2010-11-03 18:12:07 [1039] Symbol rate: 6899935
2010-11-03 18:12:07 [1039] Constellation: QAM256
2010-11-03 18:12:07 [1039] Mirroring: Mirrored
2010-11-03 18:12:08 [1039] Channel found (330000000)
2010-11-03 18:12:08 [1039] =============
2010-11-03 18:12:08 [1039] Symbol rate: 6899934
2010-11-03 18:12:08 [1039] Constellation: QAM256
2010-11-03 18:12:08 [1039] Mirroring: Mirrored
2010-11-03 18:12:09 [1039] Channel found (330000000)
2010-11-03 18:12:09 [1039] =============
2010-11-03 18:12:09 [1039] Symbol rate: 6899935
2010-11-03 18:12:09 [1039] Constellation: QAM256
2010-11-03 18:12:09 [1039] Mirroring: Mirrored
2010-11-03 18:12:10 [1039] Channel found (330000000)
2010-11-03 18:12:10 [1039] =============
2010-11-03 18:12:10 [1039] Symbol rate: 6899935
2010-11-03 18:12:10 [1039] Constellation: QAM256
2010-11-03 18:12:10 [1039] Mirroring: Mirrored
2010-11-03 18:12:11 [1039] Channel found (330000000)
2010-11-03 18:12:11 [1039] =============
2010-11-03 18:12:11 [1039] Symbol rate: 6899934
2010-11-03 18:12:11 [1039] Constellation: QAM256
2010-11-03 18:12:11 [1039] Mirroring: Mirrored
2010-11-03 18:12:12 [1039] Channel found (330000000)
2010-11-03 18:12:12 [1039] =============
2010-11-03 18:12:12 [1039] Symbol rate: 6899935
2010-11-03 18:12:12 [1039] Constellation: QAM256
2010-11-03 18:12:12 [1039] Mirroring: Mirrored
2010-11-03 18:12:13 [1039] Channel found (330000000)
2010-11-03 18:12:13 [1039] =============
2010-11-03 18:12:13 [1039] Symbol rate: 6899935
2010-11-03 18:12:13 [1039] Constellation: QAM256
2010-11-03 18:12:13 [1039] Mirroring: Mirrored
2010-11-03 18:12:14 [1039] Channel found (330000000)
2010-11-03 18:12:14 [1039] =============
2010-11-03 18:12:14 [1039] Symbol rate: 6899934
2010-11-03 18:12:14 [1039] Constellation: QAM256
2010-11-03 18:12:14 [1039] Mirroring: Mirrored
2010-11-03 18:12:15 [1039] Channel found (330000000)
2010-11-03 18:12:15 [1039] =============
2010-11-03 18:12:15 [1039] Symbol rate: 6899933
2010-11-03 18:12:15 [1039] Constellation: QAM256
2010-11-03 18:12:15 [1039] Mirroring: Mirrored
2010-11-03 18:12:16 [1039] Channel found (330000000)
2010-11-03 18:12:16 [1039] =============

und der pipelog
[2010-11-03 18:09:02]    3901440 bytes |    3810.00 kb |       3.72 mb transferred
[2010-11-03 18:09:07]    1873920 bytes |    1830.00 kb |       1.79 mb transferred
[2010-11-03 18:09:12]    1792000 bytes |    1750.00 kb |       1.71 mb transferred
[2010-11-03 18:09:17]    1781760 bytes |    1740.00 kb |       1.70 mb transferred
[2010-11-03 18:09:22]    1996800 bytes |    1950.00 kb |       1.90 mb transferred
[2010-11-03 18:09:27]    1853440 bytes |    1810.00 kb |       1.77 mb transferred
[2010-11-03 18:09:32]    1802240 bytes |    1760.00 kb |       1.72 mb transferred
[2010-11-03 18:09:37]    1802240 bytes |    1760.00 kb |       1.72 mb transferred
[2010-11-03 18:09:42]    1843200 bytes |    1800.00 kb |       1.76 mb transferred
[2010-11-03 18:09:47]    2682880 bytes |    2620.00 kb |       2.56 mb transferred
[2010-11-03 18:09:52]    3266560 bytes |    3190.00 kb |       3.12 mb transferred
[2010-11-03 18:09:57]    2508800 bytes |    2450.00 kb |       2.39 mb transferred
[2010-11-03 18:11:22]   18554880 bytes |   18120.00 kb |      17.70 mb transferred
[2010-11-03 18:11:27]    1863680 bytes |    1820.00 kb |       1.78 mb transferred

Edit:
mediasrv --build
Build date: Nov  2 2010
mediaclient --build
Build date: Nov  2 2010
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am November 03, 2010, 08:23:34 Nachmittag
Der Entwicklungstreiber vom 1. ist nicht wirklich stabil.
Bitte zumindestens den Treiber vom 2. November verwenden.
(in beiden Faellen handelt es sich um Entwicklungstreiber, die naechste stable Release ist in 1-2 Wochen geplant).

Die angegebenen haenger konnten wir mit 2 Geraeten nachvollziehen und wurden nachgebessert.

Wir haben VDR nun auch auf einem dedizierten Rechner laufen und machen damit Langzeittests.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Sundtek am November 04, 2010, 01:20:25 Vormittag
Nocheinmal nachgehakt das Problem wurde jetzt soweit verstanden. Je mehr Geraete im VDR haengen desto einfacher kann es auftreten - der Treiber wurde soweit bereits aktualisiert. Die letzten Updates gingen bereits in die richtige Richtung.

Derzeitiger Entwicklungstreiber ist vom 4. November 2010

Aktuell konnten wir eine VDR Restartsituation nachvollziehen.
Tuner A nimmt auf, Tuner B arbeitet auf einem Transponder wo kein Signal (mehr?) vorhanden ist.
Diese Situation kann man jedoch ueber die Logfile ausfindig machen.

Zitat
syslog:
Nov  4 04:34:39 ubuntu vdr: [14680] frontend 1/0 timed out while tuning to channel 261, tp 458

Nov  4 04:35:01 ubuntu vdr: [14726] ERROR: video data stream broken
Nov  4 04:35:01 ubuntu vdr: [14726] initiating emergency exit

mediasrv.log:
2010-10-27 10:34:06 [4271] Setting Frequency: 458000000
2010-10-27 10:34:06 [4271] Setting Symbolrate: 6900000
2010-10-27 10:34:06 [4271] Setting Modulation: 3
2010-10-27 10:34:07 [4271] Channel found (113000000)

458 Mhz wurde in der mediasrv.log aber nie mit "Channel found" hinterlegt.

$ /opt/bin/mediaclient -m DVBC -f 458000000 -S 6900000 -M Q64
Using device: /dev/dvb/adapter1/frontend0
Checking for lock:
..........

(auf beiden Tuner Modulen konnte hierbei kein Sender gefunden werden).


Nach dem Umschalten auf eine gueltige Frequenz hatte es soweit wieder funktioniert, vdr hing bei dieser Situation nicht - er war durchaus bedienbar jedoch ist der timeout bezueglich des nicht vorhandenen Videos angesprungen.

Die urspruenglichen Situationen das VDR komplett haengt sollte soweit mit der aktuellen Version vom 4. November geloest sein. Wir werden uns die Situation mit ungueltigen Frequenzen noch etwas genauer ansehen- insbesondere ob das mit anderen Karten anders gehandelt wird. Bei einer korrekten Scanliste sollte dies ohnehin nicht auftreten.

Diese Situation wurde soweit abgeklaert und es tritt auf sobald man von einem Transponder aufnehmen will welcher keine Daten liefert (z.B Gewitter bei DVB-S oder Ausfall eines Transponders bei DVB-C -- so wie wir dies nun bei KabelDeutschland hatten).

Zusammengefasst dies sehen wir soweit noch nicht als Problem, die oben von den anderen Anwendern angefuehrten Probleme sollten aber nicht mehr auftreten.
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am November 06, 2010, 08:32:11 Vormittag
Hab eben mal den Server gecheckt - kein Absturz, alle 37 Aufnahmen der letzten 3 Tage perfekt aufgezeichnet.

Scheint jetzt wirklich alles Tutti zu sein. Danke Jungs.  ;D
Titel: Re:merkwürdiges Problem bei zeitgleichen Aufnahmen
Beitrag von: Muschimann am November 27, 2010, 11:24:36 Vormittag
Hallöle, ich nochmal. :)

Also nach einem ausführlichen Langzeittest mit knapp 200 Aufnahmen ist mir der VDR 2x abgeraucht, allerdings hatte ich auch noch den "gefährlichen" Treiber vom 1.11. drauf, der stabil lief wie bis dahin kein anderer. ;)

Ich habe eben mak ein Upgrade auf 18.11. gemacht und qwerde die Situation weiter beobachten, allerdings werde ich nicht mehr jeden Scheiß aufnehmen. Jetzt muß ich erstmal die Platte von dem ganzen sinnlosen Zeug befreien. ;)

Bis die Tage...