markad.vps / vps.log, Sommerzeit

MarkusE · 26. März 2023

Hallo,

Mit Umstellung zur Sommerzeit, vps.log:

Code

         time        EventID      now     next    EIT  state event new  offset  action
26.03.2023 01:23:31 index 0, eventID     631, start 26.03.2023 01:23:33, stop 26.03.2023 04:53:52
26.03.2023 01:23:33         EIT eventID     631, start 26.03.2023 01:23:33, stop 26.03.2023 04:53:52
26.03.2023 01:23:33 got event 2
26.03.2023 01:23:33      631      630      631    631    0     2    2  00:00:02 accept
26.03.2023 01:23:36 got event 4
26.03.2023 01:23:36      631      630      631    631    2     4    4  00:00:05 start
         time        EventID      now     next    EIT  state event new  offset  action
26.03.2023 04:06:02 index 0, eventID     631, start 26.03.2023 01:23:33, stop 26.03.2023 04:53:52

In der markad.vps steht dann nur "VPSTIMER=YES", und keine start/stop Zeiten.

Timer war auf "Rückkehr zum Planet der Affen", "ServusTV HD Deutschland", von "Sun Mar 26 2023 01:23:33 GMT+0100 (Mitteleuropäische Normalzeit)" bis "Sun Mar 26 2023 04:53:52 GMT+0200 (Mitteleuropäische Sommerzeit)".

Warum bekommt markad

"Mar 26 03:53:56 rpi4s vdr: [1049772] channel 25 (ServusTV HD Deutschland) event So. 26.03.2023 01:23-04:53 (VPS: 26.03. 01:23) 'Rückkehr zum Planet der Affen' status 1"

nicht mit?

Und warum gibt es um "Mar 26 04:04:23" einen core dump? OK, ich mache noch eine Thread ...

Im syslog:

Code

Mar 26 01:21:33 rpi4s vdr: [1034002] timer 30 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') entered VPS margin
Mar 26 01:23:22 rpi4s vdr: [1049772] channel 25 (ServusTV HD Deutschland) event So. 26.03.2023 01:23-04:53 (VPS: 26.03. 01:23) 'Rückkehr zum Planet der Affen' status 2
Mar 26 01:23:22 rpi4s vdr: [1034002] timer 30 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') start
Mar 26 01:23:31 rpi4s vdr: [1034002] markad: cStatusMarkAd::Recording(): recording <Science Fiction~Rückkehr zum Planet der Affen> [/mnt/md0/vdr/videos/video/Science_Fiction/Rückkehr_zum_Planet_der_Affen/2023-03-26.01.23.25-0.rec] started, recording count now 1
Mar 26 01:23:31 rpi4s vdr: [1034002] markad: cStatusMarkAd::GetEventID(): eventID 631 from event for recording <Science Fiction~Rückkehr zum Planet der Affen> timer <Science Fiction~Rückkehr zum Planet der Affen>  timer start 1679790213 stop 1679799232
Mar 26 01:23:31 rpi4s vdr: [1034002] markad: cStatusMarkAd::GetEventID(): timer <Science Fiction~Rückkehr zum Planet der Affen> uses VPS
Mar 26 01:23:31 rpi4s vdr: [1034002] markad: cStatusMarkAd::Recording(): added recording <Science Fiction~Rückkehr zum Planet der Affen> event ID 631 at index 0 only for VPS detection
Mar 26 01:23:36 rpi4s vdr: [1049772] markad: StatusMarkAd::StoreVPSStatus(): recording <Science Fiction~Rückkehr zum Planet der Affen> got VPS START event at 26.03.2023 01:23:36
Mar 26 01:23:36 rpi4s vdr: [1049772] channel 25 (ServusTV HD Deutschland) event So. 26.03.2023 01:23-04:53 (VPS: 26.03. 01:23) 'Rückkehr zum Planet der Affen' status 4

Mar 26 03:53:56 rpi4s vdr: [1049772] channel 25 (ServusTV HD Deutschland) event So. 26.03.2023 01:23-04:53 (VPS: 26.03. 01:23) 'Rückkehr zum Planet der Affen' status 1
Mar 26 03:53:56 rpi4s vdr: [1034002] timer 30 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') finished with 0 errors
Mar 26 03:53:56 rpi4s vdr: [1034002] timer 30 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') stop
Mar 26 03:53:56 rpi4s vdr: [1034002] markad: cStatusMarkAd::Recording(): recording stopped, recording count now 0

Mar 26 04:04:14 rpi4s vdr[1034002]: pure virtual method called
Mar 26 04:04:14 rpi4s vdr[1034002]: terminate called without an active exception
Mar 26 04:04:14 rpi4s systemd[1]: Started Process Core Dump (PID 1051488/UID 0).
Mar 26 04:04:23 rpi4s systemd-coredump[1051489]: Process 1034002 (vdr) of user 200 dumped ...


