Some files don't appear in the movie library

Plex Media Server Metadata & Adding Files
1

Server Version#: 1.18.7.2457
Player Version#: don’t know what is this

Hi, some of my movies don’t appear in the movies library.

I’m sure, they are correctly named, let’s have movie Anna (2019) make an example here.
All movies are in folder /data/hdd1/Video/Movies/

I didn’t recognize the pattern, but to me looks like only some of the x265 coded movies are not appearing in the library, no problem with x264

The movie taken as an example has r-x rights for group which PMS is a member of.

It’s correctly named.

I tried both PLEX Movie Scanner and PLEX Video Files Scanner.

PMS is running on Debian 10.2

I don’t know what to make of this log, it looks like it knows the file is there, but the movie doesn’t appear in the library
Plex Media Scanner.1.log (3.6 KB)

2

Perform the Plex Dance

Your log indicates “no change”.

Feb 29, 2020 15:32:01.024 [0x7f05967bd740] DEBUG - Scanner: Processing directory /data/hdd1/Video/Movies/Anna (2019) (parent: yes)
Feb 29, 2020 15:32:01.028 [0x7f05967bd740] DEBUG - Skipping over directory 'Anna (2019)', as nothing has changed;

Next time please provide the accompanying Plex Media Server.log as well, as it contains further clues about the matching.

Some more tips: How to find the discrepancy between number of files on disk and the number of movies in the Plex movie library

3

Hi, thank you for the answer, I followed your plex dance tutorial, but didn’t help. From the log is again apparent that movies (and they are top of the log) Anna, Dracula Untold, Ad Astra, etc have been noticed, but they don’t appear in the library

Plex Media Scanner.1.log (689.3 KB) Plex Media Server.log (6.2 MB)

4

I think you didn’t wait long enough before fetching logs. Because it only shows that the folder was scanned, but no indication about to which movie the files were “matched”.

5

hmmm… that scan takes around 10 seconds, but OK… I downloaded all the logs now again
Plex Media Server Logs_2020-02-29_17-01-17.zip (4.3 MB)

6

Unfortunately, I cannot find anything relevant in your log files.
Have you tried anything from my above link?

7

Sorry, only get a bit time now to play around with this. No new HEVC files appear in the library, tried The Nun (2018) this time.

To me it looks like PMS recognizes the directory, but it doesn’t add it to the library for some reason

from PMS log:

