Internal Server Error (http error 500) in downloading (many) offline tracks

[ChristW 3]

Hi,

I'm trying to download (lots of) music/audio book files to my phone (Fairphone 5). I've created 2 Downloads, one for my Music library, one for my Audiobooks library. Both contain thousands (12000 + 8000) of files (20000 in total).

I _think_ I went through all the hoops debugging this (turning VPN on and off, installing latest Emby server version, deleted Downloads and the 'offending' device from the server), and now turn to you to see if there's a solution to my problem.

Eventually, I saw something in the logs that was interesting, an HTTP error 500, plus a long delay in giving reply to my client.

```

2025-03-03 16:25:52.960 Info Server: http/1.1 POST http://192.168.178.55:8096/emby/Sync/data. Source Ip: host3, UserAgent: okhttp/4.12.0
2025-03-03 16:25:54.501 Info Server: http/1.1 POST http://192.168.178.55:8096/emby/Sync/data. Source Ip: host3, UserAgent: okhttp/4.12.0
2025-03-03 16:25:54.857 Info Server: http/1.1 Response 200 to host3. Time: 1897ms. POST http://192.168.178.55:8096/emby/Sync/data
2025-03-03 16:25:54.861 Info Server: http/1.1 Response 500 to host3. Time: 10390ms. GET http://192.168.178.55:8096/emby/Sync/Items/Ready?TargetId=cfc0c569f2fcb07b
2025-03-03 16:25:54.861 Info Server: http/1.1 Response 200 to host3. Time: 360ms. POST http://192.168.178.55:8096/emby/Sync/data
2025-03-03 16:25:54.887 Info Server: http/1.1 Response 500 to host3. Time: 11951ms. GET http://192.168.178.55:8096/emby/Sync/Items/Ready?TargetId=cfc0c569f2fcb07b
2025-03-03 16:26:05.078 Info Server: http/1.1 POST http://192.168.178.55:8096/emby/Sync/data. Source Ip: host3, UserAgent: okhttp/4.12.0
2025-03-03 16:26:05.984 Info Server: http/1.1 Response 200 to host3. Time: 907ms. POST http://192.168.178.55:8096/emby/Sync/data
2025-03-03 16:26:05.985 Info Server: http/1.1 Response 500 to host3. Time: 10927ms. GET http://192.168.178.55:8096/emby/Sync/Items/Ready?TargetId=cfc0c569f2fcb07b

```

On the server, and in the App, downloads are showing as 'Ready to transfer'

Full logs (after restarting the server) attached. Hope someone can help. If instructed to, I could turn on debug logging (to see slow queries??), but haven't found how to do that, yet...

Oh, I tried downloading 'just' a couple of albums, and that seemed to work. But, I want to have all my music with me all the time (you never know when you want to hear that track, album, or episode...)

embyserver.txt

[ChristW 3]

Temporarily enabling the Debug logging, I get this:

