2018-10-14 18:50:29,878 (7f8a5f417740) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 10d48da (Fri Sep 21 11:37:35 UTC 2018)
2018-10-14 18:50:29,878 (7f8a5f417740) :  DEBUG (core:361) - Using the elevated policy
2018-10-14 18:50:29,879 (7f8a5f417740) :  DEBUG (core:450) - Starting runtime component.
2018-10-14 18:50:29,886 (7f8a5f417740) :  DEBUG (core:450) - Starting caching component.
2018-10-14 18:50:29,886 (7f8a5f417740) :  DEBUG (core:450) - Starting data component.
2018-10-14 18:50:29,886 (7f8a5f417740) :  DEBUG (core:450) - Starting networking component.
2018-10-14 18:50:29,887 (7f8a5f417740) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-10-14 18:50:29,887 (7f8a5f417740) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-10-14 18:50:29,887 (7f8a5f417740) :  DEBUG (core:450) - Starting localization component.
2018-10-14 18:50:29,887 (7f8a5f417740) :  INFO (localization:409) - Setting the default locale to en-us
2018-10-14 18:50:29,887 (7f8a5f417740) :  DEBUG (core:450) - Starting messaging component.
2018-10-14 18:50:29,888 (7f8a5f417740) :  DEBUG (core:450) - Starting debugging component.
2018-10-14 18:50:29,888 (7f8a5f417740) :  DEBUG (core:450) - Starting services component.
2018-10-14 18:50:29,888 (7f8a5f417740) :  DEBUG (core:450) - Starting myplex component.
2018-10-14 18:50:29,888 (7f8a5f417740) :  DEBUG (core:450) - Starting notifications component.
2018-10-14 18:50:29,889 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.themoviedb'
2018-10-14 18:50:29,952 (7f8a5f417740) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.themoviedb in namespace 'metadata'
2018-10-14 18:50:29,954 (7f8a5f417740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-10-14 18:50:29,964 (7f8a50ff9700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-10-14 18:50:29,964 (7f8a5f417740) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-10-14 18:50:29,964 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-10-14 18:50:29,965 (7f8a5f417740) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-10-14 18:50:29,965 (7f8a2f7fe700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-14 18:50:29,965 (7f8a5f417740) :  DEBUG (core:150) - Finished starting framework core
2018-10-14 18:50:29,966 (7f8a5f417740) :  DEBUG (core:560) - Loading plug-in code
2018-10-14 18:50:30,146 (7f8a2f7fe700) :  DEBUG (core:538) - Machine identifier is 67c1a75cfa2f72bedf11560b6b63ae2e6f2f8dca
2018-10-14 18:50:30,147 (7f8a2f7fe700) :  DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-10-14 18:50:30,185 (7f8a50ff9700) :  DEBUG (services:362) - Loaded services
2018-10-14 18:50:30,187 (7f8a2ffff700) :  DEBUG (services:438) - No shared code to load
2018-10-14 18:50:30,217 (7f8a5f417740) :  DEBUG (core:566) - Finished loading plug-in code
2018-10-14 18:50:30,217 (7f8a5f417740) :  DEBUG (messaging:69) - Exposing function GetImdbId for remote access
2018-10-14 18:50:30,217 (7f8a5f417740) :  DEBUG (messaging:69) - Exposing function GetTvdbId for remote access
2018-10-14 18:50:30,217 (7f8a5f417740) :  DEBUG (messaging:69) - Exposing function GetTvRageId for remote access
2018-10-14 18:50:30,217 (7f8a5f417740) :  DEBUG (messaging:69) - Exposing function GetTMDbSearchResults for remote access
2018-10-14 18:50:30,218 (7f8a5f417740) :  DEBUG (messaging:69) - Exposing function GetTMDbMetadata for remote access
2018-10-14 18:50:30,218 (7f8a5f417740) :  DEBUG (agentkit:1115) - Creating new agent class called TMDbAgent
2018-10-14 18:50:30,218 (7f8a5f417740) :  DEBUG (agentkit:933) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, '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'}]
2018-10-14 18:50:30,219 (7f8a5f417740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy50aGVtb3ZpZWRiczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzcjQKczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRuczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjFzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMTgKVGhlIE1vdmllIERhdGFiYXNlczQKbmFtZTEKczUKTW92aWUxCnMyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYTI2CnMyCmVuczIKY3NzMgpkYXMyCmRlczIKZWxzMgplc3MyCmZpczIKZnJzMgpoZXMyCmhyczIKaHVzMgppdHMyCmx2czIKbHRzMgpubHMyCm5vczIKcGxzMgpwdHMyCnJ1czIKc2tzMgpzdnMyCnRoczIKdHJzMgp2aXMyCnpoczIKa29yMAo_'
2018-10-14 18:50:30,224 (7f8a5f417740) :  DEBUG (agentkit:1115) - Creating new agent class called TMDbAgent
2018-10-14 18:50:30,225 (7f8a5f417740) :  DEBUG (agentkit:933) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, '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'], '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'}]
2018-10-14 18:50:30,225 (7f8a5f417740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy50aGVtb3ZpZWRiczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzcjQKczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRuczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjFzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMTgKVGhlIE1vdmllIERhdGFiYXNlczQKbmFtZTEKczUKTW92aWUxCnMyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYTI2CnMyCmVuczIKY3NzMgpkYXMyCmRlczIKZWxzMgplc3MyCmZpczIKZnJzMgpoZXMyCmhyczIKaHVzMgppdHMyCmx2czIKbHRzMgpubHMyCm5vczIKcGxzMgpwdHMyCnJ1czIKc2tzMgpzdnMyCnRoczIKdHJzMgp2aXMyCnpoczIKa28xMApyNwpzMTEKbWVkaWFfdHlwZXNyOApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI5CnMxNApjb250cmlidXRlc190b3I1CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczE4ClRoZSBNb3ZpZSBEYXRhYmFzZXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYXMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjEKczI2CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRicjAK'
2018-10-14 18:50:30,230 (7f8a5f417740) :  INFO (core:611) - Started plug-in
2018-10-14 18:50:30,230 (7f8a5f417740) :  DEBUG (socketinterface:160) - Starting socket server
2018-10-14 18:50:30,230 (7f8a5f417740) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-14 18:50:30,231 (7f8a5f417740) :  INFO (socketinterface:184) - Socket server started on port 44013
2018-10-14 18:50:30,231 (7f8a5f417740) :  INFO (pipeinterface:25) - Entering run loop
2018-10-14 18:50:30,231 (7f8a5f417740) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-10-14 18:50:30,232 (7f8a5f417740) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-10-14 18:50:30,232 (7f8a5f417740) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 154 bytes
2018-10-14 18:50:30,234 (7f8a50ff9700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU4CnMxNgpmMjAzNzcwMTg0MTlmZDAxczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczExClRoZSBTaGluaW5nczQKbmFtZXM0MAoxYmU0MjA4NDM5YWM1YjU2YWU1ZmRkOWNmYjkyZjY5ZmMwMWI4YTI4czgKcGxleEhhc2hzMTM4CiUyRmhvbWUlMkZmYXVyZSUyRkRhdGElMkZQbGV4JTJGUmFkYXJyJTJGVGhlJTIwU2hpbmluZyUyMCgxOTgwKSUyRlRoZSUyRVNoaW5pbmclMkUxOTgwJTJFVVMlMkVEQyUyRTEwODBwJTJFQmx1UmF5JTJFSDI2NCUyRUFBQy1SQVJCRyUyRW1wNHM4CmZpbGVuYW1lczYKYmx1cmF5czYKc291cmNlczQKMTk4MHM0CnllYXJzMgotMXM4CmR1cmF0aW9uczIKMTJzMgppZHIwCg__
2018-10-14 18:50:30,239 (7f8a50ff9700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU4CnMxNgpmMjAzNzcwMTg0MTlmZDAxczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczExClRoZSBTaGluaW5nczQKbmFtZXM0MAoxYmU0MjA4NDM5YWM1YjU2YWU1ZmRkOWNmYjkyZjY5ZmMwMWI4YTI4czgKcGxleEhhc2hzMTM4CiUyRmhvbWUlMkZmYXVyZSUyRkRhdGElMkZQbGV4JTJGUmFkYXJyJTJGVGhlJTIwU2hpbmluZyUyMCgxOTgwKSUyRlRoZSUyRVNoaW5pbmclMkUxOTgwJTJFVVMlMkVEQyUyRTEwODBwJTJFQmx1UmF5JTJFSDI2NCUyRUFBQy1SQVJCRyUyRW1wNHM4CmZpbGVuYW1lczYKYmx1cmF5czYKc291cmNlczQKMTk4MHM0CnllYXJzMgotMXM4CmR1cmF0aW9uczIKMTJzMgppZHIwCg__
2018-10-14 18:50:30,240 (7f8a50ff9700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'f20377018419fd01', 'name': 'The Shining', 'plexHash': '1be4208439ac5b56ae5fdd9cfb92f69fc01b8a28', 'filename': '%2Fhome%2Ffaure%2FData%2FPlex%2FRadarr%2FThe%20Shining%20(1980)%2FThe%2EShining%2E1980%2EUS%2EDC%2E1080p%2EBluRay%2EH264%2EAAC-RARBG%2Emp4', 'source': 'bluray', 'year': '1980', 'duration': '-1', 'id': '12'}
2018-10-14 18:50:30,240 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/12/tree'
2018-10-14 18:50:30,243 (7f8a50ff9700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-10-14 18:50:30,243 (7f8a50ff9700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.themoviedb
2018-10-14 18:50:30,244 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DThe%2BShining%26year%3D1980%26language%3Den%26include_adult%3Dfalse'
2018-10-14 18:50:45,593 (7f8a50ff9700) :  DEBUG (runtime:88) - Sending packed state data (110 bytes)
2018-10-14 18:50:45,593 (7f8a50ff9700) :  DEBUG (runtime:924) - Response: [200] str, 956 bytes
2018-10-14 18:50:45,616 (7f8a50ff9700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzMgoxMnM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMudGhlbW92aWVkYjovLzY5ND9sYW5nPWVuczQKZ3VpZHMzCjY5NHMyCmlkcjAK
2018-10-14 18:50:45,617 (7f8a50ff9700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzMgoxMnM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMudGhlbW92aWVkYjovLzY5ND9sYW5nPWVuczQKZ3VpZHMzCjY5NHMyCmlkcjAK
2018-10-14 18:50:45,618 (7f8a50ff9700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.themoviedb://694?lang=en
2018-10-14 18:50:45,626 (7f8a50ff9700) :  ERROR (model:205) - Cannot read model from /var/lib/plex/Plex Media Server/Metadata/Movies/4/920ebd8803e8bd118f1823b8cfbe137735928aa.bundle/Contents/com.plexapp.agents.themoviedb
2018-10-14 18:50:45,627 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/12/tree'
2018-10-14 18:50:45,630 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fconfiguration'
2018-10-14 18:51:05,649 (7f8a50ff9700) :  INFO (__init__:107) - Error fetching JSON from The Movie Database: http://127.0.0.1:32400/services/tmdb?uri=%2Fconfiguration
2018-10-14 18:51:05,650 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den'
2018-10-14 18:51:20,683 (7f8a50ff9700) :  ERROR (networking:219) - Error opening URL 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den'
2018-10-14 18:51:20,683 (7f8a50ff9700) :  INFO (__init__:107) - Error fetching JSON from The Movie Database: http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den
2018-10-14 18:51:20,684 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D'
2018-10-14 18:51:40,702 (7f8a50ff9700) :  INFO (__init__:107) - Error fetching JSON from The Movie Database: http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D
2018-10-14 18:51:40,703 (7f8a50ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%2Fimages'
2018-10-14 18:52:00,722 (7f8a50ff9700) :  INFO (__init__:107) - Error fetching JSON from The Movie Database: http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F694%2Fimages
2018-10-14 18:52:00,723 (7f8a50ff9700) :  INFO (__init__:568) - TMDb was unable to get any metadata for 694 (lang = en)
2018-10-14 18:52:00,723 (7f8a50ff9700) :  DEBUG (model:229) - Serializing to /var/lib/plex/Plex Media Server/Metadata/Movies/4/920ebd8803e8bd118f1823b8cfbe137735928aa.bundle/Contents/com.plexapp.agents.themoviedb/Info.xml
2018-10-14 18:52:00,724 (7f8a50ff9700) :  DEBUG (runtime:88) - Sending packed state data (110 bytes)
2018-10-14 18:52:00,724 (7f8a50ff9700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
