Problem mit Streamdev-Server und Streamdev-Client

Hallo Community,

ich brauche eure Hilfe !

Ich nutze nun schon seit mehr als 10 Jahren ein Client-Server-VDR-System mit einem Server und 3 Clients, welches bisher einwandfrei und unauffällig gelaufen ist. Seit einiger Zeit funktioniert das Streaming vom Server zu den Clients nicht mehr.

Setup Server:

Linux-Server mit 3 HD-SAT-Karten, VDR 2.0.6 und Streamdev-Server 0.6.1 (sowie weiteren Plugins); Server hat keine Berechtigung zum Internet, seit 10 Jahren keine Updates

Setup Clients:

Raspberry Pi mit VDR 2.0.6 und Streamdev-Client 0.6.1 (sowie weiteren Plugins); yaVDR 0.4 auf Barebones mit Streamdev-Client (und weiteren Plugins).

Aktuelles Verhalten:

Eine Verbindung über Streamdev ist nicht möglich. Eine Verbindung zum Server mittels RemoteOSD, RemoteTimers funktioniert, ebenso das Abspielen von Aufzeichnungen, welche am Server liegen. Gleiches Verhalten auf allen Clients.

Was steht in den Logfiles wenn am Client ein Kanal umgeschaltet wird:

Clientlog:

Aug 27 16:10:01 cube-1 vdr: [1280] switching to channel 3
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Connected to server 172.16.0.21:2004 using capabilities TSPIDS,FILTERS,PRIO
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Pid 101 not available from 172.16.0.21:2004
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Pid 102 not available from 172.16.0.21:2004
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Pid 103 not available from 172.16.0.21:2004
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Pid 106 not available from 172.16.0.21:2004
Aug 27 16:10:02 cube-1 vdr: [1617] osdteletext-receiver thread ended (pid=1280, tid=1617)
Aug 27 16:10:02 cube-1 vdr: [1280] Streamdev: Pid 104 not available from 172.16.0.21:2004
Aug 27 16:10:02 cube-1 vdr: [1280] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:02 cube-1 vdr: [1280] cStreamdevDevice::OpenFilter: connect failed: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:02 cube-1 vdr: [1280] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
...
Aug 27 16:10:04 cube-1 vdr: [1280] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:04 cube-1 vdr: [1280] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 27 16:10:04 cube-1 vdr: [1280] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:04 cube-1 vdr: [1280] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED

...

Aug 27 16:10:04 cube-1 vdr: [1882] receiver on device 24 thread started (pid=1280, tid=1882)
Aug 27 16:10:04 cube-1 vdr: [1280] buffer stats: 0 (0%) used
Aug 27 16:10:04 cube-1 vdr: [1280] creating directory /var/run/vdr/vtx/S19.2E-1-1101-28107
Aug 27 16:10:05 cube-1 vdr: [1882] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:05 cube-1 vdr: [1882] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 27 16:10:05 cube-1 vdr: [1882] receiver on device 24 thread ended (pid=1280, tid=1882)
Aug 27 16:10:05 cube-1 vdr: [1280] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:05 cube-1 vdr: [1280] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 27 16:10:05 cube-1 vdr: [1883] osdteletext-receiver thread started (pid=1280, tid=1883)
Aug 27 16:10:05 cube-1 vdr: [1884] receiver on device 24 thread started (pid=1280, tid=1884)
Aug 27 16:10:05 cube-1 vdr: [1881] Text2Skin: menu display update thread ended (pid=1280, tid=1881)
Aug 27 16:10:05 cube-1 vdr: [1884] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 27 16:10:05 cube-1 vdr: [1884] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 27 16:10:05 cube-1 vdr: [1884] receiver on device 24 thread ended (pid=1280, tid=1884)

Serverlog:

Aug 27 16:10:02 hp vdr: [3725] Streamdev: Accepted new client (VTP) 172.16.0.121:35744

Aug 27 16:10:02 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:34733

Aug 27 16:10:02 hp vdr: [4114] streamdev-writer thread started (pid=3655, tid=4114, prio=high)

Aug 27 16:10:02 hp vdr: [4115] streamdev-filterstreaming thread started (pid=3655, tid=4115, prio=high)

Aug 27 16:10:02 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:48268

Aug 27 16:10:02 hp vdr: [4115] streamdev-filterstreaming thread ended (pid=3655, tid=4115)

