Sep 13, 2018 13:30:48.632 [3060] INFO - Plex Media Server v1.13.5.5332-21ab172de - Microsoft PC x64 - build: windows-i386 english - GMT -04:00
Sep 13, 2018 13:30:48.632 [3060] INFO - Windows version: 10.0 (Build 17134), language en-US
Sep 13, 2018 13:30:48.632 [3060] INFO - 8 2195 MHz processor(s): Architecture=0, Level=6, Revision=15363 Processor Identifier=Intel64 Family 6 Model 60 Stepping 3, GenuineIntel
Sep 13, 2018 13:30:48.632 [3060] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Server.exe" 
Sep 13, 2018 13:30:48.633 [5220] DEBUG - Plex for Windows Store application is not installed
Sep 13, 2018 13:30:48.634 [5220] DEBUG - BPQ: [Idle] -> [Starting]
Sep 13, 2018 13:30:48.634 [5220] VERBOSE - BPQ: delaying processing 120 second(s)
Sep 13, 2018 13:30:48.636 [5220] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 13, 2018 13:30:48.676 [5220] DEBUG - Running migrations.
Sep 13, 2018 13:30:48.687 [5220] DEBUG - ChangestampAllocator: initialized to 215079
Sep 13, 2018 13:30:48.688 [5220] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.13.0, threadsafe=1
Sep 13, 2018 13:30:48.692 [5220] DEBUG - Running migrations.
Sep 13, 2018 13:30:49.419 [5220] DEBUG - CERT: Installed certificate with fingerprint a4:36:48:a3:d7:2b:f0:15:cb:16:53:38:f6:2d:fa:70:aa:e0:46:45.
Sep 13, 2018 13:30:49.419 [5220] DEBUG - CERT: Installed new private key.
Sep 13, 2018 13:30:49.419 [5220] DEBUG - CERT: Subject name is /C=US/ST=California/L=Los Gatos/O=Plex, Inc./CN=*.d8acffe4de1846a68de45953ebdc2d81.plex.direct
Sep 13, 2018 13:30:49.420 [5220] DEBUG - CERT: OCSP requests for stapling will be made to 'http://ocspx.digicert.com/'.
Sep 13, 2018 13:30:49.420 [5220] VERBOSE - CERT: Successfully generated OCSP stapling request
Sep 13, 2018 13:30:49.420 [5220] INFO - OCSP: Successfully retrieved response from cache.
Sep 13, 2018 13:30:49.420 [5220] DEBUG - CERT: Installed intermediate certificate.
Sep 13, 2018 13:30:49.424 [5220] DEBUG - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:49.424 [5220] DEBUG - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:49.424 [5220] DEBUG - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:49.426 [5220] DEBUG - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:49.426 [5220] DEBUG - HttpServer: Listening on port 32400 with queue of 2147483647 connections.
Sep 13, 2018 13:30:49.428 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:49.428 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:49.428 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:49.430 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:49.430 [5220] DEBUG - HttpServer: Listening on port 32401 with queue of 2147483647 connections.
Sep 13, 2018 13:30:49.455 [4412] DEBUG - DVR:Grabber: Cleaning up orphaned grabs.
Sep 13, 2018 13:30:49.456 [5220] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Sep 13, 2018 13:30:49.456 [5220] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 13, 2018 13:30:49.457 [5220] DEBUG - Relay: read 12 cached entries from hosts file
Sep 13, 2018 13:30:49.456 [3544] DEBUG - Relay: read 12 cached entries from hosts file
Sep 13, 2018 13:30:49.457 [3544] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:49.457 [5220] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/b359ff107ee6d756f87074f03ee0bb4f94037e68/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 13, 2018 13:30:49.458 [5220] DEBUG - MyPlex: updating with 46 access tokens
Sep 13, 2018 13:30:49.458 [4412] DEBUG - DVR:Grabber: Cleaned up 0 decrepit directories in 0.0 sec.
Sep 13, 2018 13:30:49.458 [9244] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Sep 13, 2018 13:30:49.459 [9244] DEBUG - HTTP requesting GET https://plex.tv/servers/b359ff107ee6d756f87074f03ee0bb4f94037e68/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 13, 2018 13:30:49.459 [10020] DEBUG - File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de" changed: -1 => 1536078504.
Sep 13, 2018 13:30:49.459 [10020] DEBUG - File "C:\Users\Quint\AppData\Local\Plex Media Server\Plug-ins" changed: -1 => 1536600623.
Sep 13, 2018 13:30:49.459 [10020] DEBUG - Scanning for plug-ins in "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de"
Sep 13, 2018 13:30:49.463 [10020] DEBUG - Scanning for plug-ins in "C:\Users\Quint\AppData\Local\Plex Media Server\Plug-ins"
Sep 13, 2018 13:30:49.464 [10020] DEBUG - PluginRepository::setStartState: 1, startingSystem
Sep 13, 2018 13:30:49.464 [10020] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\System.bundle.
Sep 13, 2018 13:30:49.464 [10020] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Sep 13, 2018 13:30:49.465 [10020] DEBUG - Starting file watcher for com.plexapp.system
Sep 13, 2018 13:30:49.466 [10020] VERBOSE - Plugin: setting environment variable: 'PYTHONPATH=C:\Program Files (x86)\Plex\Plex Media Server\DLLs;C:\Program Files (x86)\Plex\Plex Media Server\Exts;C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Framework.bundle\Contents\Resources\Platforms\Shared\Libraries\'
Sep 13, 2018 13:30:49.466 [10020] VERBOSE - Plugin: setting PLEXTOKEN for plugin
Sep 13, 2018 13:30:49.466 [10020] 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-21ab172de\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\System.bundle"
Sep 13, 2018 13:30:49.467 [10020] DEBUG - Spawned plug-in com.plexapp.system with PID 1860
Sep 13, 2018 13:30:49.467 [10020] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes

