stopping recording due to modification

    Was hat das zu bedeuten?


    ...
    Feb 20 05:02:42 xbmc0 vdr: [18673] switching device 2 to channel 43
    Feb 20 05:02:55 xbmc0 vdr: EPG2VDR: Change handler state to 'standby'
    Feb 20 05:02:55 xbmc0 vdr: EPG2VDR: Info: Updates pending but epgd 'busy (match)' since '14.02.20 05:02:50', retrying in 10 seconds
    Feb 20 05:03:00 xbmc0 vdr: [18673] CAM 1: assigned to device 1
    Feb 20 05:03:00 xbmc0 vdr: [18673] switching device 1 to channel 43
    Feb 20 05:03:00 xbmc0 vdr: [18673] timer 14 (43 0503-0650 'Der Flug der Störche(1)') start
    Feb 20 05:03:00 xbmc0 vdr: [18673] Title: 'Der Flug der Störche (1)' Subtitle: Actionfilm (F/SAFR/D 2012)'
    Feb 20 05:03:00 xbmc0 vdr: [18673] executing '/usr/local/bin/noadcall.sh before "/nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec"'
    Feb 20 05:03:00 xbmc0 vdr: [18688] VNSI: Timers state changed (20)
    Feb 20 05:03:00 xbmc0 vdr: [18688] VNSI: Requesting clients to reload timers
    Feb 20 05:03:00 xbmc0 vdr: [18673] record /nas/Video/vdr0/Der_Flug_der_Störche_1)/2014-02-20.05.03.43-0.rec
    Feb 20 05:03:00 xbmc0 vdr: [18673] creating directory /nas/Video/vdr0/Der_Flug_der_Störche_(1)
    Feb 20 05:03:00 xbmc0 vdr: [18673] creating directory /nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec
    Feb 20 05:03:00 xbmc0 vdr: [18673] recording to '/nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec/00001.ts'
    Feb 20 05:03:00 xbmc0 vdr: [5101] recording thread started (pid=18673, tid=5101, prio=high)
    Feb 20 05:03:00 xbmc0 vdr: [18673] DVBAPI: 0.0 set CAM decrypt (SID 131, caLm 4, HasCaDescriptors 1)
    Feb 20 05:03:00 xbmc0 vdr: [5102] receiver on device 1 thread started (pid=18673, tid=5102, prio=high)
    Feb 20 05:03:00 xbmc0 vdr: [5103] TS buffer on device 1 thread started (pid=18673, tid=5103, prio=high)
    Feb 20 05:03:00 xbmc0 vdr: [5105] video directory scanner thread started (pid=18673, tid=5105, prio=high)
    Feb 20 05:03:00 xbmc0 vdr: [5104] video directory scanner thread started (pid=18673, tid=5104, prio=high)
    Feb 20 05:03:00 xbmc0 vdr: [18688] VNSI: Recordings state changed (12412)
    Feb 20 05:03:00 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (52 2143-2240 'Serien~Low Winter Sun~S01E06 - Mein Name ist nicht Katia') set to event Don 20.02.2014 21:45-22:30 'Low Winter Sun'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (14 2013-2155 'Serien~Tatort~S2010E31 - Wie einst Lilly') set to event Sam 22.02.2014 20:15-21:45 (VPS: 22.02. 20:15) 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (14 2143-2320 'Serien~Tatort~S2011E20 - Im Abseits') set to event Sam 22.02.2014 21:45-23:10 (VPS: 22.02. 21:45) 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (18 2208-2345 'Serien~Tatort~S1992E08 - Stoevers Fall') set to event Sam 22.02.2014 22:10-23:35 (VPS: 22.02. 22:10) 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (1 2013-2155 'Serien~Tatort~S2014E09 - Brüder') set to event Son 23.02.2014 20:15-21:45 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (25 2228-2325 'Serien~Fahrten ins Ungewisse~S01E03 - Die letzte Fahrt der Deutschland') set to event Mon 24.02.2014 22:30-23:15 'Fahrten ins Ungewisse'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (25 2313-0010 'Serien~Fahrten ins Ungewisse~S01E02 - Verschollen vor Spitzbergen') set to event Mon 24.02.2014 23:15-00:00 'Fahrten ins Ungewisse'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (18 2158-2340 'Serien~Tatort~S2012E15 - Es ist böse') set to event Die 25.02.2014 22:00-23:30 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (43 2013-2220 'Kokowääh 2') set to ent Son 23.02.2014 20:15-22:10 'Kokowääh 2'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (52 2013-2110 'Strike Back') set to event Sam 22.02.2014 20:15-21:00 'Strike Back'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (14 2013-2155 'Serien~Tatort~S2011E16 - Der illegale Tod') set to event Mit 26.02.2014 20:15-21:45 'Tatort'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (43 0503-0650 'Der Flug der Störche 1)') set to event Don 20.02.2014 05:05-06:40 'Der Flug der Störche (1)'
    Feb 20 05:03:00 xbmc0 vdr: [25303] timer 1 (43 0638-0840 'Der Flug der Störche 2)') set to event Don 20.02.2014 06:40-08:30 'Der Flug der Störche (2)'
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Recordings state changed (12417)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Recordings state changed (12430)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:01 xbmc0 vdr: [5105] video directory scanner thread ended (pid=18673, tid=5105)
    Feb 20 05:03:01 xbmc0 vdr: [18673] stopping recording due to modification of channel 43
    Feb 20 05:03:01 xbmc0 vdr: [5101] recording thread ended (pid=18673, tid=5101)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Recordings state changed (12440)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:01 xbmc0 vdr: [18673] DVBAPI: 0.0 set CAM decrypt (SID 131, caLm 5, HasCaDescriptors 1)
    Feb 20 05:03:01 xbmc0 vdr: [18673] buffer stats: 265832 (1%) used
    Feb 20 05:03:01 xbmc0 vdr: [18673] timer 14 (43 0503-0650 'Der Flug der Störche(1)') stop
    Feb 20 05:03:01 xbmc0 vdr: [18673] executing '/usr/local/bin/noadcall.sh after "/nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec"'
    Feb 20 05:03:01 xbmc0 markad: [5115] starting v0.1.5pre (64bit)
    Feb 20 05:03:01 xbmc0 markad: [5115] on /nas/Video/vdr0/Der_Flug_der_Störche_(1/2014-02-20.05.03.43-0.rec
    Feb 20 05:03:01 xbmc0 vdr: [5103] TS buffer on device 1 thread ended (pid=18673, tid=5103)
    Feb 20 05:03:01 xbmc0 vdr: [5102] buffer stats: 141564 (3%) used
    Feb 20 05:03:01 xbmc0 vdr: [5102] receiver on device 1 thread ended (pid=18673, tid=5102)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Recordings state changed (12447)
    Feb 20 05:03:01 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:02 xbmc0 vdr: [18673] switching device 1 to channel 43
    Feb 20 05:03:02 xbmc0 vdr: [18673] timer 14 (43 0503-0650 'Der Flug der Störche(1)') start
    Feb 20 05:03:02 xbmc0 vdr: [18673] Title: 'Der Flug der Störche (1)' Subtitle: Actionfilm (F/SAFR/D 2012)'


    Feb 20 05:03:02 xbmc0 vdr: [18673] executing '/usr/local/bin/noadcall.sh before "/nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec"'
    Feb 20 05:03:02 xbmc0 vdr: [18688] VNSI: Recordings state changed (12464)
    Feb 20 05:03:02 xbmc0 vdr: [18688] VNSI: Requesting clients to reload recordings list
    Feb 20 05:03:02 xbmc0 vdr: [18688] VNSI: Timers state changed (22)
    Feb 20 05:03:02 xbmc0 vdr: [18688] VNSI: Requesting clients to reload timers
    Feb 20 05:03:02 xbmc0 vdr: [18673] record /nas/Video/vdr0/Der_Flug_der_Störche_1)/2014-02-20.05.03.43-0.rec
    Feb 20 05:03:02 xbmc0 vdr: [18673] cFileName::SetOffset: removing zero-sized file /nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec/00001.ts
    Feb 20 05:03:02 xbmc0 vdr: [18673] recording to '/nas/Video/vdr0/Der_Flug_der_Störche_(1)/2014-02-20.05.03.43-0.rec/00001.ts'
    Feb 20 05:03:02 xbmc0 vdr: [5191] recording thread started (pid=18673, tid=5191, prio=high)
    Feb 20 05:03:02 xbmc0 vdr: [18673] DVBAPI: 0.0 set CAM decrypt (SID 131, caLm 4, HasCaDescriptors 1)
    Feb 20 05:03:02 xbmc0 vdr: [5192] receiver on device 1 thread started (pid=18673, tid=5192, prio=high)
    Feb 20 05:03:02 xbmc0 vdr: [5193] TS buffer on device 1 thread started (pid=18673, tid=5193, prio=high)
    ...



    Die Aufnahme wurde dennoch sauber erzeugt - ich habe folgende ts-Files:



    Wer oder was modifiziert den Kanal auf dem die Aufnahme laufen soll und warum?

    Die Suche ist Dein Freund. ;) Vermutlich hat sich eine Pid während der Aufnahme geändert (bei Sky meist irgend eine Teletext-PID).


    Welche VDR-Version? Ich meine, kls hatte das mal rausgenommen, dass bei Änderung der Teletext-Pids eine Aufnahme unterbrochen wird.


    Wenn ich das in Deinem Log richtig lese, war das aber zu Anfang der Aufnahme, da kann schon sein, dass Audiospuren order ähnliches gewechselt werden.

    - Client1: Thermaltake DH 102 mit 7" TouchTFT * Debian Stretch/vdr-2.4.0/graphtft/MainMenuHooks-Patch * Zotac H55-ITX WiFi * Core i3 540 * 4GB RAM ** Zotac GT630 * 1 TB System HDD * 4 GB RAM * Harmony 900 * satip-Plugin

    - Client2: Alfawise H96 Pro Plus * KODI
    - Server: Intel Pentium G3220 * DH87RL * 16GB RAM * 4x4TB 3.5" WD RED + 1x500GB 2.5" * satip-Plugin
    - SAT>IP: Inverto iLNB

    Hallo,


    diese Änderungen an den Kanaldaten kommen, soweit ich herausgefunden habe, vom Provider. In Deinem Fall hat sich der Provider hier was Neues ausgedacht, um den Content zu schützen. Meine Recherche hat ergeben, dass irgendwann während einer Sendung die Teletext-ID auf Null gesetzt wird und ein paar Sekunden später wieder auf den vorherigen Wert.


    Dadurch wird der VDR veranlasst, die beschriebene Aktion auszuführen.


    ABER: Setzt man die Update-Funktion im Setup unter DVB auf "nur Namen", dann ignoriert VDR diese Änderungen und die Aufzeichnungen sind wieder ganz. Der Nachteil ist, dass man dann keine neuen Kanäle mehr bekommt und die Kanalliste, sofern man auch den Originalton haben will, auf das Vorhandensein aller notwendigen PIDs überprüfen und ggf. manuell ergänzen muss.


    Es gilt, abzuwägen, ob man mit kurzen Unterbrechungen der Aufzeichnungen leben kann oder ob man den Mehraufwand auf sich nimmt, die Kanalliste von Hand zu pflegen.


    Schöne Grüße aus Wien
    BobW

    VDR1: yavdr 0.5 x86_64, 2.0.2, P5QD-Turbo, HVR-4000, TBS-6980, Zotac GT240
    VDR2: yavdr 0.5 x86_64, 2.0.2, auf M3N78 headless als Server
    VDR3: yavdr 0.5 x86_64, 2.0.2, auf ZOTAC ION Mini-ITX als Streaming Client in Koexistenz mit OpenELEC 12.1

    Ich hab auch noch diesen Thread gefunden.


    Der von Klaus erwähnte patch ist (noch) nicht drin - zumindest im 2.1.2. Ich patch das mal probehalber.


    Danke in Runde.

    Dank Klaus - dann zieh ich am WE hoch.

    Wie gesagt, bei Dir scheints ja den Anfang der Aufnahme zu betreffen, wenn die Audipspuren wechseln. Also scheint zumindest die Aufnahme ok zu sein.


    Als das bei mir passierte, hab ich bei mir noch die maximale Dateigrösse hochgesetzt, um nur eine Videodatei pro Aufnahme zu erhalten. Dann sieht man immer schön, ob es Probleme gab, wenn mehrere Dateien im Verzeichnis liegen. Wenn dann aber mal mehrere da sind, so ist es in dem meisten Fällen nur zu Beginn eines Films - also Vorlaufzeit > neue Datei > Beginn des Films. Und wenn doch mittendrin ein Split ist...löschen und nochmal aufnehmen. :D

    - Client1: Thermaltake DH 102 mit 7" TouchTFT * Debian Stretch/vdr-2.4.0/graphtft/MainMenuHooks-Patch * Zotac H55-ITX WiFi * Core i3 540 * 4GB RAM ** Zotac GT630 * 1 TB System HDD * 4 GB RAM * Harmony 900 * satip-Plugin

    - Client2: Alfawise H96 Pro Plus * KODI
    - Server: Intel Pentium G3220 * DH87RL * 16GB RAM * 4x4TB 3.5" WD RED + 1x500GB 2.5" * satip-Plugin
    - SAT>IP: Inverto iLNB

    so - ich hatte dann nach dem hochziehen auf 2.1.4 auch erstmal Ruhe - bis gestern Abend - es geht um die Aufnahme von "House of Cards - Jäger oder Gejagte" - und ich verstehe nur zu einem Teil (den Timeout beim Tunen) die Ursache


    20:52:00 Der Timer wird per epgsearch um 20:52 letztmalig gesetzt (21:00 - 22:00)
    20:58:01 die erste Aufnahme beginnt - gleichzeitig/in dem Zuge werden von epgsearch? die Timerliste neu bearbeitet.
    20:58:06 (Fünf Sekunden später) wird die Aufzeichnung beendet - für mich ohne ersichtlichen Grund - jedenfalls kam kein pid - change
    20:58:07 wird (schon wieder) die Timerliste neu bearbeitet (VNSI? - aber wenn - warum nur - es ist kein Client mit dem VNSI-Server verbunden)
    20:58:22 erfolgt der n. Aufnahme-Versuch
    20:58:23 (1 Sekunde später) werden von epgsearch oder wem? die Timer neu gesetzt
    20:58:33 das Tunen auf Device 0 für den Kanal (51) geht schief, die Aufnahme wird beendet
    20:58:33 Device 2 beginnt erneut mit der Aufnahme
    20:58:33 kommt tatsächlich wieder ein PID-Change - die Aufnahme wird beendet
    20:58:34 wird die Aufnahme nochmals gestartet auf Device 2 - und läuft diesmal bis zu Ende durch
    ....




    Hat da noch jemand eine Idee?

    Du nimmst von einem verschlüsselten Kanal auf. Nach ein paar Sekunden merkt VDR, daß die gewählte Kombination aus Device und CAM keine entschlüsselten Daten liefert, also beendet er die Aufnahme und versucht es mit einer neuen Kombination erneut. Das macht er so lange, bis er entschlüsselte Daten erhält.


    Klaus

    Für den Versuch um 20:58:33 verstehe ich die Erklärung - da steht entsprechendes im log (Frontend timed out....) bei den anderen (vor allem dem ersten verstehe ich es nciht und da kommt ja auch keine entsprechende Meldung, dass er "NICHT" entschlüsseln kann.

    Einmal editiert, zuletzt von magicamun ()

    Zitat von magicamun

    Für den Versuch um 20:58:33 verstehe ich die Erklärung - da steht entsprechendes im log (Frontend timed out....) bei den anderen (vor allem dem ersten verstehe ich es nciht und da kommt ja auch keine entsprechende Meldung, dass er "NICHT" entschlüsseln kann.


    Ich gehe aber mal davon aus, daß er eben *nicht* entschlüsselt hat.
    Ich werde in cDevice::Action() eine entsprechende Meldung einbauen.


    Klaus

Jetzt mitmachen!

Sie haben noch kein Benutzerkonto auf unserer Seite? Registrieren Sie sich kostenlos und nehmen Sie an unserer Community teil!

Benutzerkonto erstellen Anmelden