Mar 06, 2020 08:40:32.437 [0x7ff7097fa700] DEBUG - Activity: registered new activity a67b4a01-a537-457c-a5a3-e31aaf894709 - Cleaning bundles
Mar 06, 2020 08:40:32.439 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 0.0% - Cleaning bundles
Mar 06, 2020 08:40:32.440 [0x7ff73f517700] DEBUG - Completed: [88.80.246.216:53875] 200 PUT /library/clean/bundles?async=1 (5 live) TLS GZIP 3ms 377 bytes (pipelined: 1)
Mar 06, 2020 08:40:33.262 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 25.0% - Cleaning bundles
Mar 06, 2020 08:40:33.262 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 50.0% - Cleaning bundles
Mar 06, 2020 08:40:33.263 [0x7ff70affd700] DEBUG - Deleted 0 metadata bundles.
Mar 06, 2020 08:40:33.263 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 50.0% - Cleaning bundles
Mar 06, 2020 08:40:33.522 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 75.0% - Cleaning bundles
Mar 06, 2020 08:40:33.523 [0x7ff70affd700] DEBUG - Activity: updated activity a67b4a01-a537-457c-a5a3-e31aaf894709 - completed 100.0% - Cleaning bundles
Mar 06, 2020 08:40:33.525 [0x7ff70affd700] DEBUG - Deleted 0 media bundles.
Mar 06, 2020 08:40:33.525 [0x7ff70affd700] DEBUG - Activity: Ended activity a67b4a01-a537-457c-a5a3-e31aaf894709.
Mar 06, 2020 08:41:23.835 [0x7ff70a7fc700] DEBUG - Sync: uploadStatus
Mar 06, 2020 08:41:28.418 [0x7ff6fa7fc700] INFO - Library section 4 (Movies) will be updated because of a change in ‘“/data/hdd0/Video/Movies”/The Nun (2018)’
Mar 06, 2020 08:41:28.420 [0x7ff6fa7fc700] DEBUG - [Notify] New directory: “/data/hdd0/Video/Movies/The Nun (2018)”, adding recursively.
Mar 06, 2020 08:41:28.420 [0x7ff6fa7fc700] DEBUG - [Notify] Now watching “/data/hdd0/Video/Movies/The Nun (2018)”
Mar 06, 2020 08:41:33.418 [0x7ff6fbfff700] DEBUG - Library Updater: Requested that section 4 be updated, force=0, deep=0, subdir=/data/hdd0/Video/Movies iTunes=0
Mar 06, 2020 08:41:33.418 [0x7ff6fbfff700] DEBUG - Library Updater: Queueing section 4
Mar 06, 2020 08:41:33.420 [0x7ff70affd700] DEBUG - Activity: registered new activity 8e82c592-1f2d-4e89-97d9-154701e13256 - Scanning
Mar 06, 2020 08:41:33.421 [0x7ff70affd700] DEBUG - Scanning section 4
Mar 06, 2020 08:41:33.421 [0x7ff70affd700] DEBUG - Activity: updated activity 8e82c592-1f2d-4e89-97d9-154701e13256 - completed 0.0% - Scanning Movies
Mar 06, 2020 08:41:33.422 [0x7ff70affd700] DEBUG - Killing job.
Mar 06, 2020 08:41:33.422 [0x7ff70affd700] DEBUG - Signalling job ID 18940 with 9
Mar 06, 2020 08:41:33.422 [0x7ff70affd700] DEBUG - Job running: EAE_ROOT=‘/tmp/pms-958831a3-53bf-4700-8899-f5c2e8de1cf9/EasyAudioEncoder’ FFMPEG_EXTERNAL_LIBS=‘/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/0bc617e-2965-linux-x86_64/’ X_PLEX_TOKEN=‘xxxxxxxxxxxxxxxxxxxx’ ‘/usr/lib/plexmediaserver/Plex Media Scanner’ ‘–scan’ ‘–refresh’ ‘–section’ ‘4’ ‘–activity’ ‘8e82c592-1f2d-4e89-97d9-154701e13256’ ‘–directory’ ‘/data/hdd0/Video/Movies’
Mar 06, 2020 08:41:33.423 [0x7ff70affd700] DEBUG - Jobs: Starting child process with pid 19428

Scanner:

Mar 06, 2020 08:41:33.472 [0x7f3ca7fce700] INFO - Plex Media Scanner v1.18.7.2457-77cb9455c - Debian GNU/Linux PC x86_64 - build: linux-x86_64 - GMT 01:00
Mar 06, 2020 08:41:33.473 [0x7f3ca7fce700] INFO - Linux version: 10 (buster), language: en-US
Mar 06, 2020 08:41:33.473 [0x7f3ca7fce700] INFO - Processor AMD E-350D APU with Radeon™ HD Graphicsÿÿ$0
Mar 06, 2020 08:41:33.473 [0x7f3ca7fce700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --scan --refresh --section 4 --activity 8e82c592-1f2d-4e89-97d9-154701e13256 --directory /data/hdd0/Video/Movies
Mar 06, 2020 08:41:33.483 [0x7f3ca8ab5740] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.26.0, threadsafe=1
Mar 06, 2020 08:41:33.929 [0x7f3ca8ab5740] DEBUG - It took 20.000000 ms to retrieve 602 items.
Mar 06, 2020 08:41:34.122 [0x7f3ca8ab5740] DEBUG - It took 20.000000 ms to retrieve 602 items.
Mar 06, 2020 08:41:34.219 [0x7f3ca8ab5740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=0
Mar 06, 2020 08:41:34.220 [0x7f3ca4a17700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/cullTimeline?librarySectionID=4&sinceTime=1583479294
Mar 06, 2020 08:41:34.223 [0x7f3ca4a17700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/cullTimeline?librarySectionID=4&sinceTime=1583479294
Mar 06, 2020 08:41:34.223 [0x7f3ca8ab5740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=0
Mar 06, 2020 08:41:34.223 [0x7f3ca8ab5740] DEBUG - Scanning Movies using en(Plex Movie Scanner) with 0 current media items and 1 section locations in the database…
Mar 06, 2020 08:41:34.478 [0x7f3ca8ab5740] DEBUG - Performing a scan with ‘Plex Movie Scanner’ (language: en virtual: 0).
Mar 06, 2020 08:41:34.478 [0x7f3ca8ab5740] DEBUG - * Scanning /data/hdd0/Video/Movies
Mar 06, 2020 08:41:34.479 [0x7f3ca8ab5740] DEBUG - Scanner: Processing directory /data/hdd0/Video/Movies (parent: no)
Mar 06, 2020 08:41:34.484 [0x7f3ca8ab5740] DEBUG - Skipping over directory ‘’, as nothing has changed; removing 0 media items from map.
Mar 06, 2020 08:41:34.488 [0x7f3ca8ab5740] DEBUG - Scanner: Processing directory /data/hdd0/Video/Movies/The Nun (2018) (parent: yes)
Mar 06, 2020 08:41:34.490 [0x7f3ca8ab5740] DEBUG - Skipping over directory ‘The Nun (2018)’, as nothing has changed; removing 0 media items from map.
Mar 06, 2020 08:41:34.490 [0x7f3ca4a17700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20The%20Nun%20(2018)
Mar 06, 2020 08:41:34.492 [0x7f3ca8ab5740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=%2B49.5&subtitle=The%20Nun%20(2018)
Mar 06, 2020 08:41:34.493 [0x7f3ca4a17700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20The%20Nun%20(2018)
Mar 06, 2020 08:41:34.496 [0x7f3ca8ab5740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=%2B49.5&subtitle=The%20Nun%20(2018)
Mar 06, 2020 08:41:34.496 [0x7f3ca8ab5740] DEBUG - Scanner: Processing directory /data/hdd0/Video/Movies/Anna (2019) (parent: yes)
Mar 06, 2020 08:41:34.498 [0x7f3ca8ab5740] DEBUG - Skipping over directory ‘Anna (2019)’, as nothing has changed; removing 0 media items from map.
Mar 06, 2020 08:41:34.499 [0x7f3ca4a17700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20Anna%20(2019)
Mar 06, 2020 08:41:34.499 [0x7f3ca8ab5740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=%2B49.5&subtitle=Anna%20(2019)
Mar 06, 2020 08:41:34.502 [0x7f3ca4a17700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20Anna%20(2019)
Mar 06, 2020 08:41:34.505 [0x7f3ca8ab5740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=%2B49.5&subtitle=Anna%20(2019)
Mar 06, 2020 08:41:34.506 [0x7f3ca8ab5740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=99.000000
Mar 06, 2020 08:41:34.509 [0x7f3ca8ab5740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=99.000000
Mar 06, 2020 08:41:34.509 [0x7f3ca8ab5740] DEBUG - Removing 0 media items that were left.
Mar 06, 2020 08:41:34.509 [0x7f3ca8ab5740] DEBUG - Removing 0 directories that were left.
Mar 06, 2020 08:41:34.509 [0x7f3ca8ab5740] DEBUG - Updating directory ‘’ (ID 5) to time 2020-03-06 08:41:28.
Mar 06, 2020 08:41:34.544 [0x7f3ca8ab5740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=100
Mar 06, 2020 08:41:34.547 [0x7f3ca8ab5740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=100
Mar 06, 2020 08:41:34.547 [0x7f3ca8ab5740] DEBUG - Refreshing section 4 of type: 1
Mar 06, 2020 08:41:34.554 [0x7f3c9e4a2700] DEBUG - Refreshing 0 IDs.

This is what I don’t understand:
Skipping over directory ‘The Nun (2018)’, as nothing has changed; removing 0 media items from map.
Huh? Why? What?

Also:
Mar 06, 2020 08:41:33.929 [0x7f3ca8ab5740] DEBUG - It took 20.000000 ms to retrieve 602 items.
602? PLEX says, there is 586 items in the library, but yes, around 20 of files is not listed in the library

8

Might want to drop this in and use the “Find Unmatched”. It will tell you what’s not been found so you can focus on them.

Please make certain to use the Released version.

9

Idiot idiot idiot idiot idiot idiot … such an idiot I am … oh my… (facepalm) …group ownership was the problem here … solved …

10

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.