Server Version#: 1.24.1.4931-1a38e63c6
Player Version#: LG WebOS, Client 5.23.1, Platform 4.3.0
Hi,
Before I start: I am 100% sure that the same combination of server hardware/client hardware/audio/video/subtitle resulted in Direct Play before, so there must be something else going on…
Since a few days multiple LG WebOS clients have shown stuttering/buffering. Apparently because the decision is made to transcode, and burn the external SRT file:
The CPU cannot (and should not have to!) handle the load of burning…
An excerpt (filtered on direct play and MDE) of the PMS logging:
Sep 01, 2021 13:52:04.354 [0x7fe0d509db38] DEBUG - Request: [172.28.0.4:35410 (WAN)] GET /video/:/transcode/universal/decision?directPlay=1&directStream=1&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=sidecar&location=wan (6 live) GZIP Signed-in Token (*USERNAME*)
Sep 01, 2021 13:52:04.366 [0x7fe0d509db38] DEBUG - [Transcode] MDE: Selected protocol http; container: srt
Sep 01, 2021 13:52:04.366 [0x7fe0d509db38] DEBUG - [Transcode] MDE: analyzing media item 25078
Sep 01, 2021 13:52:04.366 [0x7fe0d509db38] DEBUG - [Transcode] MDE: *MOVIE NAME*: no direct play video profile exists for http/mkv/h264
Sep 01, 2021 13:52:04.366 [0x7fe0d509db38] DEBUG - [Transcode] MDE: *MOVIE NAME*: no direct play video profile exists for http/mkv/h264/eac3
Sep 01, 2021 13:52:04.366 [0x7fe0d509db38] DEBUG - [Transcode] MDE: *MOVIE NAME*: transcoding selected subtitle stream
Sep 01, 2021 13:52:04.367 [0x7fe0d509db38] DEBUG - [Transcode] MDE: *MOVIE NAME*: selected media 0 / 25078
Sep 01, 2021 13:52:04.367 [0x7fe0d509db38] DEBUG - [Transcode] Streaming Resource: Reached Decision id=10489 codes=(MDE=1000,Direct play OK.) media=(id=25078 part=(id=25080 decision=direct play protocol=hls streams=(Video=(id=58497 decision= width=1920 height=800) Audio=(id=58498 decision= channels=0 rate=0) Subtitle=(id=58570 decision=copy languageCode=nld location=sidecar))))
Sep 01, 2021 13:52:04.368 [0x7fe0d4257b38] DEBUG - Completed: [172.28.0.4:35410] 200 GET /video/:/transcode/universal/decision?directPlay=1&directStream=1&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=sidecar&location=wan (6 live) GZIP 13ms 2810 bytes
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: Selected protocol hls; container: mpegts
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: analyzing media item 25078
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: Direct Play is disabled
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: media must be transcoded in order to use the hls protocol
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: selected subtitle cannot be converted to a compatible format, burning into video stream
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: Direct Streaming is disabled, so video stream will be transcoded
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: no remuxable profile found, so video stream will be transcoded
Sep 01, 2021 13:52:06.455 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: Cannot direct stream video stream due to profile or setting limitations
Sep 01, 2021 13:52:06.457 [0x7fe0d3dbcb38] DEBUG - [Transcode] MDE: *MOVIE NAME*: selected media 0 / 25078
Sep 01, 2021 13:52:06.458 [0x7fe0d3dbcb38] DEBUG - [Transcode] Streaming Resource: Reached Decision id=10489 codes=(General=1001,Direct play not available; Conversion OK. Direct Play=3000,App cannot direct play this item. Direct play is disabled. Transcode=1001,Direct play not available; Conversion OK.) media=(id=25078 part=(id=25080 decision=transcode container=mpegts protocol=hls streams=(Video=(id=58497 decision=transcode bitrate=16008 encoder=h264_vaapi width=1920 height=800) Audio=(id=58498 decision=copy channels=6 rate=48000) Subtitle=(id=58570 decision=burn languageCode=nld location=embedded))))
Sep 01, 2021 13:52:04.467 [0x7fe0d509db38] DEBUG - Request: [172.28.0.4:35412 (WAN)] GET /subtitles/:/transcode/universal/start?Accept=application%2Fjson&Accept-Language=nl&directPlay=1&directStream=1&directStreamAudio=1&protocol=http&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=sidecar&location=wan©ts=1 (6 live) GZIP Signed-in Token (*USERNAME*)
Sep 01, 2021 13:52:05.159 [0x7fe0d4257b38] DEBUG - Completed: [172.28.0.4:35412] 200 GET /subtitles/:/transcode/universal/start?Accept=application%2Fjson&Accept-Language=nl&directPlay=1&directStream=1&directStreamAudio=1&protocol=http&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=sidecar&location=wan©ts=1 (18 live) GZIP 691ms 28885 bytes
Sep 01, 2021 13:52:06.441 [0x7fe0d3dbcb38] DEBUG - Request: [172.28.0.4:38552 (WAN)] GET /video/:/transcode/universal/decision?directPlay=0&directStream=0&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=burn&location=wan (10 live) GZIP Signed-in Token (*USERNAME*)
Sep 01, 2021 13:52:06.459 [0x7fe0d4257b38] DEBUG - Completed: [172.28.0.4:38552] 200 GET /video/:/transcode/universal/decision?directPlay=0&directStream=0&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=burn&location=wan (10 live) GZIP 18ms 2744 bytes
Sep 01, 2021 13:52:06.952 [0x7fe0d30cab38] DEBUG - Request: [172.28.0.4:38560 (WAN)] GET /video/:/transcode/universal/start.m3u8?Accept=application%2Fjson&Accept-Language=nl&directPlay=0&directStream=0&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=burn&location=wan (10 live) GZIP Signed-in Token (*USERNAME*) (range: bytes=0-)
Sep 01, 2021 13:52:06.966 [0x7fe0d4257b38] DEBUG - Completed: [172.28.0.4:38560] 206 GET /video/:/transcode/universal/start.m3u8?Accept=application%2Fjson&Accept-Language=nl&directPlay=0&directStream=0&directStreamAudio=1&protocol=hls&fastSeek=1&path=%2Flibrary%2Fmetadata%2F10489&session=ogz0gcev5gqvcfu0iedkedxl&mediaIndex=0&partIndex=0&mediaBufferSize=50000&hasMDE=1&subtitleSize=100&videoQuality=100&videoResolution=3840x2160&audioBoost=100&subtitles=burn&location=wan (10 live) GZIP 13ms 381 bytes (range: bytes=0-)
Somewhere along the line it states that Direct Play is disabled, however, the LG WebOS client is set-up as follows:
- Allow Direct Play: yes
- Allow Direct Stream: yes
- Remote quality: original
- Burn subtitles: only image formats
This is what I get as playback information:
(EDIT) Added LG client logging:
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] Navigating to screen: VisualMediaPlaybackScreen
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [PlaybackMetrics] Attaching playback metrics to PlayerController
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [SubtitleConnectionManager] Subtitle connection ignored. App is not rendering subtitles.
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [ServerConnectionTestManager] Stopped
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] Navigated to screen: VisualMediaPlaybackScreen
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] WARN - [Plex for LG] [] _onOnPlayPauseInvokedChanged is not defined for @autoCallback property: onPlayPauseInvoked
Sep 01, 2021 14:49:23.590 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [MDE] Application decision, directPlay: true, directStreamVideo: true, directStreamAudio: true
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] videoStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] audioStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] subtitleStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [MDE] Server decision, directPlay: true, directStreamVideo: true, directStreamAudio: true
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] reason: Direct afspelen OK.
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Setting up player for playback
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Creating player
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Created player
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Set player
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [SubtitleConnectionManager] Creating new subtitles connection
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Checking for Ad
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Finished checking for Ad
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [PlaybackSessionController] playback state changed to: buffering
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Opening playback
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [SubtitleConnectionManager] Subtitle connection closed.
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] DEBUG - [Plex for LG] [] [SubtitleTracker] Subtitles connection closed. Reconnect at: 48:44
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [PlaybackSessionController] playback state changed to: playing
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [PlaybackSessionController] playback state changed to: buffering
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] WARN - [Plex for LG] [] [Player] A critical HTML media error occurred: 3 (Decoderen); the player cannot recover
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [PlaybackSessionController] playback state changed to: stopped
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] ERROR - [Plex for LG] [] Playback error occurred. Reason: Unknown, An unknown player error occurred. code: 3, message: Decoderen
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] WARN - [Plex for LG] [] [PlaybackSessionController] able to retry playback, {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [MDE] Application decision, directPlay: false, directStreamVideo: true, directStreamAudio: true
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] Application disabled direct play.
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] videoStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] audioStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] subtitleStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] Forcing subtitle burn: HLS direct stream incompatible
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] Cannot direct play subtitles. Reason: Server required to burn subtitles
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] [MDE] Server decision, directPlay: false, directStreamVideo: false, directStreamAudio: true
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] reason: Applicatie kan dit item niet direct afspelen. Direct afspelen is uitgeschakeld.
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] videoStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] audioStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] subtitleStream: {
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] augmentations with profile: Generic
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-transcode-target streaming videoProfile hls mpegts h264,hevc,mpeg2video,mpeg4 aac,ac3,eac3,mp2,mp3
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation videoAudioCodec mp2 upperBound audio.bitrate 350
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation videoAudioCodec mp3 upperBound audio.bitrate 350
Sep 01, 2021 14:49:23.591 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget h264 hls upperBound video.bitDepth 8
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget h264 hls upperBound video.width 3840
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget h264 hls upperBound video.height 2160
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget hevc hls upperBound video.bitDepth 10
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget hevc hls upperBound video.width 3840
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget hevc hls upperBound video.height 2160
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg2video hls upperBound video.bitDepth 8
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg2video hls upperBound video.width 1920
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg2video hls upperBound video.height 1080
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg4 hls upperBound video.bitDepth 8
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg4 hls upperBound video.width 1920
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-limitation streaming videoTranscodeTarget mpeg4 hls upperBound video.height 1080
Sep 01, 2021 14:49:23.592 [0x7fe0d29e0b38] INFO - [Plex for LG] [] add-transcode-target all subtitleProfile http srt
Sep 01, 2021 14:49:23.645 [0x7fe0d2c37b38] DEBUG - [Now] Device is webOS (LG OLED55C8PLA).
Sep 01, 2021 14:49:26.805 [0x7fe0d3109b38] DEBUG - [Now] Device is webOS (LG OLED55C8PLA).
Sep 01, 2021 14:49:26.850 [0x7fe0d2f65b38] DEBUG - [Now] Device is webOS (LG OLED55C8PLA).
Sep 01, 2021 14:49:28.599 [0x7fe0d2f65b38] DEBUG - [Plex for LG] [] [PlaybackSessionController] Setting up player for playback
Can anyone help?? Thanks!