Jellyfin Forum
Extremely Slow Startup - Printable Version

+- Jellyfin Forum (https://forum.jellyfin.org)
+-- Forum: Support (https://forum.jellyfin.org/f-support)
+--- Forum: Troubleshooting (https://forum.jellyfin.org/f-troubleshooting)
+--- Thread: Extremely Slow Startup (/t-extremely-slow-startup)



Extremely Slow Startup - ps1 - 2024-10-18

I have a installed Jellyfin 10.9.11 on my Linux server via direct install method. When starting up, server takes over 2.5 minutes to startup

Code:
[2024-10-18 12:06:23.415 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Bind Addresses ["0.0.0.0"]
[2024-10-18 12:06:23.415 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Remote IP filter is "Allowlist"
[2024-10-18 12:06:23.415 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered subnets: []
[2024-10-18 12:08:56.953 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Transcode Killer" "3.0.0.0"
[2024-10-18 12:08:56.955 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "TMDb" "10.9.11.0"
[2024-10-18 12:08:56.955 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Studio Images" "10.9.11.0"
[2024-10-18 12:08:56.956 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "OMDb" "10.9.11.0"
[2024-10-18 12:08:56.997 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "MusicBrainz" "10.9.11.0"
[2024-10-18 12:08:56.998 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AudioDB" "10.9.11.0"
[2024-10-18 12:08:57.198 +00:00] [INF] [1] Main: Kestrel is listening on "0.0.0.0"

Notice the time difference between 'Filtered' subnets and 'Loaded plugin: "Transcode Killer" "3.0.0.0"' message. What could be causing this?


RE: Extremely Slow Startup - Fate - 2024-10-18

Can you try with the transcode killer plugin removed?


RE: Extremely Slow Startup - ps1 - 2024-10-18

I did, it is the same result.


RE: Extremely Slow Startup - TheDreadPirate - 2024-10-18

Can you describe your setup? What distro (I'm assuming a Debian/Ubuntu derivative)? You said it is a direct install, but is the machine you directly installed it to a VM or LXC? How is storage situated? Is the Jellyfin database located on a SSD that is directly attached to the machine?


RE: Extremely Slow Startup - ps1 - 2024-10-18

Gentoo linux running on whatbox (not VM). Jellyfin DB on an SSD.


RE: Extremely Slow Startup - TheDreadPirate - 2024-10-18

Can you share your full log via pastebin?


RE: Extremely Slow Startup - ps1 - 2024-10-19

[2024-10-18 14:02:12.891 +00:00] [INF] [1] Main: Jellyfin version: "10.9.11"
[2024-10-18 14:02:12.918 +00:00] [INF] [1] Main: Environment Variables: ["[JELLYFIN_LOG_DIR, /.config/jellyfin/log]"]
[2024-10-18 14:02:12.921 +00:00] [INF] [1] Main: Arguments: ["/usr/share/jellyfin/jellyfin.dll", "-d", "/.config/jellyfin/data", "-C", "/.config/jellyfin/cache", "-c", "/.config/jellyfin/config", "-l", "/.config/jellyfin/log", "--ffmpeg", "/usr/bin/ffmpeg"]
[2024-10-18 14:02:12.921 +00:00] [INF] [1] Main: Operating system: "Gentoo Linux"
[2024-10-18 14:02:12.921 +00:00] [INF] [1] Main: Architecture: X64
[2024-10-18 14:02:12.921 +00:00] [INF] [1] Main: 64-Bit Process: True
[2024-10-18 14:02:12.921 +00:00] [INF] [1] Main: User Interactive: True
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Processor count: 72
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Program data path: "/.config/jellyfin/data"
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Log directory path: "/.config/jellyfin/log"
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Config directory path: "/.config/jellyfin/config"
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Cache path: "/.config/jellyfin/cache"
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Web resources path: "/usr/share/jellyfin/jellyfin-web"
[2024-10-18 14:02:12.922 +00:00] [INF] [1] Main: Application directory: "/usr/share/jellyfin/"
[2024-10-18 14:02:13.151 +00:00] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: "/.config/jellyfin/cache"
[2024-10-18 14:02:13.281 +00:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies
[2024-10-18 14:02:13.433 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.TranscodeKiller, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null" from "/.config/jellyfin/data/plugins/Transcode Killer_3.0.0.0/Jellyfin.Plugin.TranscodeKiller.dll"
[2024-10-18 14:02:13.563 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"]
[2024-10-18 14:02:13.563 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions: []
[2024-10-18 14:02:13.564 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Used LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"]
[2024-10-18 14:02:13.566 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered interface addresses: ["127.0.0.1", "xxxxxxxxx"]
[2024-10-18 14:02:13.567 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Bind Addresses ["0.0.0.0"]
[2024-10-18 14:02:13.567 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Remote IP filter is "Allowlist"
[2024-10-18 14:02:13.567 +00:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered subnets: []
[2024-10-18 14:06:15.710 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "TMDb" "10.9.11.0"
[2024-10-18 14:06:15.711 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Studio Images" "10.9.11.0"
[2024-10-18 14:06:15.711 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "OMDb" "10.9.11.0"
[2024-10-18 14:06:15.747 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "MusicBrainz" "10.9.11.0"
[2024-10-18 14:06:15.747 +00:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AudioDB" "10.9.11.0"
[2024-10-18 14:06:15.982 +00:00] [INF] [1] Main: Kestrel is listening on "0.0.0.0"
[2024-10-18 14:06:17.281 +00:00] [WRN] [1] Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware: The WebRootPath was not found: "/mnt/mpathai/plexstreams/wwwroot". Static files may be unavailable.
[2024-10-18 14:06:17.371 +00:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks
[2024-10-18 14:06:17.444 +00:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Scan Media Library" set to fire at 2024-10-19 08:00:00.000 +00:00, which is 17:53:42.5555154 from now.
[2024-10-18 14:06:17.480 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version "6.1.1"
[2024-10-18 14:06:17.514 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "decoders": ["libdav1d", "av1", "h264", "hevc", "mpeg2video", "mpeg4", "msmpeg4", "vp8", "vp9", "aac", "ac3", "dca", "flac", "mp3", "truehd"]
[2024-10-18 14:06:17.534 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "encoders": ["libx264", "h264_v4l2m2m", "libx265", "mpeg4", "msmpeg4", "aac", "ac3", "alac", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"]
[2024-10-18 14:06:17.556 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available filters: []
[2024-10-18 14:06:17.573 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "scale_cuda" with option "Output format (default \"same\")" is not available
[2024-10-18 14:06:17.590 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "tonemap_cuda" with option "GPU accelerated HDR to SDR tonemapping" is not available
[2024-10-18 14:06:17.604 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "tonemap_opencl" with option "bt2390" is not available
[2024-10-18 14:06:17.617 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "overlay_opencl" with option "Action to take when encountering EOF from secondary input" is not available
[2024-10-18 14:06:17.633 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "overlay_vaapi" with option "Action to take when encountering EOF from secondary input" is not available
[2024-10-18 14:06:17.646 +00:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "overlay_vulkan" with option "Action to take when encountering EOF from secondary input" is not available
[2024-10-18 14:06:17.664 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: []
[2024-10-18 14:06:18.785 +00:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: "/usr/bin/ffmpeg"
[2024-10-18 14:06:18.787 +00:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: "b73b35593bc7473c8b07f6d3f38260bf"
[2024-10-18 14:06:18.787 +00:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete
[2024-10-18 14:06:18.787 +00:00] [INF] [1] Main: Startup complete 0:04:06.3679898
[2024-10-18 14:06:20.511 +00:00] [INF] [16] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Clean up collections and playlists" Completed after 0 minute(s) and 0 seconds
[2024-10-18 14:06:21.242 +00:00] [INF] [18] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Update Plugins" Completed after 0 minute(s) and 0 seconds
[2024-10-18 19:39:47.919 +00:00] [INF] [30] Jellyfin.Server.Implementations.Users.UserManager: Authentication request for "admin" has succeeded.
[2024-10-18 19:39:47.925 +00:00] [INF] [30] Emby.Server.Implementations.Session.SessionManager: Current/Max sessions for user "admin": 0/0
[2024-10-18 19:39:47.926 +00:00] [INF] [30] Emby.Server.Implementations.Session.SessionManager: Creating new access token for user 8f20fa97-3625-469b-8580-52f34f383bd9
[2024-10-18 19:39:48.318 +00:00] [INF] [30] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "142.215.114.18" request
[2024-10-18 19:40:06.117 +00:00] [INF] [44] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "142.215.114.18" closed
[2024-10-18 19:40:11.298 +00:00] [INF] [32] Jellyfin.Server.Implementations.Users.UserManager: Authentication request for "admin" has succeeded.


RE: Extremely Slow Startup - TheDreadPirate - 2024-10-19

With the available information, I can't really say anything conclusive other than, perhaps, it is struggling to bind to the network interface.

You can try enabling debug logging BRIEFLY. It is extremely verbose.

Open up /.config/jellyfin/config/logging.default.json and modify these lines near the top.

Code:
{
    "Serilog": {
        "MinimumLevel": {
            "Default": "Information",
            "Override": {
                "Microsoft": "Warning",
                "System": "Warning"
            }

Replace Information and Warning with Debug. Save the file and then restart Jellyfin. Once the startup complete you will switch them back to their original values. Once you save the file, the change in logging should happen immediately. No need to restart jellyfin again.

Once you've done that, post your logs either to pastebin.com, if they are small enough, or zip the log file and attach it to a forum post.