PMS not streaming .mkv files while transcoding is needed

Plex Media Server Desktops & Laptops
,
1

Hi,

I’ve installed PMS on my Mac Mini with Debian Stretch, but I’m not able to stream .mkv files to a browser or to a devices that does not accept Direct Play. I see that PMS is transcoding the file, but the circle in the browser stays on “loading”. It seems that PMS does not stream the file before it completed the whole transcoding process. But I can play a .mp4 movie, this is not an issue.

When I open the Plex client on my laptop that supports Direct Play, the movie .mkv will play.

I’ve tried almost everything for a couple of days, reinstalled PMS, changed almost all settings but nothing will help.

I’m using: PMS Version 1.13.2.5154 on

|Distributor ID:|Debian|
|---|---|
|Description:|Debian GNU/Linux 9.4 (stretch)|
|Release:|9.4|
|Codename:|stretch|

I’ve attached the logfiles…

I hope someone can help me.

…

Some logging where I expect it goes wrong, it keeps going till there is a timeout.

Jun 25, 2018 17:50:13.488 [0x7fcb9bff3700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:50:13.489 [0x7fcb9bff3700] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
Jun 25, 2018 17:50:13.489 [0x7fcbaf3fe700] DEBUG - Completed: [192.168.1.100:59422] 206 PUT /video/:/transcode/session/lxi4cd328w800nsp6ia64bqq/718aba57-b21c-4705-845b-66ae77c26528/progress?progress=16.5&size=-22&remaining=139&speed=38.6 (9 live) 1ms 326 bytes (range: bytes=0-)
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] DEBUG - Request: [192.168.1.100:59424 (WAN)] POST /video/:/transcode/session/lxi4cd328w800nsp6ia64bqq/718aba57-b21c-4705-845b-66ae77c26528/manifest (10 live) Signed-in
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * Transfer-Encoding => chunked
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * User-Agent => Lavf/58.9.100
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * Accept => */*
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * Connection => close
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * Host => 127.0.0.1:32400
Jun 25, 2018 17:50:13.504 [0x7fcbaf3fe700] VERBOSE -  * Icy-MetaData => 1

Jun 25, 2018 17:52:49.874 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:50.377 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:50.878 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:51.377 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:51.878 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:52.378 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:52.879 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:53.380 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:53.881 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:54.381 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:54.882 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:55.382 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:55.882 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:56.384 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:56.884 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:57.384 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:57.884 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:58.384 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:58.886 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:59.386 [0x7fcb9b7f2700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
Jun 25, 2018 17:52:59.887 [0x7fcbadbff700] VERBOSE - We want 60 seconds ahead, last returned was -1.000000 and max is -1.000000.
...
...
...
2

Would you please go back to DEBUG logging and test again?

From what little I can see with VERBOSE on at the very end of the logfile, PMS is doing what it should but FF on OSX is having the problem.

Jun 25, 2018 15:43:20.989 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Client-Identifier => njgp6dx3gckua5d57vqgi2pj
Jun 25, 2018 15:43:20.989 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Device => OSX
Jun 25, 2018 15:43:20.989 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Device-Name => Firefox
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Device-Screen-Resolution => 1096x713,2560x1440
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Language => en
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Platform => Firefox
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Platform-Version => 60.0
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Product => Plex Web
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Sync-Version => 2
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * X-Plex-Version => 3.53.7
Jun 25, 2018 15:43:20.990 [0x7fcba0ffd700] VERBOSE -  * deviceClass => pc
3

Hi ChackPA,

Thanks, I did a couple of tests.

1. from 18:34 - 18:35: try to play the .mkv movie on PlexWeb on OSX (2 times) without any success

2. from 18:38 - 18:41: try to play the .mkv movie on PlexAPP on iOS (1 time, it’s loading longer than PlexWebb) without any success (below the server stats, the Sessions dir is growing very fast. (it’s on SSD)

top - 18:39:33 up 1 day,  6:53,  4 users,  load average: 0.98, 0.80, 0.69
Tasks: 164 total,   2 running, 162 sleeping,   0 stopped,   0 zombie
%Cpu(s): 22.5 us,  2.8 sy,  0.0 ni, 71.8 id,  2.4 wa,  0.0 hi,  0.5 si,  0.0 st
KiB Mem :  8156120 total,   135660 free,  1681560 used,  6338900 buff/cache
KiB Swap:  8365052 total,  8314136 free,    50916 used.  6084080 avail Mem

  PID USER      PR  NI    VIRT    RES    SHR S  %CPU %MEM     TIME+ COMMAND
26386 root      20   0  118784  37064  10000 R  90.4  0.5   0:59.32 /usr/lib/plexmediaserver/Plex Transcoder -codec:0 h264 -codec:1 ac3 -noaccurate_seek -i /test/xXx Return of Xander Cage (2017)/xXx Ret+

root@MacMedia:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode# du -h .
4.8G	./Sessions/plex-transcode-D6D08168-9480-4B96-B69B-A567BB9AB9DA-4a7e8f94-42c1-4986-8bde-8a8d55c50ed8
4.8G	./Sessions
4.8G	.
root@MacMedia:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode# du -h .
5.6G	./Sessions/plex-transcode-D6D08168-9480-4B96-B69B-A567BB9AB9DA-4a7e8f94-42c1-4986-8bde-8a8d55c50ed8
5.6G	./Sessions
5.6G	.
root@MacMedia:/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode#

3. from 18:42 - 18:42: play the .mkv movie on PlexAPP on OSX (1 time) with success. It starts directly.

4. from 18:43 - 18:44: play the .mp4 movie on PlexWeb on OSX (1 time) with success. It starts directly.

The logs:
…

4

Now only (as you asked :wink: ) with DEBUG Level.

1. from 18:52 - 18:56: try to play the .mkv movie on PlexWeb on OSX (1 time) without success

Logfiles: …

5

It is actually playing. PMS is transcoding the MKV and sending it to you. I am not a browser or a MacOS guy so cannot advise in any capacity other than some blocker in the browser?

MP4 is natively accepted by Safari where MKV is not. Yes, you are using FireFox but there is a common element in that somewhere I don’t understand because it is a browser-issue. (I am a server / OS guy).

I do know MKV is converted to HLS or fMP4 when sending to MacOS because of the MKV limitation by Apple’s media core.

Does this make any sense to you?

Your logs show:

xXx Return of Xander Cage (2017) Bluray-1080p.mkv
Jun 25, 2018 18:52:52.878 [0x7f8342fff700] DEBUG - Job running: EAE_ROOT='/tmp/pms-028cdda2-223e-4882-bd9e-e373c2023597/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/e2b7800-1302-linux-ubuntu-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:0' 'h264' '-codec:1' 'ac3' '-ss' '0' '-noaccurate_seek' '-i' '/test/xXx Return of Xander Cage (2017)/xXx Return of Xander Cage (2017) Bluray-1080p.mkv' '-filter_complex' '[0:1] aresample=async=1:ocl='\''stereo'\'':osr=48000[0]' '-map' '0:0' '-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' '1' '-time_delta' '0.0625' '-manifest_name' 'http://127.0.0.1:32400/video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/manifest' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'dash' '-start_at_zero' '-copyts' '-vsync' 'cfr' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress'
Jun 25, 2018 18:52:52.880 [0x7f8342fff700] DEBUG - Jobs: Starting child process with pid 28494
Jun 25, 2018 18:52:52.919 [0x7f833cffe700] DEBUG - Request: [192.168.1.100:47192 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/stream?index=0&id=0&codec=h264&type=video (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.920 [0x7f834ffff700] DEBUG - Completed: [192.168.1.100:47192] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/stream?index=0&id=0&codec=h264&type=video (9 live) 1ms 227 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.920 [0x7f83407fa700] DEBUG - Request: [192.168.1.100:47194 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/stream?index=1&id=0&codec=ac3&type=audio (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.921 [0x7f834ffff700] DEBUG - Completed: [192.168.1.100:47194] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/stream?index=1&id=0&codec=ac3&type=audio (9 live) 0ms 227 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.979 [0x7f833cffe700] DEBUG - Request: [192.168.1.100:47196 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&width=1920&height=800&interlaced=0&sar=1:1&level=41&frameRate=23.976&disp_default=1 (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.979 [0x7f834f7fe700] DEBUG - Completed: [192.168.1.100:47196] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&width=1920&height=800&interlaced=0&sar=1:1&level=41&frameRate=23.976&disp_default=1 (9 live) 0ms 227 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.980 [0x7f83407fa700] DEBUG - Request: [192.168.1.100:47198 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=1&id=0&codec=ac3&type=audio&bitrate=640000&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.981 [0x7f834ffff700] DEBUG - Completed: [192.168.1.100:47198] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=1&id=0&codec=ac3&type=audio&bitrate=640000&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (9 live) 0ms 227 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.981 [0x7f833cffe700] DEBUG - Request: [192.168.1.100:47200 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=2&id=0&codec=subrip&type=subtitle&language=eng&disp_default=1&disp_forced=1 (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.983 [0x7f834ffff700] DEBUG - Completed: [192.168.1.100:47200] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress/streamDetail?index=2&id=0&codec=subrip&type=subtitle&language=eng&disp_default=1&disp_forced=1 (9 live) 1ms 227 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.988 [0x7f83407fa700] DEBUG - Request: [192.168.1.100:47202 (WAN)] PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress?duration=6406.304000 (9 live) Signed-in Token (bvanelst)
Jun 25, 2018 18:52:52.988 [0x7f8342fff700] DEBUG - Started session successfully: t3579xk628itx5j3jf4qkgsl
Jun 25, 2018 18:52:52.989 [0x7f834f7fe700] DEBUG - Completed: [192.168.1.100:47202] 206 PUT /video/:/transcode/session/t3579xk628itx5j3jf4qkgsl/e8bb269e-1448-453c-ba1d-8abfacd2d464/progress?duration=6406.304000 (9 live) 1ms 326 bytes (range: bytes=0-) 
Jun 25, 2018 18:52:52.991 [0x7f834f7fe700] DEBUG - Completed: [192.168.1.12:56330] 200 GET /video/:/transcode/universal/start.mpd?hasMDE=1&path=%2Flibrary%2Fmetadata%2F579&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&addDebugOverlay=0&autoAdjustQuality=1&directStreamAudio=1&mediaBufferSize=102400&session=t3579xk628itx5j3jf4qkgsl&subtitles=burn&Accept-Language=en (9 live) TLS GZIP 152ms 1023 bytes (pipelined: 6)
Jun 25, 2018 18:52:53.026 [0x7f834f7fe700] DEBUG - Auth: authenticated user 1 as bvanelst
Jun 25, 2018 18:52:53.026 [0x7f833cffe700] DEBUG - Request: [192.168.1.12:56330 (Subnet)] GET /status/sessions (8 live) TLS GZIP Signed-in Token (bvanelst)
Jun 25, 2018 18:52:53.027 [0x7f833cffe700] DEBUG - [Now] Adding 0 sessions.
Jun 25, 2018 18:52:53.028 [0x7f834f7fe700] DEBUG - Completed: [192.168.1.12:56330] 200 GET /status/sessions (8 live) TLS GZIP 1ms 470 bytes (pipelined: 7)
Jun 25, 2018 18:52:53.245 [0x7f8342fff700] DEBUG - Request: [192.168.1.12:56330 (Subnet)] GET /video/:/transcode/universal/dash/t3579xk628itx5j3jf4qkgsl/1/initial.mp4 (8 live) TLS GZIP Signed-in
Jun 25, 2018 18:52:53.245 [0x7f833cffe700] DEBUG - Request: [192.168.1.12:56331 (Subnet)] GET /video/:/transcode/universal/dash/t3579xk628itx5j3jf4qkgsl/1/0.m4s (8 live) TLS GZIP Signed-in
Jun 25, 2018 18:52:53.245 [0x7f833cffe700] DEBUG - Asked for segment 0 from session.
Jun 25, 2018 18:52:53.261 [0x7f8349ffe700] DEBUG - Request: [192.168.1.12:56332 (Subnet)] GET /video/:/transcode/universal/dash/t3579xk628itx5j3jf4qkgsl/0/initial.mp4 (8 live) TLS GZIP Signed-in
Jun 25, 2018 18:52:53.261 [0x7f83407fa700] DEBUG - Request: [192.168.1.12:56333 (Subnet)] GET /video/:/transcode/universal/dash/t3579xk628itx5j3jf4qkgsl/0/0.m4s (8 live) TLS GZIP Signed-in
Jun 25, 2018 18:52:53.262 [0x7f83407fa700] DEBUG - Asked for segment 0 from session.
6

I understand you completely, I see also that the Transcoder is transcoding. I’ve tested it on different “platforms” iOS App, WebApp, PS4 App and Google Chromecast. They have all the same issue, they wait for the “stream” and the server is transcoding. I’ve tested it on my local network (1Gbps), through my internet connection (750Mbps) and even with 3/4G. The problem is everywhere the same.

A month ago I had OSX running on the current server (mac mini) and that had no issues. I really don’t understand why it’s transcoding but the clients are not playing the movie.

What I can do is build PMS from source or an older version, and see what happens?

Can you give me the links to those files, I can’t find them.

7

PMS source is closed / proprietary. Did you save any of the package files you previously downloaded? Those are all there are. (The repository is being completely overhauled and everything old has been removed until complete)

This is sounding a lot like a secure socket (SSL) issue where opening the data stream from the server by the client for the video isn’t reaching PMS.

To rule out networking, Settings - Server - Network - Preferred instead of Required.

8

Unfortunately I don’t have the “old” files I previously downloaded, I’ve removed them.

Preferred was already enabled at Secure network configuration. I’ve now disabled it, but still the same issue. See the logfile for more details.

…

But it’s strange that the .mp4 stream and also the Direct Play stream works. And when the server is transcoding it will not work. Is the transcoding maybe using an other port or protocol or depends on Third-party library’s?
Can I enable some more debug logging or will a TCPDump help?

9

Since this morning it’s working… Very strange, but I see a difference in the logfiles.

It seems that the Transcoder does something with the segment range… I don’t see this in the logs of yesterday.

Jun 26, 2018 08:13:34.119 [0x7f2b7d3ff700] DEBUG - Transcoder segment range: 0 - 0
Jun 26, 2018 08:13:34.202 [0x7f2b81ffe700] DEBUG - Exists("/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream0.m4s") => 1
Jun 26, 2018 08:13:34.202 [0x7f2b81ffe700] DEBUG - Content-Length of /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream0.m4s is 803.
Jun 26, 2018 08:13:34.202 [0x7f2b76ffd700] DEBUG - Returning segment 0 from session: "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/chunk-stream0-00001.m4s"
Jun 26, 2018 08:13:34.202 [0x7f2b76ffd700] DEBUG - Content-Length of /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream0.m4s,/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/chunk-stream0-00001.m4s is 237640.
Jun 26, 2018 08:13:34.202 [0x7f2b877fe700] DEBUG - Completed: [94.232.113.130:56587] 200 GET /video/:/transcode/universal/dash/h3ns1xnz6qpn5nhjms0utan7/0/initial.mp4 (11 live) TLS GZIP 1302ms 803 bytes (pipelined: 18)
Jun 26, 2018 08:13:34.203 [0x7f2b7abfc700] DEBUG - Exists("/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream1.m4s") => 1
Jun 26, 2018 08:13:34.203 [0x7f2b7abfc700] DEBUG - Content-Length of /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream1.m4s is 740.
Jun 26, 2018 08:13:34.203 [0x7f2b877fe700] DEBUG - Completed: [94.232.113.130:56585] 200 GET /video/:/transcode/universal/dash/h3ns1xnz6qpn5nhjms0utan7/1/initial.mp4 (11 live) TLS GZIP 1307ms 740 bytes (pipelined: 14)
Jun 26, 2018 08:13:34.214 [0x7f2b747ff700] DEBUG - Returning segment 0 from session: "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/chunk-stream1-00001.m4s"
Jun 26, 2018 08:13:34.214 [0x7f2b747ff700] DEBUG - Content-Length of /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/init-stream1.m4s,/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-h3ns1xnz6qpn5nhjms0utan7-19fb8d49-9846-46df-aa13-cad52256be95/chunk-stream1-00001.m4s is 150306.
Jun 26, 2018 08:13:34.219 [0x7f2b87fff700] DEBUG - Completed: [94.232.113.130:56616] 200 GET /video/:/transcode/universal/dash/h3ns1xnz6qpn5nhjms0utan7/0/0.m4s (11 live) TLS GZIP 1318ms 237640 bytes (pipelined: 10)
Jun 26, 2018 08:13:34.273 [0x7f2b73ffe700] DEBUG - Request: [94.232.113.130:56585 (WAN)] GET /video/:/transcode/universal/dash/h3ns1xnz6qpn5nhjms0utan7/0/1.m4s (11 live) TLS GZIP Signed-in
Jun 26, 2018 08:13:34.273 [0x7f2b73ffe700] DEBUG - Asked for segment 1 from session.

The logs of today: …

Do you have an idea why it’s now working and what was the issue?

10

No idea actually. Occam’s Razor being the most likely answer; Was anything restarted?

11

Yes, I’ve rebooted the server. But when I was testing/troubleshooting last weekend I restarted/rebooted Plex and the server a couple of times.

It would be nice to know what the problem was, but I understand it’s difficult to troubleshoot if it’s working again. The problem is ,I can’t reproduce it.

It’s currently still working fine, thanks for your help and support!

12

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