Log Snippet
Jan 11, 2025 19:12:45.502 [128215716735800] INFO - Plex Media Server v1.41.3.9314-a0bfb8370 - Ubuntu Intel Corporation 440BX Desktop Reference Platform x86_64 - build: linux-x86_64 debian - GMT 00:00
Jan 11, 2025 19:12:45.502 [128215716735800] INFO - Linux version: 24.04.1 LTS (Noble Numbat), language: en-US
Jan 11, 2025 19:12:45.503 [128215716735800] INFO - Processor: 2-core Intel(R) Core(TM) Ultra 5 125H
Jan 11, 2025 19:12:45.503 [128215716735800] INFO - Compiler is - Clang 11.0.1 (https://plex.tv 9b997da8e5b47bdb4a9425b3a3b290be393b4b1f)
Jan 11, 2025 19:12:45.503 [128215716735800] INFO - /usr/lib/plexmediaserver/Plex Media Server
Jan 11, 2025 19:12:45.502 [128215809518224] DEBUG - BPQ: [Idle] -> [Starting]
Jan 11, 2025 19:12:45.502 [128215809518224] DEBUG - FeatureManager: Using cached data for features list
Jan 11, 2025 19:12:45.505 [128215809518224] DEBUG - MyPlex: mapping state set to 'Unknown'.
Jan 11, 2025 19:12:45.505 [128215809518224] DEBUG - Relay: read 5 cached entries from hosts file
Jan 11, 2025 19:12:45.506 [128215809518224] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.39.4, threadsafe=1
Jan 11, 2025 19:12:45.525 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/features
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - [CERT] Subject name is /CN=*.b636433fb61946b5a7d9e7de80f6a0cb.plex.direct
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - [CERT] Installed certificate with fingerprint c3:1a:9e:c4:d6:bb:2e:9d:8f:a9:a7:db:5b:ab:cc:33:17:98:1a:72.
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - [CERT/OCSP] Stapling requests will be made to 'http://r11.o.lencr.org/'.
Jan 11, 2025 19:12:45.538 [128215809518224] INFO - [CERT/OCSP] Successfully retrieved response from cache.
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - HttpServer: Listening on IPv6 as well as IPv4.
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - HttpServer: Listening on port 32400.
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - HttpServer: Listening on port 32401.
Jan 11, 2025 19:12:45.538 [128215809518224] DEBUG - Running server...
Jan 11, 2025 19:12:45.538 [128215695764280] DEBUG - HttpServer: Set up a thread pool with 2 threads.
Jan 11, 2025 19:12:45.538 [128215809518224] INFO - Running migrations. (EPG 0)
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 0.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 1.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 2.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 3.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 4.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 5.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 6.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 7.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 8.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 9.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 10.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 11.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 12.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 13.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 14.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 15.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 16.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 17.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 18.
Jan 11, 2025 19:12:45.539 [128215809518224] DEBUG - Captured session 19.
Jan 11, 2025 19:12:45.542 [128215809518224] DEBUG - ChangestampAllocator: initialized to 5634
Jan 11, 2025 19:12:45.542 [128215809518224] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.39.4, threadsafe=1
Jan 11, 2025 19:12:45.544 [128215809518224] INFO - Running migrations. (EPG 0)
Jan 11, 2025 19:12:45.544 [128215809518224] DEBUG - Captured session 0.
Jan 11, 2025 19:12:45.544 [128215809518224] DEBUG - Captured session 1.
Jan 11, 2025 19:12:45.546 [128215708347192] DEBUG - [GPU] Got device: Intel Meteor Lake-P [Intel Arc Graphics], intel@unknown, default true, best true, ID 8086:7d55:1043:88c8@0000:02:05.0, DevID [8086:7d55:1043:88c8], flags 0xbbe7
Jan 11, 2025 19:12:45.546 [128215708347192] INFO - Preemptively preparing driver imd for GPU Intel Meteor Lake-P [Intel Arc Graphics]
Jan 11, 2025 19:12:45.546 [128215708347192] DEBUG - [DriverDL/imd] Skipping download; already exists
Jan 11, 2025 19:12:45.546 [128215708347192] INFO - Preemptively preparing driver icr for GPU Intel Meteor Lake-P [Intel Arc Graphics]
Jan 11, 2025 19:12:45.546 [128215708347192] DEBUG - [DriverDL/icr] Skipping download; already exists
Jan 11, 2025 19:12:45.555 [128215708347192] DEBUG - Grabber: Cleaning up orphaned grabs.
Jan 11, 2025 19:12:45.556 [128215809518224] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Jan 11, 2025 19:12:45.556 [128215687375672] DEBUG - [MediaProviderManager/HCl#1] HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.556 [128215809518224] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Jan 11, 2025 19:12:45.556 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.556 [128215809518224] DEBUG - MyPlex: updating with 29 access tokens
Jan 11, 2025 19:12:45.556 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.557 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/subscriptions?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.557 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/services?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.557 [128215809518224] DEBUG - Opening 1 database sessions to library (), SQLite 3.39.4, threadsafe=1
Jan 11, 2025 19:12:45.558 [128215678987064] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Jan 11, 2025 19:12:45.558 [128215678987064] DEBUG - [HCl#2] HTTP requesting GET https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.559 [128215662209848] DEBUG - File "/usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370" changed: -1 => 2025-01-10 19:43:19 (1736538199).
Jan 11, 2025 19:12:45.559 [128215662209848] DEBUG - File "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Plug-ins" changed: -1 => 2025-01-10 19:43:26 (1736538206).
Jan 11, 2025 19:12:45.559 [128215662209848] DEBUG - Scanning for plug-ins in "/usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370"
Jan 11, 2025 19:12:45.560 [128215662209848] DEBUG - Scanning for plug-ins in "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Plug-ins"
Jan 11, 2025 19:12:45.560 [128215662209848] DEBUG - PluginRepository::setStartState: 1, startingSystem
Jan 11, 2025 19:12:45.560 [128215662209848] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/System.bundle.
Jan 11, 2025 19:12:45.561 [128215662209848] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Jan 11, 2025 19:12:45.561 [128215662209848] DEBUG - Starting file watcher for com.plexapp.system
Jan 11, 2025 19:12:45.561 [128215662209848] DEBUG - Plugin: setting environment variable: 'PYTHONHOME=/usr/lib/plexmediaserver/Resources/Python'
Jan 11, 2025 19:12:45.561 [128215662209848] DEBUG - Plugin: setting environment variable: 'PYTHONPATH=/usr/lib/plexmediaserver/Resources/Python/python27.zip:/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/site-packages'
Jan 11, 2025 19:12:45.562 [128215662209848] DEBUG - Spawned plug-in com.plexapp.system with PID 3729
Jan 11, 2025 19:12:45.562 [128215662209848] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Jan 11, 2025 19:12:45.568 [128215708347192] DEBUG - Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Jan 11, 2025 19:12:45.705 [128215666404152] DEBUG - Request: [192.168.20.81:62822 (Subnet)] GET /media/providers (2 live) #1 TLS GZIP Token ()
Jan 11, 2025 19:12:45.705 [128215704152888] DEBUG - Completed: [192.168.20.81:62822] 503 GET /media/providers (2 live) #1 TLS GZIP 0ms 569 bytes (pipelined: 1)
Jan 11, 2025 19:12:45.707 [128215666404152] DEBUG - Request: [192.168.20.81:62822 (Subnet)] GET /statistics/bandwidth?timespan=6 (2 live) #5 TLS GZIP Token ()
Jan 11, 2025 19:12:45.707 [128215699958584] DEBUG - Completed: [192.168.20.81:62822] 503 GET /statistics/bandwidth?timespan=6 (2 live) #5 TLS GZIP 0ms 569 bytes (pipelined: 2)
Jan 11, 2025 19:12:45.709 [128215666404152] DEBUG - Request: [192.168.20.81:62822 (Subnet)] GET /statistics/resources?timespan=6 (2 live) #6 TLS GZIP Token ()
Jan 11, 2025 19:12:45.709 [128215704152888] DEBUG - Completed: [192.168.20.81:62822] 503 GET /statistics/resources?timespan=6 (2 live) #6 TLS GZIP 0ms 569 bytes (pipelined: 3)
Jan 11, 2025 19:12:45.711 [128215666404152] DEBUG - Request: [192.168.20.81:62822 (Subnet)] GET /media/providers (2 live) #7 TLS GZIP Token ()
Jan 11, 2025 19:12:45.711 [128215683181368] DEBUG - [HttpClient/HCl#1] HTTP/1.1 (0.2s) 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.711 [128215704152888] DEBUG - Completed: [192.168.20.81:62822] 503 GET /media/providers (2 live) #7 TLS GZIP 0ms 569 bytes (pipelined: 4)
Jan 11, 2025 19:12:45.711 [128215687375672] DEBUG - [MediaProviderManager/HCl#3] HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.753 [128215683181368] DEBUG - [HttpClient/HCl#2] HTTP/1.1 (0.2s) 200 response from GET https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.753 [128215678987064] DEBUG - MyPlex: updating with 29 access tokens
Jan 11, 2025 19:12:45.753 [128215678987064] DEBUG - [HCl#4] HTTP requesting GET https://plex.tv/api/v2/server/users?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.762 [128215683181368] DEBUG - [HttpClient/HCl#3] HTTP/1.1 (0.1s) 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:45.762 [128215687375672] DEBUG - [MediaProviderManager/HCl#5] HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.765 [128215666404152] DEBUG - Request: [192.168.20.81:62827 (Subnet)] GET /media/providers (3 live) #3 GZIP Token ()
Jan 11, 2025 19:12:45.765 [128215704152888] DEBUG - Completed: [192.168.20.81:62827] 503 GET /media/providers (3 live) #3 GZIP 0ms 436 bytes (pipelined: 1)
Jan 11, 2025 19:12:45.802 [128215683181368] DEBUG - [HttpClient/HCl#4] HTTP/1.1 (0.0s) 200 response from GET https://plex.tv/api/v2/server/users?auth_token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:45.803 [128215670598456] DEBUG - [HCl#6] HTTP requesting GET https://plex.tv/api/v2/server/users/subscriptions?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.810 [128215683181368] DEBUG - [HttpClient/HCl#5] HTTP/1.1 (0.0s) 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:45.810 [128215687375672] DEBUG - [MediaProviderManager] discovered cloud provider (Movies & Shows)
Jan 11, 2025 19:12:45.810 [128215674792760] DEBUG - [MediaProviderManager/HCl#7] HTTP requesting GET https://vod.provider.plex.tv?includePreferences=1
Jan 11, 2025 19:12:45.810 [128215687375672] DEBUG - [MediaProviderManager] discovered cloud provider (Metadata)
Jan 11, 2025 19:12:45.810 [128215687375672] DEBUG - [MediaProviderManager] loading cloud provider details (Metadata) (alive: 0)
Jan 11, 2025 19:12:45.860 [128215683181368] DEBUG - [HttpClient/HCl#6] HTTP/1.1 (0.1s) 200 response from GET https://plex.tv/api/v2/server/users/subscriptions?auth_token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:45.860 [128215670598456] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/services?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:45.918 [128215683181368] DEBUG - [HttpClient/HCl#7] HTTP/2.0 (0.1s) 200 response from GET https://vod.provider.plex.tv?includePreferences=1
Jan 11, 2025 19:12:45.925 [128215687375672] DEBUG - [MediaProviderManager] loading cloud provider details (Movies & Shows) (alive: 1)
Jan 11, 2025 19:12:45.925 [128215687375672] DEBUG - [MediaProviderManager] we had 0 cloud providers online, we now have 2
Jan 11, 2025 19:12:45.925 [128215687375672] DEBUG - [MediaProviderManager] cloud provider (Metadata) is online and available
Jan 11, 2025 19:12:45.925 [128215687375672] DEBUG - [MediaProviderManager] cloud provider (Movies & Shows) is online and available
Jan 11, 2025 19:12:45.925 [128215687375672] DEBUG - [MediaProviderManager/MetadataAgentManager] attempted to online our built-in agents but we're not yet signed in
Jan 11, 2025 19:12:46.509 [128215666404152] DEBUG - Request: [192.168.20.81:62827 (Subnet)] GET /media/providers (8 live) #a GZIP Token ()
Jan 11, 2025 19:12:46.510 [128215699958584] DEBUG - Completed: [192.168.20.81:62827] 503 GET /media/providers (8 live) #a GZIP 0ms 436 bytes (pipelined: 2)
Jan 11, 2025 19:12:46.672 [128215666404152] DEBUG - Request: [127.0.0.1:38552 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (9 live) #f GZIP Token ()
Jan 11, 2025 19:12:46.673 [128215699958584] DEBUG - Completed: [127.0.0.1:38552] 503 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (9 live) #f GZIP 0ms 436 bytes
Jan 11, 2025 19:12:46.676 [128215666404152] DEBUG - Request: [127.0.0.1:38566 (Loopback)] GET / (9 live) #11 GZIP Token ()
Jan 11, 2025 19:12:46.676 [128215699958584] DEBUG - Completed: [127.0.0.1:38566] 503 GET / (9 live) #11 GZIP 0ms 436 bytes
Jan 11, 2025 19:12:47.501 [128215678987064] DEBUG - [JobRunner] Job running: /usr/lib/plexmediaserver/CrashUploader "--directory=/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Crash Reports/1.41.3.9314-a0bfb8370" --version=1.41.3.9314-a0bfb8370 --platform=Linux "--platformVersion=24.04.1 LTS (Noble Numbat)" --serverUuid=bea5275cf31d99f66ab9d2bbab6e70ee9c22262b --userId=martin@mystisk.dk --sentryUrl=https://o17675.ingest.sentry.io/api/1233455/ --sentryKey=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx --vendor=Ubuntu --model=x86_64 "--device=Intel Corporation 440BX Desktop Reference Platform"
Jan 11, 2025 19:12:47.502 [128215678987064] DEBUG - [JobRunner] Jobs: Starting child process with pid 3748
Jan 11, 2025 19:12:47.507 [128215712541496] DEBUG - Jobs: '/usr/lib/plexmediaserver/CrashUploader' exit code for process 3748 is 0 (success)
Jan 11, 2025 19:12:47.523 [128215666404152] DEBUG - Request: [127.0.0.1:38570 (Loopback)] GET /servers (9 live) #13 GZIP Token ()
Jan 11, 2025 19:12:47.523 [128215699958584] DEBUG - Completed: [127.0.0.1:38570] 503 GET /servers (9 live) #13 GZIP 0ms 436 bytes
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - Reading 486 bytes in the body, code is 200
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - [com.plexapp.system] Plug-in running on port 43961.
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - * Plug-in handles prefix: /system
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - * Plug-in handles prefix: /player
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - Updating the list of agents known by the system.
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Jan 11, 2025 19:12:47.544 [128215662209848] DEBUG - [HCl#a] HTTP requesting GET http://127.0.0.1:43961/system/agents
Jan 11, 2025 19:12:47.544 [128215809518224] DEBUG - Image transcode cache directory: "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder"
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - Transcoder: Cleaning old transcode directories.
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/access_tokens?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: updating with 29 access tokens
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/subscriptions?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/server/users/services?auth_token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.545 [128215809518224] DEBUG - MyPlex: using cached data for request for https://plex.tv/api/v2/user?includeSubscriptions=1&includeProviders=1
Jan 11, 2025 19:12:47.546 [128215809518224] DEBUG - MyPlex: username is Martinmystisk, login is martin@mystisk.dk, home is 1, has pin
Jan 11, 2025 19:12:47.547 [128215687375672] DEBUG - [MediaProviderManager/HCl#b] HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.548 [128215809518224] DEBUG - MyPlex: start public ip check and mapping - current mapped state: 'Unknown'.
Jan 11, 2025 19:12:47.548 [128215809518224] DEBUG - MyPlex: mapping state set to 'Not Mapped'.
Jan 11, 2025 19:12:47.548 [128215809518224] DEBUG - PublicAddressManager: Starting.
Jan 11, 2025 19:12:47.548 [128215809518224] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Jan 11, 2025 19:12:47.548 [128215678987064] DEBUG - PublicAddressManager: Obtaining public IP.
Jan 11, 2025 19:12:47.548 [128215678987064] DEBUG - [HCl#c] HTTP requesting GET https://v4.plex.tv/pms/:/ip
Jan 11, 2025 19:12:47.548 [128215649626936] DEBUG - [HCl#d] HTTP requesting GET https://plex.tv/api/v2/user?includeSubscriptions=1&includeProviders=1
Jan 11, 2025 19:12:47.548 [128215674792760] DEBUG - NAT: UPnP, attempting port mapping.
Jan 11, 2025 19:12:47.549 [128215809518224] DEBUG - NetworkInterface: Starting watch thread.
Jan 11, 2025 19:12:47.549 [128215809518224] DEBUG - Network change.
Jan 11, 2025 19:12:47.549 [128215809518224] DEBUG - NetworkInterface: Notified of network changed (force=0)
Jan 11, 2025 19:12:47.549 [128215641238328] DEBUG - NetworkInterface: Watching for changes on the interfaces.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - Detected primary interface: 192.168.20.121
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - Network interfaces:
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - * 1 lo (127.0.0.1) (00-00-00-00-00-00) (loopback: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - * 2 ens34 (192.168.20.121) (00-0C-29-76-F4-2B) (loopback: 0)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - * 1 lo (::1) (00-00-00-00-00-00) (loopback: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - Creating NetworkServices singleton.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkServices: Initializing...
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.550 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.550 [128215637044024] DEBUG - Network change for advertiser.
Jan 11, 2025 19:12:47.551 [128215637044024] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414
Jan 11, 2025 19:12:47.551 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.551 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.551 [128215809518224] DEBUG - NetworkService: Creating new service.
Jan 11, 2025 19:12:47.551 [128215809518224] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Jan 11, 2025 19:12:47.551 [128215809518224] DEBUG - NetworkService: Quick dispatch of network change.
Jan 11, 2025 19:12:47.552 [128215637044024] DEBUG - Network change for advertiser.
Jan 11, 2025 19:12:47.552 [128215637044024] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - Network change for advertiser.
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32412
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Browsing on interface 192.168.20.121 on broadcast address 192.168.20.255 (index: 1)
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Network change for browser (polled=1), closing 0 browse sockets.
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Browsing on interface 192.168.20.121 on broadcast address 192.168.20.255 (index: 1)
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901
Jan 11, 2025 19:12:47.553 [128215637044024] DEBUG - NetworkService: Browsing on interface 192.168.20.121 on broadcast address 239.255.255.250 (index: 0)
Jan 11, 2025 19:12:47.554 [128215708347192] DEBUG - DVR: Starting up.
Jan 11, 2025 19:12:47.555 [128215708347192] DEBUG - Activity: registered new activity f3ec4380-709b-4d94-89b5-01ce1db2aca1 - "Processing subscriptions"
Jan 11, 2025 19:12:47.555 [128215624461112] DEBUG - [ChildProcessMonitor] Plex Tuner Service starting.
Jan 11, 2025 19:12:47.555 [128215624461112] DEBUG - [ChildProcessMonitor/JobRunner] Job running: "/usr/lib/plexmediaserver/Plex Tuner Service" /usr/lib/plexmediaserver/Resources/Tuner/Private /usr/lib/plexmediaserver/Resources/Tuner/Shared 1.41.3.9314-a0bfb8370 32600
Jan 11, 2025 19:12:47.556 [128215624461112] DEBUG - [ChildProcessMonitor/JobRunner] Jobs: Starting child process with pid 3781
Jan 11, 2025 19:12:47.558 [128215809518224] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Jan 11, 2025 19:12:47.558 [128215809518224] DEBUG - [HCl#e] HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.600 [128215683181368] DEBUG - [HttpClient/HCl#b] HTTP/1.1 (0.1s) 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:47.600 [128215632849720] DEBUG - [MediaProviderManager/HCl#f] HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jan 11, 2025 19:12:47.601 [128215683181368] DEBUG - [HttpClient/HCl#a] HTTP/1.1 (0.1s) 200 response from GET http://127.0.0.1:43961/system/agents
Jan 11, 2025 19:12:47.601 [128215662209848] DEBUG - [com.plexapp.system] HTTP reply status 200, with 8986 bytes of content.
Jan 11, 2025 19:12:47.603 [128215662209848] DEBUG - The system knows about 12 agents.
Jan 11, 2025 19:12:47.603 [128215645432632] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/HTbackdrops.bundle.
Jan 11, 2025 19:12:47.604 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/Scanners.bundle.
Jan 11, 2025 19:12:47.604 [128215645432632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
Jan 11, 2025 19:12:47.606 [128215645432632] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/LocalMedia.bundle.
Jan 11, 2025 19:12:47.606 [128215616072504] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/TheTVDBv4.bundle.
Jan 11, 2025 19:12:47.606 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/Musicbrainz.bundle.
Jan 11, 2025 19:12:47.607 [128215662209848] DEBUG - Waiting for 14 plug-ins to finish starting.
Jan 11, 2025 19:12:47.608 [128215616072504] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
Jan 11, 2025 19:12:47.608 [128215616072504] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/Framework.bundle.
Jan 11, 2025 19:12:47.609 [128215645432632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
Jan 11, 2025 19:12:47.609 [128215645432632] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/Fanart-TV.bundle.
Jan 11, 2025 19:12:47.610 [128215620266808] DEBUG - Perfect cache hit, we don't need to start [org.musicbrainz.agents.music] yet.
Jan 11, 2025 19:12:47.610 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/MoviePosterDB.bundle.
Jan 11, 2025 19:12:47.613 [128215616072504] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/PersonalMedia.bundle.
Jan 11, 2025 19:12:47.613 [128215620266808] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
Jan 11, 2025 19:12:47.613 [128215645432632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.fanarttv] yet.
Jan 11, 2025 19:12:47.614 [128215645432632] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/LyricFind.bundle.
Jan 11, 2025 19:12:47.614 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/LastFM.bundle.
Jan 11, 2025 19:12:47.616 [128215616072504] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
Jan 11, 2025 19:12:47.616 [128215616072504] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/WebClient.bundle.
Jan 11, 2025 19:12:47.617 [128215620266808] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
Jan 11, 2025 19:12:47.618 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/PlexMovie.bundle.
Jan 11, 2025 19:12:47.619 [128215645432632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lyricfind] yet.
Jan 11, 2025 19:12:47.619 [128215645432632] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/Media-Flags.bundle.
Jan 11, 2025 19:12:47.621 [128215616072504] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/PlexThemeMusic.bundle.
Jan 11, 2025 19:12:47.622 [128215620266808] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
Jan 11, 2025 19:12:47.622 [128215620266808] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-a0bfb8370/TheMovieDB.bundle.
Jan 11, 2025 19:12:47.624 [128215616072504] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
Jan 11, 2025 19:12:47.628 [128215620266808] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
Jan 11, 2025 19:12:47.629 [128215662209848] DEBUG - Starting scheduled updates, every 3600 seconds
Jan 11, 2025 19:12:47.629 [128215662209848] INFO - LibraryUpdateManager path watching is disabled
Jan 11, 2025 19:12:47.629 [128215662209848] DEBUG - Done waiting for all plug-ins to start.
Jan 11, 2025 19:12:47.629 [128215662209848] DEBUG - PluginRepository::setStartState: 3, complete
Jan 11, 2025 19:12:47.630 [128215708347192] DEBUG - Downloading document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale ro
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale es
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale pl
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale sl
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale nl_BE
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale ko
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale cs_CZ
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale uk
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale fi
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale hr_HR
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale sk
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale en
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale ja_JP
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale sr
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale da
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale sv
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale zh_CN
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale lt
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale et_EE
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale hu_HU
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale ar
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale he
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale pt_BR
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale fr
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale nl
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale pt
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale it
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale af
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale no
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale hu
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale ru
Jan 11, 2025 19:12:47.631 [128215708347192] DEBUG - Translator: Found locale de
Jan 11, 2025 19:12:47.642 [128215708347192] DEBUG - [Req#17] Starting file watcher for com.plexapp.agents.imdb
Jan 11, 2025 19:12:47.642 [128215708347192] DEBUG - [Req#17] Plugin: setting environment variable: 'PYTHONHOME=/usr/lib/plexmediaserver/Resources/Python'
Jan 11, 2025 19:12:47.642 [128215708347192] DEBUG - [Req#17] Plugin: setting environment variable: 'PYTHONPATH=/usr/lib/plexmediaserver/Resources/Python/python27.zip:/usr/lib/plexmediaserver/Resources/Python/lib/python2.7/site-packages'
Jan 11, 2025 19:12:47.645 [128215708347192] DEBUG - [Req#17] Spawned plug-in com.plexapp.agents.imdb with PID 3808
Jan 11, 2025 19:12:47.646 [128215708347192] DEBUG - [Req#17] [com.plexapp.agents.imdb] Sending command: GET /:/prefixes
Jan 11, 2025 19:12:47.660 [128215683181368] DEBUG - [HttpClient/HCl#f] HTTP/1.1 (0.1s) 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (reused)
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] discovered cloud provider (Movies & Shows)
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] discovered cloud provider (Metadata)
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] loading cloud provider details (Metadata) (alive: 1)
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] loading cloud provider details (Movies & Shows) (alive: 1)
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] we had 2 cloud providers online, we now have 2
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] cloud provider (Metadata) is online and available
Jan 11, 2025 19:12:47.660 [128215632849720] DEBUG - [MediaProviderManager] cloud provider (Movies & Shows) is online and available
Jan 11, 2025 19:12:47.730 [128215683181368] DEBUG - [HttpClient/HCl#c] HTTP/1.1 (0.2s) 200 response from GET https://v4.plex.tv/pms/:/ip
Jan 11, 2025 19:12:47.730 [128215678987064] DEBUG - PublicAddressManager: Got public IP from v4.plex.tv: 87.63.195.156
Jan 11, 2025 19:12:47.742 [128215683181368] DEBUG - [HttpClient/HCl#e] HTTP/1.1 (0.2s) 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx