All of a sudden plexpass container will start but the PMS service will exit 1. Searching shows matches for permissions issues but things look good. I cant create files and directories at /config from inside the container as well.
plexpass logs:
2022-05-27 12:17:47,476 DEBG 'plexmediaserver' stderr output:
mkdir: cannot create directory ‘/config’: Permission denied
2022-05-27 12:17:47,487 DEBG 'plexmediaserver' stderr output:
PMS: failure detected. Read/write access is required for path: /config/Plex Media Server
2022-05-27 12:17:47,488 DEBG fd 8 closed, stopped monitoring <POutputDispatcher at 23299864848864 for <Subprocess at 23299864843632 with name plexmediaserver in state STARTING> (stdout)>
2022-05-27 12:17:47,488 DEBG fd 12 closed, stopped monitoring <POutputDispatcher at 23299864849152 for <Subprocess at 23299864843632 with name plexmediaserver in state STARTING> (stderr)>
2022-05-27 12:17:47,488 INFO exited: plexmediaserver (exit status 1; not expected)
2022-05-27 12:17:47,488 DEBG received SIGCHLD indicating a child quit
2022-05-27 12:17:48,489 INFO gave up: plexmediaserver entered FATAL state, too many start retries too quickly
permissions from inside the container:
root@unraid:~# docker exec -it binhex-plexpass /bin/bash
[root@unraid /]# ls -lah /config
total 53M
drwx------ 1 root root 284 May 19 13:14 .
drwxr-xr-x 1 root root 256 May 27 12:17 ..
-rw-r--r-- 1 root root 162 Nov 12 2021 perms.txt
drwx------ 1 root root 188 May 19 15:32 'Plex Media Server'
-rw-r--r-- 1 root root 0 May 19 13:14 test
drwxr-xr-x 1 root root 0 Nov 12 2021 tmp
drwxrwxrwx 1 root root 9.5K May 18 11:38 transcode
[root@unraid /]# id
uid=0(root) gid=0(root) groups=0(root)
update:// I see the note @ FAQ Q4 about the logs. No new logs are being generated and last dated May 18.
Here are the last few lines:
May 18, 2022 11:38:11.873 [0x1542ed66eb38] DEBUG - Network change.
May 18, 2022 11:38:11.873 [0x1542ed66eb38] DEBUG - NetworkInterface: Notified of network changed (force=0)
May 18, 2022 11:38:11.873 [0x1542ed66eb38] DEBUG - Network change notification but nothing changed.
May 18, 2022 11:38:12.957 [0x1542efb48b38] DEBUG - Shutting down with signal 15 (Terminated)
May 18, 2022 11:38:12.957 [0x1542efb48b38] DEBUG - Ordered to stop server.
May 18, 2022 11:38:12.957 [0x1542efc33d50] DEBUG - Stopping server...
May 18, 2022 11:38:12.957 [0x1542efc33d50] DEBUG - HttpServer: Stopping server.
May 18, 2022 11:38:12.958 [0x1542ed5d2b38] DEBUG - MetadataItemClusterRequestHandler: a shutdown event has been received
May 18, 2022 11:38:12.958 [0x1542ed5d2b38] DEBUG - TranscodeJobManager: [Running] onServerShutdown
May 18, 2022 11:38:12.958 [0x1542ed5d2b38] DEBUG - TranscodeJobManager: [Running] -> [Shutdown]
May 18, 2022 11:38:12.958 [0x1542efc33d50] DEBUG - Server stopped.
May 18, 2022 11:38:12.958 [0x1542efc33d50] DEBUG - NetworkService: Stopping advertisement.
May 18, 2022 11:38:12.958 [0x1542ed628b38] ERROR - Network Service: Error in advertiser handle read: 125 (Operation canceled) socket=73
May 18, 2022 11:38:12.958 [0x1542efc33d50] DEBUG - Killing plug-ins.
May 18, 2022 11:38:12.986 [0x1542efc33d50] DEBUG - [com.plexapp.system] Killing.
May 18, 2022 11:38:12.988 [0x1542efb48b38] WARN - JobManager: Could not find job for handle 89
May 18, 2022 11:38:13.058 [0x1542ed628b38] INFO - Network Service: Abandoning advertise socket, it was closed.
May 18, 2022 11:38:13.263 [0x1542efc33d50] DEBUG - ChildProcessMonitor: Waiting for Plex Tuner Service to exit.
May 18, 2022 11:38:13.263 [0x1542efc33d50] DEBUG - [JobRunner] Signalling job ID 142 with 2
May 18, 2022 11:38:14.110 [0x1542efb48b38] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Tuner Service' exit code for process 142 is 0 (success)
May 18, 2022 11:38:14.110 [0x1542ed5f5b38] DEBUG - [ChildProcessMonitor] Plex Tuner Service exited.
May 18, 2022 11:38:14.110 [0x1542efc33d50] INFO - Killing process: Plex EAE Service (pid: 253)
May 18, 2022 11:38:14.110 [0x1542efc33d50] DEBUG - Killing job.
May 18, 2022 11:38:14.110 [0x1542efc33d50] DEBUG - Signalling job ID 253 with 9
May 18, 2022 11:38:14.112 [0x1542efc33d50] DEBUG - Killing job.
May 18, 2022 11:38:14.112 [0x1542efc33d50] DEBUG - Signalling job ID 4576 with 9
May 18, 2022 11:38:14.112 [0x1542efc33d50] DEBUG - Database: Shutting down.
May 18, 2022 11:38:14.114 [0x1542efb48b38] DEBUG - Jobs: '/config/Plex Media Server/Codecs/EasyAudioEncoder-1785-linux-x86_64/EasyAudioEncoder/EasyAudioEncoder' exit code for process 253 is -9 (signal: Killed)
May 18, 2022 11:38:14.186 [0x1542efc33d50] DEBUG - Database: Shutting down.