[yavdr jammy] svdrpsend timeout peering

kfb77 · 4. Juni 2022

Ich bekomme seit einiger Zeit regelmäßig einen Timeout zwischen meinen zwei VDRs mit peering.

Ich kann nicht mehr genau nachvollziehen, wann das los ging, aber vermutlich mit dem Update auf Ubuntu 22.04 und VDR 2.6.

Code

Jun  4 22:12:59 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:12:59 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'
Jun  4 22:14:59 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:15:00 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'
Jun  4 22:16:00 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:16:00 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'
Jun  4 22:17:59 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:17:59 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'
Jun  4 22:19:00 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:19:00 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'
Jun  4 22:21:00 user.err        VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.143:6419 timeout while waiting for response from 'VDR-2204-Dev'
Jun  4 22:21:00 user.err        VDR-2204        vdr: [381] ERROR: can't send 'POLL VDR-2204 TIMERS' to 'VDR-2204-Dev'

Alles anzeigen

Ein manuell gestarteter svdrpsend Befehl hat auch sporadisch Hänger, diese sind zeitgleich mit einem o.g. Syslog Eintrag.

Code

root@VDR-2204:~# time svdrpsend -d 10.1.5.144 stat disk
220 VDR-2204 SVDRP VideoDiskRecorder 2.6.1; Sat Jun  4 22:23:52 2022; UTF-8
250 5632842MB 1148574MB 80%
221 VDR-2204 closing connection

real    0m0,144s
user    0m0,035s
sys     0m0,008s
root@VDR-2204:~# time svdrpsend -d 10.1.5.144 stat disk
220 VDR-2204 SVDRP VideoDiskRecorder 2.6.1; Sat Jun  4 22:23:53 2022; UTF-8
250 5632842MB 1148574MB 80%
221 VDR-2204 closing connection

real    0m0,143s
user    0m0,034s
sys     0m0,009s
root@VDR-2204:~# time svdrpsend -d 10.1.5.144 stat disk
220 VDR-2204 SVDRP VideoDiskRecorder 2.6.1; Sat Jun  4 22:23:53 2022; UTF-8
250 5632842MB 1148573MB 80%
221 VDR-2204 closing connection

real    0m0,117s
user    0m0,012s
sys     0m0,004s
root@VDR-2204:~# time svdrpsend -d 10.1.5.144 stat disk
220 VDR-2204 SVDRP VideoDiskRecorder 2.6.1; Sat Jun  4 22:23:54 2022; UTF-8
250 5632842MB 1148573MB 80%
221 VDR-2204 closing connection

real    0m0,144s
user    0m0,043s
sys     0m0,000s
root@VDR-2204:~# time svdrpsend -d 10.1.5.144 stat disk
220 VDR-2204 SVDRP VideoDiskRecorder 2.6.1; Sat Jun  4 22:24:00 2022; UTF-8
250 5632842MB 1148570MB 80%
221 VDR-2204 closing connection

real    0m4,711s                                          <- fast 5s, aber Antwort kam noch.
user    0m0,011s
sys     0m0,007s

Alles anzeigen

Die naheliegende Ursache, ein Netzwerkproblem, würde ich ausschließen, da kein reales Netzwerk dazwischen. Beide VDRs sind lxc Container auf dem gleichen Host. Ping hat keine Hänger.

Das Peering funktioniert aber trotzdem. Hat mir jemand eine Idee, in welche Richtung ich hier weiter suchen kann, woher die svdrpsend Hänger kommen ?

seahawk1986 · 4. Juni 2022

Schau doch mal, was der VDR bzw. die Plugins dabei ins Log schreiben - eventuell macht da ein Plugin irgendwelche Dinge, die die mainloop des VDR länger aufhalten.

kfb77 · 5. Juni 2022

Zitat von seahawk1986

Schau doch mal, was der VDR bzw. die Plugins dabei ins Log schreiben

Das ist ja das verrückte: Nichts ! Das angehängte Syslog ist vom zentralen Syslog Server und ungekürzt.

Edit: Allerdings auch mit log = 1, ich drehe das mal hoch, vielleicht sieht man dann was.

kfb77 · 5. Juni 2022

Danke, dein Tipp bringt mich in eine neue Richtung der Suche. Ungekürztes Syslog über alle Maschinen auf dem Host:

Code

Jun  5 08:59:38 user.info       VDR-2204-Dev    vdr: [16157] SVDRP VDR-2204-Dev < 10.1.5.110:32850 client connection accepted
Jun  5 08:59:38 user.debug      VDR-2204-Dev    vdr: [16157] SVDRP VDR-2204-Dev > 10.1.5.110:32850 server created
Jun  5 08:59:38 user.info       VDR-2204-Dev    vdr: [16157] SVDRP VDR-2204-Dev < 10.1.5.110:32850 lost connection to client
Jun  5 08:59:38 user.info       VDR-2204-Dev    vdr: [16157] SVDRP VDR-2204-Dev < 10.1.5.110:32850 connection closed
Jun  5 08:59:38 user.debug      VDR-2204-Dev    vdr: [16157] SVDRP VDR-2204-Dev < 10.1.5.110:32850 server destroyed
Jun  5 08:59:38 user.info       VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.110:56796 client connection accepted
Jun  5 08:59:38 user.err        epgd-2004       epgd: Error: SVDRPCL: Timeout waiting server reply '10.1.5.143'
Jun  5 08:59:38 user.debug      VDR-2204        vdr: [381] SVDRP VDR-2204 > 10.1.5.110:56796 server created
Jun  5 08:59:38 user.info       VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.110:56796 lost connection to client
Jun  5 08:59:38 user.info       VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.110:56796 connection closed
Jun  5 08:59:38 user.debug      VDR-2204        vdr: [381] SVDRP VDR-2204 < 10.1.5.110:56796 server destroyed

Alles anzeigen

Die 10.1.5.110 ist der epgd Container. Wegen meinen Problemen mit mariadb im Container unter Ubuntu 22.04 habe ich die lokalen epgd Instanzen zu einem zentralen epgd Server geändert, der weiterhin unter 20.04 läuft. Vielleicht blockiert mir beim epg Update die anderen svdpsend Aufrufe ???

Ich stoppe den mal temporär, dann müsste es ja weg sein.

kfb77 · 5. Juni 2022

Ja, das ist die Ursache. Ohne epgd ist der Timeout weg. Bei laufenden epgd fällt der Timeout zeitlich mit dem merge vom epgd zusammen.

[yavdr jammy] svdrpsend timeout peering

Jetzt mitmachen!

Teilen