2018-07-28 23:01:02,726 (7f1d38f17700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 6fa5e50 (Tue Jul 24 06:22:23 UTC 2018)
2018-07-28 23:01:02,726 (7f1d38f17700) :  DEBUG (core:361) - Using the elevated policy
2018-07-28 23:01:02,727 (7f1d38f17700) :  DEBUG (core:450) - Starting runtime component.
2018-07-28 23:01:02,728 (7f1d38f17700) :  DEBUG (core:450) - Starting caching component.
2018-07-28 23:01:02,728 (7f1d38f17700) :  DEBUG (core:450) - Starting data component.
2018-07-28 23:01:02,729 (7f1d38f17700) :  DEBUG (core:450) - Starting networking component.
2018-07-28 23:01:02,746 (7f1d38f17700) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-07-28 23:01:02,768 (7f1d38f17700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-07-28 23:01:02,769 (7f1d38f17700) :  DEBUG (core:450) - Starting localization component.
2018-07-28 23:01:02,769 (7f1d38f17700) :  INFO (localization:409) - Setting the default locale to en-us
2018-07-28 23:01:02,770 (7f1d38f17700) :  DEBUG (core:450) - Starting messaging component.
2018-07-28 23:01:02,770 (7f1d38f17700) :  DEBUG (core:450) - Starting debugging component.
2018-07-28 23:01:02,771 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.imdb'
2018-07-28 23:01:02,771 (7f1d38f17700) :  DEBUG (core:450) - Starting services component.
2018-07-28 23:01:02,773 (7f1d38f17700) :  DEBUG (core:450) - Starting myplex component.
2018-07-28 23:01:02,773 (7f1d38f17700) :  DEBUG (core:450) - Starting notifications component.
2018-07-28 23:01:02,865 (7f1d38f17700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.imdb in namespace 'metadata'
2018-07-28 23:01:02,868 (7f1d38f17700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-07-28 23:01:02,878 (7f1d28ff9700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-07-28 23:01:02,878 (7f1d38f17700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-07-28 23:01:02,878 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-07-28 23:01:02,879 (7f1d38f17700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-07-28 23:01:02,880 (7f1d38f17700) :  DEBUG (core:150) - Finished starting framework core
2018-07-28 23:01:02,880 (7f1d077fe700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-07-28 23:01:02,880 (7f1d38f17700) :  DEBUG (core:560) - Loading plug-in code
2018-07-28 23:01:02,882 (7f1d077fe700) :  DEBUG (core:538) - Machine identifier is 0bcca5d21d6dbfbe4fef7536b55c7830f80b744e
2018-07-28 23:01:02,882 (7f1d077fe700) :  DEBUG (core:539) - Server version is 1.13.5.5291-6fa5e50a8
2018-07-28 23:01:03,159 (7f1d28ff9700) :  DEBUG (services:362) - Loaded services
2018-07-28 23:01:03,162 (7f1d07fff700) :  DEBUG (services:438) - No shared code to load
2018-07-28 23:01:03,232 (7f1d38f17700) :  DEBUG (core:566) - Finished loading plug-in code
2018-07-28 23:01:03,326 (7f1d38f17700) :  DEBUG (agentkit:1115) - Creating new agent class called PlexMovieAgent
2018-07-28 23:01:03,326 (7f1d38f17700) :  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-07-28 23:01:03,327 (7f1d38f17700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_'
2018-07-28 23:01:03,333 (7f1d38f17700) :  INFO (core:611) - Started plug-in
2018-07-28 23:01:03,333 (7f1d38f17700) :  DEBUG (socketinterface:160) - Starting socket server
2018-07-28 23:01:03,333 (7f1d38f17700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-07-28 23:01:03,333 (7f1d38f17700) :  INFO (socketinterface:184) - Socket server started on port 34477
2018-07-28 23:01:03,333 (7f1d38f17700) :  INFO (pipeinterface:25) - Entering run loop
2018-07-28 23:01:03,334 (7f1d38f17700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-07-28 23:01:03,334 (7f1d38f17700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-07-28 23:01:03,335 (7f1d38f17700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 148 bytes
2018-07-28 23:01:03,361 (7f1d28ff9700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpiMjVmMGM1N2NkMjA4ZTdiczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczE1CldhaXQgVW50aWwgRGFya3M0Cm5hbWVzNAoxOTY3czQKeWVhcnMxMTYKJTJGaG9tZSUyRmtldmluJTJGVmlkZW9zJTJGUGxleERWUiUyRkRWUiUyME1vdmllcyUyRldhaXQlMjBVbnRpbCUyMERhcmslMjAoMTk2NyklMkZXYWl0JTIwVW50aWwlMjBEYXJrJTIwKDE5NjcpJTJFdHNzOApmaWxlbmFtZXM0MAplZTkwNzdhMTcwNTI4Yzg5MjI5Zjg1MzU1ODhjMmM3NDZkYWExZDk4czgKcGxleEhhc2hzNwo3MzIwMDgzczgKZHVyYXRpb25zNQo2MDA1MHMyCmlkcjAK
2018-07-28 23:01:03,367 (7f1d28ff9700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjFzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1Ck1vdmllczEwCm1lZGlhX3R5cGU3CnMxNgpiMjVmMGM1N2NkMjA4ZTdiczE3Cm9wZW5TdWJ0aXRsZXNIYXNoczE1CldhaXQgVW50aWwgRGFya3M0Cm5hbWVzNAoxOTY3czQKeWVhcnMxMTYKJTJGaG9tZSUyRmtldmluJTJGVmlkZW9zJTJGUGxleERWUiUyRkRWUiUyME1vdmllcyUyRldhaXQlMjBVbnRpbCUyMERhcmslMjAoMTk2NyklMkZXYWl0JTIwVW50aWwlMjBEYXJrJTIwKDE5NjcpJTJFdHNzOApmaWxlbmFtZXM0MAplZTkwNzdhMTcwNTI4Yzg5MjI5Zjg1MzU1ODhjMmM3NDZkYWExZDk4czgKcGxleEhhc2hzNwo3MzIwMDgzczgKZHVyYXRpb25zNQo2MDA1MHMyCmlkcjAK
2018-07-28 23:01:03,368 (7f1d28ff9700) :  INFO (agentkit:957) - Searching for matches for {'openSubtitlesHash': 'b25f0c57cd208e7b', 'name': 'Wait Until Dark', 'year': '1967', 'filename': '%2Fhome%2Fkevin%2FVideos%2FPlexDVR%2FDVR%20Movies%2FWait%20Until%20Dark%20(1967)%2FWait%20Until%20Dark%20(1967)%2Ets', 'plexHash': 'ee9077a170528c89229f8535588c2c746daa1d98', 'duration': '7320083', 'id': '60050'}
2018-07-28 23:01:03,384 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/60050/tree'
2018-07-28 23:01:03,416 (7f1d28ff9700) :  INFO (__init__:138) - checking hash search vector: https://meta.plex.tv/movie/hash/ee/ee9077a170528c89229f8535588c2c746daa1d98.xml
2018-07-28 23:01:03,445 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/hash/ee/ee9077a170528c89229f8535588c2c746daa1d98.xml'
2018-07-28 23:01:03,879 (7f1d28ff9700) :  ERROR (networking:219) - Error opening URL 'https://meta.plex.tv/movie/hash/ee/ee9077a170528c89229f8535588c2c746daa1d98.xml'
2018-07-28 23:01:03,880 (7f1d28ff9700) :  INFO (__init__:165) - freebase/proxy hash lookup failed: HTTP Error 404: Not Found
2018-07-28 23:01:03,880 (7f1d28ff9700) :  INFO (__init__:169) - Scoring {}
2018-07-28 23:01:03,880 (7f1d28ff9700) :  INFO (__init__:438) - ---- HASH RESULTS MAP ----
2018-07-28 23:01:03,881 (7f1d28ff9700) :  INFO (__init__:439) - {}
2018-07-28 23:01:03,881 (7f1d28ff9700) :  INFO (__init__:138) - checking title/year search vector: https://meta.plex.tv/movie/guid/ac/aca08897d1b6617dfca748c45b47e33746518998.xml
2018-07-28 23:01:03,894 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/movie/guid/ac/aca08897d1b6617dfca748c45b47e33746518998.xml'
2018-07-28 23:01:04,095 (7f1d28ff9700) :  INFO (__init__:169) - Scoring {'tt0062467': [0, u'Wait Until Dark', u'1967', 99, 8914, 0]}
2018-07-28 23:01:04,096 (7f1d28ff9700) :  INFO (__init__:464) - ---- TITLE_YEAR RESULTS MAP ----
2018-07-28 23:01:04,096 (7f1d28ff9700) :  INFO (__init__:465) - {'tt0062467': [0, u'Wait Until Dark', u'1967', 99, 8914, 99]}
2018-07-28 23:01:04,097 (7f1d28ff9700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2018-07-28 23:01:04,143 (7f1d28ff9700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.imdb
2018-07-28 23:01:04,148 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0062467%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D'
2018-07-28 23:01:06,372 (7f1d28ff9700) :  INFO (__init__:473) - Adding title_year match: Wait Until Dark (1967) score=99, key=tt0062467
2018-07-28 23:01:06,372 (7f1d28ff9700) :  INFO (__init__:481) - Found perfect match with title/year query.
2018-07-28 23:01:06,373 (7f1d28ff9700) :  DEBUG (runtime:88) - Sending packed state data (580 bytes)
2018-07-28 23:01:06,373 (7f1d28ff9700) :  DEBUG (runtime:924) - Response: [200] str, 644 bytes
2018-07-28 23:01:06,743 (7f1d28ff9700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjBzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQo2MDA1MHM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYjovL3R0MDA2MjQ2Nz9sYW5nPWVuczQKZ3VpZHM5CnR0MDA2MjQ2N3MyCmlkcjAK
2018-07-28 23:01:06,744 (7f1d28ff9700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjBzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQo2MDA1MHM0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXM0Mwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYjovL3R0MDA2MjQ2Nz9sYW5nPWVuczQKZ3VpZHM5CnR0MDA2MjQ2N3MyCmlkcjAK
2018-07-28 23:01:06,744 (7f1d28ff9700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0062467?lang=en
2018-07-28 23:01:06,745 (7f1d28ff9700) :  ERROR (model:205) - Cannot read model from /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Movies/b/695460c7a90d7cf45d7d1dabfac4f87917850ff.bundle/Contents/com.plexapp.agents.imdb
2018-07-28 23:01:06,745 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/60050/tree'
2018-07-28 23:01:06,843 (7f1d28ff9700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fconfiguration' from the HTTP cache
2018-07-28 23:01:06,850 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0062467%3Fappend_to_response%3Dreleases%2Ccredits%26language%3Den'
2018-07-28 23:01:09,079 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0062467%2Fimages'
2018-07-28 23:01:11,285 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2F11206%2Frecommendations'
2018-07-28 23:01:13,520 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/7ZrDU5L2xp9LYRFi4rzBkf7jTZ0.jpg'
2018-07-28 23:01:13,650 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w300/7ZrDU5L2xp9LYRFi4rzBkf7jTZ0.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:13,654 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/8RymB9are5ew73oPccsweZkBXpR.jpg'
2018-07-28 23:01:13,792 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w300/8RymB9are5ew73oPccsweZkBXpR.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:13,796 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/vXYcUDIPZCfEyglzCvGdB63ATHR.jpg'
2018-07-28 23:01:13,902 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w300/vXYcUDIPZCfEyglzCvGdB63ATHR.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:13,906 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/wyDo3llhMKhEuEb99Ja1urmslAD.jpg'
2018-07-28 23:01:14,037 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w300/wyDo3llhMKhEuEb99Ja1urmslAD.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,040 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w300/8ZSXwhpybegsWhkkg6YaNgjusL5.jpg'
2018-07-28 23:01:14,149 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w300/8ZSXwhpybegsWhkkg6YaNgjusL5.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,168 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/cNW3ewCB52KkxzSE47PcE5Bqvmr.jpg'
2018-07-28 23:01:14,275 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/cNW3ewCB52KkxzSE47PcE5Bqvmr.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,279 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/aQkCZM8kxt1UDyOJHDeDSpgWxsE.jpg'
2018-07-28 23:01:14,390 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/aQkCZM8kxt1UDyOJHDeDSpgWxsE.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,393 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/x50qdMizJDdlUT6DaxxS6bp2fx2.jpg'
2018-07-28 23:01:14,503 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/x50qdMizJDdlUT6DaxxS6bp2fx2.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,519 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/y1hwrL7hoykVXI5O2KZR5HSaUG1.jpg'
2018-07-28 23:01:14,626 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/y1hwrL7hoykVXI5O2KZR5HSaUG1.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,629 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/a5vXyiXLzVXLsBuu5buPivwg5Q0.jpg'
2018-07-28 23:01:14,736 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/a5vXyiXLzVXLsBuu5buPivwg5Q0.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,754 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/20wEAq6YLvqkYCYR1SLwZRpda0Q.jpg'
2018-07-28 23:01:14,861 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/20wEAq6YLvqkYCYR1SLwZRpda0Q.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,865 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/1tjDjSGQIUozqZEtJ8aCxP9XGj1.jpg'
2018-07-28 23:01:14,972 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/1tjDjSGQIUozqZEtJ8aCxP9XGj1.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:14,995 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/tmO7zi065qe4s3jVAmdu0HJbQJj.jpg'
2018-07-28 23:01:15,103 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/tmO7zi065qe4s3jVAmdu0HJbQJj.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,106 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/a6SbOQOqcFMeostBDheCjUrTbPa.jpg'
2018-07-28 23:01:15,213 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/a6SbOQOqcFMeostBDheCjUrTbPa.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,217 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/doK42y5UPhtuDzj99ThSHUxCi0w.jpg'
2018-07-28 23:01:15,324 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/doK42y5UPhtuDzj99ThSHUxCi0w.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,328 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/2Cd6TUiusfDjjc05CbisYKFV8iZ.jpg'
2018-07-28 23:01:15,434 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/2Cd6TUiusfDjjc05CbisYKFV8iZ.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,438 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/1lu01xZ7ncAzpp4PRTsLtLAFMod.jpg'
2018-07-28 23:01:15,547 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/1lu01xZ7ncAzpp4PRTsLtLAFMod.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,551 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/d210E4qqPfDFM9HWN6x3DxW5LPC.jpg'
2018-07-28 23:01:15,655 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/d210E4qqPfDFM9HWN6x3DxW5LPC.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,659 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/m44YjHFnLkExI8fiCriJyMqkkpu.jpg'
2018-07-28 23:01:15,768 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/m44YjHFnLkExI8fiCriJyMqkkpu.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,772 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/cX6lz7pS9nGNli0NJpHysBdtv3D.jpg'
2018-07-28 23:01:15,878 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/cX6lz7pS9nGNli0NJpHysBdtv3D.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:15,900 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'http://image.tmdb.org/t/p/w154/eub7cNmcjwGOp70qZpXxCBQA95q.jpg'
2018-07-28 23:01:16,040 (7f1d28ff9700) :  DEBUG (networking:198) - Not caching 'http://image.tmdb.org/t/p/w154/eub7cNmcjwGOp70qZpXxCBQA95q.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2018-07-28 23:01:16,045 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'https://meta.plex.tv/m/0062467?lang=en&ratings=1&reviews=1&extras=1'
2018-07-28 23:01:16,247 (7f1d28ff9700) :  DEBUG (networking:161) - Fetching 'http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0062467%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D' from the HTTP cache
2018-07-28 23:01:16,258 (7f1d28ff9700) :  INFO (__init__:805) - Added 1 of 2 extras.
2018-07-28 23:01:16,273 (7f1d28ff9700) :  DEBUG (networking:166) - Requesting 'https://chapterdb.plex.tv/chapters/search?title=Wait%20Until%20Dark'
2018-07-28 23:01:16,482 (7f1d28ff9700) :  DEBUG (chapterdb:197) - Added 28 chapters.
2018-07-28 23:01:16,560 (7f1d28ff9700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(6270)?lang=en&bitrates=80,212,450,750,1500,8000&duration=154&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-07-28 23:01:16,560 (7f1d28ff9700) :  DEBUG (services:41) - Loading service code for IVA (URLServiceRecord)
2018-07-28 23:01:16,660 (7f1d28ff9700) :  DEBUG (services:41) - Loading service code for Fallback (URLServiceRecord)
2018-07-28 23:01:16,781 (7f1d28ff9700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(6270)?lang=en&bitrates=80,212,450,750,1500,8000&duration=154&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-07-28 23:01:16,782 (7f1d28ff9700) :  DEBUG (services:616) - Found a service matching 'iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(6270)?lang=en&bitrates=80,212,450,750,1500,8000&duration=154&adaptive=1&dts=0' - IVA (com.plexapp.agents.imdb)
2018-07-28 23:01:16,784 (7f1d28ff9700) :  DEBUG (model:229) - Serializing to /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Movies/b/695460c7a90d7cf45d7d1dabfac4f87917850ff.bundle/Contents/com.plexapp.agents.imdb/Info.xml
2018-07-28 23:01:16,785 (7f1d28ff9700) :  DEBUG (runtime:88) - Sending packed state data (1056 bytes)
2018-07-28 23:01:16,785 (7f1d28ff9700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
