RESOLVED: PMS 1.23.0.4480 - 1.23.1.4528 Crash on macOS Mojave 10.14.16 (Roll back to 1.22.3.4392 works fine) Transcoder Issue on Mac Os?

This is now resolved. I’m currently on Plex 1.23.4.4712 and it made through scheduled tasks cycle with no issues. This issue was, whatever Plex changed in 1.23 branch in the transcoder was causing a crash on one file in my library. Here’s how I found it. Below is an excerpt from my Plex Media Server.log file as it crashed. (Set Plex in Debug mode to capture)

At the top of the log notice it starts a new Activity “Generating video preview thumbnails” and assigned it with an activity ID of 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1. You can follow that activity ID all the way down to the very last entry where it’s generating thumbnails. The last entry in the log (at the very bottom) shows it as at 86% for the “Blahblahblah-video-file E01” with process uuid of “18e16a03-2c1a-44ca-a379-c3a9b71a0bf1”. That ties the issue to that file. I removed that file, set scheduled maintenance to run the very next hour and it completed no issue. All hardware acceleration is enabled and Plex seems stable now. Glad to check this off -

Jun 23, 2021 02:06:09.552 [0x70000e966000] DEBUG - Activity: registered new activity 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1 - "Generating video preview thumbnails"
Jun 23, 2021 02:06:09.552 [0x70000e966000] DEBUG - [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/Users/PlexUser/Library/Application\ Support/Plex\ Media\ Server/Codecs/fa235d6-3858-darwin-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/Applications/Plex Media Server.app/Contents/MacOS/Plex Transcoder' '-codec:v' 'mpeg1video' '-skip_frame:v' 'nokey' '-i' '/Volumes/Plex Media/Plex TV Shows /THE SHOW/blahblahblah-video-file.mpg' '-threads' '0' '-nostats' '-q' '3' '-loglevel' 'quiet' '-filter_complex' '[0:V:0] fps=fps=0.500000:round=up,scale=w=320:h=240:force_original_aspect_ratio=decrease [out]' '-map' '[out]' '/Users/PlexUser/Library/Application Support/Plex Media Server/Media/localhost/d/ff2cd3d6eaf9a1a1660360df03ed3446b05cfa8.bundle/Contents/Indexes/tmp/img-%06d.jpg' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress'
Jun 23, 2021 02:06:09.553 [0x70000e966000] DEBUG - [JobRunner] Jobs: Starting child process with pid 65979
Jun 23, 2021 02:06:09.570 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50643 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=startup (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.571 [0x70000ecfb000] DEBUG - Completed: [127.0.0.1:50643] 206 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=startup (7 live) 0ms 371 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:09.583 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50643 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=startup (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.583 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50643] 206 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=startup (7 live) 0ms 371 bytes (pipelined: 2) (range: bytes=0-)
Jun 23, 2021 02:06:09.584 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50643 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=opening (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.584 [0x70000ecfb000] DEBUG - Completed: [127.0.0.1:50643] 206 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=opening (7 live) 0ms 371 bytes (pipelined: 3) (range: bytes=0-)
Jun 23, 2021 02:06:09.600 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50643 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=opened (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.600 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50643] 206 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?status=opened (7 live) 0ms 371 bytes (pipelined: 4) (range: bytes=0-)
Jun 23, 2021 02:06:09.621 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50643 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=0&id=480&codec=mpeg1video&type=video (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.621 [0x70000ecfb000] DEBUG - Completed: [127.0.0.1:50643] 404 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=0&id=480&codec=mpeg1video&type=video (7 live) 0ms 288 bytes (pipelined: 5) (range: bytes=0-)
Jun 23, 2021 02:06:09.621 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50644 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=0&id=480&codec=mpeg1video&type=video (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.622 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50644] 404 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=0&id=480&codec=mpeg1video&type=video (7 live) 0ms 288 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:09.622 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50645 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=1&id=448&codec=mp2&type=audio (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.622 [0x70000ecfb000] DEBUG - Completed: [127.0.0.1:50645] 404 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/stream?index=1&id=448&codec=mp2&type=audio (7 live) 0ms 288 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:09.623 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50646 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/streamDetail?index=0&id=480&codec=mpeg1video&type=video&bitrate=1228800&width=352&height=240&interlaced=0&sar=1:1&frameRate=29.970 (7 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.624 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50646] 404 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/streamDetail?index=0&id=480&codec=mpeg1video&type=video&bitrate=1228800&width=352&height=240&interlaced=0&sar=1:1&frameRate=29.970 (7 live) 0ms 288 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:09.624 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50647 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/streamDetail?index=1&id=448&codec=mp2&type=audio&bitrate=224000&channels=2&layout=stereo&sampleRate=44100 (8 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.624 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50647] 404 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress/streamDetail?index=1&id=448&codec=mp2&type=audio&bitrate=224000&channels=2&layout=stereo&sampleRate=44100 (8 live) 0ms 288 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:09.626 [0x70000ee01000] DEBUG - Request: [127.0.0.1:50648 (Loopback)] PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?duration=1374.439733 (8 live) Signed-in Token (PlexUsername) (range: bytes=0-)
Jun 23, 2021 02:06:09.626 [0x70000ed7e000] DEBUG - Completed: [127.0.0.1:50648] 206 PUT /video/:/transcode/session/bif/18e16a03-2c1a-44ca-a379-c3a9b71a0bf1/progress?duration=1374.439733 (8 live) 0ms 371 bytes (pipelined: 1) (range: bytes=0-)
Jun 23, 2021 02:06:10.127 [0x70000ee01000] DEBUG - [Transcode] Activity: updated activity 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1 - completed 22.1% - Generating video preview thumbnails
Jun 23, 2021 02:06:10.695 [0x70000ee01000] DEBUG - [Transcode] Activity: updated activity 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1 - completed 40.2% - Generating video preview thumbnails
Jun 23, 2021 02:06:11.195 [0x70000ee01000] DEBUG - [Transcode] Activity: updated activity 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1 - completed 63.0% - Generating video preview thumbnails
Jun 23, 2021 02:06:11.695 [0x70000ee01000] DEBUG - [Transcode] Activity: updated activity 18e16a03-2c1a-44ca-a379-c3a9b71a0bf1 - completed 86.0% - Generating video preview thumbnails


1 Like