2018-10-27 11:53:25,464 (1088) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 10d48da (Fri Sep 21 03:46:16 UTC 2018)
2018-10-27 11:53:25,464 (1088) :  DEBUG (core:361) - Using the elevated policy
2018-10-27 11:53:25,466 (1088) :  DEBUG (core:365) - Extending whitelist: ['cgi', 'tempfile']
2018-10-27 11:53:25,466 (1088) :  DEBUG (core:450) - Starting runtime component.
2018-10-27 11:53:25,471 (1088) :  DEBUG (core:450) - Starting caching component.
2018-10-27 11:53:25,471 (1088) :  DEBUG (core:450) - Starting data component.
2018-10-27 11:53:25,471 (1088) :  DEBUG (core:450) - Starting networking component.
2018-10-27 11:53:25,473 (1088) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-10-27 11:53:25,476 (1088) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-10-27 11:53:25,476 (1088) :  DEBUG (core:450) - Starting localization component.
2018-10-27 11:53:25,476 (1088) :  INFO (localization:409) - Setting the default locale to en-us
2018-10-27 11:53:25,479 (1088) :  DEBUG (localization:427) - Loaded en strings
2018-10-27 11:53:25,479 (1088) :  DEBUG (core:450) - Starting messaging component.
2018-10-27 11:53:25,479 (1088) :  DEBUG (core:450) - Starting debugging component.
2018-10-27 11:53:25,480 (1088) :  DEBUG (core:450) - Starting services component.
2018-10-27 11:53:25,480 (1088) :  DEBUG (core:450) - Starting myplex component.
2018-10-27 11:53:25,480 (1088) :  DEBUG (core:450) - Starting notifications component.
2018-10-27 11:53:25,628 (1088) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2018-10-27 11:53:25,644 (270c) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-10-27 11:53:25,644 (1088) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-10-27 11:53:25,648 (270c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-10-27 11:53:25,648 (1088) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-10-27 11:53:25,650 (2714) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-27 11:53:25,651 (1088) :  DEBUG (core:150) - Finished starting framework core
2018-10-27 11:53:25,654 (1088) :  DEBUG (core:560) - Loading plug-in code
2018-10-27 11:53:25,690 (1088) :  DEBUG (core:566) - Finished loading plug-in code
2018-10-27 11:53:25,690 (1088) :  DEBUG (runtime:640) - Adding a prefix handler for 'System' ('/system')
2018-10-27 11:53:26,996 (1088) :  INFO (logkit:16) - Starting System 10d48da (Fri Sep 21 03:46:16 UTC 2018)
2018-10-27 11:53:26,996 (1088) :  DEBUG (runtime:640) - Adding a prefix handler for 'Player' ('/player')
2018-10-27 11:53:27,006 (1088) :  INFO (datakit:93) - Loaded the dictionary file
2018-10-27 11:53:27,006 (1088) :  DEBUG (logkit:13) - Starting the agent service
2018-10-27 11:53:27,196 (1088) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2018-10-27 11:53:27,204 (1088) :  DEBUG (logkit:13) - Starting the bundle service
2018-10-27 11:53:27,206 (1088) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-27 11:53:27,206 (1088) :  DEBUG (logkit:13) - Starting the help service
2018-10-27 11:53:27,209 (1088) :  DEBUG (logkit:13) - Starting the store service
2018-10-27 11:53:27,213 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,223 (1088) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-27 11:53:27,226 (2530) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-27 11:53:27,226 (1088) :  DEBUG (logkit:13) - Starting the install service
2018-10-27 11:53:27,233 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,239 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,240 (1088) :  DEBUG (logkit:13) - Starting the player service
2018-10-27 11:53:27,243 (1088) :  DEBUG (logkit:13) - Starting the media flag service
2018-10-27 11:53:27,246 (1088) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-27 11:53:27,246 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,246 (1088) :  DEBUG (logkit:13) - Starting the peer service
2018-10-27 11:53:27,252 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,253 (1088) :  DEBUG (runtime:1117) - Created a thread named 'refresh_servers'
2018-10-27 11:53:27,253 (15f0) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-10-27 11:53:27,256 (1088) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'refresh_servers'
2018-10-27 11:53:27,259 (1088) :  DEBUG (logkit:13) - Starting the stream service
2018-10-27 11:53:27,259 (15f0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-10-27 11:53:27,260 (1088) :  CRITICAL (runtime:709) - Private handlers are no longer supported; couldn't register <bound method StreamService.token_handler of <StreamService object at 0x056780B0>>
2018-10-27 11:53:27,263 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,265 (1088) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'invalidation_timer'
2018-10-27 11:53:27,267 (1088) :  DEBUG (logkit:13) - Starting the proxy service
2018-10-27 11:53:27,270 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,276 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,278 (1088) :  DEBUG (runtime:1117) - Created a thread named 'update_attribution_flags_inner'
2018-10-27 11:53:27,279 (1088) :  INFO (core:611) - Started plug-in
2018-10-27 11:53:27,279 (1088) :  DEBUG (socketinterface:160) - Starting socket server
2018-10-27 11:53:27,280 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,285 (1088) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-27 11:53:27,286 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,286 (1088) :  INFO (socketinterface:184) - Socket server started on port 49877
2018-10-27 11:53:27,289 (1088) :  INFO (pipeinterface:25) - Entering run loop
2018-10-27 11:53:27,289 (1088) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-10-27 11:53:27,292 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,298 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,299 (1088) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-10-27 11:53:27,306 (1088) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 486 bytes
2018-10-27 11:53:27,309 (2738) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-10-27 11:53:27,486 (1664) :  DEBUG (runtime:717) - Handling request GET /system/agents
2018-10-27 11:53:27,529 (1664) :  DEBUG (runtime:814) - Found route matching /system/agents
2018-10-27 11:53:28,743 (2738) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-10-27 11:53:28,743 (2738) :  DEBUG (logkit:13) - Started the bundle service
2018-10-27 11:53:28,772 (15e8) :  DEBUG (logkit:13) - Started the media flag service
2018-10-27 11:53:28,782 (dd8) :  INFO (logkit:16) - Agent info: {'com.plexapp.agents.fanarttv': [{'media_types': ['Movie'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['TV_Show'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Artist'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Album'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Fanart.tv'}], 'com.plexapp.agents.none': [{'media_types': ['Movie'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Personal Media'}, {'media_types': ['TV_Show'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Personal Media Shows'}, {'media_types': ['Artist'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Personal Media Artists'}, {'media_types': ['Album'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Personal Media Albums'}, {'media_types': ['Photo'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['en', 'ar', 'bg', 'ca', 'cs', 'cy', 'da', 'de', 'el', 'es', 'et', 'fa', 'fi', 'fr', 'he', 'hi', 'hr', 'ht', 'hu', 'id', 'it', 'ja', 'ko', 'lt', 'lv', 'ms', 'mt', 'nl', 'no', 'pl', 'pt', 'ro', 'ru', 'sk', 'sv', 'sl', 'sr', 'th', 'tr', 'uk', 'ur', 'vi', 'zh', 'xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Photos'}], 'com.plexapp.agents.plexmusic': [{'media_types': ['Artist'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.localmedia'], 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Plex Premium Music'}, {'media_types': ['Album'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.localmedia'], 'has_attribution': True, 'languages': ['en', 'ar', 'bg', 'zh', 'hr', 'cs', 'da', 'nl', 'fi', 'fr', 'de', 'el', 'hu', 'id', 'it', 'ja', 'ko', 'nn', 'pl', 'pt', 'ro', 'ru', 'sr', 'sk', 'es', 'sv', 'th', 'tr', 'vi'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Plex Premium Music'}], 'com.plexapp.agents.opensubtitles': [{'media_types': ['Movie'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'OpenSubtitles.org'}, {'media_types': ['TV_Show'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'OpenSubtitles.org'}], 'com.plexapp.agents.imdb': [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'nl', 'de', 'it', 'da', 'ar', 'ca', 'zh', 'cs', 'et', 'fi', 'el', 'he', 'hi', 'hu', 'id', 'ja', 'ko', 'lv', 'no', 'fa', 'pl', 'pt', 'ro', 'ru', 'sk', 'th', 'tr', 'uk', 'vi'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Plex Movie'}], 'com.plexapp.agents.lyricfind': [{'media_types': ['Album'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.plexmusic', 'com.plexapp.agents.localmedia', 'com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'LyricFind'}], 'com.plexapp.agents.thetvdb': [{'media_types': ['TV_Show'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'fr', 'zh', 'sv', 'no', 'da', 'fi', 'nl', 'de', 'it', 'es', 'pl', 'hu', 'el', 'tr', 'ru', 'he', 'ja', 'pt', 'cs', 'ko', 'sl', 'hr'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'TheTVDB'}], 'com.plexapp.agents.plexthememusic': [{'media_types': ['TV_Show'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.thetvdbdvdorder', 'com.plexapp.agents.themoviedb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Plex Theme Music'}], 'com.plexapp.agents.htbackdrops': [{'media_types': ['Artist'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['ab', 'aa', 'af', 'ak', 'sq', 'am', 'ar', 'an', 'hy', 'as', 'av', 'ae', 'ay', 'az', 'bm', 'ba', 'eu', 'be', 'bn', 'bh', 'bi', 'bs', 'pb', 'br', 'bg', 'my', 'ca', 'ch', 'ce', 'ny', 'zh', 'cu', 'cv', 'kw', 'co', 'cr', 'hr', 'cs', 'da', 'dv', 'nl', 'dz', 'en', 'eo', 'et', 'ee', 'fo', 'fj', 'fi', 'fr', 'fy', 'ff', 'gd', 'gl', 'lg', 'ka', 'de', 'el', 'gn', 'gu', 'ht', 'ha', 'he', 'hz', 'hi', 'ho', 'hu', 'is', 'io', 'ig', 'id', 'ia', 'ie', 'iu', 'ik', 'ga', 'it', 'ja', 'jv', 'kl', 'kn', 'kr', 'ks', 'kk', 'km', 'ki', 'rw', 'ky', 'kv', 'kg', 'ko', 'kj', 'ku', 'lo', 'la', 'lv', 'li', 'ln', 'lt', 'lu', 'lb', 'mk', 'mg', 'ms', 'ml', 'mt', 'gv', 'mi', 'mr', 'mh', 'mo', 'mn', 'na', 'nv', 'ng', 'ne', 'xn', 'nd', 'no', 'nb', 'nn', 'oc', 'oj', 'or', 'om', 'os', 'pi', 'pa', 'fa', 'pl', 'pt', 'ps', 'qu', 'rm', 'ro', 'rn', 'ru', 'se', 'sm', 'sg', 'sa', 'sc', 'sr', 'sn', 'ii', 'sd', 'si', 'sk', 'sl', 'so', 'st', 'nr', 'es', 'su', 'sw', 'ss', 'sv', 'tl', 'ty', 'tg', 'ta', 'tt', 'te', 'th', 'bo', 'ti', 'to', 'ts', 'tn', 'tr', 'tk', 'tw', 'ug', 'uk', 'ur', 'uz', 've', 'vi', 'vo', 'wa', 'cy', 'wo', 'xh', 'yi', 'yo', 'za', 'zu'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'Home Theater Backdrops'}], 'com.plexapp.agents.themoviedb': [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'cs', 'da', 'de', 'el', 'es', 'fi', 'fr', 'he', 'hr', 'hu', 'it', 'lv', 'lt', 'nl', 'no', 'pl', 'pt', 'ru', 'sk', 'sv', 'th', 'tr', 'vi', 'zh', 'ko'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'The Movie Database'}, {'media_types': ['TV_Show'], 'accepts_from': ['com.plexapp.agents.localmedia', 'com.plexapp.agents.thetvdb'], 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'has_attribution': True, 'languages': ['en', 'cs', 'da', 'de', 'el', 'es', 'fi', 'fr', 'he', 'hr', 'hu', 'it', 'lv', 'lt', 'nl', 'no', 'pl', 'pt', 'ru', 'sk', 'sv', 'th', 'tr', 'vi', 'zh', 'ko'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'The Movie Database'}], 'com.plexapp.agents.movieposterdb': [{'media_types': ['Movie'], 'primary_provider': False, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': False, 'name': 'CineMaterial'}], 'com.plexapp.agents.localmedia': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Movies)'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (TV)'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.discogs', 'com.plexapp.agents.lastfm', 'com.plexapp.agents.plexmusic', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Artists)'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.plexmusic'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 2, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Artists)'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.discogs', 'com.plexapp.agents.lastfm', 'com.plexapp.agents.plexmusic', 'com.plexapp.agents.none'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': False, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Local Media Assets (Albums)'}], 'com.plexapp.agents.lastfm': [{'media_types': ['Artist'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'de', 'pl', 'it', 'pt', 'ja', 'tr', 'ru', 'zh'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Last.fm'}, {'media_types': ['Album'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': True, 'languages': ['en', 'sv', 'fr', 'es', 'de', 'pl', 'it', 'pt', 'ja', 'tr', 'ru', 'zh'], 'persist_stored_files': True, 'version': 0, 'accepts_from': None, 'prefs': True, 'name': 'Last.fm'}]}
2018-10-27 11:53:28,823 (1664) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 9036 bytes
2018-10-27 11:53:28,835 (dd8) :  INFO (datakit:131) - Saved the dictionary file
2018-10-27 11:53:31,155 (27c4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:31,160 (15f0) :  DEBUG (logkit:13) - Refreshing local server
2018-10-27 11:53:31,161 (15f0) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-10-27 11:53:31,164 (15f0) :  DEBUG (logkit:13) - Found 1 servers
2018-10-27 11:53:31,259 (15f0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-27 11:53:31,282 (27c4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:31,318 (27c4) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:31,319 (27c4) :  DEBUG (runtime:924) - Response: [200] str, 62566 bytes
2018-10-27 11:53:31,530 (270c) :  DEBUG (services:362) - Loaded services
2018-10-27 11:53:31,542 (2718) :  DEBUG (services:438) - No shared code to load
2018-10-27 11:53:32,795 (18c0) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=192.168.1.146
2018-10-27 11:53:32,868 (18c0) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2018-10-27 11:53:32,868 (18c0) :  DEBUG (logkit:13) - Handling server update notification (192.168.1.146)
2018-10-27 11:53:32,869 (18c0) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-10-27 11:53:32,869 (18c0) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-10-27 11:53:32,871 (18c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-10-27 11:53:32,878 (18c0) :  DEBUG (logkit:13) - Found 1 servers
2018-10-27 11:53:32,878 (18c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-27 11:53:33,842 (2080) :  INFO (datakit:131) - Saved the dictionary file
2018-10-27 11:53:33,923 (1be0) :  DEBUG (runtime:717) - Handling request GET /system/messaging/clear_events/com.plexapp.plugins.WebTools
2018-10-27 11:53:33,924 (1be0) :  DEBUG (runtime:814) - Found route matching /system/messaging/clear_events/com.plexapp.plugins.WebTools
2018-10-27 11:53:33,927 (1be0) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:33,927 (1be0) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-10-27 11:53:33,956 (18c0) :  DEBUG (core:521) - Attribute 'machineIdentifier' set to '7e0d395b9e4a10d7fb39e3151eecdf3274164576'
2018-10-27 11:53:33,960 (18c0) :  DEBUG (logkit:13) - Creating new server Juno (7e0d395b9e4a10d7fb39e3151eecdf3274164576)
2018-10-27 11:53:33,960 (15f0) :  DEBUG (core:521) - Attribute 'machineIdentifier' set to '7e0d395b9e4a10d7fb39e3151eecdf3274164576'
2018-10-27 11:53:33,963 (15f0) :  DEBUG (logkit:13) - Creating new server Juno (7e0d395b9e4a10d7fb39e3151eecdf3274164576)
2018-10-27 11:53:33,964 (2530) :  DEBUG (core:521) - Attribute 'machineIdentifier' set to '7e0d395b9e4a10d7fb39e3151eecdf3274164576'
2018-10-27 11:53:33,970 (2714) :  DEBUG (core:538) - Machine identifier is 7e0d395b9e4a10d7fb39e3151eecdf3274164576
2018-10-27 11:53:33,970 (2714) :  DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-10-27 11:53:33,977 (2530) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-27 11:53:33,994 (2530) :  DEBUG (core:521) - Attribute 'platformVersion' set to '10.0 (Build 17134)'
2018-10-27 11:53:34,091 (15f0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-10-27 11:53:34,091 (18c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-10-27 11:53:34,150 (2530) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=7e0d395b9e4a10d7fb39e3151eecdf3274164576&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-10-27 11:53:34,256 (1954) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/resourceHashes
2018-10-27 11:53:34,259 (1954) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/resourceHashes
2018-10-27 11:53:34,309 (1954) :  DEBUG (networking:166) - Requesting 'http://resources-cdn.plexapp.com/hashes.json'
2018-10-27 11:53:34,460 (1954) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:34,463 (1954) :  DEBUG (runtime:924) - Response: [200] str, 13276 bytes
2018-10-27 11:53:34,463 (15f0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-10-27 11:53:34,463 (18c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-10-27 11:53:34,505 (15f0) :  DEBUG (runtime:1117) - Created a thread named 'background_refresh'
2018-10-27 11:53:34,505 (1920) :  DEBUG (logkit:13) - Background-refreshing remote servers
2018-10-27 11:53:34,519 (1920) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-10-27 11:53:34,523 (1920) :  DEBUG (logkit:13) - Found 1 servers
2018-10-27 11:53:34,523 (18c0) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-10-27 11:53:34,523 (1920) :  DEBUG (logkit:13) - Updating existing server Juno (7e0d395b9e4a10d7fb39e3151eecdf3274164576)
2018-10-27 11:53:34,529 (1920) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-10-27 11:53:34,542 (1920) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-10-27 11:53:34,584 (1c38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:34,585 (1c38) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-27 11:53:34,588 (1c38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:34,657 (1c38) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:34,658 (1c38) :  DEBUG (runtime:924) - Response: [200] str, 62566 bytes
2018-10-27 11:53:35,493 (1d7c) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-10-27 11:53:35,496 (1d7c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-27 11:53:35,497 (1d7c) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-10-27 11:53:35,502 (1d7c) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-10-27 11:53:35,589 (1d7c) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.system
2018-10-27 11:53:35,598 (1d7c) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:35,599 (1d7c) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-10-27 11:53:35,694 (2530) :  INFO (logkit:16) - No beta plugins.
2018-10-27 11:53:35,710 (2530) :  INFO (logkit:16) - Starting automatic update thread
2018-10-27 11:53:35,713 (2530) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-10-27 11:53:35,713 (2530) :  DEBUG (logkit:13) - Started the store service
2018-10-27 11:53:35,822 (1db0) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-10-27 11:53:35,825 (1db0) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-10-27 11:53:35,828 (1db0) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:35,828 (1db0) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-10-27 11:53:45,266 (1984) :  DEBUG (runtime:717) - Handling request GET /system/messaging/clear_events/com.plexapp.agents.imdb
2018-10-27 11:53:45,269 (1984) :  DEBUG (runtime:814) - Found route matching /system/messaging/clear_events/com.plexapp.agents.imdb
2018-10-27 11:53:45,269 (1984) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:45,269 (1984) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-10-27 11:53:45,392 (1954) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/resourceHashes
2018-10-27 11:53:45,394 (1954) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/resourceHashes
2018-10-27 11:53:45,398 (1954) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:45,398 (1954) :  DEBUG (runtime:924) - Response: [200] str, 13276 bytes
2018-10-27 11:53:45,431 (404) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:45,433 (404) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-27 11:53:45,434 (404) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-10-27 11:53:45,460 (404) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:45,460 (404) :  DEBUG (runtime:924) - Response: [200] str, 62566 bytes
2018-10-27 11:53:46,970 (21c4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2018-10-27 11:53:46,974 (21c4) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-27 11:53:46,977 (21c4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2018-10-27 11:53:46,979 (21c4) :  INFO (logkit:16) - Receiving agent info from com.plexapp.agents.imdb: [{'media_types': ['Movie'], 'primary_provider': True, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.themoviedb'], 'languages': ['en', 'sv', 'fr', 'es', 'nl', 'de', 'it', 'da', 'ar', 'ca', 'zh', 'cs', 'et', 'fi', 'el', 'he', 'hi', 'hu', 'id', 'ja', 'ko', 'lv', 'no', 'fa', 'pl', 'pt', 'ro', 'ru', 'sk', 'th', 'tr', 'uk', 'vi'], 'persist_stored_files': True, 'version': 0, 'accepts_from': ['com.plexapp.agents.localmedia'], 'prefs': True, 'name': 'Plex Movie'}]
2018-10-27 11:53:46,984 (21c4) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-10-27 11:53:46,986 (21c4) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-27 11:53:52,019 (18fc) :  INFO (datakit:131) - Saved the dictionary file
2018-10-27 11:54:35,713 (d68) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-10-27 11:54:35,714 (d68) :  INFO (logkit:16) - Starting automatic update check
2018-10-27 11:54:35,717 (d68) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-10-27 11:54:35,733 (d68) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=7e0d395b9e4a10d7fb39e3151eecdf3274164576&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-10-27 11:54:35,959 (d68) :  INFO (logkit:16) - No beta plugins.
2018-10-27 11:54:35,966 (d68) :  INFO (logkit:16) - 'TWiT.TV' plug-in [com.plexapp.plugins.twitlive] is up to date (18c6d1b)
2018-10-27 11:54:35,967 (d68) :  INFO (logkit:16) - 'BBC iPlayer' plug-in [com.plexapp.plugins.iplayer] is up to date (cf2d743)
2018-10-27 11:54:35,967 (d68) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (9b31f28)
2018-10-27 11:54:35,967 (d68) :  INFO (logkit:16) - All plug-ins are up to date
2018-10-27 11:54:35,967 (d68) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-10-27 11:54:40,747 (22bc) :  INFO (datakit:131) - Saved the dictionary file
2018-10-27 11:55:27,265 (dac) :  DEBUG (runtime:1156) - Starting timed thread named 'refresh_servers'
2018-10-27 11:55:27,266 (dac) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-10-27 11:55:27,269 (dac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-10-27 11:55:27,282 (dac) :  DEBUG (logkit:13) - Refreshing local server
2018-10-27 11:55:27,282 (dac) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-10-27 11:55:27,282 (dac) :  DEBUG (logkit:13) - Found 1 servers
2018-10-27 11:55:27,283 (dac) :  DEBUG (logkit:13) - Updating existing server Juno (7e0d395b9e4a10d7fb39e3151eecdf3274164576)
2018-10-27 11:55:27,286 (dac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-10-27 11:55:27,302 (dac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-10-27 11:55:27,309 (235c) :  DEBUG (logkit:13) - Background-refreshing remote servers
2018-10-27 11:55:27,309 (dac) :  DEBUG (runtime:1117) - Created a thread named 'background_refresh'
2018-10-27 11:55:27,312 (235c) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-10-27 11:55:27,313 (235c) :  DEBUG (logkit:13) - Found 1 servers
2018-10-27 11:55:27,313 (235c) :  DEBUG (logkit:13) - Updating existing server Juno (7e0d395b9e4a10d7fb39e3151eecdf3274164576)
2018-10-27 11:55:27,315 (235c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-10-27 11:55:27,326 (235c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-10-27 11:59:52,546 (aa0) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-10-27 11:59:52,549 (aa0) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-10-27 11:59:52,555 (aa0) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-10-27 12:00:06,842 (2f18) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-10-27 12:00:06,844 (2f18) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-10-27 12:00:06,851 (2f18) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
