[2024-01-26 00:00:00.000 +10:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Playback Reporting Trim Db" Completed after 0 minute(s) and 0 seconds [2024-01-26 00:00:00.001 +10:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-01-26 00:00:00.998 +10:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Playback Reporting Trim Db" set to fire at 2024-01-27 00:00:00.000 +10:00, which is 23:59:59.0013162 from now. [2024-01-26 03:19:46.385 +10:00] [ERR] [62] Emby.Server.Implementations.Library.LibraryManager: Cannot get image dimensions for "/config/metadata/People/J/Jeff Daniels/folder.jpg" System.IO.FileNotFoundException: File not found File name: '/config/metadata/People/J/Jeff Daniels/folder.jpg' at Jellyfin.Drawing.Skia.SkiaEncoder.GetImageSize(String path) at Emby.Drawing.ImageProcessor.GetImageDimensions(BaseItem item, ItemImageInfo info) at Emby.Server.Implementations.Library.LibraryManager.UpdateImagesAsync(BaseItem item, Boolean forceUpdate) [2024-01-26 03:19:46.405 +10:00] [ERR] [62] Emby.Server.Implementations.Library.LibraryManager: Cannot get image dimensions for "/config/metadata/People/C/Christina Milian/folder.jpg" System.IO.FileNotFoundException: File not found File name: '/config/metadata/People/C/Christina Milian/folder.jpg' at Jellyfin.Drawing.Skia.SkiaEncoder.GetImageSize(String path) at Emby.Drawing.ImageProcessor.GetImageDimensions(BaseItem item, ItemImageInfo info) at Emby.Server.Implementations.Library.LibraryManager.UpdateImagesAsync(BaseItem item, Boolean forceUpdate) [2024-01-26 03:19:46.421 +10:00] [ERR] [62] Emby.Server.Implementations.Library.LibraryManager: Cannot get image dimensions for "/config/metadata/People/G/Gary Cole/folder.jpg" System.IO.FileNotFoundException: File not found File name: '/config/metadata/People/G/Gary Cole/folder.jpg' at Jellyfin.Drawing.Skia.SkiaEncoder.GetImageSize(String path) at Emby.Drawing.ImageProcessor.GetImageDimensions(BaseItem item, ItemImageInfo info) at Emby.Server.Implementations.Library.LibraryManager.UpdateImagesAsync(BaseItem item, Boolean forceUpdate) [2024-01-26 04:47:39.326 +10:00] [INF] [355] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request [2024-01-26 04:53:36.350 +10:00] [INF] [355] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.173" request [2024-01-26 04:54:02.564 +10:00] [INF] [392] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:54:02.568 +10:00] [INF] [392] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/tv/M-A-S-H/Season 1/M-A-S-H - S01E02 - To Market, to Market SDTV.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/db2a757e-afc1-305a-132a-3e20f678b984/stream.mov?MediaSourceId=db2a757eafc1305a132a3e20f678b984&Static=true&VideoCodec=h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&api_key=&SubtitleMethod=Embed&Tag=5c7a5b246bae3c87b9129ced1abe8420" [2024-01-26 04:54:02.673 +10:00] [INF] [392] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:54:02.679 +10:00] [INF] [392] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/tv/M-A-S-H/Season 1/M-A-S-H - S01E02 - To Market, to Market SDTV.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/db2a757e-afc1-305a-132a-3e20f678b984/master.m3u8?MediaSourceId=db2a757eafc1305a132a3e20f678b984&VideoCodec=hevc,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=119872771&AudioBitrate=127229&AudioSampleRate=48000&MaxFramerate=24.997967&api_key=&SubtitleMethod=Encode&RequireAvc=false&Tag=5c7a5b246bae3c87b9129ced1abe8420&SegmentContainer=ts&BreakOnNonKeyFrames=False&h264-level=31&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=2&aac-profile=lc&aac-audiochannels=8&TranscodeReasons=SubtitleCodecNotSupported" [2024-01-26 04:54:03.665 +10:00] [WRN] [392] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Sessions/Playing" to "10.0.1.173" in 0:00:00.7151765 with Status Code 204 [2024-01-26 04:54:03.665 +10:00] [INF] [392] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : 62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-db2a757eafc1305a132a3e20f678b984 [2024-01-26 04:54:03.665 +10:00] [INF] [392] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 04:54:03 [2024-01-26 04:54:03.666 +10:00] [INF] [392] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 04:54:03.666 +10:00] [INF] [392] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 04:54:04.421 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:23.666 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.173" [2024-01-26 04:54:23.666 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:23.666 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:54:23.666 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 2 [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectPlay" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Android TV" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Joel's Fire TV" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "M*A*S*H - s01e02 - To Market, to Market" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:23.667 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-01-26 04:54:23.675 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 04:54:24.970 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:45.968 +10:00] [INF] [137] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-db2a757eafc1305a132a3e20f678b984" [2024-01-26 04:54:49.742 +10:00] [INF] [137] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.16.4" playing "To Market, to Market". Stopped at "0" ms [2024-01-26 04:54:54.154 +10:00] [INF] [201] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:54:54.154 +10:00] [INF] [201] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/tv/Sex and the City/Season 4/Sex and the City - S04E01 - The Agony and the 'Ex'-tacy WEBDL-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/61f18a6e-f018-e6bc-f674-12f740350917/stream.mkv?MediaSourceId=61f18a6ef018e6bcf67412f740350917&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=2&api_key=&SubtitleMethod=Embed&Tag=a599daebdffa8056bac212aa66347f62" [2024-01-26 04:54:54.307 +10:00] [INF] [201] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:54:54.308 +10:00] [INF] [201] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/tv/Sex and the City/Season 4/Sex and the City - S04E01 - The Agony and the 'Ex'-tacy WEBDL-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=AudioCodecNotSupported ) "media:/videos/61f18a6e-f018-e6bc-f674-12f740350917/master.m3u8?MediaSourceId=61f18a6ef018e6bcf67412f740350917&VideoCodec=hevc,h264,h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=119616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&RequireAvc=false&Tag=a599daebdffa8056bac212aa66347f62&SegmentContainer=ts&BreakOnNonKeyFrames=False&h264-level=40&h264-videobitdepth=8&h264-profile=high&h264-maxrefframes=4&aac-audiochannels=8&TranscodeReasons=AudioCodecNotSupported" [2024-01-26 04:54:54.468 +10:00] [INF] [201] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : 62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917 [2024-01-26 04:54:54.468 +10:00] [INF] [201] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 04:54:54 [2024-01-26 04:54:54.468 +10:00] [INF] [201] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 04:54:54.468 +10:00] [INF] [201] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 04:54:55.903 +10:00] [INF] [308] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:14.465 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.173" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 2 [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectPlay" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Android TV" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Joel's Fire TV" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "Sex and the City - s04e01 - The Agony and the 'Ex'-tacy" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:14.466 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-01-26 04:55:15.153 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 04:55:16.418 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 04:55:16.952 +10:00] [INF] [308] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.16.4" playing "The Agony and the 'Ex'-tacy". Stopped at "0" ms [2024-01-26 04:55:21.146 +10:00] [WRN] [310] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Users/c92fdf84-e2eb-426d-bd62-e59b2169535c/Items?ParentId=d0c9da2a65394445e9168bad7ef3961a&StartIndex=1&recursive=false&Fields=PrimaryImageAspectRatio%2COverview%2CItemCounts%2CDisplayPreferencesId%2CChildCount&Limit=20&IncludeItemTypes=Episode&format=json" to "10.0.1.173" in 0:00:02.9084759 with Status Code 200 [2024-01-26 04:55:21.150 +10:00] [WRN] [131] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Shows/951ab06adb944ff7969b710fb8d574f8/Episodes?AdjacentTo=61f18a6ef018e6bcf67412f740350917&UserId=c92fdf84-e2eb-426d-bd62-e59b2169535c&format=json" to "10.0.1.173" in 0:00:03.2300721 with Status Code 200 [2024-01-26 04:55:21.163 +10:00] [WRN] [269] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Users/c92fdf84-e2eb-426d-bd62-e59b2169535c/Items/61f18a6e-f018-e6bc-f674-12f740350917" to "10.0.1.173" in 0:00:02.2422728 with Status Code 200 [2024-01-26 04:55:21.164 +10:00] [WRN] [74] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Users/c92fdf84-e2eb-426d-bd62-e59b2169535c/Items/61f18a6e-f018-e6bc-f674-12f740350917?format=json" to "10.0.1.173" in 0:00:01.2428257 with Status Code 200 [2024-01-26 04:55:23.884 +10:00] [INF] [74] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:55:23.884 +10:00] [INF] [74] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/movies/300 (2007)/300 (2007) Remux-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/138e47fa-f955-dcd0-d854-b3786b5142fa/stream.mkv?MediaSourceId=138e47faf955dcd0d854b3786b5142fa&Static=true&VideoCodec=vc1&AudioCodec=dts&AudioStreamIndex=1&SubtitleStreamIndex=3&api_key=&SubtitleMethod=Embed&Tag=c7430a1511827f5d342b5c23b389725d" [2024-01-26 04:55:24.064 +10:00] [INF] [74] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:55:24.064 +10:00] [INF] [74] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/movies/300 (2007)/300 (2007) Remux-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=VideoCodecNotSupported ) "media:/videos/138e47fa-f955-dcd0-d854-b3786b5142fa/master.m3u8?MediaSourceId=138e47faf955dcd0d854b3786b5142fa&VideoCodec=hevc,h264&AudioCodec=aac,mp3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=117684437&AudioBitrate=2315563&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&RequireAvc=false&Tag=c7430a1511827f5d342b5c23b389725d&SegmentContainer=ts&BreakOnNonKeyFrames=False&vc1-level=3&vc1-videobitdepth=8&vc1-profile=advanced&aac-audiochannels=8&TranscodeReasons=VideoCodecNotSupported" [2024-01-26 04:55:25.614 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : 62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-138e47faf955dcd0d854b3786b5142fa [2024-01-26 04:55:25.614 +10:00] [WRN] [342] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Sessions/Playing" to "10.0.1.173" in 0:00:01.4036892 with Status Code 204 [2024-01-26 04:55:25.614 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 04:55:25 [2024-01-26 04:55:25.614 +10:00] [INF] [310] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 04:55:25.614 +10:00] [INF] [342] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 04:55:26.214 +10:00] [INF] [131] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:45.615 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.173" [2024-01-26 04:55:45.615 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:45.615 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:55:45.615 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 2 [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectPlay" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Android TV" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Joel's Fire TV" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "300" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Movie" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:45.616 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-01-26 04:55:45.639 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 04:55:46.215 +10:00] [INF] [223] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-138e47faf955dcd0d854b3786b5142fa" [2024-01-26 04:55:47.711 +10:00] [INF] [131] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.16.4" playing "300". Stopped at "0" ms [2024-01-26 04:56:02.210 +10:00] [INF] [223] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" closed [2024-01-26 04:56:02.399 +10:00] [INF] [87] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request [2024-01-26 04:56:18.692 +10:00] [INF] [228] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" closed [2024-01-26 04:56:18.851 +10:00] [INF] [93] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request [2024-01-26 04:56:23.451 +10:00] [INF] [228] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request [2024-01-26 04:56:26.547 +10:00] [INF] [152] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "god". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:56:26.549 +10:00] [INF] [152] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=VideoCodecNotSupported, AudioCodecNotSupported ) "media:/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/master.m3u8?MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported" [2024-01-26 04:56:26.883 +10:00] [INF] [372] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-01-26 04:56:26.886 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device cuda=cu:0 -filter_hw_device cu -hwaccel cuda -hwaccel_output_format cuda -threads 1 -autorotate 0 -i file:\"/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv\" -autoscale 0 -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 h264_nvenc -preset p1 -b:v 10254465 -maxrate 10254465 -bufsize 20508930 -g:v:0 72 -keyint_min:v:0 72 -vf \"setparams=color_primaries=bt2020:color_trc=smpte2084:colorspace=bt2020nc,tonemap_cuda=format=yuv420p:p=bt709:t=bt709:m=bt709:tonemap=bt2390:peak=100:desat=0\" -codec:a:0 libfdk_aac -ac 2 -ab 384000 -af \"volume=2\" -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/tmp/ramdisk/c442daf86270743b806ff6c725a3368f%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/tmp/ramdisk/c442daf86270743b806ff6c725a3368f.m3u8\"" [2024-01-26 04:56:27.919 +10:00] [ERR] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 1 [2024-01-26 04:56:27.990 +10:00] [ERR] [372] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/0.ts". MediaBrowser.Common.FfmpegException: FFmpeg exited with code 1 at Jellyfin.Api.Helpers.TranscodingJobHelper.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, HttpRequest request, TranscodingJobType transcodingJobType, CancellationTokenSource cancellationTokenSource, String workingDirectory) at Jellyfin.Api.Controllers.DynamicHlsController.GetDynamicSegment(StreamingRequestDto streamingRequest, Int32 segmentId) at Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment(Guid itemId, String playlistId, Int32 segmentId, String container, Int64 runtimeTicks, Int64 actualSegmentLengthTicks, Nullable`1 static, String params, String tag, String deviceProfileId, String playSessionId, String segmentContainer, Nullable`1 segmentLength, Nullable`1 minSegments, String mediaSourceId, String deviceId, String audioCodec, Nullable`1 enableAutoStreamCopy, Nullable`1 allowVideoStreamCopy, Nullable`1 allowAudioStreamCopy, Nullable`1 breakOnNonKeyFrames, Nullable`1 audioSampleRate, Nullable`1 maxAudioBitDepth, Nullable`1 audioBitRate, Nullable`1 audioChannels, Nullable`1 maxAudioChannels, String profile, String level, Nullable`1 framerate, Nullable`1 maxFramerate, Nullable`1 copyTimestamps, Nullable`1 startTimeTicks, Nullable`1 width, Nullable`1 height, Nullable`1 maxWidth, Nullable`1 maxHeight, Nullable`1 videoBitRate, Nullable`1 subtitleStreamIndex, Nullable`1 subtitleMethod, Nullable`1 maxRefFrames, Nullable`1 maxVideoBitDepth, Nullable`1 requireAvc, Nullable`1 deInterlace, Nullable`1 requireNonAnamorphic, Nullable`1 transcodingMaxAudioChannels, Nullable`1 cpuCoreLimit, String liveStreamId, Nullable`1 enableMpegtsM2TsMode, String videoCodec, String subtitleCodec, String transcodeReasons, Nullable`1 audioStreamIndex, Nullable`1 videoStreamIndex, Nullable`1 context, Dictionary`2 streamOptions) at lambda_method740(Closure , Object ) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|10_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Rethrow(ActionExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|13_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|25_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Rethrow(ResourceExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|20_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.QueryStringDecodingMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-01-26 04:56:28.017 +10:00] [WRN] [372] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/0.ts?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1&MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&PlaySessionId=a57528f2596f442da9b11a0013599d78&api_key=c2f6087512b54053889690144b652402&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported&runtimeTicks=0&actualSegmentLengthTicks=30000000" to "10.0.1.172" in 0:00:01.1364009 with Status Code 500 [2024-01-26 04:56:28.710 +10:00] [WRN] [372] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Sessions/Playing" to "10.0.1.172" in 0:00:00.6823691 with Status Code 204 [2024-01-26 04:56:28.710 +10:00] [INF] [372] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1-c5f4f470cbbc489cb2c9f2c3805c57a9-7289e25cb4bc1e10a6c70b98b6206466 [2024-01-26 04:56:28.710 +10:00] [INF] [372] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 04:56:28 [2024-01-26 04:56:28.710 +10:00] [INF] [372] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 04:56:28.710 +10:00] [INF] [372] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 04:56:28.751 +10:00] [INF] [372] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1-c5f4f470cbbc489cb2c9f2c3805c57a9-7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 04:56:28.756 +10:00] [INF] [372] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "god". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:56:28.756 +10:00] [INF] [372] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=Transcode, TranscodeReason=VideoCodecNotSupported, AudioCodecNotSupported ) "media:/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/master.m3u8?MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported" [2024-01-26 04:56:28.764 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/tmp/ramdisk/c442daf86270743b806ff6c725a3368f.m3u8" [2024-01-26 04:56:28.806 +10:00] [INF] [372] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-01-26 04:56:28.807 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device cuda=cu:0 -filter_hw_device cu -hwaccel cuda -hwaccel_output_format cuda -threads 1 -autorotate 0 -i file:\"/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv\" -autoscale 0 -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 h264_nvenc -preset p1 -b:v 10254465 -maxrate 10254465 -bufsize 20508930 -g:v:0 72 -keyint_min:v:0 72 -vf \"setparams=color_primaries=bt2020:color_trc=smpte2084:colorspace=bt2020nc,tonemap_cuda=format=yuv420p:p=bt709:t=bt709:m=bt709:tonemap=bt2390:peak=100:desat=0\" -codec:a:0 libfdk_aac -ac 2 -ab 384000 -af \"volume=2\" -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/tmp/ramdisk/dab2a3a0149aac85dd599250ef9b4675%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/tmp/ramdisk/dab2a3a0149aac85dd599250ef9b4675.m3u8\"" [2024-01-26 04:56:28.858 +10:00] [ERR] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 1 [2024-01-26 04:56:28.951 +10:00] [ERR] [372] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/0.ts". MediaBrowser.Common.FfmpegException: FFmpeg exited with code 1 at Jellyfin.Api.Helpers.TranscodingJobHelper.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, HttpRequest request, TranscodingJobType transcodingJobType, CancellationTokenSource cancellationTokenSource, String workingDirectory) at Jellyfin.Api.Controllers.DynamicHlsController.GetDynamicSegment(StreamingRequestDto streamingRequest, Int32 segmentId) at Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment(Guid itemId, String playlistId, Int32 segmentId, String container, Int64 runtimeTicks, Int64 actualSegmentLengthTicks, Nullable`1 static, String params, String tag, String deviceProfileId, String playSessionId, String segmentContainer, Nullable`1 segmentLength, Nullable`1 minSegments, String mediaSourceId, String deviceId, String audioCodec, Nullable`1 enableAutoStreamCopy, Nullable`1 allowVideoStreamCopy, Nullable`1 allowAudioStreamCopy, Nullable`1 breakOnNonKeyFrames, Nullable`1 audioSampleRate, Nullable`1 maxAudioBitDepth, Nullable`1 audioBitRate, Nullable`1 audioChannels, Nullable`1 maxAudioChannels, String profile, String level, Nullable`1 framerate, Nullable`1 maxFramerate, Nullable`1 copyTimestamps, Nullable`1 startTimeTicks, Nullable`1 width, Nullable`1 height, Nullable`1 maxWidth, Nullable`1 maxHeight, Nullable`1 videoBitRate, Nullable`1 subtitleStreamIndex, Nullable`1 subtitleMethod, Nullable`1 maxRefFrames, Nullable`1 maxVideoBitDepth, Nullable`1 requireAvc, Nullable`1 deInterlace, Nullable`1 requireNonAnamorphic, Nullable`1 transcodingMaxAudioChannels, Nullable`1 cpuCoreLimit, String liveStreamId, Nullable`1 enableMpegtsM2TsMode, String videoCodec, String subtitleCodec, String transcodeReasons, Nullable`1 audioStreamIndex, Nullable`1 videoStreamIndex, Nullable`1 context, Dictionary`2 streamOptions) at lambda_method740(Closure , Object ) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|10_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Rethrow(ActionExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|13_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|25_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Rethrow(ResourceExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|20_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.QueryStringDecodingMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-01-26 04:56:28.965 +10:00] [INF] [372] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "god". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:56:28.966 +10:00] [INF] [372] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=Transcode, TranscodeReason=VideoCodecNotSupported, AudioCodecNotSupported ) "media:/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/master.m3u8?MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported" [2024-01-26 04:56:28.970 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/tmp/ramdisk/dab2a3a0149aac85dd599250ef9b4675.m3u8" [2024-01-26 04:56:29.016 +10:00] [INF] [372] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-01-26 04:56:29.017 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device cuda=cu:0 -filter_hw_device cu -hwaccel cuda -hwaccel_output_format cuda -threads 1 -autorotate 0 -i file:\"/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv\" -autoscale 0 -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 h264_nvenc -preset p1 -b:v 10254465 -maxrate 10254465 -bufsize 20508930 -g:v:0 72 -keyint_min:v:0 72 -vf \"setparams=color_primaries=bt2020:color_trc=smpte2084:colorspace=bt2020nc,tonemap_cuda=format=yuv420p:p=bt709:t=bt709:m=bt709:tonemap=bt2390:peak=100:desat=0\" -codec:a:0 libfdk_aac -ac 2 -ab 384000 -af \"volume=2\" -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/tmp/ramdisk/eda43b33c81f6e59b409bfa10ba03084%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/tmp/ramdisk/eda43b33c81f6e59b409bfa10ba03084.m3u8\"" [2024-01-26 04:56:29.068 +10:00] [ERR] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 1 [2024-01-26 04:56:29.161 +10:00] [ERR] [372] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/0.ts". MediaBrowser.Common.FfmpegException: FFmpeg exited with code 1 at Jellyfin.Api.Helpers.TranscodingJobHelper.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, HttpRequest request, TranscodingJobType transcodingJobType, CancellationTokenSource cancellationTokenSource, String workingDirectory) at Jellyfin.Api.Controllers.DynamicHlsController.GetDynamicSegment(StreamingRequestDto streamingRequest, Int32 segmentId) at Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment(Guid itemId, String playlistId, Int32 segmentId, String container, Int64 runtimeTicks, Int64 actualSegmentLengthTicks, Nullable`1 static, String params, String tag, String deviceProfileId, String playSessionId, String segmentContainer, Nullable`1 segmentLength, Nullable`1 minSegments, String mediaSourceId, String deviceId, String audioCodec, Nullable`1 enableAutoStreamCopy, Nullable`1 allowVideoStreamCopy, Nullable`1 allowAudioStreamCopy, Nullable`1 breakOnNonKeyFrames, Nullable`1 audioSampleRate, Nullable`1 maxAudioBitDepth, Nullable`1 audioBitRate, Nullable`1 audioChannels, Nullable`1 maxAudioChannels, String profile, String level, Nullable`1 framerate, Nullable`1 maxFramerate, Nullable`1 copyTimestamps, Nullable`1 startTimeTicks, Nullable`1 width, Nullable`1 height, Nullable`1 maxWidth, Nullable`1 maxHeight, Nullable`1 videoBitRate, Nullable`1 subtitleStreamIndex, Nullable`1 subtitleMethod, Nullable`1 maxRefFrames, Nullable`1 maxVideoBitDepth, Nullable`1 requireAvc, Nullable`1 deInterlace, Nullable`1 requireNonAnamorphic, Nullable`1 transcodingMaxAudioChannels, Nullable`1 cpuCoreLimit, String liveStreamId, Nullable`1 enableMpegtsM2TsMode, String videoCodec, String subtitleCodec, String transcodeReasons, Nullable`1 audioStreamIndex, Nullable`1 videoStreamIndex, Nullable`1 context, Dictionary`2 streamOptions) at lambda_method740(Closure , Object ) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|10_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Rethrow(ActionExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.g__Awaited|13_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|25_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Rethrow(ResourceExecutedContextSealed context) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|20_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.QueryStringDecodingMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-01-26 04:56:29.171 +10:00] [INF] [372] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/tmp/ramdisk/eda43b33c81f6e59b409bfa10ba03084.m3u8" [2024-01-26 04:56:30.668 +10:00] [INF] [372] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Web" "10.8.10" playing "Winter Is Coming". Stopped at "0" ms [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.172" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c5f4f470cbbc489cb2c9f2c3805c57a9" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 1 [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c5f4f470cbbc489cb2c9f2c3805c57a9" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "na" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Jellyfin Web" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Chrome" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "Game of Thrones - s01e01 - Winter Is Coming" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Details do not match for play item [2024-01-26 04:56:48.709 +10:00] [INF] [235] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 04:57:33.844 +10:00] [INF] [2] Main: Received a SIGTERM signal, shutting down [2024-01-26 04:57:33.845 +10:00] [INF] [2] Main: Running query planner optimizations in the database... This might take a while [2024-01-26 04:57:33.852 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "CoreAppHost" [2024-01-26 04:57:33.853 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "EventMonitorEntryPoint" [2024-01-26 04:57:33.854 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "EntryPoint" [2024-01-26 04:57:33.858 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "DlnaEntryPoint" [2024-01-26 04:57:33.861 +10:00] [INF] [2] Emby.Dlna.Main.DlnaEntryPoint: Disposing DeviceDiscovery [2024-01-26 04:57:33.862 +10:00] [INF] [2] Emby.Dlna.Main.DlnaEntryPoint: Disposing SsdpCommunicationsServer [2024-01-26 04:57:33.867 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "UdpServerEntryPoint" [2024-01-26 04:57:33.868 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "ExternalPortForwarding" [2024-01-26 04:57:33.871 +10:00] [INF] [2] Emby.Server.Implementations.EntryPoints.ExternalPortForwarding: Stopping NAT discovery [2024-01-26 04:57:33.877 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "NotificationEntryPoint" [2024-01-26 04:57:33.878 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "UserDataChangeNotifier" [2024-01-26 04:57:33.879 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "SchedulesDirect" [2024-01-26 04:57:33.879 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "EntryPoint" [2024-01-26 04:57:33.879 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "LibraryMonitorStartup" [2024-01-26 04:57:33.880 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "EmbyTV" [2024-01-26 04:57:33.881 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "MusicBrainzAlbumProvider" [2024-01-26 04:57:33.881 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "RecordingNotifier" [2024-01-26 04:57:33.883 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "LibraryChangedNotifier" [2024-01-26 04:57:33.885 +10:00] [INF] [2] Emby.Server.Implementations.ApplicationHost: Disposing "DeviceAccessEntryPoint" [2024-01-26 04:57:33.896 +10:00] [INF] [235] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" closed [2024-01-26 04:57:33.896 +10:00] [INF] [235] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" closed [2024-01-26 04:59:23.499 +10:00] [INF] [1] Main: Jellyfin version: "10.8.10" [2024-01-26 04:59:23.527 +10:00] [INF] [1] Main: Environment Variables: ["[JELLYFIN_CACHE_DIR, /cache]", "[JELLYFIN_WEB_DIR, /jellyfin/jellyfin-web]", "[JELLYFIN_LOG_DIR, /config/log]", "[JELLYFIN_FFMPEG, /usr/lib/jellyfin-ffmpeg/ffmpeg]", "[JELLYFIN_DATA_DIR, /config]", "[DOTNET_SYSTEM_GLOBALIZATION_INVARIANT, 1]", "[JELLYFIN_CONFIG_DIR, /config/config]"] [2024-01-26 04:59:23.532 +10:00] [INF] [1] Main: Arguments: ["/jellyfin/jellyfin.dll"] [2024-01-26 04:59:23.533 +10:00] [INF] [1] Main: Operating system: "Linux" [2024-01-26 04:59:23.533 +10:00] [INF] [1] Main: Architecture: X64 [2024-01-26 04:59:23.534 +10:00] [INF] [1] Main: 64-Bit Process: True [2024-01-26 04:59:23.534 +10:00] [INF] [1] Main: User Interactive: True [2024-01-26 04:59:23.534 +10:00] [INF] [1] Main: Processor count: 16 [2024-01-26 04:59:23.534 +10:00] [INF] [1] Main: Program data path: "/config" [2024-01-26 04:59:23.534 +10:00] [INF] [1] Main: Web resources path: "/jellyfin/jellyfin-web" [2024-01-26 04:59:23.535 +10:00] [INF] [1] Main: Application directory: "/jellyfin/" [2024-01-26 04:59:23.828 +10:00] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: "/cache" [2024-01-26 04:59:23.910 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies [2024-01-26 04:59:23.930 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.OpenSubtitles, Version=19.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/Open Subtitles_19.0.0.0/Jellyfin.Plugin.OpenSubtitles.dll" [2024-01-26 04:59:23.934 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.PlaybackReporting, Version=13.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/Playback Reporting_13.0.0.0/Jellyfin.Plugin.PlaybackReporting.dll" [2024-01-26 04:59:23.937 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.Reports, Version=15.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/Reports_15.0.0.0/Jellyfin.Plugin.Reports.dll" [2024-01-26 04:59:23.940 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.SubtitleExtract, Version=2.0.0.0, Culture=neutral, PublicKeyToken=null" from "/config/plugins/Subtitle Extract_2.0.0.0/Jellyfin.Plugin.SubtitleExtract.dll" [2024-01-26 04:59:24.066 +10:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-01-26 04:59:24.066 +10:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-01-26 04:59:24.067 +10:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-01-26 04:59:24.081 +10:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind addresses: "[]" [2024-01-26 04:59:24.081 +10:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind exclusions: "[]" [2024-01-26 04:59:29.940 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Open Subtitles" "19.0.0.0" [2024-01-26 04:59:29.941 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Playback Reporting" "13.0.0.0" [2024-01-26 04:59:29.942 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Reports" "15.0.0.0" [2024-01-26 04:59:29.943 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Subtitle Extract" "2.0.0.0" [2024-01-26 04:59:29.943 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "TMDb" "10.8.10.0" [2024-01-26 04:59:29.944 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Studio Images" "10.8.10.0" [2024-01-26 04:59:29.944 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "OMDb" "10.8.10.0" [2024-01-26 04:59:29.945 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "MusicBrainz" "10.8.10.0" [2024-01-26 04:59:29.945 +10:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AudioDB" "10.8.10.0" [2024-01-26 04:59:30.066 +10:00] [INF] [1] Main: Kestrel listening on "Any IP4 Address" [2024-01-26 04:59:30.676 +10:00] [WRN] [1] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: No XML encryptor configured. Key {dcc27257-6b94-4bce-85d5-2c441447c9b2} may be persisted to storage in unencrypted form. [2024-01-26 04:59:30.721 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks [2024-01-26 04:59:30.722 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.TaskCleanDb: TaskCleanDb Loaded [2024-01-26 04:59:30.725 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.TaskRunBackup: TaskRunBackup Loaded [2024-01-26 04:59:30.752 +10:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Playback Reporting Trim Db" set to fire at 2024-01-27 00:00:00.000 +10:00, which is 19:00:29.2475589 from now. [2024-01-26 04:59:30.805 +10:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Download missing subtitles" set to fire at 2024-01-26 22:00:00.000 +10:00, which is 17:00:29.1945249 from now. [2024-01-26 04:59:30.815 +10:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Extract Chapter Images" set to fire at 2024-01-26 22:00:00.000 +10:00, which is 17:00:29.1843510 from now. [2024-01-26 04:59:30.841 +10:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Scan Media Library" set to fire at 2024-01-26 22:00:00.000 +10:00, which is 17:00:29.1583033 from now. [2024-01-26 04:59:30.850 +10:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Keyframe Extractor" set to fire at 2024-01-26 22:00:00.000 +10:00, which is 17:00:29.1494639 from now. [2024-01-26 04:59:30.953 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version "5.1.3" [2024-01-26 04:59:31.021 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "decoders": ["libdav1d", "av1", "av1_cuvid", "av1_qsv", "h264", "h264_qsv", "h264_cuvid", "hevc", "hevc_qsv", "hevc_cuvid", "mpeg2video", "mpeg2_qsv", "mpeg2_cuvid", "mpeg4", "mpeg4_cuvid", "msmpeg4", "vc1_qsv", "vc1_cuvid", "vp8", "libvpx", "vp8_cuvid", "vp8_qsv", "vp9", "libvpx-vp9", "vp9_cuvid", "vp9_qsv", "aac", "ac3", "dca", "flac", "mp3", "truehd"] [2024-01-26 04:59:31.067 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "encoders": ["libx264", "h264_amf", "h264_nvenc", "h264_qsv", "h264_v4l2m2m", "h264_vaapi", "libx265", "hevc_amf", "hevc_nvenc", "hevc_qsv", "hevc_vaapi", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "libfdk_aac", "ac3", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"] [2024-01-26 04:59:31.112 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available filters: ["deinterlace_qsv", "deinterlace_vaapi", "hwupload_cuda", "hwupload_vaapi", "overlay_opencl", "overlay_qsv", "overlay_vaapi", "overlay_cuda", "procamp_vaapi", "scale_cuda", "scale_opencl", "scale_qsv", "scale_vaapi", "tonemap_cuda", "tonemap_opencl", "tonemap_vaapi", "vpp_qsv", "yadif_cuda", "zscale", "alphasrc"] [2024-01-26 04:59:31.397 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: ["cuda", "vaapi", "qsv", "drm", "opencl", "vulkan"] [2024-01-26 04:59:31.607 +10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: "/usr/lib/jellyfin-ffmpeg/ffmpeg" [2024-01-26 04:59:31.625 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: "203ae386330643d796b4b5aa9496653f" [2024-01-26 04:59:31.793 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all pre-startup entry points in 0:00:00.15318 [2024-01-26 04:59:31.793 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete [2024-01-26 04:59:31.794 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: EventMonitorEntryPoint Running [2024-01-26 04:59:31.803 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Sqlite version: 3.38.3 [2024-01-26 04:59:31.805 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Sqlite compiler options: ATOMIC_INTRINSICS=1,COMPILER=gcc-7.5.0,DEFAULT_AUTOVACUUM,DEFAULT_CACHE_SIZE=-2000,DEFAULT_FILE_FORMAT=4,DEFAULT_FOREIGN_KEYS,DEFAULT_JOURNAL_SIZE_LIMIT=-1,DEFAULT_MMAP_SIZE=0,DEFAULT_PAGE_SIZE=4096,DEFAULT_PCACHE_INITSZ=20,DEFAULT_RECURSIVE_TRIGGERS,DEFAULT_SECTOR_SIZE=4096,DEFAULT_SYNCHRONOUS=2,DEFAULT_WAL_AUTOCHECKPOINT=1000,DEFAULT_WAL_SYNCHRONOUS=2,DEFAULT_WORKER_THREADS=0,ENABLE_COLUMN_METADATA,ENABLE_FTS3,ENABLE_FTS3_PARENTHESIS,ENABLE_FTS4,ENABLE_FTS5,ENABLE_RTREE,ENABLE_SNAPSHOT,MALLOC_SOFT_LIMIT=1024,MAX_ATTACHED=10,MAX_COLUMN=2000,MAX_COMPOUND_SELECT=500,MAX_DEFAULT_PAGE_SIZE=8192,MAX_EXPR_DEPTH=1000,MAX_FUNCTION_ARG=127,MAX_LENGTH=1000000000,MAX_LIKE_PATTERN_LENGTH=50000,MAX_MMAP_SIZE=0x7fff0000,MAX_PAGE_COUNT=1073741823,MAX_PAGE_SIZE=65536,MAX_SQL_LENGTH=1000000000,MAX_TRIGGER_DEPTH=1000,MAX_VARIABLE_NUMBER=32766,MAX_VDBE_OP=250000000,MAX_WORKER_THREADS=8,MUTEX_PTHREADS,SYSTEM_MALLOC,TEMP_STORE=1,THREADSAFE=1 [2024-01-26 04:59:31.810 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Default journal_mode for "/config/data/playback_reporting.db" is "delete" [2024-01-26 04:59:31.810 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Initialize PlaybackActivity Repository [2024-01-26 04:59:31.811 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: PlaybackActivity table schema OK [2024-01-26 04:59:31.811 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Expected : "datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int" [2024-01-26 04:59:31.811 +10:00] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Received : "datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int" [2024-01-26 04:59:32.056 +10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all post-startup entry points in 0:00:00.2628789 [2024-01-26 04:59:32.056 +10:00] [INF] [1] Main: Startup complete 0:00:08.8293831 [2024-01-26 04:59:32.256 +10:00] [INF] [15] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/media/movies" [2024-01-26 04:59:32.457 +10:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/media/tv" [2024-01-26 04:59:33.842 +10:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: "StartupTrigger" fired for task: "Update Plugins" [2024-01-26 04:59:33.844 +10:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "PluginUpdateTask" [2024-01-26 04:59:33.848 +10:00] [INF] [15] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Update Plugins" [2024-01-26 04:59:36.988 +10:00] [INF] [15] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Update Plugins" Completed after 0 minute(s) and 3 seconds [2024-01-26 04:59:36.996 +10:00] [INF] [15] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-01-26 04:59:44.438 +10:00] [WRN] [14] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Branding/Css" to "10.0.1.172" in 0:00:01.2970495 with Status Code 200 [2024-01-26 04:59:44.876 +10:00] [WRN] [13] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/System/Info" to "10.0.1.172" in 0:00:01.0236142 with Status Code 200 [2024-01-26 04:59:44.916 +10:00] [INF] [13] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request [2024-01-26 04:59:45.018 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"AccessSchedule"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"ActivityLog"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"CustomItemDisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"DisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"HomeSection"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"ImageInfo"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"ItemDisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.019 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"Permission"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.020 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"Preference"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.020 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"ApiKey"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.020 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"Device"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.020 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"DeviceOptions"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.020 +10:00] [WRN] [10] Microsoft.EntityFrameworkCore.Model.Validation: The entity type '"User"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-01-26 04:59:45.445 +10:00] [WRN] [14] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Sessions/Capabilities/Full" to "10.0.1.172" in 0:00:00.5640257 with Status Code 204 [2024-01-26 04:59:57.153 +10:00] [INF] [14] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "god". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 04:59:57.275 +10:00] [INF] [14] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=VideoCodecNotSupported, AudioCodecNotSupported ) "media:/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/master.m3u8?MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported" [2024-01-26 04:59:57.811 +10:00] [INF] [13] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-01-26 04:59:57.854 +10:00] [INF] [13] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -f matroska,webm -autorotate 0 -i file:\"/media/tv/Game of Thrones/Season 1/Game of Thrones - S01E01 - Winter Is Coming Bluray-2160p.mkv\" -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 libx264 -preset veryfast -crf 23 -maxrate 10254465 -bufsize 20508930 -x264opts:0 subme=0:me_range=4:rc_lookahead=10:me=dia:no_chroma_me:8x8dct=0:partitions=none -force_key_frames:0 \"expr:gte(t,0+n_forced*3)\" -sc_threshold:v:0 0 -vf \"setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale=trunc(min(max(iw\,ih*a)\,min(3840\,2160*a))/2)*2:trunc(min(max(iw/a\,ih)\,min(3840/a\,2160))/2)*2,format=yuv420p\" -codec:a:0 libfdk_aac -ac 2 -ab 384000 -af \"volume=2\" -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/tmp/ramdisk/03cb3d9f50eb95c37b1ff84e5e629de8%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/tmp/ramdisk/03cb3d9f50eb95c37b1ff84e5e629de8.m3u8\"" [2024-01-26 05:00:03.756 +10:00] [WRN] [25] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/0.ts?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1&MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&PlaySessionId=8d1809be82c94b2b8a6f5a6f4a6a0f1b&api_key=c2f6087512b54053889690144b652402&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported&runtimeTicks=0&actualSegmentLengthTicks=30000000" to "10.0.1.172" in 0:00:05.9790448 with Status Code 200 [2024-01-26 05:00:04.895 +10:00] [WRN] [27] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/1.ts?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1&MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&PlaySessionId=8d1809be82c94b2b8a6f5a6f4a6a0f1b&api_key=c2f6087512b54053889690144b652402&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported&runtimeTicks=30000000&actualSegmentLengthTicks=30000000" to "10.0.1.172" in 0:00:01.1237893 with Status Code 200 [2024-01-26 05:00:05.045 +10:00] [WRN] [25] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/Sessions/Playing" to "10.0.1.172" in 0:00:01.212871 with Status Code 204 [2024-01-26 05:00:05.046 +10:00] [INF] [27] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1-c5f4f470cbbc489cb2c9f2c3805c57a9-7289e25cb4bc1e10a6c70b98b6206466 [2024-01-26 05:00:05.049 +10:00] [INF] [27] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 05:00:05 [2024-01-26 05:00:05.049 +10:00] [INF] [27] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 05:00:05.052 +10:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 05:00:06.058 +10:00] [WRN] [25] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://10.10.10.78:8096/videos/7289e25c-b4bc-1e10-a6c7-0b98b6206466/hls1/main/2.ts?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1&MediaSourceId=7289e25cb4bc1e10a6c70b98b6206466&VideoCodec=h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=139616000&AudioBitrate=384000&MaxFramerate=23.976025&PlaySessionId=8d1809be82c94b2b8a6f5a6f4a6a0f1b&api_key=c2f6087512b54053889690144b652402&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=20aff11476271397cc961cae41bd5fa6&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&TranscodeReasons=VideoCodecNotSupported,%20AudioCodecNotSupported&runtimeTicks=60000000&actualSegmentLengthTicks=30000000" to "10.0.1.172" in 0:00:01.1015869 with Status Code 200 [2024-01-26 05:00:06.209 +10:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/tmp/ramdisk/03cb3d9f50eb95c37b1ff84e5e629de8.m3u8" [2024-01-26 05:00:06.508 +10:00] [INF] [24] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzExOS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MDE4NTMyMTg5MTA1-c5f4f470cbbc489cb2c9f2c3805c57a9-7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 05:00:06.599 +10:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-01-26 05:00:06.601 +10:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/tmp/ramdisk/03cb3d9f50eb95c37b1ff84e5e629de8.m3u8" [2024-01-26 05:00:08.117 +10:00] [INF] [13] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Web" "10.8.10" playing "Winter Is Coming". Stopped at "2055" ms [2024-01-26 05:00:10.901 +10:00] [INF] [24] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.173" request [2024-01-26 05:00:18.642 +10:00] [INF] [28] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 05:00:18.648 +10:00] [INF] [28] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/tv/Sex and the City/Season 4/Sex and the City - S04E01 - The Agony and the 'Ex'-tacy WEBDL-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/61f18a6e-f018-e6bc-f674-12f740350917/stream.mkv?MediaSourceId=61f18a6ef018e6bcf67412f740350917&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=2&api_key=&SubtitleMethod=Embed&Tag=a599daebdffa8056bac212aa66347f62" [2024-01-26 05:00:18.746 +10:00] [INF] [26] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "mulligan". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-01-26 05:00:18.754 +10:00] [INF] [26] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/tv/Sex and the City/Season 4/Sex and the City - S04E01 - The Agony and the 'Ex'-tacy WEBDL-1080p.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=AudioCodecNotSupported ) "media:/videos/61f18a6e-f018-e6bc-f674-12f740350917/master.m3u8?MediaSourceId=61f18a6ef018e6bcf67412f740350917&VideoCodec=hevc,h264,h264&AudioCodec=aac,mp3&AudioStreamIndex=1&VideoBitrate=119616000&AudioBitrate=384000&MaxFramerate=23.976025&api_key=&RequireAvc=false&Tag=a599daebdffa8056bac212aa66347f62&SegmentContainer=ts&BreakOnNonKeyFrames=False&h264-level=40&h264-videobitdepth=8&h264-profile=high&h264-maxrefframes=4&aac-audiochannels=8&TranscodeReasons=AudioCodecNotSupported" [2024-01-26 05:00:19.011 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : 62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917 [2024-01-26 05:00:19.011 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 01/26/2024 05:00:19 [2024-01-26 05:00:19.011 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-01-26 05:00:19.011 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-01-26 05:00:19.852 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:25.047 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.172" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c5f4f470cbbc489cb2c9f2c3805c57a9" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 1 [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c5f4f470cbbc489cb2c9f2c3805c57a9" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "na" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Jellyfin Web" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Chrome" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "Game of Thrones - s01e01 - Winter Is Coming" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "7289e25cb4bc1e10a6c70b98b6206466" [2024-01-26 05:00:25.050 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-01-26 05:00:25.051 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Details do not match for play item [2024-01-26 05:00:25.051 +10:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "10.0.1.173" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 2 [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "c92fdf84e2eb426dbd62e59b2169535c" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectPlay" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Android TV" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Joel's Fire TV" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "Sex and the City - s04e01 - The Agony and the 'Ex'-tacy" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:39.010 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-01-26 05:00:39.041 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-01-26 05:00:39.853 +10:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "62b528e39ff23de642f1b149c3ab888b099025d9-c92fdf84e2eb426dbd62e59b2169535c-61f18a6ef018e6bcf67412f740350917" [2024-01-26 05:00:51.759 +10:00] [INF] [24] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.16.4" playing "The Agony and the 'Ex'-tacy". Stopped at "0" ms [2024-01-26 05:03:33.376 +10:00] [INF] [23] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-01-26 05:03:45.378 +10:00] [INF] [41] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-01-26 05:03:57.376 +10:00] [INF] [43] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-01-26 05:04:33.494 +10:00] [INF] [40] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.0.1.172" request