2018-07-05 10:45:55,510 (1509a9e62700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: cd1e0da (Wed Jun 27 13:34:10 UTC 2018)
2018-07-05 10:45:55,511 (1509a9e62700) :  DEBUG (core:361) - Using the elevated policy
2018-07-05 10:45:55,513 (1509a9e62700) :  DEBUG (core:450) - Starting runtime component.
2018-07-05 10:45:55,522 (1509a9e62700) :  DEBUG (core:450) - Starting caching component.
2018-07-05 10:45:55,524 (1509a9e62700) :  DEBUG (core:450) - Starting data component.
2018-07-05 10:45:55,526 (1509a9e62700) :  DEBUG (core:450) - Starting networking component.
2018-07-05 10:45:55,529 (1509a9e62700) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-07-05 10:45:55,534 (1509a9e62700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-07-05 10:45:55,538 (1509a9e62700) :  DEBUG (core:450) - Starting localization component.
2018-07-05 10:45:55,539 (1509a9e62700) :  INFO (localization:409) - Setting the default locale to en-us
2018-07-05 10:45:55,541 (1509a9e62700) :  DEBUG (core:450) - Starting messaging component.
2018-07-05 10:45:55,543 (1509a9e62700) :  DEBUG (core:450) - Starting debugging component.
2018-07-05 10:45:55,545 (1509a147d700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.thetvdb'
2018-07-05 10:45:55,546 (1509a9e62700) :  DEBUG (core:450) - Starting services component.
2018-07-05 10:45:55,553 (1509a9e62700) :  DEBUG (core:450) - Starting myplex component.
2018-07-05 10:45:55,554 (1509a9e62700) :  DEBUG (core:450) - Starting notifications component.
2018-07-05 10:45:56,443 (1509a9e62700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.thetvdb in namespace 'metadata'
2018-07-05 10:45:56,473 (1509a9e62700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-07-05 10:45:56,562 (1509a9e62700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-07-05 10:45:56,563 (1509a147d700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-07-05 10:45:56,568 (1509a9e62700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-07-05 10:45:56,570 (1509a9e62700) :  DEBUG (core:150) - Finished starting framework core
2018-07-05 10:45:56,571 (1509a0f7b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-07-05 10:45:56,572 (1509a147d700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-07-05 10:45:56,573 (1509a9e62700) :  DEBUG (core:560) - Loading plug-in code
2018-07-05 10:45:56,843 (1509a0f7b700) :  DEBUG (core:538) - Machine identifier is a5226ea8adc6289c330cc20917adac8eac991685
2018-07-05 10:45:56,845 (1509a0f7b700) :  DEBUG (core:539) - Server version is 1.13.3.5223-cd1e0da1b
2018-07-05 10:45:59,613 (1509a147d700) :  DEBUG (services:362) - Loaded services
2018-07-05 10:45:59,646 (1509a117c700) :  DEBUG (services:438) - No shared code to load
2018-07-05 10:46:00,271 (1509a9e62700) :  DEBUG (core:566) - Finished loading plug-in code
2018-07-05 10:46:00,274 (1509a9e62700) :  DEBUG (agentkit:1115) - Creating new agent class called TVDBAgent
2018-07-05 10:46:00,280 (1509a9e62700) :  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-07-05 10:46:00,285 (1509a9e62700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo1CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdAoyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8xCnIyCjEwCnIzCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudG5zMTQKY29udHJpYnV0ZXNfdG9yNApzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMXMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3M3ClRoZVRWREJzNApuYW1lMQpzNwpUVl9TaG93MjMKczIKZW5zMgpmcnMyCnpoczIKc3ZzMgpub3MyCmRhczIKZmlzMgpubHMyCmRlczIKaXRzMgplc3MyCnBsczIKaHVzMgplbHMyCnRyczIKcnVzMgpoZXMyCmphczIKcHRzMgpjc3MyCmtvczIKc2xzMgpocnIwCg__'
2018-07-05 10:46:00,329 (1509a9e62700) :  INFO (core:611) - Started plug-in
2018-07-05 10:46:00,331 (1509a9e62700) :  DEBUG (socketinterface:160) - Starting socket server
2018-07-05 10:46:00,335 (1509a9e62700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-07-05 10:46:00,336 (1509a9e62700) :  INFO (socketinterface:184) - Socket server started on port 41323
2018-07-05 10:46:00,338 (1509a9e62700) :  INFO (pipeinterface:25) - Entering run loop
2018-07-05 10:46:00,339 (1509a9e62700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-07-05 10:46:00,348 (1509a9e62700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-07-05 10:46:00,351 (1509a9e62700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 151 bytes
2018-07-05 10:46:00,366 (1509a147d700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgozNjg0NjRzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzI1NTMxNj9sYW5nPWVuczQKZ3VpZHM2CjI1NTMxNnMyCmlkcjAK
2018-07-05 10:46:00,370 (1509a147d700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-07-05 10:46:00,442 (1509a147d700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgozNjg0NjRzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzI1NTMxNj9sYW5nPWVuczQKZ3VpZHM2CjI1NTMxNnMyCmlkcjAK
2018-07-05 10:46:00,446 (1509a147d700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.thetvdb://255316?lang=en
2018-07-05 10:46:00,457 (1509a147d700) :  DEBUG (model:234) - Deserializing from /config/Library/Application Support/Plex Media Server/Metadata/TV Shows/4/efbc3768efa0f11cc94714513e6981bb7b53fd3.bundle/Contents/com.plexapp.agents.thetvdb/Info.xml
2018-07-05 10:46:00,466 (1509a147d700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/368464/tree'
2018-07-05 10:46:01,566 (1509a147d700) :  INFO (__init__:785) - def update()
2018-07-05 10:46:01,570 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-07-05 10:46:21,700 (1509a147d700) :  INFO (__init__:140) - JWT Error: (<urlopen error ('_ssl.c:574: The handshake operation timed out',)>) - 
2018-07-05 10:46:21,716 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/255316?lang=en'
2018-07-05 10:47:21,840 (1509a147d700) :  INFO (__init__:175) - Problem with the request: 
2018-07-05 10:47:21,841 (1509a147d700) :  INFO (__init__:793) - Bad series data, no update for TVDB id: 255316 (lang: en)
2018-07-05 10:47:21,865 (1509a147d700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Ffind%2F255316%3Fexternal_source%3Dtvdb_id' from the HTTP cache
2018-07-05 10:47:21,901 (1509a147d700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Ftv%2F1415%2Frecommendations' from the HTTP cache
2018-07-05 10:47:21,923 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-07-05 10:47:42,038 (1509a147d700) :  INFO (__init__:140) - JWT Error: (<urlopen error ('_ssl.c:574: The handshake operation timed out',)>) - 
2018-07-05 10:47:42,053 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/255316/actors'
2018-07-05 10:48:42,201 (1509a147d700) :  INFO (__init__:175) - Problem with the request: 
2018-07-05 10:48:42,203 (1509a147d700) :  INFO (__init__:834) - Bad actor data, no update for TVDB id: 255316
2018-07-05 10:48:42,208 (1509a147d700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-07-05 10:48:42,214 (1509a147d700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.thetvdb
2018-07-05 10:48:42,232 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-07-05 10:49:02,344 (1509a147d700) :  INFO (__init__:140) - JWT Error: (<urlopen error ('_ssl.c:574: The handshake operation timed out',)>) - 
2018-07-05 10:49:02,358 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/255316/episodes?page=1'
2018-07-05 10:50:02,498 (1509a147d700) :  INFO (__init__:175) - Problem with the request: 
2018-07-05 10:50:02,503 (1509a147d700) :  INFO (__init__:902) - Show ordering is: aired
2018-07-05 10:50:02,505 (1509a147d700) :  DEBUG (threadkit:234) - Starting a parallel task set named UpdateEpisodes with 0 tasks
2018-07-05 10:50:02,508 (1509a147d700) :  DEBUG (threadkit:244) - Parallel task set UpdateEpisodes ended
2018-07-05 10:50:02,512 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-07-05 10:50:22,626 (1509a147d700) :  INFO (__init__:140) - JWT Error: (<urlopen error ('_ssl.c:574: The handshake operation timed out',)>) - 
2018-07-05 10:50:22,640 (1509a147d700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/255316/images?lang=en'
2018-07-05 10:51:22,901 (1509a147d700) :  INFO (__init__:175) - Problem with the request: 
2018-07-05 10:51:22,902 (1509a147d700) :  INFO (__init__:689) - Bad image type data for TVDB id: 255316
2018-07-05 10:51:22,907 (1509a147d700) :  DEBUG (threadkit:234) - Starting a parallel task set named DownloadImages with 0 tasks
2018-07-05 10:51:22,911 (1509a147d700) :  DEBUG (threadkit:244) - Parallel task set DownloadImages ended
2018-07-05 10:51:22,929 (1509a147d700) :  DEBUG (model:229) - Serializing to /config/Library/Application Support/Plex Media Server/Metadata/TV Shows/4/efbc3768efa0f11cc94714513e6981bb7b53fd3.bundle/Contents/com.plexapp.agents.thetvdb/Info.xml
2018-07-05 10:51:22,941 (1509a147d700) :  DEBUG (runtime:88) - Sending packed state data (107 bytes)
2018-07-05 10:51:22,943 (1509a147d700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
