Sep 01, 2018 13:36:35.709 [25080] INFO - Plex Media Server v1.13.6.5339-115f087d6 - Microsoft PC x64 - build: windows-i386 english - GMT -04:00
Sep 01, 2018 13:36:35.709 [25080] INFO - Windows version: 10.0 (Build 17134), language en-US
Sep 01, 2018 13:36:35.710 [25080] INFO - 16 2994 MHz processor(s): Architecture=0, Level=23, Revision=257 Processor Identifier=AMD64 Family 23 Model 1 Stepping 1, AuthenticAMD
Sep 01, 2018 13:36:35.710 [25080] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Server.exe" 
Sep 01, 2018 13:36:35.710 [19668] DEBUG - Plex for Windows Store application is not installed
Sep 01, 2018 13:36:35.711 [19668] DEBUG - BPQ: [Idle] -> [Starting]
Sep 01, 2018 13:36:35.718 [19668] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 01, 2018 13:36:35.777 [19668] DEBUG - Running migrations. (EPG 0)
Sep 01, 2018 13:36:35.788 [19668] DEBUG - ChangestampAllocator: initialized to 6983
Sep 01, 2018 13:36:35.788 [19668] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.13.0, threadsafe=1
Sep 01, 2018 13:36:35.795 [19668] DEBUG - Running migrations. (EPG 0)
Sep 01, 2018 13:36:36.837 [19668] DEBUG - CERT: Installed certificate with fingerprint 71:85:91:c9:00:ad:f3:c6:bd:4a:72:14:07:80:59:d8:4c:f1:93:63.
Sep 01, 2018 13:36:36.837 [19668] DEBUG - CERT: Installed new private key.
Sep 01, 2018 13:36:36.837 [19668] DEBUG - CERT: Subject name is /C=US/ST=California/L=Los Gatos/O=Plex, Inc./CN=*.80d652440c044bd88a6d74c00626aeb4.plex.direct
Sep 01, 2018 13:36:36.838 [19668] DEBUG - CERT: OCSP requests for stapling will be made to 'http://ocspx.digicert.com/'.
Sep 01, 2018 13:36:36.839 [19668] INFO - OCSP: Successfully retrieved response from cache.
Sep 01, 2018 13:36:36.839 [19668] DEBUG - CERT: Installed intermediate certificate.
Sep 01, 2018 13:36:36.839 [19668] DEBUG - HttpServer: Listening on IPv6 as well as IPv4.
Sep 01, 2018 13:36:36.844 [19668] DEBUG - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::4c22:bd0c:259:cb8a%23,169.254.203.138) because it has no gateway
Sep 01, 2018 13:36:36.844 [19668] DEBUG - NetworkInterface: ignoring adapter 'Local Area Connection* 14' (fe80::b443:459a:cb91:5a1b%6,169.254.90.27) because it has no gateway
Sep 01, 2018 13:36:36.846 [19668] DEBUG - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 01, 2018 13:36:36.846 [19668] DEBUG - HttpServer: Listening on port 32400 with queue of 2147483647 connections.
Sep 01, 2018 13:36:36.852 [19668] DEBUG - HttpServer: Listening on port 32401 with queue of 2147483647 connections.
Sep 01, 2018 13:36:36.862 [19668] INFO - Killing PlexScriptHost.exe process with pid 13748
Sep 01, 2018 13:36:36.884 [19668] INFO - Killing PlexTranscoder.exe process with pid 19256
Sep 01, 2018 13:36:36.943 [20660] DEBUG - DVR:Grabber: Cleaning up orphaned grabs.
Sep 01, 2018 13:36:36.943 [19668] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Sep 01, 2018 13:36:36.943 [19668] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 01, 2018 13:36:36.944 [9480] DEBUG - Relay: read 0 cached entries from hosts file
Sep 01, 2018 13:36:36.944 [19668] DEBUG - Relay: read 0 cached entries from hosts file
Sep 01, 2018 13:36:36.944 [20660] DEBUG - DVR:Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Sep 01, 2018 13:36:36.944 [9480] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:36.944 [19668] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 01, 2018 13:36:36.945 [19668] DEBUG - MyPlex: updating with 8 access tokens
Sep 01, 2018 13:36:36.946 [20496] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 01, 2018 13:36:36.946 [20496] DEBUG - HTTP requesting GET https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 01, 2018 13:36:36.946 [1980] DEBUG - File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6" changed: -1 => 1535819811.
Sep 01, 2018 13:36:36.946 [1980] DEBUG - File "C:\Users\Ross Klos\AppData\Local\Plex Media Server\Plug-ins" changed: -1 => 1535819851.
Sep 01, 2018 13:36:36.947 [1980] DEBUG - Scanning for plug-ins in "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6"
Sep 01, 2018 13:36:36.955 [1980] DEBUG - Scanning for plug-ins in "C:\Users\Ross Klos\AppData\Local\Plex Media Server\Plug-ins"
Sep 01, 2018 13:36:36.955 [1980] DEBUG - PluginRepository::setStartState: 1, startingSystem
Sep 01, 2018 13:36:36.955 [1980] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\System.bundle.
Sep 01, 2018 13:36:36.956 [1980] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Sep 01, 2018 13:36:36.959 [1980] DEBUG - Starting file watcher for com.plexapp.system
Sep 01, 2018 13:36:36.959 [1980] DEBUG - Plugin::createProcess: Creating plugin process: "C:\Program Files (x86)\Plex\Plex Media Server\PlexScriptHost.exe" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\System.bundle"
Sep 01, 2018 13:36:36.966 [1980] DEBUG - Spawned plug-in com.plexapp.system with PID 9364
Sep 01, 2018 13:36:36.966 [1980] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes

