root@Utils:/usr/local/plexdata-plexpass/Plex Media Server # cat Logs/Plex\ Media\ Server.log
Sep 22, 2025 00:38:57.737 [0x3aa696812700] INFO - Plex Media Server v1.42.2.10102-50deb00d9 - FreeBSD PC amd64 - build: freebsd-x86_64 freebsd - GMT 00:00
Sep 22, 2025 00:38:57.743 [0x3aa696812700] INFO - FreeBSD version: 14.0-RELEASE, language: en-US
Sep 22, 2025 00:38:57.744 [0x3aa696812700] INFO - Processor: 32-core Intel(R) Xeon(R) CPU E5-2450 v2 @ 2.50GHz
Sep 22, 2025 00:38:57.744 [0x3aa696812700] INFO - Compiler is - Clang 11.0.1 (https://plex.tv 9b997da8e5b47bdb4a9425b3a3b290be393b4b1f)
Sep 22, 2025 00:38:57.744 [0x3aa696812700] INFO - /usr/local/share/plexmediaserver-plexpass/Plex_Media_Server
Sep 22, 2025 00:38:57.738 [0x3aa696812000] DEBUG - BPQ: [Idle] → [Starting]
Sep 22, 2025 00:38:57.739 [0x3aa696812000] ERROR - Unable to open named mutex 9334581e-7251-4ef7-a8ec-5bfe8e89ff68 with option 1: File exists
Sep 22, 2025 00:38:57.739 [0x3aa696812000] DEBUG - FeatureManager: Using cached data for features list
Sep 22, 2025 00:38:57.743 [0x3aa696812000] DEBUG - MyPlex: mapping state set to ‘Unknown’.
Sep 22, 2025 00:38:57.743 [0x3aa696812000] DEBUG - Relay: read 0 cached entries from hosts file
Sep 22, 2025 00:38:57.743 [0x3aa696812000] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.39.4, threadsafe=1
Sep 22, 2025 00:38:57.750 [0x3aa696812000] INFO - SQLITE3:0x10, 283, recovered 860 frames from WAL file /usr/local/plexdata-plexpass/Plex Media Server/Plug-in Support/Databases/com.plexapp.plugins.library.db-wal
Sep 22, 2025 00:38:57.843 [0x3aa696812000] DEBUG - MyPlex: no cached data to load for request for https://plex.tv/api/v2/server/users/features
Sep 22, 2025 00:38:57.891 [0x3aa696812000] DEBUG - HttpServer: Listening on port 32400.
Sep 22, 2025 00:38:57.892 [0x3aa696812000] DEBUG - HttpServer: Listening on port 32401.
Sep 22, 2025 00:38:57.892 [0x3aa696812000] DEBUG - Running server…
Sep 22, 2025 00:38:57.892 [0x3aa696816600] DEBUG - HttpServer: Set up a thread pool with 2 threads.
Sep 22, 2025 00:38:57.893 [0x3aa696812000] INFO - Running migrations. (EPG 0)
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 0.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 1.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 2.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 3.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 4.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 5.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 6.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 7.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 8.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 9.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 10.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 11.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 12.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 13.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 14.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 15.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 16.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 17.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 18.
Sep 22, 2025 00:38:57.894 [0x3aa696812000] DEBUG - Captured session 19.
Sep 22, 2025 00:38:57.899 [0x3aa696812000] DEBUG - ChangestampAllocator: initialized to 0
Sep 22, 2025 00:38:57.899 [0x3aa696812000] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.39.4, threadsafe=1
Sep 22, 2025 00:38:57.905 [0x3aa696812000] INFO - SQLITE3:0x10, 283, recovered 691 frames from WAL file /usr/local/plexdata-plexpass/Plex Media Server/Plug-in Support/Databases/com.plexapp.plugins.library.blobs.db-wal
Sep 22, 2025 00:38:57.914 [0x3aa696812000] INFO - Running migrations. (EPG 0)
Sep 22, 2025 00:38:57.915 [0x3aa696812000] DEBUG - Captured session 0.
Sep 22, 2025 00:38:57.915 [0x3aa696812000] DEBUG - Captured session 1.
Sep 22, 2025 00:38:57.941 [0x3aa696813c00] DEBUG - Grabber: Cleaning up orphaned grabs.
Sep 22, 2025 00:38:57.941 [0x3aa696813c00] DEBUG - Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Sep 22, 2025 00:38:57.941 [0x3aa696812000] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Sep 22, 2025 00:38:57.942 [0x3aa696812000] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 22, 2025 00:38:57.942 [0x3aa696813c00] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 22, 2025 00:38:57.942 [0x3aa696812000] DEBUG - Opening 1 database sessions to library (), SQLite 3.39.4, threadsafe=1
Sep 22, 2025 00:38:57.946 [0x3aa696818200] DEBUG - File “/usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-50deb00d9” changed: -1 => 2025-09-12 23:56:15 (1757721375).
Sep 22, 2025 00:38:57.946 [0x3aa696818200] DEBUG - File “/usr/local/plexdata-plexpass/Plex Media Server/Plug-ins” changed: -1 => 2025-09-21 23:09:28 (1758496168).
Sep 22, 2025 00:38:57.946 [0x3aa696818200] DEBUG - Scanning for plug-ins in “/usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-50deb00d9”
Sep 22, 2025 00:38:57.949 [0x3aa696818200] DEBUG - Scanning for plug-ins in “/usr/local/plexdata-plexpass/Plex Media Server/Plug-ins”
Sep 22, 2025 00:38:57.949 [0x3aa696818200] DEBUG - PluginRepository::setStartState: 1, startingSystem
Sep 22, 2025 00:38:57.949 [0x3aa696818200] DEBUG - Starting plug-in /usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-50deb00d9/System.bundle.
Sep 22, 2025 00:38:57.950 [0x3aa696818200] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Sep 22, 2025 00:38:57.950 [0x3aa696818200] DEBUG - Starting file watcher for com.plexapp.system
Sep 22, 2025 00:38:57.951 [0x3aa696818200] DEBUG - Plugin: setting environment variable: ‘PYTHONHOME=/usr/local/share/plexmediaserver-plexpass/Resources/Python’
Sep 22, 2025 00:38:57.951 [0x3aa696818200] DEBUG - Plugin: setting environment variable: ‘PYTHONPATH=/usr/local/share/plexmediaserver-plexpass/Resources/Python/python27.zip:/usr/local/share/plexmediaserver-plexpass/Resources/Python/lib/python2.7/site-packages’
Sep 22, 2025 00:38:57.952 [0x3aa696818200] DEBUG - Spawned plug-in com.plexapp.system with PID 53068
Sep 22, 2025 00:38:57.952 [0x3aa696818200] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Sep 22, 2025 00:38:59.121 [0x3aa69941b000] DEBUG - Request: [##.##.##.93:27079 (Subnet)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (2 live) #1 GZIP Token ()
Sep 22, 2025 00:38:59.122 [0x3aa696815100] DEBUG - Completed: [##.##.##.93:27079] 503 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (2 live) #1 GZIP 0ms 436 bytes
Sep 22, 2025 00:38:59.137 [0x3aa69941b000] DEBUG - Request: [##.##.##.93:21370 (Subnet)] GET / (2 live) #3 GZIP Token ()
Sep 22, 2025 00:38:59.137 [0x3aa696815100] DEBUG - Completed: [##.##.##.93:21370] 503 GET / (2 live) #3 GZIP 0ms 436 bytes
Sep 22, 2025 00:38:59.903 [0x3aa69941b000] DEBUG - Request: [##.##.##.93:44161 (Subnet)] GET /servers (2 live) #6 GZIP Token ()
Sep 22, 2025 00:38:59.903 [0x3aa696815800] DEBUG - Completed: [##.##.##.93:44161] 503 GET /servers (2 live) #6 GZIP 0ms 436 bytes
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - Reading 486 bytes in the body, code is 200
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - [com.plexapp.system] Plug-in running on port 13532.
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - * Plug-in handles prefix: /system
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - * Plug-in handles prefix: /player
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - Updating the list of agents known by the system.
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Sep 22, 2025 00:38:59.917 [0x3aa696818200] DEBUG - [HCl#1] HTTP requesting GET http://127.0.0.1:13532/system/agents
Sep 22, 2025 00:38:59.917 [0x3aa696812000] DEBUG - Image transcode cache directory: “/usr/local/plexdata-plexpass/Plex Media Server/Cache/PhotoTranscoder”
Sep 22, 2025 00:38:59.917 [0x3aa696812000] DEBUG - Transcoder: Cleaning old transcode directories.
Sep 22, 2025 00:38:59.918 [0x3aa696812000] DEBUG - MyPlex: stop public ip check and mapping - current mapped state: ‘Unknown’.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkInterface: Starting watch thread.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - Network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkInterface: Notified of network changed (force=0)
Sep 22, 2025 00:38:59.922 [0x3aa6987b7700] DEBUG - NetworkInterface: Watching for changes on the interfaces.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - Detected primary interface: 0.0.0.0
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - Network interfaces:
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - * 1 bxe0 (##.##.##.93) (00-0A-F7-39-2A-A0) (loopback: 0)
Sep 22, 2025 00:38:59.922 [0x3aa6987b7700] DEBUG - NetworkInterface: PF_ROUTE socket received message. Version 5, Type 0x4, Len 168.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - Creating NetworkServices singleton.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkServices: Initializing…
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Creating new service.
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 22, 2025 00:38:59.922 [0x3aa696812000] DEBUG - NetworkService: Quick dispatch of network change.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - Network change for advertiser.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414
Sep 22, 2025 00:38:59.922 [0x3aa6987b7700] DEBUG - NetworkInterface: PF_ROUTE socket received message. Version 5, Type 0xf, Len 144.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - Network change for advertiser.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - Network change for advertiser.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32412
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Browsing on interface ##.##.##.93 on broadcast address ##.##.##.93 (index: 0)
Sep 22, 2025 00:38:59.922 [0x3aa6987b7e00] DEBUG - NetworkService: Network change for browser (polled=1), closing 0 browse sockets
…
Sep 22, 2025 01:04:03.103 [0x3aa6987bb600] DEBUG - [HCl#1d] HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=
Sep 22, 2025 01:04:03.683 [0x3aa6998b2700] DEBUG - [HttpClient/HCl#1d] HTTP/1.1 (0.6s) 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=
Sep 22, 2025 01:04:03.685 [0x3aa6987bb600] DEBUG - [HCl#1e] HTTP requesting GET https://plex.tv/api/v2/server/users/features
Sep 22, 2025 01:04:03.857 [0x3aa6998b2700] DEBUG - [HttpClient/HCl#1e] HTTP/1.1 (0.2s) 401 response from GET https://plex.tv/api/v2/server/users/features (reused)
Sep 22, 2025 01:04:03.857 [0x3aa6987b9300] ERROR - MyPlex: Error 401 requesting JSON from: https://plex.tv/api/v2/server/users/features
Sep 22, 2025 01:04:03.857 [0x3aa6987bb600] WARN - FeatureManager: Couldn’t get features. Trying again soon.