Thank you.
From your logs:
- Transcoder engages to convert the music for the player
- Player comes to GET blocks of audio to play.
Oct 23, 2021 02:47:48.449 [0x7f9a1216eb38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 12 from session.
Oct 23, 2021 02:47:48.449 [0x7f9a1216eb38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Returning segment 12 from session
Oct 23, 2021 02:47:48.449 [0x7f9a1216eb38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-30k2i9tcacbfvs8djg7s49rp-9683f444-92d2-4e11-8dd1-949a21c6856c/media-00012.ts is 34780 (of total: 34780).
Oct 23, 2021 02:47:48.449 [0x7f9a13b3bb38] DEBUG - Completed: [192.168.1.234:43844] 206 GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00012.ts (29 live) 0ms 34780 bytes (pipelined: 13) (range: bytes=0-)
Oct 23, 2021 02:47:48.449 [0x7f9a13b3bb38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:47:48.453 [0x7f9a12a5db38] DEBUG - Request: [192.168.1.234:43844 (Subnet)] GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00013.ts (29 live) Signed-in (range: bytes=0-)
Oct 23, 2021 02:47:48.453 [0x7f9a12a5db38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 13 from session.
Oct 23, 2021 02:47:48.454 [0x7f9a13725b38] DEBUG - [Transcode] Transcoder segment range: 0 - 13 (13)
Oct 23, 2021 02:47:48.454 [0x7f9a12613b38] DEBUG - [Transcode] Transcoder segment range: 0 - 14 (13)
Oct 23, 2021 02:47:48.468 [0x7f9a11edfb38] DEBUG - [Transcode] Transcoder segment range: 0 - 14 (14)
Oct 23, 2021 02:47:48.468 [0x7f9a124ebb38] DEBUG - [Transcode] Transcoder segment range: 0 - 15 (14)
Oct 23, 2021 02:47:48.483 [0x7f9a11bcab38] DEBUG - [Transcode] Transcoder segment range: 0 - 15 (15)
Oct 23, 2021 02:47:48.483 [0x7f9a1216eb38] DEBUG - [Transcode] Transcoder segment range: 0 - 16 (15)
Oct 23, 2021 02:47:48.498 [0x7f9a13725b38] DEBUG - [Transcode] Transcoder segment range: 0 - 16 (16)
Oct 23, 2021 02:47:48.498 [0x7f9a12613b38] DEBUG - [Transcode] Transcoder segment range: 0 - 17 (16)
Oct 23, 2021 02:47:48.512 [0x7f9a124ebb38] DEBUG - [Transcode] Transcoder segment range: 0 - 17 (17)
Oct 23, 2021 02:47:48.512 [0x7f9a11edfb38] DEBUG - [Transcode] Transcoder segment range: 0 - 18 (17)
Oct 23, 2021 02:47:48.528 [0x7f9a11bcab38] DEBUG - [Transcode] Transcoder segment range: 0 - 18 (18)
Oct 23, 2021 02:47:48.528 [0x7f9a1216eb38] DEBUG - [Transcode] Transcoder segment range: 0 - 19 (18)
Oct 23, 2021 02:47:48.553 [0x7f9a12a5db38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Returning segment 13 from session
Oct 23, 2021 02:47:48.553 [0x7f9a12a5db38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-30k2i9tcacbfvs8djg7s49rp-9683f444-92d2-4e11-8dd1-949a21c6856c/media-00013.ts is 34592 (of total: 34592).
Oct 23, 2021 02:47:48.554 [0x7f9a13b18b38] DEBUG - Completed: [192.168.1.234:43844] 206 GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00013.ts (29 live) 100ms 34592 bytes (pipelined: 14) (range: bytes=0-)
Oct 23, 2021 02:47:48.554 [0x7f9a13b18b38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:47:48.561 [0x7f9a12613b38] DEBUG - Request: [192.168.1.234:43844 (Subnet)] GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00014.ts (29 live) Signed-in (range: bytes=0-)
Oct 23, 2021 02:47:48.561 [0x7f9a12613b38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 14 from session.
Oct 23, 2021 02:47:48.561 [0x7f9a12613b38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Returning segment 14 from session
Oct 23, 2021 02:47:48.561 [0x7f9a12613b38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-30k2i9tcacbfvs8djg7s49rp-9683f444-92d2-4e11-8dd1-949a21c6856c/media-00014.ts is 34780 (of total: 34780).
Oct 23, 2021 02:47:48.561 [0x7f9a13b3bb38] DEBUG - Completed: [192.168.1.234:43844] 206 GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00014.ts (29 live) 0ms 34780 bytes (pipelined: 15) (range: bytes=0-)
Oct 23, 2021 02:47:48.561 [0x7f9a13b3bb38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:47:48.567 [0x7f9a13725b38] DEBUG - [Transcode] Transcoder segment range: 0 - 19 (19)
Oct 23, 2021 02:47:48.567 [0x7f9a124ebb38] DEBUG - [Transcode] Transcoder segment range: 0 - 20 (19)
Oct 23, 2021 02:47:48.568 [0x7f9a11edfb38] DEBUG - [Transcode] Transcoder segment range: 0 - 20 (20)
Oct 23, 2021 02:47:48.570 [0x7f9a14d3fb38] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 3153214 is 0 (success)
Oct 23, 2021 02:47:48.571 [0x7f9a1216eb38] DEBUG - Request: [192.168.1.234:43844 (Subnet)] GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00015.ts (28 live) Signed-in (range: bytes=0-)
Oct 23, 2021 02:47:48.571 [0x7f9a1216eb38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 15 from session.
Oct 23, 2021 02:47:48.571 [0x7f9a1216eb38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Returning segment 15 from session
Oct 23, 2021 02:47:48.571 [0x7f9a1216eb38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-30k2i9tcacbfvs8djg7s49rp-9683f444-92d2-4e11-8dd1-949a21c6856c/media-00015.ts is 34404 (of total: 34404).
Oct 23, 2021 02:47:48.571 [0x7f9a13b3bb38] DEBUG - Completed: [192.168.1.234:43844] 206 GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00015.ts (28 live) 0ms 34404 bytes (pipelined: 16) (range: bytes=0-)
Oct 23, 2021 02:47:48.571 [0x7f9a13b3bb38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:47:48.576 [0x7f9a12a5db38] DEBUG - Request: [192.168.1.11:49859 (Subnet)] GET /status/sessions (28 live) TLS GZIP Signed-in Token (MrPl3x)
Oct 23, 2021 02:47:48.576 [0x7f9a12a5db38] DEBUG - [Now] Adding 0 sessions.
Oct 23, 2021 02:47:48.576 [0x7f9a13b3bb38] DEBUG - Completed: [192.168.1.11:49859] 200 GET /status/sessions (28 live) TLS GZIP 0ms 350 bytes (pipelined: 81)
Oct 23, 2021 02:47:48.578 [0x7f9a12613b38] DEBUG - Request: [192.168.1.234:43844 (Subnet)] GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00016.ts (28 live) Signed-in (range: bytes=0-)
Oct 23, 2021 02:47:48.578 [0x7f9a12613b38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 16 from session.
Oct 23, 2021 02:47:48.579 [0x7f9a12613b38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Returning segment 16 from session
Oct 23, 2021 02:47:48.579 [0x7f9a12613b38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-30k2i9tcacbfvs8djg7s49rp-9683f444-92d2-4e11-8dd1-949a21c6856c/media-00016.ts is 35344 (of total: 35344).
Oct 23, 2021 02:47:48.579 [0x7f9a13b18b38] DEBUG - Completed: [192.168.1.234:43844] 206 GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00016.ts (28 live) 0ms 35344 bytes (pipelined: 17) (range: bytes=0-)
Oct 23, 2021 02:47:48.579 [0x7f9a13b18b38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:47:48.584 [0x7f9a13725b38] DEBUG - Request: [192.168.1.234:43844 (Subnet)] GET /music/:/transcode/universal/session/30k2i9tcacbfvs8djg7s49rp/base/00017.ts (28 live) Signed-in (range: bytes=0-)
Oct 23, 2021 02:47:48.584 [0x7f9a13725b38] DEBUG - [Transcode/30k2i9tcacbfvs8djg7s49rp] Asked for segment 17 from session
Then I see several of these errors where the player disconnects and shuts down the otherwise normal transcoding stream. (Connection reset by peer)
Oct 23, 2021 02:48:51.710 [0x7f9a12613b38] DEBUG - [Transcode/k3wwdnn1jvojfhfjbyhzpo7a] Returning segment 1 from session
Oct 23, 2021 02:48:51.710 [0x7f9a12613b38] DEBUG - Content-Length of /dev/shm/Transcode/Sessions/plex-transcode-k3wwdnn1jvojfhfjbyhzpo7a-576fb638-e596-497d-bdcc-765c5804eac2/media-00001.ts is 1760996 (of total: 1760996).
Oct 23, 2021 02:48:51.714 [0x7f9a13b3bb38] DEBUG - Failed to stream media, client probably disconnected after 144800 bytes: 104 - Connection reset by peer
Oct 23, 2021 02:48:51.714 [0x7f9a13b3bb38] DEBUG - Completed after connection close: [192.168.1.234:43896] 206 GET /video/:/transcode/universal/session/k3wwdnn1jvojfhfjbyhzpo7a/base/00001.ts (24 live) 4ms 144800 bytes (pipelined: 1) (range: bytes=0-)
Oct 23, 2021 02:48:51.714 [0x7f9a13b3bb38] DEBUG - Removed transcode data consumer, active count 1 => 0
Oct 23, 2021 02:48:51.718 [0x7f9a11fa2b38] DEBUG - BlurHashManager: Generated for item 1229 thumb in 36 ms.
I don’t yet know what’s causing that.
Now I would like you do a simple controlled test case.
Download this file and place in a directory by itself.
Create a library section of type “Other Videos/Home Videos” and include this directory.
Playback the file on your Web Browser (something I can replicate and am familiar with)
https://jell.yfish.us/media/jellyfish-30-mbps-hd-h264.mkv
It looks like there is a player problem here but let’s start eliminating the possibilities by using the Web player on this known file (which will play in Plex/Web)