search

NixOS / nixpkgs

Nix Packages collection & NixOS
MIT License
18.12k stars 14.16k forks source link

plex: crash on stop #338676

Closed jackwilsdon closed 2 months ago

jackwilsdon commented 2 months ago

Describe the bug

Stopping Plex with systemctl stop plex causes it to core dump:

Aug 31 20:49:37 machine PlexMediaServer[146255]: Received SIGQUIT: Quit from keyboard.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Shutting down with signal 3 (Quit)
Aug 31 20:49:37 machine systemd[1]: Stopping Plex Media Server...
Aug 31 20:49:37 machine PlexMediaServer[146176]: Ordered to stop server.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Stopping server...
Aug 31 20:49:37 machine PlexMediaServer[146176]: HttpServer: Stopping server.
Aug 31 20:49:37 machine PlexMediaServer[146176]: MetadataItemClusterRequestHandler: a shutdown event has been received
Aug 31 20:49:37 machine PlexMediaServer[146176]: TranscodeJobManager: [Running] onServerShutdown
Aug 31 20:49:37 machine PlexMediaServer[146176]: TranscodeJobManager: [Running] -> [Shutdown]
Aug 31 20:49:37 machine PlexMediaServer[146176]: Server stopped.
Aug 31 20:49:37 machine PlexMediaServer[146176]: NetworkService: Stopping advertisement.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Network Service: Error in advertiser handle read: 125 (Operation canceled) socket=73
Aug 31 20:49:37 machine PlexMediaServer[146176]: Killing plug-ins.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.agents.htbackdrops] Killing.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.agents.localmedia] Killing.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.agents.lyricfind] Killing.
Aug 31 20:49:37 machine PlexMediaServer[146176]: JobManager: Could not find job for handle 146281
Aug 31 20:49:37 machine systemd-coredump[146433]: Process 146168 (bwrap) of user 193 terminated abnormally with signal 3/QUIT, processing...
Aug 31 20:49:37 machine PlexMediaServer[146176]: JobManager: Could not find job for handle 146355
Aug 31 20:49:37 machine PlexMediaServer[146176]: BufferingLineReader: failed to read line (error: -1)
Aug 31 20:49:37 machine PlexMediaServer[146176]: Timeout or error reading status line from plug-in pipe [com.plexapp.agents.localmedia], we're killing it.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Stopping [com.plexapp.agents.localmedia].
Aug 31 20:49:37 machine PlexMediaServer[146176]: Error received reading configuration for com.plexapp.agents.localmedia
Aug 31 20:49:37 machine PlexMediaServer[146176]: Stopping [com.plexapp.agents.localmedia].
Aug 31 20:49:37 machine PlexMediaServer[146176]: JobManager: Could not find job for handle 146282
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.agents.plexthememusic] Killing.
Aug 31 20:49:37 machine systemd[1]: Started Process Core Dump (PID 146433/UID 0).
Aug 31 20:49:37 machine PlexMediaServer[146176]: JobManager: Could not find job for handle 146278
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.system] Killing.
Aug 31 20:49:37 machine PlexMediaServer[146176]: ChildProcessMonitor: Waiting for Plex Tuner Service to exit.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [JobRunner] Signalling job ID 146255 with 2
Aug 31 20:49:37 machine PlexMediaServer[146255]: Received SIGINT: Interrupt from keyboard.
Aug 31 20:49:37 machine PlexMediaServer[146176]: JobManager: Could not find job for handle 146207
Aug 31 20:49:37 machine PlexMediaServer[146176]: [HttpClient/HCl#17] HTTP error requesting GET http://127.0.0.1:33685/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_ (52, Server returned nothing (no headers, no data)). Network appears to be configured for jumbo frames.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [HttpClient/HCl#13] HTTP error requesting GET http://127.0.0.1:33685/system/agents (7, Couldn't connect to server) (Failed to connect to 127.0.0.1 port 33685 after 0 ms: Couldn't connect to server)
Aug 31 20:49:37 machine PlexMediaServer[146176]: [Req#4e] [com.plexapp.system] HTTP reply status -52, with 0 bytes of content.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.system] HTTP reply status -7, with 0 bytes of content.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.system] Couldn't connect to plug-in, treating as dead.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Stopping [com.plexapp.system].
Aug 31 20:49:37 machine PlexMediaServer[146176]: Error parsing content.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Exception caught while updating system agent list: Error parsing file
Aug 31 20:49:37 machine PlexMediaServer[146176]: The system knows about 1 agents.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.agents.thetvdb] Agent not known by system, so we're starting for sure.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Starting file watcher for com.plexapp.agents.thetvdb
Aug 31 20:49:37 machine PlexMediaServer[146176]: Starting plug-in /nix/store/y392qnfdgb8w91digwk04xr264i3s3xg-plexmediaserver-1.40.4.8679-424562606/lib/plexmediaserver/Resources/Plug-ins-424562606/WebClient.bundle.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Starting plug-in /nix/store/y392qnfdgb8w91digwk04xr264i3s3xg-plexmediaserver-1.40.4.8679-424562606/lib/plexmediaserver/Resources/Plug-ins-424562606/PlexMovie.bundle.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Updating the list of agents known by the system.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Updating the list of agents known by the system.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Starting file watcher for com.plexapp.system
Aug 31 20:49:37 machine PlexMediaServer[146176]: Plugin com.plexapp.agents.thetvdb startup cancelled, In shutdown state.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Plugin com.plexapp.system startup cancelled, In shutdown state.
Aug 31 20:49:37 machine PlexMediaServer[146176]: The system knows about 0 agents.
Aug 31 20:49:37 machine PlexMediaServer[146176]: [com.plexapp.system] Plug-in is starting, waiting 180 seconds for it to complete.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Starting plug-in /nix/store/y392qnfdgb8w91digwk04xr264i3s3xg-plexmediaserver-1.40.4.8679-424562606/lib/plexmediaserver/Resources/Plug-ins-424562606/TheMovieDB.bundle.
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term. Stop all devices
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term. Shut down all device auxes
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] tvbutler_aux_t::term
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] web_server_t::stop. Web server is stopped
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term. Stop all devices
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] device_manager_t::term. Shut down all device auxes
Aug 31 20:49:37 machine PlexMediaServer[146255]: [I] broker_t::shutdown. Shutdown is completed.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Jobs: '/nix/store/y392qnfdgb8w91digwk04xr264i3s3xg-plexmediaserver-1.40.4.8679-424562606/lib/plexmediaserver/Plex Tuner Service' exit code for process 146255 is 0 (success)
Aug 31 20:49:37 machine PlexMediaServer[146176]: [ChildProcessMonitor] Plex Tuner Service exited.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Database: Shutting down.
Aug 31 20:49:37 machine PlexMediaServer[146176]: Database: Shutting down.
Aug 31 20:49:37 machine systemd-coredump[146434]: [🡕] Process 146168 (bwrap) of user 193 dumped core.

                                                 Module libpcre2-8.so.0 without build-id.
                                                 Module libcap.so.2 without build-id.
                                                 Module libselinux.so.1 without build-id.
                                                 Module bwrap without build-id.
                                                 Stack trace of thread 146168:
                                                 #0  0x00007fbd71c8ecd4 __poll (libc.so.6 + 0x101cd4)
                                                 #1  0x0000000000403e5a main (bwrap + 0x3e5a)
                                                 #2  0x00007fbd71bb714e __libc_start_call_main (libc.so.6 + 0x2a14e)
                                                 #3  0x00007fbd71bb7209 __libc_start_main@@GLIBC_2.34 (libc.so.6 + 0x2a209)
                                                 #4  0x0000000000405495 _start (bwrap + 0x5495)
                                                 ELF object binary architecture: AMD x86-64
