I'm wondering if anyone can please help me, I can't seem to work this one out. I appear to be experiencing an issue similar to the one posted in this thread, however I have tried all of the solutions listed in there along with all of the others I can find searching back through the forums.
A few weeks back my posters, banners, and backgrounds stopped updating. The rest of the metadata is still being populated without issue. Now I appreciate that a couple of the cases may be due to file naming, but I have also modified several of the file names to exactly match the suggested naming conventions and they still fail. With that said, as the rest of the metadata is still being successfully populated and the "Fix Incorrect Match" option correctly identifies the films, so I do not believe naming to be the issue. In addition to this I have done the following:
- Added exceptions to my anti-virus for the Plex default installation location (C:\Users\\AppData\Local\).
- I had then also read in an old thread that there were occasionally issues in multi-user setups with having Plex installed to the AppData folder, so to ensure this was not the case I have moved the Plex installation folder to the root of C:\ (C:\Plex Media Server\) and then updated the location in the PlexWeb settings. With this said, this is a single user system, and Plex is running under an administrative account. I then added anti-virus exceptions for this location too.
- I have tried completely disabling my anti-virus to ensure it was not the cause of the issues (I'm using Avira).
- I have also set "Everyone" permissions to "Full Control" on the C:\Plex Media Server\ folder and all sub-folders, to ensure this was not permissions-related.
- I have added Plex (and all local addresses like 127.0.0.1 etc) to my Adblock Plus whitelist.
- In another old thread I had read of issues involving Plex Media Server or the plug-ins having issues updating files within the Plex Media Server folder due to files incorrectly being set Read Only. As such I have removed the Read Only properties from all files and folders within (and including) the Plex Media Server folder.
- As I suspect the issue lies with the TVDB and / or The Movie Database plug-ins, I tried downloading a previous version of each metadata agent from GitHub from a release date prior to when the issue occurred and overwriting the agents in the folders to see if it made a difference. It didn't, and I think the agents automatically updated themselves again anyway, so I reverted back and removed the versions I had downloaded.
- Forced refreshes of the library were completed after most of the above changes to ensure all metadata was being re-checked. It did, successfully, but still failed to pull the posters, banners, and backgrounds down.
At this point I'm really struggling for ideas. I really don't want to do a clean install as I've got over 1,000 films, many of which have custom metadata and sort orders configured on them, and without knowing the cause it could lead to it all happening again at some point. Below are the latest logs from the TVDB and Movie Database plug-ins. Any help would be greatly appreciated:
TVDB:
Note: As this is the plug-in of the two which is failing to display any URLs for images I believe this may be the faulty one.
[spoiler]2014-06-07 12:48:40,644 (1130) : INFO (core:336) - Starting framework core - Version: 2.3.17, Build: 279a6af (Tue Mar 4 18:48:47 UTC 2014)
2014-06-07 12:48:40,644 (1130) : DEBUG (core:348) - Using the standard policy
2014-06-07 12:48:40,644 (1130) : DEBUG (core:437) - Starting runtime component.
2014-06-07 12:48:40,650 (1130) : DEBUG (core:437) - Starting caching component.
2014-06-07 12:48:40,651 (1130) : DEBUG (core:437) - Starting data component.
2014-06-07 12:48:40,651 (1130) : DEBUG (core:437) - Starting networking component.
2014-06-07 12:48:40,651 (1130) : DEBUG (networking:322) - Loaded HTTP cookies
2014-06-07 12:48:40,688 (1130) : DEBUG (networking:508) - Setting the default network timeout to 20.0
2014-06-07 12:48:40,690 (1130) : DEBUG (core:437) - Starting localization component.
2014-06-07 12:48:40,690 (1130) : INFO (localization:408) - Setting the default locale to en-us
2014-06-07 12:48:40,691 (1130) : DEBUG (core:437) - Starting messaging component.
2014-06-07 12:48:40,693 (1130) : DEBUG (core:437) - Starting debugging component.
2014-06-07 12:48:40,694 (1130) : DEBUG (core:437) - Starting services component.
2014-06-07 12:48:40,694 (c3c) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.themoviedb'
2014-06-07 12:48:40,694 (1130) : DEBUG (core:437) - Starting myplex component.
2014-06-07 12:48:40,697 (1130) : DEBUG (core:437) - Starting notifications component.
2014-06-07 12:48:40,867 (1130) : DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.themoviedb in namespace 'metadata'
2014-06-07 12:48:40,875 (1130) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2014-06-07 12:48:40,911 (3f4) : DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2014-06-07 12:48:40,911 (1130) : DEBUG (runtime:1111) - Created a thread named 'load_all_services'
2014-06-07 12:48:40,915 (3f4) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2014-06-07 12:48:40,915 (1130) : DEBUG (runtime:1111) - Created a thread named 'get_server_info'
2014-06-07 12:48:40,917 (d2c) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400'
2014-06-07 12:48:40,920 (1130) : DEBUG (core:149) - Finished starting framework core
2014-06-07 12:48:40,924 (1130) : DEBUG (core:547) - Loading plug-in code
2014-06-07 12:48:40,936 (d2c) : DEBUG (core:525) - Machine identifier is 83e3a8a185653c86fd2ce5b9e2096dfc2d84ad30
2014-06-07 12:48:40,937 (d2c) : DEBUG (core:526) - Server version is 0.9.9.7.429-f80a8d6
2014-06-07 12:48:41,619 (1130) : DEBUG (core:553) - Finished loading plug-in code
2014-06-07 12:48:41,621 (1130) : DEBUG (messaging:69) - Exposing function GetImdbId for remote access
2014-06-07 12:48:41,624 (1130) : DEBUG (agentkit:1011) - Creating new agent class called TMDbAgent
2014-06-07 12:48:41,631 (1130) : DEBUG (agentkit:891) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'languages': ['en', 'cs', 'da', 'de', 'el', 'es', 'fi', 'fr', 'he', 'hr', 'hu', 'it', 'lv', 'nl', 'no', 'pl', 'pt', 'ru', 'sk', 'sv', 'th', 'tr', 'vi', 'zh'], 'persist_stored_files': True, 'primary_provider': True, 'prefs': True, 'name': 'The Movie Database'}]
2014-06-07 12:48:41,654 (1130) : INFO (core:598) - Started plug-in
2014-06-07 12:48:41,654 (1130) : DEBUG (socketinterface:160) - Starting socket server
2014-06-07 12:48:41,657 (1130) : DEBUG (runtime:1111) - Created a thread named 'start'
2014-06-07 12:48:41,660 (1130) : INFO (socketinterface:184) - Socket server started on port 59652
2014-06-07 12:48:41,661 (1130) : INFO (pipeinterface:25) - Entering run loop
2014-06-07 12:48:41,663 (1130) : DEBUG (runtime:717) - Handling request GET /:/prefixes
2014-06-07 12:48:41,671 (1130) : DEBUG (runtime:814) - Found route matching /:/prefixes
2014-06-07 12:48:41,671 (1130) : DEBUG (runtime:918) - Response: [200] MediaContainer, 154 bytes
2014-06-07 12:48:41,681 (3f4) : DEBUG (services:362) - Loaded services
2014-06-07 12:48:41,687 (12d8) : DEBUG (services:438) - No shared code to load
2014-06-07 12:48:41,700 (8f4) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczcKczE2CjVmY2E3ZmQxN2YxNzU3ZjJzMTcKb3BlblN1YnRpdGxlc0hhc2hzMjAKRnJvbSBQYXJpcyBXaXRoIExvdmVzNApuYW1lczQKMjAxMHM0CnllYXJzMTA5CkUlM0ElNUNWaWRlb3MlNUNGcm9tJTIwUGFyaXMlMjBXaXRoJTIwTG92ZSUyMCgyMDEwKSUyMFs3MjBwXSU1Q0Zyb20lMkVQYXJpcyUyRVdpdGglMkVMb3ZlJTJFMjAxMCUyRTcyMHAlMkVta3ZzOApmaWxlbmFtZXM0MAo4YzE4Y2Q1NGFhNDlhZWNkODVhYmVjMzVlNThmYjdkODY4ZjY3ZmJjczgKcGxleEhhc2hzNwo1MzA5NjExczgKZHVyYXRpb25zMwo3NjVzMgppZHIwCg__
2014-06-07 12:48:41,721 (8f4) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczcKczE2CjVmY2E3ZmQxN2YxNzU3ZjJzMTcKb3BlblN1YnRpdGxlc0hhc2hzMjAKRnJvbSBQYXJpcyBXaXRoIExvdmVzNApuYW1lczQKMjAxMHM0CnllYXJzMTA5CkUlM0ElNUNWaWRlb3MlNUNGcm9tJTIwUGFyaXMlMjBXaXRoJTIwTG92ZSUyMCgyMDEwKSUyMFs3MjBwXSU1Q0Zyb20lMkVQYXJpcyUyRVdpdGglMkVMb3ZlJTJFMjAxMCUyRTcyMHAlMkVta3ZzOApmaWxlbmFtZXM0MAo4YzE4Y2Q1NGFhNDlhZWNkODVhYmVjMzVlNThmYjdkODY4ZjY3ZmJjczgKcGxleEhhc2hzNwo1MzA5NjExczgKZHVyYXRpb25zMwo3NjVzMgppZHIwCg__
2014-06-07 12:48:41,721 (8f4) : INFO (agentkit:915) - Searching for matches for {'openSubtitlesHash': '5fca7fd17f1757f2', 'name': 'From Paris With Love', 'year': '2010', 'filename': 'E%3A%5CVideos%5CFrom%20Paris%20With%20Love%20(2010)%20[720p]%5CFrom%2EParis%2EWith%2ELove%2E2010%2E720p%2Emkv', 'plexHash': '8c18cd54aa49aecd85abec35e58fb7d868f67fbc', 'duration': '5309611', 'id': '765'}
2014-06-07 12:48:41,723 (8f4) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/765/tree'
2014-06-07 12:48:41,733 (8f4) : DEBUG (preferences:256) - Loaded preferences from DefaultPrefs.json
2014-06-07 12:48:41,733 (8f4) : DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.themoviedb
2014-06-07 12:48:41,766 (8f4) : DEBUG (networking:172) - Requesting 'https://api.tmdb.org/3/search/movie?api_key=a3dc111e66105f6387e99393813ae4d5&query=From%20Paris%20With%20Love&year=2010&language=en&include_adult=true'
2014-06-07 12:48:45,165 (8f4) : DEBUG (runtime:918) - Response: [200] str, 644 bytes
2014-06-07 12:48:48,221 (d80) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjc2NXM0CmRiaWRzNDUKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGI6Ly8yNjM4OT9sYW5nPWVuczQKZ3VpZHM1CjI2Mzg5czIKaWRyMAo_
2014-06-07 12:48:48,223 (d80) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjc2NXM0CmRiaWRzNDUKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGI6Ly8yNjM4OT9sYW5nPWVuczQKZ3VpZHM1CjI2Mzg5czIKaWRyMAo_
2014-06-07 12:48:48,224 (d80) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.themoviedb://26389?lang=en
2014-06-07 12:48:48,227 (d80) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\f\5b4cce5eae515d2d04aef599152f6e55ab7f993.bundle\Contents\com.plexapp.agents.themoviedb\Info.xml
2014-06-07 12:48:48,240 (d80) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/765/tree'
2014-06-07 12:48:48,311 (d80) : DEBUG (networking:167) - Fetching 'https://api.tmdb.org/3/movie/26389?api_key=a3dc111e66105f6387e99393813ae4d5&append_to_response=releases,credits&language=en' from the HTTP cache
2014-06-07 12:48:48,470 (d80) : DEBUG (networking:167) - Fetching 'https://api.tmdb.org/3/movie/26389/images?api_key=a3dc111e66105f6387e99393813ae4d5' from the HTTP cache
2014-06-07 12:48:48,592 (d80) : INFO (logkit:16) - Error fetching JSON from The Movie Database.
2014-06-07 12:48:48,594 (d80) : CRITICAL (core:561) - Exception in the update function of agent named 'The Movie Database', called with guid 'com.plexapp.agents.themoviedb://26389?lang=en' (most recent call last):
File "C:\Plex Media Server\Plug-ins\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\agentkit.py", line 972, in _update
agent.update(obj, media, lang)
File "C:\Plex Media Server\Plug-ins\The-Movie-Database.bundle\Contents\Code\__init__.py", line 349, in update
except: pass
File "C:\Plex Media Server\Plug-ins\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\code\sandbox.py", line 111, in
_getitem_ = lambda x, y: x.__getitem__(y),
AttributeError: 'NoneType' object has no attribute '__getitem__'
2014-06-07 12:48:48,596 (d80) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\f\5b4cce5eae515d2d04aef599152f6e55ab7f993.bundle\Contents\com.plexapp.agents.themoviedb\Info.xml
2014-06-07 12:48:48,601 (d80) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 12:49:16,275 (a04) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjc2NXM0CmRiaWRzNDUKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGI6Ly8yNjM4OT9sYW5nPWVuczQKZ3VpZHM1CjI2Mzg5czIKaWRyMAo_
2014-06-07 12:49:16,276 (a04) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.themoviedb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjc2NXM0CmRiaWRzNDUKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGI6Ly8yNjM4OT9sYW5nPWVuczQKZ3VpZHM1CjI2Mzg5czIKaWRyMAo_
2014-06-07 12:49:16,276 (a04) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.themoviedb://26389?lang=en
2014-06-07 12:49:16,278 (a04) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\f\5b4cce5eae515d2d04aef599152f6e55ab7f993.bundle\Contents\com.plexapp.agents.themoviedb\Info.xml
2014-06-07 12:49:16,280 (a04) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/765/tree'
2014-06-07 12:49:16,349 (a04) : DEBUG (networking:167) - Fetching 'https://api.tmdb.org/3/movie/26389?api_key=a3dc111e66105f6387e99393813ae4d5&append_to_response=releases,credits&language=en' from the HTTP cache
2014-06-07 12:49:16,489 (a04) : DEBUG (networking:167) - Fetching 'https://api.tmdb.org/3/movie/26389/images?api_key=a3dc111e66105f6387e99393813ae4d5' from the HTTP cache
2014-06-07 12:49:16,595 (a04) : INFO (logkit:16) - Error fetching JSON from The Movie Database.
2014-06-07 12:49:16,596 (a04) : CRITICAL (core:561) - Exception in the update function of agent named 'The Movie Database', called with guid 'com.plexapp.agents.themoviedb://26389?lang=en' (most recent call last):
File "C:\Plex Media Server\Plug-ins\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\api\agentkit.py", line 972, in _update
agent.update(obj, media, lang)
File "C:\Plex Media Server\Plug-ins\The-Movie-Database.bundle\Contents\Code\__init__.py", line 349, in update
except: pass
File "C:\Plex Media Server\Plug-ins\Framework.bundle\Contents\Resources\Versions\2\Python\Framework\code\sandbox.py", line 111, in
_getitem_ = lambda x, y: x.__getitem__(y),
AttributeError: 'NoneType' object has no attribute '__getitem__'
2014-06-07 12:49:16,598 (a04) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\f\5b4cce5eae515d2d04aef599152f6e55ab7f993.bundle\Contents\com.plexapp.agents.themoviedb\Info.xml
2014-06-07 12:49:16,605 (a04) : DEBUG (runtime:918) - Response: [200] str, 16 bytes[/spoiler]
The Movie Poster Database:
Note: This plug-in is showing URLs in the logs for poster images, which I have manually put in to the browser and they are accessible / not blocked. With that said, it doesn't appear to be pulling any images for films which are missing posters, only for films which already have posters and were working prior to the issues occurring.
[spoiler]2014-06-07 10:32:56,943 (c3c) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:32:56,963 (3b0) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxN3M0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDEzODkxMzc%40bGFuZz1lbnM0Cmd1aWRzOQp0dDEzODkxMzdzMgppZHIwCg__
2014-06-07 10:32:56,964 (3b0) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxN3M0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDEzODkxMzc@bGFuZz1lbnM0Cmd1aWRzOQp0dDEzODkxMzdzMgppZHIwCg__
2014-06-07 10:32:56,966 (3b0) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt1389137?lang=en
2014-06-07 10:32:56,966 (3b0) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\7\7ff44b59946fc758fe3d39b37db113e9e0efaec.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:32:56,967 (3b0) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/617/tree'
2014-06-07 10:32:57,002 (3b0) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=1389137&api_key=p13x2&secret=a2f59631d135&width=720&thumb_width=100'
2014-06-07 10:32:57,500 (d78) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMzk2MjY5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:32:57,503 (d78) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMzk2MjY5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:32:57,503 (d78) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt0396269?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:32:57,503 (d78) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0396269?lang=en
2014-06-07 10:32:57,503 (d78) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\4\b08c8d45f3725d2b548e6f46c63e3a648e95449.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:32:57,526 (d78) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:32:57,536 (13dc) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxOHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAzOTYyNjk%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAzOTYyNjlzMgppZHIwCg__
2014-06-07 10:32:57,538 (13dc) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxOHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAzOTYyNjk@bGFuZz1lbnM0Cmd1aWRzOQp0dDAzOTYyNjlzMgppZHIwCg__
2014-06-07 10:32:57,539 (13dc) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0396269?lang=en
2014-06-07 10:32:57,539 (13dc) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\4\b08c8d45f3725d2b548e6f46c63e3a648e95449.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:32:57,540 (13dc) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/618/tree'
2014-06-07 10:32:57,575 (13dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=396269&api_key=p13x2&secret=e0998a759c10&width=720&thumb_width=100'
2014-06-07 10:32:58,325 (3b0) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,326 (3b0) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/37/1389137/593006_720.jpg?api_key=p13x2&secret=a2f59631d135
2014-06-07 10:32:58,355 (3b0) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/593006_100.jpg'
2014-06-07 10:32:58,417 (3b0) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/593006_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:58,417 (3b0) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,417 (3b0) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/37/1389137/594802_720.jpg?api_key=p13x2&secret=a2f59631d135
2014-06-07 10:32:58,447 (3b0) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/594802_100.jpg'
2014-06-07 10:32:58,506 (3b0) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/594802_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:58,506 (3b0) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,507 (3b0) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/37/1389137/605149_720.jpg?api_key=p13x2&secret=a2f59631d135
2014-06-07 10:32:58,546 (3b0) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/605149_100.jpg'
2014-06-07 10:32:58,651 (3b0) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/37/1389137/605149_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:58,664 (3b0) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\7\7ff44b59946fc758fe3d39b37db113e9e0efaec.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:32:58,668 (3b0) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:32:58,700 (13dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,700 (13dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/69/396269/422196_720.jpg?api_key=p13x2&secret=e0998a759c10
2014-06-07 10:32:58,730 (13dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/69/396269/422196_100.jpg'
2014-06-07 10:32:58,822 (13dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/69/396269/422196_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:58,822 (13dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,822 (13dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/69/396269/25914_720.jpg?api_key=p13x2&secret=e0998a759c10
2014-06-07 10:32:58,851 (13dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/69/396269/25914_100.jpg'
2014-06-07 10:32:58,907 (13dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/69/396269/25914_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:58,907 (13dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:32:58,907 (13dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/69/396269/79921_720.jpg?api_key=p13x2&secret=e0998a759c10
2014-06-07 10:32:58,938 (13dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/69/396269/79921_100.jpg'
2014-06-07 10:32:59,045 (13dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/69/396269/79921_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:32:59,061 (13dc) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\4\b08c8d45f3725d2b548e6f46c63e3a648e95449.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:32:59,065 (13dc) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:33:00,078 (1348) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQxNTg2MjY1P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:00,079 (1348) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQxNTg2MjY1P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:00,079 (1348) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt1586265?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:00,081 (1348) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt1586265?lang=en
2014-06-07 10:33:00,082 (1348) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\6\c4be60f2627d23910966b0e2fe62c7c911734c7.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:00,086 (1348) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:00,105 (11a4) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxOXM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDE1ODYyNjU%40bGFuZz1lbnM0Cmd1aWRzOQp0dDE1ODYyNjVzMgppZHIwCg__
2014-06-07 10:33:00,108 (11a4) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYxOXM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDE1ODYyNjU@bGFuZz1lbnM0Cmd1aWRzOQp0dDE1ODYyNjVzMgppZHIwCg__
2014-06-07 10:33:00,108 (11a4) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt1586265?lang=en
2014-06-07 10:33:00,108 (11a4) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\6\c4be60f2627d23910966b0e2fe62c7c911734c7.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:33:00,109 (11a4) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/619/tree'
2014-06-07 10:33:00,145 (11a4) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=1586265&api_key=p13x2&secret=30b386dfb8f9&width=720&thumb_width=100'
2014-06-07 10:33:01,263 (11a4) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:01,263 (11a4) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/65/1586265/646307_720.jpg?api_key=p13x2&secret=30b386dfb8f9
2014-06-07 10:33:01,292 (11a4) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/646307_100.jpg'
2014-06-07 10:33:01,387 (11a4) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/646307_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:01,388 (11a4) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:01,388 (11a4) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/65/1586265/649143_720.jpg?api_key=p13x2&secret=30b386dfb8f9
2014-06-07 10:33:01,417 (11a4) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/649143_100.jpg'
2014-06-07 10:33:01,509 (11a4) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/649143_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:01,509 (11a4) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:01,509 (11a4) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/65/1586265/639054_720.jpg?api_key=p13x2&secret=30b386dfb8f9
2014-06-07 10:33:01,538 (11a4) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/639054_100.jpg'
2014-06-07 10:33:01,618 (11a4) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/65/1586265/639054_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:01,634 (11a4) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\6\c4be60f2627d23910966b0e2fe62c7c911734c7.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:33:01,638 (11a4) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:33:04,348 (10dc) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMzg2MTE3P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:04,351 (10dc) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMzg2MTE3P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:04,351 (10dc) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt0386117?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:04,351 (10dc) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0386117?lang=en
2014-06-07 10:33:04,351 (10dc) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\e\e59797a2b718e67df7ba8f6bbec8531cbaafae3.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:04,361 (10dc) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:04,371 (3dc) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAzODYxMTc%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAzODYxMTdzMgppZHIwCg__
2014-06-07 10:33:04,372 (3dc) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAzODYxMTc@bGFuZz1lbnM0Cmd1aWRzOQp0dDAzODYxMTdzMgppZHIwCg__
2014-06-07 10:33:04,374 (3dc) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0386117?lang=en
2014-06-07 10:33:04,375 (3dc) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\e\e59797a2b718e67df7ba8f6bbec8531cbaafae3.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:33:04,375 (3dc) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/620/tree'
2014-06-07 10:33:04,411 (3dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=386117&api_key=p13x2&secret=b8bc385b60c2&width=720&thumb_width=100'
2014-06-07 10:33:05,335 (3ac) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwODk2ODcyP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:05,336 (3ac) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwODk2ODcyP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:05,336 (3ac) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt0896872?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:05,338 (3ac) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0896872?lang=en
2014-06-07 10:33:05,338 (3ac) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\8\98884bb048f58e4046e60bb7a0776b09354ff20.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:05,345 (3ac) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:05,355 (3a8) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjU3NHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDA4OTY4NzI%40bGFuZz1lbnM0Cmd1aWRzOQp0dDA4OTY4NzJzMgppZHIwCg__
2014-06-07 10:33:05,357 (3a8) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjU3NHM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDA4OTY4NzI@bGFuZz1lbnM0Cmd1aWRzOQp0dDA4OTY4NzJzMgppZHIwCg__
2014-06-07 10:33:05,357 (3a8) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0896872?lang=en
2014-06-07 10:33:05,358 (3a8) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\8\98884bb048f58e4046e60bb7a0776b09354ff20.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:33:05,358 (3a8) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/574/tree'
2014-06-07 10:33:05,395 (3a8) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=896872&api_key=p13x2&secret=091cc7040124&width=720&thumb_width=100'
2014-06-07 10:33:05,539 (3dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:05,540 (3dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/17/386117/359473_720.jpg?api_key=p13x2&secret=b8bc385b60c2
2014-06-07 10:33:05,569 (3dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/17/386117/359473_100.jpg'
2014-06-07 10:33:05,630 (3dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/17/386117/359473_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:05,631 (3dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:05,631 (3dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/17/386117/359471_720.jpg?api_key=p13x2&secret=b8bc385b60c2
2014-06-07 10:33:05,661 (3dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/17/386117/359471_100.jpg'
2014-06-07 10:33:05,778 (3dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/17/386117/359471_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:05,778 (3dc) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:05,779 (3dc) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/17/386117/308564_720.jpg?api_key=p13x2&secret=b8bc385b60c2
2014-06-07 10:33:05,808 (3dc) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/17/386117/308564_100.jpg'
2014-06-07 10:33:05,894 (3dc) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/17/386117/308564_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:05,911 (3dc) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\e\e59797a2b718e67df7ba8f6bbec8531cbaafae3.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:33:05,914 (3dc) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:33:06,530 (3a8) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:06,532 (3a8) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/72/896872/558100_720.jpg?api_key=p13x2&secret=091cc7040124
2014-06-07 10:33:06,562 (3a8) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/72/896872/558100_100.jpg'
2014-06-07 10:33:06,624 (3a8) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/72/896872/558100_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:06,625 (3a8) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:06,625 (3a8) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/72/896872/561443_720.jpg?api_key=p13x2&secret=091cc7040124
2014-06-07 10:33:06,654 (3a8) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/72/896872/561443_100.jpg'
2014-06-07 10:33:06,709 (3a8) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/72/896872/561443_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:06,717 (3a8) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\8\98884bb048f58e4046e60bb7a0776b09354ff20.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:33:06,720 (3a8) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:33:07,507 (100c) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMDg0ODk5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:07,509 (100c) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMDg0ODk5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:07,509 (100c) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt0084899?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:07,509 (100c) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0084899?lang=en
2014-06-07 10:33:07,510 (100c) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\a\4bef45d3ece39a1efb9994638025c6acc049f1c.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:07,516 (100c) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:07,526 (a5c) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMXM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwODQ4OTk%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAwODQ4OTlzMgppZHIwCg__
2014-06-07 10:33:07,526 (a5c) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMXM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwODQ4OTk@bGFuZz1lbnM0Cmd1aWRzOQp0dDAwODQ4OTlzMgppZHIwCg__
2014-06-07 10:33:07,528 (a5c) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0084899?lang=en
2014-06-07 10:33:07,529 (a5c) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\a\4bef45d3ece39a1efb9994638025c6acc049f1c.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:33:07,529 (a5c) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/621/tree'
2014-06-07 10:33:07,563 (a5c) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=84899&api_key=p13x2&secret=1cd97035af9e&width=720&thumb_width=100'
2014-06-07 10:33:08,980 (a5c) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:08,980 (a5c) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/99/84899/259300_720.jpg?api_key=p13x2&secret=1cd97035af9e
2014-06-07 10:33:09,186 (a5c) : DEBUG (caching:268) - HTTP.system cache trimmed - new size is 153 KB (1024 items)
2014-06-07 10:33:09,237 (a5c) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/99/84899/259300_100.jpg'
2014-06-07 10:33:09,328 (a5c) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/99/84899/259300_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:09,329 (a5c) : INFO (logkit:16) - Adding matching language poster for language: US
2014-06-07 10:33:09,329 (a5c) : INFO (logkit:16) - Adding new poster: http://movieposterdb.plexapp.com/cache/big/99/84899/868778_720.jpg?api_key=p13x2&secret=1cd97035af9e
2014-06-07 10:33:09,358 (a5c) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/cache/normal/99/84899/868778_100.jpg'
2014-06-07 10:33:11,657 (c14) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQyMzM0ODc5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:11,660 (c14) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQyMzM0ODc5P2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:11,660 (c14) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt2334879?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:11,661 (c14) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt2334879?lang=en
2014-06-07 10:33:11,661 (c14) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\3\f3767fe912c53fb8611f65186af9c5f11abc197.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:11,684 (c14) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:11,694 (f00) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMnM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDIzMzQ4Nzk%40bGFuZz1lbnM0Cmd1aWRzOQp0dDIzMzQ4NzlzMgppZHIwCg__
2014-06-07 10:33:11,696 (f00) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyMnM0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDIzMzQ4Nzk@bGFuZz1lbnM0Cmd1aWRzOQp0dDIzMzQ4NzlzMgppZHIwCg__
2014-06-07 10:33:11,697 (f00) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt2334879?lang=en
2014-06-07 10:33:11,697 (f00) : ERROR (model:194) - Cannot read model from C:\Plex Media Server\Metadata\Movies\3\f3767fe912c53fb8611f65186af9c5f11abc197.bundle\Contents\com.plexapp.agents.movieposterdb
2014-06-07 10:33:11,697 (f00) : DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/library/metadata/622/tree'
2014-06-07 10:33:11,732 (f00) : DEBUG (networking:172) - Requesting 'http://movieposterdb.plexapp.com/1/request.json?imdb_id=2334879&api_key=p13x2&secret=6a272754397b&width=720&thumb_width=100'
2014-06-07 10:33:11,907 (a5c) : DEBUG (networking:204) - Not caching 'http://movieposterdb.plexapp.com/cache/normal/99/84899/868778_100.jpg' (content type 'image/jpeg' not cacheable in Agent plug-ins)
2014-06-07 10:33:11,917 (a5c) : DEBUG (model:218) - Serializing to C:\Plex Media Server\Metadata\Movies\a\4bef45d3ece39a1efb9994638025c6acc049f1c.bundle\Contents\com.plexapp.agents.movieposterdb\Info.xml
2014-06-07 10:33:11,921 (a5c) : DEBUG (runtime:918) - Response: [200] str, 16 bytes
2014-06-07 10:33:12,354 (244) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMDk0MzIwP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:12,355 (244) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo0CnMyCmVuczQKbGFuZ3M1Ck1vdmllczEwCm1lZGlhX3R5cGViMHM2Cm1hbnVhbHIxCnM2Cmt3YXJnczMKczQzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiOi8vdHQwMDk0MzIwP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMxMwpwcmltYXJ5X2FnZW50cjAK
2014-06-07 10:33:12,355 (244) : INFO (agentkit:915) - Searching for matches for {'guid': 'com.plexapp.agents.imdb://tt0094320?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.imdb'}
2014-06-07 10:33:12,357 (244) : DEBUG (model:32) - Loading model with GUID com.plexapp.agents.imdb://tt0094320?lang=en
2014-06-07 10:33:12,357 (244) : DEBUG (model:223) - Deserializing from C:\Plex Media Server\Metadata\Movies\3\910da3f7fd1839c5c301744dfe704d81c235082.bundle\Contents\com.plexapp.agents.imdb\Info.xml
2014-06-07 10:33:12,362 (244) : DEBUG (runtime:918) - Response: [200] str, 608 bytes
2014-06-07 10:33:12,375 (940) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyM3M0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwOTQzMjA%40bGFuZz1lbnM0Cmd1aWRzOQp0dDAwOTQzMjBzMgppZHIwCg__
2014-06-07 10:33:12,377 (940) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.movieposterdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKNwpzMgplbnM0CmxhbmdiMXM1CmZvcmNlbnMxMApwYXJlbnRHVUlEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMzCjYyM3M0CmRiaWRzNDMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGI6Ly90dDAwOTQ