Sep 01, 2018 13:36:37.494 [9480] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:37.538 [20496] DEBUG - HTTP 200 response from GET https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 01, 2018 13:36:37.541 [20496] DEBUG - MyPlex: updating with 8 access tokens
Sep 01, 2018 13:36:37.542 [20660] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:37.708 [4192] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe "--directory=C:\Users\Ross Klos\AppData\Local\Plex Media Server\Crash Reports\1.13.6.5339-115f087d6" --version=1.13.6.5339-115f087d6 "--platform=windows-i386 (10.0 (Build 17134))" --serverUuid=0a8da23742e20e2b3169643a2e9cdd2448c34681 --userId=klosterman.53@gmail.com --url=https://crashreport.plexapp.com 
Sep 01, 2018 13:36:37.716 [4192] DEBUG - Jobs: Starting child process with pid 2344
Sep 01, 2018 13:36:38.071 [20660] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:38.071 [20660] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe' exit code for process 2344 is 0 (success)
Sep 01, 2018 13:36:39.227 [1980] DEBUG - Reading 486 bytes in the body, code is 200
Sep 01, 2018 13:36:39.227 [1980] DEBUG - [com.plexapp.system] Plug-in running on port 52475.
Sep 01, 2018 13:36:39.227 [1980] DEBUG -  * Plug-in handles prefix: /system
Sep 01, 2018 13:36:39.227 [1980] DEBUG -  * Plug-in handles prefix: /player
Sep 01, 2018 13:36:39.227 [1980] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Sep 01, 2018 13:36:39.230 [1980] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Sep 01, 2018 13:36:39.230 [1980] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Sep 01, 2018 13:36:39.230 [1980] DEBUG - Updating the list of agents known by the system.
Sep 01, 2018 13:36:39.230 [1980] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Sep 01, 2018 13:36:39.230 [1980] DEBUG - HTTP requesting GET http://127.0.0.1:52475/system/agents
Sep 01, 2018 13:36:39.231 [19668] DEBUG - Image transcode cache directory: "C:\Users\Ross Klos\AppData\Local\Plex Media Server\Cache\PhotoTranscoder"
Sep 01, 2018 13:36:39.231 [19668] DEBUG - Transcoder: Cleaning old transcode directories.
Sep 01, 2018 13:36:39.233 [19668] DEBUG - Transcoder: Cleaning old transcode directory: "C:\Users\Ross Klos\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-hh6r4l6f00gzvof57d44er96-7b139204-94bb-4477-8125-c6e9874b8af3"
Sep 01, 2018 13:36:39.233 [19668] ERROR - Transcoder: Failed to delete session directory (boost::filesystem::remove: The process cannot access the file because it is being used by another process: "C:\Users\Ross Klos\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-hh6r4l6f00gzvof57d44er96-7b139204-94bb-4477-8125-c6e9874b8af3")
Sep 01, 2018 13:36:39.234 [19668] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 01, 2018 13:36:39.234 [19668] DEBUG - MyPlex: updating with 8 access tokens
Sep 01, 2018 13:36:39.235 [20496] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.235 [19668] DEBUG - MyPlex: using cached data for request for https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeGeolocation=1
Sep 01, 2018 13:36:39.236 [19668] DEBUG - MyPlex: username is Klospin, login is klosterman.53@gmail.com, home is 0, no pin
Sep 01, 2018 13:36:39.237 [19668] DEBUG - PublicAddressManager: Starting.
Sep 01, 2018 13:36:39.237 [19668] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 01, 2018 13:36:39.237 [8404] DEBUG - HTTP requesting GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.237 [19668] DEBUG - NetworkInterface: Notified of network changed (force=0)
Sep 01, 2018 13:36:39.237 [9480] DEBUG - PublicAddressManager: Obtaining public IP.
Sep 01, 2018 13:36:39.237 [9480] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Sep 01, 2018 13:36:39.242 [19668] DEBUG - Network interfaces:
Sep 01, 2018 13:36:39.242 [19668] DEBUG -  * 24 Wi-Fi 2 {F9B97710-CAF7-400D-9032-F954A1709A9B} (192.168.86.248) (loopback: 0)
Sep 01, 2018 13:36:39.243 [19668] DEBUG - Creating NetworkServices singleton.
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkServices: Initializing...
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.243 [24552] DEBUG - Network change for advertiser.
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.243 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.243 [24552] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414 (outbound: 0)
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.244 [24552] DEBUG - Network change for advertiser.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.244 [24552] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410 (outbound: 0)
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Creating new service.
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 01, 2018 13:36:39.244 [19668] DEBUG - NetworkService: Quick dispatch of network change.
Sep 01, 2018 13:36:39.245 [24552] DEBUG - Network change for advertiser.
Sep 01, 2018 13:36:39.245 [24552] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32412 (outbound: 0)
Sep 01, 2018 13:36:39.245 [24552] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Sep 01, 2018 13:36:39.245 [4192] DEBUG - NAT: UPnP, attempting port mapping.
Sep 01, 2018 13:36:39.245 [24552] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413 (outbound: 0)
Sep 01, 2018 13:36:39.245 [24552] DEBUG - NetworkService: Browsing on interface 192.168.86.248 on broadcast address 192.168.86.255 (index: 0)
Sep 01, 2018 13:36:39.245 [24552] DEBUG - NetworkService: Network change for browser (polled=1), closing 0 browse sockets.
Sep 01, 2018 13:36:39.246 [24552] DEBUG - NetworkService: Browsing on interface 192.168.86.248 on broadcast address 192.168.86.255 (index: 0)
Sep 01, 2018 13:36:39.246 [24552] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Sep 01, 2018 13:36:39.246 [24552] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901 (outbound: 0)
Sep 01, 2018 13:36:39.246 [24552] DEBUG - NetworkService: Browsing on interface 192.168.86.248 on broadcast address 239.255.255.250 (index: 0)
Sep 01, 2018 13:36:39.254 [24552] DEBUG - NetworkServiceBrowser: SERVER arrived: 192.168.86.248 (Home)
Sep 01, 2018 13:36:39.255 [24552] DEBUG - Notifying the system bundle an update to server /system/notify/serverUpdated?host=192.168.86.248
Sep 01, 2018 13:36:39.255 [24552] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/notify/serverUpdated?host=192.168.86.248
Sep 01, 2018 13:36:39.255 [24552] DEBUG - HTTP requesting GET http://127.0.0.1:52475/system/notify/serverUpdated?host=192.168.86.248
Sep 01, 2018 13:36:39.340 [19668] DEBUG - Gracenote Version 3.07.7.3686 (build: 2015-07-05 11:53-0700)
Sep 01, 2018 13:36:39.340 [19668] DEBUG - Gracenote: Using SQLite 3.13.0
Sep 01, 2018 13:36:39.341 [10460] DEBUG - Plex Dlna Server.exe starting.
Sep 01, 2018 13:36:39.341 [10460] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\Plex Dlna Server.exe 
Sep 01, 2018 13:36:39.341 [19668] DEBUG - Starting HTTP server.
Sep 01, 2018 13:36:39.342 [19668] DEBUG - Running server...
Sep 01, 2018 13:36:39.342 [3328] DEBUG - Plex Tuner Service.exe starting.
Sep 01, 2018 13:36:39.342 [23468] DEBUG - HttpServer: Set up a thread pool with 2 threads.
Sep 01, 2018 13:36:39.342 [19668] DEBUG - Waiting for server condition to be signaled.
Sep 01, 2018 13:36:39.342 [23468] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.348 [10460] DEBUG - Jobs: Starting child process with pid 17892
Sep 01, 2018 13:36:39.349 [3328] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\Plex Tuner Service.exe "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Tuner\Private" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Tuner\Shared" 1.13.6.5339-115f087d6 32600 /waitmutex 
Sep 01, 2018 13:36:39.350 [1980] DEBUG - HTTP 200 response from GET http://127.0.0.1:52475/system/agents
Sep 01, 2018 13:36:39.350 [1980] DEBUG - [com.plexapp.system] HTTP reply status 200, with 9036 bytes of content.
Sep 01, 2018 13:36:39.354 [1980] DEBUG - The system knows about 13 agents.
Sep 01, 2018 13:36:39.354 [1980] DEBUG - Waiting for 18 plug-ins to finish starting.
Sep 01, 2018 13:36:39.355 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Framework.bundle.
Sep 01, 2018 13:36:39.355 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Fanart-TV.bundle.
Sep 01, 2018 13:36:39.355 [7664] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\HTbackdrops.bundle.
Sep 01, 2018 13:36:39.356 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\LastFM.bundle.
Sep 01, 2018 13:36:39.357 [3328] DEBUG - Jobs: Starting child process with pid 10988
Sep 01, 2018 13:36:39.357 [14632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.fanarttv] yet.
Sep 01, 2018 13:36:39.357 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\LocalMedia.bundle.
Sep 01, 2018 13:36:39.357 [7664] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
Sep 01, 2018 13:36:39.358 [7664] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\LyricFind.bundle.
Sep 01, 2018 13:36:39.358 [2184] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
Sep 01, 2018 13:36:39.358 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Media-Flags.bundle.
Sep 01, 2018 13:36:39.361 [7664] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lyricfind] yet.
Sep 01, 2018 13:36:39.361 [7664] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\MoviePosterDB.bundle.
Sep 01, 2018 13:36:39.361 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\OpenSubtitles.bundle.
Sep 01, 2018 13:36:39.362 [14632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
Sep 01, 2018 13:36:39.362 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\PersonalMedia.bundle.
Sep 01, 2018 13:36:39.363 [7664] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
Sep 01, 2018 13:36:39.363 [2184] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.opensubtitles] yet.
Sep 01, 2018 13:36:39.363 [7664] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\PlexMovie.bundle.
Sep 01, 2018 13:36:39.363 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\PlexMusic.bundle.
Sep 01, 2018 13:36:39.363 [14632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
Sep 01, 2018 13:36:39.364 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\PlexThemeMusic.bundle.
Sep 01, 2018 13:36:39.365 [14632] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
Sep 01, 2018 13:36:39.365 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Scanners.bundle.
Sep 01, 2018 13:36:39.365 [7664] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
Sep 01, 2018 13:36:39.365 [2184] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexmusic] yet.
Sep 01, 2018 13:36:39.366 [7664] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\TheMovieDB.bundle.
Sep 01, 2018 13:36:39.366 [2184] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\TheTVDB.bundle.
Sep 01, 2018 13:36:39.366 [14632] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\WebClient.bundle.
Sep 01, 2018 13:36:39.367 [14632] DEBUG - Starting plug-in C:\Users\Ross Klos\AppData\Local\Plex Media Server\Plug-ins\Services.bundle.
Sep 01, 2018 13:36:39.367 [7664] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
Sep 01, 2018 13:36:39.368 [2184] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
Sep 01, 2018 13:36:39.369 [1980] DEBUG - Starting scheduled updates, every 3600 seconds
Sep 01, 2018 13:36:39.369 [1980] INFO - Refreshing paths watched by LibraryUpdateManager
Sep 01, 2018 13:36:39.369 [18828] DEBUG - Downloading document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs
Sep 01, 2018 13:36:39.370 [1980] DEBUG - LibraryUpdateManager will start watching G:\Movies Home
Sep 01, 2018 13:36:39.370 [1980] DEBUG - LibraryUpdateManager will start watching C:\Users\Ross Klos\Desktop\Test
Sep 01, 2018 13:36:39.370 [1980] DEBUG - LibraryUpdateManager will start watching G:\Movies Home
Sep 01, 2018 13:36:39.371 [1980] DEBUG - Done waiting for all plug-ins to start.
Sep 01, 2018 13:36:39.371 [1980] DEBUG - PluginRepository::setStartState: 3, complete
Sep 01, 2018 13:36:39.371 [18828] DEBUG - Translator: Found locale ar
Sep 01, 2018 13:36:39.371 [18828] DEBUG - Translator: Found locale cs_CZ
Sep 01, 2018 13:36:39.371 [18828] DEBUG - Translator: Found locale da
Sep 01, 2018 13:36:39.371 [18828] DEBUG - Translator: Found locale de
Sep 01, 2018 13:36:39.371 [18828] DEBUG - Translator: Found locale en
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale es
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale et_EE
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale fr
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale he
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale hr_HR
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale hu_HU
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale it
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale ja_JP
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale ko
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale lt
Sep 01, 2018 13:36:39.372 [18828] DEBUG - Translator: Found locale nl
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale nl_BE
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale no
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale pt_BR
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale ro
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale ru
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale sr
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale sv
Sep 01, 2018 13:36:39.373 [18828] DEBUG - Translator: Found locale zh_CN
Sep 01, 2018 13:36:39.388 [18828] DEBUG - Starting file watcher for com.plexapp.agents.imdb
Sep 01, 2018 13:36:39.388 [18828] DEBUG - Plugin::createProcess: Creating plugin process: "C:\Program Files (x86)\Plex\Plex Media Server\PlexScriptHost.exe" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-115f087d6\PlexMovie.bundle"
Sep 01, 2018 13:36:39.394 [18828] DEBUG - Spawned plug-in com.plexapp.agents.imdb with PID 23120
Sep 01, 2018 13:36:39.394 [18828] DEBUG - [com.plexapp.agents.imdb] Sending command: GET /:/prefixes