Mar 26 04:05:56 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') set to event So. 26.03.2023 01:23-04:53 (VPS: 26.03. 01:23) 'Rückkehr zum Planet der Affen'
Mar 26 04:05:56 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') start
Mar 26 04:06:02 rpi4s vdr: [1051540] markad: cStatusMarkAd::GetEventID(): eventID 631 from event for recording <Science Fiction~Rückkehr zum Planet der Affen> timer <Science Fiction~Rückkehr zum Planet der Affen>  timer start 1679790213 stop 1679799232
Mar 26 04:06:02 rpi4s vdr: [1051540] markad: cStatusMarkAd::GetEventID(): timer <Science Fiction~Rückkehr zum Planet der Affen> uses VPS
Mar 26 04:06:04 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') finished with 0 errors
Mar 26 04:06:04 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') stop
Mar 26 04:06:07 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') entered VPS margin
Mar 26 04:55:04 rpi4s vdr: [1051540] timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen') set to no event
Mar 26 04:55:04 rpi4s vdr: [1051540] deleting timer 26 (25 0123-0453 VPS 'Science Fiction~Rückkehr zum Planet der Affen')

Alles anzeigen

Liegt das an der Sommerzeitumstellung?

Bei einem älteren Timer hat das noch funktioniert, und sieht so aus:

Code

         time        EventID      now     next    EIT  state event new  offset  action
22.03.2023 02:40:40 index 0, eventID   24998, start 22.03.2023 02:40:00, stop 22.03.2023 03:45:00
22.03.2023 02:40:40         EIT eventID   24998, start 22.03.2023 02:40:00, stop 22.03.2023 03:45:00
22.03.2023 02:40:40 got event 2
22.03.2023 02:40:40    24998    24998    24999  24998    0     2    2  00:00:00 accept
22.03.2023 02:41:52 got event 4
22.03.2023 02:41:52    24998    24998    24999  24998    2     4    4  00:01:12 start
22.03.2023 03:44:02 got event 1
22.03.2023 03:44:02    24998    24998    24999  24998    4     1    1  01:03:22 stop

Mit markad.vps:

Code

VPSTIMER=YES
START: 22.03.2023-02:41:52 72
STOP: 22.03.2023-03:44:02 3802

~ Markus

kfb77 · 26. März 2023

Da hast du jetzt aber alles reingepackt, was Probleme machen kann: Zeit Umstellung, VPS mit epg2vdr (vermutlich), ...

Die Variante markad VPS mit echtem VPS Timer ist auch nicht wirklich eine Variante, die ich empfehlen würde. Die "markad VPS light" Funktion war ja eigentlich auch als Ersatz für echtes VPS gedacht (insbesondere eben wegen den epg2vdr Problemen mit VPS) und nicht zusätzlich.

Ich habe mal bei mir zwei Timer eingestellt, mit und ohne VPS von deinem Sender. Das muss ich mir erst mal anschauen, was hier grundsätzlich passiert. Das Thema Zeit Umstellung können wir eh nicht angehen, die ist zu selten um da was zu testen.

Ich vermute mal, dass das ohne deine Patches für VDP und epg2vdr eh nicht funktionieren wird. Die sind aber weder bei VDR noch bei epg2vdr im git.

MarkusE · 26. März 2023

Also, epg2vdr habe ich nicht.

Nachdem Klaus klar gemacht hat, daß VPS mit epg2vdr nicht funktioniert (weil epg2vdr eigene event IDs verwendet), habe ich es wieder de-installiert.

kfb77 · 26. März 2023

OK, dass ändert alles. Dann muss ich mir erst einen Test VDR ohne epg2vdr basteln.

kfb77 · 26. März 2023

Mein Testserver steht, die erste Aufnahme mit VPS von o.g. Sender ist durch: Ich kann das Problem reproduzierten.

Ich mache mich jetzt an die Fehlersuche. Das kann aber dauern, weil ich für Tests jeweils eine komplette Aufnahme brauche.

Was mir beim Vergleich mit deinem Log File noch aufgefallen ist, aber nichts mit dem Problem zu tun hat: Deine markad Version ist wohl schon ein wenig alt, da hat sich mal das Format vom Log File geändert.

MarkusE · 26. März 2023

Zitat von kfb77

Mein Testserver steht, die erste Aufnahme mit VPS von o.g. Sender ist durch: Ich kann das Problem reproduzierten.
Ich mache mich jetzt an die Fehlersuche.

Super, danke!

kfb77 · 27. März 2023

Kurzer Status Update:

Der Sender sendet gar keinen VPS Event 1 (Stop) am Ende der Aufnahme, somit stimmt die Ausgabe von markad.

VDR zaubert hier: In cSchedule::SetRunningStatus(): erzeugt er sich selber einen Stop Event, wenn der Start Event der nachfolgenden Aufnahme kommt.

Ich vermute das machen alle privaten Sender so, da habe ich noch nie einen Stop am Ende der Aufnahme gesehen. Nur die ÖR senden diesen.

Ich sehe zwei Lösungsansätze:

1. HandleEvent zusätzlich zu HandleEitEvent auswerten, vielleicht bekomme ich da den Zauber vom VDR auch mit (noch nicht getestet)

2. in markad genauso wie der VDR den Stop selber erfinden

Ich würde die erste Variante bevorzugen, dann brauche ich nicht was bauen, was es im VDR schon gibt.

kfb77 · 27. März 2023

Es sind jetzt beide Varianten gemischt geworden, erster Code zum Testen hier.

Vorsicht, nur auf Test VDR einsetzen:

- das ist noch ungetestet, meine Test Aufnahmen laufen erst heute Nacht.

- es wird sicher nicht mit epg2vdr gehen, den EIT Eventhandler habe ich noch nicht angepasst.

kfb77 · 28. März 2023

Das muss ich wohl heute Abend nochmals ran, funktioniert nur, wenn die Aufnahme nach der VPS Zeit gestartet wurde. Das macht so mal gar keinen Sinn.

kfb77 · 30. März 2023

Es wurden dann doch mehrere Abende ...

MarkusE : bitte den Stand im Branch VPS testen. Der müsste ohne epg2vdr funktionieren, an der Variante mit epg2vdr arbeite ich noch. Das VPS Verhalten der Sender ist teilweise stark unterschiedlich, somit: Falls du Probleme findest, bitte Sendername und vps.log posten.

MarkusE · 31. März 2023

Danke!

Habe auf ServusTV HD Deutschland getestet, funktioniert :).

Ich empfange hier nur FTA Sender. Gibt es noch andere private FTA Sender, die VPS senden?

Code

31.03.2023 00:06:09 timer info: recording index 0, eventID 790, eventNextID 0
31.03.2023 00:06:09 timer info: start 31.03.2023 00:06:00, stop 31.03.2023 01:29:00
31.03.2023 00:06:09 timer info: eventID 790 <= 0xFFFF: channel not under control of epg2vdr, use HandleEvent() and ignore HandleEitEvent()
31.03.2023 00:08:54 ------------------------------------> new VPS VDR Event: ID:  790, state: 2 -> starts in a few seconds
31.03.2023 00:08:54 VPS status: time offset: 00:02:45, eventID: 790, old state 0, new state: 2 -> recording starts in a few seconds
31.03.2023 00:09:06 ------------------------------------> new VPS VDR Event: ID:  790, state: 4 -> got next eventID 791
31.03.2023 00:09:06 ------------------------------------> new VPS VDR Event: ID:  790, state: 4 -> running
31.03.2023 00:09:06 VPS status: time offset: 00:02:57, eventID: 790, old state 2, new state: 4 -> recording start
31.03.2023 01:19:31 ------------------------------------> new VPS VDR Event: ID:  791, state: 4 -> next event started
31.03.2023 01:19:31 ------------------------------------> new VPS VDR Event: ID:  790, state: 1 -> not running
31.03.2023 01:19:31 VPS status: time offset: 01:13:22, eventID: 790, old state 4, new state: 1 -> recording end

Alles anzeigen

Code

VPSTIMER=NO
START: 31.03.2023-00:09:06 177
STOP: 31.03.2023-01:19:31 4402

kfb77 · 31. März 2023

Zitat von MarkusE

Gibt es noch andere private FTA Sender, die VPS senden?

Ich bin noch bei den ÖR am testen, die senden besseres VPS und auch da gehen noch nicht alle, private kommen danach. Ich vermute aber, die senden (fast) alle irgendwas, zumindest wie deinen Beispiel nur den Start.

utiltiy · 31. März 2023

Zitat von kfb77

Ich vermute aber, die senden (fast) alle irgendwas, zumindest wie deinen Beispiel nur den Start.

Denk ich auch, den meine enigma2 Box hat eine Option dass die die Infobar einblendet bei Sendungsbeginn, die muss ja auch irgendein Signal dafür bekommen zur Auswertung.

kfb77 · 31. März 2023

Kann mal bitte jemand eine Aufnahme von "MDR Sachsen HD" mit einem VPS Timer testen.

Bei mir looped der VDR im "emergency exit!" und die Aufnahme bleibt 0 Bytes groß. Leider wird kein Coredump geschreiben.

Zum Test habe ich markad entfernt, das Verhalten bleibt gleich, daher kommt es also nicht.

Edit: muss an meinem Testserver liegen, ohne VPS geht es auch nicht, auf dem produktiven VDR geht es. Muss ich nicht verstehen, die channels.conf ist von dem kopiert.

Edit2: channels.conf Eintrag hatte sich tatsächlich geändert, nochmals kopiert, dann ging es.

Sorry for the noise.

markad.vps / vps.log, Sommerzeit

Jetzt mitmachen!

Teilen