```

2025-03-07 13:38:07.745 Debug Server: http/1.1 GET http://192.168.178.55:8096/emby/Users/c51bfe2671bf4155b10a832611d453f8/Views?X-Emby-Client=Emby for Android&X-Emby-Device-Name=FP5&X-Emby-Device-Id=cfc0c569f2fcb07b&X-Emby-Client-Version=3.4.36&X-Emby-Token=x_secret3_x&X-Emby-Language=nl. Source Ip: host3, UserAgent: Mozilla/5.0 (Linux; Android 14; FP5 Build/UKQ1.230924.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36
2025-03-07 13:38:07.750 Debug Server: http/1.1 GET http://192.168.178.55:8096/emby/Users/c51bfe2671bf4155b10a832611d453f8?X-Emby-Client=Emby for Android&X-Emby-Device-Name=FP5&X-Emby-Device-Id=cfc0c569f2fcb07b&X-Emby-Client-Version=3.4.36&X-Emby-Token=x_secret3_x&X-Emby-Language=nl. Source Ip: host3, UserAgent: Mozilla/5.0 (Linux; Android 14; FP5 Build/UKQ1.230924.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36
2025-03-07 13:38:07.751 Debug Server: http/1.1 Response 200 to host3. Time: 1ms. GET http://192.168.178.55:8096/emby/Users/c51bfe2671bf4155b10a832611d453f8?X-Emby-Client=Emby for Android&X-Emby-Device-Name=FP5&X-Emby-Device-Id=cfc0c569f2fcb07b&X-Emby-Client-Version=3.4.36&X-Emby-Token=x_secret3_x&X-Emby-Language=nl
2025-03-07 13:38:09.023 Debug SqliteItemRepository: GetitemById Audio 3790 /volume1/EmbyMedia/Music/A Night at the Met/Robin Williams - A Night at the Met - 16. ...and the Future.flac
2025-03-07 13:38:09.025 Debug SqliteItemRepository: GetitemById Audio 8145 /volume1/EmbyMedia/Music/Face Value (2015 Re-Master)/Phil Collins - Face Value (2015 Re-Master) - 20. ... And So To F (Live).flac
2025-03-07 13:38:09.026 Debug Server: http/1.1 Response 200 to host3. Time: 1280ms. GET http://192.168.178.55:8096/emby/Users/c51bfe2671bf4155b10a832611d453f8/Views?X-Emby-Client=Emby for Android&X-Emby-Device-Name=FP5&X-Emby-Device-Id=cfc0c569f2fcb07b&X-Emby-Client-Version=3.4.36&X-Emby-Token=x_secret3_x&X-Emby-Language=nl
2025-03-07 13:38:09.026 Debug SqliteItemRepository: GetitemById Audio 17517 /volume1/EmbyMedia/Music/Under A Blood Red Sky/U2 - Under A Blood Red Sky - 08. '40'.flac
2025-03-07 13:38:09.027 Debug SqliteItemRepository: GetitemById Audio 35374 /volume1/EmbyMedia/Music/The Studio Albums 2009-2018/67. .38 Special.flac
2025-03-07 13:38:09.027 Debug SqliteItemRepository: GetitemById Audio 7584 /volume1/EmbyMedia/Music/Een goede raad/J. K. Rowling - Een goede raad - 04. 'Barry Fairbrother is dood,' zei Ruth Prince hijgend.flac
2025-03-07 13:38:09.028 Debug SqliteItemRepository: GetitemById Audio 7715 /volume1/EmbyMedia/Music/Een goede raad/J. K. Rowling - Een goede raad - 84. '...stormde hier moord en brand schreeuwend de deur uit,'.flac

.

.

.

2025-03-07 13:38:40.607 Debug SqliteItemRepository: GetitemById Audio 38929 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 11. Zonnedek.mp3
2025-03-07 13:38:40.608 Debug SqliteItemRepository: GetitemById Audio 38930 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 12. Zonnedek.mp3
2025-03-07 13:38:40.608 Debug SqliteItemRepository: GetitemById Audio 38933 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 15. Zonnedek.mp3
2025-03-07 13:38:40.609 Debug SqliteItemRepository: GetitemById Audio 38938 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 20. Zonnedek.mp3
2025-03-07 13:38:40.610 Debug SqliteItemRepository: GetitemById Audio 38943 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 25. Zonnedek.mp3
2025-03-07 13:38:40.610 Debug SqliteItemRepository: GetitemById Audio 38944 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 26. Zonnedek.mp3
2025-03-07 13:38:40.611 Debug SqliteItemRepository: GetitemById Audio 38945 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 27. Zonnedek.mp3
2025-03-07 13:38:40.612 Debug SqliteItemRepository: GetitemById Audio 38947 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 29. Zonnedek.mp3
2025-03-07 13:38:40.612 Debug SqliteItemRepository: GetitemById Audio 38952 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 34. Zonnedek.mp3
2025-03-07 13:38:40.613 Debug SqliteItemRepository: GetitemById Audio 38957 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 39. Zee.mp3
2025-03-07 13:38:40.613 Debug SqliteItemRepository: GetitemById Audio 38962 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 44. Zonnedek.mp3
2025-03-07 13:38:40.614 Debug SqliteItemRepository: GetitemById Audio 38974 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 56. Zonnedek.mp3
2025-03-07 13:38:40.615 Debug SqliteItemRepository: GetitemById Audio 38980 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 62. Zonnedek.mp3
2025-03-07 13:38:40.615 Debug SqliteItemRepository: GetitemById Audio 39025 /volume1/EmbyMedia/Audiobooks/Jetset/Marion Pauw - Jetset - 107. Zonnedek.mp3
2025-03-07 13:38:40.616 Debug Sync: Returning 20111 ready sync items for targetId 1
2025-03-07 13:38:41.173 Info Server: http/1.1 Response 500 to host3. Time: 34830ms. GET http://192.168.178.55:8096/emby/Sync/Items/Ready?TargetId=cfc0c569f2fcb07b
2025-03-07 13:38:44.212 Info Server: http/1.1 Response 500 to host3. Time: 31119ms. GET http://192.168.178.55:8096/emby/Sync/Items/Ready?TargetId=cfc0c569f2fcb07b
```

So, the number of 'ready' items matches what I expect, but the client only sees 1 Download list of 13227 items (the Music), not the rest (Audio books).

I haven't seen anything in the logs that points me to a 'slow query', but I noticed that listing those 20000 items took about 31 seconds...

[ChristW 3]

Installed the latest version of the server software, 4.8.11.0. The problem persists...

 

 

embyserver.txt

[Luke 42077]

HI, we'll take a look at it. Thanks.