Live TV constant buffering *FIXED* - remove Plex and install Emby

Server Version#: 1.24.5.5173
Player Version#: 8.25.1.28703
Tuner Make/Model: Silicon Dust HDHomeRun Connect Quatro
Guide/Lineup name:
Using XMLTV?:
Channel number/Name:

This is an ongoing problem. Live TV constantly buffers. This does not happen with the HD Homerun app that runs natively on Firestick. It seems to have something to do with the audio stream. If i can get a non-spanish stereo audio channel, it tends to happen less. Sometimes deleting the codecs directory from the server helps for a short period of time.

Logs from the Firestick during buffering event:
12-10 17:47:11.151 i: [ExoPlayer][EventLogger] timeline [eventTime=18.65, mediaPos=13.96, window=0, period=0, periodCount=1, windowCount=1, reason=SOURCE_UPDATE
12-10 17:47:11.152 i: [ExoPlayer][EventLogger] period [?]
12-10 17:47:11.165 i: [ExoPlayer][EventLogger] window [16.77, seekable=true, dynamic=true]
12-10 17:47:11.167 i: [ExoPlayer][EventLogger] ]
12-10 17:47:11.168 i: [Player][ExoPlayer] onTimelineChanged (Position: 13959 ms, Duration: 16767 ms)
12-10 17:47:11.397 i: [PlaybackTimeBehaviour] Time: 13781 IsStarted: true
12-10 17:47:12.227 i: [PlaybackTimeBehaviour] Time: 14590 IsStarted: true
12-10 17:47:12.295 i: [HttpServer] /10.0.9.142:48594 - GET /logging
12-10 17:47:12.661 i: [PlaybackTimeBehaviour] Time: 15045 IsStarted: true
12-10 17:47:13.484 i: [PlaybackTimeBehaviour] Time: 15823 IsStarted: true
12-10 17:47:13.931 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:13.936 i: [TranscodeSession] Media choice updated
12-10 17:47:13.944 i: [TranscodeSession] Pausing…
12-10 17:47:13.946 i: [ExoPlayer][EventLogger] state [eventTime=21.43, mediaPos=16.60, window=0, period=0, BUFFERING]
12-10 17:47:13.947 i: [ExoPlayer][EventLogger] isPlaying [eventTime=21.43, mediaPos=16.60, window=0, period=0, false]
12-10 17:47:14.010 e: [ExoPlayer][EventLogger] audioTrackUnderrun [eventTime=21.50, mediaPos=16.60, window=0, period=0, 196608, 341, 578]
12-10 17:47:14.264 i: [ExoPlayer][EventLogger] timeline [eventTime=21.75, mediaPos=16.60, window=0, period=0, periodCount=1, windowCount=1, reason=SOURCE_UPDATE
12-10 17:47:14.266 i: [ExoPlayer][EventLogger] period [?]
12-10 17:47:14.268 i: [ExoPlayer][EventLogger] window [19.77, seekable=true, dynamic=true]
12-10 17:47:14.301 i: [ExoPlayer][EventLogger] ]
12-10 17:47:14.308 i: [Player][ExoPlayer] onTimelineChanged (Position: 16604 ms, Duration: 19770 ms)
12-10 17:47:14.442 i: [EngineEventManager] onBufferingEnded
12-10 17:47:14.444 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:14.446 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:14.447 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:14.462 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:14.464 i: [TranscodeSession] Media choice updated
12-10 17:47:14.471 i: [TranscodeSession] Resuming…
12-10 17:47:14.473 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:14.475 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:14.477 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:14.529 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:14.545 i: [ExoPlayer][EventLogger] state [eventTime=21.96, mediaPos=16.60, window=0, period=0, READY]
12-10 17:47:14.569 i: [ExoPlayer][EventLogger] isPlaying [eventTime=21.96, mediaPos=16.60, window=0, period=0, true]
12-10 17:47:14.697 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:14.711 i: [TranscodeSession] Media choice updated
12-10 17:47:14.715 i: [TranscodeSession] Pausing…
12-10 17:47:14.720 i: [ExoPlayer][EventLogger] state [eventTime=22.20, mediaPos=16.72, window=0, period=0, BUFFERING]
12-10 17:47:14.723 i: [ExoPlayer][EventLogger] isPlaying [eventTime=22.21, mediaPos=16.72, window=0, period=0, false]
12-10 17:47:14.793 i: [EngineEventManager] onBufferingEnded
12-10 17:47:14.794 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:14.796 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:14.797 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:14.834 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:14.835 i: [TranscodeSession] Media choice updated
12-10 17:47:14.837 i: [TranscodeSession] Resuming…
12-10 17:47:14.848 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:14.849 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:14.851 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:14.853 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:14.855 i: [LiveServerActivityBehaviour] Signal quality is 100.
12-10 17:47:14.856 i: [ExoPlayer][EventLogger] state [eventTime=22.25, mediaPos=16.83, window=0, period=0, READY]
12-10 17:47:14.858 i: [ExoPlayer][EventLogger] isPlaying [eventTime=22.25, mediaPos=16.83, window=0, period=0, true]
12-10 17:47:14.875 i: [PlaybackTimeBehaviour] Time: 17258 IsStarted: true
12-10 17:47:14.927 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:14.929 i: [TranscodeSession] Media choice updated
12-10 17:47:14.932 i: [TranscodeSession] Pausing…
12-10 17:47:14.933 i: [ExoPlayer][EventLogger] state [eventTime=22.43, mediaPos=16.96, window=0, period=0, BUFFERING]
12-10 17:47:14.934 i: [ExoPlayer][EventLogger] isPlaying [eventTime=22.43, mediaPos=16.96, window=0, period=0, false]
12-10 17:47:15.198 i: [EngineEventManager] onBufferingEnded
12-10 17:47:15.200 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:15.202 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:15.208 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:15.228 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:15.231 i: [TranscodeSession] Media choice updated
12-10 17:47:15.245 i: [TranscodeSession] Resuming…
12-10 17:47:15.247 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:15.265 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:15.267 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:15.282 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:15.285 i: [ExoPlayer][EventLogger] state [eventTime=22.71, mediaPos=17.08, window=0, period=0, READY]
12-10 17:47:15.305 i: [ExoPlayer][EventLogger] isPlaying [eventTime=22.72, mediaPos=17.09, window=0, period=0, true]
12-10 17:47:15.307 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:15.309 i: [TranscodeSession] Media choice updated
12-10 17:47:15.318 i: [TranscodeSession] Pausing…
12-10 17:47:15.327 i: [ExoPlayer][EventLogger] state [eventTime=22.77, mediaPos=17.11, window=0, period=0, BUFFERING]
12-10 17:47:15.333 i: [ExoPlayer][EventLogger] isPlaying [eventTime=22.78, mediaPos=17.11, window=0, period=0, false]
12-10 17:47:15.571 i: [EngineEventManager] onBufferingEnded
12-10 17:47:15.573 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:15.578 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:15.597 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:15.609 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:15.627 i: [TranscodeSession] Media choice updated
12-10 17:47:15.629 i: [TranscodeSession] Resuming…
12-10 17:47:15.642 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:15.647 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:15.661 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:15.682 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:15.684 i: [ExoPlayer][EventLogger] state [eventTime=23.09, mediaPos=17.19, window=0, period=0, READY]
12-10 17:47:15.708 i: [ExoPlayer][EventLogger] isPlaying [eventTime=23.09, mediaPos=17.19, window=0, period=0, true]
12-10 17:47:15.741 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:15.742 i: [TranscodeSession] Media choice updated
12-10 17:47:15.743 i: [TranscodeSession] Pausing…
12-10 17:47:15.756 i: [ExoPlayer][EventLogger] state [eventTime=23.24, mediaPos=17.27, window=0, period=0, BUFFERING]
12-10 17:47:15.761 i: [ExoPlayer][EventLogger] isPlaying [eventTime=23.24, mediaPos=17.27, window=0, period=0, false]
12-10 17:47:15.838 i: [EngineEventManager] onBufferingEnded
12-10 17:47:15.839 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:15.841 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:15.843 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:15.846 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:15.866 i: [TranscodeSession] Media choice updated
12-10 17:47:15.880 i: [TranscodeSession] Resuming…
12-10 17:47:15.895 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:15.898 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:15.922 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:15.924 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:15.937 i: [ExoPlayer][EventLogger] state [eventTime=23.35, mediaPos=17.30, window=0, period=0, READY]
12-10 17:47:15.939 i: [ExoPlayer][EventLogger] isPlaying [eventTime=23.35, mediaPos=17.30, window=0, period=0, true]
12-10 17:47:16.116 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:16.119 i: [TranscodeSession] Media choice updated
12-10 17:47:16.122 i: [TranscodeSession] Pausing…
12-10 17:47:16.128 i: [ExoPlayer][EventLogger] state [eventTime=23.62, mediaPos=17.47, window=0, period=0, BUFFERING]
12-10 17:47:16.131 i: [ExoPlayer][EventLogger] isPlaying [eventTime=23.62, mediaPos=17.47, window=0, period=0, false]
12-10 17:47:16.196 i: [PlaybackTimeBehaviour] Time: 18575 IsStarted: true
12-10 17:47:16.270 i: [PlaybackTimeBehaviour] Time: 18655 IsStarted: true
12-10 17:47:16.298 i: Fetching [method:GET] https://10.0.9.12:32400/:/timeline?airingID=36537&audioStreamID=81309&context=inline&duration=19770&guid=plex%3A%2F%2Fepisode%2F61a81545e8eae50ea4365369&key=%2Flivetv%2Fsessions%2F002657d8-d6f2-4b7f-9731-c9852117326a&playbackTime=18676&playQueueItemID=5fc76c2fa05ef8002e7a926e-5fc70600a05ef8002e61645f-1639173600000&ratingKey=28454&state=buffering&time=17469&token=...oZ2g&X-Plex-Client-Identifier=91c3e4afbc92382f-com-plexapp-android&X-Plex-Token=...oZ2g&X-Plex-Language=en-us
12-10 17:47:16.393 i: [EngineEventManager] onBufferingEnded
12-10 17:47:16.395 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:16.416 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:16.426 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:16.428 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:16.430 i: [TranscodeSession] Media choice updated
12-10 17:47:16.433 i: [TranscodeSession] Resuming…
12-10 17:47:16.438 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:16.457 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:16.493 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:16.499 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:16.505 i: [ExoPlayer][EventLogger] state [eventTime=23.90, mediaPos=17.53, window=0, period=0, READY]
12-10 17:47:16.516 i: [ExoPlayer][EventLogger] isPlaying [eventTime=23.91, mediaPos=17.53, window=0, period=0, true]
12-10 17:47:16.676 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:16.677 i: [TranscodeSession] Media choice updated
12-10 17:47:16.680 i: [TranscodeSession] Pausing…
12-10 17:47:16.682 i: [ExoPlayer][EventLogger] state [eventTime=24.17, mediaPos=17.70, window=0, period=0, BUFFERING]
12-10 17:47:16.684 i: [ExoPlayer][EventLogger] isPlaying [eventTime=24.17, mediaPos=17.70, window=0, period=0, false]
12-10 17:47:16.940 i: [EngineEventManager] onBufferingEnded
12-10 17:47:16.942 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:16.944 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:16.947 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:16.949 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:16.962 i: [TranscodeSession] Media choice updated
12-10 17:47:16.964 i: [TranscodeSession] Resuming…
12-10 17:47:16.975 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:16.985 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:16.992 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:17.002 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:17.004 i: [ExoPlayer][EventLogger] state [eventTime=24.46, mediaPos=17.79, window=0, period=0, READY]
12-10 17:47:17.005 i: [ExoPlayer][EventLogger] isPlaying [eventTime=24.46, mediaPos=17.79, window=0, period=0, true]
12-10 17:47:17.296 i: [ExoPlayer][EventLogger] timeline [eventTime=24.80, mediaPos=18.12, window=0, period=0, periodCount=1, windowCount=1, reason=SOURCE_UPDATE
12-10 17:47:17.297 i: [ExoPlayer][EventLogger] period [?]
12-10 17:47:17.299 i: [ExoPlayer][EventLogger] window [22.77, seekable=true, dynamic=true]
12-10 17:47:17.300 i: [ExoPlayer][EventLogger] ]
12-10 17:47:17.303 i: [Player][ExoPlayer] onTimelineChanged (Position: 18119 ms, Duration: 22773 ms)
12-10 17:47:17.327 i: [PlaybackTimeBehaviour] Time: 19706 IsStarted: true
12-10 17:47:17.687 i: [EngineEventManager] onBufferingStarted (isSeeking: false)
12-10 17:47:17.688 i: [TranscodeSession] Media choice updated
12-10 17:47:17.689 i: [TranscodeSession] Pausing…
12-10 17:47:17.691 i: [ExoPlayer][EventLogger] state [eventTime=25.19, mediaPos=18.51, window=0, period=0, BUFFERING]
12-10 17:47:17.703 i: [ExoPlayer][EventLogger] isPlaying [eventTime=25.19, mediaPos=18.51, window=0, period=0, false]
12-10 17:47:17.803 i: [LiveServerActivityBehaviour] Signal quality is 100.
12-10 17:47:17.848 i: [PlaybackTimeBehaviour] Time: 20232 IsStarted: true
12-10 17:47:18.007 i: [EngineEventManager] onBufferingEnded
12-10 17:47:18.009 i: [EngineEventManager] onPlaybackResumed
12-10 17:47:18.019 i: [PlaybackTimeBehaviour] Resuming stopwatch
12-10 17:47:18.024 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
12-10 17:47:18.026 i: [AudioFocusBehaviour] Playback resumed
12-10 17:47:18.027 i: [TranscodeSession] Media choice updated
12-10 17:47:18.027 i: [TranscodeSession] Resuming…
12-10 17:47:18.033 i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: true
12-10 17:47:18.044 i: [Player][ExoPlayer] Passing subtitle offset of 0.
12-10 17:47:18.080 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was resumed.
12-10 17:47:18.102 i: [MediaSessionBehaviour] Updating state to PLAYING
12-10 17:47:18.110 i: [ExoPlayer][EventLogger] state [eventTime=25.54, mediaPos=18.62, window=0, period=0, READY]
12-10 17:47:18.112 i: [ExoPlayer][EventLogger] isPlaying [eventTime=25.54, mediaPos=18.62, window=0, period=0, true]
12-10 17:47:18.649 i: [PlaybackTimeBehaviour] Time: 21032 IsStarted: true
12-10 17:47:19.135 i: [PlaybackTimeBehaviour] Time: 21517 IsStarted: true
12-10 17:47:19.884 i: [PlaybackTimeBehaviour] Time: 22268 IsStarted: true
12-10 17:47:20.276 i: [HttpServer] /10.0.9.142:48604 - GET /logging
12-10 17:47:20.296 i: [ExoPlayer][EventLogger] timeline [eventTime=27.79, mediaPos=20.82, window=0, period=0, periodCount=1, windowCount=1, reason=SOURCE_UPDATE
12-10 17:47:20.297 i: [ExoPlayer][EventLogger] period [?]
12-10 17:47:20.298 i: [ExoPlayer][EventLogger] window [25.78, seekable=true, dynamic=true]
12-10 17:47:20.300 i: [ExoPlayer][EventLogger] ]
12-10 17:47:20.302 i: [Player][ExoPlayer] onTimelineChanged (Position: 20829 ms, Duration: 25776 ms)
12-10 17:47:20.637 i: [PlaybackTimeBehaviour] Time: 23022 IsStarted: true
12-10 17:47:20.836 i: [LiveServerActivityBehaviour] Signal quality is 100.