Aug 31 20:49:37 machine systemd[1]: systemd-coredump@15-146433-0.service: Deactivated successfully.
Aug 31 20:49:37 machine systemd[1]: plex.service: Main process exited, code=dumped, status=3/QUIT
Aug 31 20:49:37 machine systemd[1]: plex.service: Failed with result 'core-dump'.
Aug 31 20:49:37 machine systemd[1]: Stopped Plex Media Server.

Steps To Reproduce

Steps to reproduce the behavior:

  1. Enable Plex with services.plex.enable = true.
  2. Stop Plex with systemctl stop plex.

Expected behavior

Plex should stop cleanly.

Notify maintainers

@badmutex @forkk @lnl7 @pjones @thoughtpolice @MayNiklas

Metadata

Please run nix-shell -p nix-info --run "nix-info -m" and paste the result.

[user@system:~]$ nix-shell -p nix-info --run "nix-info -m"
 - system: `"x86_64-linux"`
 - host os: `Linux 6.10.6, NixOS, 24.11 (Vicuna), 24.11.20240827.a6292e3`
 - multi-user?: `yes`
 - sandbox: `yes`
 - version: `nix-env (Nix) 2.18.5`
 - nixpkgs: `/nix/store/h1v7aq3k9wy0i5l53cirm7kka7fsipji-source`

Add a :+1: reaction to issues you find important.

SuperSandro2000 commented 2 months ago

Is this a dupe of #173338 ?

jackwilsdon commented 2 months ago

Ah yep - not sure how I missed that. Thanks!