Audio Books library not loading - exaveal - 2024-02-13
Hi all!
first I have to say: Thanks for alle the work, love the project.
I am running jellyfin on a raspberry pi 4 ubuntu server 22.04.03 lts installation.
Performance is really good, data is stored on a ssd.
I started to have problems when trying to use the podcasts and the audio book feature. I have added several podcasts & audio books and now the audio book library is not loading, podcast library is very slow. Meaning in the client selecting audio books leads to an never ending loading circle. the list never shows. With Podcasts its simliar, but it will load after a while. I have added 13 podcasts with 90 GB to jellyfin. when clicking on Podcasts, it loads around ~14 seconds until the podcast list is shown.
As a comparison:
"Music" is loading around 1,5 seconds, and the library is around 80GB
"Series" is loading around 0,5 seconds with 2,7 TB
"Movies" is loading around 2,5 seconds with 2,2 TB
It seems client inpendent. Same problem with Jellyfin Media Player Desktop Client, Jellyfin for Android or in the webbrowser.
In the log-location /var/logs/jellyfin is now log file for the current day, only for yesterday. So I have nothing where I can check on.
/€dit: Now I see the log file - don't know if I have been blind before ..
That's the log file after trying to open audio books. But I think there is nothing in the log that shows any error.
Code: wolf@frida:/var/log/jellyfin$ cat jellyfin20240213.log
[2024-02-13 21:13:32.436 +01:00] [INF] Jellyfin version: "10.8.13"
[2024-02-13 21:13:32.524 +01:00] [INF] Environment Variables: ["[JELLYFIN_CACHE_DIR, /var/cache/jellyfin]", "[JELLYFIN_USER, jellyfin]", "[JELLYFIN_FFMPEG_OPT, --ffmpeg=/usr/lib/jellyfin-ffmpeg/ffmpeg]", "[JELLYFIN_ADDITIONAL_OPTS, ]", "[JELLYFIN_CONFIG_DIR, /home/wolf/hd_cloud/jellyfin/config]", "[JELLYFIN_ARGS, $JELLYFIN_WEB_OPT $JELLYFIN_RESTART_OPT $JELLYFIN_FFMPEG_OPT $JELLYFIN_SERVICE_OPT $JELLYFIN_NOWEBAPP_OPT $JELLFIN_ADDITIONAL_OPTS]", "[JELLYFIN_WEB_OPT, --webdir=/usr/share/jellyfin/web]", "[JELLYFIN_LOG_DIR, /var/log/jellyfin]", "[JELLYFIN_RESTART_OPT, --restartpath=/usr/lib/jellyfin/restart.sh]", "[JELLYFIN_DATA_DIR, /var/lib/jellyfin]"]
[2024-02-13 21:13:32.536 +01:00] [INF] Arguments: ["/usr/lib/jellyfin/bin/jellyfin.dll", "--webdir=/usr/share/jellyfin/web", "--restartpath=/usr/lib/jellyfin/restart.sh", "--ffmpeg=/usr/lib/jellyfin-ffmpeg/ffmpeg"]
[2024-02-13 21:13:32.540 +01:00] [INF] Operating system: "Linux"
[2024-02-13 21:13:32.540 +01:00] [INF] Architecture: Arm64
[2024-02-13 21:13:32.544 +01:00] [INF] 64-Bit Process: True
[2024-02-13 21:13:32.544 +01:00] [INF] User Interactive: True
[2024-02-13 21:13:32.544 +01:00] [INF] Processor count: 4
[2024-02-13 21:13:32.544 +01:00] [INF] Program data path: "/var/lib/jellyfin"
[2024-02-13 21:13:32.545 +01:00] [INF] Web resources path: "/usr/share/jellyfin/web"
[2024-02-13 21:13:32.546 +01:00] [INF] Application directory: "/usr/lib/jellyfin/bin/"
[2024-02-13 21:13:33.107 +01:00] [INF] Setting cache path: "/var/cache/jellyfin"
[2024-02-13 21:13:33.264 +01:00] [INF] Loading assemblies
[2024-02-13 21:13:33.300 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.Fanart, Version=10.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/Fanart_10.0.0.0/Jellyfin.Plugin.Fanart.dll"
[2024-02-13 21:13:33.307 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.IMVDb, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/IMVDb_3.0.0.0/Jellyfin.Plugin.IMVDb.dll"
[2024-02-13 21:13:33.330 +01:00] [INF] Loaded assembly "LiteDB, Version=5.0.12.0, Culture=neutral, PublicKeyToken=4ee40123013c9f27" from "/var/lib/jellyfin/plugins/Kodi Sync Queue_9.0.0.0/LiteDB.dll"
[2024-02-13 21:13:33.335 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.KodiSyncQueue, Version=9.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/Kodi Sync Queue_9.0.0.0/Jellyfin.Plugin.KodiSyncQueue.dll"
[2024-02-13 21:13:33.341 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.OpenSubtitles, Version=19.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/Open Subtitles_19.0.0.0/Jellyfin.Plugin.OpenSubtitles.dll"
[2024-02-13 21:13:33.345 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.PlaybackReporting, Version=13.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/Playback Reporting_13.0.0.0/Jellyfin.Plugin.PlaybackReporting.dll"
[2024-02-13 21:13:33.350 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.Reports, Version=15.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/Reports_15.0.0.0/Jellyfin.Plugin.Reports.dll"
[2024-02-13 21:13:33.357 +01:00] [INF] Loaded assembly "TvDbSharper, Version=3.2.2.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TheTVDB_10.0.0.0/TvDbSharper.dll"
[2024-02-13 21:13:33.365 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.Tvdb, Version=10.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TheTVDB_10.0.0.0/Jellyfin.Plugin.Tvdb.dll"
[2024-02-13 21:13:33.411 +01:00] [INF] Loaded assembly "Polly, Version=7.0.0.0, Culture=neutral, PublicKeyToken=c8a3ffc3f8f825cc" from "/var/lib/jellyfin/plugins/TVmaze_10.0.0.0/Polly.dll"
[2024-02-13 21:13:33.416 +01:00] [INF] Loaded assembly "Flurl, Version=3.0.1.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TVmaze_10.0.0.0/Flurl.dll"
[2024-02-13 21:13:33.421 +01:00] [INF] Loaded assembly "TvMaze.Api.Client, Version=0.1.72.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TVmaze_10.0.0.0/TvMaze.Api.Client.dll"
[2024-02-13 21:13:33.429 +01:00] [INF] Loaded assembly "Flurl.Http, Version=3.0.1.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TVmaze_10.0.0.0/Flurl.Http.dll"
[2024-02-13 21:13:33.433 +01:00] [INF] Loaded assembly "Jellyfin.Plugin.TvMaze, Version=10.0.0.0, Culture=neutral, PublicKeyToken=null" from "/var/lib/jellyfin/plugins/TVmaze_10.0.0.0/Jellyfin.Plugin.TvMaze.dll"
[2024-02-13 21:13:33.758 +01:00] [INF] Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-02-13 21:13:33.759 +01:00] [INF] Defined LAN exclusions : "[]"
[2024-02-13 21:13:33.762 +01:00] [INF] Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-02-13 21:13:33.780 +01:00] [INF] Using bind addresses: "[]"
[2024-02-13 21:13:33.781 +01:00] [INF] Using bind exclusions: "[]"
[2024-02-13 21:13:57.813 +01:00] [INF] Loaded plugin: "Fanart" "10.0.0.0"
[2024-02-13 21:13:57.817 +01:00] [INF] Loaded plugin: "IMVDb" "3.0.0.0"
[2024-02-13 21:13:57.820 +01:00] [INF] KodiSyncQueue is starting...
[2024-02-13 21:13:57.822 +01:00] [INF] Creating DB Repository...
[2024-02-13 21:13:57.988 +01:00] [INF] Loaded plugin: "Kodi Sync Queue" "9.0.0.0"
[2024-02-13 21:13:57.990 +01:00] [INF] Loaded plugin: "Open Subtitles" "19.0.0.0"
[2024-02-13 21:13:57.993 +01:00] [INF] Loaded plugin: "Playback Reporting" "13.0.0.0"
[2024-02-13 21:13:57.995 +01:00] [INF] Loaded plugin: "Reports" "15.0.0.0"
[2024-02-13 21:13:57.998 +01:00] [INF] Loaded plugin: "TheTVDB" "10.0.0.0"
[2024-02-13 21:13:58.000 +01:00] [INF] Loaded plugin: "TVmaze" "10.0.0.0"
[2024-02-13 21:13:58.002 +01:00] [INF] Loaded plugin: "TMDb" "10.8.13.0"
[2024-02-13 21:13:58.004 +01:00] [INF] Loaded plugin: "Studio Images" "10.8.13.0"
[2024-02-13 21:13:58.005 +01:00] [INF] Loaded plugin: "OMDb" "10.8.13.0"
[2024-02-13 21:13:58.007 +01:00] [INF] Loaded plugin: "MusicBrainz" "10.8.13.0"
[2024-02-13 21:13:58.009 +01:00] [INF] Loaded plugin: "AudioDB" "10.8.13.0"
[2024-02-13 21:13:58.275 +01:00] [INF] Kestrel listening on "Any IP4 Address"
[2024-02-13 21:13:59.666 +01:00] [INF] Running startup tasks
[2024-02-13 21:13:59.668 +01:00] [INF] Retention task scheduled
[2024-02-13 21:13:59.670 +01:00] [INF] TaskCleanDb Loaded
[2024-02-13 21:13:59.680 +01:00] [INF] TaskRunBackup Loaded
[2024-02-13 21:13:59.743 +01:00] [INF] Daily trigger for "Remove Old Sync Data" set to fire at 2024-02-14 00:01:00.000 +01:00, which is 02:47:00.2565318 from now.
[2024-02-13 21:13:59.746 +01:00] [INF] Daily trigger for "Playback Reporting Trim Db" set to fire at 2024-02-14 00:00:00.000 +01:00, which is 02:46:00.2535764 from now.
[2024-02-13 21:13:59.807 +01:00] [INF] Daily trigger for "Extrahiere Kapitel-Bilder" set to fire at 2024-02-14 02:00:00.000 +01:00, which is 04:46:00.1928563 from now.
[2024-02-13 21:13:59.979 +01:00] [INF] Found ffmpeg version "5.1.4"
[2024-02-13 21:14:00.088 +01:00] [INF] Available "decoders": ["libdav1d", "av1", "h264", "hevc", "mpeg2video", "mpeg4", "msmpeg4", "vp8", "libvpx", "vp9", "libvpx-vp9", "aac", "ac3", "dca", "flac", "mp3", "truehd"]
[2024-02-13 21:14:00.139 +01:00] [INF] Available "encoders": ["libx264", "h264_v4l2m2m", "libx265", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "libfdk_aac", "ac3", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"]
[2024-02-13 21:14:00.187 +01:00] [INF] Available filters: ["hwupload_vaapi", "zscale", "alphasrc"]
[2024-02-13 21:14:00.235 +01:00] [WRN] Filter: "scale_cuda" with option "Output format (default \"same\")" is not available
[2024-02-13 21:14:00.281 +01:00] [WRN] Filter: "tonemap_cuda" with option "GPU accelerated HDR to SDR tonemapping" is not available
[2024-02-13 21:14:00.320 +01:00] [WRN] Filter: "tonemap_opencl" with option "bt2390" is not available
[2024-02-13 21:14:00.361 +01:00] [WRN] Filter: "overlay_opencl" with option "Action to take when encountering EOF from secondary input" is not available
[2024-02-13 21:14:00.408 +01:00] [WRN] Filter: "overlay_vaapi" with option "Action to take when encountering EOF from secondary input" is not available
[2024-02-13 21:14:00.450 +01:00] [INF] Available hwaccel types: ["drm"]
[2024-02-13 21:14:00.773 +01:00] [INF] FFmpeg: "/usr/lib/jellyfin-ffmpeg/ffmpeg"
[2024-02-13 21:14:00.776 +01:00] [INF] ServerId: "c7458980eb9c4a64a8cee4e5ff5d8a86"
[2024-02-13 21:14:01.207 +01:00] [INF] Registering publisher for "urn:schemas-upnp-org:device:MediaServer:1" on "192.168.101.103/24"
[2024-02-13 21:14:01.276 +01:00] [INF] Registering publisher for "urn:schemas-upnp-org:device:MediaServer:1" on "172.17.0.1/16"
[2024-02-13 21:14:01.278 +01:00] [INF] Registering publisher for "urn:schemas-upnp-org:device:MediaServer:1" on "127.0.0.1/8"
[2024-02-13 21:14:01.290 +01:00] [INF] Executed all pre-startup entry points in 0:00:00.4806023
[2024-02-13 21:14:01.290 +01:00] [INF] Core startup complete
[2024-02-13 21:14:01.298 +01:00] [INF] EventMonitorEntryPoint Running
[2024-02-13 21:14:01.320 +01:00] [INF] Sqlite version: 3.38.3
[2024-02-13 21:14:01.324 +01:00] [INF] Sqlite compiler options: ATOMIC_INTRINSICS=1,COMPILER=gcc-7.5.0,DEFAULT_AUTOVACUUM,DEFAULT_CACHE_SIZE=-2000,DEFAULT_FILE_FORMAT=4,DEFAULT_FOREIGN_KEYS,DEFAULT_JOURNAL_SIZE_LIMIT=-1,DEFAULT_MMAP_SIZE=0,DEFAULT_PAGE_SIZE=4096,DEFAULT_PCACHE_INITSZ=20,DEFAULT_RECURSIVE_TRIGGERS,DEFAULT_SECTOR_SIZE=4096,DEFAULT_SYNCHRONOUS=2,DEFAULT_WAL_AUTOCHECKPOINT=1000,DEFAULT_WAL_SYNCHRONOUS=2,DEFAULT_WORKER_THREADS=0,ENABLE_COLUMN_METADATA,ENABLE_FTS3,ENABLE_FTS3_PARENTHESIS,ENABLE_FTS4,ENABLE_FTS5,ENABLE_RTREE,ENABLE_SNAPSHOT,MALLOC_SOFT_LIMIT=1024,MAX_ATTACHED=10,MAX_COLUMN=2000,MAX_COMPOUND_SELECT=500,MAX_DEFAULT_PAGE_SIZE=8192,MAX_EXPR_DEPTH=1000,MAX_FUNCTION_ARG=127,MAX_LENGTH=1000000000,MAX_LIKE_PATTERN_LENGTH=50000,MAX_MMAP_SIZE=0x7fff0000,MAX_PAGE_COUNT=1073741823,MAX_PAGE_SIZE=65536,MAX_SQL_LENGTH=1000000000,MAX_TRIGGER_DEPTH=1000,MAX_VARIABLE_NUMBER=32766,MAX_VDBE_OP=250000000,MAX_WORKER_THREADS=8,MUTEX_PTHREADS,SYSTEM_MALLOC,TEMP_STORE=1,THREADSAFE=1
[2024-02-13 21:14:01.337 +01:00] [INF] Default journal_mode for "/var/lib/jellyfin/data/playback_reporting.db" is "delete"
[2024-02-13 21:14:01.338 +01:00] [INF] Initialize PlaybackActivity Repository
[2024-02-13 21:14:01.339 +01:00] [INF] PlaybackActivity table schema OK
[2024-02-13 21:14:01.339 +01:00] [INF] Expected : "datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int"
[2024-02-13 21:14:01.339 +01:00] [INF] Received : "datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int"
[2024-02-13 21:14:01.356 +01:00] [INF] Loading live tv data from "/var/lib/jellyfin/data/livetv/timers.json"
[2024-02-13 21:14:02.274 +01:00] [INF] Executed all post-startup entry points in 0:00:00.9834009
[2024-02-13 21:14:02.274 +01:00] [INF] Startup complete 0:00:30.3560644
[2024-02-13 21:14:02.291 +01:00] [INF] Watching directory "/home/wolf/hd_data01/audio/hoerbuecher"
[2024-02-13 21:14:02.297 +01:00] [INF] Watching directory "/home/wolf/hd_data01/audio/podcasts"
[2024-02-13 21:14:02.299 +01:00] [INF] Watching directory "/home/wolf/hd_data01/audio/vids"
[2024-02-13 21:14:02.323 +01:00] [INF] Watching directory "/home/wolf/hd_data02/filme/dokumentationen"
[2024-02-13 21:14:02.495 +01:00] [INF] Watching directory "/home/wolf/hd_data01/audio/musik"
[2024-02-13 21:14:02.520 +01:00] [INF] Watching directory "/var/lib/jellyfin/data/collections"
[2024-02-13 21:14:02.533 +01:00] [INF] Watching directory "/home/wolf/hd_data03/serien"
[2024-02-13 21:14:02.536 +01:00] [INF] Watching directory "/var/lib/jellyfin/data/livetv/recordings"
[2024-02-13 21:14:02.830 +01:00] [INF] "StartupTrigger" fired for task: "Aktualisiere Plugins"
[2024-02-13 21:14:02.835 +01:00] [INF] Queuing task "PluginUpdateTask"
[2024-02-13 21:14:02.848 +01:00] [INF] Executing "Aktualisiere Plugins"
[2024-02-13 21:14:02.856 +01:00] [INF] Watching directory "/home/wolf/hd_cloud/fotos"
[2024-02-13 21:14:02.858 +01:00] [INF] Watching directory "/home/wolf/hd_data02/filme/spielfilme"
[2024-02-13 21:14:06.643 +01:00] [INF] "Aktualisiere Plugins" Completed after 0 minute(s) and 3 seconds
[2024-02-13 21:14:06.663 +01:00] [INF] ExecuteQueuedTasks
[2024-02-13 21:14:32.927 +01:00] [INF] Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-02-13 21:14:32.927 +01:00] [INF] Defined LAN exclusions : "[]"
[2024-02-13 21:14:32.927 +01:00] [INF] Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]"
[2024-02-13 21:15:27.053 +01:00] [INF] WS "192.168.101.102" request
[2024-02-13 21:16:16.023 +01:00] [INF] Sending ForceKeepAlive message to 1 inactive WebSockets.
[2024-02-13 21:16:28.023 +01:00] [INF] Lost 1 WebSockets.
Is this a known problem? I could not find anything about problems with the library for podcasts or audio books.
RE: Audio Books library not loading - TheDreadPirate - 2024-02-13
For your other libraries, are their images stored with the videos/music on the SSD?
RE: Audio Books library not loading - exaveal - 2024-02-13
You mean images as pictures? Yes a lot. All album arts and stuff downloaded by jellyfin.
RE: Audio Books library not loading - TheDreadPirate - 2024-02-13
I don't see anything in your log or your setup that points to an obvious problem. I have no idea why it would only affect one, smaller, library and not the other larger libraries.
RE: Audio Books library not loading - exaveal - 2024-02-15
Okay so I had to find it out myself. Logging of Jellyfin is just grab. If problems aren't shown in the log file, than the logging can be thrown to trash.
So that's what I did:
1. I removed all audio books from the library
2. I added again one by one
3. After the 5th audio book, loading already took 7(!) seconds. Wow.
4. After adding audio book number 15, the library isn't loading at all anymore. And it does not matter which audio book I take. So it's just "too much" for Jellyfin.
So there must be some really big problem in the listing of Podcasts and Audio Books. And if the library gets "too big" (lol) than it's not loading at all anymore. So I bet, when I add more Podcasts, the same will happpen with my Podcast library.
As this bug won't be fixed soon (database rewrite?!) I will have to look for another solution
Nevertheless thanks for your help Pirate! Perhaps somebody finds this thread before trying to use Jellyfin for Podcasts and/or Audio books. I will have a look into https://www.audiobookshelf.org/.
RE: Audio Books library not loading - exaveal - 2024-07-10
Since last update, the problem is fixed. Audio Library is loading in light speed
|