Added about 100 new movies, Plex not matching automatically but manual match works fine....

General Discussions
1

Well, as the title says I added a bunch of new movies but Plex will not match them automatically for some reason.

It still matches my new TV Episodes correctly and if I manually go in to match the movies it works every single time with no problems at all, I just do not want to match all of those movies manually.

I have:

  1. Checked the naming convention (all handled by CP as it always has been) and it is correct.
  2. I have requested an Update of the Library (not a refresh as I have 4100+ movies)
  3. I have shut down the PMS and restarted it

None of these things have helped. Also, weirder still, new movies that I added last night after adding the 100 new movies are now matching just fine automatically just not that group of movies. All movies are added via CP with no other manual processing involved.

Any ideas would be great!

Thanks

2

No one has the same issue? I am still having the problem. Is it because I have too many movies in one directory (~4300)?

3

You have 4300 files in one directory? For better performance, you should put each movie in a separate directory.

4

I never tried adding more than 4 movies at a time before, but try removing the last 100 movies you just added and do Plex Dance (update the library + optimize + empty trash/bundles).

Then try adding one movie and update the library again. If it works then maybe your fault is that the agent was not fast enough to grab all the metadata, which I don’t blame it :).

For me, the movie naming is always Name (Year).exe and in its own folder alongside its external SRT files (forced and normal). and all these folders are inside Movie folder.

5

Yeah, I have been using the same setup (Couchpotato) to grab and rename all of my movies and it works perfectly and matches the Plex movie naming convention perfectly. When I manually match them, the agent works perfectly. But for some reason, it does not when I add a lot of moves at once. (And by a lot of movies at once I mean one movie every few minutes or as fast as the downloader can work).

I thought maybe it had to do with how many files I have in one directory, so I split my movies into three separate directories…opps…I didn’t realize that plex would have to reindex every movie even though it alread!
y had all of its artwork, metadata, etc.

Now the server is reindexing and looking up data for 3000+ movies and they are all failing just like before. I have plenty of bandwidth and plenty of processing power and a 10G connection to the back-end NFS system. No iowait is being recorded on the monitoring system, no high CPU, plenty of memory available…I am just at a loss as to what could be wrong.

It has the right name, the right year, but unless I go to manually fix the match, it looks like the attached image for everything.

6

@kegobeer-plex said:
You have 4300 files in one directory? For better performance, you should put each movie in a separate directory.

WOW…really…a separate directory for each movie…? Really…? That would be 4300+ directories…

I have looked around and others have thousands of movies in a single directory, I just didn’t know how many would be too many…

7

You can have as much movies as you want in a single Directory, some people use Cloud servers attached to their PMS + external drives, and some use seedboxes. There’s no rule on how many you want as long as they’re structured correctly.

The thing I can think of is that either the Agent (perhaps TVDB or TheMovieDB) might be down, or the connection to them is timing-out when it’s trying to fetch as many movies at once.

Some Agents (or Add-ons) might put a limit cap (I’m looking at you Opensubtitles.org) due to hugging bandwidth. Only way to find out is by checking your logs. See where the problem is coming from when fetching the metadata.

8

I am looking at the logs and do not see anything particular to the media matching. Which log specifically should I be looking at? I took a look in the following logs:

  • com.plexapp.agents.imdb.log
  • com.plexapp.agents.localmedia.log
  • com.plexapp.system.log
  • Plex Media Scanner.log
  • Plex Media Server.log

I don’t see any errors but I also do not see things getting matched up. I get nothing unless I manually match a movie, just a single frame from the movie, no information about the movie itself, etc.

When I manually match, it gets the correct movie right every single time!

9

Which Agent do you use for Movies? The Default would be TheMovieDB.

So I would try to be looking for that text file, something called “Agent.TheMovieDB” or something similar.

look for where you started adding/updating the library with your movies (by time). See if it was trying to “Fetch” the metadata including description, and check agent.movieposterdb, are they Requesting? Did the connection time-out? or any error/critical.

Also look in imdb log.

10

OK, found these two log files:

  • com.plexapp.agents.themoviedb.log
  • com.plexapp.agents.imdb.log

Here is the log entry from com.plexapp.agents.themoviedb.log:

