search

Barracuda09 / SATPI

SATIP server for linux, suitable to run on an Raspberry Pi, Vu+, GigaBlue or any other linux box. currently supporting DVB-S/S2/T/C and transform DVB-S requests to DVB-C
http://barracuda09.github.io/SATPI
GNU General Public License v2.0
155 stars 32 forks source link

No picture with Sundtek SkyTV Ultimate Dual #127

Closed nikolauzi11 closed 2 years ago

nikolauzi11 commented 3 years ago

Hello, I would like to install a SATPI server in a VM. For this I have a Sundtek SkyTV Ultimate Dual USB Tuner passed through to the VM. SATPI is running, web interface is there, but I get no picture. I have a simple DiseqC 1.0 switch and for testing I use DVBviewer Lite. Can someone please help me to solve the problem?

log.txt

Thanks

nikolauzi11 commented 3 years ago

Hi @Barracuda09

This time without DMX_SET_SOURCE:smiley:

  Wed Apr  7 13:47:49.3837 2021  6  --- Starting SatPI version: 1.5.415~g8fe87fc ---
  Wed Apr  7 13:47:49.3837 2021  6  Number of processors online: 1
  Wed Apr  7 13:47:49.3838 2021  6  Default network buffer size: 104 KBytes
  Wed Apr  7 13:47:49.3838 2021  6  ens18: 192.168.112.66 [86:03:51:15:4f:89]
  Wed Apr  7 13:47:49.3838 2021  6  Current DVB_API_VERSION: 5.11
  Wed Apr  7 13:47:49.3838 2021  6  Enumerating all devices...
  Wed Apr  7 13:47:49.3839 2021  6  Detecting frontends in: /dev/dvb
  Wed Apr  7 13:47:49.3861 2021  6  Frontend Name: Sundtek DVB-S/S2 (VIII)
  Wed Apr  7 13:47:49.3862 2021  6  Frontend Type: Satellite (DVB-S2)
  Wed Apr  7 13:47:49.3862 2021  6  Frontend Type: Satellite (DVB-S)
  Wed Apr  7 13:47:49.3862 2021  6  Frontend Freq: 925000 Hz to 2175000 Hz
  Wed Apr  7 13:47:49.3862 2021  6  Frontend srat: 1000000 symbols/s to 45000000 symbols/s
  Wed Apr  7 13:47:49.3891 2021  6  Frontend Name: Sundtek DVB-S/S2 (VIII)
  Wed Apr  7 13:47:49.3892 2021  6  Frontend Type: Satellite (DVB-S2)
  Wed Apr  7 13:47:49.3892 2021  6  Frontend Type: Satellite (DVB-S)
  Wed Apr  7 13:47:49.3892 2021  6  Frontend Freq: 925000 Hz to 2175000 Hz
  Wed Apr  7 13:47:49.3892 2021  6  Frontend srat: 1000000 symbols/s to 45000000 symbols/s
  Wed Apr  7 13:47:49.3892 2021  6  Frontends found: 2
  Wed Apr  7 13:47:49.3892 2021  6  Setting up TS Reader using path: .
  Wed Apr  7 13:47:49.3893 2021  6  Setting up TS Streamer
  Wed Apr  7 13:47:49.3901 2021  6  Setting HTTP Port to: 8875
  Wed Apr  7 13:47:49.3901 2021  6  Setting RTSP Port to: 554
  Wed Apr  7 13:47:49.3901 2021  6  Setting WEB Path to: ./web
  Wed Apr  7 13:47:49.3901 2021  6  Setting App Data Path to: .
  Wed Apr  7 13:47:49.3914 2021  6  Setting up RTSP server
  Wed Apr  7 13:47:49.3914 2021  6  Setting up HTTP server
  Wed Apr  7 13:47:49.4027 2021  6  Setting up SSDP server with BOOTID: 2  annouce interval: 60 Sec
  Wed Apr  7 13:47:49.5941 2021  6  HTTP Connection from 192.168.112.61 Port 58566 with fd: 8
  Wed Apr  7 13:47:49.6386 2021  6  HTTP Connection from 192.168.112.61 Port 58564 with fd: 9
  Wed Apr  7 13:47:49.8908 2021  6  HTTP Connection from 192.168.112.61 Port 58565 with fd: 10
  Wed Apr  7 13:47:50.0009 2021  6  HTTP Connection from 192.168.112.61 Port 58567 with fd: 11
  Wed Apr  7 13:47:50.0014 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 13:47:50.0062 2021  6  HTTP Client 192.168.112.61:58567 Connection closed with fd: 11
  Wed Apr  7 13:47:50.3053 2021  6  HTTP Connection from 192.168.112.61 Port 58568 with fd: 11
  Wed Apr  7 13:47:50.3054 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 13:47:50.3120 2021  6  HTTP Client 192.168.112.61:58568 Connection closed with fd: 11
  Wed Apr  7 13:47:50.6122 2021  6  HTTP Connection from 192.168.112.61 Port 58569 with fd: 11
  Wed Apr  7 13:47:50.6125 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 13:47:50.6188 2021  6  HTTP Client 192.168.112.61:58569 Connection closed with fd: 11
  Wed Apr  7 13:47:54.6412 2021  6  HTTP Client 192.168.112.61:58564 Connection closed with fd: 9
  Wed Apr  7 13:47:55.6472 2021  6  HTTP Client 192.168.112.61:58565 Connection closed with fd: 10
  Wed Apr  7 13:48:05.2987 2021  6  RTSP Connection from 192.168.112.61 Port 58573 with fd: 9
  Wed Apr  7 13:48:05.2987 2021  7  RTSP Stream data from client None with IP 192.168.112.61 on Port 58573: OPTIONS rtsp://satip:554/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&plts=on&sr=22000&fec=23&pids=0,17,18,6100,6110,6120,6130 RTSP/1.0
  Wed Apr  7 13:48:05.2987 2021  7  CSeq: 2
  Wed Apr  7 13:48:05.2987 2021  7  User-Agent: LibVLC/3.0.12 (LIVE555 Streaming Media v2016.11.28)
  Wed Apr  7 13:48:05.2987 2021  7  --- LINE END ---
  Wed Apr  7 13:48:05.2988 2021  7  RTSP/1.0 200 OK
  Wed Apr  7 13:48:05.2988 2021  7  CSeq: 2
  Wed Apr  7 13:48:05.2988 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Wed Apr  7 13:48:05.2988 2021  7  --- LINE END ---
  Wed Apr  7 13:48:05.3036 2021  7  RTSP Stream data from client None with IP 192.168.112.61 on Port 58573: DESCRIBE rtsp://satip:554/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&plts=on&sr=22000&fec=23&pids=0,17,18,6100,6110,6120,6130 RTSP/1.0
  Wed Apr  7 13:48:05.3036 2021  7  CSeq: 3
  Wed Apr  7 13:48:05.3036 2021  7  User-Agent: LibVLC/3.0.12 (LIVE555 Streaming Media v2016.11.28)
  Wed Apr  7 13:48:05.3036 2021  7  Accept: application/sdp
  Wed Apr  7 13:48:05.3036 2021  7  --- LINE END ---
  Wed Apr  7 13:48:05.3036 2021  7  RTSP/1.0 404 Not Found
  Wed Apr  7 13:48:05.3036 2021  7  CSeq: 3
  Wed Apr  7 13:48:05.3036 2021  7  Content-Type: application/sdp
  Wed Apr  7 13:48:05.3036 2021  7  Content-Base: rtsp://192.168.112.66/
  Wed Apr  7 13:48:05.3036 2021  7  Content-Length: 0
  Wed Apr  7 13:48:05.3036 2021  7  --- LINE END ---
  Wed Apr  7 13:48:05.3084 2021  6  RTSP Client 192.168.112.61:58573 Connection closed with fd: 9
  Wed Apr  7 13:48:05.3110 2021  6  RTSP Connection from 192.168.112.61 Port 58574 with fd: 9
  Wed Apr  7 13:48:05.3146 2021  7  RTSP Stream data from client None with IP 192.168.112.61 on Port 58574: SETUP rtsp://satip:554/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&plts=on&sr=22000&fec=23&pids=0,17,18,6100,6110,6120,6130 RTSP/1.0
  Wed Apr  7 13:48:05.3146 2021  7  CSeq: 0
  Wed Apr  7 13:48:05.3146 2021  7  Transport: RTP/AVP;unicast;client_port=9376-9377
  Wed Apr  7 13:48:05.3146 2021  7  --- LINE END ---
  Wed Apr  7 13:48:05.3147 2021  6  Found StreamID x - SessionID: 0277394281
  Wed Apr  7 13:48:05.3147 2021  6  Stream: 0, StreamClient[0] with SessionID 0277394281 for dvbs2
  Wed Apr  7 13:48:05.3147 2021  6  Stream: 0, Parsing transport parameters...
  Wed Apr  7 13:48:05.3147 2021  6  Stream: 0, New frequency requested, clearing old channel data...
  Wed Apr  7 13:48:05.3148 2021  7  Stream: 0, Parsing transport parameters (Finished)
  Wed Apr  7 13:48:05.3148 2021  7  Stream: 0, Found Streaming type: RTSP Unicast
  Wed Apr  7 13:48:05.3148 2021  6  Stream: 0, Updating frontend...
  Wed Apr  7 13:48:06.5252 2021  6  Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Read/Write with fd: 11
  Wed Apr  7 13:48:06.5504 2021  6  Stream: 0, Start tuning process for DVB-S(2)...
  Wed Apr  7 13:48:06.5504 2021  6  Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Writing DiSEqC command with fd: 11
  Wed Apr  7 13:48:06.5939 2021  6  Stream: 0, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
  Wed Apr  7 13:48:06.9430 2021  7  Stream: 0, Set Properties: Frequency 1612000
  Wed Apr  7 13:48:07.3796 2021  6  Stream: 0, Waiting on lock...
  Wed Apr  7 13:48:07.6581 2021  6  Stream: 0, Tuned and locked (FE status 0x1F)
  Wed Apr  7 13:48:07.6581 2021  6  Stream: 0, Updating PID filters...
  Wed Apr  7 13:48:07.7704 2021  6  Stream: 0, Set DMX buffer size to 18874368 Bytes
  Wed Apr  7 13:48:07.7998 2021  6  Stream: 0, Opened /dev/dvb/adapter0/demux0 fd: 13
  Wed Apr  7 13:48:07.7998 2021  7  Stream: 0, Set filter PID: 0000
  Wed Apr  7 13:48:07.7998 2021  7  Stream: 0, Set filter PID: 0001
  Wed Apr  7 13:48:07.7998 2021  7  Stream: 0, Set filter PID: 0016
  Wed Apr  7 13:48:07.7998 2021  7  Stream: 0, Set filter PID: 0017
  Wed Apr  7 13:48:07.7998 2021  7  Stream: 0, Set filter PID: 0018
  Wed Apr  7 13:48:07.8001 2021  7  Stream: 0, Set filter PID: 6100
  Wed Apr  7 13:48:07.8001 2021  7  Stream: 0, Set filter PID: 6110
  Wed Apr  7 13:48:07.8001 2021  7  Stream: 0, Set filter PID: 6120
  Wed Apr  7 13:48:07.8002 2021  7  Stream: 0, Set filter PID: 6130
  Wed Apr  7 13:48:07.8003 2021  7  Stream: 0, Updating frontend (Finished)
  Wed Apr  7 13:48:07.8003 2021  6  Stream: 0, RTP/UDP set network buffer size: 2080 KBytes
  Wed Apr  7 13:48:07.8003 2021  6  Stream: 0, Start RTCP/UDP stream to 192.168.112.61:9377
  Wed Apr  7 13:48:07.8003 2021  6  Stream: 0, Start RTP/UDP stream to 192.168.112.61:9376
  Wed Apr  7 13:48:07.8003 2021  7  RTSP/1.0 200 OK
  Wed Apr  7 13:48:07.8003 2021  7  CSeq: 0
  Wed Apr  7 13:48:07.8003 2021  7  Session: 0277394281;timeout=60
  Wed Apr  7 13:48:07.8003 2021  7  Transport: RTP/AVP;unicast;client_ip=192.168.112.61;client_port=9376-9377
  Wed Apr  7 13:48:07.8003 2021  7  com.ses.streamID: 0
  Wed Apr  7 13:48:07.8003 2021  7  --- LINE END ---
  Wed Apr  7 13:48:07.8535 2021  7  RTSP Stream data from client None with IP 192.168.112.61 on Port 58574: PLAY rtsp://satip:554/stream=0 RTSP/1.0
  Wed Apr  7 13:48:07.8535 2021  7  CSeq: 1
  Wed Apr  7 13:48:07.8535 2021  7  Session: 0277394281
  Wed Apr  7 13:48:07.8535 2021  7  --- LINE END ---
  Wed Apr  7 13:48:07.8535 2021  6  Found StreamID 0 - SessionID 0277394281
  Wed Apr  7 13:48:07.8535 2021  6  Stream: 0, StreamClient[0] with SessionID 0277394281
  Wed Apr  7 13:48:07.8535 2021  6  Stream: 0, Updating frontend...
  Wed Apr  7 13:48:07.8535 2021  7  Stream: 0, Updating frontend (Finished)
  Wed Apr  7 13:48:07.8535 2021  7  RTSP/1.0 200 OK
  Wed Apr  7 13:48:07.8535 2021  7  RTP-Info: url=rtsp://192.168.112.66/stream=0
  Wed Apr  7 13:48:07.8535 2021  7  CSeq: 1
  Wed Apr  7 13:48:07.8535 2021  7  Session: 0277394281
  Wed Apr  7 13:48:07.8535 2021  7  Range: npt=0.000-
  Wed Apr  7 13:48:07.8535 2021  7  --- LINE END ---
  Wed Apr  7 13:48:08.4019 2021  6  Stream: 0, PAT - PID 0000: sectionLength: 21  tableDataSize: 188  secNr: 0  lastSecNr: 0  currSecNr: 0
  Wed Apr  7 13:48:08.4019 2021  6  Stream: 0, PAT: Section Length: 21  TID: 1011  Version: 193  secNr: 0 lastSecNr: 0  CRC: 0x47179A1A
  Wed Apr  7 13:48:08.4019 2021  6  Stream: 0, PAT: Prog NR: 0x0000 - 00000  NIT PID: 0016
  Wed Apr  7 13:48:08.4019 2021  6  Stream: 0, PAT: Prog NR: 0x2B66 - 11110  PMT PID: 6100
  Wed Apr  7 13:48:08.4019 2021  6  Stream: 0, PAT: Prog NR: 0x2B7A - 11130  PMT PID: 6300
  Wed Apr  7 13:48:50.2133 2021  6  HTTP Connection from 192.168.112.61 Port 58583 with fd: 16
  Wed Apr  7 13:48:50.2135 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 13:48:50.2189 2021  6  HTTP Client 192.168.112.61:58583 Connection closed with fd: 16
  Wed Apr  7 13:48:50.5191 2021  6  HTTP Connection from 192.168.112.61 Port 58584 with fd: 16
  Wed Apr  7 13:48:50.5199 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 13:48:50.5247 2021  6  HTTP Client 192.168.112.61:58584 Connection closed with fd: 16