Sep 13, 2018 13:30:50.280 [3544] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:50.339 [9244] DEBUG - HTTP 200 response from GET https://plex.tv/servers/b359ff107ee6d756f87074f03ee0bb4f94037e68/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 13, 2018 13:30:50.341 [9244] DEBUG - MyPlex: updating with 46 access tokens
Sep 13, 2018 13:30:50.342 [1796] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.098 [1796] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.098 [1796] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.286 [10020] DEBUG - Reading 486 bytes in the body, code is 200
Sep 13, 2018 13:30:51.286 [10020] DEBUG - [com.plexapp.system] Plug-in running on port 53720.
Sep 13, 2018 13:30:51.286 [10020] DEBUG -  * Plug-in handles prefix: /system
Sep 13, 2018 13:30:51.286 [10020] DEBUG -  * Plug-in handles prefix: /player
Sep 13, 2018 13:30:51.286 [10020] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Sep 13, 2018 13:30:51.354 [10020] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Sep 13, 2018 13:30:51.354 [10020] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Sep 13, 2018 13:30:51.354 [10020] DEBUG - Updating the list of agents known by the system.
Sep 13, 2018 13:30:51.354 [10020] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Sep 13, 2018 13:30:51.354 [5220] DEBUG - Image transcode cache directory: "C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder"
Sep 13, 2018 13:30:51.354 [10020] DEBUG - HTTP requesting GET http://127.0.0.1:53720/system/agents
Sep 13, 2018 13:30:51.354 [5220] DEBUG - Transcoder: Cleaning old transcode directories.
Sep 13, 2018 13:30:51.356 [5220] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/b359ff107ee6d756f87074f03ee0bb4f94037e68/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Sep 13, 2018 13:30:51.356 [5220] DEBUG - MyPlex: updating with 46 access tokens
Sep 13, 2018 13:30:51.357 [9244] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe "--directory=C:\Users\Quint\AppData\Local\Plex Media Server\Crash Reports\1.13.5.5332-21ab172de" --version=1.13.5.5332-21ab172de "--platform=windows-i386 (10.0 (Build 17134))" --serverUuid=b359ff107ee6d756f87074f03ee0bb4f94037e68 --userId=michaelquint@live.com --url=https://crashreport.plexapp.com 
Sep 13, 2018 13:30:51.357 [5220] DEBUG - MyPlex: using cached data for request for https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeGeolocation=1
Sep 13, 2018 13:30:51.358 [5220] DEBUG - MyPlex: username is GettinFishy, login is michaelquint@live.com, home is 1, has pin
Sep 13, 2018 13:30:51.359 [9244] DEBUG - Jobs: Starting child process with pid 2408
Sep 13, 2018 13:30:51.359 [5220] DEBUG - PublicAddressManager: Starting.
Sep 13, 2018 13:30:51.359 [5220] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 13, 2018 13:30:51.359 [5828] DEBUG - HTTP requesting GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.359 [5220] DEBUG - NetworkInterface: Notified of network changed (force=0)
Sep 13, 2018 13:30:51.362 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:51.362 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:51.362 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:51.365 [5220] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:51.365 [5220] DEBUG - Network interfaces:
Sep 13, 2018 13:30:51.365 [5220] DEBUG -  * 4 Wi-Fi {1B131EB1-44EC-4568-8B39-0C497E973135} (192.168.1.103) (loopback: 0)
Sep 13, 2018 13:30:51.365 [5220] DEBUG - Creating NetworkServices singleton.
Sep 13, 2018 13:30:51.365 [5220] DEBUG - NetworkService: Creating new service.
Sep 13, 2018 13:30:51.366 [5220] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Sep 13, 2018 13:30:51.366 [5220] DEBUG - NetworkService: Quick dispatch of network change.
Sep 13, 2018 13:30:51.366 [6608] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Sep 13, 2018 13:30:51.366 [6608] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901 (outbound: 0)
Sep 13, 2018 13:30:51.366 [3544] DEBUG - PublicAddressManager: Obtaining public IP.
Sep 13, 2018 13:30:51.366 [6608] DEBUG - NetworkService: Browsing on interface 192.168.1.103 on broadcast address 239.255.255.250 (index: 0)
Sep 13, 2018 13:30:51.367 [3544] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Sep 13, 2018 13:30:51.380 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.1 (http://192.168.1.1:1780/InternetGatewayDevice.xml)
Sep 13, 2018 13:30:51.391 [9244] DEBUG - HTTP requesting GET http://192.168.1.1:1780/InternetGatewayDevice.xml
Sep 13, 2018 13:30:51.402 [9244] DEBUG - HTTP 200 response from GET http://192.168.1.1:1780/InternetGatewayDevice.xml
Sep 13, 2018 13:30:51.407 [10020] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/system/agents
Sep 13, 2018 13:30:51.407 [10020] DEBUG - [com.plexapp.system] HTTP reply status 200, with 9036 bytes of content.
Sep 13, 2018 13:30:51.410 [10020] DEBUG - The system knows about 13 agents.
Sep 13, 2018 13:30:51.411 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\HTbackdrops.bundle.
Sep 13, 2018 13:30:51.411 [2080] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Framework.bundle.
Sep 13, 2018 13:30:51.411 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Fanart-TV.bundle.
Sep 13, 2018 13:30:51.411 [10020] DEBUG - Waiting for 18 plug-ins to finish starting.
Sep 13, 2018 13:30:51.412 [2080] VERBOSE - The plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Framework.bundle is not runnable.
Sep 13, 2018 13:30:51.412 [2244] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
Sep 13, 2018 13:30:51.412 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\LastFM.bundle.
Sep 13, 2018 13:30:51.412 [2080] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\LocalMedia.bundle.
Sep 13, 2018 13:30:51.412 [8816] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.fanarttv] yet.
Sep 13, 2018 13:30:51.413 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\LyricFind.bundle.
Sep 13, 2018 13:30:51.413 [2244] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
Sep 13, 2018 13:30:51.413 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Media-Flags.bundle.
Sep 13, 2018 13:30:51.414 [8816] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lyricfind] yet.
Sep 13, 2018 13:30:51.414 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\MoviePosterDB.bundle.
Sep 13, 2018 13:30:51.414 [2080] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
Sep 13, 2018 13:30:51.414 [2244] VERBOSE - The plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Media-Flags.bundle is not runnable.
Sep 13, 2018 13:30:51.414 [2080] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\OpenSubtitles.bundle.
Sep 13, 2018 13:30:51.414 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\PersonalMedia.bundle.
Sep 13, 2018 13:30:51.415 [8816] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
Sep 13, 2018 13:30:51.415 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\PlexMovie.bundle.
Sep 13, 2018 13:30:51.415 [2080] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.opensubtitles] yet.
Sep 13, 2018 13:30:51.415 [2080] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\PlexMusic.bundle.
Sep 13, 2018 13:30:51.415 [2244] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
Sep 13, 2018 13:30:51.415 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\PlexThemeMusic.bundle.
Sep 13, 2018 13:30:51.416 [8816] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
Sep 13, 2018 13:30:51.416 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Scanners.bundle.
Sep 13, 2018 13:30:51.417 [2080] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexmusic] yet.
Sep 13, 2018 13:30:51.416 [2244] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
Sep 13, 2018 13:30:51.417 [2080] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\TheMovieDB.bundle.
Sep 13, 2018 13:30:51.417 [2244] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\TheTVDB.bundle.
Sep 13, 2018 13:30:51.417 [8816] VERBOSE - The plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Scanners.bundle is not runnable.
Sep 13, 2018 13:30:51.417 [8816] DEBUG - Starting plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\WebClient.bundle.
Sep 13, 2018 13:30:51.418 [2080] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
Sep 13, 2018 13:30:51.418 [2080] DEBUG - Starting plug-in C:\Users\Quint\AppData\Local\Plex Media Server\Plug-ins\Services.bundle.
Sep 13, 2018 13:30:51.418 [2244] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
Sep 13, 2018 13:30:51.418 [8816] VERBOSE - The plug-in C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\WebClient.bundle is not runnable.
Sep 13, 2018 13:30:51.418 [2080] VERBOSE - The plug-in C:\Users\Quint\AppData\Local\Plex Media Server\Plug-ins\Services.bundle is not runnable.
Sep 13, 2018 13:30:51.421 [5176] VERBOSE - AutoTagging: word lists loaded
Sep 13, 2018 13:30:51.429 [10020] DEBUG - Starting scheduled updates, every 86400 seconds
Sep 13, 2018 13:30:51.429 [10020] INFO - LibraryUpdateManager path watching is disabled
Sep 13, 2018 13:30:51.429 [10020] DEBUG - Done waiting for all plug-ins to start.
Sep 13, 2018 13:30:51.429 [10020] DEBUG - PluginRepository::setStartState: 3, complete
Sep 13, 2018 13:30:51.430 [9088] DEBUG - Downloading document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs
Sep 13, 2018 13:30:51.430 [9088] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.430 [9088] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.430 [9088] DEBUG - Translator: Found locale ar
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale cs_CZ
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale da
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale de
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale en
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale es
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale et_EE
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale fr
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale he
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale hr_HR
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale hu_HU
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale it
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale ja_JP
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale ko
Sep 13, 2018 13:30:51.431 [9088] DEBUG - Translator: Found locale lt
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale nl
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale nl_BE
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale no
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale pt_BR
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale ro
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale ru
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale sr
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale sv
Sep 13, 2018 13:30:51.432 [9088] DEBUG - Translator: Found locale zh_CN
Sep 13, 2018 13:30:51.443 [9088] DEBUG - Starting file watcher for com.plexapp.agents.imdb
Sep 13, 2018 13:30:51.443 [9088] VERBOSE - Plugin: setting environment variable: 'PYTHONPATH=C:\Program Files (x86)\Plex\Plex Media Server\DLLs;C:\Program Files (x86)\Plex\Plex Media Server\Exts;C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\Framework.bundle\Contents\Resources\Platforms\Shared\Libraries\'
Sep 13, 2018 13:30:51.443 [9088] VERBOSE - Plugin: setting PLEXTOKEN for plugin
Sep 13, 2018 13:30:51.444 [9088] 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-21ab172de\Framework.bundle\Contents\Resources\Versions\2\Python\bootstrap.py" "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-21ab172de\PlexMovie.bundle"
Sep 13, 2018 13:30:51.445 [9088] DEBUG - Spawned plug-in com.plexapp.agents.imdb with PID 1732
Sep 13, 2018 13:30:51.445 [9088] DEBUG - [com.plexapp.agents.imdb] Sending command: GET /:/prefixes