!
! 2017-01-01 18:38:06,155 (7f77d9e69700) : INFO (core:349) - Starting framework core - Version: 2.6.3, Build: b38628e (Thu Dec 15 21:34:00 UTC 2016)
! 2017-01-01 18:38:06,156 (7f77d9e69700) : DEBUG (core:361) - Using the elevated policy
! 2017-01-01 18:38:06,156 (7f77d9e69700) : DEBUG (core:450) - Starting runtime component.
! 2017-01-01 18:38:06,158 (7f77d9e69700) : DEBUG (core:450) - Starting caching component.
! 2017-01-01 18:38:06,159 (7f77d9e69700) : DEBUG (core:450) - Starting data component.
! 2017-01-01 18:38:06,159 (7f77d9e69700) : DEBUG (core:450) - Starting networking component.
! 2017-01-01 18:38:06,160 (7f77d9e69700) : DEBUG (networking:284) - Loaded HTTP cookies
! 2017-01-01 18:38:06,162 (7f77d9e69700) : DEBUG (networking:452) - Setting the default network timeout to 20.0
! 2017-01-01 18:38:06,163 (7f77d9e69700) : DEBUG (core:450) - Starting localization component.
! 2017-01-01 18:38:06,163 (7f77d9e69700) : INFO (localization:409) - Setting the default locale to en-us
! 2017-01-01 18:38:06,164 (7f77d9e69700) : DEBUG (core:450) - Starting messaging component.
! 2017-01-01 18:38:06,164 (7f77d9e69700) : DEBUG (core:450) - Starting debugging component.
! 2017-01-01 18:38:06,165 (7f77d9e69700) : DEBUG (core:450) - Starting services component.
! 2017-01-01 18:38:06,165 (7f77c1ffb700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.themoviedb’
! 2017-01-01 18:38:06,165 (7f77d9e69700) : DEBUG (core:450) - Starting myplex component.
! 2017-01-01 18:38:06,167 (7f77d9e69700) : DEBUG (core:450) - Starting notifications component.
! 2017-01-01 18:38:06,315 (7f77d9e69700) : DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.themoviedb in namespace ‘metadata’
! 2017-01-01 18:38:06,330 (7f77d9e69700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes’
! 2017-01-01 18:38:06,353 (7f77c1ffb700) : DEBUG (services:265) - Plug-in is not daemonized - loading services from system
! 2017-01-01 18:38:06,353 (7f77d9e69700) : DEBUG (runtime:1117) - Created a thread named ‘load_all_services’
! 2017-01-01 18:38:06,354 (7f77c1ffb700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_’
! 2017-01-01 18:38:06,355 (7f77c0f79700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400’
! 2017-01-01 18:38:06,355 (7f77d9e69700) : DEBUG (runtime:1117) - Created a thread named ‘get_server_info’
! 2017-01-01 18:38:06,357 (7f77d9e69700) : DEBUG (core:150) - Finished starting framework core
! 2017-01-01 18:38:06,358 (7f77d9e69700) : DEBUG (core:560) - Loading plug-in code
! 2017-01-01 18:38:06,424 (7f77c0f79700) : DEBUG (core:538) - Machine identifier is c8484f0174d9e02c6ba97931b4ef537720d732f3
! 2017-01-01 18:38:06,425 (7f77c0f79700) : DEBUG (core:539) - Server version is 1.3.3.3148-b38628e
! 2017-01-01 18:38:06,596 (7f77c1ffb700) : DEBUG (services:362) - Loaded services
! 2017-01-01 18:38:06,603 (7f77c177a700) : DEBUG (services:438) - No shared code to load
! 2017-01-01 18:38:06,731 (7f77d9e69700) : DEBUG (core:566) - Finished loading plug-in code
! 2017-01-01 18:38:06,731 (7f77d9e69700) : DEBUG (messaging:69) - Exposing function GetImdbId for remote access
! 2017-01-01 18:38:06,731 (7f77d9e69700) : DEBUG (messaging:69) - Exposing function GetTvdbId for remote access
! 2017-01-01 18:38:06,731 (7f77d9e69700) : DEBUG (messaging:69) - Exposing function GetTvRageId for remote access
! 2017-01-01 18:38:06,732 (7f77d9e69700) : DEBUG (messaging:69) - Exposing function GetTMDbSearchResults for remote access
! 2017-01-01 18:38:06,732 (7f77d9e69700) : DEBUG (messaging:69) - Exposing function GetTMDbMetadata for remote access
! 2017-01-01 18:38:06,732 (7f77d9e69700) : DEBUG (agentkit:1104) - Creating new agent class called TMDbAgent
! 2017-01-01 18:38:06,732 (7f77d9e69700) : DEBUG (agentkit:922) - Updating agent information: [{‘media_types’: [‘Movie’], ‘accepts_from’: [‘com.plexapp.agents.localmedia’], ‘fallback_agent’: None, ‘contributes_to’: None, ‘languages’: [‘en’, ‘cs’, ‘da’, ‘de’, ‘el’, ‘es’, ‘fi’, ‘fr’, ‘he’, ‘hr’, ‘hu’, ‘it’, ‘lv’, ‘nl’, ‘no’, ‘pl’, ‘pt’, ‘ru’, ‘sk’, ‘sv’, ‘th’, ‘tr’, ‘vi’, ‘zh’, ‘ko’], ‘persist_stored_files’: True, ‘version’: 0, ‘primary_provider’: True, ‘prefs’: True, ‘name’: ‘The Movie Database’}]

Here is the log entry for the imdb log:

! 2017-01-01 18:38:19,109 (7fae9a548700) : INFO (core:349) - Starting framework core - Version: 2.6.3, Build: b38628e (Thu Dec 15 21:34:00 UTC 2016)
! 2017-01-01 18:38:19,109 (7fae9a548700) : DEBUG (core:361) - Using the elevated policy
! 2017-01-01 18:38:19,110 (7fae9a548700) : DEBUG (core:450) - Starting runtime component.
! 2017-01-01 18:38:19,112 (7fae9a548700) : DEBUG (core:450) - Starting caching component.
! 2017-01-01 18:38:19,112 (7fae9a548700) : DEBUG (core:450) - Starting data component.
! 2017-01-01 18:38:19,112 (7fae9a548700) : DEBUG (core:450) - Starting networking component.
! 2017-01-01 18:38:19,113 (7fae9a548700) : DEBUG (networking:284) - Loaded HTTP cookies
! 2017-01-01 18:38:19,114 (7fae9a548700) : DEBUG (networking:452) - Setting the default network timeout to 20.0
! 2017-01-01 18:38:19,114 (7fae9a548700) : DEBUG (core:450) - Starting localization component.
! 2017-01-01 18:38:19,114 (7fae9a548700) : INFO (localization:409) - Setting the default locale to en-us
! 2017-01-01 18:38:19,114 (7fae9a548700) : DEBUG (core:450) - Starting messaging component.
! 2017-01-01 18:38:19,115 (7fae9a548700) : DEBUG (core:450) - Starting debugging component.
! 2017-01-01 18:38:19,115 (7fae9a548700) : DEBUG (core:450) - Starting services component.
! 2017-01-01 18:38:19,115 (7fae9a548700) : DEBUG (core:450) - Starting myplex component.
! 2017-01-01 18:38:19,115 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.imdb’
! 2017-01-01 18:38:19,116 (7fae9a548700) : DEBUG (core:450) - Starting notifications component.
! 2017-01-01 18:38:19,203 (7fae9a548700) : DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.imdb in namespace ‘metadata’
! 2017-01-01 18:38:19,208 (7fae9a548700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes’
! 2017-01-01 18:38:19,224 (7fae7a7fc700) : DEBUG (services:265) - Plug-in is not daemonized - loading services from system
! 2017-01-01 18:38:19,224 (7fae9a548700) : DEBUG (runtime:1117) - Created a thread named ‘load_all_services’
! 2017-01-01 18:38:19,225 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_’
! 2017-01-01 18:38:19,226 (7fae9a548700) : DEBUG (runtime:1117) - Created a thread named ‘get_server_info’
! 2017-01-01 18:38:19,226 (7fae796ba700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400’
! 2017-01-01 18:38:19,227 (7fae9a548700) : DEBUG (core:150) - Finished starting framework core
! 2017-01-01 18:38:19,228 (7fae9a548700) : DEBUG (core:560) - Loading plug-in code
! 2017-01-01 18:38:19,271 (7fae796ba700) : DEBUG (core:538) - Machine identifier is c8484f0174d9e02c6ba97931b4ef537720d732f3
! 2017-01-01 18:38:19,272 (7fae796ba700) : DEBUG (core:539) - Server version is 1.3.3.3148-b38628e
! 2017-01-01 18:38:19,444 (7fae7a7fc700) : DEBUG (services:362) - Loaded services
! 2017-01-01 18:38:19,451 (7fae79ebb700) : DEBUG (services:438) - No shared code to load
! 2017-01-01 18:38:19,663 (7fae9a548700) : DEBUG (core:566) - Finished loading plug-in code
! 2017-01-01 18:38:19,752 (7fae9a548700) : DEBUG (agentkit:1104) - Creating new agent class called PlexMovieAgent
! 2017-01-01 18:38:19,753 (7fae9a548700) : DEBUG (agentkit:922) - 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’}]
! 2017-01-01 18:38:19,754 (7fae9a548700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_’
! 2017-01-01 18:38:19,765 (7fae9a548700) : INFO (core:611) - Started plug-in
! 2017-01-01 18:38:19,765 (7fae9a548700) : DEBUG (socketinterface:160) - Starting socket server
! 2017-01-01 18:38:19,765 (7fae9a548700) : DEBUG (runtime:1117) - Created a thread named ‘start’
! 2017-01-01 18:38:19,766 (7fae9a548700) : INFO (socketinterface:184) - Socket server started on port 29941
! 2017-01-01 18:38:19,766 (7fae9a548700) : INFO (pipeinterface:25) - Entering run loop
! 2017-01-01 18:38:19,766 (7fae9a548700) : DEBUG (runtime:717) - Handling request GET /:/prefixes
! 2017-01-01 18:38:19,767 (7fae9a548700) : DEBUG (runtime:814) - Found route matching /:/prefixes
! 2017-01-01 18:38:19,767 (7fae9a548700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 148 bytes
! 2017-01-01 18:38:19,795 (7fae7a7fc700) : DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.imdb/prefs
! 2017-01-01 18:38:19,814 (7fae7a7fc700) : DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.imdb/prefs
! 2017-01-01 18:38:19,814 (7fae7a7fc700) : DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
! 2017-01-01 18:38:19,815 (7fae7a7fc700) : DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.imdb
! 2017-01-01 18:38:19,821 (7fae7a7fc700) : DEBUG (runtime:88) - Sending packed state data (104 bytes)
! 2017-01-01 18:38:19,821 (7fae7a7fc700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 2213 bytes
! 2017-01-01 18:42:15,848 (7fae7a7fc700) : DEBUG (runtime:717) - Handling request GET

Here is when I manually ask for a match (which works):

! 2017-01-01 18:42:15,851 (7fae7a7fc700) : INFO (agentkit:946) - Searching for matches for {‘openSubtitlesHash’: ‘9a3c2a7a84fc139d’, ‘name’: ‘Alien’, ‘year’: ‘1979’, ‘filename’: ‘%2Fmount%2Fmedia%2FMovies%2FOther2%2FAliens%2FAlien%20(1979)%2Emkv’, ‘plexHash’: ‘d204b62c3804f85d333bd3880d198a5c2c95fce8’, ‘duration’: ‘6999225’, ‘id’: ‘920241’}
! 2017-01-01 18:42:15,851 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/library/metadata/920241/tree’
! 2017-01-01 18:42:15,860 (7fae7a7fc700) : INFO (init:151) - checking hash search vector: https://meta.plex.tv/movie/hash/d2/d204b62c3804f85d333bd3880d198a5c2c95fce8.xml
! 2017-01-01 18:42:15,864 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘https://meta.plex.tv/movie/hash/d2/d204b62c3804f85d333bd3880d198a5c2c95fce8.xml’
! 2017-01-01 18:42:16,018 (7fae7a7fc700) : ERROR (networking:219) - Error opening URL ‘https://meta.plex.tv/movie/hash/d2/d204b62c3804f85d333bd3880d198a5c2c95fce8.xml’
! 2017-01-01 18:42:16,018 (7fae7a7fc700) : INFO (init:178) - freebase/proxy hash lookup failed: HTTP Error 404: NOT FOUND
! 2017-01-01 18:42:16,019 (7fae7a7fc700) : INFO (init:182) - Scoring {}
! 2017-01-01 18:42:16,019 (7fae7a7fc700) : INFO (init:449) - ---- HASH RESULTS MAP ----
! 2017-01-01 18:42:16,019 (7fae7a7fc700) : INFO (init:450) - {}
! 2017-01-01 18:42:16,020 (7fae7a7fc700) : INFO (init:151) - checking title/year search vector: https://meta.plex.tv/movie/guid/87/87965edafd069d34f930ea3f64153dd11604d409.xml
! 2017-01-01 18:42:16,024 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘https://meta.plex.tv/movie/guid/87/87965edafd069d34f930ea3f64153dd11604d409.xml’
! 2017-01-01 18:42:16,372 (7fae7a7fc700) : INFO (init:182) - Scoring {‘tt0103644’: [2, u’Alien 3’, u’1992’, 0, 47, 0], ‘tt0079287’: [0, u’Alien’, u’1979’, 0, 1708, 0], ‘tt0090605’: [1, u’Aliens’, u’1986’, 0, 977, 0], ‘tt0370263’: [0, u’Alien’, u’1979’, 0, 52, 0], ‘tt0078748’: [0, u’Alien’, u’1979’, 98, 287253, 0], ‘tt0096969’: [0, u’Alien’, u’1979’, 0, 206, 0], ‘tt0078750’: [0, u’Alien’, u’1979’, 0, 102, 0]}
! 2017-01-01 18:42:16,372 (7fae7a7fc700) : INFO (init:481) - ---- TITLE_YEAR RESULTS MAP ----
! 2017-01-01 18:42:16,372 (7fae7a7fc700) : INFO (init:482) - {‘tt0103644’: [2, u’Alien 3’, u’1992’, 0, 47, 58], ‘tt0079287’: [0, u’Alien’, u’1979’, 0, 1708, 80], ‘tt0090605’: [1, u’Aliens’, u’1986’, 0, 977, 69], ‘tt0370263’: [0, u’Alien’, u’1979’, 0, 52, 71], ‘tt0078748’: [0, u’Alien’, u’1979’, 98, 287253, 99], ‘tt0096969’: [0, u’Alien’, u’1979’, 0, 206, 74], ‘tt0078750’: [0, u’Alien’, u’1979’, 0, 102, 72]}
! 2017-01-01 18:42:16,376 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0103644%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:18,811 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: Alien³ (1992) score=58, key=tt0103644
! 2017-01-01 18:42:18,816 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0079287%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:20,989 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: The First Part of King Henry the Fourth, with the Life and Death of Henry Surnamed Hotspur (1979) score=80, key=tt0079287
! 2017-01-01 18:42:20,993 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0090605%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:23,141 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: Aliens (1986) score=69, key=tt0090605
! 2017-01-01 18:42:23,146 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0370263%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:25,535 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: AVP: Alien vs. Predator (2004) score=71, key=tt0370263
! 2017-01-01 18:42:25,540 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0078748%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:27,696 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: Alien (1979) score=99, key=tt0078748
! 2017-01-01 18:42:27,700 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0096969%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:29,881 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: Born on the Fourth of July (1989) score=74, key=tt0096969
! 2017-01-01 18:42:29,884 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fmovie%2Ftt0078750%3Fappend_to_response%3Dreleases%2Ccredits%26language%3D’
! 2017-01-01 18:42:32,249 (7fae7a7fc700) : INFO (init:490) - Adding title_year match: The Alien Encounters (1979) score=72, key=tt0078750
! 2017-01-01 18:42:32,249 (7fae7a7fc700) : INFO (init:499) - Found perfect match with title/year query.
! 2017-01-01 18:42:32,250 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘https://metrics.plex.tv/collect/event’
! 2017-01-01 18:42:47,339 (7fae7a7fc700) : INFO (init:507) - ---- TMDb RESULTS MAP ----
! 2017-01-01 18:42:47,344 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/tmdb?uri=%2Fsearch%2Fmovie%3Fquery%3DAlien%26year%3D1979%26language%3Den%26include_adult%3Dfalse’
! 2017-01-01 18:42:49,597 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.agents.themoviedb/messaging/function/TWVzc2FnZUtpdDpHZXRJbWRiSWQ_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzMwozNDhzNwp0bWRiX2lkcjAK’
! 2017-01-01 18:42:51,804 (7fae7a7fc700) : INFO (init:305) - MetadataSearchResult(lang=‘en’, thumb=None, score=100, year=1979, id=‘tt0078748’, name=‘Alien’)
! 2017-01-01 18:42:51,804 (7fae7a7fc700) : INFO (init:309) - Found perfect match with TMDb query.
! 2017-01-01 18:42:51,805 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘https://metrics.plex.tv/collect/event’
! 2017-01-01 18:43:12,464 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.agents.themoviedb/messaging/function/TWVzc2FnZUtpdDpHZXRJbWRiSWQ_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMQpzNQo5ODQwMXM3CnRtZGJfaWRyMAo_’
! 2017-01-01 18:43:14,936 (7fae7a7fc700) : INFO (init:305) - MetadataSearchResult(lang=‘en’, thumb=None, score=84, year=1979, id=‘tt0078750’, name=‘The Alien Encounters’)
! 2017-01-01 18:43:14,936 (7fae7a7fc700) : INFO (init:511) - ---- UMP RESULTS MAP ----
! 2017-01-01 18:43:14,939 (7fae7a7fc700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/services/ump/matches?type=1&title=Alien&year=1979&plexHash=d204b62c3804f85d333bd3880d198a5c2c95fce8&lang=en&manual=1’
! 2017-01-01 18:43:15,407 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/2h00HrZs89SL3tXB4nbkiM7BKHs.jpg’, score=106, year=1979, id=‘tt0078748’, name=‘Alien’)
! 2017-01-01 18:43:15,408 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/vz1vBw17F0x42bhziHdYRJC9uCv.jpg’, score=85, year=1992, id=‘tt0103644’, name=u’Alien\xb3’)
! 2017-01-01 18:43:15,408 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=None, score=74, year=1979, id=‘tt0078750’, name=‘The Alien Encounters’)
! 2017-01-01 18:43:15,409 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/zshai2RQNOetdXUdN3aPV1NvEPm.jpg’, score=65, year=1978, id=‘tt0072626’, name=‘Alien Zone’)
! 2017-01-01 18:43:15,409 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/E8Wvspbubh5chGWQwO20T4OSQi.jpg’, score=64, year=1978, id=‘tt0075656’, name=‘The Alien Factor’)
! 2017-01-01 18:43:15,410 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/ahS08iXvddHMxASAlDInXxPglep.jpg’, score=63, year=1978, id=‘tt0086872’, name=‘Prey’)
! 2017-01-01 18:43:15,410 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/walvlnCMgZxJT1OAYER3eYErEMu.jpg’, score=62, year=1980, id=‘tt0081764’, name=‘Without Warning’)
! 2017-01-01 18:43:15,411 (7fae7a7fc700) : INFO (init:340) - MetadataSearchResult(lang=‘en’, thumb=‘https://image.tmdb.org/t/p/w780/9Q0lbq4L7V67AfePhTPRcK9LEz7.jpg’, score=57, year=1977, id=‘tt0076760’, name=‘Starship Invasions’)

What is interesting is that there is nothing much in the logs (and nothing about searching for anything) until I specifically request a manual match by selecting the movie, then the (…) and then match. There is no option to fix an incorrect match which tells me that there is nothing matched.

Restarting plex completely and even rebooting the server, selecting ‘optimize database’, selecting ‘update library’, none of these start the server on trying to find matches for the media. The only thing that works if manually going into each movie and selecting match. Then it works perfectly every time.

11

I’m no expert, but the logs seems missing, I don’t see it fetching from IMDB DB nor TheMovieDB for your movies.

Just a quick question, check your Agents order, maybe you got Personal Media Agent before TheMovieDB. If you can manually “Match” the movie with TheMovieDB Agent or Plex Agent, then your agents orders are out of place. It might be looking at your Local Media instead of IMDB or others. Just a guess.

12

hummm…it looks like it always has…what do you think:

and

13

That’s weird, let a person more experienced than me try to tackle this one. But just a quick one, why not try to disable/untick Local Media Assets and Plex Movie agents temporary, then restart your PMS and try again. After that, re-tick/enable them again and try it.

Also I would recommend trying to restart your router as well, maybe there’s something blocking the connection. Turn off your router for around 10 minutes and start it back up. (Might be something on PMS Logs, other than the agents, that’s blocking.)

If that doesn’t work, then I apologise as i’m out of ideas here.

EDIT: I just realised I never used my Plex Movie Agent, it has always been unticked here, only my local media and The Movie DB are ticked… and thats by default.

14

Thanks Ashus -

Restarting the router is a non-starter, I have this at our office and there is no way I can reboot our Cisco 6509 as it would take our entire infrastructure down in the process. Same goes for the firewall. I think the fact that it works manually tells me from a network perspective that there is nothing wrong on that end.

I like the idea about unchecking the other agents and will give that a try as well!

Thanks again for all of the great ideas!