Qnap keeps shutting down Plex server with OOM while doing the media scan

Plex Media Server NAS & Devices
1

Server Version#: 1.41.9.9961
1.41.9.9961-46083195d
Plex Media Server
TVS-882
i5-7500 - 16GB memory
Linux QTS 5.2.5.3145
Player Version#: Chrome 4.148.0
<If providing server logs please do NOT turn on verbose logging, only debug logging should be enabled>

Have been running this server for over 2 years - recently have seen this issue every few days.

This happens every few days usually in the early am (2am -5am):

Warning 2025-08-05 02:55:44 — — localhost — Hardware Status — [Hardware Status] PlexMediaServer has been automatically disabled by the operating system to free up system memory.
Warning 2025-08-05 02:55:43 — — localhost — Hardware Status Kernel [Hardware Status] NAS out of memory. Started kill process: 8671 Plex Media Scan. Disable some applications to free up memory, or expand the system memory.
Warning 2025-06-27 02:24:00 — — localhost — Hardware Status Kernel [Hardware Status] NAS out of memory. Started kill process: 10397 Plex Media Scan. Disable some applications to free up memory, or expand the system memory.
Warning 2025-06-27 02:24:01 — — localhost — Hardware Status — [Hardware Status] PlexMediaServer has been automatically disabled by the operating system to free up system memory.
Warning 2025-07-04 05:21:19 — — localhost — Hardware Status Kernel [Hardware Status] NAS out of memory. Started kill process: 29114 Plex Media Scan. Disable some applications to free up memory, or expand the system memory.
Warning 2025-07-04 05:21:19 — — localhost — Hardware Status — [Hardware Status] PlexMediaServer has been automatically disabled by the operating system to free up system memory.
Warning 2025-07-20 05:20:44 — — localhost — Hardware Status Kernel [Hardware Status] NAS out of memory. Started kill process: 24022 Plex Media Scan. Disable some applications to free up memory, or expand the system memory.
Warning 2025-07-20 05:20:47 — — localhost — Hardware Status — [Hardware Status] PlexMediaServer has been automatically disabled by the operating system to free up system memory.

normally runs about 25% memory (idle)

Plex logs:
Plex Media Scanner Matcher.1.log
Aug 05, 2025 02:53:44.434 [140128266226432] INFO - Plex Media Scanner v1.41.9.9961-46083195d - QNAP TVS-882 x86_64 - build: linux-x86_64 - GMT -05:00
Aug 05, 2025 02:53:44.434 [140128266226432] INFO - Linux version: QTS 5.2.5.3145, language: en-US
Aug 05, 2025 02:53:44.446 [140128266226432] INFO - Processor: 4-core Intel(R) Core™ i5-7500 CPU @ 3.40GHz
Aug 05, 2025 02:53:44.446 [140128266226432] INFO - /share/CACHEDEV2_DATA/.qpkg/PlexMediaServer/Plex Media Scanner --match --type 8 --log-file-suffix Matcher --item 72763 --match-tag-mode=exclusive --content-type=application/json
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encoding
Aug 05, 2025 02:50:53.725 [140128266739456] WARN - [FFMPEG] - Unknown encodin

Not sure which file is causing this but it happens every time.

2

May I please have the server ZIP logfile which captures this?

It’s not possible to diagnose from a snippet.

What you pasted looks like either inability to download the necessary codec or a bad file.

As a test, you can download 1.41.8 and try it.
This will give us some info about .8 vs .9

3

Plex Media Server Logs_2025-08-05_08-28-48.zip (2.2 MB)

4

I thought bad file as well - but not sure which one it would be.

5

Thank for the logs.

Does this make sense to you?

It does look like a bad file (format Plex doesn’t understand)