2021-04-07 13:47:44 [1470] Starting up Multimedia Framework (Apr  7 2021 11:16:49)
2021-04-07 13:47:44 [1470] Semaphore exists, removing and reallocating it
2021-04-07 13:47:44 [1470] Detected DVB version.h
2021-04-07 13:47:44 [1470] API Version: 5.11
2021-04-07 13:47:44 [1470] Running on Linux (5.4.0-70-generic)
2021-04-07 13:47:44 [1470] Detected: GenuineIntel
2021-04-07 13:47:44 [1470] This CPU supports: MMX, SSE, SSE2
2021-04-07 13:47:44 [1470] scanning devices
2021-04-07 13:47:44 [1470] 
2021-04-07 13:47:44 [1470] Scanning for drivers
2021-04-07 13:47:44 [1470] found lib: libdrv_fm_dab_dabplus.so
2021-04-07 13:47:44 [1470] found lib: libdrv_tntdvb.so
2021-04-07 13:47:44 [1470] found lib: libdrv_net.so
2021-04-07 13:47:44 [1470] found lib: libdrv_fm.so
2021-04-07 13:47:44 [1470] found lib: libdrv_hikarisoft_isdb.so
2021-04-07 13:47:44 [1470] found lib: libdrv_ngTV.so
2021-04-07 13:47:44 [1470] found lib: libdrv_eLight.so
2021-04-07 13:47:44 [1470] found lib: libdrv_vivi.so
2021-04-07 13:47:44 [1470] found lib: libdrv_em28xx.so
2021-04-07 13:47:44 [1470] 
2021-04-07 13:47:44 [1470] Scanning for plugins
2021-04-07 13:47:44 [1470] found lib: libencoder_plugin.so
2021-04-07 13:47:44 [1470] MediaAVPlugin: MPEG Encoder
2021-04-07 13:47:44 [1470] Copyright: (C) Tpe 2011/2012
2021-04-07 13:47:44 [1470] 
2021-04-07 13:47:44 [1470] Starting up device manager
2021-04-07 13:47:44 [1471] Starting service processor (PID 1471)
2021-04-07 13:47:44 [1470] scanning devices done
2021-04-07 13:47:44 [1470] attached devices:
2021-04-07 13:47:44 [1471] Autostarting scripts in /etc/sundtek/
2021-04-07 13:47:44 [1471] executed all available items
2021-04-07 13:47:44 [1470] registering ID: 0
2021-04-07 13:47:44 [1470] Infrared Control Support is disabled in configuration file
2021-04-07 13:47:44 [1470] Memory mapped transfers are not available
2021-04-07 13:47:44 [1470] Board config found: Sundtek SkyTV Dual 8 (eLight)
2021-04-07 13:47:44 [1470] This board provides 2 frontends
2021-04-07 13:47:44 [1470] 
2021-04-07 13:47:44 [1470] *********
2021-04-07 13:47:44 [1470] Signature: Sundtek
2021-04-07 13:47:44 [1470] Initializing SYSV-IPC
2021-04-07 13:47:44 [1470] Allocation using pg for type 65678
2021-04-07 13:47:44 [1470] Allocated Shared memory buffer: 0x7f94e1299000
2021-04-07 13:47:46 [1470] demodulator successfully attached (DVB_S/S2)!
2021-04-07 13:47:46 [1470] attaching second tuner...
2021-04-07 13:47:46 [1470] Allocation using pg for type 65678
2021-04-07 13:47:46 [1470] Allocated Shared memory buffer: 0x7f94e0f03000
2021-04-07 13:47:47 [1470] demodulator successfully attached (DVB_S/S2)!
2021-04-07 13:47:47 [1470] Configuring Dual LNB Power Supply
2021-04-07 13:47:47 [1470] Vertical Polarisation is set to 14.00 Volt
2021-04-07 13:47:47 [1470] Horizontal Polarisation is set to 19.10 Volt
2021-04-07 13:47:47 [1470] Enabling LNB status monitor
2021-04-07 13:47:48 [1470] Using Sundtek remote control layout
2021-04-07 13:47:48 [1470] 
2021-04-07 13:47:48 [1470] IR Setup
2021-04-07 13:47:48 [1470] registered virtual: /dev/mediainput0
2021-04-07 13:47:48 [1470] registering: adapter0/0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter0/frontend0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter0/demux0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter0/dvr0
2021-04-07 13:47:48 [1470] registering: adapter1/0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter1/frontend0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter1/demux0
2021-04-07 13:47:48 [1470] registered virtual: /dev/dvb/adapter1/dvr0
2021-04-07 13:47:48 [1470] Driver loaded within 3664 milliseconds
2021-04-07 13:47:48 [1483] RC: IR Event /dev/input/event4
2021-04-07 13:47:48 [1493] RC: IR Event /dev/input/event4
2021-04-07 13:47:51 [1470] Initial devicescan done, switching detection mode
2021-04-07 13:48:04 [1470] Enabling Standby
2021-04-07 13:48:04 [1470] Enabling Standby
2021-04-07 13:48:05 [1470] Waking up from standby
2021-04-07 13:48:06 [1470] Set Voltage off
2021-04-07 13:48:06 [1470] Disabling High Tone (22khz)
2021-04-07 13:48:06 [1470] Set Voltage 18V
2021-04-07 13:48:06 [1470] DISEQC> sending commands:
2021-04-07 13:48:06 [1470] DISEQC> e0
2021-04-07 13:48:06 [1470] DISEQC> 10
2021-04-07 13:48:06 [1470] DISEQC> 38
2021-04-07 13:48:06 [1470] DISEQC> f2
2021-04-07 13:48:06 [1470] DISEQC> done
2021-04-07 13:48:06 [1470] Disabling High Tone (22khz)
2021-04-07 13:48:06 [1470] Diseqc execution time: 116 ms
2021-04-07 13:48:06 [1470] Disabling High Tone (22khz)
2021-04-07 13:48:06 [1470] diseqc send burst Unmodulated (SEC_MINI_A)
2021-04-07 13:48:06 [1470] Disabling High Tone (22khz)
2021-04-07 13:48:06 [1470] Disabling High Tone (22khz)
2021-04-07 13:48:06 [1470] Setting Frequency: 1612000
2021-04-07 13:48:06 [1470] Setting DVB-S2
2021-04-07 13:48:06 [1470] Frequency: 1612
2021-04-07 13:48:06 [1470] Symbolrate: 22000
2021-04-07 13:48:07 [1470] Frontend has locked
2021-04-07 13:48:07 [1470] INIT_DTV: 0
2021-04-07 13:48:07 [1470] Starting transfer
2021-04-07 13:48:07 [1470] TS Sync byte not aligned, realigning stream (0 // 0 // 3d // FEID: 0)
2021-04-07 13:48:07 [1470] TS Sync byte not aligned, realigning stream (279 // 0 // d6 // FEID: 0)
Barracuda09 commented 3 years ago

And if you stop the stream what are the PID showing? (edit: : In the log of SatPI)

nikolauzi11 commented 3 years ago

Hi @Barracuda09 


  Wed Apr  7 14:05:03.9523 2021  7  --- LINE END ---
  Wed Apr  7 14:05:04.5157 2021  6  Stream: 0, PAT - PID 0000: sectionLength: 21  tableDataSize: 188  secNr: 0  lastSecNr: 0  currSecNr: 0
  Wed Apr  7 14:05:04.5157 2021  6  Stream: 0, PAT: Section Length: 21  TID: 1011  Version: 193  secNr: 0 lastSecNr: 0  CRC: 0x47179A1A
  Wed Apr  7 14:05:04.5157 2021  6  Stream: 0, PAT: Prog NR: 0x0000 - 00000  NIT PID: 0016
  Wed Apr  7 14:05:04.5157 2021  6  Stream: 0, PAT: Prog NR: 0x2B66 - 11110  PMT PID: 6100
  Wed Apr  7 14:05:04.5157 2021  6  Stream: 0, PAT: Prog NR: 0x2B7A - 11130  PMT PID: 6300
  Wed Apr  7 14:05:06.1896 2021  6  HTTP Connection from 192.168.112.61 Port 58832 with fd: 16
  Wed Apr  7 14:05:06.1897 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 14:05:06.1958 2021  6  HTTP Client 192.168.112.61:58832 Connection closed with fd: 16
  Wed Apr  7 14:05:06.4985 2021  6  HTTP Connection from 192.168.112.61 Port 58833 with fd: 16
  Wed Apr  7 14:05:06.4986 2021  7  Client: 192.168.112.61 requested desc.xml
  Wed Apr  7 14:05:06.5038 2021  6  HTTP Client 192.168.112.61:58833 Connection closed with fd: 16
  Wed Apr  7 14:05:24.1223 2021  7  RTSP Stream data from client None with IP 192.168.112.61 on Port 58831: TEARDOWN rtsp://satip:554/stream=0 RTSP/1.0
  Wed Apr  7 14:05:24.1223 2021  7  CSeq: 2
  Wed Apr  7 14:05:24.1223 2021  7  Session: 0270023721
  Wed Apr  7 14:05:24.1223 2021  7  --- LINE END ---
  Wed Apr  7 14:05:24.1223 2021  6  Found StreamID 0 - SessionID 0270023721
  Wed Apr  7 14:05:24.1223 2021  6  Stream: 0, StreamClient[0] with SessionID 0270023721
  Wed Apr  7 14:05:24.1223 2021  6  Stream: 0, Teardown StreamClient[0] with SessionID 0270023721
  Wed Apr  7 14:05:24.2224 2021  6  Stream: 0, Destroy RTP/UDP stream to 192.168.112.61:9086
  Wed Apr  7 14:05:24.5227 2021  6  Stream: 0, Destroy RTCP/UDP stream to 192.168.112.61:9087
  Wed Apr  7 14:05:24.5228 2021  7  Stream: 0, Remove filter PID: 0000 - Packet Count: 203
  Wed Apr  7 14:05:24.5228 2021  7  Stream: 0, Remove filter PID: 0001 - Packet Count: 0
  Wed Apr  7 14:05:24.5228 2021  7  Stream: 0, Remove filter PID: 0016 - Packet Count: 0
  Wed Apr  7 14:05:24.5228 2021  7  Stream: 0, Remove filter PID: 0017 - Packet Count: 0
  Wed Apr  7 14:05:24.5228 2021  7  Stream: 0, Remove filter PID: 0018 - Packet Count: 0
  Wed Apr  7 14:05:24.5231 2021  7  Stream: 0, Remove filter PID: 6100 - Packet Count: 0 - PMT
  Wed Apr  7 14:05:24.5231 2021  7  Stream: 0, Remove filter PID: 6110 - Packet Count: 0
  Wed Apr  7 14:05:24.5231 2021  7  Stream: 0, Remove filter PID: 6120 - Packet Count: 0
  Wed Apr  7 14:05:24.5231 2021  7  Stream: 0, Remove filter PID: 6130 - Packet Count: 0
  Wed Apr  7 14:05:24.5232 2021  6  Stream: 0, Closing /dev/dvb/adapter0/frontend0 fd: 11
  Wed Apr  7 14:05:24.5232 2021  6  Stream: 0, Closing /dev/dvb/adapter0/demux0 fd: 13
  Wed Apr  7 14:05:24.5233 2021  7  RTSP/1.0 200 OK
  Wed Apr  7 14:05:24.5233 2021  7  CSeq: 2
  Wed Apr  7 14:05:24.5233 2021  7  Session: 0270023721
  Wed Apr  7 14:05:24.5233 2021  7  --- LINE END ---```
Barracuda09 commented 3 years ago

Hi @nikolauzi11

Thanks for your effort.

So it seems that at the moment only PID 0000 is receiving data. And maybe the rest is not added (in the driver?) to the PES-filters with DMX_ADD_PID?

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Does this mean that Sundtek has to work on the driver again?

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I'm afraid so, but I'm not 100% sure. The PID 0000 data is received by SatPI via the 'new' method. but for some reason the rest of the PIDS are not passed to SatPI

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Good news! Sundtek support was just remote on my machine and fixed the DMX_ADD_PID feature. He said that it was forgotten because no one else was using it. Anyway, SatPi now works with VLC and DMX_ADD_PID comes back in the official driver. I still have to test with the VDR, but unfortunately I don't have time today. I'll get back to you tomorrow.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Great that they could fix it that quick.

Well I used the more 'used' (or historical) method before, that is why the old version worked. But this method is way easier in setting up PES-Filters and reading data.

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Now that it works fine with VLC, with the VDR unfortunately it does not work yet.

  Thu Apr  8 11:34:19.5565 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:19.5565 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:19.5565 2021  7  Location: 
  Thu Apr  8 11:34:19.5565 2021  7  CSeq: 2
  Thu Apr  8 11:34:19.5565 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:19.5565 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:19.5565 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.5569 2021  6  RTSP Client 192.168.112.26:39078 Connection closed with fd: 10
  Thu Apr  8 11:34:19.8079 2021  6  RTSP Connection from 192.168.112.26 Port 39080 with fd: 10
  Thu Apr  8 11:34:19.8080 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39080: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:19.8080 2021  7  CSeq: 1
  Thu Apr  8 11:34:19.8080 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:19.8080 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.8080 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:19.8080 2021  7  CSeq: 1
  Thu Apr  8 11:34:19.8080 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:19.8080 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.8085 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39080: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:19.8085 2021  7  CSeq: 2
  Thu Apr  8 11:34:19.8085 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:19.8085 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:19.8085 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.8085 2021  6  Found StreamID x - SessionID: 0267341282
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:19.8085 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:19.8085 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:19.8085 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:19.8085 2021  7  Location: 
  Thu Apr  8 11:34:19.8085 2021  7  CSeq: 2
  Thu Apr  8 11:34:19.8085 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:19.8085 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:19.8085 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.8091 2021  6  RTSP Client 192.168.112.26:39080 Connection closed with fd: 10
  Thu Apr  8 11:34:20.0597 2021  6  RTSP Connection from 192.168.112.26 Port 39082 with fd: 10
  Thu Apr  8 11:34:20.0598 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39082: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:20.0598 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.0598 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.0598 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.0598 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:20.0598 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.0598 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:20.0598 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.0603 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39082: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:20.0603 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.0603 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:20.0603 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.0603 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.0603 2021  6  Found StreamID x - SessionID: 0271447621
  Thu Apr  8 11:34:20.0603 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.0603 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.0603 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.0603 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.0603 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:20.0603 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:20.0603 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:20.0603 2021  7  Location: 
  Thu Apr  8 11:34:20.0603 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.0603 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:20.0603 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:20.0603 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.0607 2021  6  RTSP Client 192.168.112.26:39082 Connection closed with fd: 10
  Thu Apr  8 11:34:20.3115 2021  6  RTSP Connection from 192.168.112.26 Port 39084 with fd: 10
  Thu Apr  8 11:34:20.3116 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39084: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:20.3116 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.3116 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.3116 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.3116 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:20.3116 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.3116 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:20.3116 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.3121 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39084: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:20.3121 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.3121 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:20.3121 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.3121 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.3121 2021  6  Found StreamID x - SessionID: 0251087744
  Thu Apr  8 11:34:20.3121 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.3121 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.3121 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.3121 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.3121 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:20.3121 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:20.3121 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:20.3121 2021  7  Location: 
  Thu Apr  8 11:34:20.3121 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.3121 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:20.3121 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:20.3121 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.3125 2021  6  RTSP Client 192.168.112.26:39084 Connection closed with fd: 10
  Thu Apr  8 11:34:20.5634 2021  6  RTSP Connection from 192.168.112.26 Port 39086 with fd: 10
  Thu Apr  8 11:34:20.5634 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39086: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:20.5634 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.5634 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.5634 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.5634 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:20.5634 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.5634 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:20.5634 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.5639 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39086: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:20.5639 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.5639 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:20.5639 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.5639 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.5640 2021  6  Found StreamID x - SessionID: 0305139185
  Thu Apr  8 11:34:20.5640 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.5640 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.5640 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.5640 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.5640 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:20.5640 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:20.5640 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:20.5640 2021  7  Location: 
  Thu Apr  8 11:34:20.5640 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.5640 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:20.5640 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:20.5640 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.5644 2021  6  RTSP Client 192.168.112.26:39086 Connection closed with fd: 10
  Thu Apr  8 11:34:20.8152 2021  6  RTSP Connection from 192.168.112.26 Port 39088 with fd: 10
  Thu Apr  8 11:34:20.8153 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39088: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:20.8153 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.8153 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.8153 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.8153 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:20.8153 2021  7  CSeq: 1
  Thu Apr  8 11:34:20.8153 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:20.8153 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.8159 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39088: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:20.8159 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.8159 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:20.8159 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:20.8159 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.8159 2021  6  Found StreamID x - SessionID: 0282635283
  Thu Apr  8 11:34:20.8159 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.8159 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:20.8159 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.8159 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:20.8159 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:20.8159 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:20.8159 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:20.8159 2021  7  Location: 
  Thu Apr  8 11:34:20.8159 2021  7  CSeq: 2
  Thu Apr  8 11:34:20.8159 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:20.8159 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:20.8159 2021  7  --- LINE END ---
  Thu Apr  8 11:34:20.8164 2021  6  RTSP Client 192.168.112.26:39088 Connection closed with fd: 10
  Thu Apr  8 11:34:21.0673 2021  6  RTSP Connection from 192.168.112.26 Port 39090 with fd: 10
  Thu Apr  8 11:34:21.0674 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39090: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:21.0674 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.0674 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.0674 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.0674 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:21.0674 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.0674 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:21.0674 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.0678 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39090: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:21.0678 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.0678 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:21.0678 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.0678 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.0678 2021  6  Found StreamID x - SessionID: 0293641279
  Thu Apr  8 11:34:21.0678 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.0678 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.0678 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.0678 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.0678 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:21.0678 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:21.0678 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:21.0678 2021  7  Location: 
  Thu Apr  8 11:34:21.0678 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.0678 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:21.0678 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:21.0678 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.0682 2021  6  RTSP Client 192.168.112.26:39090 Connection closed with fd: 10
  Thu Apr  8 11:34:21.3191 2021  6  RTSP Connection from 192.168.112.26 Port 39092 with fd: 10
  Thu Apr  8 11:34:21.3191 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39092: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:21.3191 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.3191 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.3191 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.3191 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:21.3191 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.3191 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:21.3191 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.3196 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39092: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:21.3196 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.3196 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:21.3196 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.3196 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.3196 2021  6  Found StreamID x - SessionID: 0259081472
  Thu Apr  8 11:34:21.3196 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.3196 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.3196 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.3196 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.3196 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:21.3196 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:21.3196 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:21.3196 2021  7  Location: 
  Thu Apr  8 11:34:21.3196 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.3196 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:21.3196 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:21.3196 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.3201 2021  6  RTSP Client 192.168.112.26:39092 Connection closed with fd: 10
  Thu Apr  8 11:34:21.5708 2021  6  RTSP Connection from 192.168.112.26 Port 39094 with fd: 10
  Thu Apr  8 11:34:21.5708 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39094: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:21.5708 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.5708 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.5708 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.5709 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:21.5709 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.5709 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:21.5709 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.5713 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39094: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:21.5713 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.5713 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:21.5713 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.5713 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.5713 2021  6  Found StreamID x - SessionID: 0249479403
  Thu Apr  8 11:34:21.5713 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.5713 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.5713 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.5713 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.5713 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:21.5713 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:21.5713 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:21.5713 2021  7  Location: 
  Thu Apr  8 11:34:21.5713 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.5713 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:21.5713 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:21.5713 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.5717 2021  6  RTSP Client 192.168.112.26:39094 Connection closed with fd: 10
  Thu Apr  8 11:34:21.8226 2021  6  RTSP Connection from 192.168.112.26 Port 39136 with fd: 10
  Thu Apr  8 11:34:21.8227 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39136: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:21.8227 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.8227 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.8227 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.8227 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:21.8227 2021  7  CSeq: 1
  Thu Apr  8 11:34:21.8227 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:21.8227 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.8232 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39136: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:21.8232 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.8232 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:21.8232 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:21.8232 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.8232 2021  6  Found StreamID x - SessionID: 0248859388
  Thu Apr  8 11:34:21.8232 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.8232 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:21.8232 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.8232 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:21.8232 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:21.8232 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:21.8232 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:21.8232 2021  7  Location: 
  Thu Apr  8 11:34:21.8232 2021  7  CSeq: 2
  Thu Apr  8 11:34:21.8232 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:21.8232 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:21.8232 2021  7  --- LINE END ---
  Thu Apr  8 11:34:21.8237 2021  6  RTSP Client 192.168.112.26:39136 Connection closed with fd: 10
  Thu Apr  8 11:34:22.0745 2021  6  RTSP Connection from 192.168.112.26 Port 39138 with fd: 10
  Thu Apr  8 11:34:22.0746 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39138: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:22.0746 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.0746 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.0746 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.0746 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:22.0746 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.0746 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:22.0746 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.0751 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39138: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:22.0751 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.0751 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:22.0751 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.0751 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.0751 2021  6  Found StreamID x - SessionID: 0272715873
  Thu Apr  8 11:34:22.0751 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.0751 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.0751 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.0751 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.0751 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:22.0751 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:22.0751 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:22.0751 2021  7  Location: 
  Thu Apr  8 11:34:22.0751 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.0751 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:22.0751 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:22.0751 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.0755 2021  6  RTSP Client 192.168.112.26:39138 Connection closed with fd: 10
  Thu Apr  8 11:34:22.3264 2021  6  RTSP Connection from 192.168.112.26 Port 39140 with fd: 10
  Thu Apr  8 11:34:22.3264 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39140: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:22.3264 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.3264 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.3264 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.3265 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:22.3265 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.3265 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:22.3265 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.3270 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39140: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:22.3270 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.3270 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:22.3270 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.3270 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.3270 2021  6  Found StreamID x - SessionID: 0282832363
  Thu Apr  8 11:34:22.3270 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.3270 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.3270 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.3270 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.3270 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:22.3270 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:22.3270 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:22.3270 2021  7  Location: 
  Thu Apr  8 11:34:22.3270 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.3270 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:22.3270 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:22.3270 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.3274 2021  6  RTSP Client 192.168.112.26:39140 Connection closed with fd: 10
  Thu Apr  8 11:34:22.5782 2021  6  RTSP Connection from 192.168.112.26 Port 39142 with fd: 10
  Thu Apr  8 11:34:22.5783 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39142: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:22.5783 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.5783 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.5783 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.5783 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:22.5783 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.5783 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:22.5783 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.5787 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39142: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:22.5787 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.5787 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:22.5787 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.5787 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.5788 2021  6  Found StreamID x - SessionID: 0300809798
  Thu Apr  8 11:34:22.5788 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.5788 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.5788 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.5788 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.5788 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:22.5788 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:22.5788 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:22.5788 2021  7  Location: 
  Thu Apr  8 11:34:22.5788 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.5788 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:22.5788 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:22.5788 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.5791 2021  6  RTSP Client 192.168.112.26:39142 Connection closed with fd: 10
  Thu Apr  8 11:34:22.8300 2021  6  RTSP Connection from 192.168.112.26 Port 39144 with fd: 10
  Thu Apr  8 11:34:22.8300 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39144: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:22.8300 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.8300 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.8300 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.8300 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:22.8300 2021  7  CSeq: 1
  Thu Apr  8 11:34:22.8300 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:22.8300 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.8305 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39144: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:22.8305 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.8305 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:22.8305 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:22.8305 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.8305 2021  6  Found StreamID x - SessionID: 0216031197
  Thu Apr  8 11:34:22.8305 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.8305 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:22.8305 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.8305 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:22.8305 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:22.8305 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:22.8305 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:22.8305 2021  7  Location: 
  Thu Apr  8 11:34:22.8305 2021  7  CSeq: 2
  Thu Apr  8 11:34:22.8305 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:22.8305 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:22.8305 2021  7  --- LINE END ---
  Thu Apr  8 11:34:22.8309 2021  6  RTSP Client 192.168.112.26:39144 Connection closed with fd: 10
  Thu Apr  8 11:34:23.0818 2021  6  RTSP Connection from 192.168.112.26 Port 39146 with fd: 10
  Thu Apr  8 11:34:23.0819 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39146: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
  Thu Apr  8 11:34:23.0819 2021  7  CSeq: 1
  Thu Apr  8 11:34:23.0819 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:23.0819 2021  7  --- LINE END ---
  Thu Apr  8 11:34:23.0819 2021  7  RTSP/1.0 200 OK
  Thu Apr  8 11:34:23.0819 2021  7  CSeq: 1
  Thu Apr  8 11:34:23.0819 2021  7  Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
  Thu Apr  8 11:34:23.0819 2021  7  --- LINE END ---
  Thu Apr  8 11:34:23.0824 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39146: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:23.0824 2021  7  CSeq: 2
  Thu Apr  8 11:34:23.0824 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:23.0824 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:23.0824 2021  7  --- LINE END ---
  Thu Apr  8 11:34:23.0824 2021  6  Found StreamID x - SessionID: 0288386067
  Thu Apr  8 11:34:23.0824 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:23.0824 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:23.0824 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:23.0824 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:23.0824 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:23.0824 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:23.0824 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:23.0824 2021  7  Location: 
  Thu Apr  8 11:34:23.0824 2021  7  CSeq: 2
  Thu Apr  8 11:34:23.0824 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:23.0824 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:23.0824 2021  7  --- LINE END ---
  Thu Apr  8 11:34:23.0829 2021  6  RTSP Client 192.168.112.26:39146 Connection closed with fd: 10

VDR:

Apr  8 11:35:31 vdr6 vdr: [1412] SATIP-ERROR: Connect failed [device 0]
Apr  8 11:35:31 vdr6 vdr: [1415] SATIP-ERROR: Connect failed [device 1]
Apr  8 11:35:31 vdr6 vdr: [1415] SATIP-ERROR: Detected invalid status code 503: rtsp://192.168.112.66/ [device 1]
Apr  8 11:35:31 vdr6 vdr: [1415] SATIP-ERROR: Connect failed [device 1]
Apr  8 11:35:31 vdr6 vdr: [1412] SATIP-ERROR: Detected invalid status code 503: rtsp://192.168.112.66/ [device 0]
Apr  8 11:35:31 vdr6 vdr: [1412] SATIP-ERROR: Connect failed [device 0]
Barracuda09 commented 3 years ago

Hi @nikolauzi11

Something went wrong before this:

Thu Apr  8 11:34:19.8085 2021  7  RTSP Stream data from client None with IP 192.168.112.26 on Port 39080: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
  Thu Apr  8 11:34:19.8085 2021  7  CSeq: 2
  Thu Apr  8 11:34:19.8085 2021  7  Transport: RTP/AVP;unicast;client_port=35032-35033
  Thu Apr  8 11:34:19.8085 2021  7  User-Agent: vdr-satip/2.4.1 (device 0)
  Thu Apr  8 11:34:19.8085 2021  7  --- LINE END ---
  Thu Apr  8 11:34:19.8085 2021  6  Found StreamID x - SessionID: 0267341282
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 0, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 1, New session but this stream is in use, skipping...
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 2, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:19.8085 2021  6  Stream: 3, Not capable of handling msys=dvbs2
  Thu Apr  8 11:34:19.8085 2021  3  Found no Stream/Client of interest!
  Thu Apr  8 11:34:19.8085 2021  7  RTSP/1.0 503 Service Unavailable
  Thu Apr  8 11:34:19.8085 2021  7  Server: SatPI WebServer v0.1
  Thu Apr  8 11:34:19.8085 2021  7  Location: 
  Thu Apr  8 11:34:19.8085 2021  7  CSeq: 2
  Thu Apr  8 11:34:19.8085 2021  7  cache-control: no-cache
  Thu Apr  8 11:34:19.8085 2021  7  Content-Type: video/MP2T
  Thu Apr  8 11:34:19.8085 2021  7  --- LINE END ---

Stream: 0 Stream: 1 are already in use, those are the physical tuners, which are not released yet. Could you please make a log of starting SatPI and first search/tune of VDR.

nikolauzi11 commented 3 years ago

Hi @Barracuda09 

Apr  8 12:07:11 satip SatPI[1578]: Setting up HTTP server
Apr  8 12:07:11 satip SatPI[1578]: Setting up RTSP server
Apr  8 12:07:11 satip SatPI[1578]: Setting up SSDP server with BOOTID: 8  annouce interval: 60 Sec
Apr  8 12:07:12 satip SatPI[1578]: HTTP Connection from 192.168.112.61 Port 49210 with fd: 8
Apr  8 12:07:12 satip SatPI[1578]: HTTP Connection from 192.168.112.61 Port 49208 with fd: 9
Apr  8 12:07:12 satip SatPI[1578]: HTTP Connection from 192.168.112.61 Port 49209 with fd: 10
Apr  8 12:07:17 satip SatPI[1578]: HTTP Client 192.168.112.61:49208 Connection closed with fd: 9
Apr  8 12:07:18 satip SatPI[1578]: HTTP Client 192.168.112.61:49209 Connection closed with fd: 10
Apr  8 12:08:03 satip SatPI[1578]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  8 12:08:04 satip SatPI[1578]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  8 12:08:04 satip SatPI[1578]: HTTP Connection from 192.168.112.26 Port 34874 with fd: 9
Apr  8 12:08:04 satip SatPI[1578]: Client: 192.168.112.26 requested desc.xml
Apr  8 12:08:04 satip SatPI[1578]: Client: 192.168.112.26 requested desc.xml
Apr  8 12:08:05 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42058 with fd: 10
Apr  8 12:08:05 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42058: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:05 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:05 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:05 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:05 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:05 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:05 satip SatPI[1578]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 12:08:05 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:05 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42058: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 12:08:05 satip SatPI[1578]: CSeq: 2
Apr  8 12:08:05 satip SatPI[1578]: Transport: RTP/AVP;unicast;client_port=58620-58621
Apr  8 12:08:05 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:05 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:05 satip SatPI[1578]: Found StreamID x - SessionID: 0271707784
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, StreamClient[0] with SessionID 0271707784 for dvbs2
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, Parsing transport parameters...
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, New frequency requested, clearing old channel data...
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, Parsing transport parameters (Finished)
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, Found Streaming type: RTSP Unicast
Apr  8 12:08:05 satip SatPI[1578]: Stream: 0, Updating frontend...
Apr  8 12:08:07 satip SatPI[1578]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Read/Write with fd: 12
Apr  8 12:08:07 satip SatPI[1578]: Stream: 0, Start tuning process for DVB-S(2)...
Apr  8 12:08:07 satip SatPI[1578]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Writing DiSEqC command with fd: 12
Apr  8 12:08:07 satip SatPI[1578]: Stream: 0, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:07 satip SatPI[1578]: Stream: 0, Sending DiSEqC: [e1] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:08 satip SatPI[1578]: Stream: 0, Sending DiSEqC: [e1] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:08 satip SatPI[1578]: Stream: 0, Set Properties: Frequency 1744000
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, Waiting on lock...
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, Tuned and locked (FE status 0x1F)
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, Updating frontend (Finished)
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, RTP/UDP set network buffer size: 2080 KBytes
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, Start RTCP/UDP stream to 192.168.112.26:58621
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, Start RTP/UDP stream to 192.168.112.26:58620
Apr  8 12:08:09 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 2
Apr  8 12:08:09 satip SatPI[1578]: Session: 0271707784;timeout=60
Apr  8 12:08:09 satip SatPI[1578]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=58620-58621
Apr  8 12:08:09 satip SatPI[1578]: com.ses.streamID: 0
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42060 with fd: 15
Apr  8 12:08:09 satip SatPI[1578]: RTSP Client 192.168.112.26:42058 Connection closed with fd: 10
Apr  8 12:08:09 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42068 with fd: 10
Apr  8 12:08:09 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42060: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:09 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:09 satip SatPI[1578]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42068: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:09 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:09 satip SatPI[1578]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: RTSP Client 192.168.112.26:42060 Connection closed with fd: 15
Apr  8 12:08:09 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42068: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 12:08:09 satip SatPI[1578]: CSeq: 2
Apr  8 12:08:09 satip SatPI[1578]: Transport: RTP/AVP;unicast;client_port=58620-58621
Apr  8 12:08:09 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:09 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:09 satip SatPI[1578]: Found StreamID x - SessionID: 0269077541
Apr  8 12:08:09 satip SatPI[1578]: Stream: 0, New session but this stream is in use, skipping...
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, StreamClient[0] with SessionID 0269077541 for dvbs2
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, Parsing transport parameters...
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, New frequency requested, clearing old channel data...
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, Parsing transport parameters (Finished)
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, Found Streaming type: RTSP Unicast
Apr  8 12:08:09 satip SatPI[1578]: Stream: 1, Updating frontend...
Apr  8 12:08:10 satip SatPI[1578]: Stream: 1, Opened /dev/dvb/adapter1/frontend0 for Read/Write with fd: 16
Apr  8 12:08:10 satip SatPI[1578]: Stream: 1, Start tuning process for DVB-S(2)...
Apr  8 12:08:10 satip SatPI[1578]: Stream: 1, Opened /dev/dvb/adapter1/frontend0 for Writing DiSEqC command with fd: 16
Apr  8 12:08:11 satip SatPI[1578]: Stream: 1, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:12 satip SatPI[1578]: Stream: 1, Sending DiSEqC: [e1] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:12 satip SatPI[1578]: Stream: 1, Sending DiSEqC: [e1] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 12:08:13 satip SatPI[1578]: Stream: 1, Set Properties: Frequency 1744000
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, Waiting on lock...
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, Tuned and locked (FE status 0x1F)
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, Updating frontend (Finished)
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, RTP/UDP set network buffer size: 2080 KBytes
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, Start RTCP/UDP stream to 192.168.112.26:58621
Apr  8 12:08:14 satip SatPI[1578]: Stream: 1, Start RTP/UDP stream to 192.168.112.26:58620
Apr  8 12:08:14 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 2
Apr  8 12:08:14 satip SatPI[1578]: Session: 0269077541;timeout=60
Apr  8 12:08:14 satip SatPI[1578]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=58620-58621
Apr  8 12:08:14 satip SatPI[1578]: com.ses.streamID: 1
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:14 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42070 with fd: 19
Apr  8 12:08:14 satip SatPI[1578]: RTSP Client 192.168.112.26:42068 Connection closed with fd: 10
Apr  8 12:08:14 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42072 with fd: 10
Apr  8 12:08:14 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42070: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:14 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:14 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:14 satip SatPI[1578]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:14 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42072: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:14 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:14 satip SatPI[1578]: RTSP/1.0 200 OK
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:14 satip SatPI[1578]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Apr  8 12:08:14 satip SatPI[1578]: RTSP Client 192.168.112.26:42070 Connection closed with fd: 19
Apr  8 12:08:14 satip SatPI[1578]: RTSP Client 192.168.112.26:42072 Connection closed with fd: 10
Apr  8 12:08:14 satip SatPI[1578]: RTSP Connection from 192.168.112.26 Port 42076 with fd: 10
Apr  8 12:08:14 satip SatPI[1578]: RTSP Stream data from client None with IP 192.168.112.26 on Port 42076: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 12:08:14 satip SatPI[1578]: CSeq: 1
Apr  8 12:08:14 satip SatPI[1578]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 12:08:14 satip SatPI[1578]: --- LINE END ---
Barracuda09 commented 3 years ago

Hi @nikolauzi11

It seems that VDR is waiting on something, that the signal is tuned (most likely on RTCP packet with signal strength etc.) You could check the Frontend view under Monitor to see the value

nikolauzi11 commented 3 years ago

Hi @Barracuda09

grafik

I also noticed this, after VDR was runnig a while:

Apr  8 12:41:36 satip SatPI[1628]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr  8 12:41:53 satip SatPI[1628]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr  8 12:41:53 satip SatPI[1628]: Mutex in HttpServer not unlocked!!
Apr  8 12:41:53 satip SatPI[1628]: Mutex in HttpServer not unlocked!!
Apr  8 12:41:53 satip SatPI[1628]: send: Connection reset by peer (code 104)
Apr  8 12:41:53 satip SatPI[1628]: Send htmlBody failed
Apr  8 12:41:53 satip SatPI[1628]: HTTP Connection from 192.168.112.61 Port 50228 with fd: 13
Apr  8 12:42:10 satip SatPI[1628]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr  8 12:42:27 satip SatPI[1628]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr  8 12:42:27 satip SatPI[1628]: Mutex in HttpServer not unlocked!!
Apr  8 12:42:27 satip SatPI[1628]: Mutex in HttpServer not unlocked!!
Apr  8 12:42:27 satip SatPI[1628]: send: Connection reset by peer (code 104)
Apr  8 12:42:27 satip SatPI[1628]: Send htmlBody failed
Barracuda09 commented 3 years ago

Hi @nikolauzi11

Thanks for your effort so far. I have to check this evening if the RTCP packets are (correctly) send.

I did not test with VDR (myself) at all, to be honest.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Could you please try new commit, when you have time?

Thanks and kind regards,

Marc

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Unfortunately, it does not look any better(I disabled Frontend 2+3 for now).

I don't know if it matters, but the stream URL from the log has no PIDs.

Apr  8 23:01:08 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35046: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0

If I add the PIDs to this URL and paste it in the VLC player, I get a picture.

Apr  8 23:00:45 satip SatPI[17357]: Setting up HTTP server
Apr  8 23:00:45 satip SatPI[17357]: Setting up RTSP server
Apr  8 23:00:45 satip SatPI[17357]: Setting up SSDP server with BOOTID: 18  annouce interval: 60 Sec
Apr  8 23:00:45 satip SatPI[17357]: HTTP Connection from 192.168.112.61 Port 58657 with fd: 8
Apr  8 23:00:45 satip SatPI[17357]: HTTP Connection from 192.168.112.61 Port 58658 with fd: 9
Apr  8 23:00:50 satip SatPI[17357]: HTTP Client 192.168.112.61:58658 Connection closed with fd: 9
Apr  8 23:01:06 satip SatPI[17357]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  8 23:01:07 satip SatPI[17357]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  8 23:01:07 satip SatPI[17357]: HTTP Connection from 192.168.112.26 Port 46528 with fd: 9
Apr  8 23:01:07 satip SatPI[17357]: Client: 192.168.112.26 requested desc.xml
Apr  8 23:01:07 satip SatPI[17357]: Client: 192.168.112.26 requested desc.xml
Apr  8 23:01:08 satip SatPI[17357]: RTSP Connection from 192.168.112.26 Port 35046 with fd: 10
Apr  8 23:01:08 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35046: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 23:01:08 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:08 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:08 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:08 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:08 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:08 satip SatPI[17357]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 23:01:08 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:08 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35046: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 23:01:08 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:08 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_port=48080-48081
Apr  8 23:01:08 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:08 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:08 satip SatPI[17357]: Found StreamID x - SessionID: 0291352295
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, StreamClient[0] with SessionID 0291352295 for dvbs2
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, Parsing transport parameters...
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, New frequency requested, clearing old channel data...
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, Parsing transport parameters (Finished)
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, Found Streaming type: RTSP Unicast
Apr  8 23:01:08 satip SatPI[17357]: Stream: 0, Updating frontend...
Apr  8 23:01:09 satip SatPI[17357]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Read/Write with fd: 12
Apr  8 23:01:09 satip SatPI[17357]: Stream: 0, Start tuning process for DVB-S(2)...
Apr  8 23:01:09 satip SatPI[17357]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Writing DiSEqC command with fd: 12
Apr  8 23:01:09 satip SatPI[17357]: Stream: 0, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 23:01:09 satip SatPI[17357]: Stream: 0, Set Properties: Frequency 1612000
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, Waiting on lock...
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, Tuned and locked (FE status 0x1F)
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, Updating frontend (Finished)
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, RTP/UDP set network buffer size: 2080 KBytes
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, Start RTCP/UDP stream to 192.168.112.26:48081
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, Start RTP/UDP stream to 192.168.112.26:48080
Apr  8 23:01:10 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:10 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:10 satip SatPI[17357]: Session: 0291352295;timeout=60
Apr  8 23:01:10 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=48080-48081
Apr  8 23:01:10 satip SatPI[17357]: com.ses.streamID: 0
Apr  8 23:01:10 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:10 satip SatPI[17357]: RTSP Connection from 192.168.112.26 Port 35048 with fd: 15
Apr  8 23:01:10 satip SatPI[17357]: RTSP Client 192.168.112.26:35046 Connection closed with fd: 10
Apr  8 23:01:10 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35048: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 23:01:10 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:10 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:10 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:10 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:10 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:10 satip SatPI[17357]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 23:01:10 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:10 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35048: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 23:01:10 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:10 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_port=48080-48081
Apr  8 23:01:10 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:10 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:10 satip SatPI[17357]: Found StreamID x - SessionID: 0268243757
Apr  8 23:01:10 satip SatPI[17357]: Stream: 0, New session but this stream is in use, skipping...
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, StreamClient[0] with SessionID 0268243757 for dvbs2
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, Parsing transport parameters...
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, New frequency requested, clearing old channel data...
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, Parsing transport parameters (Finished)
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, Found Streaming type: RTSP Unicast
Apr  8 23:01:10 satip SatPI[17357]: Stream: 1, Updating frontend...
Apr  8 23:01:11 satip SatPI[17357]: Stream: 1, Opened /dev/dvb/adapter1/frontend0 for Read/Write with fd: 16
Apr  8 23:01:11 satip SatPI[17357]: Stream: 1, Start tuning process for DVB-S(2)...
Apr  8 23:01:11 satip SatPI[17357]: Stream: 1, Opened /dev/dvb/adapter1/frontend0 for Writing DiSEqC command with fd: 16
Apr  8 23:01:12 satip SatPI[17357]: Stream: 1, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  8 23:01:12 satip SatPI[17357]: Stream: 1, Set Properties: Frequency 1612000
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, Waiting on lock...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, Tuned and locked (FE status 0x1F)
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, Updating frontend (Finished)
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, RTP/UDP set network buffer size: 2080 KBytes
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, Start RTCP/UDP stream to 192.168.112.26:48081
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, Start RTP/UDP stream to 192.168.112.26:48080
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: Session: 0268243757;timeout=60
Apr  8 23:01:13 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=48080-48081
Apr  8 23:01:13 satip SatPI[17357]: com.ses.streamID: 1
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Connection from 192.168.112.26 Port 35056 with fd: 19
Apr  8 23:01:13 satip SatPI[17357]: RTSP Client 192.168.112.26:35048 Connection closed with fd: 15
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35056: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35056: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_port=48080-48081
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: Found StreamID x - SessionID: 0281274771
Apr  8 23:01:13 satip SatPI[17357]: Stream: 0, New session but this stream is in use, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, New session but this stream is in use, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 2, New session but this stream is not enabled, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 3, New session but this stream is not enabled, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Found no Stream/Client of interest!
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 503 Service Unavailable
Apr  8 23:01:13 satip SatPI[17357]: Server: SatPI WebServer v0.1
Apr  8 23:01:13 satip SatPI[17357]: Location: 
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: cache-control: no-cache
Apr  8 23:01:13 satip SatPI[17357]: Content-Type: video/MP2T
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Client 192.168.112.26:35056 Connection closed with fd: 19
Apr  8 23:01:13 satip SatPI[17357]: RTSP Connection from 192.168.112.26 Port 35058 with fd: 15
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35058: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35058: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_port=48080-48081
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: Found StreamID x - SessionID: 0259937801
Apr  8 23:01:13 satip SatPI[17357]: Stream: 0, New session but this stream is in use, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 1, New session but this stream is in use, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 2, New session but this stream is not enabled, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Stream: 3, New session but this stream is not enabled, skipping...
Apr  8 23:01:13 satip SatPI[17357]: Found no Stream/Client of interest!
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 503 Service Unavailable
Apr  8 23:01:13 satip SatPI[17357]: Server: SatPI WebServer v0.1
Apr  8 23:01:13 satip SatPI[17357]: Location: 
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: cache-control: no-cache
Apr  8 23:01:13 satip SatPI[17357]: Content-Type: video/MP2T
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Client 192.168.112.26:35058 Connection closed with fd: 15
Apr  8 23:01:13 satip SatPI[17357]: RTSP Connection from 192.168.112.26 Port 35060 with fd: 15
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35060: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP/1.0 200 OK
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 1
Apr  8 23:01:13 satip SatPI[17357]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Apr  8 23:01:13 satip SatPI[17357]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35060: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  8 23:01:13 satip SatPI[17357]: CSeq: 2
Apr  8 23:01:13 satip SatPI[17357]: Transport: RTP/AVP;unicast;client_port=48080-48081
Apr  8 23:01:13 satip SatPI[17357]: User-Agent: vdr-satip/2.4.1 (device 0)
Apr  8 23:01:13 satip SatPI[17357]: --- LINE END ---
Barracuda09 commented 3 years ago

Hi @nikolauzi11

Yes I also thought that was strange. And it keeps giving the same SETUP just like it waits on something to receive? But SatPI gives an 'session id' to VDR but VDR never closes the session (which it should).

Is there some option in VDR to give PIDS with an SETUP command?

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Is there some option in VDR to give PIDS with an SETUP command?

As far as I know, there is no such setting. Please see the Readme https://github.com/rofafor/vdr-plugin-satip

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I think I have to setup VDR myself. And try it, but I do not find it easy to do.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

It could be a timeout in VDR, that would explain why: Apr 8 11:35:31 vdr6 vdr: [1412] SATIP-ERROR: Connect failed [device 0]

Barracuda09 commented 3 years ago

Hi @nikolauzi11

This timeout can probably be increased (2500): https://github.com/rofafor/vdr-plugin-satip/blob/1ad0a81d16eb5d44f1abd932a41ae79789ff4d34/rtsp.h#L21-L30

nikolauzi11 commented 3 years ago

Hi @Barracuda09

I think I have to setup VDR myself. And try it, but I do not find it easy to do.

Unfortunately, that's true. I did it this way: https://github.com/yavdr/yavdr-ansible

This timeout can probably be increased (2500):

I could test this. But for that I have to build a development environment first, because my VDR is not self-compiled.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I could test this. But for that I have to build a development environment first, because my VDR is not self-compiled.

You only need to build vdr-plugin-satip or not? (I am almost sure it will fix it)

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Yes, I will be able to manage it. I have built another plugin before as well.

I have used a Digibit R1 SAT>IP box together with the Satip-Plugin for several years. But now the box starts to make problems, so SatPi should replace it.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Yes the "problem" is that SatPI is sending the 200 OK after the tuning is done. And this takes in your case about 2500ms.

nikolauzi11 commented 3 years ago

Hi @Barracuda09

I have increased the timeout to 3000ms. It looks different now, it doesn't repeat anymore, but still no stream. The VDR does not get any PIDs.

Apr  9 12:32:26 satip SatPI[18569]: Setting up HTTP server
Apr  9 12:32:26 satip SatPI[18569]: Setting up RTSP server
Apr  9 12:32:26 satip SatPI[18569]: Setting up SSDP server with BOOTID: 23  annouce interval: 60 Sec
Apr  9 12:32:26 satip SatPI[18569]: HTTP Connection from 192.168.112.61 Port 64350 with fd: 8
Apr  9 12:32:26 satip SatPI[18569]: HTTP Connection from 192.168.112.61 Port 64348 with fd: 9
Apr  9 12:32:27 satip SatPI[18569]: HTTP Connection from 192.168.112.61 Port 64349 with fd: 10
Apr  9 12:32:31 satip SatPI[18569]: HTTP Client 192.168.112.61:64348 Connection closed with fd: 9
Apr  9 12:32:32 satip SatPI[18569]: HTTP Client 192.168.112.61:64349 Connection closed with fd: 10
Apr  9 12:32:42 satip SatPI[18569]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 12:32:43 satip SatPI[18569]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 12:32:43 satip SatPI[18569]: HTTP Connection from 192.168.112.26 Port 58356 with fd: 9
Apr  9 12:32:43 satip SatPI[18569]: Client: 192.168.112.26 requested desc.xml
Apr  9 12:32:43 satip SatPI[18569]: Client: 192.168.112.26 requested desc.xml
Apr  9 12:32:44 satip SatPI[18569]: RTSP Connection from 192.168.112.26 Port 35712 with fd: 10
Apr  9 12:32:44 satip SatPI[18569]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35712: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  9 12:32:44 satip SatPI[18569]: CSeq: 1
Apr  9 12:32:44 satip SatPI[18569]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 12:32:44 satip SatPI[18569]: --- LINE END ---
Apr  9 12:32:44 satip SatPI[18569]: RTSP/1.0 200 OK
Apr  9 12:32:44 satip SatPI[18569]: CSeq: 1
Apr  9 12:32:44 satip SatPI[18569]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  9 12:32:44 satip SatPI[18569]: --- LINE END ---
Apr  9 12:32:44 satip SatPI[18569]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35712: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  9 12:32:44 satip SatPI[18569]: CSeq: 2
Apr  9 12:32:44 satip SatPI[18569]: Transport: RTP/AVP;unicast;client_port=57598-57599
Apr  9 12:32:44 satip SatPI[18569]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 12:32:44 satip SatPI[18569]: --- LINE END ---
Apr  9 12:32:44 satip SatPI[18569]: Found StreamID x - SessionID: 0288386972
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, StreamClient[0] with SessionID 0288386972 for dvbs2
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, Parsing transport parameters...
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, New frequency requested, clearing old channel data...
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, Parsing transport parameters (Finished)
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, Found Streaming type: RTSP Unicast
Apr  9 12:32:44 satip SatPI[18569]: Stream: 0, Updating frontend...
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Read/Write with fd: 12
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Start tuning process for DVB-S(2)...
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Writing DiSEqC command with fd: 12
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Set Properties: Frequency 1744000
Apr  9 12:32:46 satip SatPI[18569]: Stream: 0, Waiting on lock...
Apr  9 12:32:47 satip SatPI[18569]: Stream: 0, Tuned and locked (FE status 0x1F)
Apr  9 12:32:47 satip SatPI[18569]: Stream: 0, Updating frontend (Finished)
Apr  9 12:32:47 satip SatPI[18569]: Stream: 0, RTP/UDP set network buffer size: 2080 KBytes
Apr  9 12:32:47 satip SatPI[18569]: Stream: 0, Start RTCP/UDP stream to 192.168.112.26:57599
Apr  9 12:32:47 satip SatPI[18569]: Stream: 0, Start RTP/UDP stream to 192.168.112.26:57598
Apr  9 12:32:47 satip SatPI[18569]: RTSP/1.0 200 OK
Apr  9 12:32:47 satip SatPI[18569]: CSeq: 2
Apr  9 12:32:47 satip SatPI[18569]: Session: 0288386972;timeout=60
Apr  9 12:32:47 satip SatPI[18569]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=57598-57599
Apr  9 12:32:47 satip SatPI[18569]: com.ses.streamID: 0
Apr  9 12:32:47 satip SatPI[18569]: --- LINE END ---
Apr  9 12:32:47 satip SatPI[18569]: HTTP Connection from 192.168.112.61 Port 64354 with fd: 15
Apr  9 12:32:50 satip SatPI[18569]: SAT>IP Client 192.168.112.67 : tries to discover the network, sending reply back
Apr  9 12:32:51 satip SatPI[18569]: SAT>IP Client 192.168.112.67 : tries to discover the network, sending reply back
Apr  9 12:32:51 satip SatPI[18569]: HTTP Connection from 192.168.112.67 Port 46182 with fd: 16
Apr  9 12:32:51 satip SatPI[18569]: Client: 192.168.112.67 requested desc.xml
Apr  9 12:32:51 satip SatPI[18569]: Client: 192.168.112.67 requested desc.xml
Apr  9 12:33:42 satip SatPI[18569]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 12:33:43 satip SatPI[18569]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 12:33:43 satip SatPI[18569]: Client: 192.168.112.26 requested desc.xml
Apr  9 12:33:43 satip SatPI[18569]: Client: 192.168.112.26 requested desc.xml
Apr  9 12:33:47 satip SatPI[18569]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35712: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  9 12:33:47 satip SatPI[18569]: CSeq: 3
Apr  9 12:33:47 satip SatPI[18569]: Session: 0288386972
Apr  9 12:33:47 satip SatPI[18569]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 12:33:47 satip SatPI[18569]: --- LINE END ---
Apr  9 12:33:47 satip SatPI[18569]: Found StreamID x - SessionID: 0288386972
Apr  9 12:33:47 satip SatPI[18569]: Stream: 0, StreamClient[0] with SessionID 0288386972
Apr  9 12:33:47 satip SatPI[18569]: RTSP/1.0 200 OK
Apr  9 12:33:47 satip SatPI[18569]: CSeq: 3
Apr  9 12:33:47 satip SatPI[18569]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  9 12:33:47 satip SatPI[18569]: Session: 0288386972
Apr  9 12:33:47 satip SatPI[18569]: --- LINE END ---
Apr  9 12:33:50 satip SatPI[18569]: SAT>IP Client 192.168.112.67 : tries to discover the network, sending reply back
Apr  9 12:33:51 satip SatPI[18569]: SAT>IP Client 192.168.112.67 : tries to discover the network, sending reply back
Apr  9 12:33:51 satip SatPI[18569]: Client: 192.168.112.67 requested desc.xml

1000676_1 1000677_1 1000678_1

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Yes, it seems that SatPI does not get the PIDs from VDR. Maybe VDR expects the server will enable them by default?

Apr  9 12:32:44 satip SatPI[18569]: RTSP Stream data from client None with IP 192.168.112.26 on Port 35712: SETUP rtsp://192.168.112.66/?src=1&freq=11494&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  9 12:32:44 satip SatPI[18569]: CSeq: 2
Apr  9 12:32:44 satip SatPI[18569]: Transport: RTP/AVP;unicast;client_port=57598-57599
Apr  9 12:32:44 satip SatPI[18569]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 12:32:44 satip SatPI[18569]: --- LINE END ---

Later there is no PLAY command? (That activates PIDs)

Barracuda09 commented 3 years ago

Hi @nikolauzi11

You could change if (!pidsList.empty()) { to if (!pidsList.empty() || method == "SETUP") {

Here Line 326: https://github.com/Barracuda09/SATPI/blob/b02eda89c6cc0aea05771a55a6cf2e47ee8fee47/src/input/dvb/FrontendData.cpp#L326-L330

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Later there is no PLAY command? (That activates PIDs)

Unfortunately, there is nothing more to come.

You could change if (!pidsList.empty()) { to if (!pidsList.empty() || method == "SETUP") {

Unfortunately, I can't get a stream with it either.

Apr  9 19:07:09 satip SatPI[19575]: Setting up HTTP server
Apr  9 19:07:09 satip SatPI[19575]: Setting up RTSP server
Apr  9 19:07:09 satip SatPI[19575]: Setting up SSDP server with BOOTID: 27  annouce interval: 60 Sec
Apr  9 19:07:09 satip SatPI[19575]: HTTP Connection from 192.168.112.61 Port 56942 with fd: 8
Apr  9 19:07:09 satip SatPI[19575]: HTTP Connection from 192.168.112.61 Port 56941 with fd: 9
Apr  9 19:07:14 satip SatPI[19575]: HTTP Client 192.168.112.61:56941 Connection closed with fd: 9
Apr  9 19:07:31 satip SatPI[19575]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 19:07:32 satip SatPI[19575]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 19:07:32 satip SatPI[19575]: HTTP Connection from 192.168.112.26 Port 33982 with fd: 9
Apr  9 19:07:32 satip SatPI[19575]: Client: 192.168.112.26 requested desc.xml
Apr  9 19:07:32 satip SatPI[19575]: Client: 192.168.112.26 requested desc.xml
Apr  9 19:07:33 satip SatPI[19575]: RTSP Connection from 192.168.112.26 Port 47546 with fd: 10
Apr  9 19:07:33 satip SatPI[19575]: RTSP Stream data from client None with IP 192.168.112.26 on Port 47546: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  9 19:07:33 satip SatPI[19575]: CSeq: 1
Apr  9 19:07:33 satip SatPI[19575]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 19:07:33 satip SatPI[19575]: --- LINE END ---
Apr  9 19:07:33 satip SatPI[19575]: RTSP/1.0 200 OK
Apr  9 19:07:33 satip SatPI[19575]: CSeq: 1
Apr  9 19:07:33 satip SatPI[19575]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  9 19:07:33 satip SatPI[19575]: --- LINE END ---
Apr  9 19:07:33 satip SatPI[19575]: RTSP Stream data from client None with IP 192.168.112.26 on Port 47546: SETUP rtsp://192.168.112.66/?src=1&freq=11362&pol=h&ro=0.35&msys=dvbs2&mtype=8psk&sr=22000&fec=23 RTSP/1.0
Apr  9 19:07:33 satip SatPI[19575]: CSeq: 2
Apr  9 19:07:33 satip SatPI[19575]: Transport: RTP/AVP;unicast;client_port=59444-59445
Apr  9 19:07:33 satip SatPI[19575]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 19:07:33 satip SatPI[19575]: --- LINE END ---
Apr  9 19:07:33 satip SatPI[19575]: Found StreamID x - SessionID: 0250741217
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, StreamClient[0] with SessionID 0250741217 for dvbs2
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, Parsing transport parameters...
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, New frequency requested, clearing old channel data...
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, Parsing transport parameters (Finished)
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, Found Streaming type: RTSP Unicast
Apr  9 19:07:33 satip SatPI[19575]: Stream: 0, Updating frontend...
Apr  9 19:07:34 satip SatPI[19575]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Read/Write with fd: 12
Apr  9 19:07:34 satip SatPI[19575]: Stream: 0, Start tuning process for DVB-S(2)...
Apr  9 19:07:34 satip SatPI[19575]: Stream: 0, Opened /dev/dvb/adapter0/frontend0 for Writing DiSEqC command with fd: 12
Apr  9 19:07:34 satip SatPI[19575]: Stream: 0, Sending DiSEqC: [e0] [10] [38] [f2] - DiSEqC Src: 0
Apr  9 19:07:34 satip SatPI[19575]: Stream: 0, Set Properties: Frequency 1612000
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Waiting on lock...
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Tuned and locked (FE status 0x1F)
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Updating PID filters...
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set DMX buffer size to 18874368 Bytes
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Opened /dev/dvb/adapter0/demux0 fd: 14
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set filter PID: 0000
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set filter PID: 0001
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set filter PID: 0016
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set filter PID: 0017
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Set filter PID: 0018
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Updating frontend (Finished)
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, RTP/UDP set network buffer size: 2080 KBytes
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Start RTCP/UDP stream to 192.168.112.26:59445
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, Start RTP/UDP stream to 192.168.112.26:59444
Apr  9 19:07:35 satip SatPI[19575]: RTSP/1.0 200 OK
Apr  9 19:07:35 satip SatPI[19575]: CSeq: 2
Apr  9 19:07:35 satip SatPI[19575]: Session: 0250741217;timeout=60
Apr  9 19:07:35 satip SatPI[19575]: Transport: RTP/AVP;unicast;client_ip=192.168.112.26;client_port=59444-59445
Apr  9 19:07:35 satip SatPI[19575]: com.ses.streamID: 0
Apr  9 19:07:35 satip SatPI[19575]: --- LINE END ---
Apr  9 19:07:35 satip SatPI[19575]: HTTP Connection from 192.168.112.61 Port 56953 with fd: 17
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, SDT - PID 0017: sectionLength: 70  tableDataSize: 188  secNr: 0  lastSecNr: 0  currSecNr: 0
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, SDT - Section Length: 70  Transport Stream ID: 1011  Version: 201  secNr: 0  lastSecNr: 0  NetworkID: 0001  CRC: 0x8779FFBD
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0,  serviceID: 0x2B66 - 11110  EIT: 0xFF  NetworkName: ZDFvision  ChannelName: ZDF HD
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0,  serviceID: 0x2B7A - 11130  EIT: 0xFF  NetworkName: ZDFvision  ChannelName: zdf_neo HD
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, PAT - PID 0000: sectionLength: 21  tableDataSize: 188  secNr: 0  lastSecNr: 0  currSecNr: 0
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, PAT: Section Length: 21  TID: 1011  Version: 193  secNr: 0 lastSecNr: 0  CRC: 0x47179A1A
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, PAT: Prog NR: 0x0000 - 00000  NIT PID: 0016
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, PAT: Prog NR: 0x2B66 - 11110  PMT PID: 6100
Apr  9 19:07:35 satip SatPI[19575]: Stream: 0, PAT: Prog NR: 0x2B7A - 11130  PMT PID: 6300
Apr  9 19:08:31 satip SatPI[19575]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 19:08:32 satip SatPI[19575]: SAT>IP Client 192.168.112.26 : tries to discover the network, sending reply back
Apr  9 19:08:32 satip SatPI[19575]: Client: 192.168.112.26 requested desc.xml
Apr  9 19:08:32 satip SatPI[19575]: Client: 192.168.112.26 requested desc.xml
Apr  9 19:08:35 satip SatPI[19575]: RTSP Stream data from client None with IP 192.168.112.26 on Port 47546: OPTIONS rtsp://192.168.112.66/ RTSP/1.0
Apr  9 19:08:35 satip SatPI[19575]: CSeq: 3
Apr  9 19:08:35 satip SatPI[19575]: Session: 0250741217
Apr  9 19:08:35 satip SatPI[19575]: User-Agent: vdr-satip/2.4.1-GIT-1ad0a81 (device 0)
Apr  9 19:08:35 satip SatPI[19575]: --- LINE END ---
Apr  9 19:08:35 satip SatPI[19575]: Found StreamID x - SessionID: 0250741217
Apr  9 19:08:35 satip SatPI[19575]: Stream: 0, StreamClient[0] with SessionID 0250741217
Apr  9 19:08:35 satip SatPI[19575]: RTSP/1.0 200 OK
Apr  9 19:08:35 satip SatPI[19575]: CSeq: 3
Apr  9 19:08:35 satip SatPI[19575]: Public: OPTIONS, DESCRIBE, SETUP, PLAY, TEARDOWN
Apr  9 19:08:35 satip SatPI[19575]: Session: 0250741217
Apr  9 19:08:35 satip SatPI[19575]: --- LINE END ---
nikolauzi11 commented 3 years ago

Strangely enough, I no longer get any SATIP errors on the VDR.

nikolauzi11 commented 3 years ago

And packets are also sent. grafik

Barracuda09 commented 3 years ago

Yes, I don't get it why it is not giving PIDs

Is this a channel search?

nikolauzi11 commented 3 years ago

Hi @Barracuda09

VDR always looks in the background if there are changes on the channels. But first and foremost, this is not a channel scan. When I change the channel it also looks like this.

Would it make sense to ask the satip-plugin people?

Barracuda09 commented 3 years ago

Maybe, I am bit of a noob in VDR (satip).

I am trying to set it up now, but is not as easy (but I must be doing something wrong)

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I have tried VDR and satip with this command: ./vdr -P 'satip -n' And this seems to work OK with sending of PID requests

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Now I am totally confused. Did you compile the SATIP plugin with the extended timeout? What does the -n parameter mean?

Barracuda09 commented 3 years ago

Hi @nikolauzi11

No I did not compile with ext. timeout, I use DVB-C which locks quick. the -n is to disable all 'server quirks' (I assume this means no weird workarounds)

nikolauzi11 commented 3 years ago

Hi @Barracuda09

I set up a new minimal VDR on a Raspberry Pi4, just the output plugin and satip. Unfortunately the result is exactly the same(with the old Digibit box it works). I also looked at the channels.conf again. Do you have the possibility to test it with DVB-S? Otherwise I will have to give up the project for now, unfortunately I don't know what else I can do to find the problem. Sorry for all the time you have invested.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I just compiled VDR and vdr-plugin-satip form source. What is this output give you cat /var/log/syslog | grep vdr

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Unfortunately, it doesn't say much about SATIP. It would probably help to increase the log level of the satip plugin, but I haven't figured out how to do that yet. I had a picture once when I restarted SatPi while the VDR was running. But it is not possible to reproduce this.

Apr 11 15:39:05 vdrpi vdr: [472] VDR version 2.4.0 started
Apr 11 15:39:05 vdrpi vdr: [472] switched to user 'vdr'
Apr 11 15:39:05 vdrpi vdr: [472] codeset is 'UTF-8' - known
Apr 11 15:39:06 vdrpi vdr: [472] loading plugin: /usr/lib/vdr/plugins/libvdr-softhddevice-drm.so.2.4.0
Apr 11 15:39:07 vdrpi vdr: [472] loading plugin: /usr/lib/vdr/plugins/libvdr-satip.so.2.4.0
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/setup.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/sources.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/diseqc.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/scr.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/channels.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/timers.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/commands.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/reccmds.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/svdrphosts.conf
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/keymacros.conf
Apr 11 15:39:07 vdrpi vdr: [472] no DVB device found
Apr 11 15:39:07 vdrpi vdr: [472] initializing plugin: softhddevice-drm (0.0.1rc1-GITe38b4f6): A software and GPU emulated HD device
Apr 11 15:39:07 vdrpi vdr: [472] initializing plugin: satip (2.4.1-GIT-1ad0a81): SAT>IP Geräte
Apr 11 15:39:07 vdrpi vdr: [472] SATIP: Adding server '192.168.112.99|DVBS2-4|SatPI' Bind: default Filters: none CI: no Quirks: none
Apr 11 15:39:07 vdrpi vdr: [472] SATIP: Creating device CardIndex=1 DeviceNumber=1 [device 0]
Apr 11 15:39:07 vdrpi vdr: [472] SATIP: Creating device CardIndex=2 DeviceNumber=2 [device 1]
Apr 11 15:39:07 vdrpi vdr: [472] setting primary device to 1
Apr 11 15:39:07 vdrpi vdr: [472] setting current skin to "lcars"
Apr 11 15:39:07 vdrpi vdr: [472] loading /var/lib/vdr/themes/lcars-default.theme
Apr 11 15:39:07 vdrpi vdr: [472] starting plugin: softhddevice-drm
Apr 11 15:39:07 vdrpi vdr: [472] starting plugin: satip
Apr 11 15:39:07 vdrpi vdr: [472] SATIP: Using CURL 7.64.0 rtsp
Apr 11 15:39:17 vdrpi vdr: [472] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:39:19 vdrpi vdr: [646] SVDRP vdrpi opening port 6419/tcp
Apr 11 15:39:19 vdrpi vdr: [646] SVDRP vdrpi listening on port 6419/tcp
Apr 11 15:40:14 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39122 client connection accepted
Apr 11 15:40:14 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:16 vdrpi vdr: [472] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:16 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39122 connection closed
Apr 11 15:40:16 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39124 client connection accepted
Apr 11 15:40:17 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39124 connection closed
Apr 11 15:40:17 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39126 client connection accepted
Apr 11 15:40:17 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:17 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39126 connection closed
Apr 11 15:40:17 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39128 client connection accepted
Apr 11 15:40:17 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:17 vdrpi vdr: [472] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:17 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39128 connection closed
Apr 11 15:40:18 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39130 client connection accepted
Apr 11 15:40:18 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:18 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39130 connection closed
Apr 11 15:40:18 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39132 client connection accepted
Apr 11 15:40:18 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:19 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39132 connection closed
Apr 11 15:40:19 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39134 client connection accepted
Apr 11 15:40:19 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:19 vdrpi vdr: [472] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:19 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39134 connection closed
Apr 11 15:40:20 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39136 client connection accepted
Apr 11 15:40:20 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:20 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39136 connection closed
Apr 11 15:40:20 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39138 client connection accepted
Apr 11 15:40:20 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:20 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39138 connection closed
Apr 11 15:40:21 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39140 client connection accepted
Apr 11 15:40:21 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:21 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39140 connection closed
Apr 11 15:40:22 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39142 client connection accepted
Apr 11 15:40:22 vdrpi vdr: [646] switching to channel 6 S19.2E-1-1011-11110 (ZDF HD)
Apr 11 15:40:22 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39142 connection closed
Apr 11 15:40:47 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39144 client connection accepted
Apr 11 15:40:47 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:48 vdrpi vdr: [472] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:48 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39144 connection closed
Apr 11 15:40:48 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39146 client connection accepted
Apr 11 15:40:48 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:50 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39146 connection closed
Apr 11 15:40:51 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39150 client connection accepted
Apr 11 15:40:51 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:52 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39150 connection closed
Apr 11 15:40:52 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39154 client connection accepted
Apr 11 15:40:52 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:53 vdrpi vdr: [541] SATIP: Detected 1 RTP packet error [device 0]
Apr 11 15:40:53 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39154 connection closed
Apr 11 15:40:53 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39156 client connection accepted
Apr 11 15:40:53 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:53 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39156 connection closed
Apr 11 15:40:54 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39158 client connection accepted
Apr 11 15:40:54 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:54 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39158 connection closed
Apr 11 15:40:55 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39160 client connection accepted
Apr 11 15:40:55 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:55 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39160 connection closed
Apr 11 15:40:55 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39162 client connection accepted
Apr 11 15:40:55 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:55 vdrpi vdr: [472] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:55 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39162 connection closed
Apr 11 15:40:56 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39164 client connection accepted
Apr 11 15:40:56 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:56 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39164 connection closed
Apr 11 15:40:57 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39166 client connection accepted
Apr 11 15:40:57 vdrpi vdr: [646] switching to channel 5 S19.2E-1-1019-10301 (Das Erste HD)
Apr 11 15:40:57 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39166 connection closed
Apr 11 15:42:45 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39168 client connection accepted
Apr 11 15:42:45 vdrpi vdr: [646] SVDRP vdrpi < 127.0.0.1:39168 connection closed
nikolauzi11 commented 3 years ago

Hi @Barracuda09

I found out how to enable debugging of the satip plugin.

https://www.vdr-portal.de/forum/index.php?thread/125275-vdr-plugin-satip-debug-rtsp-communication-for-inverto-oem-devices/

Barracuda09 commented 3 years ago

Hi @nikolauzi11

I have tested with DVB-S2 and that works here as well (channel search). I compiled it for RaspberryPI.

I started with one channel in in /var/lib/vdr/channels.conf for Astra 23.5E and after some time it started searching channels VDR.log

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Have made a change when SETUP is requested to send reply before tuning is started. Hope this prevents Timeouts more.

nikolauzi11 commented 3 years ago

Hi @Barracuda09

I don't dare to say it, but unfortunately it still doesn't work. I unfortunately sent the wrong log earlier. The correct one is attached now. The VDR also scans for new channels and EPG. But during the scanning SatPi seems to crash partially. The WebIF then no longer works.

Apr 11 23:20:40 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x73  Date: 2021-4-11  Time: 21:20.39  MJD: 0xE7B3
Apr 11 23:20:41 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x70  Date: 2021-4-11  Time: 21:20.39  MJD: 0xE7B3
Apr 11 23:20:41 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x73  Date: 2021-4-11  Time: 21:20.40  MJD: 0xE7B3
Apr 11 23:20:42 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x70  Date: 2021-4-11  Time: 21:20.40  MJD: 0xE7B3
Apr 11 23:20:42 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x73  Date: 2021-4-11  Time: 21:20.41  MJD: 0xE7B3
Apr 11 23:20:42 satpi SatPI[3650]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr 11 23:20:42 satpi SatPI[3650]: Mutex in HttpServer not unlocked!!
Apr 11 23:20:42 satpi SatPI[3650]: send: Connection reset by peer (code 104)
Apr 11 23:20:42 satpi SatPI[3650]: Send htmlBody failed
Apr 11 23:20:42 satpi SatPI[3650]: HTTP Connection from 192.168.112.61 Port 52838 with fd: 27
Apr 11 23:20:43 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x70  Date: 2021-4-11  Time: 21:20.41  MJD: 0xE7B3
Apr 11 23:20:43 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x73  Date: 2021-4-11  Time: 21:20.42  MJD: 0xE7B3
Apr 11 23:20:44 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x70  Date: 2021-4-11  Time: 21:20.42  MJD: 0xE7B3
Apr 11 23:20:44 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x73  Date: 2021-4-11  Time: 21:20.43  MJD: 0xE7B3
Apr 11 23:20:45 satpi SatPI[3650]: Stream: 1, TDT - Table ID: 0x70  Date: 2021-4-11  Time: 21:20.43  MJD: 0xE7B3

vdr.txt

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Thanks you, for your persistence effort so far!

Do you have any way of reproducing this issue?:

Apr 11 23:20:42 satpi SatPI[3650]: Mutex in HttpServer did not lock within timeout?  !!DEADLOCK!!
Apr 11 23:20:42 satpi SatPI[3650]: Mutex in HttpServer not unlocked!!
Apr 11 23:20:42 satpi SatPI[3650]: send: Connection reset by peer (code 104)
Apr 11 23:20:42 satpi SatPI[3650]: Send htmlBody failed
Apr 11 23:20:42 satpi SatPI[3650]: HTTP Connection from 192.168.112.61 Port 52838 with fd: 27
nikolauzi11 commented 3 years ago

Hi @Barracuda09

Yes, if EPG scan and frontend reuse are active in the satip plugin, it occurs after a few minutes. Possibly it has something to do with the very fast use of the tuners during EPG/channel scan. The problem also occurred earlier, when I had not yet increased the timeout in the satip plugin and the tuners were always retuned. I also tested minisatip last night to rule out errors in the Raspi VDR. That worked immediately.

nikolauzi11 commented 3 years ago

Hi @Barracuda09

I have now made another test to exclude that it is somehow the Sundtek driver. I installed my old DVBSky S952 PCIe card into the Dell PC. The result was again the same. It worked briefly in between, but that was not reproducible. But with VLC Player it always works, no matter what platform.

Barracuda09 commented 3 years ago

@nikolauzi11

Thanks for testing so far. I have done some research, and if you can try to disable frontend 0 (So ONLY frontend 1 enabled).

I have the impression that VDR satip plugin does not like StreamID = 0

Kind regards,

Marc

nikolauzi11 commented 3 years ago

Hi @Barracuda09

Thanks for the effort you had. It actually works with frontend 0 disabled. Then after a few channel changes it eventually stops working and the WebIf hangs again. But in the meantime I had also undone the increase of the timeout in the plugin.

Barracuda09 commented 3 years ago

Hi @nikolauzi11

Found the problem inVDR Plugin satip (streamIdM > 0) this should probably be (streamIdM >= 0):

https://github.com/rofafor/vdr-plugin-satip/blob/1ad0a81d16eb5d44f1abd932a41ae79789ff4d34/tuner.c#L497-L504 https://github.com/rofafor/vdr-plugin-satip/blob/1ad0a81d16eb5d44f1abd932a41ae79789ff4d34/tuner.c#L594-L609

I am trying to find the problem with hanging WebIf, which I can not reproduce at the moment