Full library scan getting stuck at 96%

[ghoulli]

Hi!

I've been using Jellyfin for a bit now on TrueNAS Scale with a lot of fun. Recently, starting around the 10.9.X update via Truecharts, my Jellyfin refuses to scan further than 96%. This doesn't pose any issues when just downloading something off Sonarr, but whenever it goes for an automatic  update it gets stuck and I have to refresh the container to get it to work again. When I press the round X button at the scan in the Dashboard it also is unable to stop itself. Does anyone have any idea or experienced this same issue?

I'm gonna post a small snippet of the logs and also the full logs as an attachment.

P.S. after posting I realised that there's a dedicated forum for Media Scanning & Identification... oops. If anyone, mods or the like, could move it there it would be great.

Logs:

Code:

[2024-06-27 17:34:11.368 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-06-27 17:34:11.368 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]"
[2024-06-27 17:34:11.369 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-06-27 17:34:11.381 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind addresses: "[]"
[2024-06-27 17:34:11.381 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind exclusions: "[]"
[2024-06-27 17:34:13.389 +02:00] [FTL] [1] Main: Error while starting server.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 1: 'no such column: u.EasyPassword'.
  at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
  at Microsoft.Data.Sqlite.SqliteCommand.PrepareAndEnumerateStatements(Stopwatch timer)+MoveNext()
  at Microsoft.Data.Sqlite.SqliteCommand.GetStatements(Stopwatch timer)+MoveNext()
  at Microsoft.Data.Sqlite.SqliteDataReader.NextResult()
  at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
  at Microsoft.Data.Sqlite.SqliteCommand.ExecuteDbDataReader(CommandBehavior behavior)
  at System.Data.Common.DbCommand.ExecuteReader()
  at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReader(RelationalCommandParameterObject parameterObject)
  at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.Enumerator.InitializeReader(Enumerator enumerator)
  at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.Enumerator.<>c.<MoveNext>b__19_0(DbContext _, Enumerator enumerator)
  at Microsoft.EntityFrameworkCore.Storage.NonRetryingExecutionStrategy.Execute[TState,TResult](TState state, Func`3 operation, Func`3 verifySucceeded)
  at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.Enumerator.MoveNext()
  at Jellyfin.Server.Implementations.Users.UserManager..ctor(JellyfinDbProvider dbProvider, IEventManager eventManager, ICryptoProvider cryptoProvider, INetworkManager networkManager, IApplicationHost appHost, IImageProcessor imageProcessor, ILogger`1 logger)
  at System.RuntimeMethodHandle.InvokeMethod(Object target, Span`1& arguments, Signature sig, Boolean constructor, Boolean wrapExceptions)
  at System.Reflection.RuntimeConstructorInfo.Invoke(BindingFlags invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitConstructor(ConstructorCallSite constructorCallSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSiteMain(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitRootCache(ServiceCallSite callSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSite(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitConstructor(ConstructorCallSite constructorCallSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSiteMain(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitRootCache(ServiceCallSite callSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSite(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitConstructor(ConstructorCallSite constructorCallSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSiteMain(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.VisitRootCache(ServiceCallSite callSite, RuntimeResolverContext context)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteVisitor`2.VisitCallSite(ServiceCallSite callSite, TArgument argument)
  at Microsoft.Extensions.DependencyInjection.ServiceLookup.CallSiteRuntimeResolver.Resolve(ServiceCallSite callSite, ServiceProviderEngineScope scope)
  at Microsoft.Extensions.DependencyInjection.ServiceProvider.CreateServiceAccessor(Type serviceType)
  at System.Collections.Concurrent.ConcurrentDictionary`2.GetOrAdd(TKey key, Func`2 valueFactory)
  at Microsoft.Extensions.DependencyInjection.ServiceProvider.GetService(Type serviceType, ServiceProviderEngineScope serviceProviderEngineScope)
  at Microsoft.Extensions.DependencyInjection.ServiceProvider.GetService(Type serviceType)
  at Microsoft.Extensions.DependencyInjection.ServiceProviderServiceExtensions.GetService[T](IServiceProvider provider)
  at Emby.Server.Implementations.ApplicationHost.Resolve[T]()
  at Emby.Server.Implementations.ApplicationHost.InitializeServices()
  at Jellyfin.Server.Program.StartApp(StartupOptions options)
[2024-06-27 17:34:13.392 +02:00] [INF] [1] Main: Running query planner optimizations in the database... This might take a while
[2024-06-27 17:34:13.459 +02:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Disposing "CoreAppHost"
[2024-06-27 17:34:13.460 +02:00] [FTL] [1] Main: Unhandled Exception
System.NullReferenceException: Object reference not set to an instance of an object.
  at Emby.Server.Implementations.ApplicationHost.DisposeAsyncCore()
  at Emby.Server.Implementations.ApplicationHost.DisposeAsync()
  at Jellyfin.Server.Program.StartApp(StartupOptions options)
  at Jellyfin.Server.Program.<Main>(String[] args)
[2024-06-27 17:34:49.803 +02:00] [INF] [1] Main: Jellyfin version: "10.9.3"
[2024-06-27 17:34:49.857 +02:00] [INF] [1] Main: Environment Variables: ["[JELLYFIN_CACHE_DIR, /cache]", "[JELLYFIN_LOG_DIR, /config/log]", "[JELLYFIN_FFMPEG, /usr/lib/jellyfin-ffmpeg/ffmpeg]", "[JELLYFIN_PublishedServerUrl, https://jelly.ghoulli.com]", "[JELLYFIN_WEB_DIR, /jellyfin/jellyfin-web]", "[JELLYFIN_DATA_DIR, /config]", "[JELLYFIN_CONFIG_DIR, /config/config]"]
[2024-06-27 17:34:49.862 +02:00] [INF] [1] Main: Arguments: ["/jellyfin/jellyfin.dll", "--ffmpeg", "/usr/lib/jellyfin-ffmpeg/ffmpeg"]
[2024-06-27 17:34:49.862 +02:00] [INF] [1] Main: Operating system: "Debian GNU/Linux 12 (bookworm)"
[2024-06-27 17:34:49.862 +02:00] [INF] [1] Main: Architecture: X64
[2024-06-27 17:34:49.863 +02:00] [INF] [1] Main: 64-Bit Process: True
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: User Interactive: True
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Processor count: 4
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Program data path: "/config"
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Log directory path: "/config/log"
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Config directory path: "/config/config"
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Cache path: "/cache"
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Web resources path: "/jellyfin/jellyfin-web"
[2024-06-27 17:34:49.864 +02:00] [INF] [1] Main: Application directory: "/jellyfin/"
[2024-06-27 17:34:50.060 +02:00] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: "/cache"
[2024-06-27 17:34:50.289 +02:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies
[2024-06-27 17:34:50.331 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.AniDB, Version=8.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/AniDB_8.0.0.0/Jellyfin.Plugin.AniDB.dll"
[2024-06-27 17:34:50.334 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.AniList, Version=9.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/AniList_9.0.0.0/Jellyfin.Plugin.AniList.dll"
[2024-06-27 17:34:50.336 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.Kitsu, Version=5.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/Kitsu_5.0.0.0/Jellyfin.Plugin.Kitsu.dll"
[2024-06-27 17:34:50.431 +02: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-06-27 17:34:50.431 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions: []
[2024-06-27 17:34:50.431 +02: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-06-27 17:34:50.433 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered interface addresses: ["127.0.0.1", "172.16.1.219"]
[2024-06-27 17:34:50.433 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Bind Addresses ["0.0.0.0"]
[2024-06-27 17:34:50.433 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Remote IP filter is "Allowlist"
[2024-06-27 17:34:50.433 +02:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered subnets: []
[2024-06-27 17:34:53.593 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AniDB" "8.0.0.0"
[2024-06-27 17:34:53.594 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AniList" "9.0.0.0"
[2024-06-27 17:34:53.595 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Kitsu" "5.0.0.0"
[2024-06-27 17:34:53.596 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "TMDb" "10.9.3.0"
[2024-06-27 17:34:53.596 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Studio Images" "10.9.3.0"
[2024-06-27 17:34:53.596 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "OMDb" "10.9.3.0"
[2024-06-27 17:34:53.618 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "MusicBrainz" "10.9.3.0"
[2024-06-27 17:34:53.618 +02:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AudioDB" "10.9.3.0"
[2024-06-27 17:34:53.686 +02:00] [WRN] [1] Microsoft.AspNetCore.DataProtection.Repositories.EphemeralXmlRepository: Using an in-memory repository. Keys will not be persisted to storage.
[2024-06-27 17:34:53.686 +02:00] [WRN] [1] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: Neither user profile nor HKLM registry available. Using an ephemeral key repository. Protected data will be unavailable when application exits.
[2024-06-27 17:34:53.695 +02:00] [INF] [1] Main: Kestrel is listening on "0.0.0.0"
[2024-06-27 17:34:53.713 +02:00] [WRN] [1] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: No XML encryptor configured. Key {7136b3f4-9db4-42f5-b6c4-8facf681abb1} may be persisted to storage in unencrypted form.
[2024-06-27 17:34:54.475 +02:00] [WRN] [1] Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware: The WebRootPath was not found: "/wwwroot". Static files may be unavailable.
[2024-06-27 17:34:54.516 +02:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks
[2024-06-27 17:34:54.520 +02:00] [INF] [8] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/Films"
[2024-06-27 17:34:54.521 +02:00] [INF] [10] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/Series"
[2024-06-27 17:34:54.560 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/Shows"
[2024-06-27 17:34:54.567 +02:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Generate Trickplay Images" set to fire at 2024-06-28 03:00:00.000 +02:00, which is 09:25:05.4331249 from now.
[2024-06-27 17:34:54.572 +02:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Extract Chapter Images" set to fire at 2024-06-28 02:00:00.000 +02:00, which is 08:25:05.4278027 from now.
[2024-06-27 17:34:54.613 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version "6.0.1"
[2024-06-27 17:34:54.672 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "decoders": ["libdav1d", "av1", "av1_cuvid", "av1_qsv", "h264", "h264_qsv", "h264_cuvid", "hevc", "hevc_qsv", "hevc_cuvid", "mpeg2video", "mpeg2_qsv", "mpeg2_cuvid", "mpeg4", "mpeg4_cuvid", "msmpeg4", "vc1_qsv", "vc1_cuvid", "vp8", "libvpx", "vp8_cuvid", "vp8_qsv", "vp9", "libvpx-vp9", "vp9_cuvid", "vp9_qsv", "aac", "ac3", "dca", "flac", "mp3", "truehd"]
[2024-06-27 17:34:54.697 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "encoders": ["libsvtav1", "av1_nvenc", "av1_qsv", "av1_amf", "av1_vaapi", "libx264", "h264_amf", "h264_nvenc", "h264_qsv", "h264_v4l2m2m", "h264_vaapi", "libx265", "hevc_amf", "hevc_nvenc", "hevc_qsv", "hevc_vaapi", "mjpeg_qsv", "mjpeg_vaapi", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "libfdk_aac", "ac3", "alac", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"]
[2024-06-27 17:34:54.725 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available filters: ["deinterlace_qsv", "deinterlace_vaapi", "hwupload_cuda", "hwupload_vaapi", "libplacebo", "overlay_opencl", "overlay_qsv", "overlay_vaapi", "overlay_vulkan", "overlay_cuda", "procamp_vaapi", "scale_cuda", "scale_opencl", "scale_qsv", "scale_vaapi", "scale_vulkan", "tonemap_cuda", "tonemap_opencl", "tonemap_vaapi", "vpp_qsv", "yadif_cuda", "zscale", "alphasrc"]
[2024-06-27 17:34:54.878 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: ["cuda", "vaapi", "qsv", "drm", "opencl", "vulkan"]
[2024-06-27 17:34:55.105 +02:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: "/usr/lib/jellyfin-ffmpeg/ffmpeg"
[2024-06-27 17:34:55.106 +02:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: "d81e86aa1ac34ac7939e6aa14a28322e"
[2024-06-27 17:34:55.106 +02:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete
[2024-06-27 17:34:55.106 +02:00] [INF] [1] Main: Startup complete 0:00:05.6410568
[2024-06-27 17:34:57.602 +02:00] [INF] [8] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Clean up collections and playlists" Completed after 0 minute(s) and 0 seconds
[2024-06-27 17:34:59.352 +02:00] [INF] [19] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Update Plugins" Completed after 0 minute(s) and 1 seconds
[2024-06-27 17:35:22.204 +02:00] [INF] [21] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.2.254" request
[2024-06-27 17:35:43.441 +02:00] [INF] [26] MediaBrowser.Providers.TV.SeriesMetadataService: Removing virtual season null in series "Delicious in Dungeon"
[2024-06-27 17:35:43.446 +02:00] [INF] [26] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Season", Name: "Season Unknown", Path: "", Id: 2c08071c-f9c0-ed24-dfdb-c146c09e74fe
[2024-06-27 17:35:43.465 +02:00] [INF] [26] MediaBrowser.Providers.TV.SeriesMetadataService: Creating Season "Season Unknown" entry for "Delicious in Dungeon"
[2024-06-27 17:36:21.483 +02:00] [INF] [24] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.2.254" closed
[2024-06-27 17:36:21.986 +02:00] [INF] [24] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.2.254" request
[2024-06-27 17:36:25.561 +02:00] [INF] [14] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.2.254" closed
[2024-06-27 17:36:25.875 +02:00] [INF] [14] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.2.254" request
[2024-06-27 17:36:28.751 +02:00] [INF] [32] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/Films"
[2024-06-27 17:36:28.752 +02:00] [INF] [32] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/Series"
[2024-06-27 17:36:28.753 +02:00] [INF] [32] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/Shows"
[2024-06-27 17:36:28.756 +02:00] [INF] [32] Emby.Server.Implementations.Library.LibraryManager: Validating media library
[2024-06-27 17:36:28.784 +02:00] [WRN] [32] MediaBrowser.Controller.Entities.BaseItem: Library folder "/config/data/playlists" is inaccessible or empty, skipping
[2024-06-27 17:36:28.825 +02:00] [WRN] [32] MediaBrowser.Controller.Entities.BaseItem: Library folder "/config/data/playlists" is inaccessible or empty, skipping
[2024-06-27 17:36:30.622 +02:00] [INF] [19] MediaBrowser.Providers.TV.SeriesMetadataService: Removing virtual season null in series "Delicious in Dungeon"
[2024-06-27 17:36:30.622 +02:00] [INF] [19] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Season", Name: "Season Unknown", Path: "", Id: 2c08071c-f9c0-ed24-dfdb-c146c09e74fe
[2024-06-27 17:36:30.629 +02:00] [INF] [19] MediaBrowser.Providers.TV.SeriesMetadataService: Creating Season "Season Unknown" entry for "Delicious in Dungeon"

[theguymadmax]

Looks like you are on 10.9.3. Update to 10.9.7 and see if you are still having issues. There's been a ton of bug fixes since then. That particular entry you posted was due to a bug dealing with custom season names, which was fixed in the later releases.

[ghoulli]

Thanks for your reply! That's good to hear it's been fixed. Problem is currently that the latest release I can get from TrueNAS Scale (Using the Truecharts list) is 10.9.3 and I am not sure how to force this to update.

[ghoulli]

I have found the problem. The Jellyfin updates I was getting via TrueCHARTS. Truecharts is no longer updating their repository for TrueNAS Scale. That's why it's not receiving them. The issue is solved I suppose.

[Efficient_Good_5784]

Currently, you can deploy custom apps with Truenas Scale. So you can pull the latest Jellyfin image from Docker or Github, then run it with the custom app option.

Later this year (around October), Scale will get an update that brings Docker to run its apps and to replace Kubernetes. The anouncement of Kubernetes being dropped from Scale resulted in Truecharts dropping all support for Truenas Scale and depreciating their current apps on it as well. That means all Truecharts apps will not get any more updates on Scale from now on.