Unsurprisingly, nobody at Plex responds. What a bunch of clowns… :clown_face: :clown_face: :clown_face:

1 Like

they did it on my thread too for the same issue, they don’t care

@tom80H another example

clown bump :clown_face:

1 Like

We are looking into reports of issues with Live TV and the Fire TV devices. Can you provide me the entire log from the Fire TV after reproducing this issue? Attach the logs as a file, do not cut/paste.

removed.

plexlog.log (4.9 MB)

plexlog2.log (1.8 MB)

plexlog3.log (4.1 MB)

@anon18523487

Thanks for the logs. I do see where it is buffering. The logs indicate there are buffer underruns (the app is not getting the data from your server fast enough) so playback has to pause to wait for the data. Do you have any other Plex clients that also have this issue?

If it’s specific to the Fire TV, do you have their ethernet connector? I’ve found the WiFi on Fire devices to be not very good or reliable, even when sitting very close to the router.

Bandwidth is not an issue. I’m hardwired with the ethernet adapter to a gigabit switch with a 10g uplink to the plex server. This ONLY happens with live streams, not with recorded programming, and DOES NOT happen in the native HDHomeRun app, as many others have also pointed out in other threads. ALL of my Plex clients show this issue (all are hardwired), and they don’t have to be playing simultaneously for the behavior to occur.

I found out the devs have been trying to reproduce an issue found in your logs and haven’t been able to. Can you provide details on the specific HDHR device you have, which guide you are using, and what channel you were watching in that last log from yesterday?

Or if you can’t remember, if you can provide a new log with the above information. Thanks.

Model: HDHR5-4US
Firmware: 20210624
Channel: 2.1 KDKADT

I’m not sure what you mean by ā€˜which guide’. It’s the EPG provided by Plex.

What region is the guide from? i.e. zip code. You can PM me if you don’t want to say publicly.

PM’d.

Thanks. I’ve been told that your issue has a potential fix in our latest 8.28 beta, Release Announcements - Android TV beta - #495 by ManuelPG. You can try sideloading that to see if it helps, otherwise you can wait until it becomes available through the Appstore after it becomes public.

Tried side loading * Amazon Fire OS Devices (armv7a) and the install failed.

When will it be available through normal channels?

You might need to uninstall the current version first. Different app signing will affect being able to install over other versions.

The version went public yesterday which means it was submitted to Amazon. Just need to wait for them to approve. They approval times vary so can’t say when it will be available.

Looked good for a while, but after an hour or so, same behavior cropped up.
plexlog4.log (1.1 MB)