Jellyfin Forum
Audio out of sync every few minutes - 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: Audio out of sync every few minutes (/t-audio-out-of-sync-every-few-minutes)

Audio out of sync every few minutes - Henni - 2024-08-17

Hi all,

recently I'm having trouble with my audio. It only seems to happen with Dolby Atmos tracks (twice so far: Black Hawk Down 4k remux and The Abyss 4k remux). 
The problem itself is the following:
  • The audio has a small hiccup (about 1 seccond)
  • The audio is totally out of sync after resuming

I can only resolve it by exiting the movie and resuming. The hiccups happen about every 5-20 minutes. Unfortunately, it's hard to reproduce because of that.

My setup is the following:
  • Jellyfin Docker on Synology version 10.9.9
  • Jellyfin for androidTV version 0.17.3 on nvidia shield pro 2019
  • Sony Bravia TV
  • Anthem MRX 740 AVR

What I've tried so far:
  • I've tried using Just Player as an external player
  • Restarting everything
  • Enabling dolby audio bitstream


The logs I found are:

Code:
[2024-08-17 16:50:22.012 +00:00] [INF] [35] Jellyfin.LiveTv.Guide.GuideManager: Refreshing guide with 7 days of guide data
[2024-08-17 16:50:22.017 +00:00] [INF] [35] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Refresh Guide" Completed after 0 minute(s) and 3 seconds
[2024-08-17 17:07:58.458 +00:00] [INF] [25] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "7482340" ms
[2024-08-17 17:08:17.679 +00:00] [INF] [117] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:12:36.052 +00:00] [INF] [40] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "7739075" ms
[2024-08-17 17:12:37.113 +00:00] [INF] [37] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:14:46.934 +00:00] [INF] [25] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "7867634" ms
[2024-08-17 17:14:47.810 +00:00] [INF] [102] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:18:28.955 +00:00] [INF] [25] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "8087467" ms
[2024-08-17 17:18:30.279 +00:00] [INF] [25] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:24:23.489 +00:00] [INF] [106] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "8439448" ms
[2024-08-17 17:24:24.543 +00:00] [INF] [66] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:24:31.011 +00:00] [INF] [65] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "5597" ms
[2024-08-17 17:24:40.365 +00:00] [INF] [66] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-17 17:31:15.976 +00:00] [INF] [100] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "8763188" ms
[2024-08-17 17:36:05.841 +00:00] [WRN] [44] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "192.168.178.90" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake."
[2024-08-17 17:36:05.923 +00:00] [INF] [44] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.178.90" closed
[2024-08-17 17:37:50.232 +00:00] [INF] [103] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.178.37" request

Unfotunately, we've watched a lot of DTS movies recently which don't have this problem, so I cannot say for sure if a specific update caused this problem. It did work before without issues though.

Thank you for your help Smiling-face

RE: Audio out of sync every few minutes - TheDreadPirate - 2024-08-17

You can try repackaging the problem files. Open a bash shell for the container and use ffmpeg to remux.

Code:
sudo docker exec -it jellyfin bash
/usr/lib/jellyfin-ffmpeg/ffmpeg -fflags +genpts+igndts -i "/container/path/to/video.mkv" -map 0 -codec copy newFile.mkv


RE: Audio out of sync every few minutes - Henni - 2024-08-18

Thanks, but this did not seem to help. What I've found out now is, that the hiccups always appear at the same timestamps of the movie.
Quitting and resuming the stream works, because it'll resume a few seconds after the "hiccup-timestamp".

But I can reliably reprocude the behavior by selecting the last chapter of Black Hawk Down. The hiccup will trigger a few seconds into that chapter.
This means I can provide the Debug logs:

