IPTV using Plex and TellyTV: I don't get it running

Dev Community Apps & Creations
,
1

Server Version#: 1.19.5.3112

I have created a dockerized setup of TellyTV and Plex according to documentation (I also tried non-dockerized setups and setups using xteve rather than tellytv. No matter what I do, I keep getting the playback error at the end when I try to play a stream):

TellyTV:

$ cat telly.config.toml
[Discovery]                                    # most likely you won't need to change anything here
  Device-Auth = "telly123"                     # These settings are all related to how telly identifies
  Device-ID = 12345678                         # itself to Plex.
  Device-UUID = ""
  Device-Firmware-Name = "hdhomeruntc_atsc"
  Device-Firmware-Version = "20150826"
  Device-Friendly-Name = "telly"
  Device-Manufacturer = "Silicondust"
  Device-Model-Number = "HDTC-2US"
  SSDP = true

[IPTV]
  Streams = 1               # number of simultaneous streams that telly virtual tuner will provide
  Starting-Channel = 10000  # When telly assigns channel numbers it will start here
  XMLTV-Channels = true     # if true, any channel numbers specified in your M3U file will be used.
  
[Log]
  Level = "info"            # Only log messages at or above the given level. [debug, info, warn, error, fatal]
  Requests = true           # Log HTTP requests made to telly

[Web]
  Base-Address = "192.168.188.20:6077"   # Set this to the IP address of the machine telly runs on AS SEEN BY PLEX
  Listen-Address = "0.0.0.0:6077" # this can stay as-is

[[Source]]
  Name = "Magenta TV"       # Name is optional and is used mostly for logging purposes
  Provider = "Custom"       # DO NOT CHANGE THIS
  M3U = "http://download.avm.de/tv/1/m3u/das_erste.m3u"  # This can be either URL or fully-qualified path.

$ docker run -d \
  --name='telly-test' \
  -e TZ="Europe/Berlin" \
  -p '6077:6077/tcp' \
  -v ${MY_DIR}/telly.config.toml:/etc/telly/telly.config.toml \
  --restart unless-stopped \
  tellytv/telly:dev-ffmpeg
time="2020-08-07T14:39:34Z" level=info msg="telly is preparing to go live (version=1.1.0.6, branch=dev, revision=741108cd2100cf9f4d3a13f771d1ebe5132baae6)"
time="2020-08-07T14:39:34Z" level=info msg="Loading M3U from http://download.avm.de/tv/1/m3u/das_erste.m3u"
time="2020-08-07T14:39:34Z" level=info msg="Loaded 52 channels into the lineup from Magenta TV"
time="2020-08-07T14:39:34Z" level=info msg="telly is live and on the air!"
time="2020-08-07T14:39:34Z" level=info msg="Broadcasting from http://0.0.0.0:6077/"
time="2020-08-07T14:39:34Z" level=info msg="EPG URL: http://0.0.0.0:6077/epg.xml"

Plex:

$ docker run \
  --name=plex \
  --net=host \
  -e PUID=999 \
  -e PGID=999 \
  -e VERSION=docker \
  -e UMASK_SET=022 `#optional` \
  -e PLEX_CLAIM= `#optional` \
  -v /opt/plex:/config \
  -v /Videos/series:/tv \
  -v /Videos/movies:/movies \
  --restart unless-stopped \
  linuxserver/plex

Works as a charm. I can now navigate to Settings-> Live TV & DVR and add TellyTV:

Screenshot from 2020-08-07 16-21-44
Screenshot from 2020-08-07 16-21-441102×454 103 KB

Seems to work. But when I now try to play a show on one of the enabled channels (e.g. using Chrome browser as Plex client) I get a Playback Error:

Screenshot from 2020-08-07 16-20-40
Screenshot from 2020-08-07 16-20-40985×341 50.4 KB

every time. Why is that?

The TellyTV log just says
time="2020-08-07T14:20:23Z" level=info msg="Serving channel number 10001"

Please below an excerpt of the Plex Media Server.log:

Aug 07, 2020 14:33:57.165 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.165 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58434 (Loopback)] POST /livetv/dvrs/2/channels/001/tune (4 live) GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.166 [0x7f58237fe700] DEBUG - Subscription: Starting a new rolling subscription for session hxbuuxqllm9h12qlwxbkwc6j channel 001.
Aug 07, 2020 14:33:57.173 [0x7f58237fe700] DEBUG - Activity: registered new activity e56cbe99-8fd5-413f-a35d-adbe5789644a - Refreshing Sub
Aug 07, 2020 14:33:57.173 [0x7f58237fe700] DEBUG - Activity: updated activity e56cbe99-8fd5-413f-a35d-adbe5789644a - completed 0.0% - Refreshing Sub
Aug 07, 2020 14:33:57.173 [0x7f58237fe700] DEBUG - Activity: updated activity e56cbe99-8fd5-413f-a35d-adbe5789644a - completed 0.0% - Refreshing Sub
Aug 07, 2020 14:33:57.174 [0x7f58237fe700] DEBUG - Activity: updated activity e56cbe99-8fd5-413f-a35d-adbe5789644a - completed 0.0% - Refreshing Sub
Aug 07, 2020 14:33:57.174 [0x7f58237fe700] DEBUG - Activity: registered new activity a5b378f6-a301-490d-9643-9e04c7ba5971 - Processing subscriptions
Aug 07, 2020 14:33:57.174 [0x7f58237fe700] DEBUG - Subscription: Scheduling subscriptions.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - Subscription: Initialized 1 schedulers.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Partitioning, step one, let's compute an absolute ordering.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG -  DVR:NewSchedule: Between 2020-08-07 14:33:57 and 2020-08-07 14:38:57 on channel 001: 'Live TV - Session'
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Initial partitioning completed with 1 partitions.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Partitioning completed with 1 partitions.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: PARTITION of size 1.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG -  DVR:NewSchedule:    Between 2020-08-07 14:33:57 and 2020-08-07 14:38:57 on channel 001: 'Live TV - Session'
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: After processing the partition, we have 1 alternate realities.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: We computed 1 alternative realities in 0 ms.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - DVR:NewSchedule: The winning schedule had score: 10 and 0 conflicts.
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG -  DVR:NewSchedule: device 0 tuner 0 airing 0 between 2020-08-07 14:33:57 and 2020-08-07 14:38:57 on channel 001: 'Live TV - Session'
Aug 07, 2020 14:33:57.175 [0x7f58237fe700] DEBUG - Grabber: Starting grab immediately for 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001 and we're 0 seconds in already.
Aug 07, 2020 14:33:57.176 [0x7f58237fe700] DEBUG - Subscription: Scheduled all subscriptions in 1 ms.
Aug 07, 2020 14:33:57.176 [0x7f58237fe700] DEBUG - Activity: Ended activity a5b378f6-a301-490d-9643-9e04c7ba5971.
Aug 07, 2020 14:33:57.176 [0x7f58017fa700] DEBUG - Grabber: Starting operation for 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001.
Aug 07, 2020 14:33:57.176 [0x7f58017fa700] DEBUG - Activity: registered new activity 7f9d0c47-4bde-495b-85f5-6bd79a49a794 - Recording
Aug 07, 2020 14:33:57.176 [0x7f58237fe700] DEBUG - Subscription: There are 1 active grabs at the end.
Aug 07, 2020 14:33:57.176 [0x7f58017fa700] DEBUG - Grabber: HDHomerun starting a media grab on device device://tv.plex.grabbers.hdhomerun/12345678 (Silicondust telly, supported) tuner 0.
Aug 07, 2020 14:33:57.176 [0x7f58017fa700] DEBUG - Grabber: Creating custom segmented recorder for grab for channel 001
Aug 07, 2020 14:33:57.176 [0x7f58237fe700] DEBUG - Subscription: Waiting for media grab to start.
Aug 07, 2020 14:33:57.176 [0x7f58017fa700] DEBUG - HTTP requesting GET http://192.168.188.20:6077/lineup.json
Aug 07, 2020 14:33:57.176 [0x7f58037fe700] DEBUG - HTTP requesting GET http://192.168.188.20:6077/discover.json
Aug 07, 2020 14:33:57.177 [0x7f58037fe700] DEBUG - HTTP 200 response from GET http://192.168.188.20:6077/discover.json
Aug 07, 2020 14:33:57.177 [0x7f58017fa700] DEBUG - HTTP 200 response from GET http://192.168.188.20:6077/lineup.json
Aug 07, 2020 14:33:57.177 [0x7f58037fe700] DEBUG - HTTP requesting GET http://192.168.188.20:6077/lineup_status.json
Aug 07, 2020 14:33:57.177 [0x7f58017fa700] DEBUG - DVR:Segmenter: Creating a new recorder for http://192.168.188.20:6077/auto/v10000?transcode=heavy.
Aug 07, 2020 14:33:57.177 [0x7f58017fa700] DEBUG - Grabber: Setting timer to stop grab of 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001 in 300 seconds.
Aug 07, 2020 14:33:57.177 [0x7f58017fa700] DEBUG - Grabber: Waiting for a tuner on device://tv.plex.grabbers.hdhomerun/12345678 (1 available) for at most 300 seconds.
Aug 07, 2020 14:33:57.177 [0x7f58017fa700] DEBUG - Grabber: Allocated a tuner on device://tv.plex.grabbers.hdhomerun/12345678 (0 left)
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - Selecting best audio stream for part ID -1 (autoselect: 0 language: en)
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - Audio Stream: -1, Subtitle Stream: -1
Aug 07, 2020 14:33:57.178 [0x7f58037fe700] DEBUG - HTTP 200 response from GET http://192.168.188.20:6077/lineup_status.json
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: Selected protocol hls; container: mpegts
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] ERROR - Unable to find title for item of type 5
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: analyzing media item -1
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: : no direct play video profile exists for http/mpegts/
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: : no direct play video profile exists for http/mpegts//
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: : codec is unavailable for analysis
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: : codec is unavailable for analysis
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] ERROR - Unable to find title for item of type 5
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - MDE: : selected media 0 / -1
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - Cleaning directory for session 249709c3-5926-4531-87fd-baeaf62e9222 ()
Aug 07, 2020 14:33:57.178 [0x7f58017fa700] DEBUG - Starting a transcode session 249709c3-5926-4531-87fd-baeaf62e9222 at offset -1.0 (state=3)
Aug 07, 2020 14:33:57.179 [0x7f58017fa700] DEBUG - Streaming Resource: Added session 0x7f57ec012820:249709c3-5926-4531-87fd-baeaf62e9222
Aug 07, 2020 14:33:57.179 [0x7f58017fa700] DEBUG - Job running: EAE_ROOT='/tmp/pms-2a67dd2b-826e-4b40-a09d-f363909e211c/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/config/Library/Application\ Support/Plex\ Media\ Server/Codecs/5f603a2-3204-linux-x86_64/' XDG_CACHE_HOME='/config/Library/Application Support/Plex Media Server/Cache' XDG_DATA_HOME='/usr/lib/plexmediaserver/Resources' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Transcoder' '-noaccurate_seek' '-ignore_unknown' '-scan_all_pmts' '-1' '-rw_timeout' '30000000' '-reconnect' '1' '-reconnect_streamed' '1' '-reconnect_delay_max' '30' '-fflags' '+discardcorruptts+fillwallclockdts' '-probesize' '20000000' '-i' 'http://192.168.188.20:6077/auto/v10000?transcode=heavy' '-map' '0:V?' '-codec:V' 'copy' '-map' '0:a?' '-codec:a' 'copy' '-map' '0:s?' '-codec:s' 'copy' '-break_non_keyframes' '1' '-segment_format' 'mpegts' '-f' 'ssegment' '-individual_header_trailer' '0' '-segment_time' '1' '-segment_start_number' '0' '-segment_time_delta' '0.25' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/seglist?X-Plex-Http-Pipeline=infinite' '-segment_list_type' 'csv' '-segment_list_size' '5' '-segment_list_separate_stream_times' '1' '-segment_list_unfinished' '1' '-max_delay' '5000000' '-map_metadata' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-xioerror' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress'
Aug 07, 2020 14:33:57.179 [0x7f5831162700] DEBUG - Whacked session 6d852fa3-e316-485d-87d5-fe09f75271da, 1 remaining.
Aug 07, 2020 14:33:57.179 [0x7f5831162700] DEBUG - Streaming Resource: Removing session 0x7f58180476b0:6d852fa3-e316-485d-87d5-fe09f75271da
Aug 07, 2020 14:33:57.179 [0x7f5831162700] DEBUG - Subscription: Destroying rolling subscription session hxbuuxqllm9h12qlwxbkwc6j for channel 001.
Aug 07, 2020 14:33:57.179 [0x7f58017fa700] DEBUG - Jobs: Starting child process with pid 478
Aug 07, 2020 14:33:57.183 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58448 (Loopback)] PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=startup (5 live) Signed-in Token (mystef) (range: bytes=0-) 
Aug 07, 2020 14:33:57.183 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58448] 204 PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=startup (5 live) 0ms 203 bytes (pipelined: 1) (range: bytes=0-) 
Aug 07, 2020 14:33:57.187 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58448 (Loopback)] PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=startup (5 live) Signed-in Token (mystef) (range: bytes=0-) 
Aug 07, 2020 14:33:57.187 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58448] 204 PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=startup (5 live) 0ms 203 bytes (pipelined: 2) (range: bytes=0-) 
Aug 07, 2020 14:33:57.188 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58448 (Loopback)] PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=opening (5 live) Signed-in Token (mystef) (range: bytes=0-) 
Aug 07, 2020 14:33:57.189 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58448] 204 PUT /video/:/transcode/session/249709c3-5926-4531-87fd-baeaf62e9222/50ca2a34-b517-4d85-a57c-e967898738e2/progress?status=opening (5 live) 1ms 203 bytes (pipelined: 3) (range: bytes=0-) 
Aug 07, 2020 14:33:57.189 [0x7f5829ffb700] ERROR - [Transcoder] http://192.168.188.20:6077/auto/v10000?transcode=heavy: Server returned 404 Not Found
Aug 07, 2020 14:33:57.190 [0x7f582bfff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 478 is 1 (failure)
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Streaming Resource: Terminated session 0x7f57ec012820:249709c3-5926-4531-87fd-baeaf62e9222 with reason Recording failed. Please check your tuner or antenna.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - TranscodeSession: session failed while waiting for duration
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] ERROR - Failed to start session.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] ERROR - Recorder: Unable to create transcode session or session failed to start.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Killing job.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Signalling job ID 478 with 9
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Job was already killed, not killing again.
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Job was already killed, not killing again.
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Stopping transcode session 249709c3-5926-4531-87fd-baeaf62e9222
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] ERROR - Recorder: Error 16 (Recording failed. Please check your tuner or antenna.) starting the record, shutting things down.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Grabber: Cleaning up rolling grab for channel 001.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Recorder: No more consumers, stopping.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Recorder: Asked to stop recording 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Grabber: Freed a tuner on device://tv.plex.grabbers.hdhomerun/12345678 (now 1 available)
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Grabber: Operation for 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001 completed with status error (Recording failed. Please check your tuner or antenna.)
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Activity: Ended activity 7f9d0c47-4bde-495b-85f5-6bd79a49a794.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Activity: updated activity e56cbe99-8fd5-413f-a35d-adbe5789644a - completed 100.0% - Refreshing Sub
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Activity: Ended activity e56cbe99-8fd5-413f-a35d-adbe5789644a.
Aug 07, 2020 14:33:57.190 [0x7f5823fff700] DEBUG - Cleaning directory for session 249709c3-5926-4531-87fd-baeaf62e9222 (/config/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-249709c3-5926-4531-87fd-baeaf62e9222)
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Grabber: Cleaning up rolling grab for channel 001.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Recorder: No more consumers, stopping.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] ERROR - Grabber: Starting media grab failed.
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] ERROR - Unknown metadata type: 
Aug 07, 2020 14:33:57.190 [0x7f58017fa700] DEBUG - Asked for unknown type: -1
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Transcoder: Cleaning old transcode directories.
Aug 07, 2020 14:33:57.190 [0x7f5828ff9700] DEBUG - Whacked session 249709c3-5926-4531-87fd-baeaf62e9222, 0 remaining.
Aug 07, 2020 14:33:57.190 [0x7f58237fe700] ERROR - Subscription: Rolling media grab failed to start.
Aug 07, 2020 14:33:57.190 [0x7f58237fe700] DEBUG - Subscription: Cancelling grab for subscription 8: 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001
Aug 07, 2020 14:33:57.190 [0x7f58237fe700] DEBUG - Grabber: Cancelling operation for 'Live TV - Session hxbuuxqllm9h12qlwxbkwc6j' on channel 001 with status cancelled.
Aug 07, 2020 14:33:57.190 [0x7f58237fe700] DEBUG - Grabber: Operation was active, stopping recorder.
Aug 07, 2020 14:33:57.190 [0x7f58237fe700] DEBUG - Grabber: We've cancelled the grab with 300 seconds remaining.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Activity: registered new activity 45781842-607b-4542-be29-2a0d98bdf37d - Processing subscriptions
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Subscription: Scheduling subscriptions.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Subscription: Initialized 1 schedulers.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Partitioning, step one, let's compute an absolute ordering.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Initial partitioning completed with 0 partitions.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - DVR:NewSchedule: Partitioning completed with 0 partitions.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - DVR:NewSchedule: We computed 1 alternative realities in 0 ms.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - DVR:NewSchedule: The winning schedule had score: 0 and 0 conflicts.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Subscription: Scheduled all subscriptions in 0 ms.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Activity: Ended activity 45781842-607b-4542-be29-2a0d98bdf37d.
Aug 07, 2020 14:33:57.191 [0x7f58237fe700] DEBUG - Subscription: There are 0 active grabs at the end.
Aug 07, 2020 14:33:57.191 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58434] 200 POST /livetv/dvrs/2/channels/001/tune (4 live) GZIP 25ms 541 bytes (pipelined: 1)
Aug 07, 2020 14:33:57.350 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.350 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58434 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/all (4 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.351 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.355 [0x7f582affd700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.355 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/shows (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.355 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.361 [0x7f582a7fc700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/shows (5 live) GZIP Page 0-15 6ms 3782 bytes (pipelined: 1)
Aug 07, 2020 14:33:57.363 [0x7f582a7fc700] DEBUG - Completed: [127.0.0.1:58434] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/all (5 live) GZIP Page 0-15 12ms 4250 bytes (pipelined: 2)
Aug 07, 2020 14:33:57.373 [0x7f582affd700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.373 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/sports (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.373 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.376 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/sports (5 live) GZIP Page 0-15 3ms 544 bytes (pipelined: 2)
Aug 07, 2020 14:33:57.378 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.378 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/movies (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.378 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.378 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.379 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58434 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/kids (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.379 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.379 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/movies (5 live) GZIP Page 0-15 1ms 544 bytes (pipelined: 3)
Aug 07, 2020 14:33:57.382 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58434] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/kids (5 live) GZIP Page 0-15 3ms 1372 bytes (pipelined: 3)
Aug 07, 2020 14:33:57.389 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.389 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onnow/news (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.389 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.393 [0x7f582a7fc700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onnow/news (5 live) GZIP Page 0-15 3ms 544 bytes (pipelined: 4)
Aug 07, 2020 14:33:57.396 [0x7f582affd700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.396 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/sections/2/all?type=4&beginsAt%3E=1596826800&beginsAt%3C=1596841200&mediaAnalysisVersion=1&sort=beginsAt (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.397 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.398 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=0)
Aug 07, 2020 14:33:57.398 [0x7f582a7fc700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/sections/2/all?type=4&beginsAt%3E=1596826800&beginsAt%3C=1596841200&mediaAnalysisVersion=1&sort=beginsAt (5 live) GZIP Page 0-15 2ms 695 bytes (pipelined: 5)
Aug 07, 2020 14:33:57.402 [0x7f582affd700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.403 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/playlists/fav (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.403 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.403 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.403 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58434 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/playlists/rec (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.403 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.404 [0x7f582a7fc700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/playlists/fav (5 live) GZIP Page 0-15 1ms 544 bytes (pipelined: 6)
Aug 07, 2020 14:33:57.404 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58434] 200 GET /tv.plex.providers.epg.cloud:2/hubs/playlists/rec (5 live) GZIP Page 0-15 1ms 544 bytes (pipelined: 4)
Aug 07, 2020 14:33:57.407 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.407 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onlater/all (5 live) Page 0-15 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.407 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Aug 07, 2020 14:33:57.412 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onlater/all (5 live) GZIP Page 0-15 5ms 3751 bytes (pipelined: 7)
Aug 07, 2020 14:33:57.413 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.413 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58434 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onlater/movies (5 live) Page 0-16 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.413 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 16] (total=-1)
Aug 07, 2020 14:33:57.414 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.414 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/onlater/kids (5 live) Page 0-50 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.414 [0x7f58237fe700] DEBUG - Setting container serialization range to [0, 50] (total=-1)
Aug 07, 2020 14:33:57.417 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58434] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onlater/movies (5 live) GZIP Page 0-16 3ms 5126 bytes (pipelined: 5)
Aug 07, 2020 14:33:57.427 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.427 [0x7f5829ffb700] DEBUG - Request: [127.0.0.1:58462 (Loopback)] GET /tv.plex.providers.epg.cloud:2/sections/4/all?type=4&beginsAt%3E=now&sort=beginsAt,mediaHeight:desc,mediaAnalysisVersion:desc (7 live) Page 0-50 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.427 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 50] (total=-1)
Aug 07, 2020 14:33:57.427 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.427 [0x7f5803fff700] DEBUG - Request: [127.0.0.1:58460 (Loopback)] GET /tv.plex.providers.epg.cloud:2/metadata/plex%3A%2F%2Fepisode%2F5f2425bce96ad600427bb483?includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&includeStations=1&includeExternalMedia=1&asyncAugmentMetadata=1&asyncCheckFiles=1&asyncRefreshAnalysis=1&asyncRefreshLocalMediaAgent=1&skipRefresh=1 (7 live) GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.428 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/hubs/onlater/kids (7 live) GZIP Page 0-50 14ms 13349 bytes (pipelined: 8)
Aug 07, 2020 14:33:57.429 [0x7f5803fff700] DEBUG - Activity: registered new activity 02f898b4-690b-4585-bd8e-43d6ee31f01e - Refreshing
Aug 07, 2020 14:33:57.429 [0x7f5828ff9700] DEBUG - Activity: updated activity 02f898b4-690b-4585-bd8e-43d6ee31f01e - completed 0.0% - Refreshing
Aug 07, 2020 14:33:57.429 [0x7f5828ff9700] DEBUG - Activity: updated activity 02f898b4-690b-4585-bd8e-43d6ee31f01e - completed 33.0% - Refreshing
Aug 07, 2020 14:33:57.429 [0x7f5828ff9700] DEBUG - Activity: updated activity 02f898b4-690b-4585-bd8e-43d6ee31f01e - completed 66.0% - Refreshing
Aug 07, 2020 14:33:57.429 [0x7f5828ff9700] DEBUG - Activity: Ended activity 02f898b4-690b-4585-bd8e-43d6ee31f01e.
Aug 07, 2020 14:33:57.429 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58460] 200 GET /tv.plex.providers.epg.cloud:2/metadata/plex%3A%2F%2Fepisode%2F5f2425bce96ad600427bb483?includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&includeStations=1&includeExternalMedia=1&asyncAugmentMetadata=1&asyncCheckFiles=1&asyncRefreshAnalysis=1&asyncRefreshLocalMediaAgent=1&skipRefresh=1 (7 live) GZIP 2ms 1726 bytes (pipelined: 1)
Aug 07, 2020 14:33:57.432 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.432 [0x7f582a7fc700] DEBUG - Auth: authenticated user 1 as mystef
Aug 07, 2020 14:33:57.432 [0x7f5803fff700] DEBUG - Request: [127.0.0.1:58458 (Loopback)] GET /tv.plex.providers.epg.cloud:2/metadata/plex%3A%2F%2Fshow%2F5da900d562aeac001f688dca/grandchildren?excludeAllLeaves=1 (7 live) Page 0-0 GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.432 [0x7f58237fe700] DEBUG - Request: [127.0.0.1:58460 (Loopback)] GET /tv.plex.providers.epg.cloud:2/hubs/metadata/plex%3A%2F%2Fepisode%2F5f2425bce96ad600427bb483/related?excludeFields=summary&includeExternalMetadata=1&asyncAugmentMetadata=1 (7 live) GZIP Signed-in Token (mystef)
Aug 07, 2020 14:33:57.433 [0x7f5803fff700] DEBUG - Setting container serialization range to [0, 0] (total=-1)
Aug 07, 2020 14:33:57.434 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58460] 200 GET /tv.plex.providers.epg.cloud:2/hubs/metadata/plex%3A%2F%2Fepisode%2F5f2425bce96ad600427bb483/related?excludeFields=summary&includeExternalMetadata=1&asyncAugmentMetadata=1 (7 live) GZIP 2ms 484 bytes (pipelined: 2)
Aug 07, 2020 14:33:57.435 [0x7f5803fff700] DEBUG - Setting container serialization range to [0, 0] (total=1)
Aug 07, 2020 14:33:57.435 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58458] 200 GET /tv.plex.providers.epg.cloud:2/metadata/plex%3A%2F%2Fshow%2F5da900d562aeac001f688dca/grandchildren?excludeAllLeaves=1 (7 live) GZIP Page 0-0 3ms 1614 bytes (pipelined: 9)
Aug 07, 2020 14:33:57.437 [0x7f5829ffb700] DEBUG - Setting container serialization range to [0, 50] (total=55)
Aug 07, 2020 14:33:57.442 [0x7f582affd700] DEBUG - Completed: [127.0.0.1:58462] 200 GET /tv.plex.providers.epg.cloud:2/sections/4/all?type=4&beginsAt%3E=now&sort=beginsAt,mediaHeight:desc,mediaAnalysisVersion:desc (7 live) GZIP Page 0-50 15ms 7143 bytes (pipelined: 1)
Aug 07, 2020 14:33:58.178 [0x7f5800ff9700] DEBUG - DVR:Segmenter: Stopping idle session: http://192.168.188.20:6077/auto/v10000?transcode=heavy.
2

To receive MagentaTV in PLEX you have to change the MagentaTV multicast stream to http.
I run"IPTV-ReStream" in another container to get xTeVe + PLEX working.

Futher details here:
https://www.heise.de/select/ct/2020/7/2000809370690961974

3

Thanks for the hint, much appreciated! Could you post your configuration here, please (docker run options plus content of config files)?

Cheers

4

OK, @ tleichtw, please give me a piece of guidance, as I followed your suggestion, but it’s stlll not running…

What I did:

I started a IPTV-restream container:

docker run -d --network host --restart always --name IPTV-ReStream -e HOST="0.0.0.0" -e PORT=3000 -e XSPF_PROTOCOL="http" -e XSPF_PATH_PREFIX="/iptv" -e ALLOW_UNKNOWN="false" -e DEBUG="iptv-restream:*" nthumann/iptv-restream:latest

Now it is possible to watch Magenta channels on http URLs, eg.:

    <track>
      <title>Das Erste HD</title>
      <location>http://rift:3000/iptv/live/87.141.215.251@232.0.20.35:10000</location>
      <image>https://ngiss.t-online.de/iss?client=ngtv&amp;y=30&amp;ar=keep&amp;src=http://programm-manager.telekom.de/media/3711d16d0e3570276ebba175620385b5f4ff18f4.png</image>
    </track>

Great! So I created a new M3U for xteve with the http URLs of the channels:

#EXTM3U
#EXTINF:-1 tvg-name="Das Erste HD" tvg-id="ARD.de" group-title="Vollprogramm" tvg-logo="https://raw.githubusercontent.com/jnk22/entertain-iptv/master/logos/tv/daserstehd.png",Das Erste HD
http://rift:3000/iptv/live/87.141.215.251@232.0.20.35:10000
#EXTINF:-1 tvg-name="ZDF HD" tvg-id="ZDF.de" group-title="Vollprogramm" tvg-logo="https://raw.githubusercontent.com/jnk22/entertain-iptv/master/logos/tv/zdfhd.png",ZDF HD
http://rift:3000/iptv/live/87.141.215.251@232.0.20.234:10000

And added xteve as a LiveTV source to plex:

Screen Shot 2020-08-10 at 22.48.02
Screen Shot 2020-08-10 at 22.48.021072×466 100 KB

But I keep getting the Playback error:

Screen Shot 2020-08-10 at 22.42.46
Screen Shot 2020-08-10 at 22.42.46904×296 16.4 KB

Damn!

What’s wrong here?

xteve says:

2020/08/10 22:41:29 [xTeVe] [WARNING] Don't run this as Root!
2020/08/10 22:41:29 [xTeVe] Version:               2.1.2 Build: 0121
2020/08/10 22:41:29 [xTeVe] Database Version:      2.1.0
2020/08/10 22:41:29 [xTeVe] System IP Addresses:   IPv4: 3 | IPv6: 4
2020/08/10 22:41:29 [xTeVe] Hostname:              rift
2020/08/10 22:41:29 [xTeVe] System Folder:         /root/.xteve/
2020/08/10 22:41:29 [xTeVe] Load Settings:         /root/.xteve/settings.json
2020/08/10 22:41:29 [xTeVe] Temporary Folder:      /tmp/xteve/2020-08-0JWX-D4944R/
2020/08/10 22:41:29 [xTeVe] GitHub:                https://github.com/xteve-project
2020/08/10 22:41:29 [xTeVe] Git Branch:            master [xteve-project]
2020/08/10 22:41:29 [xTeVe] SSDP / DLNA:           true
2020/08/10 22:41:29 [xTeVe] UUID:                  2020-08-0JWX-D4944R
2020/08/10 22:41:29 [xTeVe] Tuner (Plex / Emby):   1
2020/08/10 22:41:29 [xTeVe] EPG Source:            PMS
2020/08/10 22:41:29 [xTeVe] Plex Channel Limit:    480
2020/08/10 22:41:29 [xTeVe] Backup Path:           /root/.xteve/backup/
2020/08/10 22:41:29 [xTeVe] Backup file:           /root/.xteve/backup/xteve_auto_backup_20200810_2241.zip
2020/08/10 22:41:29 [xTeVe] Open:                  /home/sbogun/Downloads/xteve.m3u
2020/08/10 22:41:29 [xTeVe] Check File:            /home/sbogun/Downloads/xteve.m3u
2020/08/10 22:41:29 [xTeVe] Save File:             /home/sbogun/Downloads/xteve.m3u [ID: M5K1GNAIPV7TVRKM8IUS]
2020/08/10 22:41:29 [xTeVe] All streams:           2
2020/08/10 22:41:29 [xTeVe] Active streams:        2
2020/08/10 22:41:29 [xTeVe] Filter:                0
2020/08/10 22:41:29 [xTeVe] DVR IP:                172.17.0.1:34400
2020/08/10 22:41:29 [xTeVe] Web Interface:         http://172.17.0.1:34400/web/ | xTeVe is also available via the other 6 IP's.
2020/08/10 22:42:26 [xTeVe] Buffer:                false [-]
2020/08/10 22:42:26 [xTeVe] Channel Name:          Das Erste HD
2020/08/10 22:42:26 [xTeVe] Client User-Agent:     Lavf/58.27.104
2020/08/10 22:42:26 [xTeVe] Streaming URL:         http://rift:3000/iptv/live/87.141.215.251@232.0.20.35:10000
2020/08/10 22:42:26 [xTeVe] Streaming Info:        URL was passed to the client.
2020/08/10 22:42:26 [xTeVe] Streaming Info:        xTeVe is no longer involved, the client connects directly to the streaming server.

Plex says (as it always said):

Aug 10, 2020 22:51:33.020 [0x7f7d12d02700] DEBUG - Auth: authenticated user 1 as mystef
Aug 10, 2020 22:51:33.021 [0x7f7d12501700] DEBUG - Request: [192.168.188.47:53315 (Subnet)] POST /livetv/dvrs/28/channels/001/tune (9 live) GZIP Signed-in Token (mystef)
Aug 10, 2020 22:51:33.021 [0x7f7d12501700] DEBUG - Subscription: Starting a new rolling subscription for session baf7npcki3v0mf1gsv6eyi0l channel 001.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Activity: registered new activity 45776617-0d02-4236-972f-99231778eb98 - Refreshing Sub
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Activity: updated activity 45776617-0d02-4236-972f-99231778eb98 - completed 0.0% - Refreshing Sub
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Activity: updated activity 45776617-0d02-4236-972f-99231778eb98 - completed 0.0% - Refreshing Sub
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Activity: updated activity 45776617-0d02-4236-972f-99231778eb98 - completed 0.0% - Refreshing Sub
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Activity: registered new activity 2344cb47-921f-415c-8074-ab5b0600b6bf - Processing subscriptions
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Subscription: Scheduling subscriptions.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Subscription: Initialized 1 schedulers.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: Partitioning, step one, let's compute an absolute ordering.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG -  DVR:NewSchedule: Between 2020-08-10 22:51:33 and 2020-08-10 22:56:33 on channel 001: 'Live TV - Session'
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: Initial partitioning completed with 1 partitions.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: Partitioning completed with 1 partitions.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: PARTITION of size 1.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG -  DVR:NewSchedule:    Between 2020-08-10 22:51:33 and 2020-08-10 22:56:33 on channel 001: 'Live TV - Session'
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: After processing the partition, we have 1 alternate realities.
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - DVR:NewSchedule: We computed 1 alternative realities in 0 ms.
XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG -  DVR:NewSchedule: device 0 tuner 0 airing 0 between 2020-08-10 22:51:33 and 2020-08-10 22:56:33 on channel 001: 'Live TV - Session'
Aug 10, 2020 22:51:33.027 [0x7f7d12501700] DEBUG - Grabber: Starting grab immediately for 'Live TV - Session baf7npcki3v0mf1gsv6eyi0l' on channel 001 and we're 0 seconds in already.
Aug 10, 2020 22:51:33.028 [0x7f7d12501700] DEBUG - Subscription: Scheduled all subscriptions in 0 ms.
Aug 10, 2020 22:51:33.028 [0x7f7d12501700] DEBUG - Activity: Ended activity 2344cb47-921f-415c-8074-ab5b0600b6bf.
Aug 10, 2020 22:51:33.028 [0x7f7d12501700] DEBUG - Subscription: There are 1 active grabs at the end.
Aug 10, 2020 22:51:33.028 [0x7f7d12501700] DEBUG - Subscription: Waiting for media grab to start.
Aug 10, 2020 22:51:33.028 [0x7f7d03fff700] DEBUG - Grabber: Starting operation for 'Live TV - Session baf7npcki3v0mf1gsv6eyi0l' on channel 001.
Aug 10, 2020 22:51:33.028 [0x7f7d03fff700] DEBUG - Activity: registered new activity 1e77ccec-5fdb-4089-a074-c743310a65f9 - Recording
Aug 10, 2020 22:51:33.028 [0x7f7d03fff700] DEBUG - Grabber: HDHomerun starting a media grab on device device://tv.plex.grabbers.hdhomerun/2020-08-0JWX-D4944R (Silicondust xTeVe, supported) tuner 0.
Aug 10, 2020 22:51:33.028 [0x7f7d03fff700] DEBUG - Grabber: Creating custom segmented recorder for grab for channel 001
Aug 10, 2020 22:51:33.028 [0x7f7d03fff700] DEBUG - HTTP requesting GET http://rift:34400/lineup.json
Aug 10, 2020 22:51:33.028 [0x7f7cd77fe700] DEBUG - HTTP requesting GET http://rift:34400/discover.json
Aug 10, 2020 22:51:33.029 [0x7f7cd77fe700] DEBUG - HTTP 200 response from GET http://rift:34400/discover.json
Aug 10, 2020 22:51:33.029 [0x7f7cd77fe700] DEBUG - HTTP requesting GET http://rift:34400/lineup_status.json
Aug 10, 2020 22:51:33.029 [0x7f7d03fff700] DEBUG - HTTP 200 response from GET http://rift:34400/lineup.json
Aug 10, 2020 22:51:33.029 [0x7f7cd77fe700] DEBUG - HTTP 200 response from GET http://rift:34400/lineup_status.json
Aug 10, 2020 22:51:33.029 [0x7f7d03fff700] DEBUG - DVR:Segmenter: Creating a new recorder for http://rift:34400/stream/f3bc8a2846925f1eda974a67a1054026.
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - Grabber: Setting timer to stop grab of 'Live TV - Session baf7npcki3v0mf1gsv6eyi0l' on channel 001 in 300 seconds.
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - Grabber: Waiting for a tuner on device://tv.plex.grabbers.hdhomerun/2020-08-0JWX-D4944R (1 available) for at most 300 seconds.
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - Grabber: Allocated a tuner on device://tv.plex.grabbers.hdhomerun/2020-08-0JWX-D4944R (0 left)
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - Selecting best audio stream for part ID -1 (autoselect: 1 language: en)
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - Audio Stream: -1, Subtitle Stream: -1
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: Selected protocol hls; container: mpegts
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] ERROR - Unable to find title for item of type 5
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: analyzing media item -1
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: : no direct play video profile exists for http/mpegts/
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: : no direct play video profile exists for http/mpegts//
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: : codec is unavailable for analysis
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] DEBUG - MDE: : codec is unavailable for analysis
Aug 10, 2020 22:51:33.030 [0x7f7d03fff700] ERROR - Unable to find title for item of type 5
5

Hi,

Just had a quick look. At the first glance it looks very similar to mine. I activated FFmpeg in xteve. Not sure if that makes the difference?
And if course restarting the Plex container before changing the tuner setup.

Hope that helps.

Cheers.