I’ve seen this posted in the forum quite a few times with not a lot of answers. I was having no issues with PMS 1.5.5.3634 on my iMac running 10.12.4. But suddenly a few weeks ago my server stopped being able to download metadata for any new movies that I add. It says they are matched, but there is no metadata or posters downloading after a long processing time.
I’ve tried doing a Plex Dance. I’m tried different files. TV Shows have no problems. It’s just movies. I’m not running a router with iPv6. Part of the weird thing is I’ve put a few of the files on the Plex Cloud Server and those get metadata. But when it’s on my iMacs PMS it has issues.
Logs are attached. Any help will be greatly appreciated.
Please do the following… (let’s give this a fresh shot)
Make sure Verbose logging is disabled (important)
Stop PMS
Clear out the Agent caches (which you found in Plug-ins Support) and the main Caches directory which I pointed out to you.
Start PMS
Analyse several items which do not have metadata.
Refresh/Reload the metadata for them
If this effective, repeat for all in that library
If ineffective, stop there and have PMS ZIP the logs (Settings - server - help - download logs)
Attach them here.
Also, with this ZIP file, list the exact file names for the file(s) tested. If MP4 files, verify the Name and Title fields in them. Include any metadata embedded there.
Clear out the Agent caches (which you found in Plug-ins Support) and the main Caches directory which I pointed out to you.
I did everything you said except for step 3, as mentioned before, there was no main Caches directory. I only have the Agent Caches that I found. I cleared those out but the problem still isn’t fixed.
I tried it with “Ed Wood (1194) Bluray-1080p.mkv”, “Stephen King’s It (1990) Bluray-720p Proper.mkv”, and “Logan (2017) WEBDL-1080p.mkv”
B. It (1994) it a TV miniseries and belongs under TV, not movies.
[chuck@lizum tv.129]$ pwd
/vie/test/tv
[chuck@lizum tv.130]$ ls -laR
.:
total 12
drwxr-xr-x 3 chuck chuck 4096 Jun 22 11:14 ./
drwxrwxrwx 4 chuck chuck 4096 Jun 22 11:13 ../
drwxr-xr-x 3 chuck chuck 4096 Jun 22 11:15 It (1990)/
./It (1990):
total 12
drwxr-xr-x 3 chuck chuck 4096 Jun 22 11:15 ./
drwxr-xr-x 3 chuck chuck 4096 Jun 22 11:14 ../
drwxr-xr-x 2 chuck chuck 4096 Jun 22 11:15 Season 01/
./It (1990)/Season 01:
total 12
drwxr-xr-x 2 chuck chuck 4096 Jun 22 11:15 ./
drwxr-xr-x 3 chuck chuck 4096 Jun 22 11:15 ../
-rw-r--r-- 1 chuck chuck 127 Jun 22 11:15 It.s01e01.optional-title.mkv
[chuck@lizum tv.131]$
C. There is a Logan (2010) as well as Logan (2017).
Of these three titles, you have two incorrectly named or classified. Logan is mostly correct. Your names are "just as I got them’ style. You really do need to clean these up. PMS is flexible but it isn’t perfect. FileBot or TheRenamer will fix this.
I use FileBot (it’s free).
TV series renaming rule is: /nas/tv/{n}/Season {s.pad(2)/{n}.{s00e00}.{t}
Movie renaming rule is: /nas/movies/{n} ({y})/{n} ({y})
FileBot allows you to add additional information if you wish but I believe your first focus should be cleaning names up. If you have conflicts, such as multiple resolutions of the same file/extension combination, you can add things like [720p] at the very end of the movie title (but not TV) for your clarification. PMS will ignore anything inside [ ].
As always, when you perform renaming in-situ like this, be prepared to “Plex Dance” the media (movie it out of the media library, update library, empty trash, clean bundles, move it back, update again)
This was just a typo on my part. The filename was ‘(1994)’
Of these three titles, you have two incorrectly named or classified. Logan is mostly correct. Your names are "just as I got them’ style. You really do need to clean these up. PMS is flexible but it isn’t perfect. FileBot or TheRenamer will fix this.
I don’t use them ‘just as I got them’, the program I use to download things also renames them and strips out all of the extra stuff. I’ve just kept quality. But I can easily have them rename them all. But this also seems odd because this is the naming convention I’ve always used for the almost two years I’ve had Plex. It’s never had any problems before. One day it suddenly just stopped working.
As always, when you perform renaming in-situ like this, be prepared to “Plex Dance” the media (movie it out of the media library, update library, empty trash, clean bundles, move it back, update again)
I did the rename and Plex Dance on three different movie files. Still isn’t working. Attached are logs.
File Names:
Passengers (2016).mkv
Bugsy Malone (1976).mkv
Lion (2016).mkv
Your database is very badly fragmented or the device I keep seeing below is causing you great problems. I cannot differentiate .
Even the best query time tells me your Database needs optimizing. The query requiring 3460ms (3.5 seconds) to reply will cause PMS to fault. Metadata lookup will fail because the agent which needs DB access can’t get it.
[chuck@lizum user.133]$ grep SLOW *
Plex Media Server.1.log:Jun 22, 2017 15:32:36.000 [0x7000035e2000] WARN - SLOW QUERY: It took 3460.000000 ms to retrieve 16 items.
Plex Media Server.1.log:Jun 22, 2017 15:47:07.449 [0x7000036e8000] WARN - SLOW QUERY: It took 240.000000 ms to retrieve 75 items.
Plex Media Server.1.log:Jun 22, 2017 15:49:39.261 [0x7000035e2000] WARN - SLOW QUERY: It took 220.000000 ms to retrieve 75 items.
Plex Media Server.1.log:Jun 22, 2017 15:49:39.284 [0x700003665000] WARN - SLOW QUERY: It took 230.000000 ms to retrieve 75 items.
[chuck@lizum user.134]$
I continue to see a device on your LAN which is spouting all kinds of bad XML when PMS is looking for clients. It’s causing PMS several thousand lines (6420 lines) of errors and delays.
The device is at:
un 22, 2017 05:28:31.586 [0x7000079bd000] DEBUG - HTTP 200 response from GET http://10.0.1.3:8080
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Entity: line 13:
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: parser
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: error :
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Opening and ending tag mismatch: link line 12 and head
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: </head>
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: ^
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Entity: line 18:
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: parser
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: error :
Jun 22, 2017 05:28:31.589 [0x7000079bd000] ERROR - XML: Entity 'hellip' not defined
Jun 22, 2017 05:28:31.589 [0x7000079bd000] ERROR - XML: <div>Loading, please wait…</div>```
I don’t know what you’re running there but when PMS is looking for Clients and verifying its way out to the internet, this device is ‘sticking its head up’.
Can you disable the device from advertising or turn it off temporarily to see if this is causing you issue?
@ChuckPA said:
Your database is very badly fragmented or the device I keep seeing below is causing you great problems. I cannot differentiate .
Even the best query time tells me your Database needs optimizing. The query requiring 3460ms (3.5 seconds) to reply will cause PMS to fault. Metadata lookup will fail because the agent which needs DB access can’t get it.
Should I run an “Optimize” command to see if that helps clear things up?
The device is at:
un 22, 2017 05:28:31.586 [0x7000079bd000] DEBUG - HTTP 200 response from GET http://10.0.1.3:8080
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Entity: line 13:
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: parser
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: error :
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Opening and ending tag mismatch: link line 12 and head
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: </head>
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: ^
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: Entity: line 18:
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: parser
Jun 22, 2017 05:28:31.588 [0x7000079bd000] ERROR - XML: error :
Jun 22, 2017 05:28:31.589 [0x7000079bd000] ERROR - XML: Entity 'hellip' not defined
Jun 22, 2017 05:28:31.589 [0x7000079bd000] ERROR - XML: <div>Loading, please wait…</div>```
I don’t know what you’re running there but when PMS is looking for Clients and verifying its way out to the internet, this device is ‘sticking its head up’.
Can you disable the device from advertising or turn it off temporarily to see if this is causing you issue?
That was my listening port for uTorrent’s WebUI. I turned off the WebUI. Did another Plex Dance with the same files. Still nothing. Though I am a relative novice when it comes to coding etc so it’s quite possible there was something with that port that I didn’t catch or didn’t know to do.
Move your torrent UI port number to something much lower and non-standard. 8080 is a traditional web page. It’s also were devices ‘live’. If you can move it to ‘888’ or ‘777’ (oddball), you’re in much better shape. Also, if it has an ‘advertise’ setting (don’t know your specific client) in Preferences, turn it off… Its Web/UI should be otherwise silent until opened directly by your browser.
Please do optimize the database. Once Optimized, restart PMS or just reboot the machine.
You’ll be pleased to know, PMS sees all these and wants to scan / process them. Some of these exist already but PMS wanting to scan them again means something has changed -OR- it never managed to match them before (for whatever reason).
Jun 22, 2017 16:43:19.583 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Arrival (2016)
Jun 22, 2017 16:43:19.583 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Blood Simple (1984)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Bugsy Malone (1976)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Doctor Strange (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Ed Wood (1994)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Fences (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Jackie (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Kubo and the Two Strings (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Lion (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Little Men (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Loving (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Mary Poppins (1964)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Moana (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Nocturnal Animals (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Oliver & Company (1988)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Passengers (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Resident Evil (2002)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Resident Evil Afterlife (2010)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Resident Evil Extinction (2007)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Resident Evil Retribution (2012)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Rules Don't Apply (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Game (1997)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Great Mouse Detective (1986)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Handmaiden (2016)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Mummy (1999)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Mummy Returns (2001)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Mummy Tomb of the Dragon Emperor (2008)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/The Sword in the Stone (1963)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/What Ever Happened to Baby Jane! (1962)
Jun 22, 2017 16:43:19.584 [0x7fffb355c3c0] DEBUG - Adding subdirectory for scanner: /Users/Ben/Movies/Plex/Movies/Wonder Boys (2000)
Move your torrent UI port number to something much lower and non-standard. 8080 is a traditional web page. It’s also were devices ‘live’. If you can move it to ‘888’ or ‘777’ (oddball), you’re in much better shape. Also, if it has an ‘advertise’ setting (don’t know your specific client) in Preferences, turn it off… Its Web/UI should be otherwise silent until opened directly by your browser.
Please do optimize the database. Once Optimized, restart PMS or just reboot.
I was having issues with uTorrent anyways so I just completely deleted the program from my computer. Emptied the trash. Optimized the database. Did a Plex Dance. Still not working.
I am honestly at a loss here. I tried going to the port directly in a web browser and nothing loads. Everything seems like it should be working. And yet, it isn’t.
Set a new instance with only defaults. (give it a temporary name)
Add one section at a time, optimizing the database after each is fully complete.
Evaluate library completeness when done.
So to be clear before I start, you want me to take the parent folders where all of my media is and rename them. I have my library spread out on a couple different HDDs so do it for each one I assume. Then I get lost by what you mean in steps 5 & 6.
rename Plex Media Server to PMS.save
I do not want to destroy/lose what you currently have. I want a clean, install first… Then we will decide how to proceed.
So I did what you said and added a library of movies from the folder that included the files that we were testing before and a couple dozen others that had been downloaded just fine before. I let it process it all and no metadata matched. I optimized the database and refresh the library, still nothing.
Ben,
I did not mean to confuse. With these results in hand, I can see the full sequence.
How many manual plug-ins (or channels) did you add/load?
Jun 23, 2017 11:00:55.591 [0x700010291000] DEBUG - HTTP requesting GET http://127.0.0.1:55985/system/agents
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - Starting plug-in /Applications/Plex Media Server.app/Contents/Resources/Plug-ins-25d94bad9/TheMovieDB.bundle.
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - [com.plexapp.agents.themoviedb] Agent not known by system, so we're starting for sure.
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - Starting file watcher for com.plexapp.agents.themoviedb
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - Plug-in limit of 10 exceeded.
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - * Bringing down the older plug-in: com.plexapp.agents.htbackdrops.
Jun 23, 2017 11:00:55.592 [0x700011062000] DEBUG - Stopping [com.plexapp.agents.htbackdrops].
Note the limit of 10 is now exceeded. At the point, there should be 6 active. not 10.
Sorry you weren’t confusing me, the situation is and why it won’t work. But in response to your question, I haven’t added any channels to this new server. I literally just opened the server, added a library, and that was it.
In my old server that we saved off, I only had one or two channels. One i deleted recently because I never used which left me with just the Trakt.tv channel.
I am looking more and more now to your networking. Curl error 28 is a very strong indicator of network issues.
PMS has issued a metadata request either to Plex.tv, imdb, tvdb, or TheMovieDB and these requests, are not completing in time. If PMS doesn’t get the full block of data, it will not populate any of it. This is what you’re seeing.
This having been said, Speed test your Mac’s network performance out to the internet. ping test (via terminal) plex.tv, themoviedb, thedbdb.org, and imdb.