Aug 05, 2025 02:46:58.595 [140228245375800] DEBUG - Loaded metadata for You Tell Me (ID 66697) in 1ms
Aug 05, 2025 02:46:58.595 [140228245375800] DEBUG - There was a change for metadata item 66697 (You Tell Me), saving.
Aug 05, 2025 02:46:58.595 [140228245375800] DEBUG - Updating metadata item (save) (You Tell Me) with ID 66697
Aug 05, 2025 02:46:58.595 [140228245375800] DEBUG - Done with metadata update for 66697
Aug 05, 2025 02:46:58.598 [140228245375800] DEBUG - Loaded metadata for What Are You Doin’ in My Life? (ID 66698) in 1ms
Aug 05, 2025 02:46:58.598 [140228245375800] DEBUG - There was a change for metadata item 66698 (What Are You Doin’ in My Life?), saving.
Aug 05, 2025 02:46:58.598 [140228245375800] DEBUG - Updating metadata item (save) (What Are You Doin’ in My Life?) with ID 66698
Aug 05, 2025 02:46:58.598 [140228245375800] DEBUG - Done with metadata update for 66698
Aug 05, 2025 02:46:58.601 [140228245375800] DEBUG - Loaded metadata for Louisiana Rain (ID 66699) in 1ms
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - There was a change for metadata item 66699 (Louisiana Rain), saving.
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Updating metadata item (save) (Louisiana Rain) with ID 66699
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Done with metadata update for 66699
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Activity: updated activity 3aad3656-e2ea-479f-9db0-d6617092155f - completed 89.0% - Updating Metadata
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Activity: Ended activity 3aad3656-e2ea-479f-9db0-d6617092155f.
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Activity: ended sub-activity f54ff4bc-64be-4c43-8843-2dbffc586369 parent: fb85c2f3-80af-493d-9f4e-f6f2129aeb42 overall progress: 100.0% (133/133)
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Activity: updated activity fb85c2f3-80af-493d-9f4e-f6f2129aeb42 - completed 100.0% - Butler tasks
Aug 05, 2025 02:46:58.602 [140228245375800] DEBUG - Activity: registered new sub-activity e87147fe-382c-4b03-b370-62188c5e5bd1 - "RefreshPeriodicMetadata" parent: fb85c2f3-80af-493d-9f4e-f6f2129aeb42 overall progress: 99.3% (133/134)
Aug 05, 2025 02:46:58.603 [140228245375800] DEBUG - Activity: updated activity fb85c2f3-80af-493d-9f4e-f6f2129aeb42 - completed 99.3% - Butler tasks
Aug 05, 2025 02:46:58.604 [140228245375800] DEBUG - Activity: registered new activity 38717496-a1a8-45d5-8ddd-824f0471afdc - "Updating Metadata"
Aug 05, 2025 02:46:58.630 [140228245375800] DEBUG - [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/share/CACHEDEV2_DATA/.qpkg/PlexMediaServer/Library/Plex\ Media\ Server/Codecs/46f74ab-560174306fe167a5978a79dd-linux-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx "/share/CACHEDEV2_DATA/.qpkg/PlexMediaServer/Plex Media Scanner" --match --type 8 --log-file-suffix " Matcher" --item 66700 --match-tag-mode=exclusive --content-type=application/json
Aug 05, 2025 02:46:58.630 [140228245375800] DEBUG - [JobRunner] Jobs: Starting child process with pid 23507
Aug 05, 2025 02:46:58.853 [140228245375800] DEBUG - Killing job.
Aug 05, 2025 02:46:58.853 [140228245375800] DEBUG - Signalling job ID 23507 with 9
Aug 05, 2025 02:46:58.853 [140228347730744] DEBUG - Jobs: '/share/CACHEDEV2_DATA/.qpkg/PlexMediaServer/Plex Media Scanner' exit code for process 23507 is 0 (success)
Aug 05, 2025 02:46:58.855 [140228245375800] DEBUG - Loaded metadata for Tom Mabe (ID 66700) in 2ms
Aug 05, 2025 02:46:58.856 [140228245375800] DEBUG - Done with metadata update for 66700
Aug 05, 2025 02:46:58.857 [140228245375800] DEBUG - Activity: updated activity 38717496-a1a8-45d5-8ddd-824f0471afdc - completed -1.0% - Updating Metadata
6

So which file is it - it looked to me like it completed “Louisana Rain” and hit a error on the next file but what is it? Is it another audio file?

7

I don’t know. When you scan files / refresh metadata – watching the upper right activity corner, what’s the last thing you see?

8

Not sure how to kick it off manually…

9

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