Plex scans and recognizes new content but does not add content

[bigbruise]

Server Version#: 1.18.6.2368
Player Version#: 4.20.2

Radarr and Sonarr handle my media naming and placing. These apps have been in my infrastructure for a few years now. Working without issue.

Problem:
As of the version I’m on, I’m noticing that content from only one folder is not being added to Plex.

Automatic scanning and manual scanning produce the same result.

• Content will be scanned but not added.

Work around.
Move the file to another monitored folder.
Move the file back to the original location.
Plex adds the content.

For example:
Movie is added to monitored folder.
Plex scans folder.
Plex recognizes new media.
Plex does not add new media.

Logs: after a manual scan

Feb 17, 2020 19:31:12.283 [0x7f24c2d44740] DEBUG - Scanner: Processing directory /mnt/wdten/movies/Queen & Slim (2019) (parent: yes)
Feb 17, 2020 19:31:12.284 [0x7f24c2d44740] DEBUG - Skipping over directory 'Queen & Slim (2019)', as nothing has changed; removing 0 media items from map.

Queen & Slim was download and added to /mnt/wdten/movies today. Plex noticed the file and scanned but did not notice a change and did not add the file.

This is only occurring on /mnt/wdten/movies and /mnt/wdten/tv_shows

/mnt/wdten/ is a ext4 formatted 10TB drive inside a Linux Mint machine.
My Plex user has permission to access this directory as I can browse it from Plex.

Steps taken:
Rebooted Plex service
Rebooted Plex server
Removed and re-added the folder in the library settings.
Found the work around mentioned above.

[ChuckPa]

may I have a few examples please so I may use to diagnose with?

I’m looking into one problem which has just surfaced.

[bigbruise]

Hey @ChuckPa,

Can you expand on what you’re looking for?

The log snippet above is from just over an hour ago. That movie was added to the monitored folder at 1343 and the auto scan created the same results.

Here is the stack from 1343 today during the auto scan.

