DB locks and wait times

Server Version#:1.25.0.5220
Player Version#:4.66,1

Wondering if anyone could help me as I am at my wit’s end.

Running Plex on a docker container on a fresh new box.

Could someone please confirm if it’s normal to have a whole host of “waited one whole second for a busy database” or “Held transaction for too long”

I’m doing a scan of a library and don’t recall this being issue, but then again, maybe I wasn’t paying attention to the console.

Can attach logs once I can properly sit down (let me know what logs do you need as I’ve downloaded them from the server), but in the meantime if someone is able to shed light on this with limited Information, I would appreciate it!

Screenshot attached.

May I have the actual DEBUG logs ZIP which capture this?

The usual causes:

  1. CPU overloaded (software transcoding - burning subtitles)
  2. Ingesting a lot of media
  3. A fragmented database (most common cause)

Thanks for the reply @ChuckPa

Thanks for the logs.

Yes you ARE Ingesting a lot of media.

As a suggestion – Have you considered moving the metadata to a SSD ?

If you do that, database & metadata performance will skyrocket (up to the 535 MB/sec speed of SATA-3 / 2.7 GB/sec for NVMe Gen 3 - 4 Lane)

Hey

Metadata is already on an NVME.

2x1 TB nvme to be exact in raid 0 in btrfs

Ok, then it must be time to Optimize the DB .

I know you’re ingesting media. (which leaves deleted , but not removed, records from the update process)

This optimization will cause ingestion to pause but it will recover by itself.

Optimize the DB and then look at the logs in a little while. You should no longer be seeing the busy database

I would love to say that resolved the issue, but no such luck.
Same exact thing.
Do you want more logs or…?
Or shall I just wait till I’m not scanning a library in? Guessing this is not normal behaviour for Plex even when scanning a ton of Media in?
I just can’t conceive how this has happened on a brand new install in an NVME storage medium.

What are you ingesting? Movies, Episodes, Music, or Photos ?

Ingesting a lot is no big deal. I do it all the time and don’t have issues.
I don’t ingest photos at all. I don’t ingest a lot of music (that is hard on it / slow)

At the moment ingesting anime series.

I forgot about Anime. Anime is very difficult to match because of the international nature of the titles. It has more to try … then score, then update appropriately

Hmmm will try a different library once this one is scanned.

Steps to take after it is?

Optimise, restart docker then add new library? What’s the easiest one to test? Movies or normal shows ?

Optimize,
Restart
Add normal movies
Optimize
Add normal episodes

Will try in a sec, will let you know :slight_smile:

Meh still having issues.

Anime library was added, optimised database. So far so good.

Restarted the container, added the movie library. BAM, Plex Media Server crash (from docker logs).

Still getting the same issues as before.

New logs attached

Plex Media Server Logs_2021-11-13_22-50-10.zip (368.1 KB)

This is bloody hopeless…

I could be wrong but I believe where the issue happened was here:

