2018-06-23 22:40:26,132 (7f1f30b0f700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: fd05be3 (Fri Jun 08 17:33:50 UTC 2018)
2018-06-23 22:40:26,133 (7f1f30b0f700) :  DEBUG (core:361) - Using the elevated policy
2018-06-23 22:40:26,134 (7f1f30b0f700) :  DEBUG (core:450) - Starting runtime component.
2018-06-23 22:40:26,137 (7f1f30b0f700) :  DEBUG (core:450) - Starting caching component.
2018-06-23 22:40:26,138 (7f1f30b0f700) :  DEBUG (core:450) - Starting data component.
2018-06-23 22:40:26,139 (7f1f30b0f700) :  DEBUG (core:450) - Starting networking component.
2018-06-23 22:40:26,140 (7f1f30b0f700) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-06-23 22:40:26,143 (7f1f30b0f700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-06-23 22:40:26,144 (7f1f30b0f700) :  DEBUG (core:450) - Starting localization component.
2018-06-23 22:40:26,145 (7f1f30b0f700) :  INFO (localization:409) - Setting the default locale to en-us
2018-06-23 22:40:26,145 (7f1f30b0f700) :  DEBUG (core:450) - Starting messaging component.
2018-06-23 22:40:26,147 (7f1f30b0f700) :  DEBUG (core:450) - Starting debugging component.
2018-06-23 22:40:26,147 (7f1f30b0f700) :  DEBUG (core:450) - Starting services component.
2018-06-23 22:40:26,148 (7f1f30b0f700) :  DEBUG (core:450) - Starting myplex component.
2018-06-23 22:40:26,149 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.imdb'
2018-06-23 22:40:26,149 (7f1f30b0f700) :  DEBUG (core:450) - Starting notifications component.
2018-06-23 22:40:26,513 (7f1f30b0f700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.imdb in namespace 'metadata'
2018-06-23 22:40:26,525 (7f1f30b0f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-06-23 22:40:26,618 (7f1f30b0f700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-06-23 22:40:26,619 (7f1f22e6b700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-06-23 22:40:26,621 (7f1f30b0f700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-06-23 22:40:26,623 (7f1f30b0f700) :  DEBUG (core:150) - Finished starting framework core
2018-06-23 22:40:26,623 (7f1f30b0f700) :  DEBUG (core:560) - Loading plug-in code
2018-06-23 22:40:26,624 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-06-23 22:40:26,714 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-06-23 22:40:26,726 (7f1f2280f700) :  DEBUG (core:538) - Machine identifier is 6aa2959cccfe8ea185a5501c6c5d15c2a6a61cde
2018-06-23 22:40:26,727 (7f1f2280f700) :  DEBUG (core:539) - Server version is 1.13.2.5154-fd05be322
2018-06-23 22:40:27,466 (7f1f22e6b700) :  DEBUG (services:362) - Loaded services
2018-06-23 22:40:27,549 (7f1f22afd700) :  DEBUG (services:438) - No shared code to load
2018-06-23 22:40:28,339 (7f1f30b0f700) :  DEBUG (core:566) - Finished loading plug-in code
2018-06-23 22:40:28,709 (7f1f30b0f700) :  DEBUG (agentkit:1115) - Creating new agent class called PlexMovieAgent
2018-06-23 22:40:28,712 (7f1f30b0f700) :  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'}]
2018-06-23 22:40:28,714 (7f1f30b0f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_'
2018-06-23 22:40:28,735 (7f1f30b0f700) :  INFO (core:611) - Started plug-in
2018-06-23 22:40:28,735 (7f1f30b0f700) :  DEBUG (socketinterface:160) - Starting socket server
2018-06-23 22:40:28,737 (7f1f30b0f700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-06-23 22:40:28,738 (7f1f30b0f700) :  INFO (socketinterface:184) - Socket server started on port 49124
2018-06-23 22:40:28,738 (7f1f30b0f700) :  INFO (pipeinterface:25) - Entering run loop
2018-06-23 22:40:28,739 (7f1f30b0f700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-06-23 22:40:28,743 (7f1f30b0f700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-06-23 22:40:28,744 (7f1f30b0f700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 148 bytes
2018-06-23 22:40:29,133 (7f1f22e6b700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/prefs
2018-06-23 22:40:29,168 (7f1f22e6b700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/prefs
2018-06-23 22:40:29,169 (7f1f22e6b700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-06-23 22:40:29,172 (7f1f22e6b700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.imdb
2018-06-23 22:40:29,186 (7f1f22e6b700) :  DEBUG (runtime:88) - Sending packed state data (104 bytes)
2018-06-23 22:40:29,186 (7f1f22e6b700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 2345 bytes
2018-06-23 22:40:40,923 (7f1f22e6b700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxNDI4ODNzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM1Ck1vdmllczEwCm1lZGlhX3R5cGVzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwNzUyMTM%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAwNzUyMTNzMgppZHIwCg__
2018-06-23 22:40:40,926 (7f1f22e6b700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxNDI4ODNzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM1Ck1vdmllczEwCm1lZGlhX3R5cGVzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwNzUyMTM@bGFuZz1lbnM0Cmd1aWRzOQp0dDAwNzUyMTNzMgppZHIwCg__
2018-06-23 22:40:40,928 (7f1f22e6b700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0075213?lang=en
2018-06-23 22:40:40,931 (7f1f22e6b700) :  ERROR (model:205) - Cannot read model from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Movies/f/7509a214a46bb5e765e015bde61e3b0260096c1.bundle/Contents/com.plexapp.agents.imdb
2018-06-23 22:40:40,932 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/142883/tree'
2018-06-23 22:40:40,950 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fconfiguration'
2018-06-23 22:40:43,193 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0075213%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den'
2018-06-23 22:40:45,304 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0075213%2Fimages'
2018-06-23 22:40:47,410 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F12584%2Frecommendations'
2018-06-23 22:40:50,463 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/bMZSThZbUuu6fz14IR22ERTL3p.jpg'
2018-06-23 22:41:10,520 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/jH95zPyPLBJfQSciQUNnxhbx7j8.jpg'
2018-06-23 22:41:25,318 (7f1f2280f700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IxczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpmYjE5ZTMxMTY3MDNjOWE1czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczEyClRoZSBTaG9vdGlzdHM0Cm5hbWVzNAoxOTc2czQKeWVhcnM3NAolMkZ2b2x1bWUxJTJGVmlkZW8lMkZNb3ZpZXMlMkZEVkQlMjBNb3ZpZXMlMkZUaGUlMjBTaG9vdGlzdCUyMCgxOTc2KSUyRW1rdnM4CmZpbGVuYW1lczQwCmFhMmM3MjBiYTUwNGRjMjVlNmFkNDM4NjA0ZWYyN2JhMzE1ZDA5OTVzOApwbGV4SGFzaHM3CjU5Mzg1MTBzOApkdXJhdGlvbnM2CjE0Mjg4M3MyCmlkcjAK
2018-06-23 22:41:25,321 (7f1f2280f700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IxczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpmYjE5ZTMxMTY3MDNjOWE1czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczEyClRoZSBTaG9vdGlzdHM0Cm5hbWVzNAoxOTc2czQKeWVhcnM3NAolMkZ2b2x1bWUxJTJGVmlkZW8lMkZNb3ZpZXMlMkZEVkQlMjBNb3ZpZXMlMkZUaGUlMjBTaG9vdGlzdCUyMCgxOTc2KSUyRW1rdnM4CmZpbGVuYW1lczQwCmFhMmM3MjBiYTUwNGRjMjVlNmFkNDM4NjA0ZWYyN2JhMzE1ZDA5OTVzOApwbGV4SGFzaHM3CjU5Mzg1MTBzOApkdXJhdGlvbnM2CjE0Mjg4M3MyCmlkcjAK
2018-06-23 22:41:25,322 (7f1f2280f700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'fb19e3116703c9a5', 'name': 'The Shootist', 'year': '1976', 'filename': '%2Fvolume1%2FVideo%2FMovies%2FDVD%20Movies%2FThe%20Shootist%20(1976)%2Emkv', 'plexHash': 'aa2c720ba504dc25e6ad438604ef27ba315d0995', 'duration': '5938510', 'id': '142883'}
2018-06-23 22:41:25,323 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/142883/tree'
2018-06-23 22:41:25,336 (7f1f2280f700) :  INFO (__init__:152) - checking hash search vector: https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml
2018-06-23 22:41:25,340 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml'
2018-06-23 22:41:25,478 (7f1f2280f700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml'
2018-06-23 22:41:25,478 (7f1f2280f700) :  INFO (__init__:179) - freebase/proxy hash lookup failed: HTTP Error 404: Not Found
2018-06-23 22:41:25,479 (7f1f2280f700) :  INFO (__init__:183) - Scoring {}
2018-06-23 22:41:25,480 (7f1f2280f700) :  INFO (__init__:454) - ---- HASH RESULTS MAP ----
2018-06-23 22:41:25,480 (7f1f2280f700) :  INFO (__init__:455) - {}
2018-06-23 22:41:25,482 (7f1f2280f700) :  INFO (__init__:152) - checking title/year search vector: https://meta.plex.tv/movie/guid/48/480fa3da393b60e3d30e6e03d098797cdfbd6a7d.xml
2018-06-23 22:41:25,485 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/guid/48/480fa3da393b60e3d30e6e03d098797cdfbd6a7d.xml'
2018-06-23 22:41:25,568 (7f1f2280f700) :  INFO (__init__:183) - Scoring {'tt0075213': [0, u'The Shootist', u'1976', 100, 11712, 0]}
2018-06-23 22:41:25,569 (7f1f2280f700) :  INFO (__init__:486) - ---- TITLE_YEAR RESULTS MAP ----
2018-06-23 22:41:25,569 (7f1f2280f700) :  INFO (__init__:487) - {'tt0075213': [0, u'The Shootist', u'1976', 100, 11712, 100]}
2018-06-23 22:41:25,572 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0075213%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D'
2018-06-23 22:41:27,907 (7f1f2280f700) :  INFO (__init__:495) - Adding title_year match: The Shootist (1976) score=100, key=tt0075213
2018-06-23 22:41:27,908 (7f1f2280f700) :  INFO (__init__:504) - Found perfect match with title/year query.
2018-06-23 22:41:27,909 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://metrics.plex.tv/collect/event'
2018-06-23 22:41:28,428 (7f1f2280f700) :  INFO (__init__:512) - ---- TMDb RESULTS MAP ----
2018-06-23 22:41:28,432 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DThe%2BShootist%26year%3D1976%26language%3Den%26include_adult%3Dfalse'
2018-06-23 22:41:30,564 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/zbpnjkfssa4upGZKruBc8FiiUDS.jpg'
2018-06-23 22:41:30,830 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.agents.themoviedb/messaging/function/TWVzc2FnZUtpdDpHZXRJbWRiSWQ_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzNQoxMjU4NHM3CnRtZGJfaWRyMAo_'
2018-06-23 22:41:36,755 (7f1f2280f700) :  INFO (__init__:306) - MetadataSearchResult(lang='en', thumb=None, score=90, year=1976, id='tt0075213', name='The Shootist')
2018-06-23 22:41:36,756 (7f1f2280f700) :  INFO (__init__:516) - ---- UMP RESULTS MAP ----
2018-06-23 22:41:36,760 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20Shootist&year=1976&plexHash=aa2c720ba504dc25e6ad438604ef27ba315d0995&lang=en&manual=1'
2018-06-23 22:41:37,135 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/sevwrHfjIGhRQMYrVt1c8VwYXLv.jpg', score=108, year=1976, id='tt0075213', name='The Shootist')
2018-06-23 22:41:37,136 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/vIfygAvR5FXISAscAFTHOMAqQeA.jpg', score=72, year=1976, id='tt0074811', name='The Tenant')
2018-06-23 22:41:37,137 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/o4X5KTSqAvelfw49Gx5BZDUEYCm.jpg', score=72, year=1976, id='tt0074720', name='The Toy')
2018-06-23 22:41:37,138 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/xtiu51bOYSCp6dKOEchUiOsibKq.jpg', score=70, year=1976, id='tt0074103', name='The Wing or the Thigh')
2018-06-23 22:41:37,139 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/4Xy69IdK1MPwZdudHpPHdcYbDr4.jpg', score=70, year=1976, id='tt0074540', name='The Food of the Gods')
2018-06-23 22:41:37,139 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/l1eUAsChRxoqaCpub9aBq2FV3d.jpg', score=70, year=1976, id='tt0074400', name='The Desert of the Tartars')
2018-06-23 22:41:37,140 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/hI7FQqa1wWCWBqOs800Wax0kl0j.jpg', score=68, year=1966, id='tt0062262', name='The Shooting')
2018-06-23 22:41:37,141 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/37EBRMPRpF49t2gDvr2ybXkVKYa.jpg', score=60, year=1975, id='tt0072443', name='Mirror')
2018-06-23 22:41:37,141 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/rYfnOaYYgAuoI8R0JiAV72jAESS.jpg', score=60, year=1975, id='tt0073580', name='The Passenger')
2018-06-23 22:41:37,142 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/yWIh8cMGd9XubkdhJB2TJ7buGy3.jpg', score=60, year=1975, id='tt0073092', name='Hard Times')
2018-06-23 22:41:37,142 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/yDprPzWBXhqpm1Z8X8kss55XOMe.jpg', score=60, year=1975, id='tt0072752', name='The Beast')
2018-06-23 22:41:37,143 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/bgoLAArIZlEqYK7ohrNAFyBMnBS.jpg', score=60, year=1975, id='tt0073008', name='The Fortune')
2018-06-23 22:41:37,144 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/wVwU0lKWKfL4jpw12rir5Csjb7d.jpg', score=55, year=1974, id='tt0071550', name='The Slap')
2018-06-23 22:41:37,144 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/ihujcNbfmPxE4yGHd2TIXzzjwsS.jpg', score=50, year=1972, id='tt0069197', name='The Call of the Wild')
2018-06-23 22:41:37,145 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/gb9eGNWZMUWTFUuji6maIVUNiVu.jpg', score=50, year=1973, id='tt0068772', name='Hunchback of the Morgue')
2018-06-23 22:41:37,150 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://api.cinematerial.com/1/request.json?imdb_id=tt0075213&key=plex&secret=ranzo1dL.SN8A&width=720&thumb_width=100.'
2018-06-23 22:41:38,704 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://api.cinematerial.com/1/request.json?imdb_id=tt0074720&key=plex&secret=raPdNwW./ZGC.&width=720&thumb_width=100.'
2018-06-23 22:41:40,253 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://api.cinematerial.com/1/request.json?imdb_id=tt0074811&key=plex&secret=raLvQV1D8d6yU&width=720&thumb_width=100.'
2018-06-23 22:41:41,808 (7f1f2280f700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2018-06-23 22:41:41,809 (7f1f2280f700) :  DEBUG (runtime:924) - Response: [200] str, 6488 bytes
2018-06-23 22:41:50,607 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/8wrbJLhdyfrFIAhqKNK3ZNjZa9I.jpg'
2018-06-23 22:42:10,667 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/kPNFzgdg4w6nrdr4Ra4HnWrT5dK.jpg'
2018-06-23 22:42:27,279 (7f1f2280f700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IxczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpmYjE5ZTMxMTY3MDNjOWE1czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczEyClRoZSBTaG9vdGlzdHM0Cm5hbWVzNAoxOTc2czQKeWVhcnM3NAolMkZ2b2x1bWUxJTJGVmlkZW8lMkZNb3ZpZXMlMkZEVkQlMjBNb3ZpZXMlMkZUaGUlMjBTaG9vdGlzdCUyMCgxOTc2KSUyRW1rdnM4CmZpbGVuYW1lczQwCmFhMmM3MjBiYTUwNGRjMjVlNmFkNDM4NjA0ZWYyN2JhMzE1ZDA5OTVzOApwbGV4SGFzaHM3CjU5Mzg1MTBzOApkdXJhdGlvbnM2CjE0Mjg4M3MyCmlkcjAK
2018-06-23 22:42:27,283 (7f1f2280f700) :  DEBUG (runtime:49) - Received packed state data (556 bytes)
2018-06-23 22:42:27,286 (7f1f2280f700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IxczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpmYjE5ZTMxMTY3MDNjOWE1czE3Cm9wZW5TdWJ0aXRsZXNIYXNoczEyClRoZSBTaG9vdGlzdHM0Cm5hbWVzNAoxOTc2czQKeWVhcnM3NAolMkZ2b2x1bWUxJTJGVmlkZW8lMkZNb3ZpZXMlMkZEVkQlMjBNb3ZpZXMlMkZUaGUlMjBTaG9vdGlzdCUyMCgxOTc2KSUyRW1rdnM4CmZpbGVuYW1lczQwCmFhMmM3MjBiYTUwNGRjMjVlNmFkNDM4NjA0ZWYyN2JhMzE1ZDA5OTVzOApwbGV4SGFzaHM3CjU5Mzg1MTBzOApkdXJhdGlvbnM2CjE0Mjg4M3MyCmlkcjAK
2018-06-23 22:42:27,287 (7f1f2280f700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'fb19e3116703c9a5', 'name': 'The Shootist', 'year': '1976', 'filename': '%2Fvolume1%2FVideo%2FMovies%2FDVD%20Movies%2FThe%20Shootist%20(1976)%2Emkv', 'plexHash': 'aa2c720ba504dc25e6ad438604ef27ba315d0995', 'duration': '5938510', 'id': '142883'}
2018-06-23 22:42:27,289 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/142883/tree'
2018-06-23 22:42:27,306 (7f1f2280f700) :  INFO (__init__:152) - checking hash search vector: https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml
2018-06-23 22:42:27,311 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml'
2018-06-23 22:42:27,365 (7f1f2280f700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/movie/hash/aa/aa2c720ba504dc25e6ad438604ef27ba315d0995.xml'
2018-06-23 22:42:27,365 (7f1f2280f700) :  INFO (__init__:179) - freebase/proxy hash lookup failed: HTTP Error 404: Not Found
2018-06-23 22:42:27,366 (7f1f2280f700) :  INFO (__init__:183) - Scoring {}
2018-06-23 22:42:27,367 (7f1f2280f700) :  INFO (__init__:454) - ---- HASH RESULTS MAP ----
2018-06-23 22:42:27,367 (7f1f2280f700) :  INFO (__init__:455) - {}
2018-06-23 22:42:27,368 (7f1f2280f700) :  INFO (__init__:152) - checking title/year search vector: https://meta.plex.tv/movie/guid/48/480fa3da393b60e3d30e6e03d098797cdfbd6a7d.xml
2018-06-23 22:42:27,374 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'https://meta.plex.tv/movie/guid/48/480fa3da393b60e3d30e6e03d098797cdfbd6a7d.xml' from the HTTP cache
2018-06-23 22:42:27,380 (7f1f2280f700) :  INFO (__init__:183) - Scoring {'tt0075213': [0, u'The Shootist', u'1976', 100, 11712, 0]}
2018-06-23 22:42:27,380 (7f1f2280f700) :  INFO (__init__:486) - ---- TITLE_YEAR RESULTS MAP ----
2018-06-23 22:42:27,381 (7f1f2280f700) :  INFO (__init__:487) - {'tt0075213': [0, u'The Shootist', u'1976', 100, 11712, 100]}
2018-06-23 22:42:27,387 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0075213%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D' from the HTTP cache
2018-06-23 22:42:27,394 (7f1f2280f700) :  INFO (__init__:495) - Adding title_year match: The Shootist (1976) score=100, key=tt0075213
2018-06-23 22:42:27,394 (7f1f2280f700) :  INFO (__init__:504) - Found perfect match with title/year query.
2018-06-23 22:42:27,396 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://metrics.plex.tv/collect/event'
2018-06-23 22:42:27,927 (7f1f2280f700) :  INFO (__init__:512) - ---- TMDb RESULTS MAP ----
2018-06-23 22:42:27,934 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DThe%2BShootist%26year%3D1976%26language%3Den%26include_adult%3Dfalse' from the HTTP cache
2018-06-23 22:42:27,941 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.agents.themoviedb/messaging/function/TWVzc2FnZUtpdDpHZXRJbWRiSWQ_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzNQoxMjU4NHM3CnRtZGJfaWRyMAo_'
2018-06-23 22:42:27,970 (7f1f2280f700) :  INFO (__init__:306) - MetadataSearchResult(lang='en', thumb=None, score=90, year=1976, id='tt0075213', name='The Shootist')
2018-06-23 22:42:27,970 (7f1f2280f700) :  INFO (__init__:516) - ---- UMP RESULTS MAP ----
2018-06-23 22:42:27,977 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/ump/matches?type=1&title=The%20Shootist&year=1976&plexHash=aa2c720ba504dc25e6ad438604ef27ba315d0995&lang=en&manual=1' from the HTTP cache
2018-06-23 22:42:27,984 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/sevwrHfjIGhRQMYrVt1c8VwYXLv.jpg', score=108, year=1976, id='tt0075213', name='The Shootist')
2018-06-23 22:42:27,985 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/vIfygAvR5FXISAscAFTHOMAqQeA.jpg', score=72, year=1976, id='tt0074811', name='The Tenant')
2018-06-23 22:42:27,986 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/o4X5KTSqAvelfw49Gx5BZDUEYCm.jpg', score=72, year=1976, id='tt0074720', name='The Toy')
2018-06-23 22:42:27,987 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/xtiu51bOYSCp6dKOEchUiOsibKq.jpg', score=70, year=1976, id='tt0074103', name='The Wing or the Thigh')
2018-06-23 22:42:27,988 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/4Xy69IdK1MPwZdudHpPHdcYbDr4.jpg', score=70, year=1976, id='tt0074540', name='The Food of the Gods')
2018-06-23 22:42:27,988 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/l1eUAsChRxoqaCpub9aBq2FV3d.jpg', score=70, year=1976, id='tt0074400', name='The Desert of the Tartars')
2018-06-23 22:42:27,989 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/hI7FQqa1wWCWBqOs800Wax0kl0j.jpg', score=68, year=1966, id='tt0062262', name='The Shooting')
2018-06-23 22:42:27,990 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/37EBRMPRpF49t2gDvr2ybXkVKYa.jpg', score=60, year=1975, id='tt0072443', name='Mirror')
2018-06-23 22:42:27,991 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/rYfnOaYYgAuoI8R0JiAV72jAESS.jpg', score=60, year=1975, id='tt0073580', name='The Passenger')
2018-06-23 22:42:27,992 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/yWIh8cMGd9XubkdhJB2TJ7buGy3.jpg', score=60, year=1975, id='tt0073092', name='Hard Times')
2018-06-23 22:42:27,992 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/yDprPzWBXhqpm1Z8X8kss55XOMe.jpg', score=60, year=1975, id='tt0072752', name='The Beast')
2018-06-23 22:42:27,993 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/bgoLAArIZlEqYK7ohrNAFyBMnBS.jpg', score=60, year=1975, id='tt0073008', name='The Fortune')
2018-06-23 22:42:27,994 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/wVwU0lKWKfL4jpw12rir5Csjb7d.jpg', score=55, year=1974, id='tt0071550', name='The Slap')
2018-06-23 22:42:27,995 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/ihujcNbfmPxE4yGHd2TIXzzjwsS.jpg', score=50, year=1972, id='tt0069197', name='The Call of the Wild')
2018-06-23 22:42:27,996 (7f1f2280f700) :  INFO (__init__:341) - MetadataSearchResult(lang='en', thumb='https://image.tmdb.org/t/p/w154/gb9eGNWZMUWTFUuji6maIVUNiVu.jpg', score=50, year=1973, id='tt0068772', name='Hunchback of the Morgue')
2018-06-23 22:42:28,005 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'https://api.cinematerial.com/1/request.json?imdb_id=tt0075213&key=plex&secret=ranzo1dL.SN8A&width=720&thumb_width=100.' from the HTTP cache
2018-06-23 22:42:28,019 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'https://api.cinematerial.com/1/request.json?imdb_id=tt0074720&key=plex&secret=raPdNwW./ZGC.&width=720&thumb_width=100.' from the HTTP cache
2018-06-23 22:42:28,033 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'https://api.cinematerial.com/1/request.json?imdb_id=tt0074811&key=plex&secret=raLvQV1D8d6yU&width=720&thumb_width=100.' from the HTTP cache
2018-06-23 22:42:28,045 (7f1f2280f700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2018-06-23 22:42:28,046 (7f1f2280f700) :  DEBUG (runtime:924) - Response: [200] str, 6488 bytes
2018-06-23 22:42:30,721 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/ysp0PigZ9uiTb9aE3K9yS62la5N.jpg'
2018-06-23 22:42:50,784 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/jCABRUksZjDmtrIrS2OqCd9hvlV.jpg'
2018-06-23 22:43:10,817 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/c6YBrhYLJvF7HoNiSeVkjkk0sW6.jpg'
2018-06-23 22:43:30,870 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/qKiWdhRiGvJsjoIpGiKV3s18Ak1.jpg'
2018-06-23 22:43:50,920 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/wVRazixGNuxL0PtA7sTGVRoS765.jpg'
2018-06-23 22:44:10,964 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/sevwrHfjIGhRQMYrVt1c8VwYXLv.jpg'
2018-06-23 22:44:31,011 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/bmVuPhTxNxWVfBa9pXl3OTRAj5V.jpg'
2018-06-23 22:44:51,058 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/tL4nWu3EZ16kLii4iTKir4AYg0C.jpg'
2018-06-23 22:45:11,091 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/rCo1nevgAUOB8cH6oOJSdTOqVf.jpg'
2018-06-23 22:45:31,137 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/uMDo8wXaniNiEPgDURGQny02jbg.jpg'
2018-06-23 22:45:51,191 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/qaCfapGNbfr7xYV3Im4r7NroaoO.jpg'
2018-06-23 22:46:11,248 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/pD6hAYUP2hlIjMfB44i1S5Lepcz.jpg'
2018-06-23 22:46:13,740 (7f1f2280f700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxNDI4NTVzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM1Ck1vdmllczEwCm1lZGlhX3R5cGVzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAxMTczMTg%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAxMTczMThzMgppZHIwCg__
2018-06-23 22:46:13,743 (7f1f2280f700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxNDI4NTVzNApkYmlkaTAKczcKdmVyc2lvbm5zMTAKcGFyZW50R1VJRG5zOApwYXJlbnRJRHM1Ck1vdmllczEwCm1lZGlhX3R5cGVzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAxMTczMTg@bGFuZz1lbnM0Cmd1aWRzOQp0dDAxMTczMThzMgppZHIwCg__
2018-06-23 22:46:13,745 (7f1f2280f700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0117318?lang=en
2018-06-23 22:46:13,747 (7f1f2280f700) :  ERROR (model:205) - Cannot read model from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Movies/9/589444ec8dce8ebb0180c9794088c0a5d59f2af.bundle/Contents/com.plexapp.agents.imdb
2018-06-23 22:46:13,749 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/142855/tree'
2018-06-23 22:46:13,768 (7f1f2280f700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fconfiguration' from the HTTP cache
2018-06-23 22:46:13,776 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0117318%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den'
2018-06-23 22:46:15,888 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0117318%2Fimages'
2018-06-23 22:46:17,993 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F1630%2Frecommendations'
2018-06-23 22:46:20,113 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/u4p68fTYXV7HyJuEbwYvZ8TNe3K.jpg'
2018-06-23 22:46:31,292 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/jFRDvIleui02VixNLo8NIj4ODVx.jpg'
2018-06-23 22:46:40,158 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/2jnGNLha2odeRspgsp2m4TkYc4c.jpg'
2018-06-23 22:46:51,335 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/7kqK1RArUftfXz0IMJo6lhGTLRR.jpg'
2018-06-23 22:47:00,201 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/l4v0LV93ZAYUv4DMcORMRRZ8VEJ.jpg'
2018-06-23 22:47:11,385 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/bIDv4Wp7vVrxBCty4MMHs6VwcXp.jpg'
2018-06-23 22:47:20,257 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/2ZmFzdx7O7mPfea2tzvDHlA9wU2.jpg'
2018-06-23 22:47:31,409 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/qT4s9M7QkN6dDYeRe9qoepQcRMY.jpg'
2018-06-23 22:47:40,283 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/buZxhz6TJdSHg4RcirERbKeUABl.jpg'
2018-06-23 22:47:51,458 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/9K4eDXp3mJnrvBcBRFszujqEP48.jpg'
2018-06-23 22:48:00,327 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/jFUvUhn1yZ8HlTEbWJXFWooY3Wl.jpg'
2018-06-23 22:48:11,516 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/m/0075213?lang=en&ratings=1&reviews=1&extras=1'
2018-06-23 22:48:11,591 (7f1f22e6b700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0075213%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D' from the HTTP cache
2018-06-23 22:48:11,603 (7f1f22e6b700) :  INFO (__init__:830) - Added 1 of 1 extras.
2018-06-23 22:48:11,610 (7f1f22e6b700) :  DEBUG (networking:166) - Requesting 'https://chapterdb.plex.tv/chapters/search?title=The%20Shootist'
2018-06-23 22:48:11,699 (7f1f22e6b700) :  DEBUG (chapterdb:197) - Added 13 chapters.
2018-06-23 22:48:11,743 (7f1f22e6b700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(1812)?lang=en&bitrates=80,212,450,750,1500,8000&duration=195&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:48:11,744 (7f1f22e6b700) :  DEBUG (services:41) - Loading service code for IVA (URLServiceRecord)
2018-06-23 22:48:11,824 (7f1f22e6b700) :  DEBUG (services:41) - Loading service code for Fallback (URLServiceRecord)
2018-06-23 22:48:12,137 (7f1f22e6b700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(1812)?lang=en&bitrates=80,212,450,750,1500,8000&duration=195&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:48:12,142 (7f1f22e6b700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(1812)?lang=en&bitrates=80,212,450,750,1500,8000&duration=195&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:48:12,151 (7f1f22e6b700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Movies/f/7509a214a46bb5e765e015bde61e3b0260096c1.bundle/Contents/com.plexapp.agents.imdb/Info.xml
2018-06-23 22:48:12,154 (7f1f22e6b700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2018-06-23 22:48:12,155 (7f1f22e6b700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-06-23 22:48:20,359 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/rngd0LYhHpaDZNtURnsYLWoyLHU.jpg'
2018-06-23 22:48:40,412 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/jobRi0dOQw4JYLMiRRSz3w1oUIt.jpg'
2018-06-23 22:49:00,467 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/mPPeSE0up9zSDpbcyd6BJfO8Wu0.jpg'
2018-06-23 22:49:20,509 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/padaRZg6E4RGJzqVVQ38FWkDJgl.jpg'
2018-06-23 22:49:40,571 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/c9nsTPAQvIakmwr6af2lJzgLJkO.jpg'
2018-06-23 22:50:00,614 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/nk2ODhMKBJRx3sWkZWfx5lrWbdj.jpg'
2018-06-23 22:50:20,644 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/e4MtP0e6wW4sKR9yC9prOdKSa58.jpg'
2018-06-23 22:50:40,687 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/4li1V6ZjEJzauCg3wZiiXa80Oug.jpg'
2018-06-23 22:51:00,839 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/brf2oCDMjcuzA2GxdpuVGwnG9Q7.jpg'
2018-06-23 22:51:20,900 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/6ellx9azXNsGjxMygN8dz1fNFiJ.jpg'
2018-06-23 22:51:40,943 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/y3HbQ8r5V1cyUfDSfIJteTlztqY.jpg'
2018-06-23 22:52:00,999 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/a6QnVqPsRlVggpgoedsoXohICsv.jpg'
2018-06-23 22:52:21,054 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/tCJcC714AHnRmsJgFXs4Pm1ZNue.jpg'
2018-06-23 22:52:41,093 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/486lJFtKZsSrEhNlDKOvqawSXOp.jpg'
2018-06-23 22:53:01,212 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/9F1eO4vH7yseGQEovIkXOm3Hrtq.jpg'
2018-06-23 22:53:21,268 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/2I7eqO9ABujjuH9zRynkj7OMJ9C.jpg'
2018-06-23 22:53:41,323 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/z8XsXh01OMDIdouJoWvVBYQqvIT.jpg'
2018-06-23 22:54:01,386 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/m/0117318?lang=en&ratings=1&reviews=1&extras=1'
2018-06-23 22:54:01,748 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0117318%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D'
2018-06-23 22:54:03,917 (7f1f2280f700) :  INFO (__init__:830) - Added 1 of 2 extras.
2018-06-23 22:54:03,927 (7f1f2280f700) :  DEBUG (networking:166) - Requesting 'https://chapterdb.plex.tv/chapters/search?title=The%20People%20vs.%20Larry%20Flynt'
2018-06-23 22:54:04,018 (7f1f2280f700) :  DEBUG (chapterdb:197) - Added 36 chapters.
2018-06-23 22:54:04,039 (7f1f2280f700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(302681)?lang=en&bitrates=80,212,450,750,1500,8000&duration=132&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:54:04,047 (7f1f2280f700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(302681)?lang=en&bitrates=80,212,450,750,1500,8000&duration=132&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:54:04,052 (7f1f2280f700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(302681)?lang=en&bitrates=80,212,450,750,1500,8000&duration=132&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-06-23 22:54:04,061 (7f1f2280f700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Movies/9/589444ec8dce8ebb0180c9794088c0a5d59f2af.bundle/Contents/com.plexapp.agents.imdb/Info.xml
2018-06-23 22:54:04,065 (7f1f2280f700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2018-06-23 22:54:04,065 (7f1f2280f700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
