Buffering again!

Server Version#: Version 1.15.4.993
Running on Ubuntu 18.10 -64Bit
Memory: Ram 8G
Processor:Intel® Core™ i7-3537U CPU @ 2.00GHz × 4
Graphs: Intel® Ivybridge Mobile
HD: 1 Tera
I’ve been using Plex for years now with the regular now and then buffering but most of the time it works fine. I can watch entire movies without buffering once UNTIL recently at least the last 2 updates the issue started to happen. Now i’m not able to see anything because it keeps on buffering, its SO frustrating. Since it is the same Hardware, same settings and the computer is not running anything else i can’t help to think that the newer Plex versions are causing these issues. Any ideas? I’ve read articles and tried what they suggest but again the only change in the equation is the newer plex version. HELP!!

Please verify you have DEBUG logging enabled, VERBOSE disabled.
Recreate the problem then stop playback.
Wait 30 seconds.
Settings - Server - Troubleshooting - Download Logs.
Attach the ZIP file

Hey Chuck thanks for replying to my post. I’m attaching the logs following the instructions you provided. I played the movie in the same computer i’m using as server. Let me know if you need anything else. Thanks in advance!Plex Media Server Logs_2019-05-08_12-03-31.zip (2.6 MB)

In your Plex/web playback settings, do you have Subtitles set to Burn Always?

ASS subtitles are being burned-in here. Not that easy on an i7-3xxx (like mine)