Nov 13, 2021 22:47:12.594 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.594 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.595 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 200 items.
Nov 13, 2021 22:47:12.595 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.595 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.596 [0x7f09be51eb38] DEBUG - It took 10.000000 ms to retrieve 405 items.
Nov 13, 2021 22:47:12.596 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.596 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.598 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 605 items.
Nov 13, 2021 22:47:12.598 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.598 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.601 [0x7f09be51eb38] DEBUG - It took 10.000000 ms to retrieve 806 items.
Nov 13, 2021 22:47:12.602 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.602 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.605 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 1028 items.
Nov 13, 2021 22:47:12.605 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.606 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.609 [0x7f09be51eb38] DEBUG - It took 10.000000 ms to retrieve 1245 items.
Nov 13, 2021 22:47:12.623 [0x7f09be51eb38] DEBUG - HubCache: Computed '1/tv.recentlyadded.1/1/hubs/promoted/en-GBexternal-media,indirect-media/contentDirectoryID=1&count=12&excludeContinueWatching=1&excludeFields=summary&includeGames=1&includeLibraryPlaylists=1&includeMeta=1&includeRecentChannels=1&includeStations=1&pinnedContentDirectoryID=1' in 29 ms.
Nov 13, 2021 22:47:12.623 [0x7f09be51eb38] DEBUG - MetadataCounterCache: rebuilding full counter cache for totals
Nov 13, 2021 22:47:12.628 [0x7f09be541b38] DEBUG - HubCache: Computed '1/continueWatching/1/hubs/continueWatching/en-GBexternal-media,indirect-media/contentDirectoryID=1&excludeFields=summary&includeMeta=1' in 34 ms.
Nov 13, 2021 22:47:12.628 [0x7f09befe7b38] DEBUG - Completed: [172.18.0.16:51406] 200 GET /hubs/continueWatching?contentDirectoryID=1&includeMeta=1&excludeFields=summary (9 live) GZIP 35ms 476 bytes
Nov 13, 2021 22:47:12.654 [0x7f09befe7b38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:12.654 [0x7f09be4fbb38] DEBUG - Request: [172.18.0.16:51410 (WAN)] PUT /updater/check?download=0 (9 live) GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:12.654 [0x7f09be4fbb38] DEBUG - AutoUpdate: requesting check endpoint: /updater/products/5/check.xml?build=linux-x86_64&channel=8&distribution=debian&version=1.25.0.5220-de6e61df7, download: NO
Nov 13, 2021 22:47:12.654 [0x7f09be4fbb38] DEBUG - Downloading document https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=8&distribution=debian&version=1.25.0.5220-de6e61df7
Nov 13, 2021 22:47:12.654 [0x7f09be4fbb38] DEBUG - HTTP requesting GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=8&distribution=debian&version=1.25.0.5220-de6e61df7
Nov 13, 2021 22:47:12.657 [0x7f09be51eb38] DEBUG - MetadataCounterCache: rebuilding full counter cache for views
Nov 13, 2021 22:47:12.658 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Fire Force.
Nov 13, 2021 22:47:12.658 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Food Wars! Shokugeki no Soma.
Nov 13, 2021 22:47:12.664 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for One Piece.
Nov 13, 2021 22:47:12.665 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for JoJo's Bizarre Adventure.
Nov 13, 2021 22:47:12.665 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Aggretsuko.
Nov 13, 2021 22:47:12.666 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Another.
Nov 13, 2021 22:47:12.667 [0x7f09befe7b38] DEBUG - Completed: [172.18.0.16:51408] 200 GET /hubs/promoted?contentDirectoryID=1&pinnedContentDirectoryID=1&includeMeta=1&excludeFields=summary&count=12&includeGames=1&includeStations=1&includeLibraryPlaylists=1&includeRecentChannels=1&excludeContinueWatching=1 (9 live) GZIP 73ms 5398 bytes
Nov 13, 2021 22:47:12.714 [0x7f09be4fbb38] DEBUG - HTTP/1.1 (0.1s) 200 response from GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=8&distribution=debian&version=1.25.0.5220-de6e61df7 (reused)
Nov 13, 2021 22:47:12.715 [0x7f09be4fbb38] INFO - AutoUpdate: no updates available
Nov 13, 2021 22:47:12.715 [0x7f09befe7b38] DEBUG - Completed: [172.18.0.16:51410] 200 PUT /updater/check?download=0 (8 live) GZIP 60ms 296 bytes
Nov 13, 2021 22:47:12.731 [0x7f09bf00ab38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:12.732 [0x7f09be94cb38] DEBUG - Request: [172.18.0.16:51414 (WAN)] GET /:/websockets/notifications (8 live) GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:12.732 [0x7f09be94cb38] DEBUG - WebSocket: Performing handshake from origin https://plex.madflix.xyz
Nov 13, 2021 22:47:12.732 [0x7f09be94cb38] DEBUG - Beginning read from WebSocket
Nov 13, 2021 22:47:12.774 [0x7f09bf00ab38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:12.774 [0x7f09be541b38] DEBUG - Request: [172.18.0.16:51416 (WAN)] GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=1 (9 live) Page 12-35 GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:12.775 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.775 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.775 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.775 [0x7f09be541b38] DEBUG - It took 0.000000 ms to retrieve 200 items.
Nov 13, 2021 22:47:12.776 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.776 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.776 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.777 [0x7f09be541b38] DEBUG - It took 0.000000 ms to retrieve 405 items.
Nov 13, 2021 22:47:12.777 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.777 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.777 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.778 [0x7f09be541b38] DEBUG - It took 0.000000 ms to retrieve 605 items.
Nov 13, 2021 22:47:12.778 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.778 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.778 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.781 [0x7f09be541b38] DEBUG - It took 0.000000 ms to retrieve 806 items.
Nov 13, 2021 22:47:12.781 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.781 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.781 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.784 [0x7f09be541b38] DEBUG - It took 10.000000 ms to retrieve 1028 items.
Nov 13, 2021 22:47:12.784 [0x7f09be541b38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.784 [0x7f09be541b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.784 [0x7f09be541b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.788 [0x7f09be541b38] DEBUG - It took 0.000000 ms to retrieve 1245 items.
Nov 13, 2021 22:47:12.791 [0x7f09bf00ab38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:12.791 [0x7f09be51eb38] DEBUG - Request: [172.18.0.16:51418 (WAN)] GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=1 (10 live) Page 12-35 GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:12.791 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.791 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.791 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.792 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 200 items.
Nov 13, 2021 22:47:12.792 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.792 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.792 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.793 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 405 items.
Nov 13, 2021 22:47:12.793 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.793 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.793 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.795 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 605 items.
Nov 13, 2021 22:47:12.795 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.795 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.795 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.798 [0x7f09be51eb38] DEBUG - It took 10.000000 ms to retrieve 806 items.
Nov 13, 2021 22:47:12.798 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.798 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.798 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.801 [0x7f09be51eb38] DEBUG - It took 0.000000 ms to retrieve 1028 items.
Nov 13, 2021 22:47:12.802 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:12.802 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.802 [0x7f09be51eb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:12.804 [0x7f09be541b38] DEBUG - Setting container serialization range to [12, 35] (total=-1)
Nov 13, 2021 22:47:12.805 [0x7f09be541b38] DEBUG - There were 1 top-level paths for Assassination Classroom.
Nov 13, 2021 22:47:12.806 [0x7f09be51eb38] DEBUG - It took 10.000000 ms to retrieve 1245 items.
Nov 13, 2021 22:47:12.806 [0x7f09be541b38] DEBUG - There were 1 top-level paths for Attack on Titan.
Nov 13, 2021 22:47:12.807 [0x7f09be541b38] DEBUG - There were 1 top-level paths for B: The Beginning.
Nov 13, 2021 22:47:12.808 [0x7f09be541b38] DEBUG - There were 1 top-level paths for BAKI.
Nov 13, 2021 22:47:12.809 [0x7f09be541b38] DEBUG - There were 1 top-level paths for BanG Dream!.
Nov 13, 2021 22:47:12.812 [0x7f09be541b38] DEBUG - There were 1 top-level paths for Bleach.
Nov 13, 2021 22:47:12.813 [0x7f09be541b38] DEBUG - There were 1 top-level paths for Cardcaptor Sakura.
Nov 13, 2021 22:47:12.813 [0x7f09bf00ab38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:12.813 [0x7f09be4fbb38] DEBUG - Request: [172.18.0.16:51420 (WAN)] GET /activities (11 live) GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:12.814 [0x7f09bf00ab38] DEBUG - Completed: [172.18.0.16:51420] 200 GET /activities (11 live) GZIP 0ms 321 bytes
Nov 13, 2021 22:47:12.815 [0x7f09be541b38] DEBUG - There were 1 top-level paths for Castlevania.
Nov 13, 2021 22:47:12.816 [0x7f09bf00ab38] DEBUG - Completed: [172.18.0.16:51416] 200 GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=1 (10 live) GZIP Page 12-35 41ms 9557 bytes
Nov 13, 2021 22:47:12.822 [0x7f09be51eb38] DEBUG - Setting container serialization range to [12, 35] (total=-1)
Nov 13, 2021 22:47:12.823 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Assassination Classroom.
Nov 13, 2021 22:47:12.823 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Attack on Titan.
Nov 13, 2021 22:47:12.824 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for B: The Beginning.
Nov 13, 2021 22:47:12.825 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for BAKI.
Nov 13, 2021 22:47:12.825 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for BanG Dream!.
Nov 13, 2021 22:47:12.828 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Bleach.
Nov 13, 2021 22:47:12.828 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Cardcaptor Sakura.
Nov 13, 2021 22:47:12.829 [0x7f09be51eb38] DEBUG - There were 1 top-level paths for Castlevania.
Nov 13, 2021 22:47:12.830 [0x7f09bf00ab38] DEBUG - Completed: [172.18.0.16:51418] 200 GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=1 (9 live) GZIP Page 12-35 39ms 9557 bytes
Nov 13, 2021 22:47:13.145 [0x7f09bf00ab38] DEBUG - Using X-Forwarded-For: 77.54.128.231 as remote address
Nov 13, 2021 22:47:13.145 [0x7f09be94cb38] DEBUG - Request: [172.18.0.16:51422 (WAN)] GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=1 (9 live) Page 36-80 GZIP Signed-in Token (M3th0s)
Nov 13, 2021 22:47:13.146 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.146 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.146 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.146 [0x7f09be94cb38] DEBUG - It took 0.000000 ms to retrieve 200 items.
Nov 13, 2021 22:47:13.147 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.147 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.147 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.148 [0x7f09be94cb38] DEBUG - It took 0.000000 ms to retrieve 405 items.
Nov 13, 2021 22:47:13.148 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.148 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.148 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.150 [0x7f09be94cb38] DEBUG - It took 0.000000 ms to retrieve 605 items.
Nov 13, 2021 22:47:13.150 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.150 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.150 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.152 [0x7f09be94cb38] DEBUG - It took 0.000000 ms to retrieve 806 items.
Nov 13, 2021 22:47:13.152 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.152 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.152 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.155 [0x7f09be94cb38] DEBUG - It took 0.000000 ms to retrieve 1028 items.
Nov 13, 2021 22:47:13.156 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'sectionID' found, ignoring.
Nov 13, 2021 22:47:13.156 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Nov 13, 2021 22:47:13.156 [0x7f09be94cb38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.

This is of course for this crash, however still doesn’t help me with my previous DB issue (which is still occurring).

At this point I just want to wipe the whole box and start anew, but to be fair, if this is a Plex issue, that might not help either.

I’ve wiped the whole thing again, reinstalled Plex yet again on docker with a brand new install…Same damn errors…
This is mind numbing…
@ChuckPa do the logs tell you anything?

@M3th0s

Those messages are actually meaningless. You’re seeing Engeering’s work in progress. The “invalid fields” are new fields being created for some of the bigger changes (internal mechanism)

I need the entire ZIP please.

I’ll upload logs again once I get home :slight_smile:

Plex Media Server Logs_2021-11-14_18-10-13.zip (2.3 MB)

Logs attached from a TV library being scanned after a full machine wipe.

How many Plug-ins did you add?

Nov 14, 2021 15:53:57.684 [0x7fc70f767b38] DEBUG - Waiting for 21 plug-ins to finish starting.
Nov 14, 2021 15:54:04.950 [0x7fc70f8dab38] DEBUG - Read configuration for [com.plexapp.plugins.WebTools]