Sep 13, 2018 13:30:51.503 [5220] DEBUG - Gracenote Version 3.07.7.3686 (build: 2015-07-05 11:53-0700)
Sep 13, 2018 13:30:51.504 [5220] DEBUG - Gracenote: Using SQLite 3.13.0
Sep 13, 2018 13:30:51.504 [3952] VERBOSE - JobManager: child process with handle 0x6d8 exited
Sep 13, 2018 13:30:51.504 [3952] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\CrashUploader.exe' exit code for process 2408 is 0 (success)
Sep 13, 2018 13:30:51.505 [6648] DEBUG - Plex Dlna Server.exe starting.
Sep 13, 2018 13:30:51.505 [5220] DEBUG - Starting HTTP server.
Sep 13, 2018 13:30:51.505 [7504] DEBUG - Plex Tuner Service.exe starting.
Sep 13, 2018 13:30:51.505 [5220] DEBUG - Running server...
Sep 13, 2018 13:30:51.505 [6648] DEBUG - Job running: C:\Program Files (x86)\Plex\Plex Media Server\Plex Dlna Server.exe 
Sep 13, 2018 13:30:51.505 [5220] DEBUG - Waiting for server condition to be signaled.
Sep 13, 2018 13:30:51.505 [8920] DEBUG - HttpServer: Set up a thread pool with 2 threads.
Sep 13, 2018 13:30:51.506 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.506 [8920] DEBUG - Running database fix-ups.
Sep 13, 2018 13:30:51.506 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.507 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.507 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.507 [9380] DEBUG - Request: [127.0.0.1:53713 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (5 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.507 [6648] DEBUG - Jobs: Starting child process with pid 7500
Sep 13, 2018 13:30:51.507 [8920] DEBUG - Database Fixups: Destroyed 0 transient items.
Sep 13, 2018 13:30:51.507 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.508 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.507 [7504] 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.5.5332-21ab172de 32600 /waitmutex 
Sep 13, 2018 13:30:51.508 [9380] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.508 [9380] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.508 [10232] DEBUG - Request: [127.0.0.1:53714 (Loopback)] GET / (5 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.508 [9380] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.508 [10232] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.508 [9380] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.508 [10232] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.508 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.509 [9380] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.509 [10232] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.509 [9376] DEBUG - Request: [127.0.0.1:53718 (Loopback)] GET / (5 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.509 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.509 [9376] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.509 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.509 [10232] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.509 [7504] DEBUG - Jobs: Starting child process with pid 8328
Sep 13, 2018 13:30:51.509 [9376] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.510 [9376] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.510 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.510 [9376] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.510 [9796] DEBUG - Request: [127.0.0.1:53719 (Loopback)] GET /servers (5 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.510 [9380] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:51.510 [9796] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.510 [9796] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.510 [9796] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.511 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.511 [9796] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.511 [9380] DEBUG - HTTP requesting GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:51.511 [9796] VERBOSE - It took 0.0 sec to serialize a list with 1 elements.
Sep 13, 2018 13:30:51.512 [10232] VERBOSE - It took 0.0 sec to serialize a list with 21 elements.
Sep 13, 2018 13:30:51.512 [9376] VERBOSE - It took 0.0 sec to serialize a list with 21 elements.
Sep 13, 2018 13:30:51.512 [3468] DEBUG - Completed: [127.0.0.1:53719] 200 GET /servers (5 live) GZIP 2ms 501 bytes
Sep 13, 2018 13:30:51.512 [8920] DEBUG - Running database fix-ups completed in 0.0 seconds.
Sep 13, 2018 13:30:51.512 [8300] DEBUG - Completed: [127.0.0.1:53718] 200 GET / (5 live) GZIP 4ms 1197 bytes
Sep 13, 2018 13:30:51.513 [3468] DEBUG - Completed: [127.0.0.1:53714] 200 GET / (5 live) GZIP 5ms 1197 bytes
Sep 13, 2018 13:30:51.513 [8920] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.525 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.525 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.525 [9796] DEBUG - Request: [127.0.0.1:53730 (Loopback)] GET / (6 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.526 [9796] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.526 [9796] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.526 [9796] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.526 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.526 [9796] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.527 [9796] VERBOSE - It took 0.0 sec to serialize a list with 21 elements.
Sep 13, 2018 13:30:51.527 [3468] DEBUG - Completed: [127.0.0.1:53730] 200 GET / (6 live) GZIP 1ms 1197 bytes
Sep 13, 2018 13:30:51.528 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.529 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.529 [9796] DEBUG - Request: [127.0.0.1:53731 (Loopback)] GET /library/sections (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.529 [9796] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.529 [9796] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.529 [9796] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.529 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.529 [9796] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.531 [9796] VERBOSE - It took 0.0 sec to serialize a list with 4 elements.
Sep 13, 2018 13:30:51.531 [3468] DEBUG - Completed: [127.0.0.1:53731] 200 GET /library/sections (7 live) GZIP 2ms 1006 bytes
Sep 13, 2018 13:30:51.539 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.539 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.540 [10232] DEBUG - Request: [127.0.0.1:53732 (Loopback)] GET /channels/all (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.540 [10232] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.540 [10232] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.540 [10232] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.540 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.540 [10232] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.541 [10232] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
Sep 13, 2018 13:30:51.541 [3468] DEBUG - Completed: [127.0.0.1:53732] 200 GET /channels/all (7 live) GZIP 1ms 387 bytes
Sep 13, 2018 13:30:51.552 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.552 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.552 [9376] DEBUG - Request: [127.0.0.1:53733 (Loopback)] GET /library/sections (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.553 [9376] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.553 [9376] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.553 [9376] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.553 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.553 [9376] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.554 [9376] VERBOSE - It took 0.0 sec to serialize a list with 4 elements.
Sep 13, 2018 13:30:51.555 [3468] DEBUG - Completed: [127.0.0.1:53733] 200 GET /library/sections (7 live) GZIP 2ms 1006 bytes
Sep 13, 2018 13:30:51.560 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:51.560 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:51.561 [10232] DEBUG - Request: [127.0.0.1:53734 (Loopback)] GET /channels/all (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:51.561 [10232] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:51.561 [10232] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:51.561 [10232] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:51.561 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.561 [10232] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:51.562 [10232] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
Sep 13, 2018 13:30:51.562 [3468] DEBUG - Completed: [127.0.0.1:53734] 200 GET /channels/all (7 live) GZIP 1ms 387 bytes
Sep 13, 2018 13:30:51.591 [9380] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:51.591 [9380] DEBUG - [com.plexapp.system] HTTP reply status 200, with 60036 bytes of content.
Sep 13, 2018 13:30:51.594 [3468] DEBUG - Completed: [127.0.0.1:53713] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (7 live) GZIP 87ms 19471 bytes
Sep 13, 2018 13:30:51.716 [3544] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Sep 13, 2018 13:30:51.716 [3544] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 172.58.175.10
Sep 13, 2018 13:30:51.833 [1796] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:51.834 [1796] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.123 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.123 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.124 [9796] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260 (7 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * format => png
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * height => 260
Sep 13, 2018 13:30:52.124 [9796] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:52.125 [9796] VERBOSE -  * width => 260
Sep 13, 2018 13:30:52.125 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.125 [9796] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.125 [9796] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.125 [9796] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.125 [9796] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.126 [9796] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\a1\a145abbb1d17c835232a38a0929328259b7df774.png is 71936.
Sep 13, 2018 13:30:52.126 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260 (7 live) 2ms 71936 bytes (pipelined: 1)
Sep 13, 2018 13:30:52.126 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.127 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.177 [5828] DEBUG - HTTP 200 response from GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.179 [5828] DEBUG - MyPlex: username is GettinFishy, login is michaelquint@live.com, home is 1, has pin
Sep 13, 2018 13:30:52.179 [5828] DEBUG - Sync: onMyPlexSignIn
Sep 13, 2018 13:30:52.180 [5828] WARN - Sync: Couldn't get sync lists without subscription.
Sep 13, 2018 13:30:52.180 [5828] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.190 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.190 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.191 [9376] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120 (6 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * format => png
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * height => 120
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * width => 120
Sep 13, 2018 13:30:52.191 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.192 [9376] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.192 [9376] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.192 [9376] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.192 [9376] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.192 [9376] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\d2\d20a8c1601a1a8facc7b25cb2f3735827a5ba0cc.png is 20177.
Sep 13, 2018 13:30:52.193 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120 (6 live) 1ms 20177 bytes (pipelined: 2)
Sep 13, 2018 13:30:52.193 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.193 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.203 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.203 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.204 [9796] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48 (6 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * format => png
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * height => 48
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * width => 48
Sep 13, 2018 13:30:52.204 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.204 [9796] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.205 [9796] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.205 [9796] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.205 [9796] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.205 [9796] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\ab\ab96e8964b94322a84d0f7fd2490bb16259396ac.png is 4682.
Sep 13, 2018 13:30:52.205 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48 (6 live) 1ms 4682 bytes (pipelined: 3)
Sep 13, 2018 13:30:52.206 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.206 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.213 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.213 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.213 [9796] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260 (6 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * height => 260
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * width => 260
Sep 13, 2018 13:30:52.214 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.214 [9796] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.215 [9796] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.215 [9796] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.215 [9796] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.215 [9796] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\f9\f97ac7d1835a4f3a37b19ab76cfeea8e4e4fe733.jpg is 7889.
Sep 13, 2018 13:30:52.215 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260 (6 live) 1ms 7889 bytes (pipelined: 4)
Sep 13, 2018 13:30:52.215 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.215 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.223 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.223 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.223 [10232] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120 (5 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:52.223 [10232] VERBOSE -  * height => 120
Sep 13, 2018 13:30:52.224 [10232] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:52.224 [10232] VERBOSE -  * width => 120
Sep 13, 2018 13:30:52.224 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.224 [10232] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.224 [10232] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.224 [10232] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.224 [10232] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.224 [10232] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\dd\dd48254469847a37e81af334403590fb6b815270.jpg is 2732.
Sep 13, 2018 13:30:52.225 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120 (5 live) 1ms 2732 bytes (pipelined: 5)
Sep 13, 2018 13:30:52.225 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.225 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.270 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.270 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.271 [10232] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48 (5 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * height => 48
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * width => 48
Sep 13, 2018 13:30:52.271 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.272 [10232] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:52.272 [10232] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.272 [10232] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:52.272 [10232] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:52.272 [10232] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\c8\c8901481ac00cfedfc4a23133e930a37c2df8459.jpg is 946.
Sep 13, 2018 13:30:52.273 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48 (5 live) 2ms 946 bytes (pipelined: 6)
Sep 13, 2018 13:30:52.273 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.273 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:52.283 [8920] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.286 [8920] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.324 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.324 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.325 [9380] DEBUG - Request: [127.0.0.1:53784 (Loopback)] GET /system/messaging/clear_events/com.plexapp.agents.imdb (6 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.325 [9380] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:52.325 [9380] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:52.325 [9380] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:52.325 [9380] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.325 [9380] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:52.326 [9380] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/messaging/clear_events/com.plexapp.agents.imdb
Sep 13, 2018 13:30:52.326 [9380] DEBUG - HTTP requesting GET http://127.0.0.1:53720/system/messaging/clear_events/com.plexapp.agents.imdb
Sep 13, 2018 13:30:52.331 [9380] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/system/messaging/clear_events/com.plexapp.agents.imdb
Sep 13, 2018 13:30:52.331 [9380] DEBUG - [com.plexapp.system] HTTP reply status 200, with 0 bytes of content.
Sep 13, 2018 13:30:52.331 [3468] DEBUG - Completed: [127.0.0.1:53784] 200 GET /system/messaging/clear_events/com.plexapp.agents.imdb (6 live) GZIP 6ms 330 bytes
Sep 13, 2018 13:30:52.429 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.429 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.429 [9376] DEBUG - Request: [127.0.0.1:53790 (Loopback)] GET /:/plugins/com.plexapp.system/resourceHashes (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.430 [9376] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:52.430 [9376] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:52.430 [9376] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:52.430 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.430 [9376] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:52.430 [9376] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/resourceHashes
Sep 13, 2018 13:30:52.430 [9376] DEBUG - HTTP requesting GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/resourceHashes
Sep 13, 2018 13:30:52.556 [9376] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/resourceHashes
Sep 13, 2018 13:30:52.556 [9376] DEBUG - [com.plexapp.system] HTTP reply status 200, with 13276 bytes of content.
Sep 13, 2018 13:30:52.557 [3468] DEBUG - Completed: [127.0.0.1:53790] 200 GET /:/plugins/com.plexapp.system/resourceHashes (7 live) GZIP 127ms 3498 bytes
Sep 13, 2018 13:30:52.572 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.572 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.572 [9796] DEBUG - Request: [127.0.0.1:53793 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (9 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.572 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:52.572 [9796] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:52.572 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:52.573 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.573 [9796] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:52.573 [9796] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:52.573 [9376] DEBUG - Request: [127.0.0.1:53794 (Loopback)] GET / (8 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:52.573 [9796] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:52.573 [9376] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:52.573 [9796] VERBOSE -  * Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK
Sep 13, 2018 13:30:52.573 [9376] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:52.573 [9376] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:52.574 [9376] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.574 [9376] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:52.574 [9796] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:52.574 [9796] DEBUG - HTTP requesting GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:52.574 [1796] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.595 [9796] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Sep 13, 2018 13:30:52.596 [9796] DEBUG - [com.plexapp.system] HTTP reply status 200, with 60036 bytes of content.
Sep 13, 2018 13:30:52.598 [8300] DEBUG - Completed: [127.0.0.1:53793] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (8 live) GZIP 26ms 19471 bytes
Sep 13, 2018 13:30:52.690 [1796] DEBUG - Gracenote: Loading 29 locales in 0.1 seconds.
Sep 13, 2018 13:30:52.892 [5828] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:52.903 [5828] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.045 [8920] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.047 [3952] DEBUG - DVR: Starting up.
Sep 13, 2018 13:30:53.047 [8920] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.051 [3952] DEBUG - EPG[onconnect]: Starting.
Sep 13, 2018 13:30:53.051 [3952] DEBUG - Opening 10 database sessions to library (tv.plex.providers.epg.onconnect:11), SQLite 3.13.0, threadsafe=1
Sep 13, 2018 13:30:53.052 [3952] INFO - SQLITE3:0x5404055c, 283, recovered 129 frames from WAL file C:\Users\Quint\AppData\Local\Plex Media Server\Plug-in Support\Databases\tv.plex.providers.epg.onconnect-8893d80f-5940-4803-9a26-9b39252e1971.db-wal
Sep 13, 2018 13:30:53.071 [3952] DEBUG - Running migrations.
Sep 13, 2018 13:30:53.071 [3952] DEBUG - Media Provider: Registering provider tv.plex.providers.epg.onconnect:11
Sep 13, 2018 13:30:53.072 [3952] DEBUG - EPG[onconnect]: Not enough time has passed, not refreshing program guide.
Sep 13, 2018 13:30:53.072 [9244] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.072 [3952] DEBUG - Activity: registered new activity 82244822-b7d4-469c-8c06-94ca66dd527b - Processing subscriptions
Sep 13, 2018 13:30:53.073 [4412] DEBUG - EPG[onconnect]: Purging 4 airings which completed in the past.
Sep 13, 2018 13:30:53.074 [4412] DEBUG - Destroying metadata item 96 (The Internet; The Plan)
Sep 13, 2018 13:30:53.085 [1796] DEBUG - EPG[onconnect]: Next thing to start/end is at 2018-09-13 17:55:00 (in 1448 seconds)
Sep 13, 2018 13:30:53.125 [4412] VERBOSE - BPQ: onLibrarySectionChanged for library section 2: ItemsDeleted
Sep 13, 2018 13:30:53.161 [4412] DEBUG - Destroying metadata item 171 (New Babysitter; Dinosaur Egg)
Sep 13, 2018 13:30:53.198 [4412] VERBOSE - BPQ: onLibrarySectionChanged for library section 2: ItemsDeleted
Sep 13, 2018 13:30:53.198 [4412] VERBOSE - BPQ: onLibraryChanged callback already scheduled at 1536859853
Sep 13, 2018 13:30:53.223 [4412] DEBUG - Destroying metadata item 604 (Spellbound)
Sep 13, 2018 13:30:53.224 [4412] VERBOSE - BPQ: onLibrarySectionChanged for library section 2: ItemsDeleted
Sep 13, 2018 13:30:53.224 [4412] VERBOSE - BPQ: onLibraryChanged callback already scheduled at 1536859853
Sep 13, 2018 13:30:53.252 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.252 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.252 [9380] DEBUG - Request: [127.0.0.1:53811 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_ (8 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * Connection => close
Sep 13, 2018 13:30:53.252 [9380] VERBOSE -  * Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK
Sep 13, 2018 13:30:53.253 [9380] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Sep 13, 2018 13:30:53.253 [9380] DEBUG - HTTP requesting GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Sep 13, 2018 13:30:53.268 [9380] DEBUG - HTTP 200 response from GET http://127.0.0.1:53720/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Sep 13, 2018 13:30:53.268 [9380] DEBUG - [com.plexapp.system] HTTP reply status 200, with 16 bytes of content.
Sep 13, 2018 13:30:53.268 [3468] DEBUG - Completed: [127.0.0.1:53811] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_ (8 live) GZIP 16ms 465 bytes
Sep 13, 2018 13:30:53.286 [9088] DEBUG - Reading 148 bytes in the body, code is 200
Sep 13, 2018 13:30:53.286 [9088] DEBUG - [com.plexapp.agents.imdb] Plug-in running on port 53813.
Sep 13, 2018 13:30:53.286 [9088] DEBUG - Read configuration for [com.plexapp.agents.imdb], had 0 prefixes
Sep 13, 2018 13:30:53.304 [9088] DEBUG - [com.plexapp.agents.imdb] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.imdb/prefs
Sep 13, 2018 13:30:53.304 [9088] DEBUG - HTTP requesting GET http://127.0.0.1:53813/:/plugins/com.plexapp.agents.imdb/prefs
Sep 13, 2018 13:30:53.340 [9088] DEBUG - HTTP 200 response from GET http://127.0.0.1:53813/:/plugins/com.plexapp.agents.imdb/prefs
Sep 13, 2018 13:30:53.340 [9088] DEBUG - [com.plexapp.agents.imdb] HTTP reply status 200, with 2224 bytes of content.
Sep 13, 2018 13:30:53.340 [9088] DEBUG - Caching document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs as 76d4525ecf0523aea9370bba2bf0d97f74e371aa
Sep 13, 2018 13:30:53.340 [9088] DEBUG - IVA: Downloading trailer lists.
Sep 13, 2018 13:30:53.613 [9088] DEBUG - IVA: Downloaded 29 trailers for source 1.
Sep 13, 2018 13:30:53.658 [5828] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.661 [5828] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.707 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.707 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.707 [10232] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260 (8 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * format => png
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * height => 260
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * width => 260
Sep 13, 2018 13:30:53.708 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.709 [10232] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.709 [10232] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.709 [10232] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.709 [10232] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.710 [10232] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\a1\a145abbb1d17c835232a38a0929328259b7df774.png is 71936.
Sep 13, 2018 13:30:53.710 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260 (8 live) 3ms 71936 bytes (pipelined: 7)
Sep 13, 2018 13:30:53.710 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.711 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.745 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.746 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.746 [9796] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120 (7 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.746 [9796] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.746 [9796] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * format => png
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * height => 120
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * width => 120
Sep 13, 2018 13:30:53.747 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.748 [9796] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.748 [9796] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.748 [9796] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.749 [9796] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.749 [9796] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\d2\d20a8c1601a1a8facc7b25cb2f3735827a5ba0cc.png is 20177.
Sep 13, 2018 13:30:53.750 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120 (7 live) 4ms 20177 bytes (pipelined: 8)
Sep 13, 2018 13:30:53.750 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.750 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.760 [8920] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.762 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.762 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.762 [9796] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48 (7 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.762 [9796] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * format => png
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * height => 48
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.png
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * width => 48
Sep 13, 2018 13:30:53.763 [9796] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.764 [9796] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.png] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.764 [9796] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.764 [9796] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.764 [9796] VERBOSE - [IDLE] * http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.765 [9796] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\ab\ab96e8964b94322a84d0f7fd2490bb16259396ac.png is 4682.
Sep 13, 2018 13:30:53.765 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48 (7 live) 3ms 4682 bytes (pipelined: 9)
Sep 13, 2018 13:30:53.765 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?format=png&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Epng&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.765 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.772 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.772 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.773 [10232] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260 (7 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:53.773 [10232] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:53.774 [10232] VERBOSE -  * height => 260
Sep 13, 2018 13:30:53.774 [10232] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:53.774 [10232] VERBOSE -  * width => 260
Sep 13, 2018 13:30:53.774 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.774 [10232] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.775 [10232] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.775 [10232] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.775 [10232] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.775 [10232] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\f9\f97ac7d1835a4f3a37b19ab76cfeea8e4e4fe733.jpg is 7889.
Sep 13, 2018 13:30:53.776 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260 (7 live) 2ms 7889 bytes (pipelined: 10)
Sep 13, 2018 13:30:53.776 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=260&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=260&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.776 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.784 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.784 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.784 [9380] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120 (6 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.784 [9380] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.784 [9380] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.784 [9380] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * height => 120
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * width => 120
Sep 13, 2018 13:30:53.785 [9380] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.786 [9380] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.786 [9380] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.786 [9380] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.786 [9380] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.786 [9380] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\dd\dd48254469847a37e81af334403590fb6b815270.jpg is 2732.
Sep 13, 2018 13:30:53.787 [3468] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120 (6 live) 2ms 2732 bytes (pipelined: 11)
Sep 13, 2018 13:30:53.787 [3468] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=120&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=120&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.787 [3468] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.799 [3468] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:30:53.799 [3468] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:30:53.799 [10232] DEBUG - Request: [127.0.0.1:53778 (Loopback)] GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48 (6 live) Signed-in Token (GettinFishy)
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * Connection => Keep-Alive
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * User-Agent => User-Agent: Microsoft-DLNA DLNADOC/1.50
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * Host => 192.168.1.103:32469
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * chromaSubsampling => 4:2:2
Sep 13, 2018 13:30:53.799 [10232] VERBOSE -  * format => jpg
Sep 13, 2018 13:30:53.800 [10232] VERBOSE -  * height => 48
Sep 13, 2018 13:30:53.800 [10232] VERBOSE -  * url => http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg
Sep 13, 2018 13:30:53.800 [10232] VERBOSE -  * width => 48
Sep 13, 2018 13:30:53.800 [10232] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.800 [10232] DEBUG - Photo transcoder: Request for url [http://127.0.0.1:32400/:/resources/dlna-icon-260.jpg] (is local: 1 upscaled: 0)
Sep 13, 2018 13:30:53.800 [10232] VERBOSE - [IDLE] Adding (0->1) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.800 [10232] VERBOSE - [IDLE] Server is now active
Sep 13, 2018 13:30:53.801 [10232] VERBOSE - [IDLE] * http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx - 1 active item(s)
Sep 13, 2018 13:30:53.801 [10232] DEBUG - Content-Length of C:\Users\Quint\AppData\Local\Plex Media Server\Cache\PhotoTranscoder\c8\c8901481ac00cfedfc4a23133e930a37c2df8459.jpg is 946.
Sep 13, 2018 13:30:53.801 [8300] DEBUG - Completed: [127.0.0.1:53778] 200 GET /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48 (6 live) 2ms 946 bytes (pipelined: 12)
Sep 13, 2018 13:30:53.801 [8300] VERBOSE - [IDLE] Removing (1->0) work item http_download - /photo/:/transcode?chromaSubsampling=4%3A2%3A2&format=jpg&height=48&url=http%3A%2F%2F127%2E0%2E0%2E1%3A32400%2F%3A%2Fresources%2Fdlna-icon-260%2Ejpg&width=48&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:53.801 [8300] VERBOSE - [IDLE] Server is now idle
Sep 13, 2018 13:30:53.838 [9088] DEBUG - IVA: Downloaded 52 trailers for source 2.
Sep 13, 2018 13:30:53.853 [9244] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:54.425 [5828] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:54.427 [5828] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:30:54.427 [5828] DEBUG - EventSource: Resolving 45.79.197.109 port 443s
Sep 13, 2018 13:30:54.428 [8300] DEBUG - EventSource: Resolved 45.79.197.109 to 45.79.197.109
Sep 13, 2018 13:30:54.428 [1796] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:54.656 [8300] DEBUG - EventSource: Connected in 138 ms.
Sep 13, 2018 13:30:54.656 [3468] DEBUG - EventSource: Wrote data, reading reply.
Sep 13, 2018 13:30:54.735 [3544] DEBUG - NAT: UPnP, found device <http://192.168.1.1:1780/InternetGatewayDevice.xml> with private address <192.168.1.103>
Sep 13, 2018 13:30:54.751 [3544] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:1780/InternetGatewayDevice.xml> with private address <192.168.1.103>.
Sep 13, 2018 13:30:54.751 [3544] DEBUG - NAT: UPnP, public address is 192.168.8.103
Sep 13, 2018 13:30:54.751 [3544] DEBUG - PublicAddressManager: got WAN IP 192.168.8.103 from router
Sep 13, 2018 13:30:54.751 [3544] WARN - PublicAddressManager: WAN IP is a private IP address
Sep 13, 2018 13:30:54.751 [8920] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 13, 2018 13:30:54.751 [9376] VERBOSE - It took 0.0 sec to serialize a list with 21 elements.
Sep 13, 2018 13:30:54.751 [4412] DEBUG - HTTP requesting GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:54.751 [3468] DEBUG - Completed: [127.0.0.1:53794] 200 GET / (4 live) GZIP 2186ms 1197 bytes
Sep 13, 2018 13:30:54.751 [5828] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:54.751 [5828] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:54.751 [5828] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:54.751 [6016] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:54.751 [6016] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:54.751 [6016] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:54.751 [5828] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:54.751 [5828] DEBUG - MyPlex: Updating device connections (from timer: 0)
Sep 13, 2018 13:30:54.751 [6016] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:54.751 [5828] DEBUG - HTTP requesting PUT https://plex.tv/devices/b359ff107ee6d756f87074f03ee0bb4f94037e68?Connection[][uri]=http://192.168.1.103:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:54.751 [6016] VERBOSE - It took 0.0 sec to serialize a list with 5 elements.
Sep 13, 2018 13:30:54.751 [6016] DEBUG - MyPlex: Sending Server Info to myPlex (user=michaelquint@live.com, ip=, port=32400)
Sep 13, 2018 13:30:54.751 [6016] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=4e8b677d-4016-4306-839e-9ae0e31baa80
Sep 13, 2018 13:30:55.127 [3468] DEBUG - EventSource: Read HTTP reply header.
Sep 13, 2018 13:30:55.127 [3468] DEBUG - MyPlex: We appear to have regained Internet connectivity.
Sep 13, 2018 13:30:55.127 [3468] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 13, 2018 13:30:55.127 [3468] DEBUG - EventSource: Successfully connected to 45.79.197.109.
Sep 13, 2018 13:30:55.190 [1796] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:55.190 [1796] DEBUG - PublicAddressManager: Obtaining public IP.
Sep 13, 2018 13:30:55.190 [1796] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Sep 13, 2018 13:30:55.533 [5828] DEBUG - HTTP 200 response from PUT https://plex.tv/devices/b359ff107ee6d756f87074f03ee0bb4f94037e68?Connection[][uri]=http://192.168.1.103:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:55.533 [1796] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Sep 13, 2018 13:30:55.533 [1796] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 172.58.175.10
Sep 13, 2018 13:30:55.533 [5828] DEBUG - CERT: Certificate will not expire soon.
Sep 13, 2018 13:30:55.580 [6016] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=4e8b677d-4016-4306-839e-9ae0e31baa80
Sep 13, 2018 13:30:55.580 [6016] DEBUG - MyPlex: Published Mapping State response was 201
Sep 13, 2018 13:30:55.580 [6016] DEBUG - MyPlex: Got response for b359ff107ee6d756f87074f03ee0bb4f94037e68 ~ registered :0
Sep 13, 2018 13:30:55.768 [4412] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:30:58.542 [1796] DEBUG - NAT: UPnP, found device <http://192.168.1.1:1780/InternetGatewayDevice.xml> with private address <192.168.1.103>
Sep 13, 2018 13:30:58.557 [1796] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:1780/InternetGatewayDevice.xml> with private address <192.168.1.103>.
Sep 13, 2018 13:30:58.557 [1796] DEBUG - NAT: UPnP, public address is 192.168.8.103
Sep 13, 2018 13:30:58.557 [1796] DEBUG - PublicAddressManager: got WAN IP 192.168.8.103 from router
Sep 13, 2018 13:30:58.557 [1796] WARN - PublicAddressManager: WAN IP is a private IP address
Sep 13, 2018 13:30:58.573 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:58.573 [1796] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:58.573 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:58.573 [1796] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:58.573 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:58.573 [1796] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:58.573 [1796] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:58.573 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:58.573 [1796] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 13, 2018 13:30:58.573 [3544] VERBOSE - It took 0.0 sec to serialize a list with 5 elements.
Sep 13, 2018 13:30:58.573 [3544] DEBUG - MyPlex: Sending Server Info to myPlex (user=michaelquint@live.com, ip=, port=32400)
Sep 13, 2018 13:30:58.573 [3544] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=8d347139-6a64-45e8-8e6e-81a8cd337301
Sep 13, 2018 13:30:59.387 [3544] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=8d347139-6a64-45e8-8e6e-81a8cd337301
Sep 13, 2018 13:30:59.387 [3544] DEBUG - MyPlex: Published Mapping State response was 201
Sep 13, 2018 13:30:59.387 [3544] DEBUG - MyPlex: Got response for b359ff107ee6d756f87074f03ee0bb4f94037e68 ~ registered :0
Sep 13, 2018 13:30:59.402 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Ethernet' (fe80::f9c9:259b:5d2f:491e%17,169.254.73.30) because it has no gateway
Sep 13, 2018 13:30:59.402 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 11' (fe80::c403:6c79:4492:3615%8,169.254.54.21) because it has no gateway
Sep 13, 2018 13:30:59.402 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Local Area Connection* 13' (fe80::3c2a:9586:ef50:c0e7%21,169.254.192.231) because it has no gateway
Sep 13, 2018 13:30:59.402 [3544] VERBOSE - NetworkInterface: ignoring adapter 'Loopback Pseudo-Interface 1' (::1,127.0.0.1) because it has no gateway
Sep 13, 2018 13:30:59.402 [3544] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 13, 2018 13:30:59.434 [5176] DEBUG - HTTP requesting GET https://plex.tv/services/pubsub/servers
Sep 13, 2018 13:30:59.465 [4412] DEBUG - DVR:Device: Discovering and refreshing devices.
Sep 13, 2018 13:30:59.465 [4412] DEBUG - DVR:Grabber: HDHomerun discovered 0 compatible devices.
Sep 13, 2018 13:30:59.465 [4412] DEBUG - DVR:Device: Testing grabber HDHomerun device device://tv.plex.grabbers.hdhomerun/12345678 at http://127.0.0.1:6077
Sep 13, 2018 13:30:59.465 [4412] DEBUG - HTTP requesting GET http://127.0.0.1:6077/discover.json
Sep 13, 2018 13:31:00.157 [5176] DEBUG - HTTP 200 response from GET https://plex.tv/services/pubsub/servers
Sep 13, 2018 13:31:00.157 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.157 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.157 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.157 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.157 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.173 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.173 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.173 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.173 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:00.173 [5176] VERBOSE - EventSource: Creating.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 45.79.197.109 was 155 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 45.79.211.188 was 157 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 172.104.217.190 was 172 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 45.79.11.43 was 185 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 184.105.148.101 was 238 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 178.79.132.174 was 316 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 82.94.168.55 was 320 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 172.104.225.166 was 383 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 139.162.117.249 was 447 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Time to connect to 103.3.62.6 was 617 ms.
Sep 13, 2018 13:31:01.095 [5176] DEBUG - PubSubManager: Updating best ping time for 45.79.197.109 to 155 ms.
Sep 13, 2018 13:31:01.470 [4412] ERROR - Error issuing curl_easy_perform(handle): 7
Sep 13, 2018 13:31:01.470 [4412] WARN - HTTP error requesting GET http://127.0.0.1:6077/discover.json (0, No error) (Failed connect to 127.0.0.1:6077; No error)
Sep 13, 2018 13:31:01.486 [4412] ERROR - DVR:Device: Error refreshing existing device device://tv.plex.grabbers.hdhomerun/12345678, marking as dead.
Sep 13, 2018 13:31:01.486 [4412] DEBUG - DVR:Device: Testing grabber HDHomerun device device://tv.plex.grabbers.hdhomerun/2018-09-7OYW-YEH1A6:5 at http://192.168.1.103:34400
Sep 13, 2018 13:31:01.486 [4412] DEBUG - HTTP requesting GET http://192.168.1.103:34400/discover.json
Sep 13, 2018 13:31:01.499 [4412] DEBUG - HTTP 200 response from GET http://192.168.1.103:34400/discover.json
Sep 13, 2018 13:31:01.499 [4412] DEBUG - HTTP requesting GET http://192.168.1.103:34400/lineup_status.json
Sep 13, 2018 13:31:01.517 [4412] DEBUG - HTTP 200 response from GET http://192.168.1.103:34400/lineup_status.json
Sep 13, 2018 13:31:01.549 [4412] DEBUG - DVR:Device: Device was alive, refreshed device://tv.plex.grabbers.hdhomerun/2018-09-7OYW-YEH1A6:5.
Sep 13, 2018 13:31:01.549 [4412] DEBUG - HTTP requesting POST http://127.0.0.1:32600/devices/discover
Sep 13, 2018 13:31:03.084 [9244] DEBUG - Activity: registered new activity 76355220-bb2d-4e15-b00c-79ba1b1b868d - Processing subscriptions
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: Scheduling subscriptions.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: Initialized 1 schedulers.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: Scheduled all subscriptions in 0 ms.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - Activity: Ended activity 76355220-bb2d-4e15-b00c-79ba1b1b868d.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: There are 0 grabs at the end.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - Activity: Ended activity 82244822-b7d4-469c-8c06-94ca66dd527b.
Sep 13, 2018 13:31:03.084 [9244] DEBUG - DVR:Subscription: Refreshed all content in 2 ms.
Sep 13, 2018 13:31:04.038 [4412] DEBUG - HTTP 200 response from POST http://127.0.0.1:32600/devices/discover
Sep 13, 2018 13:31:05.433 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.103 (http://192.168.1.103:32469/DeviceDescription.xml)
Sep 13, 2018 13:31:05.433 [7660] DEBUG - HTTP requesting GET http://192.168.1.103:32469/DeviceDescription.xml
Sep 13, 2018 13:31:05.433 [7660] DEBUG - HTTP 200 response from GET http://192.168.1.103:32469/DeviceDescription.xml
Sep 13, 2018 13:31:05.683 [8300] DEBUG - EventSource: Got event [data] '<Message address="172.58.175.10" port="32400" asyncIdentifier="4e8b677d-4016-4306-839e-9ae0e31baa80" connectivity="0" command="notifyConnectivity"/>'
Sep 13, 2018 13:31:05.683 [8300] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (4e8b677d-4016-4306-839e-9ae0e31baa80, expected 8d347139-6a64-45e8-8e6e-81a8cd337301)
Sep 13, 2018 13:31:09.511 [3468] DEBUG - EventSource: Got event [data] '<Message address="172.58.175.10" port="32400" asyncIdentifier="8d347139-6a64-45e8-8e6e-81a8cd337301" connectivity="0" command="notifyConnectivity"/>'
Sep 13, 2018 13:31:09.511 [3468] ERROR - MyPlex: mapping failed due to potential double NAT configuration
Sep 13, 2018 13:31:09.511 [3468] DEBUG - PubSub: Got notified of reachability: 0 for 172.58.175.10:32400
Sep 13, 2018 13:31:13.814 [3468] VERBOSE - We didn't receive any data from 127.0.0.1:53778 in time, dropping connection.
Sep 13, 2018 13:31:53.138 [4060] DEBUG - BPQ: onConsiderProcessing: Starting (true)
Sep 13, 2018 13:31:53.138 [4060] DEBUG - BPQ: garbageCollect - sync - forced - 1
Sep 13, 2018 13:31:53.138 [4060] DEBUG - Sync: skipping GC because sync lists haven't been downloaded yet
Sep 13, 2018 13:31:53.138 [4060] DEBUG - BPQ: garbageCollect - version - forced - -1
Sep 13, 2018 13:31:53.138 [4060] DEBUG - Versions: garbage collecting
Sep 13, 2018 13:31:53.138 [4060] DEBUG - Versions: garbage collected in 0.0 seconds
Sep 13, 2018 13:32:48.642 [7764] DEBUG - BPQ: [Starting] -> [Processing]
Sep 13, 2018 13:32:48.642 [7764] DEBUG - BPQ: generating queue items from 0 generator(s)
Sep 13, 2018 13:32:48.642 [7764] DEBUG - BPQ: generated 0 item(s) for queue
Sep 13, 2018 13:32:48.642 [7764] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Sep 13, 2018 13:32:48.642 [7764] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Sep 13, 2018 13:32:48.689 [7764] DEBUG - BPQ: [Processing] -> [Idle]
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:32:51.256 [5784] DEBUG - Request: [127.0.0.1:53956 (Loopback)] GET /servers (3 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Connection => close
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:32:51.256 [5784] VERBOSE - It took 0.0 sec to serialize a list with 1 elements.
Sep 13, 2018 13:32:51.256 [3468] DEBUG - Completed: [127.0.0.1:53956] 200 GET /servers (3 live) GZIP 1ms 501 bytes
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:32:51.256 [5784] DEBUG - Request: [127.0.0.1:53957 (Loopback)] GET /library/sections (4 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Connection => close
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:32:51.256 [5784] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:32:51.256 [5784] VERBOSE - It took 0.0 sec to serialize a list with 4 elements.
Sep 13, 2018 13:32:51.256 [3468] DEBUG - Completed: [127.0.0.1:53957] 200 GET /library/sections (4 live) GZIP 1ms 1007 bytes
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:32:51.256 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:32:51.256 [2028] DEBUG - Request: [127.0.0.1:53958 (Loopback)] GET /channels/all (5 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:32:51.256 [2028] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:32:51.256 [2028] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:32:51.256 [2028] VERBOSE -  * Connection => close
Sep 13, 2018 13:32:51.256 [2028] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:32:51.256 [2028] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:32:51.256 [2028] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
Sep 13, 2018 13:32:51.256 [3468] DEBUG - Completed: [127.0.0.1:53958] 200 GET /channels/all (5 live) GZIP 1ms 387 bytes
Sep 13, 2018 13:32:51.272 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:32:51.272 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:32:51.272 [5784] DEBUG - Request: [127.0.0.1:53959 (Loopback)] GET /library/sections (6 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:32:51.272 [5784] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:32:51.272 [5784] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:32:51.272 [5784] VERBOSE -  * Connection => close
Sep 13, 2018 13:32:51.272 [5784] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:32:51.272 [5784] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:32:51.272 [5784] VERBOSE - It took 0.0 sec to serialize a list with 4 elements.
Sep 13, 2018 13:32:51.272 [3468] DEBUG - Completed: [127.0.0.1:53959] 200 GET /library/sections (6 live) GZIP 1ms 1007 bytes
Sep 13, 2018 13:32:51.272 [8300] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Sep 13, 2018 13:32:51.272 [8300] VERBOSE - Auth: Came in with the master token, authorization succeeded.
Sep 13, 2018 13:32:51.272 [2028] DEBUG - Request: [127.0.0.1:53960 (Loopback)] GET /channels/all (7 live) GZIP Signed-in Token (GettinFishy)
Sep 13, 2018 13:32:51.272 [2028] VERBOSE -  * Host => 127.0.0.1:32400
Sep 13, 2018 13:32:51.272 [2028] VERBOSE -  * User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9
Sep 13, 2018 13:32:51.272 [2028] VERBOSE -  * Connection => close
Sep 13, 2018 13:32:51.272 [2028] VERBOSE -  * X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
Sep 13, 2018 13:32:51.272 [2028] VERBOSE -  * Accept-Encoding => gzip
Sep 13, 2018 13:32:51.272 [2028] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
Sep 13, 2018 13:32:51.272 [3468] DEBUG - Completed: [127.0.0.1:53960] 200 GET /channels/all (7 live) GZIP 0ms 387 bytes
Sep 13, 2018 13:33:44.943 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.101 (http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce)
Sep 13, 2018 13:33:44.943 [8992] DEBUG - HTTP requesting GET http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce
Sep 13, 2018 13:34:00.017 [8992] ERROR - Error issuing curl_easy_perform(handle): 28
Sep 13, 2018 13:34:00.017 [8992] DEBUG - HTTP simulating 408 after curl timeout
Sep 13, 2018 13:34:13.376 [6608] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 28.433307 seconds: 192.168.1.101
Sep 13, 2018 13:34:21.954 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.102 (http://192.168.1.102:2869/upnphost/udhisapi.dll?content=uuid:2b680f8b-eb1e-401a-9e07-734a3f165c29)
Sep 13, 2018 13:34:21.954 [8960] DEBUG - HTTP requesting GET http://192.168.1.102:2869/upnphost/udhisapi.dll?content=uuid:2b680f8b-eb1e-401a-9e07-734a3f165c29
Sep 13, 2018 13:34:21.985 [8960] DEBUG - HTTP 200 response from GET http://192.168.1.102:2869/upnphost/udhisapi.dll?content=uuid:2b680f8b-eb1e-401a-9e07-734a3f165c29
Sep 13, 2018 13:34:43.385 [6608] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 21.431010 seconds: 192.168.1.102
Sep 13, 2018 13:35:45.962 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.101 (http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce)
Sep 13, 2018 13:35:45.962 [3840] DEBUG - HTTP requesting GET http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce
Sep 13, 2018 13:35:53.288 [6084] DEBUG - EPG[onconnect]: Purging 0 airings which completed in the past.
Sep 13, 2018 13:36:00.993 [3840] ERROR - Error issuing curl_easy_perform(handle): 28
Sep 13, 2018 13:36:00.993 [3840] DEBUG - HTTP simulating 408 after curl timeout
Sep 13, 2018 13:36:13.385 [6608] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 27.423297 seconds: 192.168.1.101
Sep 13, 2018 13:40:53.296 [3908] DEBUG - EPG[onconnect]: Purging 1 airings which completed in the past.
Sep 13, 2018 13:40:53.296 [3908] DEBUG - Destroying metadata item 35 (Fry and Leela's Big Fling)
Sep 13, 2018 13:40:53.342 [3908] VERBOSE - BPQ: onLibrarySectionChanged for library section 2: ItemsDeleted
Sep 13, 2018 13:41:44.665 [6608] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.101 (http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce)
Sep 13, 2018 13:41:44.665 [7004] DEBUG - HTTP requesting GET http://192.168.1.101:2869/upnphost/udhisapi.dll?content=uuid:64cf1ac4-22d8-4212-8cdd-41b7b17b61ce
Sep 13, 2018 13:41:53.354 [4608] DEBUG - BPQ: onConsiderProcessing: Idle (true)
Sep 13, 2018 13:41:53.354 [4608] DEBUG - BPQ: [Idle] -> [Processing]
Sep 13, 2018 13:41:53.354 [4608] DEBUG - BPQ: generating queue items from 0 generator(s)
Sep 13, 2018 13:41:53.354 [4608] DEBUG - BPQ: generated 0 item(s) for queue
Sep 13, 2018 13:41:53.354 [4608] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Sep 13, 2018 13:41:53.354 [4608] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Sep 13, 2018 13:41:53.401 [4608] DEBUG - BPQ: [Processing] -> [Idle]
Sep 13, 2018 13:41:53.401 [4608] DEBUG - BPQ: garbageCollect - sync - forced - 1
Sep 13, 2018 13:41:53.401 [4608] DEBUG - Sync: skipping GC because sync lists haven't been downloaded yet
Sep 13, 2018 13:41:53.401 [4608] DEBUG - BPQ: garbageCollect - version - forced - -1
Sep 13, 2018 13:41:53.401 [4608] DEBUG - Versions: garbage collecting
Sep 13, 2018 13:41:53.401 [4608] DEBUG - Versions: garbage collected in 0.0 seconds
Sep 13, 2018 13:41:59.691 [7004] ERROR - Error issuing curl_easy_perform(handle): 28
Sep 13, 2018 13:41:59.691 [7004] DEBUG - HTTP simulating 408 after curl timeout
Sep 13, 2018 13:42:13.382 [6608] DEBUG - NetworkServiceBrowser: SSDP departed after not being seen for 28.717029 seconds: 192.168.1.101
Sep 13, 2018 13:43:21.660 [5892] DEBUG - Ordered to stop server.
Sep 13, 2018 13:43:21.660 [5220] DEBUG - Stopping server...
Sep 13, 2018 13:43:21.660 [5220] DEBUG - HttpServer: Stopping server.
Sep 13, 2018 13:43:21.660 [8920] DEBUG - TranscodeJobManager: [Running] onServerShutdown
Sep 13, 2018 13:43:21.660 [8920] DEBUG - TranscodeJobManager: [Running] -> [Shutdown]
Sep 13, 2018 13:43:21.660 [8920] DEBUG - MetadataItemClusterRequestHandler: a shutdown event has been received
Sep 13, 2018 13:43:21.661 [5220] DEBUG - Server stopped.
Sep 13, 2018 13:43:21.661 [5220] DEBUG - Killing plug-ins.
Sep 13, 2018 13:43:21.661 [5220] DEBUG - [com.plexapp.agents.imdb] Killing.
Sep 13, 2018 13:43:21.661 [5220] DEBUG - [com.plexapp.system] Killing.
Sep 13, 2018 13:43:21.661 [5220] DEBUG - Waiting for Plex Dlna Server.exe to exit.
Sep 13, 2018 13:43:21.923 [3300] VERBOSE - JobManager: child process with handle 0x894 exited
Sep 13, 2018 13:43:21.923 [3300] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\Plex Dlna Server.exe' exit code for process 7500 is 0 (success)
Sep 13, 2018 13:43:21.923 [6648] DEBUG - Plex Dlna Server.exe exited.
Sep 13, 2018 13:43:21.923 [5220] DEBUG - Waiting for Plex Tuner Service.exe to exit.
Sep 13, 2018 13:43:21.936 [3300] VERBOSE - JobManager: child process with handle 0x8e8 exited
Sep 13, 2018 13:43:21.936 [3300] DEBUG - Jobs: 'C:\Program Files (x86)\Plex\Plex Media Server\Plex Tuner Service.exe' exit code for process 8328 is 0 (success)
Sep 13, 2018 13:43:21.937 [7504] DEBUG - Plex Tuner Service.exe exited.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Database: Shutting down.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 0.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 1.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 2.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 3.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 4.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 5.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 6.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 7.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 8.
Sep 13, 2018 13:43:21.955 [5220] DEBUG - Captured session 9.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 10.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 11.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 12.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 13.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 14.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 15.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 16.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 17.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 18.
Sep 13, 2018 13:43:21.956 [5220] DEBUG - Captured session 19.
Sep 13, 2018 13:43:22.048 [5220] DEBUG - Database: Shutting down.
Sep 13, 2018 13:43:22.048 [5220] DEBUG - Captured session 0.
Sep 13, 2018 13:43:22.048 [5220] DEBUG - Captured session 1.
