Yeah, doing that change did not result in any difference:
May 15, 2020 15:48:16.309 [0x7f8825ffb700] DEBUG - Request: [127.0.0.1:48404 (Loopback)] GET /:/plugins/com.plexapp.agents.lastfm/messaging/function/TWVzc2FnZUtpdDpHZXRBcnRpc3RFdmVudHNGcm9tU29uZ2tpY2tCeUlk/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzMzYKZDYyODVkOTUtOGVlMS00ZGUyLThjZWItZmY5MDA5OGFiMWQxczExCmFydGlzdF9tYmlkcjAK (20 live) GZIP Signed-in Token (savantali)
May 15, 2020 15:48:16.309 [0x7f8825ffb700] DEBUG - [com.plexapp.agents.lastfm] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.lastfm/messaging/function/TWVzc2FnZUtpdDpHZXRBcnRpc3RFdmVudHNGcm9tU29uZ2tpY2tCeUlk/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzMzYKZDYyODVkOTUtOGVlMS00ZGUyLThjZWItZmY5MDA5OGFiMWQxczExCmFydGlzdF9tYmlkcjAK
May 15, 2020 15:48:16.309 [0x7f8825ffb700] DEBUG - HTTP requesting GET http://127.0.0.1:40553/:/plugins/com.plexapp.agents.lastfm/messaging/function/TWVzc2FnZUtpdDpHZXRBcnRpc3RFdmVudHNGcm9tU29uZ2tpY2tCeUlk/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzMzYKZDYyODVkOTUtOGVlMS00ZGUyLThjZWItZmY5MDA5OGFiMWQxczExCmFydGlzdF9tYmlkcjAK
May 15, 2020 15:48:16.313 [0x7f8797fef700] DEBUG - Request: [127.0.0.1:48410 (Loopback)] GET /services/songkick?uri=%2Fartists%2Fmbid%3Ad6285d95-8ee1-4de2-8ceb-ff90098ab1d1%2Fcalendar.json (21 live) GZIP Signed-in Token (savantali)
May 15, 2020 15:48:16.360 [0x7f88277fe700] WARN - Waited one whole second for a busy database.
May 15, 2020 15:48:16.369 [0x7f87a57fa700] DEBUG - [Notify] Now watching "/data/rclone/gmusic/Fiona Apple"
May 15, 2020 15:48:16.499 [0x7f8827fff700] DEBUG - Completed: [127.0.0.1:48410] 200 GET /services/songkick?uri=%2Fartists%2Fmbid%3Ad6285d95-8ee1-4de2-8ceb-ff90098ab1d1%2Fcalendar.json (21 live) GZIP 186ms 4584 bytes
May 15, 2020 15:48:16.550 [0x7f879e7fc700] DEBUG - Looking for path match for [/data/rclone/gmusic/X/1980 - X - Los Angeles/14 - X - Los Angeles [Dangerhouse Version].mp3]
May 15, 2020 15:48:16.550 [0x7f88267fc700] DEBUG - Done with metadata update for 44709
--
May 15, 2020 15:48:17.626 [0x7f87957ea700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
May 15, 2020 15:48:17.626 [0x7f882cec5700] DEBUG - Completed: [192.168.2.1:51700] 200 GET /hubs/home/onDeck?includeExternalMedia=1 (19 live) TLS GZIP Page 0-15 332ms 1851 bytes (pipelined: 5)
May 15, 2020 15:48:17.742 [0x7f87a57fa700] DEBUG - [Notify] Now watching "/data/rclone/gmusic/Fire! Orchestra"
May 15, 2020 15:48:17.910 [0x7f879e7fc700] WARN - Held transaction for too long (../Library/MetadataItem.cpp:3590): 1.390000 seconds
May 15, 2020 15:48:17.910 [0x7f879e7fc700] DEBUG - Native Scanner: Executed Add to Database stage in 30.72 sec.
May 15, 2020 15:48:17.919 [0x7f87d77fe700] DEBUG - Request: [127.0.0.1:48468 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=45398&metadataType=10&state=-1&mediaState=analyzing (20 live) GZIP Signed-in Token (savantali)
May 15, 2020 15:48:17.920 [0x7f882cec5700] DEBUG - Completed: [127.0.0.1:48468] 200 GET /:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=45398&metadataType=10&state=-1&mediaState=analyzing (20 live) GZIP 0ms 166 bytes
May 15, 2020 15:48:17.920 [0x7f88277fe700] DEBUG - Loaded metadata for Young Thug (ID 44734) in 1530.000000 ms
May 15, 2020 15:48:17.920 [0x7f88277fe700] DEBUG - There was a change for metadata item 44734 (Young Thug), saving.
Disk IO shouldn’t be a problem here, but it seems like plex is getting stuck at 99% sometimes:
After looking around, it seems like this is very similar to my issue: Plex server stop and Sqlite3: Sleeping for 200ms to retry busy DB is reported in the Log file
I am running everything off of an NVME ssd, ECC RAM, and the CPU as shown. Seems like this may be an optimization problem with the application itself.