Sep 01, 2018 13:36:39.487 [9480] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Sep 01, 2018 13:36:39.488 [9480] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 65.96.122.105
Sep 01, 2018 13:36:39.773 [20496] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.881 [23468] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.884 [23468] DEBUG - Running database fix-ups.
Sep 01, 2018 13:36:39.885 [23468] DEBUG - Database Fixups: Destroyed 0 transient items.
Sep 01, 2018 13:36:39.886 [23468] DEBUG - Collections: Found 0 collections tags in section 1.
Sep 01, 2018 13:36:39.886 [23468] DEBUG - Collections: We had 0 collections in the library already.
Sep 01, 2018 13:36:39.887 [23468] DEBUG - Collections: Synced tags in section 1 in 0ms.
Sep 01, 2018 13:36:39.887 [23468] DEBUG - Collections: Refreshed attributes for 0 collections in section 1 in 0ms.
Sep 01, 2018 13:36:39.922 [8404] DEBUG - HTTP 200 response from GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.922 [23468] DEBUG - Collection: Refreshed visibility in section 1 in 35ms.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Collections: Found 0 collections tags in section 2.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Collections: We had 0 collections in the library already.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Collections: Synced tags in section 2 in 0ms.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Collections: Refreshed attributes for 0 collections in section 2 in 0ms.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Collection: Refreshed visibility in section 2 in 0ms.
Sep 01, 2018 13:36:39.923 [23468] DEBUG - Running database fix-ups completed in 0.1 seconds.
Sep 01, 2018 13:36:39.924 [23468] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:39.925 [8404] DEBUG - MyPlex: username is Klospin, login is klosterman.53@gmail.com, home is 0, no pin
Sep 01, 2018 13:36:39.926 [8404] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.451 [23468] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.455 [20660] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.488 [8404] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.491 [8404] DEBUG - Sync: onMyPlexSignIn
Sep 01, 2018 13:36:40.492 [8404] DEBUG - HTTP requesting GET https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/sync_lists?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.986 [20660] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.986 [20660] DEBUG - DVR: Starting up.
Sep 01, 2018 13:36:40.987 [24900] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:40.987 [20660] DEBUG - Activity: registered new activity c3079a25-34e3-49a5-85ff-6a7afbaa8f3e - Processing subscriptions
Sep 01, 2018 13:36:41.026 [8404] DEBUG - HTTP 200 response from GET https://plex.tv/servers/0a8da23742e20e2b3169643a2e9cdd2448c34681/sync_lists?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.026 [8404] DEBUG - Sync: downloaded 0 sync lists, analyzing now...
Sep 01, 2018 13:36:41.027 [8404] DEBUG - Sync: synchronizing 0 sync lists to generators
Sep 01, 2018 13:36:41.027 [8404] DEBUG - Sync: synchronized 0 sync list(s) to 0 generators
Sep 01, 2018 13:36:41.027 [8404] INFO - Sync: downloaded 0 sync list(s) with 0 sync items(s): 0 new, 0 updated, 0 deleted
Sep 01, 2018 13:36:41.027 [10728] DEBUG - BPQ: garbageCollect - sync - forced - 8
Sep 01, 2018 13:36:41.027 [8404] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.027 [10728] DEBUG - Sync: starting Sync garbage collection: 8, forced
Sep 01, 2018 13:36:41.028 [10728] DEBUG - Sync: finished Sync garbage collection: 8
Sep 01, 2018 13:36:41.508 [24900] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.653 [8404] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.657 [19020] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.657 [8404] DEBUG - EventSource: Resolving 45.33.75.206 port 443s
Sep 01, 2018 13:36:41.657 [24900] DEBUG - HTTP requesting GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.658 [25268] DEBUG - EventSource: Resolved 45.33.75.206 to 45.33.75.206
Sep 01, 2018 13:36:41.658 [8404] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:41.759 [25268] DEBUG - EventSource: Connected in 68 ms.
Sep 01, 2018 13:36:41.759 [22236] DEBUG - EventSource: Wrote data, reading reply.
Sep 01, 2018 13:36:42.157 [22236] DEBUG - EventSource: Read HTTP reply header.
Sep 01, 2018 13:36:42.157 [22236] DEBUG - MyPlex: We appear to have regained Internet connectivity.
Sep 01, 2018 13:36:42.265 [8404] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:42.277 [19020] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:42.316 [4192] DEBUG - NAT: UPnP, found device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>
Sep 01, 2018 13:36:42.322 [24900] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:42.336 [4192] DEBUG - NAT: UPnP, usable device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>.
Sep 01, 2018 13:36:42.350 [4192] DEBUG - NAT: UPnP, mapped port 23030 to 192.168.86.248:32400.
Sep 01, 2018 13:36:42.563 [9480] DEBUG - NAT: UPnP, found device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>
Sep 01, 2018 13:36:42.585 [9480] DEBUG - NAT: UPnP, usable device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>.
Sep 01, 2018 13:36:42.596 [9480] DEBUG - NAT: UPnP, public address is 65.96.122.105
Sep 01, 2018 13:36:42.601 [22236] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 01, 2018 13:36:42.601 [22236] DEBUG - EventSource: Successfully connected to 45.33.75.206.
Sep 01, 2018 13:36:42.601 [20660] DEBUG - PublicAddressManager: Obtaining public IP.
Sep 01, 2018 13:36:42.602 [20660] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Sep 01, 2018 13:36:42.613 [8404] DEBUG - MyPlex: Updating device connections (from timer: 0)
Sep 01, 2018 13:36:42.613 [4192] DEBUG - PublicAddressManager: Mapping succeeded for 192.168.86.248:23030.
Sep 01, 2018 13:36:42.613 [8404] DEBUG - HTTP requesting PUT https://plex.tv/devices/0a8da23742e20e2b3169643a2e9cdd2448c34681?Connection[][uri]=http://192.168.86.248:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:42.620 [23468] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 01, 2018 13:36:42.620 [24900] DEBUG - NAT: UPnP, attempting port mapping.
Sep 01, 2018 13:36:42.620 [23468] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:42.620 [24072] DEBUG - MyPlex: Sending Server Info to myPlex (user=klosterman.53@gmail.com, ip=, port=0)
Sep 01, 2018 13:36:42.621 [24072] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=c2c14d81-7bea-416e-bcef-5ce78e1f27fb
Sep 01, 2018 13:36:42.838 [20660] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Sep 01, 2018 13:36:42.838 [20660] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 65.96.122.105
Sep 01, 2018 13:36:43.123 [23468] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:43.177 [24072] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=c2c14d81-7bea-416e-bcef-5ce78e1f27fb
Sep 01, 2018 13:36:43.177 [24072] DEBUG - MyPlex: Published Mapping State response was 201
Sep 01, 2018 13:36:43.177 [24072] DEBUG - MyPlex: Got response for 0a8da23742e20e2b3169643a2e9cdd2448c34681 ~ registered :0
Sep 01, 2018 13:36:43.179 [8404] DEBUG - HTTP 200 response from PUT https://plex.tv/devices/0a8da23742e20e2b3169643a2e9cdd2448c34681?Connection[][uri]=http://192.168.86.248:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 01, 2018 13:36:43.184 [8404] DEBUG - CERT: Certificate will not expire soon.
Sep 01, 2018 13:36:43.267 [22236] DEBUG - EventSource: Got event [data] '<Message address="" port="0" asyncIdentifier="c2c14d81-7bea-416e-bcef-5ce78e1f27fb" connectivity="0" command="notifyConnectivity"/>'
Sep 01, 2018 13:36:45.687 [24900] DEBUG - NAT: UPnP, found device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>
Sep 01, 2018 13:36:45.710 [24900] DEBUG - NAT: UPnP, usable device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>.
Sep 01, 2018 13:36:45.722 [24900] DEBUG - NAT: UPnP, mapped port 23030 to 192.168.86.248:32400.
Sep 01, 2018 13:36:45.904 [20660] DEBUG - NAT: UPnP, found device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>
Sep 01, 2018 13:36:45.921 [20660] DEBUG - NAT: UPnP, usable device <http://192.168.86.1:5000/rootDesc.xml> with private address <192.168.86.248>.
Sep 01, 2018 13:36:45.930 [20660] DEBUG - NAT: UPnP, public address is 65.96.122.105
Sep 01, 2018 13:36:45.935 [24900] DEBUG - PublicAddressManager: Mapping succeeded for 192.168.86.248:23030.
Sep 01, 2018 13:36:45.951 [20660] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 01, 2018 13:36:45.959 [9480] DEBUG - MyPlex: Sending Server Info to myPlex (user=klosterman.53@gmail.com, ip=, port=23030)
Sep 01, 2018 13:36:45.960 [9480] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=25fe5841-24c8-474d-8611-6bb15dd0970c
Sep 01, 2018 13:36:45.963 [24900] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 01, 2018 13:36:46.515 [9480] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=25fe5841-24c8-474d-8611-6bb15dd0970c
Sep 01, 2018 13:36:46.516 [9480] DEBUG - MyPlex: Published Mapping State response was 201
Sep 01, 2018 13:36:46.516 [9480] DEBUG - MyPlex: Got response for 0a8da23742e20e2b3169643a2e9cdd2448c34681 ~ registered :0
Sep 01, 2018 13:36:46.529 [4192] DEBUG - MyPlex: Sending Server Info to myPlex (user=klosterman.53@gmail.com, ip=, port=23030)
Sep 01, 2018 13:36:46.530 [4192] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=498d1dda-138f-4b86-8537-20d63f8794bb
Sep 01, 2018 13:36:46.534 [9480] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 01, 2018 13:36:46.658 [19020] DEBUG - HTTP requesting GET https://plex.tv/services/pubsub/servers
Sep 01, 2018 13:36:46.943 [19144] DEBUG - DVR:Device: Discovering and refreshing devices.
Sep 01, 2018 13:36:46.943 [19144] DEBUG - DVR:Grabber: HDHomerun discovered 0 compatible devices.
Sep 01, 2018 13:36:46.943 [19144] DEBUG - HTTP requesting POST http://127.0.0.1:32600/devices/discover
Sep 01, 2018 13:36:47.115 [4192] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=498d1dda-138f-4b86-8537-20d63f8794bb
Sep 01, 2018 13:36:47.115 [4192] DEBUG - MyPlex: Published Mapping State response was 201
Sep 01, 2018 13:36:47.115 [4192] DEBUG - MyPlex: Got response for 0a8da23742e20e2b3169643a2e9cdd2448c34681 ~ registered :0
Sep 01, 2018 13:36:47.115 [22236] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (c2c14d81-7bea-416e-bcef-5ce78e1f27fb, expected 498d1dda-138f-4b86-8537-20d63f8794bb)
Sep 01, 2018 13:36:47.126 [4192] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 01, 2018 13:36:47.170 [19020] DEBUG - HTTP 200 response from GET https://plex.tv/services/pubsub/servers
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 45.33.75.206 was 70 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 172.104.217.190 was 76 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 45.79.197.109 was 117 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 45.79.11.43 was 174 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 184.105.148.83 was 209 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 178.79.176.52 was 216 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 172.104.132.7 was 234 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 139.162.115.125 was 371 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 82.94.168.56 was 392 ms.
Sep 01, 2018 13:36:48.027 [19020] DEBUG - PubSubManager: Time to connect to 139.162.21.199 was 544 ms.
Sep 01, 2018 13:36:48.028 [19020] DEBUG - PubSubManager: Updating best ping time for 45.33.75.206 to 70 ms.
Sep 01, 2018 13:36:49.354 [19144] DEBUG - HTTP 200 response from POST http://127.0.0.1:32600/devices/discover
Sep 01, 2018 13:36:50.988 [20660] DEBUG - Activity: registered new activity b9f6f2f8-8215-461e-a841-766ecf19ff43 - Processing subscriptions
Sep 01, 2018 13:36:50.988 [20660] DEBUG - DVR:Subscription: Scheduling subscriptions.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - DVR:Subscription: Initialized 0 schedulers.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - DVR:Subscription: Scheduled all subscriptions in 0 ms.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - Activity: Ended activity b9f6f2f8-8215-461e-a841-766ecf19ff43.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - DVR:Subscription: There are 0 grabs at the end.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - Activity: Ended activity c3079a25-34e3-49a5-85ff-6a7afbaa8f3e.
Sep 01, 2018 13:36:50.989 [20660] DEBUG - DVR:Subscription: Refreshed all content in 1 ms.
Sep 01, 2018 13:36:56.796 [22236] DEBUG - EventSource: Got event [data] '<Message address="65.96.122.105" port="23030" asyncIdentifier="25fe5841-24c8-474d-8611-6bb15dd0970c" connectivity="0" command="notifyConnectivity"/>'
Sep 01, 2018 13:36:56.797 [22236] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (25fe5841-24c8-474d-8611-6bb15dd0970c, expected 498d1dda-138f-4b86-8537-20d63f8794bb)
Sep 01, 2018 13:36:57.447 [25268] DEBUG - EventSource: Got event [data] '<Message address="65.96.122.105" port="23030" asyncIdentifier="498d1dda-138f-4b86-8537-20d63f8794bb" connectivity="0" command="notifyConnectivity"/>'
Sep 01, 2018 13:36:57.447 [25268] DEBUG - PubSub: Got notified of reachability: 0 for 65.96.122.105:23030
Sep 01, 2018 13:36:59.301 [24552] DEBUG - HTTP 500 response from GET http://127.0.0.1:52475/system/notify/serverUpdated?host=192.168.86.248
Sep 01, 2018 13:36:59.301 [24552] DEBUG - [com.plexapp.system] HTTP reply status 500, with 3550 bytes of content.
Sep 01, 2018 13:36:59.301 [24552] DEBUG - NetworkServiceBrowser: Parsing SSDP schema for http://192.168.86.1:5000/rootDesc.xml
Sep 01, 2018 13:36:59.301 [24552] DEBUG - HTTP requesting GET http://192.168.86.1:5000/rootDesc.xml
Sep 01, 2018 13:36:59.312 [24552] DEBUG - HTTP 200 response from GET http://192.168.86.1:5000/rootDesc.xml
Sep 01, 2018 13:36:59.312 [24552] DEBUG - NetworkServiceBrowser: found 3 SSDP devices via http://192.168.86.1:5000/rootDesc.xml
Sep 01, 2018 13:36:59.312 [24552] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.86.1 (OnHub)
Sep 01, 2018 13:36:59.312 [24552] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.86.1 (WANDevice)
Sep 01, 2018 13:36:59.313 [24552] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.86.1 (WANConnectionDevice)
Sep 01, 2018 13:36:59.315 [24552] DEBUG - NetworkServiceBrowser: Parsing SSDP schema for http://192.168.86.249:8008/ssdp/device-desc.xml
Sep 01, 2018 13:36:59.315 [24552] DEBUG - HTTP requesting GET http://192.168.86.249:8008/ssdp/device-desc.xml
Sep 01, 2018 13:36:59.333 [24552] DEBUG - HTTP 200 response from GET http://192.168.86.249:8008/ssdp/device-desc.xml
Sep 01, 2018 13:36:59.333 [24552] DEBUG - NetworkServiceBrowser: found 1 SSDP devices via http://192.168.86.249:8008/ssdp/device-desc.xml
Sep 01, 2018 13:36:59.333 [24552] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.86.249 (Living Room)
Sep 01, 2018 13:37:00.412 [20496] DEBUG - Gracenote: Loading 29 locales in 20.6 seconds.
Sep 01, 2018 13:37:00.415 [24552] DEBUG - NetworkServiceBrowser: Parsing SSDP schema for http://192.168.86.248:32469/DeviceDescription.xml
Sep 01, 2018 13:37:00.415 [24552] DEBUG - HTTP requesting GET http://192.168.86.248:32469/DeviceDescription.xml
Sep 01, 2018 13:37:00.416 [24552] DEBUG - HTTP 200 response from GET http://192.168.86.248:32469/DeviceDescription.xml
Sep 01, 2018 13:37:00.417 [24552] DEBUG - NetworkServiceBrowser: found 1 SSDP devices via http://192.168.86.248:32469/DeviceDescription.xml
Sep 01, 2018 13:37:00.417 [24552] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.86.248 (Plex Media Server: Home)
Sep 01, 2018 13:37:14.053 [14092] DEBUG - Ordered to stop server.
Sep 01, 2018 13:37:14.053 [19668] DEBUG - Stopping server...
Sep 01, 2018 13:37:14.053 [19668] DEBUG - HttpServer: Stopping server.
Sep 01, 2018 13:37:14.053 [23468] DEBUG - MetadataItemClusterRequestHandler: a shutdown event has been received
Sep 01, 2018 13:37:14.053 [23468] DEBUG - TranscodeJobManager: [Running] onServerShutdown
Sep 01, 2018 13:37:14.053 [23468] DEBUG - TranscodeJobManager: [Running] -> [Shutdown]
Sep 01, 2018 13:37:14.054 [19668] DEBUG - Server stopped.
Sep 01, 2018 13:37:14.054 [19668] DEBUG - NetworkService: Stopping advertisement.
Sep 01, 2018 13:37:14.054 [19668] DEBUG - Killing plug-ins.
Sep 01, 2018 13:37:14.054 [24552] ERROR - Network Service: Error in advertiser handle read: 995 (The I/O operation has been aborted because of either a thread exit or an application request) socket=-1
Sep 01, 2018 13:37:14.054 [19668] DEBUG - [com.plexapp.agents.imdb] Killing.
Sep 01, 2018 13:37:14.054 [19668] DEBUG - [com.plexapp.system] Killing.
Sep 01, 2018 13:37:14.055 [19668] DEBUG - Waiting for Plex Dlna Server.exe to exit.
Sep 01, 2018 13:37:14.071 [18828] ERROR - Timeout or error reading status line from plug-in pipe [com.plexapp.agents.imdb], we're killing it.
Sep 01, 2018 13:37:14.071 [18828] DEBUG - Stopping [com.plexapp.agents.imdb].
Sep 01, 2018 13:37:14.071 [18828] ERROR - Error received reading configuration for com.plexapp.agents.imdb
Sep 01, 2018 13:37:14.071 [18828] DEBUG - Stopping [com.plexapp.agents.imdb].
Sep 01, 2018 13:37:14.071 [18828] DEBUG - Caching document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs as ba9cec84155e04621ae9df83829a1977604975b7
Sep 01, 2018 13:37:14.071 [18828] ERROR - PlexClient::downloadContainer: expected MediaContainer element, found html
Sep 01, 2018 13:37:14.071 [18828] ERROR - IVA: failed to get IMDB prefs
Sep 01, 2018 13:37:14.071 [18828] DEBUG - IVA: Downloading trailer lists.
Sep 01, 2018 13:37:14.155 [24552] INFO - Network Service: Abandoning advertise socket, it was closed.
Sep 01, 2018 13:37:14.270 [18828] DEBUG - IVA: Downloaded 38 trailers for source 1.
Sep 01, 2018 13:37:14.319 [1048] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\Plex Dlna Server.exe' exit code for process 17892 is 0 (success)
Sep 01, 2018 13:37:14.319 [10460] DEBUG - Plex Dlna Server.exe exited.
Sep 01, 2018 13:37:14.320 [19668] DEBUG - Waiting for Plex Tuner Service.exe to exit.
Sep 01, 2018 13:37:14.332 [1048] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\Plex Tuner Service.exe' exit code for process 10988 is 0 (success)
Sep 01, 2018 13:37:14.333 [3328] DEBUG - Plex Tuner Service.exe exited.
Sep 01, 2018 13:37:14.343 [19668] INFO - Killing PlexScriptHost.exe process with pid 13748
Sep 01, 2018 13:37:14.362 [19668] INFO - Killing PlexTranscoder.exe process with pid 19256
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Database: Shutting down.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 0.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 1.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 2.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 3.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 4.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 5.
Sep 01, 2018 13:37:14.401 [19668] DEBUG - Captured session 6.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 7.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 8.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 9.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 10.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 11.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 12.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 13.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 14.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 15.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 16.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 17.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 18.
Sep 01, 2018 13:37:14.402 [19668] DEBUG - Captured session 19.
Sep 01, 2018 13:37:14.407 [19668] DEBUG - Database: Shutting down.
Sep 01, 2018 13:37:14.407 [19668] DEBUG - Captured session 0.
Sep 01, 2018 13:37:14.407 [19668] DEBUG - Captured session 1.