Aug 27 16:10:02 hp vdr: [4114] streamdev-writer thread ended (pid=3655, tid=4114)

Aug 27 16:10:02 hp vdr: [4116] streamdev-writer thread started (pid=3655, tid=4116, prio=high)

Aug 27 16:10:02 hp vdr: [4117] streamdev-filterstreaming thread started (pid=3655, tid=4117, prio=high)

Aug 27 16:10:02 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:44025

Aug 27 16:10:03 hp vdr: [4117] streamdev-filterstreaming thread ended (pid=3655, tid=4117)

Aug 27 16:10:03 hp vdr: [4116] streamdev-writer thread ended (pid=3655, tid=4116)

Aug 27 16:10:03 hp vdr: [4118] streamdev-writer thread started (pid=3655, tid=4118, prio=high)

Aug 27 16:10:03 hp vdr: [4119] streamdev-filterstreaming thread started (pid=3655, tid=4119, prio=high)

Aug 27 16:10:03 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:41469

Aug 27 16:10:04 hp vdr: [4119] streamdev-filterstreaming thread ended (pid=3655, tid=4119)

Aug 27 16:10:04 hp vdr: [4118] streamdev-writer thread ended (pid=3655, tid=4118)

Aug 27 16:10:04 hp vdr: [4120] streamdev-writer thread started (pid=3655, tid=4120, prio=high)

Aug 27 16:10:04 hp vdr: [4121] streamdev-filterstreaming thread started (pid=3655, tid=4121, prio=high)

Aug 27 16:10:04 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:51066

Aug 27 16:10:04 hp vdr: [4122] streamdev-writer thread started (pid=3655, tid=4122, prio=high)

Aug 27 16:10:04 hp vdr: [4123] streamdev-livestreaming thread started (pid=3655, tid=4123, prio=high)

Aug 27 16:10:04 hp vdr: [4124] receiver on device 1 thread started (pid=3655, tid=4124, prio=high)

Aug 27 16:10:04 hp vdr: [4125] TS buffer on device 1 thread started (pid=3655, tid=4125, prio=high)

Aug 27 16:10:04 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:53890

Aug 27 16:10:04 hp vdr: [4123] streamdev-livestreaming thread ended (pid=3655, tid=4123)

Aug 27 16:10:04 hp vdr: [4125] TS buffer on device 1 thread ended (pid=3655, tid=4125)

...

Aug 27 16:10:04 hp vdr: [4132] receiver on device 1 thread ended (pid=3655, tid=4132)

Aug 27 16:10:04 hp vdr: [4130] streamdev-writer thread ended (pid=3655, tid=4130)

Aug 27 16:10:04 hp vdr: [4134] streamdev-writer thread started (pid=3655, tid=4134, prio=high)

Aug 27 16:10:04 hp vdr: [4136] receiver on device 1 thread started (pid=3655, tid=4136, prio=high)

Aug 27 16:10:04 hp vdr: [4135] streamdev-livestreaming thread started (pid=3655, tid=4135, prio=high)

Aug 27 16:10:04 hp vdr: [4137] TS buffer on device 1 thread started (pid=3655, tid=4137, prio=high)

Aug 27 16:10:04 hp vdr: [3725] Streamdev: Setting data connection to 172.16.0.121:52664

Aug 27 16:10:04 hp vdr: [4135] streamdev-livestreaming thread ended (pid=3655, tid=4135)

Aug 27 16:10:05 hp vdr: [4137] TS buffer on device 1 thread ended (pid=3655, tid=4137)

Aug 27 16:10:05 hp vdr: [4134] streamdev-writer thread ended (pid=3655, tid=4134)

Aug 27 16:10:05 hp vdr: [4136] buffer stats: 0 (0%) used

...

Aug 27 16:10:05 hp vdr: [4144] receiver on device 1 thread ended (pid=3655, tid=4144)

Aug 27 16:10:05 hp vdr: [4142] streamdev-writer thread ended (pid=3655, tid=4142)

Aug 27 16:10:05 hp vdr: [4146] streamdev-writer thread started (pid=3655, tid=4146, prio=high)

Aug 27 16:10:05 hp vdr: [4148] receiver on device 1 thread started (pid=3655, tid=4148, prio=high)

Aug 27 16:10:05 hp vdr: [4147] streamdev-livestreaming thread started (pid=3655, tid=4147, prio=high)

Aug 27 16:10:05 hp vdr: [4149] TS buffer on device 1 thread started (pid=3655, tid=4149, prio=high)