Code:
[2024-08-18 13:40:01.639 +00:00] [DBG] [32] Jellyfin.Api.Controllers.MediaInfoController: GetPostedPlaybackInfo profile: DeviceProfile { Name: "AndroidTV-External", Id: null, MaxStreamingBitrate: 8000000, MaxStaticBitrate: 100000000, MusicStreamingTranscodingBitrate: 128000, MaxStaticMusicBitrate: 8000000, DirectPlayProfiles: [DirectPlayProfile { Container: null, AudioCodec: null, VideoCodec: null, Type: Video }, DirectPlayProfile { Container: null, AudioCodec: null, VideoCodec: null, Type: Audio }], TranscodingProfiles: [], ContainerProfiles: [], CodecProfiles: [], SubtitleProfiles: [SubtitleProfile { Format: "srt", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "subrip", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ass", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ssa", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "pgs", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "pgssub", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "dvdsub", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "vtt", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "sub", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "idx", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "smi", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "smil", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ttml", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "webvtt", Method: Embed, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "srt", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "subrip", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ass", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ssa", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "pgs", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "pgssub", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "dvdsub", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "vtt", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "sub", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "idx", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "smi", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "smil", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "ttml", Method: External, DidlMode: null, Language: null, Container: null }, SubtitleProfile { Format: "webvtt", Method: External, DidlMode: null, Language: null, Container: null }] }
[2024-08-18 13:40:01.644 +00:00] [DBG] [32] MediaBrowser.Controller.Entities.BaseItem: "Filme" has no parental rating set.
[2024-08-18 13:40:01.644 +00:00] [DBG] [32] MediaBrowser.Controller.Entities.BaseItem: "root" has no parental rating set.
[2024-08-18 13:40:01.644 +00:00] [DBG] [32] MediaBrowser.Controller.Entities.BaseItem: "Filme" has no parental rating set.
[2024-08-18 13:40:01.645 +00:00] [DBG] [32] MediaBrowser.Controller.Entities.BaseItem: "Serien" has no parental rating set.
[2024-08-18 13:40:01.645 +00:00] [DBG] [32] MediaBrowser.Controller.Entities.BaseItem: "Playlists" has no parental rating set.
[2024-08-18 13:40:01.655 +00:00] [INF] [32] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Henni". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: False EnableAudioPlaybackTranscoding: False
[2024-08-18 13:40:01.655 +00:00] [DBG] [32] Jellyfin.Api.Helpers.MediaInfoHelper: Profile: "AndroidTV-External", Path: "/Filme/Black Hawk Down.mkv", isEligibleForDirectPlay: True, isEligibleForDirectStream: False
[2024-08-18 13:40:01.655 +00:00] [DBG] [32] Jellyfin.Api.Helpers.MediaInfoHelper: DirectPlay Result for Profile: "AndroidTV-External", Path: "/Filme/Black Hawk Down.mkv", PlayMethod: DirectPlay, AudioStreamIndex: 1, SubtitleStreamIndex: null, Reasons: 0
[2024-08-18 13:40:01.655 +00:00] [DBG] [32] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-External", Path="/Filme/Black Hawk Down.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv?MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Static=true&VideoCodec=hevc&AudioCodec=truehd&AudioStreamIndex=1&api_key=<token>&Tag=81abae771a49bb58efbb59cb3c89e46c"
[2024-08-18 13:40:01.678 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.678 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.689 +00:00] [DBG] [43] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.690 +00:00] [DBG] [43] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.774 +00:00] [DBG] [3] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.774 +00:00] [DBG] [49] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.775 +00:00] [DBG] [32] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.776 +00:00] [DBG] [47] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.787 +00:00] [DBG] [44] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.826 +00:00] [DBG] [36] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:01.870 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:01.874 +00:00] [DBG] [43] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.090 +00:00] [DBG] [44] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was not authenticated.
[2024-08-18 13:40:02.090 +00:00] [DBG] [47] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.090 +00:00] [DBG] [36] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.091 +00:00] [DBG] [36] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.090 +00:00] [DBG] [49] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.091 +00:00] [DBG] [47] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.093 +00:00] [DBG] [36] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.093 +00:00] [DBG] [49] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.099 +00:00] [DBG] [47] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.099 +00:00] [DBG] [47] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.262 +00:00] [DBG] [3] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.262 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.265 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.262 +00:00] [DBG] [50] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.313 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.313 +00:00] [DBG] [50] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.358 +00:00] [DBG] [3] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.499 +00:00] [DBG] [36] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.720 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.834 +00:00] [DBG] [35] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was successfully authenticated.
[2024-08-18 13:40:02.871 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:02.886 +00:00] [DBG] [43] Jellyfin.Api.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.178.88:8096/Items/c0da8029aefb458f672f24e487d3c37c/Images/Logo?tag=0b4ce9b49019e32fda383c344d3c147a&maxHeight=24&maxWidth=130&quality=90" to "192.168.178.37" in 0:00:00.7961239 with Status Code 200
[2024-08-18 13:40:03.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:04.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:05.871 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:06.445 +00:00] [DBG] [44] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was not authenticated.
[2024-08-18 13:40:06.871 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:07.312 +00:00] [DBG] [3] Emby.Server.Implementations.Session.SessionWebSocketListener: Watching 1 WebSockets.
[2024-08-18 13:40:07.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:08.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:09.871 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:10.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:11.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:12.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:13.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:14.872 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:15.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:16.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:17.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:18.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:19.312 +00:00] [DBG] [36] Emby.Server.Implementations.Session.SessionWebSocketListener: Watching 1 WebSockets.
[2024-08-18 13:40:19.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:20.872 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:21.871 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:22.871 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:23.871 +00:00] [DBG] [36] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:24.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:25.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:26.871 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:27.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:28.871 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:29.871 +00:00] [DBG] [43] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:30.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:31.312 +00:00] [DBG] [35] Emby.Server.Implementations.Session.SessionWebSocketListener: Watching 1 WebSockets.
[2024-08-18 13:40:31.872 +00:00] [DBG] [36] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:32.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:33.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:34.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:35.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:36.871 +00:00] [DBG] [49] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:37.354 +00:00] [DBG] [3] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: "CustomAuthentication" was not authenticated.
[2024-08-18 13:40:37.872 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:38.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:39.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:40.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:41.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:42.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:43.312 +00:00] [DBG] [3] Emby.Server.Implementations.Session.SessionWebSocketListener: Watching 1 WebSockets.
[2024-08-18 13:40:43.313 +00:00] [INF] [3] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets.
[2024-08-18 13:40:43.374 +00:00] [DBG] [3] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "192.168.178.37" received message: InboundWebSocketMessage`1 { Data: null, MessageType: KeepAlive, ServerId: null }
[2024-08-18 13:40:43.872 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:44.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:45.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:46.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:47.871 +00:00] [DBG] [44] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:48.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:49.872 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:50.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:51.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:52.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:53.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:54.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:55.312 +00:00] [DBG] [35] Emby.Server.Implementations.Session.SessionWebSocketListener: Watching 1 WebSockets.
[2024-08-18 13:40:55.872 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:56.872 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:57.871 +00:00] [DBG] [3] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False
[2024-08-18 13:40:58.871 +00:00] [DBG] [35] MediaBrowser.MediaEncoding.Transcoding.TranscodeManager: PingTranscodingJob PlaySessionId="8461e28ba82944e5aec3aa760f29a8dd" isUsedPaused: False


RE: Audio out of sync every few minutes - Henni - 2024-08-18

Sorry, I think those logs aren't very helpful. I restarted everything to get the complete logs:

Code:
[2024-08-18 13:56:18.257 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)"'
[2024-08-18 13:56:18.260 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackStart\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackStart(MediaBrowser.Model.Session.PlaybackStartInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:18.264 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVideoStreamByContainer\", controller = \"Videos\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVideoStreamByContainer(System.Guid, System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.String, System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.Nullable`1[System.Single], System.Nullable`1[System.Single], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.SubtitleDeliveryMethod], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.EncodingContext], System.Collections.Generic.Dictionary`2[System.String,System.String])" on controller "Jellyfin.Api.Controllers.VideosController" ("Jellyfin.Api").
[2024-08-18 13:56:18.305 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.PhysicalFileResultExecutor: Executing "PhysicalFileResult", sending file '"/Filme/Black Hawk Down.mkv"' with download name '""' ...
[2024-08-18 13:56:18.329 +00:00] [INF] [23] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__itemId_0='?' (DbType = Guid)"], CommandType='Text', CommandTimeout='30']"
""SELECT \"t\".\"ItemId\", \"t\".\"Width\", \"t\".\"Bandwidth\", \"t\".\"Height\", \"t\".\"Interval\", \"t\".\"ThumbnailCount\", \"t\".\"TileHeight\", \"t\".\"TileWidth\"
FROM \"TrickplayInfos\" AS \"t\"
WHERE \"t\".\"ItemId\" = @__itemId_0"
[2024-08-18 13:56:18.342 +00:00] [INF] [23] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p0='?' (DbType = DateTime), @p1='?' (Size = 32), @p2='?' (DbType = Int32), @p3='?' (Size = 65), @p4='?', @p5='?' (DbType = UInt32), @p6='?', @p7='?' (Size = 13), @p8='?' (DbType = Guid)"], CommandType='Text', CommandTimeout='30']"
""INSERT INTO \"ActivityLogs\" (\"DateCreated\", \"ItemId\", \"LogSeverity\", \"Name\", \"Overview\", \"RowVersion\", \"ShortOverview\", \"Type\", \"UserId\")
VALUES (@p0, @p1, @p2, @p3, @p4, @p5, @p6, @p7, @p8)
RETURNING \"Id\";"
[2024-08-18 13:56:18.391 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:18.391 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)" in 130.7457ms
[2024-08-18 13:56:18.391 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)"'
[2024-08-18 13:56:18.391 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing""" - 204 null null 134.8665ms
[2024-08-18 13:56:18.393 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=4&minDate=2024-08-11T13%3A56%3A19.953Z&hasUserId=false" - null null
[2024-08-18 13:56:18.394 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=4&minDate=2024-08-11T13%3A56%3A19.954Z&hasUserId=false" - null null
[2024-08-18 13:56:18.395 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.393 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=7&minDate=2024-08-17T13%3A56%3A19.953Z&hasUserId=true" - null null
[2024-08-18 13:56:18.395 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.394 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=7&minDate=2024-08-17T13%3A56%3A19.954Z&hasUserId=true" - null null
[2024-08-18 13:56:18.395 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetLogEntries\", controller = \"ActivityLog\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Querying.QueryResult`1[MediaBrowser.Model.Activity.ActivityLogEntry]]] GetLogEntries(System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.DateTime], System.Nullable`1[System.Boolean])" on controller "Jellyfin.Api.Controllers.ActivityLogController" ("Jellyfin.Api").
[2024-08-18 13:56:18.397 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.397 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetLogEntries\", controller = \"ActivityLog\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Querying.QueryResult`1[MediaBrowser.Model.Activity.ActivityLogEntry]]] GetLogEntries(System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.DateTime], System.Nullable`1[System.Boolean])" on controller "Jellyfin.Api.Controllers.ActivityLogController" ("Jellyfin.Api").
[2024-08-18 13:56:18.398 +00:00] [INF] [25] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']"
""SELECT COUNT(*)
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1"
[2024-08-18 13:56:18.398 +00:00] [INF] [28] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Items/c0da8029aefb458f672f24e487d3c37c/Images/Backdrop""?maxWidth=512&tag=e590686f961774c0f9b0246f1a506c05&quality=80" - null null
[2024-08-18 13:56:18.398 +00:00] [INF] [28] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.ImageController.GetItemImage (Jellyfin.Api)"'
[2024-08-18 13:56:18.399 +00:00] [INF] [25] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean), @__p_3='?' (DbType = Int32), @__p_2='?' (DbType = Int32)"], CommandType='Text', CommandTimeout='30']"
""SELECT \"a\".\"Name\", \"a\".\"Type\", \"a\".\"UserId\", CAST(\"a\".\"Id\" AS INTEGER), \"a\".\"Overview\", \"a\".\"ShortOverview\", \"a\".\"ItemId\", \"a\".\"DateCreated\", \"a\".\"LogSeverity\"
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1
ORDER BY \"a\".\"DateCreated\" DESC
LIMIT @__p_3 OFFSET @__p_2"
[2024-08-18 13:56:18.399 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Querying.QueryResult`1[[MediaBrowser.Model.Activity.ActivityLogEntry, MediaBrowser.Model, Version=10.9.9.0, Culture=neutral, PublicKeyToken=null]]"'.
[2024-08-18 13:56:18.400 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)" in 3.339ms
[2024-08-18 13:56:18.400 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.400 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=4&minDate=2024-08-11T13%3A56%3A19.954Z&hasUserId=false" - 200 null "application/json; charset=utf-8" 5.9092ms
[2024-08-18 13:56:18.396 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.400 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetLogEntries\", controller = \"ActivityLog\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Querying.QueryResult`1[MediaBrowser.Model.Activity.ActivityLogEntry]]] GetLogEntries(System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.DateTime], System.Nullable`1[System.Boolean])" on controller "Jellyfin.Api.Controllers.ActivityLogController" ("Jellyfin.Api").
[2024-08-18 13:56:18.396 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetLogEntries\", controller = \"ActivityLog\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Querying.QueryResult`1[MediaBrowser.Model.Activity.ActivityLogEntry]]] GetLogEntries(System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.DateTime], System.Nullable`1[System.Boolean])" on controller "Jellyfin.Api.Controllers.ActivityLogController" ("Jellyfin.Api").
[2024-08-18 13:56:18.398 +00:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']"
""SELECT COUNT(*)
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1"
[2024-08-18 13:56:18.401 +00:00] [INF] [23] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']"
""SELECT COUNT(*)
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1"
[2024-08-18 13:56:18.404 +00:00] [INF] [23] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean), @__p_3='?' (DbType = Int32), @__p_2='?' (DbType = Int32)"], CommandType='Text', CommandTimeout='30']"
""SELECT \"a\".\"Name\", \"a\".\"Type\", \"a\".\"UserId\", CAST(\"a\".\"Id\" AS INTEGER), \"a\".\"Overview\", \"a\".\"ShortOverview\", \"a\".\"ItemId\", \"a\".\"DateCreated\", \"a\".\"LogSeverity\"
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1
ORDER BY \"a\".\"DateCreated\" DESC
LIMIT @__p_3 OFFSET @__p_2"
[2024-08-18 13:56:18.404 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Querying.QueryResult`1[[MediaBrowser.Model.Activity.ActivityLogEntry, MediaBrowser.Model, Version=10.9.9.0, Culture=neutral, PublicKeyToken=null]]"'.
[2024-08-18 13:56:18.405 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)" in 4.319ms
[2024-08-18 13:56:18.405 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.405 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=7&minDate=2024-08-17T13%3A56%3A19.953Z&hasUserId=true" - 200 null "application/json; charset=utf-8" 11.3503ms
[2024-08-18 13:56:18.405 +00:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean), @__p_3='?' (DbType = Int32), @__p_2='?' (DbType = Int32)"], CommandType='Text', CommandTimeout='30']"
""SELECT \"a\".\"Name\", \"a\".\"Type\", \"a\".\"UserId\", CAST(\"a\".\"Id\" AS INTEGER), \"a\".\"Overview\", \"a\".\"ShortOverview\", \"a\".\"ItemId\", \"a\".\"DateCreated\", \"a\".\"LogSeverity\"
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1
ORDER BY \"a\".\"DateCreated\" DESC
LIMIT @__p_3 OFFSET @__p_2"
[2024-08-18 13:56:18.405 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetItemImage\", controller = \"Image\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetItemImage(System.Guid, MediaBrowser.Model.Entities.ImageType, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.Nullable`1[MediaBrowser.Model.Drawing.ImageFormat], System.Nullable`1[System.Double], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.Nullable`1[System.Int32])" on controller "Jellyfin.Api.Controllers.ImageController" ("Jellyfin.Api").
[2024-08-18 13:56:18.406 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Querying.QueryResult`1[[MediaBrowser.Model.Activity.ActivityLogEntry, MediaBrowser.Model, Version=10.9.9.0, Culture=neutral, PublicKeyToken=null]]"'.
[2024-08-18 13:56:18.406 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)" in 9.1542ms
[2024-08-18 13:56:18.406 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.407 +00:00] [INF] [24] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("4"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']"
""SELECT COUNT(*)
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1"
[2024-08-18 13:56:18.408 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=7&minDate=2024-08-17T13%3A56%3A19.954Z&hasUserId=true" - 200 null "application/json; charset=utf-8" 13.8434ms
[2024-08-18 13:56:18.409 +00:00] [INF] [24] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__query_MinDate_0='?' (DbType = DateTime), @__query_HasUserId_Value_1='?' (DbType = Boolean), @__p_3='?' (DbType = Int32), @__p_2='?' (DbType = Int32)"], CommandType='Text', CommandTimeout='30']"
""SELECT \"a\".\"Name\", \"a\".\"Type\", \"a\".\"UserId\", CAST(\"a\".\"Id\" AS INTEGER), \"a\".\"Overview\", \"a\".\"ShortOverview\", \"a\".\"ItemId\", \"a\".\"DateCreated\", \"a\".\"LogSeverity\"
FROM \"ActivityLogs\" AS \"a\"
WHERE \"a\".\"DateCreated\" >= @__query_MinDate_0 AND (\"a\".\"UserId\" = '00000000-0000-0000-0000-000000000000') <> @__query_HasUserId_Value_1
ORDER BY \"a\".\"DateCreated\" DESC
LIMIT @__p_3 OFFSET @__p_2"
[2024-08-18 13:56:18.410 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Querying.QueryResult`1[[MediaBrowser.Model.Activity.ActivityLogEntry, MediaBrowser.Model, Version=10.9.9.0, Culture=neutral, PublicKeyToken=null]]"'.
[2024-08-18 13:56:18.410 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)" in 7.8079ms
[2024-08-18 13:56:18.410 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries (Jellyfin.Api)"'
[2024-08-18 13:56:18.411 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/System/ActivityLog/Entries""?startIndex=0&limit=4&minDate=2024-08-11T13%3A56%3A19.953Z&hasUserId=false" - 200 null "application/json; charset=utf-8" 17.2772ms
[2024-08-18 13:56:18.423 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)" in 159.517ms
[2024-08-18 13:56:18.424 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:18.424 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - 200 63468207662 "video/x-matroska" 169.64ms
[2024-08-18 13:56:18.424 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - null null
[2024-08-18 13:56:18.427 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:18.427 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVideoStreamByContainer\", controller = \"Videos\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVideoStreamByContainer(System.Guid, System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.String, System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.Nullable`1[System.Single], System.Nullable`1[System.Single], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.SubtitleDeliveryMethod], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.EncodingContext], System.Collections.Generic.Dictionary`2[System.String,System.String])" on controller "Jellyfin.Api.Controllers.VideosController" ("Jellyfin.Api").
[2024-08-18 13:56:18.429 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.PhysicalFileResultExecutor: Executing "PhysicalFileResult", sending file '"/Filme/Black Hawk Down.mkv"' with download name '""' ...
[2024-08-18 13:56:18.432 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)" in 4.4572ms
[2024-08-18 13:56:18.432 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:18.432 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - 206 203069 "video/x-matroska" 7.9195ms
[2024-08-18 13:56:18.514 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - null null
[2024-08-18 13:56:18.515 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:18.515 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVideoStreamByContainer\", controller = \"Videos\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVideoStreamByContainer(System.Guid, System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.String, System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.Nullable`1[System.Single], System.Nullable`1[System.Single], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.SubtitleDeliveryMethod], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.EncodingContext], System.Collections.Generic.Dictionary`2[System.String,System.String])" on controller "Jellyfin.Api.Controllers.VideosController" ("Jellyfin.Api").
[2024-08-18 13:56:18.517 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.PhysicalFileResultExecutor: Executing "PhysicalFileResult", sending file '"/Filme/Black Hawk Down.mkv"' with download name '""' ...
[2024-08-18 13:56:18.582 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.PhysicalFileResultExecutor: Executing "PhysicalFileResult", sending file '"/cache/images/resized-images/5/574f51e0-8013-3f4d-c978-10de17ff838d.webp"' with download name '""' ...
[2024-08-18 13:56:18.583 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.ImageController.GetItemImage (Jellyfin.Api)" in 177.1681ms
[2024-08-18 13:56:18.583 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.ImageController.GetItemImage (Jellyfin.Api)"'
[2024-08-18 13:56:18.583 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Items/c0da8029aefb458f672f24e487d3c37c/Images/Backdrop""?maxWidth=512&tag=e590686f961774c0f9b0246f1a506c05&quality=80" - 200 20832 "image/webp" 185.1682ms
[2024-08-18 13:56:19.011 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 264
[2024-08-18 13:56:19.012 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:19.015 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:19.024 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:19.024 +00:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 8.7935ms
[2024-08-18 13:56:19.024 +00:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:19.024 +00:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 13.1818ms
[2024-08-18 13:56:19.025 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 228
[2024-08-18 13:56:19.027 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:19.027 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:19.029 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:19.029 +00:00] [INF] [24] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 2.0268ms
[2024-08-18 13:56:19.029 +00:00] [INF] [24] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:19.029 +00:00] [INF] [24] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 4.0344ms
[2024-08-18 13:56:19.136 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)" in 620.4616ms
[2024-08-18 13:56:19.136 +00:00] [INF] [28] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:19.136 +00:00] [INF] [28] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - 206 63468203246 "video/x-matroska" 621.927ms
[2024-08-18 13:56:19.136 +00:00] [INF] [28] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"192.168.178.88:8096""""/Videos/c0da8029-aefb-458f-672f-24e487d3c37c/stream.mkv""?api_key=5d29d929bdf14ddd879a1fdc2652c409&DeviceId=7ff65c2d87bd819e1a44eb337b5f19a76a5793d5&MediaSourceId=c0da8029aefb458f672f24e487d3c37c&Tag=81abae771a49bb58efbb59cb3c89e46c&Static=true" - null null
[2024-08-18 13:56:19.137 +00:00] [INF] [28] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.VideosController.GetVideoStreamByContainer (Jellyfin.Api)"'
[2024-08-18 13:56:19.137 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVideoStreamByContainer\", controller = \"Videos\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVideoStreamByContainer(System.Guid, System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.String, System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.String, System.Nullable`1[System.Single], System.Nullable`1[System.Single], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.SubtitleDeliveryMethod], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Boolean], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.String, System.Nullable`1[System.Boolean], System.String, System.String, System.String, System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[MediaBrowser.Model.Dlna.EncodingContext], System.Collections.Generic.Dictionary`2[System.String,System.String])" on controller "Jellyfin.Api.Controllers.VideosController" ("Jellyfin.Api").
[2024-08-18 13:56:19.138 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.PhysicalFileResultExecutor: Executing "PhysicalFileResult", sending file '"/Filme/Black Hawk Down.mkv"' with download name '""' ...
[2024-08-18 13:56:22.027 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:22.027 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:22.028 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:22.029 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:22.029 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.1616ms
[2024-08-18 13:56:22.029 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:22.029 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.1913ms
[2024-08-18 13:56:25.027 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:25.028 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:25.028 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:25.029 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:25.029 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.0721ms
[2024-08-18 13:56:25.030 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:25.030 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.4494ms
[2024-08-18 13:56:28.030 +00:00] [INF] [28] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:28.031 +00:00] [INF] [28] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:28.031 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:28.032 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:28.032 +00:00] [INF] [28] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.1748ms
[2024-08-18 13:56:28.032 +00:00] [INF] [28] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:28.032 +00:00] [INF] [28] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.9104ms
[2024-08-18 13:56:31.029 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:31.030 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:31.030 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:31.031 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:31.031 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.2151ms
[2024-08-18 13:56:31.032 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:31.032 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.3175ms
[2024-08-18 13:56:34.032 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:34.033 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:34.033 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:34.034 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:34.034 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.0438ms
[2024-08-18 13:56:34.034 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:34.035 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.8668ms
[2024-08-18 13:56:37.032 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:37.033 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:37.033 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:37.034 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:37.034 +00:00] [INF] [26] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.1433ms
[2024-08-18 13:56:37.035 +00:00] [INF] [26] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:37.035 +00:00] [INF] [26] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.515ms
[2024-08-18 13:56:40.033 +00:00] [INF] [29] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:40.033 +00:00] [INF] [29] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:40.033 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:40.035 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:40.035 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.2867ms
[2024-08-18 13:56:40.035 +00:00] [INF] [29] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:40.035 +00:00] [INF] [29] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.7989ms
[2024-08-18 13:56:43.034 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:43.035 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:43.035 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:43.036 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:43.036 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.4124ms
[2024-08-18 13:56:43.037 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:43.037 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 3.0677ms
[2024-08-18 13:56:45.830 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/health""" - null null
[2024-08-18 13:56:45.831 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Health checks"'
[2024-08-18 13:56:45.832 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Health checks"'
[2024-08-18 13:56:45.832 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/health""" - 200 null "text/plain" 1.7055ms
[2024-08-18 13:56:46.037 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:46.038 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:46.038 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:46.039 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:46.039 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.1759ms
[2024-08-18 13:56:46.039 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:46.039 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.5271ms
[2024-08-18 13:56:49.038 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:49.038 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:49.038 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:49.040 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:49.040 +00:00] [INF] [25] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.0434ms
[2024-08-18 13:56:49.040 +00:00] [INF] [25] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:49.040 +00:00] [INF] [25] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 2.3444ms
[2024-08-18 13:56:52.039 +00:00] [INF] [29] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - "application/json" 274
[2024-08-18 13:56:52.040 +00:00] [INF] [29] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:52.040 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackProgress\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackProgress(MediaBrowser.Model.Session.PlaybackProgressInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:52.041 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204
[2024-08-18 13:56:52.041 +00:00] [INF] [29] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 1.2434ms
[2024-08-18 13:56:52.042 +00:00] [INF] [29] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"'
[2024-08-18 13:56:52.042 +00:00] [INF] [29] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Progress""" - 204 null null 3.3745ms
[2024-08-18 13:56:52.445 +00:00] [INF] [23] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"192.168.178.88:8096""""/Sessions/Playing/Stopped""" - "application/json" 143
[2024-08-18 13:56:52.446 +00:00] [INF] [23] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStopped (Jellyfin.Api)"'
[2024-08-18 13:56:52.450 +00:00] [INF] [23] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"ReportPlaybackStopped\", controller = \"Playstate\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] ReportPlaybackStopped(MediaBrowser.Model.Session.PlaybackStopInfo)" on controller "Jellyfin.Api.Controllers.PlaystateController" ("Jellyfin.Api").
[2024-08-18 13:56:52.464 +00:00] [INF] [23] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.17.3" playing "Black Hawk Down". Stopped at "8446032" ms
[2024-08-18 13:56:52.467 +00:00] [INF] [23] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p0='?' (DbType = DateTime), @p1='?' (Size = 32), @p2='?' (DbType = Int32), @p3='?' (Size = 63), @p4='?', @p5='?' (DbType = UInt32), @p6='?', @p7='?' (Size = 20), @p8='?' (DbType = Guid)"], CommandType='Text', CommandTimeout='30']"
""INSERT INTO \"ActivityLogs\" (\"DateCreated\", \"ItemId\", \"LogSeverity\", \"Name\", \"Overview\", \"RowVersion\", \"ShortOverview\", \"Type\", \"UserId\")
VALUES (@p0, @p1, @p2, @p3, @p4, @p5, @p6, @p7, @p8)
RETURNING \"Id\";"


RE: Audio out of sync every few minutes - Henni - 2024-08-18

I just tried using VLC as an external player. At least this known hiccup was avoided this way.
So it seems like an exoplayer (and just player) issue on the androidTV side of things.

RE: Audio out of sync every few minutes - bkl842 - 2024-08-20

I’ve had this problem on the Firestick / Fire TV cube. Recently I switched the audio in the Firestick settings from best available or Dolby digital to PCM and it seems to have fixed the problem.