Feb 17, 2020 13:43:24.452 [0x7f6289211700] INFO - Plex Media Scanner v1.18.6.2368-97add474d - Linux Mint PC x86_64 - build: linux-x86_64 - GMT -05:00
Feb 17, 2020 13:43:24.452 [0x7f6289211700] INFO - Linux version: 19.3 (Tricia), language: en-US
Feb 17, 2020 13:43:24.452 [0x7f6289211700] INFO - Processor AMD Ryzen 7 1700 Eight-Core Processor          
Feb 17, 2020 13:43:24.452 [0x7f6289211700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --scan --refresh --section 1 --activity 4c324c34-4260-42a5-93a5-b24d12cf7b29 --directory /mnt/wdten/movies/Queen & Slim (2019)
Feb 17, 2020 13:43:24.453 [0x7f6291ca2740] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.26.0, threadsafe=1
Feb 17, 2020 13:43:24.519 [0x7f6291ca2740] DEBUG - It took 0.000000 ms to retrieve 125 items.
Feb 17, 2020 13:43:24.523 [0x7f6291ca2740] DEBUG - It took 0.000000 ms to retrieve 125 items.
Feb 17, 2020 13:43:24.527 [0x7f6291ca2740] DEBUG - It took 0.000000 ms to retrieve 125 items.
Feb 17, 2020 13:43:24.532 [0x7f6291ca2740] DEBUG - It took 0.000000 ms to retrieve 125 items.
Feb 17, 2020 13:43:24.535 [0x7f6291ca2740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=0
Feb 17, 2020 13:43:24.535 [0x7f62820e1700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1581963804
Feb 17, 2020 13:43:24.536 [0x7f62820e1700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1581963804
Feb 17, 2020 13:43:24.536 [0x7f6291ca2740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=0
Feb 17, 2020 13:43:24.536 [0x7f6291ca2740] DEBUG - Scanning Movies using en(Plex Movie Scanner) with 0 current media items and 1 section locations in the database...
Feb 17, 2020 13:43:24.601 [0x7f6291ca2740] DEBUG - Performing a scan with 'Plex Movie Scanner' (language: en virtual: 0).
Feb 17, 2020 13:43:24.601 [0x7f6291ca2740] DEBUG -   * Scanning /mnt/wdten/movies/Queen & Slim (2019)
Feb 17, 2020 13:43:24.601 [0x7f6291ca2740] DEBUG - Scanner: Processing directory /mnt/wdten/movies/Queen & Slim (2019) (parent: yes)
Feb 17, 2020 13:43:24.602 [0x7f6291ca2740] DEBUG - Skipping over directory 'Queen & Slim (2019)', as nothing has changed; removing 0 media items from map.
Feb 17, 2020 13:43:24.602 [0x7f6291ca2740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=%2B0&subtitle=Queen%20%26%20Slim%20%282019%29
Feb 17, 2020 13:43:24.602 [0x7f62820e1700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20Queen%20%26%20Slim%20%282019%29
Feb 17, 2020 13:43:24.603 [0x7f62820e1700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/updateProgressMessage?message=Scanning%20Queen%20%26%20Slim%20%282019%29
Feb 17, 2020 13:43:24.603 [0x7f6291ca2740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=%2B0&subtitle=Queen%20%26%20Slim%20%282019%29
Feb 17, 2020 13:43:24.604 [0x7f6291ca2740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=99.000000
Feb 17, 2020 13:43:24.605 [0x7f6291ca2740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=99.000000
Feb 17, 2020 13:43:24.605 [0x7f6291ca2740] DEBUG - Removing 0 media items that were left.
Feb 17, 2020 13:43:24.605 [0x7f6291ca2740] DEBUG - Removing 0 directories that were left.
Feb 17, 2020 13:43:24.606 [0x7f6291ca2740] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/activities/?percentComplete=100
Feb 17, 2020 13:43:24.606 [0x7f6291ca2740] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/activities/?percentComplete=100
Feb 17, 2020 13:43:24.606 [0x7f6291ca2740] DEBUG - Refreshing section 1 of type: 1
Feb 17, 2020 13:43:24.608 [0x7f627bb22700] DEBUG - Refreshing 0 IDs.

Let me know what you’re looking for and I’ll get it to you.

[ChuckPa]

I’m looking for specific names which are not seen by PMS.

I know of one problem addressed by 1.18.7 regarding IMDB in this regard.

Re TheTVDB, we’re looking for any examples which can give a pattern.

Whatever the example(s), please state if TV or movie.

[bigbruise]

Movies:
Queen & Slim (2019)
Dark Waters (2019)
Jojo Rabbit (2019)

TV Shows:
Avenue 5 S01E05

[ChuckPa]

“Avenue 5”

I am on PMS 1.18.5.2309 so should be good for you if you’re 1.18.4 and above.

[bigbruise]

I am on 1.18.6.2368. I don’t think this issue is isolated or caused by specific titles. It seems more involved with the scanning and PMS recognizing content it scans.

I provided a work around that brings the file into PMS. This shows it’s not a problem adding the file. It’s the scanning recognizing a new file. So far, from a specific folder.

[ChuckPa]

Is this therefore a Linux permission/naming issue?
I used the naming as given ( “Avenue 5”).

My script populated extras (please ignore)

[chuck@lizum tv.532]$ cd Avenue\ 5/
[chuck@lizum Avenue 5.533]$ ls -laR
.:
total 56
drwxr-xr-x   4 chuck chuck  4096 Feb 17 21:49 ./
drwxr-xr-x 911 chuck chuck 45056 Feb 17 21:49 ../
drwxr-xr-x   2 chuck chuck  4096 Feb 17 21:49 Season 01/
drwxr-xr-x   2 chuck chuck  4096 Feb 17 21:49 Season 02/

./Season 01:
total 88
drwxr-xr-x 2 chuck chuck 4096 Feb 17 21:49 ./
drwxr-xr-x 4 chuck chuck 4096 Feb 17 21:49 ../
-rw-r--r-- 1 chuck chuck  264 Feb 17 21:49 Avenue 5 - S01E01.mkv
-rw-r--r-- 1 chuck chuck  264 Feb 17 21:49 Avenue 5 - S01E02.mkv
-rw-r--r-- 1 chuck chuck  264 Feb 17 21:49 Avenue 5 - S01E03.mkv

[bigbruise]

I do not think so as my work around proves otherwise.

jimmy@mintbox:/mnt/wdten/tv_shows/Avenue 5$ ls -laR
.:
total 12
drwxrwxr-x 3 jimmy jimmy 4096 Jan 19 22:38  .
drwxrwxr-x 8 jimmy jimmy 4096 Feb  7 18:27  ..
drwxr-xr-x 2 jimmy jimmy 4096 Feb 17 08:03 'Season 1'

'./Season 1':
total 8395004
drwxr-xr-x 2 jimmy jimmy       4096 Feb 17 08:03  .
drwxrwxr-x 3 jimmy jimmy       4096 Jan 19 22:38  ..
-rw-r--r-- 1 jimmy jimmy 1117331485 Jan 20 03:36 'Avenue 5 - S01E01 - I Was Flying WEBDL-1080p.mkv'
-rw-r--r-- 1 jimmy jimmy 1070249795 Jan 27 03:35 'Avenue 5 - S01E02 - And Then He’s Gonna Shoot Off… WEBDL-1080p.mkv'
-rw-r--r-- 1 jimmy jimmy 2134758424 Jan 31 15:26 "Avenue 5 - S01E03 - I'm a Hand Model WEBDL-1080p.mkv"
-rw-r--r-- 1 jimmy jimmy 2072482358 Feb  9 22:32 'Avenue 5 - S01E04 - Wait a Minute, Then Who Was That on the Ladder WEBDL-1080p.mkv'
-rw-rw-r-- 1 jimmy jimmy 2201619152 Feb 17 06:53 "Avenue 5 - S01E05 - He's Only There To Stop His Skeleton Falling Over WEBDL-1080p.mkv"

[bigbruise]

This is indeed a permission problem. Not a Plex problem.

Something changed in my environment that is now changing Sonarr / Radarr create directories and files (movies and TV shows) permissions. For the /mnt/wdten directory only.

Applying 777 permissions on the folder temporarily solves the problem for the recently added content. It’s a manual process of applying permissions to each newly added file until I find the fix.

[hanses]

@bigbruise
I got exactly the same issue, but can’t seem to figure it out… it had been working for a long time with my sonarr/radarr setup, bit now all of a sudden it does not work anymore. I got the same workaround to “fix” the problem, but I Can’t find any permission issues.

I don’t know if you noticed that if you changed the view in Plex from “movies” to “folders” the folder for the movie would appear, but it would be empty. That is the case for me. Don’t know if that is any help.

Would really appreciate some help. This is driving me nuts.

[ChuckPa]

Asking the dumb questions.

1. Permissions are set (show advanced)?
2. Finished download handling (which is what does the work)

[hanses]

Set permissions has always been set to off. The dataset in freenas does this automatically. And I can indeed see that the files downloaded has the correct permissions, and it has not changed since the last time this worked.

[ChuckPa]

I run normal linux, not bsd, and this has always worked.
I was just trying to help and ask the dumb question because I’ve found myself staring at the problem for hours and then doing a big ole’ facepalm.

[hanses]

Thanks anyway!
I’m running Plex in a jail:) and Permissions are set on the dataset and then the dataset is being mounted to the jail. The files get the correct permissions, but Plex won’t add them on the scan. It adds the folder, but not the movie inside of it. But if I move the folder away from the library folder, and move it back in, Plex picks up the movie. And that does not act like a permission problem?

Nothing in my setup changed, but all of a sudden this stopped working…

[ChuckPa]

Linux has the inotify kernel service.
The default table size holds 8192 directories.
Until that table fills, PMS will get the first event (top most directory being monitored) then add any new subdirectories (which catches all the files contained therein).

Restart and see if “No Space Left on Device” occurs in the logs.

If it fills up, new directories will mysteriously not be seen.

Quickest way to test is to Plex Dance the media block (series) , scan files, empty trash, clean bundles (most important) and move it back. Observe if it picks everything up.

[hanses]

New folder will be seen, but the .mkv file inside the folder does not get picked up by Plex. And this wouldn’t be an issue because the movie does add when moving the movie out and back In to the library folder?

I’ve also done those things unfortunately. And it all results in the movies being added to Plex, but for the next new media added to the library folder, Plex will not add them…

[bigbruise]

I had to set permissions at the application level rather than the OS level in the end.

Haven’t had a problem since. Gave up on trying to fix it at a OS level, the permissions would not stay consistent for newly added content, no matter what I did.