May 08, 2019 09:58:09.762 [0x7f0a6a688700] DEBUG - Completed: [127.0.0.1:41400] 200 GET /video/:/transcode/universal/dash/mp5dbk2qoxrze67maw2ok0ww/1/115.m4s (10 live) GZIP 201ms 194880 bytes (pipelined: 28)
May 08, 2019 09:58:09.776 [0x7f0a13fff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 08, 2019 09:58:09.776 [0x7f0a13fff700] DEBUG - Selecting best audio stream for part ID 6281 (autoselect: 1 language: en)
May 08, 2019 09:58:09.776 [0x7f0a13fff700] DEBUG - We're going to try to auto-select a subtitle.
May 08, 2019 09:58:09.776 [0x7f0a13fff700] DEBUG - Selected a foreign audio track: eng
May 08, 2019 09:58:09.776 [0x7f0a13fff700] DEBUG - Subtitles: Found a candidate subtitle language [eng] for a foreign film
May 08, 2019 09:58:09.777 [0x7f0a13fff700] DEBUG - Audio Stream: 14137, Subtitle Stream: 14138
May 08, 2019 09:58:09.777 [0x7f0a13fff700] DEBUG - Found session GUID of mp5dbk2qoxrze67maw2ok0ww in session start.
May 08, 2019 09:58:09.778 [0x7f0a13fff700] DEBUG - Using existing transcode session.
May 08, 2019 09:58:09.778 [0x7f0a32ffd700] DEBUG - Request: [127.0.0.1:41400 (Loopback)] GET /video/:/transcode/universal/dash/mp5dbk2qoxrze67maw2ok0ww/0/115.m4s (10 live) GZIP Signed-in
May 08, 2019 09:58:09.779 [0x7f0a32ffd700] DEBUG - Asked for segment 115 from session.
May 08, 2019 09:58:09.779 [0x7f0a32ffd700] DEBUG - Returning segment 115 from session
May 08, 2019 09:58:09.779 [0x7f0a137fe700] DEBUG - Cleaning directory for session mp5dbk2qoxrze67maw2ok0ww (/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-mp5dbk2qoxrze67maw2ok0ww-18d7c7c7-7594-432a-834f-38ab0f803116)

So the currently settings in that section are:
Multi-Channel Audio Boost: HUGE
Subtitle Color: White
Sb-Position: Bottom
Sb-Size: Normal
Burn Size: Only image formats

Shall i change any of those?

try “Automatic” for subtitles. See if that makes a difference.

If not, please get the XML ?

You don’t have a Plex Pass so can’t make use of the HW transcoding capability in the -3xxx

I don’t know how to get the XML but i did the change and the issue remained. Im attaching the logs again to see if you can see something else. Thank you once again for taking the time.Plex Media Server Logs_2019-05-08_12-46-45.zip (2.6 MB)

This looks like damanged timecodes / frame rate in the media. 50.94 isn’t a valid frame rate. 59.94 is the correct value.

May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.287 [0x7f0a30ff9700] DEBUG - Job running: EAE_ROOT='/tmp/pms-e26a6195-2212-4a22-b896-ba2b62e881b5/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/392df4f-2183-linux-x86_64/' XDG_CACHE_HOME='/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache' XDG_DATA_HOME='/usr/lib/plexmediaserver/Resources' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Transcoder' '-codec:#0x01' 'h264' '-codec:#0x02' 'ac3' '-ss' '195' '-noaccurate_seek' '-analyzeduration' '20000000' '-probesize' '20000000' '-i' '/media/SeaGate/TV Shows/True Detective Season 3 Mp4 1080p/True Detective S03E06.mp4' '-filter_complex' '[0:#0x02] aresample=async=1:ocl='\''stereo'\'':osr=48000:rematrix_maxval=15.000000dB[0]' '-map' '0:#0x01' '-codec:0' 'copy' '-map' '[0]' '-metadata:s:1' 'language=eng' '-codec:1' 'aac' '-b:1' '256k' '-f' 'dash' '-min_seg_duration' '5000000' '-skip_to_segment' '40' '-time_delta' '0.0625' '-manifest_name' 'http://127.0.0.1:32400/video/:/transcode/session/9zkpwb4mee9juojtegvq0szd/e7fcedf5-5a9e-4f27-a16d-5389dca7703d/manifest' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'dash' '-map' '0:#0x03' '-metadata:s:0' 'language=eng' '-codec:0' 'ass' '-f' 'segment' '-segment_format' 'ass' '-segment_time' '1' '-segment_header_filename' 'sub-header' '-segment_start_number' '0' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/9zkpwb4mee9juojtegvq0szd/e7fcedf5-5a9e-4f27-a16d-5389dca7703d/seglist?stream=subtitles' '-segment_list_type' 'csv' '-segment_list_size' '2147483647' '-segment_list_separate_stream_times' '1' '-segment_format_options' 'ignore_readorder=1' 'sub-chunk-%05d' '-start_at_zero' '-copyts' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/9zkpwb4mee9juojtegvq0szd/e7fcedf5-5a9e-4f27-a16d-5389dca7703d/progress'
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1
May 08, 2019 11:46:27.288 [0x7f0a13fff700] DEBUG - [TranscodeOutputStream] Changed instance none which had to 25; was at chunk 26 with offset 50.940000 now at chunk -1

To get the XML:

hover over the item
Click the ellipsis
Get Info
View XML
then copy paste it in a triple-grave box like I do here to show you logs.

```
text
```

comes out as

text
<MediaContainer size="1" allowSync="1" identifier="com.plexapp.plugins.library" librarySectionID="2" librarySectionTitle="TV Shows" librarySectionUUID="8a804e8d-466d-4b5c-b04b-3731822c56a6" mediaTagPrefix="/system/bundle/media/flags/" mediaTagVersion="1555951837">
<Video ratingKey="3127" key="/library/metadata/3127" parentRatingKey="3140" grandparentRatingKey="3130" guid="com.plexapp.agents.thetvdb://270633/3/6?lang=en" librarySectionTitle="TV Shows" librarySectionID="2" librarySectionKey="/library/sections/2" type="episode" title="Hunters in the Dark" grandparentKey="/library/metadata/3130" parentKey="/library/metadata/3140" grandparentTitle="True Detective" parentTitle="Season 3" contentRating="TV-MA" summary="Wayne and Roland revisit discrepancies in the Purcell case that were hidden or forgotten over the years. Among those being reevaluated is Tom Purcell, as well as Lucy Purcell’s cousin, Dan O’Brien. The glitter of Amelia’s book release is tarnished by a voice from the past." index="6" parentIndex="3" viewOffset="576000" lastViewedAt="1557337563" year="2019" thumb="/library/metadata/3127/thumb/1556824561" art="/library/metadata/3130/art/1556823273" parentThumb="/library/metadata/3140/thumb/1556823272" grandparentThumb="/library/metadata/3130/thumb/1556823273" grandparentArt="/library/metadata/3130/art/1556823273" grandparentTheme="/library/metadata/3130/theme/1556823273" duration="3537558" originallyAvailableAt="2019-02-10" addedAt="1553713994" updatedAt="1556824561">
<Media id="6241" duration="3537558" bitrate="4143" width="1920" height="1080" aspectRatio="1.78" audioChannels="6" audioCodec="ac3" videoCodec="h264" videoResolution="1080" container="mp4" videoFrameRate="24p" optimizedForStreaming="0" has64bitOffsets="0" videoProfile="high">
<Part accessible="1" exists="1" id="6241" key="/library/parts/6241/1553713994/file.mp4" duration="3537558" file="/media/SeaGate/TV Shows/True Detective Season 3 Mp4 1080p/True Detective S03E06.mp4" size="1834140971" container="mp4" deepAnalysisVersion="3" has64bitOffsets="0" optimizedForStreaming="0" requiredBandwidths="9500,6239,5428,5428,5428,5428,5428,5428" videoProfile="high">
<Stream id="14046" streamType="1" default="1" codec="h264" index="0" bitrate="3758" bitDepth="8" chromaLocation="left" chromaSubsampling="4:2:0" colorPrimaries="bt709" colorRange="tv" colorSpace="bt709" colorTrc="bt709" frameRate="23.976" hasScalingMatrix="0" height="1080" level="50" profile="high" refFrames="5" requiredBandwidths="9121,5855,5062,5062,5062,5062,5062,5062" streamIdentifier="1" width="1920" displayTitle="1080p (H.264)"/>
<Stream id="14047" streamType="2" selected="1" default="1" codec="ac3" index="1" channels="6" bitrate="384" language="English" languageCode="eng" audioChannelLayout="5.1(side)" requiredBandwidths="384,384,384,384,384,384,384,384" samplingRate="48000" streamIdentifier="2" displayTitle="English (AC3 5.1)"/>
<Stream id="14048" streamType="3" selected="1" default="1" codec="mov_text" index="2" bitrate="0" language="English" languageCode="eng" requiredBandwidths="1,1,1,1,1,1,1,1" streamIdentifier="3" displayTitle="English (MOV_TEXT)"/>
<Stream id="14049" streamType="3" codec="mov_text" index="3" bitrate="0" language="English" languageCode="eng" requiredBandwidths="1,1,1,1,1,1,1,1" streamIdentifier="4" displayTitle="English (MOV_TEXT)"/>
</Part>
</Media>
<Director id="15473" filter="director=15473" tag="Daniel Sackheim"/>
<Writer id="15570" filter="writer=15570" tag="Graham Gordy"/>
<Writer id="15556" filter="writer=15556" tag="Nic Pizzolatto"/>
<Extras size="0"> </Extras>
</Video>
</MediaContainer>

How many files have this problem? All of them?

Yes all of them, series or movies whatever i play and the thing is that it is at random. Sometimes i get to see 15 minutes without interruptions and some others interruptions happen every 2-3 seconds.

what else is running on the host. I’m starting to suspect it’s external to PMS because I see the transcoder going into Sloth mode (it’s caught up and sleeps)

Normally nothing, its my desktop computer and i use chrome browser. I’m actually watching the True Detective episode in Videolan player without an issue and i just saw a youtube video too at the same time without an issue. CPU, RAM, LAN and HD utilization are low. Tempeture of CPU is 43 Celcius. I can work with my computer with out issues. No big apps or other servers.

So i got a notification that a new version of PMS was available and i have updated it. I stop and start the service manually via terminal and i’ve been playing movies randomly for few minutes without interruptions… not sure what happened nor if this behavior will be permanent… weird!

Chuck i think i owe you a follow up here: So after that version update i continue to play movies without ANY interruption which is awesome! As i mentioned at the beginning of my post i see these issues happening after a PMS update. So i guess the latest one solved that issue. I really appreciate the time you invested with me. Thank you!

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.