Aug 27 16:10:05 hp vdr: [4146] ERROR: streamdev-server: couldn't send 74636 bytes: Connection reset by peer

Aug 27 16:10:05 hp vdr: [4146] streamdev-writer thread ended (pid=3655, tid=4146)

Aug 27 16:10:05 hp vdr: [3725] streamdev-server: closing VTP connection to 172.16.0.121:35744

Aug 27 16:10:05 hp vdr: [4147] streamdev-livestreaming thread ended (pid=3655, tid=4147)

Aug 27 16:10:05 hp vdr: [3725] buffer stats: 72944 (1%) used

Aug 27 16:10:05 hp vdr: [4149] TS buffer on device 1 thread ended (pid=3655, tid=4149)

Aug 27 16:10:05 hp vdr: [4148] buffer stats: 92496 (2%) used

Aug 27 16:10:05 hp vdr: [4148] receiver on device 1 thread ended (pid=3655, tid=4148)

Hat jemand von euch ne Idee ?

Grüße

Mane

Hallo jsffm,

habe zur Sicherheit die channels.conf vom Server auf einen Client kopiert, leider das gleiche Verhalten.

Grüße

Mane

Hallo maxzapper,

ne, kann ich ausschließen.

Ich kann über den Client über remoteosd in das Servermenü, eine Aufnahme programmieren, den Timer auch vom Client aus wieder editieren und die Aufnahme anschauen.

Ausserdem funktioniert Streaming über z.B. vlc über Port 3000 ohne Probleme.

Grüße

Mane

Hallo machtnix,

auf dem Client ? Die Datei ist das letzte Mal am 31.08.2011 editiert:

#
# svdrphosts    This file describes a number of host addresses that
#               are allowed to connect to the SVDRP port of the Video
#               Disk Recorder (VDR) running on this system.
# Syntax:
#
# IP-Address[/Netmask]
#

127.0.0.1             # always accept localhost
#192.168.100.0/24     # any host on the local net
#204.152.189.113      # a specific host
#0.0.0.0/0            # any host on any net (USE THIS WITH CARE!)

Der Vollständigkeit auch noch die vom Server (das letzte Mal am 12.06.2011 editiert):

#
# svdrphosts    This file describes a number of host addresses that
#               are allowed to connect to the SVDRP port of the Video
#               Disk Recorder (VDR) running on this system.
# Syntax:
#
# IP-Address[/Netmask]
#

127.0.0.1             # always accept localhost
#192.168.100.0/24     # any host on the local net
#204.152.189.113      # a specific host
0.0.0.0/0            # any host on any net (USE THIS WITH CARE!)

Grüße

Mane

Hallo machtnix,

am Client kann ichs zwar nicht nachvollziehen, aber ich habs am Client und am Server entsprechend geändert und beide VDR-Instanzen neu gestartet - leider das selbe Fehlerbild.

Was ich nicht verstehe wenn ich mir die Logs wieder anschaue, der Client baut ne Verbindung auf und diese wird vom Server akzeptiert (cube-1 ist der Client, hp der Server):

Aug 30 20:20:18 cube-1 vdr: [1994] Streamdev: Connected to server 172.16.0.21:2004 using capabilities TSPIDS,FILTERS,PRIO

Aug 30 20:20:18 cube-1 vdr: [1994] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 30 20:20:18 cube-1 vdr: [1994] cStreamdevDevice::OpenFilter: connect failed: Die Ressource ist zur Zeit nicht verfügbar
Aug 30 20:20:18 cube-1 vdr: [1994] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 30 20:20:18 cube-1 vdr: [1994] cStreamdevDevice::OpenFilter: connect failed: Die Ressource ist zur Zeit nicht verfügbar

Aug 30 20:20:18 hp vdr: [4970] Streamdev: Accepted new client (VTP) 172.16.0.121:41628

Aug 30 20:20:18 hp vdr: [4970] Streamdev: Setting data connection to 172.16.0.121:37537

Aug 30 20:20:18 hp vdr: [4974] streamdev-writer thread started (pid=4954, tid=4974, prio=high)

Aug 30 20:20:18 hp vdr: [4975] streamdev-filterstreaming thread started (pid=4954, tid=4975, prio=high)

Aug 30 20:20:18 hp vdr: [4970] Streamdev: Setting data connection to 172.16.0.121:46058

