Live TV & DVR: Fixes and Improvements

[OmegaPlexx]

@OmegaPlexx

watching a channel, sometimes it will just stop/pause. You need to exit out of the channel and choose it again, or change channels

It happened again Today and it looks like something to do with transcoding.
We have ‘Use hardware acceleration when available’ and ‘Use hardware-accelerated video encoding’ enabled.
‘Convert video while recording’ is set to ‘Off’ on the tuner settings.
See below log extract at the moment it went to a black screen and I had to exit out and then change the channel:

Apr 08, 2020 11:13:13.938 [12132] DEBUG - DVR:Segmenter: Creating a new recorder for http://IPAddress:5004/auto/v23.
Apr 08, 2020 11:13:13.940 [12132] DEBUG - Grabber: Setting timer to stop grab of 'Live TV - Session 1475afcc16874cef-com-plexapp-android' on channel 23 in 300 seconds.
Apr 08, 2020 11:13:13.940 [12132] DEBUG - Grabber: Waiting for a tuner on device://tv.plex.grabbers.hdhomerun/1251015D (4 available) for at most 300 seconds.
Apr 08, 2020 11:13:13.940 [12132] DEBUG - Grabber: Allocated a tuner on device://tv.plex.grabbers.hdhomerun/1251015D (3 left)
Apr 08, 2020 11:13:13.941 [12132] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 08, 2020 11:13:13.941 [12132] DEBUG - Selecting best audio stream for part ID -1 (autoselect: 1 language: en)
Apr 08, 2020 11:13:13.941 [12132] DEBUG - We're going to try to auto-select a subtitle.
Apr 08, 2020 11:13:13.941 [12132] DEBUG - Audio Stream: -1, Subtitle Stream: -1
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: Selected protocol hls; container: mpegts
Apr 08, 2020 11:13:13.941 [12132] ERROR - Unable to find title for item of type 5
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: analyzing media item -1
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: : no direct play video profile exists for http/mpegts/
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: : no direct play video profile exists for http/mpegts//
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: : codec is unavailable for analysis
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: : codec is unavailable for analysis
Apr 08, 2020 11:13:13.941 [12132] ERROR - Unable to find title for item of type 5
Apr 08, 2020 11:13:13.941 [12132] DEBUG - MDE: : selected media 0 / -1
Apr 08, 2020 11:13:13.942 [12132] DEBUG - Cleaning directory for session aac23e20-8825-46c3-a464-a4f97f71720c ()
Apr 08, 2020 11:13:13.942 [12132] DEBUG - Starting a transcode session aac23e20-8825-46c3-a464-a4f97f71720c at offset -1.0 (state=3)
Apr 08, 2020 11:13:13.942 [12132] DEBUG - Streaming Resource: Added session 0x94590e0:aac23e20-8825-46c3-a464-a4f97f71720c
Apr 08, 2020 11:13:13.943 [12132] DEBUG - TPU: hardware transcoding: enabled, but no hardware decode accelerator found
Apr 08, 2020 11:13:13.943 [12132] DEBUG - TPU: hardware transcoding: final decoder: , final encoder: 
Apr 08, 2020 11:13:13.944 [12132] DEBUG - Job running: EAE_ROOT='\\?\C:\Users\MyUser\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='\\\\?\\C\:\\Users\\MyUser\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\99c90e0-3079-windows-x86\\' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' C:\Program Files (x86)\Plex\Plex Media Server\Plex Transcoder.exe -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://IPAddress:5004/auto/v23 -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/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/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/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress 
Apr 08, 2020 11:13:13.955 [12132] DEBUG - Jobs: Starting child process with pid 888
Apr 08, 2020 11:13:14.020 [5264] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=startup (13 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.021 [11656] DEBUG - Completed: [127.0.0.1:58792] 204 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=startup (13 live) 0ms 203 bytes (pipelined: 1) (range: bytes=0-) 
Apr 08, 2020 11:13:14.046 [5264] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=startup (13 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.046 [11656] DEBUG - Completed: [127.0.0.1:58792] 204 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=startup (13 live) 0ms 203 bytes (pipelined: 2) (range: bytes=0-) 
Apr 08, 2020 11:13:14.047 [5264] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=opening (13 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.047 [11656] DEBUG - Completed: [127.0.0.1:58792] 204 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=opening (13 live) 0ms 203 bytes (pipelined: 3) (range: bytes=0-) 
Apr 08, 2020 11:13:14.395 [11040] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=opened (12 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.395 [11592] DEBUG - Completed: [127.0.0.1:58792] 204 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress?status=opened (12 live) 0ms 203 bytes (pipelined: 4) (range: bytes=0-) 
Apr 08, 2020 11:13:14.396 [11040] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress/stream?index=0&id=2311&codec=mpeg2video&type=video (12 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.396 [11592] DEBUG - Completed: [127.0.0.1:58792] 200 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress/stream?index=0&id=2311&codec=mpeg2video&type=video (12 live) 0ms 195 bytes (pipelined: 5) (range: bytes=0-) 
Apr 08, 2020 11:13:14.397 [11040] DEBUG - Request: [127.0.0.1:58792 (Loopback)] PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress/stream?index=1&id=2312&codec=mp3&type=audio (12 live) Signed-in Token (OmegaPlexx) (range: bytes=0-) 
Apr 08, 2020 11:13:14.397 [11592] DEBUG - Completed: [127.0.0.1:58792] 200 PUT /video/:/transcode/session/aac23e20-8825-46c3-a464-a4f97f71720c/a051d30f-9b06-4540-b6c9-b12ea38ba2a3/progress/stream?index=1&id=2312&codec=mp3&type=audio (12 live) 0ms 195 bytes (pipelined: 6) (range: bytes=0-) 
Apr 08, 2020 11:13:14.458 [11040] ERROR - [Transcoder] [mp3 @ 0087fc00] Header missing
Apr 08, 2020 11:13:14.544 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.579 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.678 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.728 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.779 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.807 [7612] DEBUG - Sync: uploadStatus
Apr 08, 2020 11:13:14.861 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.909 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:14.954 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.029 [11040] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.063 [5264] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.096 [5264] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.163 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.179 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.196 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.229 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.245 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.249 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.
Apr 08, 2020 11:13:15.313 [4460] ERROR - [Transcoder] [mpeg2video @ 0087ec80] Invalid frame dimensions 0x0.

[OmegaPlexx]

And here is a log extract from last night when the stream simply froze/paused. This seems to happen when the current program on the channel you are watching, transitions over to the next program, and the transcoded session is being deleted. For some reason it shows an ‘Access Denied’ error, but the user account has full permissions to that directory.

Apr 08, 2020 00:03:12.380 [7812] DEBUG - Deleting media item 69101.
Apr 08, 2020 00:03:12.385 [7812] DEBUG - Was connected to metadata item 63584, count is now 0.
Apr 08, 2020 00:03:12.386 [7812] DEBUG - Destroying metadata item 63584 (Episode)
Apr 08, 2020 00:03:12.409 [7812] DEBUG - Transcoder: Cleaning old transcode directories.
Apr 08, 2020 00:03:12.411 [7812] DEBUG - Transcoder: Cleaning old transcode directory: "C:\Users\MyUser\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-1e43120f-76d0-4921-8526-a8bfcde6dd27"
Apr 08, 2020 00:03:12.430 [3756] ERROR - Failed to delete session directory (boost::filesystem::remove: Access is denied: "C:\Users\MyUser\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-1e43120f-76d0-4921-8526-a8bfcde6dd27\media-00727.ts")

[DaveBinM]

Rather than posting log extracts, can you attach the full client and server logs so we can review, please?

[protechgarage27_gmail_com]

Improvements:

Being able to keep + 24hrs in programme guide (using something like ff buttons)
Being able to type in channel numbers somehow, which takes you to the channel in the guide.

If watching an SD channel and a HD version of that channel is available a link inside the player to re tune to the HD channel

Being able to quickly navigate to you DVR files within live tv section

[protechgarage27_gmail_com]

There was an error attempting to tune selected channel, please check you connection and try again. Quattro showing 6 tuners in use?

Plex Media Server Logs_2020-04-09_09-45-00 (1).zip (6.6 MB)

[DaveBinM]

If you’ve got a specific issue that requires investigation, please create a separate thread

[SimonCraddock]

Incorrect number of tuners reported in use

Server Version#: 1.19.1.2621 Player Version#: Tuner Make/Model: HDHR QUATRO Plex is reporting 3 tuners in use whilst recording ITV1 (show also available in HD) whilst watching E4. [Annotation 2020-04-04 190403] [Annotation 2020-04-04 190425] [Annotation 2020-04-04 190748] Setting 2 more programs to record Plex now states 5 tuners in use. [Annotation 2020-04-04 1912055] Which is obviously wrong.

Seems to be a bug

[protechgarage27_gmail_com]

Hi thanks for your reply, I have added this issue to Simon’s thread.
Plex news blog: We’ve made lots of fixes around “watch from start,” seeking while watching live, and resuming in-progress recordings.
This error happened after starting an in progress recording from the beginning which is why I posted it here

[AmazingRando24]

I have noticed that a tuner will tend to “hang tuned” for a while after exiting live tv recently. It hasn’t become a bother for me as I don’t bounce off and on a lot.

[wally007]

Based on your recommendations i bought nVidia shield to test the Live TV.

You’re right - Live TV is much much smoother on the Shield than on Apple TV.
Hope with next Apple TV update - you will re-evaluate Apple TV capabilities and unlock the same deinterlacer

I like the player on the Shielf but UI is laggy compared to iOS/tvOS (for example no animation to switching libraries in home screen)

[DaveBinM]

Th specifications of the Apple TV and it’s capabilities haven’t changed, and won’t until there is new hardware.

The UI on the Shield isn’t what I’d call laggy, and having different (or no animations) based on platform conventions isn’t really an indicator of performance.

[wally007]

refresh of the library content (the right side of the home screen) is definitely slower when scrolling thru libraries. i dont think it’s too much to expect for fluid animations UI in 2020.
lack of any animations while scrolling libraries is what i had in mind.

Anyways - it wasnt meant to be a dig at Android or start wars between iOS/Android.
To each his own.

And yes, i meant when there is an update to Apple TV hardware - i hope you will re-evaluate deinsterlacer for live tv. Current Apple TV is 2 years old - it’s up for an update any day now.

Thank you

[cbass]

I’ve been getting the same error since upgrading to 1.19.1.2645.

Apr 13, 2020 15:16:18.903 ERROR Failed to delete session directory (boost::filesystem::remove: Access is denied: “C:\Users\USER\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-9391dd20-8bfb-432e-9f4a-2c373ca6c436\media-00538.ts”)

[xcalx9]

Having identical issues/errors - started a few days ago after upgrading to 1.19.1.2645. Live TV transcoding is crashing every couple minutes on apple tv. Worked flawlessly for the last year.

[wally007]

Been playing with Shield quite bit - and set it to 60Hz in system settings - mostly for gaming from my PC.

I’ve noticed that Live TV in Plex does not change refresh rate to 50Hz when i tune in to a channel (i’m in Europe). Recorded TV, movies etc, all switch to 60, 50, 24Hz - but Live TV does not. Is this a bug or expected ?

If it’s a bug I will provide logs (in network log it clearly says its 1920x1080 50fps feed coming in, but there is no section in the log where it evaluates capability of the display - like there is when locally stored movie is played)

I prefer to have system wide 60Hz for gaming, youtube, etc but with Live TV not switching refresh rate is a bit of a bummer.

[vishal207]

This has been happening to me as well “[Transcoder] [mpeg2video @ 0x1009e00] Invalid frame dimensions 0x0.”

I have Plex server with Ubuntu with live tv via HD Home run prime and shield as my client. Everything is up to date. Was watching CNN (Fios streams it at 1080i) and I’ve seen this ERROR when the AV sync messes up too; especially when going to/from commercials.

Plex Media Server.log (4.7 MB)

[vishal207]

Plex Live TV is soooo close. Cant seem to find a fix for the “Invalid frame dimensions 0x0.” HDHomeRun Prime firmware updated as well.

[sa2000]

@vishal207

This has been happening to me as well “[Transcoder] [mpeg2video @ 0x1009e00] Invalid frame dimensions 0x0.”

I have Plex server with Ubuntu with live tv via HD Home run prime and shield as my client. Everything is up to date. Was watching CNN (Fios streams it at 1080i) and I’ve seen this ERROR when the AV sync messes up too; especially when going to/from commercials.

@vishal207

Plex Live TV is soooo close. Cant seem to find a fix for the “Invalid frame dimensions 0x0.” HDHomeRun Prime firmware updated as well.

There is no evidence that this is causing any issue. The Transcoder does log a lot of abnormalities but most of them have no impact and are just for diagnostic purposes in event of a problem

This shows successful tuning and direct play by the client app on the Shield

Apr 17, 2020 15:53:27.606 [0x7f232b7e6700] DEBUG - Request: [192.168.1.240:33438 (Allowed Network (Subnet))] POST /livetv/dvrs/4/channels/600/tune (30 live) TLS GZIP Signed-in Token (Sonal)
Apr 17, 2020 15:53:29.366 [0x7f237dc7c700] DEBUG - Completed: [192.168.1.240:33438] 200 POST /livetv/dvrs/4/channels/600/tune (31 live) TLS GZIP 1760ms 29598 bytes (pipelined: 7)

Apr 17, 2020 15:53:29.228 [0x7f2334ff9700] DEBUG - Recorder: It took 1.5 sec to start the session for http://192.168.1.23:5004/auto/v600

Apr 17, 2020 15:53:29.616 [0x7f23317f2700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:53:31.511 [0x7f236a293700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 0/2782ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=0ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:53:39.537 [0x7f23377fe700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 7207/9756ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=8034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:53:39.663 [0x7f236aa94700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:53:49.535 [0x7f232fcdd700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 17209/20767ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=18033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:53:49.705 [0x7f232653d700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:53:59.537 [0x7f2331ff3700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 27215/29776ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=28034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:53:59.716 [0x7f232c7e8700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:09.536 [0x7f232c7e8700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 37208/39753ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=38033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:09.759 [0x7f2331ff3700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:19.538 [0x7f236b295700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 47206/49763ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=48033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:19.766 [0x7f2325d3c700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:29.537 [0x7f232c7e8700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 57213/59773ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=58033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:29.771 [0x7f232fcdd700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:39.537 [0x7f232c7e8700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 67212/69783ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=68033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:39.829 [0x7f236828f700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:49.541 [0x7f236828f700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 77212/80760ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=78035ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:49.869 [0x7f232c7e8700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:54:59.538 [0x7f232b7e6700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 87212/89769ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=88033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:54:59.880 [0x7f232553b700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:09.540 [0x7f2330ff1700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 97211/100780ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=98033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:55:09.974 [0x7f2325d3c700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:19.539 [0x7f236b295700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 107206/110757ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=108034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:55:19.949 [0x7f232ecdb700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:29.538 [0x7f23317f2700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 117214/120767ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=118033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:55:30.002 [0x7f232c7e8700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:39.542 [0x7f232f4dc700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 127208/130777ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=128035ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:55:40.039 [0x7f232bfe7700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:49.539 [0x7f232afe5700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 137208/140753ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=138033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:55:50.041 [0x7f236aa94700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:55:59.542 [0x7f232ecdb700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 147208/149762ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=148033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:00.098 [0x7f236828f700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:09.540 [0x7f236aa94700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 157212/159772ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=158033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:10.137 [0x7f232553b700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:19.541 [0x7f232ecdb700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 167208/169782ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=168033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:20.151 [0x7f236a293700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:29.543 [0x7f2331ff3700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 177213/179759ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=178033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:30.127 [0x7f232afe5700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:39.541 [0x7f23317f2700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 187214/190770ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=188033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:40.176 [0x7f2330ff1700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:49.545 [0x7f236828f700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 197207/199779ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=198034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:56:50.215 [0x7f23377fe700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:56:59.544 [0x7f232b7e6700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 207208/209756ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=208034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:00.253 [0x7f232b7e6700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:09.542 [0x7f232f4dc700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 217210/220767ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=218033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:10.267 [0x7f2331ff3700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:19.546 [0x7f2330ff1700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 227207/230777ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=228033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:20.314 [0x7f2367a8e700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:29.543 [0x7f23377fe700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 237207/239752ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=238033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:30.349 [0x7f23297e2700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:39.543 [0x7f23317f2700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 247207/250763ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=248033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:40.384 [0x7f232ecdb700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:49.544 [0x7f2367a8e700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 257206/260773ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=258034ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:57:50.413 [0x7f236b295700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:57:59.544 [0x7f232c7e8700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 267207/269782ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=268033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:58:00.435 [0x7f232fcdd700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:58:09.546 [0x7f236b295700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state playing, progress of 277209/279759ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=278033ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:58:10.476 [0x7f232bfe7700] DEBUG - Client [d84595df42af3d54-com-plexapp-android] reporting timeline state paused, progress of 2815974/3600000ms for guid=plex://episode/5e928157ce88f10042b50202, playbackTime=2353799ms ratingKey=8351 url=, key=/livetv/sessions/0b890cf8-e676-4d09-b797-ed7e4c1d207a, containerKey=, metadataId=8351, source=
Apr 17, 2020 15:58:13.297 [0x7f2367a8e700] DEBUG - Client [211b5a2265d2d3d0-com-plexapp-android] reporting timeline state stopped, progress of 280956/283830ms for guid=plex://episode/5e93d2e43cd2be00405ea6d4, playbackTime=281779ms ratingKey=8356 url=, key=/livetv/sessions/b93e23d5-3d8f-4a2e-85f0-782efd1567c2, containerKey=, metadataId=8356, source=
Apr 17, 2020 15:58:13.329 [0x7f2367a8e700] DEBUG - Streaming Resource: Terminated session 0x30cee10:211b5a2265d2d3d0-com-plexapp-android with reason Client stopped playback.
Apr 17, 2020 15:58:13.338 [0x7f2384937700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 19599 is -9 (signal: Killed)

[vishal207]

Thanks for the response!

What else could be causing the AV sync issue with 1080i streams? The AV sync tends to go haywire after/during commercial breaks…

Could the resolution of the commercials be different than the main program?

I would be ecstatic to help solve this problem for you guys. I love the Plex setup I have right now.

[sa2000]

I cannot say if it is relevant

If you have a problem with AV sync then please raise a specific forum topic for it with relevant title with server logs covering time of the issue and also beforehand start a curl capture of the channel stream and note down exact times for when the channel stream capture was started and the times when the AV sync was ok and at what time it drifted

For the channel curl stream capture - assuming it is the channel mentioned above, please run this curl command before starting the test

curl http://192.168.1.23:5004/auto/v600 > chan600.ts

break in on this capture when you reproduce the problem

Please remember to note down times and make sure server is running with right time

Please also capture the android app log

Android, Android TV, Fire TV Logs | Plex Support

For the .ts file please zip and upload to google drive or dropbox etc and share a link