2019-04-23 02:30:19,895 (7f605ed18700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: ad6e397 (Thu Apr 04 06:47:07 UTC 2019)
2019-04-23 02:30:19,895 (7f605ed18700) :  DEBUG (core:361) - Using the elevated policy
2019-04-23 02:30:19,896 (7f605ed18700) :  DEBUG (core:450) - Starting runtime component.
2019-04-23 02:30:19,899 (7f605ed18700) :  DEBUG (core:450) - Starting caching component.
2019-04-23 02:30:19,900 (7f605ed18700) :  DEBUG (core:450) - Starting data component.
2019-04-23 02:30:19,900 (7f605ed18700) :  DEBUG (core:450) - Starting networking component.
2019-04-23 02:30:19,901 (7f605ed18700) :  DEBUG (networking:284) - Loaded HTTP cookies
2019-04-23 02:30:19,937 (7f605ed18700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2019-04-23 02:30:19,939 (7f605ed18700) :  DEBUG (core:450) - Starting localization component.
2019-04-23 02:30:19,939 (7f605ed18700) :  INFO (localization:409) - Setting the default locale to en-us
2019-04-23 02:30:19,940 (7f605ed18700) :  DEBUG (core:450) - Starting messaging component.
2019-04-23 02:30:19,941 (7f605ed18700) :  DEBUG (core:450) - Starting debugging component.
2019-04-23 02:30:19,941 (7f605ed18700) :  DEBUG (core:450) - Starting services component.
2019-04-23 02:30:19,942 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.imdb'
2019-04-23 02:30:19,942 (7f605ed18700) :  DEBUG (core:450) - Starting myplex component.
2019-04-23 02:30:19,944 (7f605ed18700) :  DEBUG (core:450) - Starting notifications component.
2019-04-23 02:30:20,259 (7f605ed18700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.imdb in namespace 'metadata'
2019-04-23 02:30:20,270 (7f605ed18700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2019-04-23 02:30:20,299 (7f605506c700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2019-04-23 02:30:20,300 (7f605ed18700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2019-04-23 02:30:20,301 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2019-04-23 02:30:20,302 (7f605ed18700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2019-04-23 02:30:20,304 (7f6054950700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2019-04-23 02:30:20,305 (7f605ed18700) :  DEBUG (core:150) - Finished starting framework core
2019-04-23 02:30:20,308 (7f605ed18700) :  DEBUG (core:560) - Loading plug-in code
2019-04-23 02:30:20,315 (7f6054950700) :  DEBUG (core:538) - Machine identifier is 0527976522a83a79b0b9961b3b2e99b955460851
2019-04-23 02:30:20,315 (7f6054950700) :  DEBUG (core:539) - Server version is 1.15.3.876-ad6e39743
2019-04-23 02:30:21,467 (7f605ed18700) :  DEBUG (core:566) - Finished loading plug-in code
2019-04-23 02:30:21,755 (7f605506c700) :  DEBUG (services:362) - Loaded services
2019-04-23 02:30:21,826 (7f6054c3e700) :  DEBUG (services:438) - No shared code to load
2019-04-23 02:30:22,030 (7f605ed18700) :  DEBUG (agentkit:1115) - Creating new agent class called PlexMovieAgent
2019-04-23 02:30:22,033 (7f605ed18700) :  DEBUG (agentkit:933) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], '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, 'primary_provider': True, 'prefs': True, 'name': 'Plex Movie'}]
2019-04-23 02:30:22,034 (7f605ed18700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_'
2019-04-23 02:30:22,074 (7f605ed18700) :  INFO (core:611) - Started plug-in
2019-04-23 02:30:22,074 (7f605ed18700) :  DEBUG (socketinterface:160) - Starting socket server
2019-04-23 02:30:22,076 (7f605ed18700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2019-04-23 02:30:22,077 (7f605ed18700) :  INFO (socketinterface:184) - Socket server started on port 35646
2019-04-23 02:30:22,077 (7f605ed18700) :  INFO (pipeinterface:25) - Entering run loop
2019-04-23 02:30:22,077 (7f605ed18700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2019-04-23 02:30:22,081 (7f605ed18700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2019-04-23 02:30:22,082 (7f605ed18700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 148 bytes
2019-04-23 02:30:22,115 (7f605506c700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU2CnMxNgpmMDcyZWU1NWI3MjI3ZTRkczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIwClRoZSBGaXJzdCBQdXJnZSAyMDE4czQKbmFtZXM2MwolMkZ2b2x1bWUxJTJGdmlkZW8lMkZUaGUlMjBGaXJzdCUyMFB1cmdlJTIwLSUyMDIwMTglMkVVSEQlMkVta3ZzOApmaWxlbmFtZXM0MAplMjBmM2Y2NjA5ODEyOWEwMmVjMWRhODJhOTIwMTlmM2ZjZTNiNDhiczgKcGxleEhhc2hzMgotMXM4CmR1cmF0aW9uczUKMTc4MTlzMgppZHIwCg__
2019-04-23 02:30:22,117 (7f605506c700) :  DEBUG (runtime:49) - Received packed state data (556 bytes)
2019-04-23 02:30:22,145 (7f605506c700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU2CnMxNgpmMDcyZWU1NWI3MjI3ZTRkczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIwClRoZSBGaXJzdCBQdXJnZSAyMDE4czQKbmFtZXM2MwolMkZ2b2x1bWUxJTJGdmlkZW8lMkZUaGUlMjBGaXJzdCUyMFB1cmdlJTIwLSUyMDIwMTglMkVVSEQlMkVta3ZzOApmaWxlbmFtZXM0MAplMjBmM2Y2NjA5ODEyOWEwMmVjMWRhODJhOTIwMTlmM2ZjZTNiNDhiczgKcGxleEhhc2hzMgotMXM4CmR1cmF0aW9uczUKMTc4MTlzMgppZHIwCg__
2019-04-23 02:30:22,146 (7f605506c700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'f072ee55b7227e4d', 'name': 'The First Purge 2018', 'filename': '%2Fvolume1%2Fvideo%2FThe%20First%20Purge%20-%202018%2EUHD%2Emkv', 'plexHash': 'e20f3f66098129a02ec1da82a92019f3fce3b48b', 'duration': '-1', 'id': '17819'}
2019-04-23 02:30:22,177 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/17819/tree'
2019-04-23 02:30:22,248 (7f605506c700) :  INFO (__init__:138) - checking hash search vector: https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml
2019-04-23 02:30:22,255 (7f605506c700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml'
2019-04-23 02:30:22,439 (7f605506c700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml'
2019-04-23 02:30:22,440 (7f605506c700) :  INFO (__init__:165) - freebase/proxy hash lookup failed: HTTP Error 404: Not Found
2019-04-23 02:30:22,441 (7f605506c700) :  INFO (__init__:169) - Scoring {}
2019-04-23 02:30:22,441 (7f605506c700) :  INFO (__init__:438) - ---- HASH RESULTS MAP ----
2019-04-23 02:30:22,442 (7f605506c700) :  INFO (__init__:439) - {}
2019-04-23 02:30:22,444 (7f605506c700) :  INFO (__init__:138) - checking title/year search vector: https://meta.plex.tv/movie/guid/60/600c7b70821f6ae21fc927eb40e665de8e2b4099.xml
2019-04-23 02:30:22,486 (7f605506c700) :  DEBUG (networking:161) - Fetching 'https://meta.plex.tv/movie/guid/60/600c7b70821f6ae21fc927eb40e665de8e2b4099.xml' from the HTTP cache
2019-04-23 02:30:22,498 (7f605506c700) :  INFO (__init__:169) - Scoring {}
2019-04-23 02:30:22,499 (7f605506c700) :  INFO (__init__:464) - ---- TITLE_YEAR RESULTS MAP ----
2019-04-23 02:30:22,499 (7f605506c700) :  INFO (__init__:465) - {}
2019-04-23 02:30:22,500 (7f605506c700) :  INFO (__init__:487) - ---- TMDb RESULTS MAP ----
2019-04-23 02:30:22,530 (7f605506c700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2019-04-23 02:30:22,531 (7f605506c700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.imdb
2019-04-23 02:30:22,543 (7f605506c700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DThe%2BFirst%2BPurge%2B2018%26year%3D%26language%3Den%26include_adult%3Dfalse' from the HTTP cache
2019-04-23 02:30:22,553 (7f605506c700) :  INFO (__init__:491) - ---- UMP RESULTS MAP ----
2019-04-23 02:30:22,559 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20First%20Purge%202018&year=&plexHash=e20f3f66098129a02ec1da82a92019f3fce3b48b&lang=en&manual=0'
2019-04-23 02:30:29,568 (7f605506c700) :  ERROR (networking:219) - Error opening URL 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20First%20Purge%202018&year=&plexHash=e20f3f66098129a02ec1da82a92019f3fce3b48b&lang=en&manual=0'
2019-04-23 02:30:29,569 (7f605506c700) :  INFO (__init__:493) - Unable to get any results from UMP for The First Purge 2018, no worries...
2019-04-23 02:30:29,571 (7f605506c700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2019-04-23 02:30:29,571 (7f605506c700) :  DEBUG (runtime:924) - Response: [200] str, 320 bytes
2019-04-23 02:30:29,651 (7f605506c700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU2CnMxNgpmMDcyZWU1NWI3MjI3ZTRkczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIwClRoZSBGaXJzdCBQdXJnZSAyMDE4czQKbmFtZXM2MwolMkZ2b2x1bWUxJTJGdmlkZW8lMkZUaGUlMjBGaXJzdCUyMFB1cmdlJTIwLSUyMDIwMTglMkVVSEQlMkVta3ZzOApmaWxlbmFtZXM0MAplMjBmM2Y2NjA5ODEyOWEwMmVjMWRhODJhOTIwMTlmM2ZjZTNiNDhiczgKcGxleEhhc2hzMgotMXM4CmR1cmF0aW9uczUKMTc4MTlzMgppZHIwCg__
2019-04-23 02:30:29,653 (7f605506c700) :  DEBUG (runtime:49) - Received packed state data (556 bytes)
2019-04-23 02:30:29,655 (7f605506c700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU2CnMxNgpmMDcyZWU1NWI3MjI3ZTRkczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczIwClRoZSBGaXJzdCBQdXJnZSAyMDE4czQKbmFtZXM2MwolMkZ2b2x1bWUxJTJGdmlkZW8lMkZUaGUlMjBGaXJzdCUyMFB1cmdlJTIwLSUyMDIwMTglMkVVSEQlMkVta3ZzOApmaWxlbmFtZXM0MAplMjBmM2Y2NjA5ODEyOWEwMmVjMWRhODJhOTIwMTlmM2ZjZTNiNDhiczgKcGxleEhhc2hzMgotMXM4CmR1cmF0aW9uczUKMTc4MTlzMgppZHIwCg__
2019-04-23 02:30:29,656 (7f605506c700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'f072ee55b7227e4d', 'name': 'The First Purge 2018', 'filename': '%2Fvolume1%2Fvideo%2FThe%20First%20Purge%20-%202018%2EUHD%2Emkv', 'plexHash': 'e20f3f66098129a02ec1da82a92019f3fce3b48b', 'duration': '-1', 'id': '17819'}
2019-04-23 02:30:29,656 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/17819/tree'
2019-04-23 02:30:29,664 (7f605506c700) :  INFO (__init__:138) - checking hash search vector: https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml
2019-04-23 02:30:29,670 (7f605506c700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml'
2019-04-23 02:30:29,753 (7f605506c700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/movie/hash/e2/e20f3f66098129a02ec1da82a92019f3fce3b48b.xml'
2019-04-23 02:30:29,753 (7f605506c700) :  INFO (__init__:165) - freebase/proxy hash lookup failed: HTTP Error 404: Not Found
2019-04-23 02:30:29,754 (7f605506c700) :  INFO (__init__:169) - Scoring {}
2019-04-23 02:30:29,754 (7f605506c700) :  INFO (__init__:438) - ---- HASH RESULTS MAP ----
2019-04-23 02:30:29,754 (7f605506c700) :  INFO (__init__:439) - {}
2019-04-23 02:30:29,755 (7f605506c700) :  INFO (__init__:138) - checking title/year search vector: https://meta.plex.tv/movie/guid/60/600c7b70821f6ae21fc927eb40e665de8e2b4099.xml
2019-04-23 02:30:29,765 (7f605506c700) :  DEBUG (networking:161) - Fetching 'https://meta.plex.tv/movie/guid/60/600c7b70821f6ae21fc927eb40e665de8e2b4099.xml' from the HTTP cache
2019-04-23 02:30:29,775 (7f605506c700) :  INFO (__init__:169) - Scoring {}
2019-04-23 02:30:29,776 (7f605506c700) :  INFO (__init__:464) - ---- TITLE_YEAR RESULTS MAP ----
2019-04-23 02:30:29,776 (7f605506c700) :  INFO (__init__:465) - {}
2019-04-23 02:30:29,776 (7f605506c700) :  INFO (__init__:487) - ---- TMDb RESULTS MAP ----
2019-04-23 02:30:29,787 (7f605506c700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DThe%2BFirst%2BPurge%2B2018%26year%3D%26language%3Den%26include_adult%3Dfalse' from the HTTP cache
2019-04-23 02:30:29,797 (7f605506c700) :  INFO (__init__:491) - ---- UMP RESULTS MAP ----
2019-04-23 02:30:29,803 (7f605506c700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20First%20Purge%202018&year=&plexHash=e20f3f66098129a02ec1da82a92019f3fce3b48b&lang=en&manual=0'
2019-04-23 02:30:36,813 (7f605506c700) :  ERROR (networking:219) - Error opening URL 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20First%20Purge%202018&year=&plexHash=e20f3f66098129a02ec1da82a92019f3fce3b48b&lang=en&manual=0'
2019-04-23 02:30:36,813 (7f605506c700) :  INFO (__init__:493) - Unable to get any results from UMP for The First Purge 2018, no worries...
2019-04-23 02:30:36,815 (7f605506c700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2019-04-23 02:30:36,816 (7f605506c700) :  DEBUG (runtime:924) - Response: [200] str, 320 bytes