Aug 30 20:20:18 hp vdr: [4975] streamdev-filterstreaming thread ended (pid=4954, tid=4975)

Aug 30 20:20:18 hp vdr: [4974] streamdev-writer thread ended (pid=4954, tid=4974)

Aug 30 20:20:18 hp vdr: [4976] streamdev-writer thread started (pid=4954, tid=4976, prio=high)

Aug 30 20:20:18 hp vdr: [4977] streamdev-filterstreaming thread started (pid=4954, tid=4977, prio=high)

dann geht das Spiel 3 Sekunden weiter und endet in der letzten Sekunde mit:

Aug 30 20:20:21 cube-1 vdr: [1994] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 30 20:20:21 cube-1 vdr: [1994] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 30 20:20:21 cube-1 vdr: [2129] receiver on device 24 thread started (pid=1994, tid=2129)
Aug 30 20:20:21 cube-1 vdr: [2129] ERROR: Streamdev: Couldn't establish data connection to 172.16.0.21:2004: Die Ressource ist zur Zeit nicht verfügbar
Aug 30 20:20:21 cube-1 vdr: [2129] cStreamdevDevice::OpenDvrInt(): DVR connection FAILED
Aug 30 20:20:21 cube-1 vdr: [2129] receiver on device 24 thread ended (pid=1994, tid=2129)

Aug 30 20:20:21 hp vdr: [4998] streamdev-writer thread ended (pid=4954, tid=4998)

Aug 30 20:20:21 hp vdr: [5002] streamdev-writer thread started (pid=4954, tid=5002, prio=high)

Aug 30 20:20:21 hp vdr: [5004] receiver on device 1 thread started (pid=4954, tid=5004, prio=high)

Aug 30 20:20:21 hp vdr: [5003] streamdev-livestreaming thread started (pid=4954, tid=5003, prio=high)

Aug 30 20:20:21 hp vdr: [5005] TS buffer on device 1 thread started (pid=4954, tid=5005, prio=high)

Aug 30 20:20:21 hp vdr: [4970] Streamdev: Setting data connection to 172.16.0.121:51020

Aug 30 20:20:21 hp vdr: [5003] streamdev-livestreaming thread ended (pid=4954, tid=5003)

Aug 30 20:20:21 hp vdr: [5005] TS buffer on device 1 thread ended (pid=4954, tid=5005)

Aug 30 20:20:21 hp vdr: [5004] buffer stats: 564 (0%) used

Aug 30 20:20:21 hp vdr: [5004] receiver on device 1 thread ended (pid=4954, tid=5004)

Aug 30 20:20:21 hp vdr: [5002] streamdev-writer thread ended (pid=4954, tid=5002)

Aug 30 20:20:21 hp vdr: [5006] streamdev-writer thread started (pid=4954, tid=5006, prio=high)

Aug 30 20:20:21 hp vdr: [5007] streamdev-livestreaming thread started (pid=4954, tid=5007, prio=high)

Aug 30 20:20:21 hp vdr: [5008] receiver on device 1 thread started (pid=4954, tid=5008, prio=high)

Aug 30 20:20:21 hp vdr: [5009] TS buffer on device 1 thread started (pid=4954, tid=5009, prio=high)

Aug 30 20:20:21 hp vdr: [5006] ERROR: streamdev-server: couldn't send 69748 bytes: Connection reset by peer

Aug 30 20:20:21 hp vdr: [5006] streamdev-writer thread ended (pid=4954, tid=5006)

Aug 30 20:20:21 hp vdr: [4970] streamdev-server: closing VTP connection to 172.16.0.121:41628

Aug 30 20:20:21 hp vdr: [5009] TS buffer on device 1 thread ended (pid=4954, tid=5009)

Aug 30 20:20:21 hp vdr: [5007] streamdev-livestreaming thread ended (pid=4954, tid=5007)

Aug 30 20:20:21 hp vdr: [4970] buffer stats: 76328 (2%) used

Aug 30 20:20:21 hp vdr: [5008] buffer stats: 78960 (1%) used

Aug 30 20:20:21 hp vdr: [5008] receiver on device 1 thread ended (pid=4954, tid=5008)

Aug 30 20:20:22 hp vdr: [4981] streamdev-filterstreaming thread ended (pid=4954, tid=4981)

Aug 30 20:20:22 hp vdr: [4980] streamdev-writer thread ended (pid=4954, tid=4980)

Ich hab keinen Schimmer was da los ist.

Grüße

Manfred