2018-09-25 18:43:27,002 (360c) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 10d48da (Fri Sep 21 03:46:16 UTC 2018)
2018-09-25 18:43:27,002 (360c) :  DEBUG (core:361) - Using the elevated policy
2018-09-25 18:43:27,002 (360c) :  DEBUG (core:365) - Extending whitelist: ['cgi', 'tempfile']
2018-09-25 18:43:27,003 (360c) :  DEBUG (core:450) - Starting runtime component.
2018-09-25 18:43:27,005 (360c) :  DEBUG (core:450) - Starting caching component.
2018-09-25 18:43:27,005 (360c) :  DEBUG (core:450) - Starting data component.
2018-09-25 18:43:27,005 (360c) :  DEBUG (core:450) - Starting networking component.
2018-09-25 18:43:27,006 (360c) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-09-25 18:43:27,009 (360c) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-09-25 18:43:27,009 (360c) :  DEBUG (core:450) - Starting localization component.
2018-09-25 18:43:27,009 (360c) :  INFO (localization:409) - Setting the default locale to en-us
2018-09-25 18:43:27,010 (360c) :  DEBUG (localization:427) - Loaded en strings
2018-09-25 18:43:27,010 (360c) :  DEBUG (core:450) - Starting messaging component.
2018-09-25 18:43:27,010 (360c) :  DEBUG (core:450) - Starting debugging component.
2018-09-25 18:43:27,012 (360c) :  DEBUG (core:450) - Starting services component.
2018-09-25 18:43:27,012 (360c) :  DEBUG (core:450) - Starting myplex component.
2018-09-25 18:43:27,012 (360c) :  DEBUG (core:450) - Starting notifications component.
2018-09-25 18:43:27,095 (360c) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2018-09-25 18:43:27,108 (37f4) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-09-25 18:43:27,108 (360c) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-09-25 18:43:27,109 (360c) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-09-25 18:43:27,109 (360c) :  DEBUG (core:150) - Finished starting framework core
2018-09-25 18:43:27,109 (37f4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-09-25 18:43:27,111 (37fc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-09-25 18:43:27,111 (360c) :  DEBUG (core:560) - Loading plug-in code
2018-09-25 18:43:27,128 (360c) :  DEBUG (core:566) - Finished loading plug-in code
2018-09-25 18:43:27,130 (360c) :  DEBUG (runtime:640) - Adding a prefix handler for 'System' ('/system')
2018-09-25 18:43:27,865 (360c) :  INFO (logkit:16) - Starting System 10d48da (Fri Sep 21 03:46:16 UTC 2018)
2018-09-25 18:43:27,865 (360c) :  DEBUG (runtime:640) - Adding a prefix handler for 'Player' ('/player')
2018-09-25 18:43:27,871 (360c) :  INFO (datakit:93) - Loaded the dictionary file
2018-09-25 18:43:27,871 (360c) :  DEBUG (logkit:13) - Starting the agent service
2018-09-25 18:43:27,970 (360c) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.system in namespace 'metadata'
2018-09-25 18:43:27,974 (360c) :  DEBUG (logkit:13) - Starting the bundle service
2018-09-25 18:43:27,976 (360c) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-25 18:43:27,976 (360c) :  DEBUG (logkit:13) - Starting the help service
2018-09-25 18:43:27,976 (360c) :  DEBUG (logkit:13) - Starting the store service
2018-09-25 18:43:27,979 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:27,986 (360c) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-25 18:43:27,986 (360c) :  DEBUG (logkit:13) - Starting the install service
2018-09-25 18:43:27,986 (3524) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-09-25 18:43:27,996 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:27,996 (360c) :  DEBUG (logkit:13) - Starting the player service
2018-09-25 18:43:27,997 (360c) :  DEBUG (logkit:13) - Starting the media flag service
2018-09-25 18:43:27,999 (360c) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-25 18:43:28,000 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,000 (360c) :  DEBUG (logkit:13) - Starting the peer service
2018-09-25 18:43:28,003 (360c) :  DEBUG (runtime:1117) - Created a thread named 'refresh_servers'
2018-09-25 18:43:28,003 (355c) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-09-25 18:43:28,003 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,005 (360c) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'refresh_servers'
2018-09-25 18:43:28,006 (360c) :  DEBUG (logkit:13) - Starting the stream service
2018-09-25 18:43:28,006 (355c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-09-25 18:43:28,006 (360c) :  CRITICAL (runtime:709) - Private handlers are no longer supported; couldn't register <bound method StreamService.token_handler of <StreamService object at 0x037C1FF0>>
2018-09-25 18:43:28,009 (360c) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'invalidation_timer'
2018-09-25 18:43:28,009 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,010 (360c) :  DEBUG (logkit:13) - Starting the proxy service
2018-09-25 18:43:28,012 (360c) :  DEBUG (runtime:1117) - Created a thread named 'update_attribution_flags_inner'
2018-09-25 18:43:28,013 (360c) :  INFO (core:611) - Started plug-in
2018-09-25 18:43:28,013 (360c) :  DEBUG (socketinterface:160) - Starting socket server
2018-09-25 18:43:28,016 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,016 (360c) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-25 18:43:28,016 (360c) :  INFO (socketinterface:184) - Socket server started on port 49864
2018-09-25 18:43:28,017 (360c) :  INFO (pipeinterface:25) - Entering run loop
2018-09-25 18:43:28,017 (360c) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-09-25 18:43:28,019 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,019 (360c) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-09-25 18:43:28,022 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,023 (360c) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 486 bytes
2018-09-25 18:43:28,023 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,026 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,028 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,029 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,032 (353c) :  DEBUG (runtime:1117) - Created a thread named 'ensure_agent_info_exists_inner'
2018-09-25 18:43:28,052 (3590) :  DEBUG (runtime:717) - Handling request GET /system/agents
2018-09-25 18:43:28,101 (3590) :  DEBUG (runtime:814) - Found route matching /system/agents
2018-09-25 18:43:28,193 (353c) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-25 18:43:28,193 (353c) :  DEBUG (logkit:13) - Started the bundle service
2018-09-25 18:43:28,201 (3560) :  DEBUG (logkit:13) - Started the media flag service
2018-09-25 18:43:28,207 (3544) :  INFO (logkit:16) - Agent info: {'com.plexapp.agents.fanarttv': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb', 'com.plexapp.agents.themoviedb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.lastfm'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Fanart.tv'}], 'com.plexapp.agents.none': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Shows'}, {'media_types': ['Artist'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Artists'}, {'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': False, 'name': 'Personal Media Albums'}, {'media_types': ['Photo'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': False, 'name': 'Photos'}], 'com.plexapp.agents.plexmusic': [{'media_types': ['Artist'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': True, 'name': 'Plex Premium Music'}, {'media_types': ['Album'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': True, 'name': 'Plex Premium Music'}], 'com.plexapp.agents.opensubtitles': [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'has_attribution': False, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, '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'], 'accepts_from': None, '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, 'primary_provider': False, 'prefs': False, 'name': 'LyricFind'}], 'com.plexapp.agents.thetvdb': [{'media_types': ['TV_Show'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': True, 'name': 'TheTVDB'}], 'com.plexapp.agents.plexthememusic': [{'media_types': ['TV_Show'], 'accepts_from': None, '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, 'primary_provider': False, 'prefs': False, 'name': 'Plex Theme Music'}], 'com.plexapp.agents.htbackdrops': [{'media_types': ['Artist'], 'accepts_from': None, '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, 'primary_provider': False, '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'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'has_attribution': True, 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, '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'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': True, 'name': 'Last.fm'}, {'media_types': ['Album'], 'accepts_from': None, '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, 'primary_provider': True, 'prefs': True, 'name': 'Last.fm'}]}
2018-09-25 18:43:28,220 (3590) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 9036 bytes
2018-09-25 18:43:28,240 (3544) :  INFO (datakit:131) - Saved the dictionary file
2018-09-25 18:43:28,290 (3664) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-09-25 18:43:28,292 (355c) :  DEBUG (logkit:13) - Refreshing local server
2018-09-25 18:43:28,293 (355c) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 18:43:28,295 (3524) :  DEBUG (core:521) - Attribute 'machineIdentifier' set to 'be9b701a0d306b73d78bdba9bf616622ab4d5d39'
2018-09-25 18:43:28,296 (37fc) :  DEBUG (core:538) - Machine identifier is be9b701a0d306b73d78bdba9bf616622ab4d5d39
2018-09-25 18:43:28,296 (355c) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 18:43:28,298 (37fc) :  DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-09-25 18:43:28,298 (3524) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-09-25 18:43:28,299 (355c) :  DEBUG (logkit:13) - Creating new server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 18:43:28,305 (355c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 18:43:28,309 (3524) :  DEBUG (core:521) - Attribute 'platformVersion' set to '10.0 (Build 17134)'
2018-09-25 18:43:28,315 (3524) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-25 18:43:28,319 (355c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 18:43:28,328 (355c) :  DEBUG (runtime:1117) - Created a thread named 'background_refresh'
2018-09-25 18:43:28,328 (3494) :  DEBUG (logkit:13) - Background-refreshing remote servers
2018-09-25 18:43:28,329 (3494) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 18:43:28,331 (3664) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-09-25 18:43:28,331 (3494) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 18:43:28,332 (3494) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 18:43:28,334 (3494) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 18:43:28,344 (3494) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 18:43:28,367 (3664) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 18:43:28,367 (3664) :  DEBUG (runtime:924) - Response: [200] str, 59976 bytes
2018-09-25 18:43:28,479 (37f4) :  DEBUG (services:362) - Loaded services
2018-09-25 18:43:28,493 (37f8) :  DEBUG (services:438) - No shared code to load
2018-09-25 18:43:29,584 (3548) :  DEBUG (runtime:717) - Handling request GET /system/messaging/clear_events/com.plexapp.agents.imdb
2018-09-25 18:43:29,607 (3548) :  DEBUG (runtime:814) - Found route matching /system/messaging/clear_events/com.plexapp.agents.imdb
2018-09-25 18:43:29,608 (3548) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 18:43:29,608 (3548) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-09-25 18:43:29,684 (23b4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/resourceHashes
2018-09-25 18:43:29,686 (23b4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/resourceHashes
2018-09-25 18:43:29,687 (23b4) :  DEBUG (networking:166) - Requesting 'http://resources-cdn.plexapp.com/hashes.json'
2018-09-25 18:43:29,693 (23b4) :  WARNING (data:179) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting value: line 1 column 1 (char 0)
2018-09-25 18:43:29,694 (23b4) :  CRITICAL (core:574) - Exception getting hosted resource hashes (most recent call last):
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\runtime.py", line 1295, in get_resource_hashes
    self._resource_hashes = self._core.data.json.from_string(json)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\data.py", line 180, in from_string
    return demjson.decode(jsonstring, encoding)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Platforms\Shared\Libraries\demjson.py", line 2135, in decode
    obj = j.decode( unitxt )
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Platforms\Shared\Libraries\demjson.py", line 1706, in decode
    r = self.decodeobj(txt, 0, only_object_or_array=not self._allow_any_type_at_start)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Platforms\Shared\Libraries\demjson.py", line 1697, in decodeobj
    raise JSONDecodeError('can not decode value',txt[i:])
JSONDecodeError: ('can not decode value', u'<html><head>\r\n<script>parent.location.href=\'/QIS_wizard.htm?flag=welcome\';</script>\n<meta http-equiv="Content-Type" content="text/html">\r\n</head></html>\r\n')

2018-09-25 18:43:29,696 (23b4) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 18:43:29,696 (23b4) :  DEBUG (runtime:924) - Response: [404] NoneType, 0 bytes
2018-09-25 18:43:29,734 (359c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-09-25 18:43:29,736 (359c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-25 18:43:29,736 (359c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
2018-09-25 18:43:29,750 (359c) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 18:43:29,750 (359c) :  DEBUG (runtime:924) - Response: [200] str, 59976 bytes
2018-09-25 18:43:30,334 (2270) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2018-09-25 18:43:30,335 (2270) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-25 18:43:30,335 (2270) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
2018-09-25 18:43:30,335 (2270) :  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-09-25 18:43:30,336 (2270) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 18:43:30,336 (2270) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-09-25 18:43:33,082 (1c08) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=192.168.1.49
2018-09-25 18:43:33,084 (1c08) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2018-09-25 18:43:33,084 (1c08) :  DEBUG (logkit:13) - Handling server update notification (192.168.1.49)
2018-09-25 18:43:33,084 (1c08) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 18:43:33,085 (1c08) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-09-25 18:43:33,085 (1c08) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-09-25 18:43:33,089 (1c08) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 18:43:33,089 (1c08) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 18:43:33,091 (1c08) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 18:43:33,096 (1c08) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 18:43:33,102 (1c08) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-09-25 18:43:33,209 (35ac) :  INFO (datakit:131) - Saved the dictionary file
2018-09-25 18:43:49,516 (3524) :  INFO (logkit:16) - Failed to fetch Plex Online data - the store probably won't work
2018-09-25 18:43:49,517 (3524) :  CRITICAL (core:579) - Error info (most recent call last):
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\System.bundle\Contents\Code\storeservice.py", line 495, in update
    log_msg = "Updated information for plug-in '%s' (class: %s) to a stable version"
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\parsekit.py", line 145, in ObjectFromURL
    method=method,
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\networkkit.py", line 67, in _http_request
    req = self._core.networking.http_request(url, *args, **kwargs)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 370, in http_request
    return HTTPRequest(self._core, url, data, h, url_cache, encoding, errors, timeout, immediate, sleep, opener, follow_redirects, method)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 141, in __init__
    self.load()
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 181, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 429, in open
    response = self._open(req, data)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 447, in _open
    '_open', req)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 1241, in https_open
    context=self._context)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 1198, in do_open
    raise URLError(err)
URLError: <urlopen error timed out>

2018-09-25 18:43:49,519 (3524) :  INFO (logkit:16) - Starting automatic update thread
2018-09-25 18:43:49,519 (3524) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-25 18:43:49,519 (3524) :  DEBUG (logkit:13) - Started the store service
2018-09-25 18:44:49,519 (440) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-25 18:44:49,519 (440) :  INFO (logkit:16) - Starting automatic update check
2018-09-25 18:44:49,520 (440) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-25 18:44:49,532 (440) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-25 18:44:54,536 (64) :  INFO (datakit:131) - Saved the dictionary file
2018-09-25 18:45:09,549 (440) :  INFO (logkit:16) - Failed to fetch Plex Online data - the store probably won't work
2018-09-25 18:45:09,551 (440) :  CRITICAL (core:579) - Error info (most recent call last):
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\System.bundle\Contents\Code\storeservice.py", line 495, in update
    log_msg = "Updated information for plug-in '%s' (class: %s) to a stable version"
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\parsekit.py", line 145, in ObjectFromURL
    method=method,
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\networkkit.py", line 67, in _http_request
    req = self._core.networking.http_request(url, *args, **kwargs)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 370, in http_request
    return HTTPRequest(self._core, url, data, h, url_cache, encoding, errors, timeout, immediate, sleep, opener, follow_redirects, method)
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 141, in __init__
    self.load()
  File "C:\Program Files (x86)\Plex\Plex Media Server\Resources\Plug-ins-10d48da0d\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\components\networking.py", line 181, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 429, in open
    response = self._open(req, data)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 447, in _open
    '_open', req)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 1241, in https_open
    context=self._context)
  File "C:\Program Files (x86)\Plex\Plex Media Server\python27.zip\urllib2.py", line 1198, in do_open
    raise URLError(err)
URLError: <urlopen error timed out>

2018-09-25 18:45:09,551 (440) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-25 18:45:09,552 (440) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-25 18:45:28,006 (3558) :  DEBUG (runtime:1156) - Starting timed thread named 'refresh_servers'
2018-09-25 18:45:28,006 (3558) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-09-25 18:45:28,006 (3558) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-09-25 18:45:28,012 (3558) :  DEBUG (logkit:13) - Refreshing local server
2018-09-25 18:45:28,012 (3558) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 18:45:28,013 (3558) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 18:45:28,013 (3558) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 18:45:28,013 (3558) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 18:45:28,019 (3558) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 18:45:28,023 (2458) :  DEBUG (logkit:13) - Background-refreshing remote servers
2018-09-25 18:45:28,023 (3558) :  DEBUG (runtime:1117) - Created a thread named 'background_refresh'
2018-09-25 18:45:28,023 (2458) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 18:45:28,025 (2458) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 18:45:28,025 (2458) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 18:45:28,026 (2458) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 18:45:28,029 (2458) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 19:43:28,009 (354c) :  DEBUG (runtime:1156) - Starting timed thread named 'invalidation_timer'
2018-09-25 20:05:46,036 (2fa8) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=192.168.2.49
2018-09-25 20:05:46,038 (2fa8) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2018-09-25 20:05:46,038 (2fa8) :  DEBUG (logkit:13) - Handling server update notification (192.168.2.49)
2018-09-25 20:05:46,038 (2fa8) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 20:05:46,039 (2fa8) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-09-25 20:05:46,039 (2fa8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-09-25 20:05:46,046 (2fa8) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 20:05:46,046 (2fa8) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 20:05:46,048 (2fa8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 20:05:46,053 (2fa8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 20:05:46,059 (2fa8) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-09-25 20:15:34,352 (6d0) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0110478%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_8ae3ca21cb09f6d7b544e9bd1f284a241c5da2af
2018-09-25 20:15:34,354 (6d0) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:34,355 (6d0) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.imdb in namespace 'metadata'
2018-09-25 20:15:34,359 (6d0) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_8ae3ca21cb09f6d7b544e9bd1f284a241c5da2af (in com.plexapp.agents.imdb)
2018-09-25 20:15:34,365 (6d0) :  DEBUG (runtime:924) - Response: [200] str, 1013427 bytes
2018-09-25 20:15:34,375 (3528) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0062803%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_f44e05a73cab8b06c981036a6403ddbc8b5ef417
2018-09-25 20:15:34,375 (3528) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:34,378 (3528) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_f44e05a73cab8b06c981036a6403ddbc8b5ef417 (in com.plexapp.agents.imdb)
2018-09-25 20:15:34,381 (3528) :  DEBUG (runtime:924) - Response: [200] str, 389316 bytes
2018-09-25 20:15:34,413 (321c) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt1981115%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_f8f8c3a7096ee127cfe0db8d3452efbf730ce6da
2018-09-25 20:15:34,414 (321c) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:34,415 (321c) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_f8f8c3a7096ee127cfe0db8d3452efbf730ce6da (in com.plexapp.agents.imdb)
2018-09-25 20:15:34,418 (321c) :  DEBUG (runtime:924) - Response: [200] str, 389685 bytes
2018-09-25 20:15:37,335 (59c) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt2527336%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_841ecbc4e9a662fb3a7a38de90f2acca21e363a7
2018-09-25 20:15:37,335 (59c) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:37,338 (59c) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_841ecbc4e9a662fb3a7a38de90f2acca21e363a7 (in com.plexapp.agents.imdb)
2018-09-25 20:15:37,339 (59c) :  DEBUG (runtime:924) - Response: [200] str, 241837 bytes
2018-09-25 20:15:37,986 (38f8) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt1228705%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_d3a97ee46b87ff8b1b9f9f2321d23da495661955
2018-09-25 20:15:37,987 (38f8) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:37,990 (38f8) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_d3a97ee46b87ff8b1b9f9f2321d23da495661955 (in com.plexapp.agents.imdb)
2018-09-25 20:15:37,993 (38f8) :  DEBUG (runtime:924) - Response: [200] str, 355079 bytes
2018-09-25 20:15:38,723 (f40) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5463162%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_e12914046f8406b427caaf9a246145ced7be99fa
2018-09-25 20:15:38,724 (f40) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:38,726 (f40) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_e12914046f8406b427caaf9a246145ced7be99fa (in com.plexapp.agents.imdb)
2018-09-25 20:15:38,733 (f40) :  DEBUG (runtime:924) - Response: [200] str, 1696528 bytes
2018-09-25 20:15:38,746 (670) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt1843866%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_c9c904903a34a0ae6a08bc0ecd9ca08b5854dfdf
2018-09-25 20:15:38,746 (670) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:38,749 (670) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_c9c904903a34a0ae6a08bc0ecd9ca08b5854dfdf (in com.plexapp.agents.imdb)
2018-09-25 20:15:38,752 (670) :  DEBUG (runtime:924) - Response: [200] str, 280621 bytes
2018-09-25 20:15:38,882 (378) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt4154756%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_0d329908b40e18db540ee4b7f256c82a1590c385
2018-09-25 20:15:38,884 (378) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:38,885 (378) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_0d329908b40e18db540ee4b7f256c82a1590c385 (in com.plexapp.agents.imdb)
2018-09-25 20:15:38,891 (378) :  DEBUG (runtime:924) - Response: [200] str, 1130734 bytes
2018-09-25 20:15:48,346 (2c60) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt1825683%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_6d88e8f0538a283d1a866024092ea884f9a7f04f
2018-09-25 20:15:48,348 (2c60) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-25 20:15:48,349 (2c60) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_6d88e8f0538a283d1a866024092ea884f9a7f04f (in com.plexapp.agents.imdb)
2018-09-25 20:15:48,351 (2c60) :  DEBUG (runtime:924) - Response: [200] str, 307219 bytes
2018-09-25 20:16:55,453 (12c4) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-25 20:16:55,456 (12c4) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-25 20:16:55,457 (12c4) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-09-25 20:16:55,459 (12c4) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.system
2018-09-25 20:16:55,461 (12c4) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 20:16:55,463 (12c4) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-25 20:17:09,831 (2450) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-25 20:17:09,831 (2450) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-25 20:17:09,832 (2450) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-25 20:17:09,834 (2450) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 20:17:09,835 (2450) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-25 20:17:14,918 (1eb0) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-25 20:17:14,921 (1eb0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-25 20:17:14,923 (764) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-25 20:17:14,924 (1eb0) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-25 20:17:14,924 (764) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-25 20:17:14,927 (764) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-25 20:17:14,930 (1eb0) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 20:17:14,930 (1eb0) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-25 20:17:14,931 (764) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-25 20:17:14,931 (764) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-25 20:18:03,099 (36e8) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=192.168.1.12
2018-09-25 20:18:03,101 (36e8) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2018-09-25 20:18:03,101 (36e8) :  DEBUG (logkit:13) - Handling server update notification (192.168.1.12)
2018-09-25 20:18:03,101 (36e8) :  DEBUG (logkit:13) - Updating servers (True/False True/True/True)
2018-09-25 20:18:03,101 (36e8) :  DEBUG (logkit:13) - Fetching the current list of servers
2018-09-25 20:18:03,101 (36e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/servers'
2018-09-25 20:18:03,107 (36e8) :  DEBUG (logkit:13) - Found 1 servers
2018-09-25 20:18:03,107 (36e8) :  DEBUG (logkit:13) - Updating existing server Server (be9b701a0d306b73d78bdba9bf616622ab4d5d39)
2018-09-25 20:18:03,108 (36e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/sections'
2018-09-25 20:18:03,112 (36e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/channels/all'
2018-09-25 20:18:03,118 (36e8) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2018-09-25 23:48:01,552 (c04) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-25 23:48:01,553 (c04) :  INFO (logkit:16) - Starting automatic update check
2018-09-25 23:48:01,555 (c04) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-25 23:48:01,569 (c04) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-25 23:48:01,742 (c04) :  INFO (logkit:16) - No beta plugins.
2018-09-25 23:48:01,746 (c04) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-25 23:48:01,746 (c04) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-25 23:48:01,746 (c04) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-25 23:48:06,569 (2904) :  INFO (datakit:131) - Saved the dictionary file
2018-09-26 04:16:34,746 (1b54) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-26 04:16:34,747 (1b54) :  INFO (logkit:16) - Starting automatic update check
2018-09-26 04:16:34,749 (1b54) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-26 04:16:34,765 (1b54) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-26 04:16:34,930 (1b54) :  INFO (logkit:16) - No beta plugins.
2018-09-26 04:16:34,933 (1b54) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-26 04:16:34,934 (1b54) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-26 04:16:34,934 (1b54) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-26 04:16:39,765 (1744) :  INFO (datakit:131) - Saved the dictionary file
2018-09-26 09:10:25,934 (204) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-26 09:10:25,934 (204) :  INFO (logkit:16) - Starting automatic update check
2018-09-26 09:10:25,936 (204) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-26 09:10:25,951 (204) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-26 09:10:26,121 (204) :  INFO (logkit:16) - No beta plugins.
2018-09-26 09:10:26,125 (204) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-26 09:10:26,125 (204) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-26 09:10:26,127 (204) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-26 09:10:30,950 (1e30) :  INFO (datakit:131) - Saved the dictionary file
2018-09-26 13:28:10,128 (41e8) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-26 13:28:10,128 (41e8) :  INFO (logkit:16) - Starting automatic update check
2018-09-26 13:28:10,130 (41e8) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-26 13:28:10,144 (41e8) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-26 13:28:10,344 (41e8) :  INFO (logkit:16) - No beta plugins.
2018-09-26 13:28:10,346 (41e8) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-26 13:28:10,346 (41e8) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-26 13:28:10,348 (41e8) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-26 13:28:15,144 (3b98) :  INFO (datakit:131) - Saved the dictionary file
2018-09-26 18:11:34,348 (43c0) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-26 18:11:34,349 (43c0) :  INFO (logkit:16) - Starting automatic update check
2018-09-26 18:11:34,351 (43c0) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-26 18:11:34,367 (43c0) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-26 18:11:34,532 (43c0) :  INFO (logkit:16) - No beta plugins.
2018-09-26 18:11:34,536 (43c0) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-26 18:11:34,538 (43c0) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-26 18:11:34,538 (43c0) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-26 18:11:39,367 (4128) :  INFO (datakit:131) - Saved the dictionary file
2018-09-26 20:19:48,010 (674) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0848228%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_faf9db70572b5cab1a6b3fb7108c1944f4296ef2
2018-09-26 20:19:48,013 (674) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-26 20:19:48,016 (674) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_faf9db70572b5cab1a6b3fb7108c1944f4296ef2 (in com.plexapp.agents.imdb)
2018-09-26 20:19:48,019 (674) :  DEBUG (runtime:924) - Response: [200] str, 389490 bytes
2018-09-26 20:19:48,119 (3e84) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0099088%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_93d7a0ed7da06983d9ef1ad7c49a361ef904cbe7
2018-09-26 20:19:48,121 (3e84) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-26 20:19:48,121 (3e84) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_93d7a0ed7da06983d9ef1ad7c49a361ef904cbe7 (in com.plexapp.agents.imdb)
2018-09-26 20:19:48,125 (3e84) :  DEBUG (runtime:924) - Response: [200] str, 307487 bytes
2018-09-26 20:19:51,006 (1de4) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt0322259%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_364dd3f0225055b20007d2eb5847e7688e2e6f5c
2018-09-26 20:19:51,006 (1de4) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2018-09-26 20:19:51,007 (1de4) :  DEBUG (logkit:13) - Returning stored data for metadata://posters/com.plexapp.agents.imdb_364dd3f0225055b20007d2eb5847e7688e2e6f5c (in com.plexapp.agents.imdb)
2018-09-26 20:19:51,009 (1de4) :  DEBUG (runtime:924) - Response: [200] str, 310367 bytes
2018-09-26 22:07:16,875 (60) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-26 22:07:16,877 (60) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-26 22:07:16,880 (60) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-26 22:07:16,880 (60) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-26 22:07:17,609 (1d08) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-26 22:07:17,611 (1d08) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-26 22:07:17,611 (1d08) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-26 22:07:17,615 (1d08) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-26 22:07:17,615 (1d08) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-26 22:07:25,019 (908) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-26 22:07:25,019 (908) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-26 22:07:25,019 (908) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-26 22:07:25,023 (908) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-26 22:07:25,023 (908) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-26 22:07:26,586 (1260) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-26 22:07:26,588 (1260) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-26 22:07:26,588 (1260) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-26 22:07:26,591 (1260) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-26 22:07:26,591 (1260) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-26 22:07:28,359 (3dd4) :  DEBUG (runtime:717) - Handling request GET /system/:/prefs
2018-09-26 22:07:28,361 (3dd4) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-26 22:07:28,361 (3dd4) :  DEBUG (runtime:814) - Found route matching /system/:/prefs
2018-09-26 22:07:28,364 (3dd4) :  DEBUG (runtime:88) - Sending packed state data (99 bytes)
2018-09-26 22:07:28,364 (3dd4) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 418 bytes
2018-09-27 00:25:56,539 (1b38) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-27 00:25:56,539 (1b38) :  INFO (logkit:16) - Starting automatic update check
2018-09-27 00:25:56,540 (1b38) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-27 00:25:56,555 (1b38) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-27 00:25:57,440 (1b38) :  INFO (logkit:16) - No beta plugins.
2018-09-27 00:25:57,444 (1b38) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-27 00:25:57,444 (1b38) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-27 00:25:57,444 (1b38) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-27 00:26:01,555 (42dc) :  INFO (datakit:131) - Saved the dictionary file
2018-09-27 06:16:20,444 (355c) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-27 06:16:20,444 (355c) :  INFO (logkit:16) - Starting automatic update check
2018-09-27 06:16:20,446 (355c) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-27 06:16:20,460 (355c) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-27 06:16:20,634 (355c) :  INFO (logkit:16) - No beta plugins.
2018-09-27 06:16:20,640 (355c) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-27 06:16:20,640 (355c) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-27 06:16:20,641 (355c) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-27 06:16:25,460 (2fc8) :  INFO (datakit:131) - Saved the dictionary file
2018-09-27 12:47:47,653 (eec) :  DEBUG (runtime:1156) - Starting timed thread named 'auto_update_thread'
2018-09-27 12:47:47,667 (eec) :  INFO (logkit:16) - Starting automatic update check
2018-09-27 12:47:47,677 (eec) :  DEBUG (runtime:1117) - Created a thread named 'remove_unavailable_agents'
2018-09-27 12:47:47,700 (eec) :  DEBUG (networking:166) - Requesting 'https://plugins.plex.tv/apps/all.json?frameworkVersion=2.6.3&machineIdentifier=be9b701a0d306b73d78bdba9bf616622ab4d5d39&os=Windows&osVersion=10.0%20%28Build%2017134%29&cpu=i386&serverVersion=1.13.8.5395-10d48da0d&systemRevision=10d48da'
2018-09-27 12:47:47,943 (eec) :  INFO (logkit:16) - No beta plugins.
2018-09-27 12:47:47,950 (eec) :  INFO (logkit:16) - 'Services' plug-in [com.plexapp.system.services] is up to date (e851797)
2018-09-27 12:47:47,950 (eec) :  INFO (logkit:16) - All plug-ins are up to date
2018-09-27 12:47:47,951 (eec) :  DEBUG (runtime:1150) - Scheduled a timed thread named 'auto_update_thread'
2018-09-27 12:47:52,697 (4b9c) :  INFO (datakit:131) - Saved the dictionary file
