2018-09-24 21:01:04,214 (7f9b601f5700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 10d48da (Fri Sep 21 11:37:35 UTC 2018)
2018-09-24 21:01:04,214 (7f9b601f5700) :  DEBUG (core:361) - Using the elevated policy
2018-09-24 21:01:04,215 (7f9b601f5700) :  DEBUG (core:450) - Starting runtime component.
2018-09-24 21:01:04,219 (7f9b601f5700) :  DEBUG (core:450) - Starting caching component.
2018-09-24 21:01:04,219 (7f9b601f5700) :  DEBUG (core:450) - Starting data component.
2018-09-24 21:01:04,220 (7f9b601f5700) :  DEBUG (core:450) - Starting networking component.
2018-09-24 21:01:04,221 (7f9b601f5700) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-09-24 21:01:04,223 (7f9b601f5700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-09-24 21:01:04,224 (7f9b601f5700) :  DEBUG (core:450) - Starting localization component.
2018-09-24 21:01:04,224 (7f9b601f5700) :  INFO (localization:409) - Setting the default locale to en-us
2018-09-24 21:01:04,224 (7f9b601f5700) :  DEBUG (core:450) - Starting messaging component.
2018-09-24 21:01:04,225 (7f9b601f5700) :  DEBUG (core:450) - Starting debugging component.
2018-09-24 21:01:04,226 (7f9b601f5700) :  DEBUG (core:450) - Starting services component.
2018-09-24 21:01:04,226 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.thetvdb'
2018-09-24 21:01:04,226 (7f9b601f5700) :  DEBUG (core:450) - Starting myplex component.
2018-09-24 21:01:04,228 (7f9b601f5700) :  DEBUG (core:450) - Starting notifications component.
2018-09-24 21:01:04,380 (7f9b601f5700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.thetvdb in namespace 'metadata'
2018-09-24 21:01:04,386 (7f9b601f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-09-24 21:01:04,405 (7f9b37fff700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-09-24 21:01:04,405 (7f9b601f5700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-09-24 21:01:04,407 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-09-24 21:01:04,409 (7f9b601f5700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-09-24 21:01:04,409 (7f9b36ffd700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-09-24 21:01:04,410 (7f9b601f5700) :  DEBUG (core:150) - Finished starting framework core
2018-09-24 21:01:04,411 (7f9b601f5700) :  DEBUG (core:560) - Loading plug-in code
2018-09-24 21:01:04,751 (7f9b36ffd700) :  DEBUG (core:538) - Machine identifier is cf70331b0806ecd09f07f17c6b5f86487dbf67be
2018-09-24 21:01:04,755 (7f9b36ffd700) :  DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-09-24 21:01:05,098 (7f9b37fff700) :  DEBUG (services:362) - Loaded services
2018-09-24 21:01:05,105 (7f9b377fe700) :  DEBUG (services:438) - No shared code to load
2018-09-24 21:01:05,218 (7f9b601f5700) :  DEBUG (core:566) - Finished loading plug-in code
2018-09-24 21:01:05,219 (7f9b601f5700) :  DEBUG (agentkit:1115) - Creating new agent class called TVDBAgent
2018-09-24 21:01:05,220 (7f9b601f5700) :  DEBUG (agentkit:933) - Updating agent information: [{'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': None, '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'}]
2018-09-24 21:01:05,221 (7f9b601f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo1CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdAoyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8xCnIyCjEwCnIzCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudG5zMTQKY29udHJpYnV0ZXNfdG9yNApzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMXMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3M3ClRoZVRWREJzNApuYW1lMQpzNwpUVl9TaG93MjMKczIKZW5zMgpmcnMyCnpoczIKc3ZzMgpub3MyCmRhczIKZmlzMgpubHMyCmRlczIKaXRzMgplc3MyCnBsczIKaHVzMgplbHMyCnRyczIKcnVzMgpoZXMyCmphczIKcHRzMgpjc3MyCmtvczIKc2xzMgpocnIwCg__'
2018-09-24 21:01:05,235 (7f9b601f5700) :  INFO (core:611) - Started plug-in
2018-09-24 21:01:05,235 (7f9b601f5700) :  DEBUG (socketinterface:160) - Starting socket server
2018-09-24 21:01:05,236 (7f9b601f5700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-24 21:01:05,236 (7f9b601f5700) :  INFO (socketinterface:184) - Socket server started on port 38599
2018-09-24 21:01:05,236 (7f9b601f5700) :  INFO (pipeinterface:25) - Entering run loop
2018-09-24 21:01:05,237 (7f9b601f5700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-09-24 21:01:05,239 (7f9b601f5700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-09-24 21:01:05,240 (7f9b601f5700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 151 bytes
2018-09-24 21:01:05,250 (7f9b37fff700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxMDg3OXM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQzCmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vMzM3OTA3P2xhbmc9ZW5zNApndWlkczYKMzM3OTA3czIKaWRyMAo_
2018-09-24 21:01:05,252 (7f9b37fff700) :  DEBUG (runtime:49) - Received packed state data (556 bytes)
2018-09-24 21:01:05,278 (7f9b37fff700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxMDg3OXM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQzCmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vMzM3OTA3P2xhbmc9ZW5zNApndWlkczYKMzM3OTA3czIKaWRyMAo_
2018-09-24 21:01:05,279 (7f9b37fff700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.thetvdb://337907?lang=en
2018-09-24 21:01:05,281 (7f9b37fff700) :  DEBUG (model:234) - Deserializing from /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/TV Shows/3/30f47d17ee9d77a2a92ba2aedb353378f86de55.bundle/Contents/com.plexapp.agents.thetvdb/Info.xml
2018-09-24 21:01:05,319 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/10879/tree'
2018-09-24 21:01:05,339 (7f9b37fff700) :  INFO (__init__:785) - def update()
2018-09-24 21:01:05,341 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-09-24 21:01:05,749 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907?lang=en'
2018-09-24 21:01:06,200 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Ffind%2F337907%3Fexternal_source%3Dtvdb_id'
2018-09-24 21:01:08,590 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Ftv%2F75219%2Frecommendations'
2018-09-24 21:01:10,805 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/actors'
2018-09-24 21:01:11,214 (7f9b37fff700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-09-24 21:01:11,215 (7f9b37fff700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.thetvdb
2018-09-24 21:01:11,226 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv_e/337907/nine+one+one/2018'
2018-09-24 21:01:11,560 (7f9b37fff700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/tv_e/337907/nine+one+one/2018'
2018-09-24 21:01:11,571 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/episodes?page=1'
2018-09-24 21:01:11,974 (7f9b37fff700) :  INFO (__init__:902) - Show ordering is: aired
2018-09-24 21:01:11,975 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 1 - skipping population of episode data
2018-09-24 21:01:11,975 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 2 - skipping population of episode data
2018-09-24 21:01:11,976 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 3 - skipping population of episode data
2018-09-24 21:01:11,977 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 4 - skipping population of episode data
2018-09-24 21:01:11,977 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 5 - skipping population of episode data
2018-09-24 21:01:11,978 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 6 - skipping population of episode data
2018-09-24 21:01:11,978 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 7 - skipping population of episode data
2018-09-24 21:01:11,979 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 8 - skipping population of episode data
2018-09-24 21:01:11,979 (7f9b37fff700) :  INFO (__init__:930) - No media for season 1 episode 9 - skipping population of episode data
2018-09-24 21:01:11,980 (7f9b37fff700) :  INFO (__init__:930) - No media for season 2 episode 1 - skipping population of episode data
2018-09-24 21:01:11,982 (7f9b37fff700) :  INFO (__init__:930) - No media for season 2 episode 3 - skipping population of episode data
2018-09-24 21:01:11,983 (7f9b37fff700) :  INFO (__init__:930) - No media for season 2 episode 4 - skipping population of episode data
2018-09-24 21:01:11,983 (7f9b37fff700) :  DEBUG (threadkit:234) - Starting a parallel task set named UpdateEpisodes with 2 tasks
2018-09-24 21:01:11,991 (7f9b36ffd700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/episodes/6542411?lang=en'
2018-09-24 21:01:11,997 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/episodes/6743116?lang=en'
2018-09-24 21:01:12,404 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/episodes/337907/6743116.jpg'
2018-09-24 21:01:12,532 (7f9b36ffd700) :  INFO (__init__:1025) - Season Extra XML is empty - therefore, no episode XML
2018-09-24 21:01:12,955 (7f9b35b85700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/episodes/337907/6743116.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:12,956 (7f9b35b85700) :  INFO (__init__:1025) - Season Extra XML is empty - therefore, no episode XML
2018-09-24 21:01:12,957 (7f9b37fff700) :  DEBUG (threadkit:244) - Parallel task set UpdateEpisodes ended
2018-09-24 21:01:12,963 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/images?lang=en'
2018-09-24 21:01:13,407 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/images/query?keyType=fanart&lang=en'
2018-09-24 21:01:13,854 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/images/query?keyType=poster&lang=en'
2018-09-24 21:01:14,328 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/images/query?keyType=series&lang=en'
2018-09-24 21:01:14,749 (7f9b37fff700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/337907/images/query?keyType=season&lang=en'
2018-09-24 21:01:15,319 (7f9b37fff700) :  DEBUG (threadkit:234) - Starting a parallel task set named DownloadImages with 29 tasks
2018-09-24 21:01:15,331 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/fanart/original/5b7f1eb0dca2c.jpg'
2018-09-24 21:01:15,337 (7f9b34b83700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/graphical/5b8741bd31262.jpg'
2018-09-24 21:01:15,343 (7f9b36ffd700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b96f2efb1d2d.jpg'
2018-09-24 21:01:15,349 (7f9b35384700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5ba966a8accb4.jpg'
2018-09-24 21:01:15,802 (7f9b35b85700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/fanart/original/5b7f1eb0dca2c.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:15,808 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b9c8b11be288.jpg'
2018-09-24 21:01:16,023 (7f9b34b83700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/graphical/5b8741bd31262.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,024 (7f9b36ffd700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b96f2efb1d2d.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,031 (7f9b34b83700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b6b629f364ab.jpg'
2018-09-24 21:01:16,040 (7f9b36ffd700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b821bed0a421.jpg'
2018-09-24 21:01:16,060 (7f9b35384700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5ba966a8accb4.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,065 (7f9b35384700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b2db8f48401c.jpg'
2018-09-24 21:01:16,212 (7f9b35b85700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b9c8b11be288.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,217 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/fanart/original/5b86f3accd68f.jpg'
2018-09-24 21:01:16,499 (7f9b36ffd700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b821bed0a421.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,503 (7f9b36ffd700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/posters/5b6b4fb88becd.jpg'
2018-09-24 21:01:16,544 (7f9b35384700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b2db8f48401c.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,550 (7f9b35384700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/graphical/5ba945659619c.jpg'
2018-09-24 21:01:16,710 (7f9b35b85700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/fanart/original/5b86f3accd68f.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,715 (7f9b35b85700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/graphical/5ba945712968e.jpg'
2018-09-24 21:01:16,772 (7f9b34b83700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b6b629f364ab.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:16,779 (7f9b34b83700) :  DEBUG (networking:166) - Requesting 'https://thetvdb.com/banners/_cache/seasons/5ba8d75b79c9d.jpg'
2018-09-24 21:01:16,945 (7f9b36ffd700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/posters/5b6b4fb88becd.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:17,110 (7f9b35b85700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/graphical/5ba945712968e.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:17,163 (7f9b34b83700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/seasons/5ba8d75b79c9d.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:17,172 (7f9b35384700) :  DEBUG (networking:198) - Not caching 'https://thetvdb.com/banners/_cache/graphical/5ba945659619c.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-09-24 21:01:17,173 (7f9b37fff700) :  DEBUG (threadkit:244) - Parallel task set DownloadImages ended
2018-09-24 21:01:17,174 (7f9b37fff700) :  INFO (__init__:1118) - Series Extra XML is empty - therefore, no season XML
2018-09-24 21:01:17,175 (7f9b37fff700) :  INFO (__init__:1118) - Series Extra XML is empty - therefore, no season XML
2018-09-24 21:01:17,210 (7f9b37fff700) :  DEBUG (model:229) - Serializing to /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/TV Shows/3/30f47d17ee9d77a2a92ba2aedb353378f86de55.bundle/Contents/com.plexapp.agents.thetvdb/Info.xml
2018-09-24 21:01:17,213 (7f9b37fff700) :  DEBUG (runtime:88) - Sending packed state data (583 bytes)
2018-09-24 21:01:17,213 (7f9b37fff700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
