2018-10-30 10:11:05,412 (7ffbd28ac740) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 21ab172 (Sat Aug 18 04:15:06 UTC 2018)
2018-10-30 10:11:05,412 (7ffbd28ac740) :  DEBUG (core:361) - Using the elevated policy
2018-10-30 10:11:05,412 (7ffbd28ac740) :  DEBUG (core:450) - Starting runtime component.
2018-10-30 10:11:05,414 (7ffbd28ac740) :  DEBUG (core:450) - Starting caching component.
2018-10-30 10:11:05,415 (7ffbd28ac740) :  DEBUG (core:450) - Starting data component.
2018-10-30 10:11:05,415 (7ffbd28ac740) :  DEBUG (core:450) - Starting networking component.
2018-10-30 10:11:05,416 (7ffbd28ac740) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-10-30 10:11:05,426 (7ffbd28ac740) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-10-30 10:11:05,427 (7ffbd28ac740) :  DEBUG (core:450) - Starting localization component.
2018-10-30 10:11:05,427 (7ffbd28ac740) :  INFO (localization:409) - Setting the default locale to en-us
2018-10-30 10:11:05,427 (7ffbd28ac740) :  DEBUG (core:450) - Starting messaging component.
2018-10-30 10:11:05,427 (7ffbd28ac740) :  DEBUG (core:450) - Starting debugging component.
2018-10-30 10:11:05,428 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.thetvdb'
2018-10-30 10:11:05,428 (7ffbd28ac740) :  DEBUG (core:450) - Starting services component.
2018-10-30 10:11:05,429 (7ffbd28ac740) :  DEBUG (core:450) - Starting myplex component.
2018-10-30 10:11:05,429 (7ffbd28ac740) :  DEBUG (core:450) - Starting notifications component.
2018-10-30 10:11:05,560 (7ffbd28ac740) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.thetvdb in namespace 'metadata'
2018-10-30 10:11:05,565 (7ffbd28ac740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-10-30 10:11:05,581 (7ffbb9ffb700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-10-30 10:11:05,581 (7ffbd28ac740) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-10-30 10:11:05,582 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-10-30 10:11:05,583 (7ffbd28ac740) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-10-30 10:11:05,583 (7ffbd28ac740) :  DEBUG (core:150) - Finished starting framework core
2018-10-30 10:11:05,584 (7ffbb8ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-30 10:11:05,584 (7ffbd28ac740) :  DEBUG (core:560) - Loading plug-in code
2018-10-30 10:11:06,010 (7ffbd28ac740) :  DEBUG (core:566) - Finished loading plug-in code
2018-10-30 10:11:06,011 (7ffbd28ac740) :  DEBUG (agentkit:1115) - Creating new agent class called TVDBAgent
2018-10-30 10:11:06,012 (7ffbd28ac740) :  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-10-30 10:11:06,013 (7ffbd28ac740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo1CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdAoyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8xCnIyCjEwCnIzCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudG5zMTQKY29udHJpYnV0ZXNfdG9yNApzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMXMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3M3ClRoZVRWREJzNApuYW1lMQpzNwpUVl9TaG93MjMKczIKZW5zMgpmcnMyCnpoczIKc3ZzMgpub3MyCmRhczIKZmlzMgpubHMyCmRlczIKaXRzMgplc3MyCnBsczIKaHVzMgplbHMyCnRyczIKcnVzMgpoZXMyCmphczIKcHRzMgpjc3MyCmtvczIKc2xzMgpocnIwCg__'
2018-10-30 10:11:06,016 (7ffbb8ff9700) :  DEBUG (core:538) - Machine identifier is 3292b13278b71be78ecde6aa3aa6f2776cf4da13
2018-10-30 10:11:06,016 (7ffbb8ff9700) :  DEBUG (core:539) - Server version is 1.13.5.5332-21ab172de
2018-10-30 10:11:06,086 (7ffbb9ffb700) :  DEBUG (services:362) - Loaded services
2018-10-30 10:11:06,090 (7ffbb97fa700) :  DEBUG (services:438) - No shared code to load
2018-10-30 10:11:06,092 (7ffbd28ac740) :  INFO (core:611) - Started plug-in
2018-10-30 10:11:06,092 (7ffbd28ac740) :  DEBUG (socketinterface:160) - Starting socket server
2018-10-30 10:11:06,093 (7ffbd28ac740) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-30 10:11:06,093 (7ffbd28ac740) :  INFO (socketinterface:184) - Socket server started on port 43411
2018-10-30 10:11:06,093 (7ffbd28ac740) :  INFO (pipeinterface:25) - Entering run loop
2018-10-30 10:11:06,093 (7ffbd28ac740) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-10-30 10:11:06,094 (7ffbd28ac740) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-10-30 10:11:06,095 (7ffbd28ac740) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 151 bytes
2018-10-30 10:11:06,120 (7ffbb9ffb700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTEwCnMxNgo3YzI5OTg1YjYyYzM2NzA2czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIKMThzNwplcGlzb2RlczEKMXM4CmVwaXNvZGljczM2ClNvbWV0aGluZyBTcGVjaWFsOiBXZSdyZSBBbGwgRnJpZW5kc3M0CnNob3dzMTkKMjAxOC0xMC0yNyAwOTowMDowMHMxMQpyZWxlYXNlZF9hdHMyCjExczYKc2Vhc29uczE3OQolMkZtZWRpYSUyRkZyZWV2aWV3JTJGU29tZXRoaW5nJTIwU3BlY2lhbCUyMFdlJ3JlJTIwQWxsJTIwRnJpZW5kcyUyMCgyMDEyKSUyRlNlYXNvbiUyMDExJTJGU29tZXRoaW5nJTIwU3BlY2lhbCUyMFdlJ3JlJTIwQWxsJTIwRnJpZW5kcyUyMCgyMDEyKSUyMC0lMjBTMTFFMTglMjAtJTIwTmV3JTIwU2hvZXMlMkV0c3M4CmZpbGVuYW1lczQwCmQ1NjIxZGM4ZGRiNTgyMTcwYmJkYzQ2NzIyNjM1NTZhZDlkNTQ4MDNzOApwbGV4SGFzaHM3CjE1NTU4MDBzOApkdXJhdGlvbnM1CjI2NzA1czIKaWRyMAo_
2018-10-30 10:11:06,121 (7ffbb9ffb700) :  DEBUG (runtime:49) - Received packed state data (556 bytes)
2018-10-30 10:11:06,136 (7ffbb9ffb700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTEwCnMxNgo3YzI5OTg1YjYyYzM2NzA2czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIKMThzNwplcGlzb2RlczEKMXM4CmVwaXNvZGljczM2ClNvbWV0aGluZyBTcGVjaWFsOiBXZSdyZSBBbGwgRnJpZW5kc3M0CnNob3dzMTkKMjAxOC0xMC0yNyAwOTowMDowMHMxMQpyZWxlYXNlZF9hdHMyCjExczYKc2Vhc29uczE3OQolMkZtZWRpYSUyRkZyZWV2aWV3JTJGU29tZXRoaW5nJTIwU3BlY2lhbCUyMFdlJ3JlJTIwQWxsJTIwRnJpZW5kcyUyMCgyMDEyKSUyRlNlYXNvbiUyMDExJTJGU29tZXRoaW5nJTIwU3BlY2lhbCUyMFdlJ3JlJTIwQWxsJTIwRnJpZW5kcyUyMCgyMDEyKSUyMC0lMjBTMTFFMTglMjAtJTIwTmV3JTIwU2hvZXMlMkV0c3M4CmZpbGVuYW1lczQwCmQ1NjIxZGM4ZGRiNTgyMTcwYmJkYzQ2NzIyNjM1NTZhZDlkNTQ4MDNzOApwbGV4SGFzaHM3CjE1NTU4MDBzOApkdXJhdGlvbnM1CjI2NzA1czIKaWRyMAo_
2018-10-30 10:11:06,136 (7ffbb9ffb700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': '7c29985b62c36706', 'episode': '18', 'episodic': '1', 'show': "Something Special: We're All Friends", 'released_at': '2018-10-27 09:00:00', 'season': '11', 'filename': "%2Fmedia%2FFreeview%2FSomething%20Special%20We're%20All%20Friends%20(2012)%2FSeason%2011%2FSomething%20Special%20We're%20All%20Friends%20(2012)%20-%20S11E18%20-%20New%20Shoes%2Ets", 'plexHash': 'd5621dc8ddb582170bbdc4672263556ad9d54803', 'duration': '1555800', 'id': '26705'}
2018-10-30 10:11:06,136 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/26705/tree'
2018-10-30 10:11:06,187 (7ffbb9ffb700) :  DEBUG (networking:161) - Fetching 'https://meta.plex.tv/tv/guid/24/24689e4daa28851f5bfc68a659f2d8bffa5aeac8.xml' from the HTTP cache
2018-10-30 10:11:06,192 (7ffbb9ffb700) :  INFO (__init__:258) - Inspecting: guid = 263556, count = 32, pct = 100
2018-10-30 10:11:06,193 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/login'
2018-10-30 10:11:06,333 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/series/263556?lang=en'
2018-10-30 10:11:06,585 (7ffbb9ffb700) :  ERROR (networking:219) - Error opening URL 'https://tvdb2.plex.tv/series/263556?lang=en'
2018-10-30 10:11:06,586 (7ffbb9ffb700) :  INFO (__init__:162) - HTTPError 404: 
2018-10-30 10:11:06,792 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/1a/1af17e73721dbe0c40011b82ed4bb1a7dbe3ce29.xml'
2018-10-30 10:11:06,890 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/ba/ba36b97a41e7faf742ab09bf88405ac04f99599a.xml'
2018-10-30 10:11:06,964 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/67/676e6f35cfc173f73fea9fe27699cf8185397f0c.xml'
2018-10-30 10:11:07,036 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/c3/c387c982a132d05cbd5f88840aef2c8157740049.xml'
2018-10-30 10:11:07,133 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/d8/d87c448044defb778f33158d8ccf94a20531d600.xml'
2018-10-30 10:11:07,212 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/tv/names/en/3d/3d9209c4598bfbc38b3c096081bee3a09697e939.xml'
2018-10-30 10:11:07,292 (7ffbb9ffb700) :  INFO (__init__:369) - Searching for exact match with: Something+Special%3A+We%27re+All+Friends (lang: en)
2018-10-30 10:11:07,293 (7ffbb9ffb700) :  DEBUG (networking:166) - Requesting 'https://tvdb2.plex.tv/search/series?name=Something+Special%3A+We%27re+All+Friends'
2018-10-30 10:11:07,538 (7ffbb9ffb700) :  INFO (__init__:491) - ---- UMP RESULTS MAP ----
2018-10-30 10:11:07,669 (7ffbb9ffb700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/ump/matches?type=2&title=Something%20Special%3A%20We%27re%20All%20Friends&year=&lang=en&manual=0' from the HTTP cache
2018-10-30 10:11:07,675 (7ffbb9ffb700) :  INFO (__init__:411) - UMP: MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/fpUAD0QrhzNxxjkk23IB273QaeO.jpg', score=91, year=None, id='89581', name='Something Special')
2018-10-30 10:11:07,676 (7ffbb9ffb700) :  INFO (__init__:516) - Final result: MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/fpUAD0QrhzNxxjkk23IB273QaeO.jpg', score=91, year=None, id='89581', name='Something Special')
2018-10-30 10:11:07,677 (7ffbb9ffb700) :  DEBUG (runtime:88) - Sending packed state data (583 bytes)
2018-10-30 10:11:07,678 (7ffbb9ffb700) :  DEBUG (runtime:924) - Response: [200] str, 720 bytes
