[2024-05-31 20:55:12.551 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/Users/ba0e0f65c15349eca85c66f25da96cb9/Items/7fca0e95fe90d17edec563c368fdd387""" - null null [2024-05-31 20:55:12.566 -04:00] [INF] [18] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:12.575 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.UserLibraryController.GetItemLegacy (Jellyfin.Api)"' [2024-05-31 20:55:12.578 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetItemLegacy\", controller = \"UserLibrary\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Dto.BaseItemDto]] GetItemLegacy(System.Guid, System.Guid)" on controller "Jellyfin.Api.Controllers.UserLibraryController" ("Jellyfin.Api"). [2024-05-31 20:55:12.621 -04:00] [INF] [18] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"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-05-31 20:55:12.627 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Dto.BaseItemDto"'. [2024-05-31 20:55:12.640 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.UserLibraryController.GetItemLegacy (Jellyfin.Api)" in 58.0604ms [2024-05-31 20:55:12.644 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.UserLibraryController.GetItemLegacy (Jellyfin.Api)"' [2024-05-31 20:55:12.647 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/Users/ba0e0f65c15349eca85c66f25da96cb9/Items/7fca0e95fe90d17edec563c368fdd387""" - 200 null "application/json; charset=utf-8" 95.7451ms [2024-05-31 20:55:12.655 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/Users/ba0e0f65c15349eca85c66f25da96cb9/Items/7fca0e95fe90d17edec563c368fdd387/Intros""" - null null [2024-05-31 20:55:12.662 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:12.671 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.UserLibraryController.GetIntrosLegacy (Jellyfin.Api)"' [2024-05-31 20:55:12.674 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetIntrosLegacy\", controller = \"UserLibrary\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.Querying.QueryResult`1[MediaBrowser.Model.Dto.BaseItemDto]]] GetIntrosLegacy(System.Guid, System.Guid)" on controller "Jellyfin.Api.Controllers.UserLibraryController" ("Jellyfin.Api"). [2024-05-31 20:55:12.679 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.Querying.QueryResult`1[[MediaBrowser.Model.Dto.BaseItemDto, MediaBrowser.Model, Version=10.9.3.0, Culture=neutral, PublicKeyToken=null]]"'. [2024-05-31 20:55:12.682 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.UserLibraryController.GetIntrosLegacy (Jellyfin.Api)" in 4.7157ms [2024-05-31 20:55:12.685 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.UserLibraryController.GetIntrosLegacy (Jellyfin.Api)"' [2024-05-31 20:55:12.688 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/Users/ba0e0f65c15349eca85c66f25da96cb9/Items/7fca0e95fe90d17edec563c368fdd387/Intros""" - 200 null "application/json; charset=utf-8" 32.8816ms [2024-05-31 20:55:12.701 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&MaxStreamingBitrate=140000000" - "application/json" 4659 [2024-05-31 20:55:12.706 -04:00] [INF] [6] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:12.710 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:12.716 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:12.718 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetPostedPlaybackInfo\", controller = \"MediaInfo\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.MediaInfo.PlaybackInfoResponse]] GetPostedPlaybackInfo(System.Guid, System.Nullable`1[System.Guid], System.Nullable`1[System.Int32], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], 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.Boolean], System.Nullable`1[System.Boolean], Jellyfin.Api.Models.MediaInfoDtos.PlaybackInfoDto)" on controller "Jellyfin.Api.Controllers.MediaInfoController" ("Jellyfin.Api"). [2024-05-31 20:55:12.732 -04:00] [INF] [6] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Bob". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-05-31 20:55:12.740 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.MediaInfo.PlaybackInfoResponse"'. [2024-05-31 20:55:12.746 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)" in 23.076ms [2024-05-31 20:55:12.749 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:12.751 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&MaxStreamingBitrate=140000000" - 200 null "application/json; charset=utf-8" 50.1895ms [2024-05-31 20:55:13.129 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported" - null null [2024-05-31 20:55:13.158 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.164 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.167 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetMasterHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetMasterHlsVideoPlaylist(System.Guid, 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], Boolean, Boolean)" on controller "Jellyfin.Api.Controllers.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:13.181 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"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-05-31 20:55:13.191 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:13.196 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)" in 23.6848ms [2024-05-31 20:55:13.199 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.203 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported" - 200 988 "application/vnd.apple.mpegurl" 73.6355ms [2024-05-31 20:55:13.218 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported" - null null [2024-05-31 20:55:13.224 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.229 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.232 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVariantHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVariantHlsVideoPlaylist(System.Guid, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:13.273 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:13.306 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)" in 69.7718ms [2024-05-31 20:55:13.314 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.318 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported" - 200 2286747 "application/vnd.apple.mpegurl" 100.463ms [2024-05-31 20:55:13.496 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&runtimeTicks=0&actualSegmentLengthTicks=0" - null null [2024-05-31 20:55:13.518 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.532 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:13.538 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetHlsVideoSegment\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetHlsVideoSegment(System.Guid, System.String, Int32, System.String, Int64, Int64, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:13.551 -04:00] [INF] [20] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-05-31 20:55:13.561 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)" in 15.2412ms [2024-05-31 20:55:13.564 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:13.568 -04:00] [ERR] [20] Jellyfin.Api.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4". System.NullReferenceException: Object reference not set to an instance of an object. at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.<>c.b__8_0(MediaAttachment a) at System.Linq.Enumerable.Any[TSource](IEnumerable`1 source, Func`2 predicate) at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.ExtractAllAttachments(String inputFile, MediaSourceInfo mediaSource, String outputPath, CancellationToken cancellationToken) at MediaBrowser.MediaEncoding.Transcoding.TranscodeManager.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, Guid userId, 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_method1107(Closure, Object) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(ActionContext actionContext, 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.InvokeInnerFilterAsync() --- End of stack trace from previous location --- 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.InvokeFilterPipelineAsync() --- End of stack trace from previous location --- at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|7_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Api.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Api.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Api.Middleware.IPBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Api.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Api.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.Api.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Api.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Api.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Api.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-05-31 20:55:13.594 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&runtimeTicks=0&actualSegmentLengthTicks=0" - 500 null "text/plain" 98.3566ms [2024-05-31 20:55:13.612 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing/Progress""" - "application/json" 553 [2024-05-31 20:55:13.618 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing""" - "application/json" 623 [2024-05-31 20:55:13.623 -04:00] [INF] [6] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:13.628 -04:00] [INF] [20] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:13.632 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.634 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.638 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"' [2024-05-31 20:55:13.643 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)"' [2024-05-31 20:55:13.646 -04:00] [INF] [6] 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-05-31 20:55:13.651 -04:00] [INF] [20] 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-05-31 20:55:13.701 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.713 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&AudioStreamIndex=1&SubtitleStreamIndex=2&EnableDirectPlay=false&EnableDirectStream=false&AllowVideoStreamCopy=false&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&MaxStreamingBitrate=140000000" - "application/json" 4659 [2024-05-31 20:55:13.715 -04:00] [INF] [21] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("9"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-05-31 20:55:13.716 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("8"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.732 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.720 -04:00] [INF] [18] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:13.738 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.742 -04:00] [INF] [18] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.746 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.750 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:13.755 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("2"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-05-31 20:55:13.758 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.759 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetPostedPlaybackInfo\", controller = \"MediaInfo\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.MediaInfo.PlaybackInfoResponse]] GetPostedPlaybackInfo(System.Guid, System.Nullable`1[System.Guid], System.Nullable`1[System.Int32], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], 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.Boolean], System.Nullable`1[System.Boolean], Jellyfin.Api.Models.MediaInfoDtos.PlaybackInfoDto)" on controller "Jellyfin.Api.Controllers.MediaInfoController" ("Jellyfin.Api"). [2024-05-31 20:55:13.768 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.778 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.780 -04:00] [INF] [18] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Bob". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-05-31 20:55:13.784 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.791 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.MediaInfo.PlaybackInfoResponse"'. [2024-05-31 20:55:13.795 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.799 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)" in 27.3079ms [2024-05-31 20:55:13.802 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.804 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:13.810 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.812 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&AudioStreamIndex=1&SubtitleStreamIndex=2&EnableDirectPlay=false&EnableDirectStream=false&AllowVideoStreamCopy=false&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&MaxStreamingBitrate=140000000" - 200 null "application/json; charset=utf-8" 98.6202ms [2024-05-31 20:55:13.818 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.824 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c" - null null [2024-05-31 20:55:13.830 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.833 -04:00] [INF] [18] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:13.838 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.841 -04:00] [INF] [18] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.845 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.849 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:13.853 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.854 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"StopEncodingProcess\", controller = \"HlsSegment\"}". Executing controller action with signature "Microsoft.AspNetCore.Mvc.ActionResult StopEncodingProcess(System.String, System.String)" on controller "Jellyfin.Api.Controllers.HlsSegmentController" ("Jellyfin.Api"). [2024-05-31 20:55:13.860 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.863 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:13.867 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.868 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)" in 5.848ms [2024-05-31 20:55:13.875 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.876 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:13.881 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.882 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c" - 204 null null 58.7028ms [2024-05-31 20:55:13.889 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.900 -04:00] [INF] [18] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false" - null null [2024-05-31 20:55:13.909 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.918 -04:00] [INF] [18] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:13.925 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?' (DbType = Boolean)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Permissions\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.937 -04:00] [INF] [18] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.939 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.940 -04:00] [INF] [18] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetMasterHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetMasterHlsVideoPlaylist(System.Guid, 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], Boolean, Boolean)" on controller "Jellyfin.Api.Controllers.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:13.945 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.955 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("2"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-05-31 20:55:13.955 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("2"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.969 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:13.969 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.972 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)" in 24.2994ms [2024-05-31 20:55:13.984 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.986 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:13.992 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:13.994 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false" - 200 1015 "application/vnd.apple.mpegurl" 94.4264ms [2024-05-31 20:55:14.000 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.013 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.007 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false" - null null [2024-05-31 20:55:14.020 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.030 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.038 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("2"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.049 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.053 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.055 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVariantHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVariantHlsVideoPlaylist(System.Guid, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:14.061 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.070 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@p4='?' (DbType = Int32), @p0='?' (DbType = Int32), @p1='?' (DbType = UInt32), @p5='?' (DbType = UInt32), @p2='?' (DbType = Guid), @p3='?'"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Preferences\" SET \"Kind\" = @p0, \"RowVersion\" = @p1, \"UserId\" = @p2, \"Value\" = @p3 WHERE \"Id\" = @p4 AND \"RowVersion\" = @p5 RETURNING 1;" [2024-05-31 20:55:14.078 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p29='?' (DbType = Guid), @p0='?', @p1='?' (Size = 67), @p2='?', @p3='?' (DbType = Boolean), @p4='?' (DbType = Boolean), @p5='?' (DbType = Boolean), @p6='?' (DbType = Boolean), @p7='?' (DbType = Boolean), @p8='?' (DbType = Boolean), @p9='?' (DbType = Boolean), @p10='?' (DbType = Int64), @p11='?' (DbType = Int32), @p12='?' (DbType = DateTime), @p13='?' (DbType = DateTime), @p14='?' (DbType = Int32), @p15='?' (DbType = Int32), @p16='?' (DbType = Int32), @p17='?' (DbType = Boolean), @p18='?' (Size = 194), @p19='?' (Size = 66), @p20='?' (DbType = Boolean), @p21='?' (DbType = Boolean), @p22='?' (DbType = Boolean), @p23='?' (DbType = Int32), @p24='?' (DbType = UInt32), @p30='?' (DbType = UInt32), @p25='?', @p26='?' (DbType = Int32), @p27='?' (DbType = Int32), @p28='?' (Size = 3)"], CommandType='Text', CommandTimeout='30']" ""UPDATE \"Users\" SET \"AudioLanguagePreference\" = @p0, \"AuthenticationProviderId\" = @p1, \"CastReceiverId\" = @p2, \"DisplayCollectionsView\" = @p3, \"DisplayMissingEpisodes\" = @p4, \"EnableAutoLogin\" = @p5, \"EnableLocalPassword\" = @p6, \"EnableNextEpisodeAutoPlay\" = @p7, \"EnableUserPreferenceAccess\" = @p8, \"HidePlayedInLatest\" = @p9, \"InternalId\" = @p10, \"InvalidLoginAttemptCount\" = @p11, \"LastActivityDate\" = @p12, \"LastLoginDate\" = @p13, \"LoginAttemptsBeforeLockout\" = @p14, \"MaxActiveSessions\" = @p15, \"MaxParentalAgeRating\" = @p16, \"MustUpdatePassword\" = @p17, \"Password\" = @p18, \"PasswordResetProviderId\" = @p19, \"PlayDefaultAudioTrack\" = @p20, \"RememberAudioSelections\" = @p21, \"RememberSubtitleSelections\" = @p22, \"RemoteClientBitrateLimit\" = @p23, \"RowVersion\" = @p24, \"SubtitleLanguagePreference\" = @p25, \"SubtitleMode\" = @p26, \"SyncPlayAccess\" = @p27, \"Username\" = @p28 WHERE \"Id\" = @p29 AND \"RowVersion\" = @p30 RETURNING 1;" [2024-05-31 20:55:14.133 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:14.158 -04:00] [INF] [21] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)" in 94.3073ms [2024-05-31 20:55:14.168 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.171 -04:00] [INF] [21] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.190 -04:00] [INF] [21] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false" - 200 2353464 "application/vnd.apple.mpegurl" 183.0673ms [2024-05-31 20:55:14.180 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)" in 507.1946ms [2024-05-31 20:55:14.202 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackProgress (Jellyfin.Api)"' [2024-05-31 20:55:14.206 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing/Progress""" - 204 null null 593.9685ms [2024-05-31 20:55:14.257 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=0" - null null [2024-05-31 20:55:14.258 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("488"ms) [Parameters=["@p0='?' (DbType = DateTime), @p1='?' (Size = 32), @p2='?' (DbType = Int32), @p3='?' (Size = 35), @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-05-31 20:55:14.347 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.357 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:14.360 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetHlsVideoSegment\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetHlsVideoSegment(System.Guid, System.String, Int32, System.String, Int64, Int64, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:14.364 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.367 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)" in 666.9246ms [2024-05-31 20:55:14.369 -04:00] [INF] [6] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-05-31 20:55:14.370 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStart (Jellyfin.Api)"' [2024-05-31 20:55:14.377 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing""" - 204 null null 758.3719ms [2024-05-31 20:55:14.379 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)" in 14.2888ms [2024-05-31 20:55:14.390 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:14.394 -04:00] [ERR] [6] Jellyfin.Api.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4". System.NullReferenceException: Object reference not set to an instance of an object. at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.<>c.b__8_0(MediaAttachment a) at System.Linq.Enumerable.Any[TSource](IEnumerable`1 source, Func`2 predicate) at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.ExtractAllAttachments(String inputFile, MediaSourceInfo mediaSource, String outputPath, CancellationToken cancellationToken) at MediaBrowser.MediaEncoding.Transcoding.TranscodeManager.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, Guid userId, 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_method1107(Closure, Object) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(ActionContext actionContext, 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.InvokeInnerFilterAsync() --- End of stack trace from previous location --- 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.InvokeFilterPipelineAsync() --- End of stack trace from previous location --- at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|7_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Api.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Api.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Api.Middleware.IPBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Api.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Api.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.Api.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Api.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Api.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Api.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-05-31 20:55:14.413 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=db02fcb450284f808270cfefcd31c115&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=0" - 500 null "text/plain" 155.7748ms [2024-05-31 20:55:14.435 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&AudioStreamIndex=1&SubtitleStreamIndex=2&EnableDirectPlay=false&EnableDirectStream=false&AllowVideoStreamCopy=false&AllowAudioStreamCopy=false&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&MaxStreamingBitrate=140000000" - "application/json" 4659 [2024-05-31 20:55:14.466 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c" - null null [2024-05-31 20:55:14.471 -04:00] [INF] [20] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:14.475 -04:00] [INF] [6] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:14.480 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.484 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.489 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:14.494 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.497 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetPostedPlaybackInfo\", controller = \"MediaInfo\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[MediaBrowser.Model.MediaInfo.PlaybackInfoResponse]] GetPostedPlaybackInfo(System.Guid, System.Nullable`1[System.Guid], System.Nullable`1[System.Int32], System.Nullable`1[System.Int64], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], System.Nullable`1[System.Int32], 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.Boolean], System.Nullable`1[System.Boolean], Jellyfin.Api.Models.MediaInfoDtos.PlaybackInfoDto)" on controller "Jellyfin.Api.Controllers.MediaInfoController" ("Jellyfin.Api"). [2024-05-31 20:55:14.500 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"StopEncodingProcess\", controller = \"HlsSegment\"}". Executing controller action with signature "Microsoft.AspNetCore.Mvc.ActionResult StopEncodingProcess(System.String, System.String)" on controller "Jellyfin.Api.Controllers.HlsSegmentController" ("Jellyfin.Api"). [2024-05-31 20:55:14.508 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.510 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)" in 2.9978ms [2024-05-31 20:55:14.512 -04:00] [INF] [20] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Bob". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-05-31 20:55:14.513 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.519 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor: Executing "ObjectResult", writing value of type '"MediaBrowser.Model.MediaInfo.PlaybackInfoResponse"'. [2024-05-31 20:55:14.519 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=508d99e4404b4268a1b0bd5e94b7630c" - 204 null null 53.2825ms [2024-05-31 20:55:14.526 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)" in 22.4509ms [2024-05-31 20:55:14.533 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.MediaInfoController.GetPostedPlaybackInfo (Jellyfin.Api)"' [2024-05-31 20:55:14.535 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Items/7fca0e95fe90d17edec563c368fdd387/PlaybackInfo""?UserId=ba0e0f65c15349eca85c66f25da96cb9&StartTimeTicks=0&IsPlayback=true&AutoOpenLiveStream=true&AudioStreamIndex=1&SubtitleStreamIndex=2&EnableDirectPlay=false&EnableDirectStream=false&AllowVideoStreamCopy=false&AllowAudioStreamCopy=false&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&MaxStreamingBitrate=140000000" - 200 null "application/json; charset=utf-8" 100.6103ms [2024-05-31 20:55:14.544 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=db02fcb450284f808270cfefcd31c115" - null null [2024-05-31 20:55:14.548 -04:00] [INF] [20] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:14.551 -04:00] [INF] [20] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.557 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.559 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"StopEncodingProcess\", controller = \"HlsSegment\"}". Executing controller action with signature "Microsoft.AspNetCore.Mvc.ActionResult StopEncodingProcess(System.String, System.String)" on controller "Jellyfin.Api.Controllers.HlsSegmentController" ("Jellyfin.Api"). [2024-05-31 20:55:14.563 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.565 -04:00] [INF] [20] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)" in 2.5848ms [2024-05-31 20:55:14.568 -04:00] [INF] [20] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.571 -04:00] [INF] [20] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=db02fcb450284f808270cfefcd31c115" - 204 null null 27.0987ms [2024-05-31 20:55:14.580 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false" - null null [2024-05-31 20:55:14.586 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.591 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.594 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetMasterHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetMasterHlsVideoPlaylist(System.Guid, 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], Boolean, Boolean)" on controller "Jellyfin.Api.Controllers.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:14.604 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"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-05-31 20:55:14.610 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:14.613 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)" in 15.2624ms [2024-05-31 20:55:14.627 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetMasterHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.631 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/master.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false" - 200 1042 "application/vnd.apple.mpegurl" 51.1585ms [2024-05-31 20:55:14.649 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false" - null null [2024-05-31 20:55:14.655 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.660 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.663 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetVariantHlsVideoPlaylist\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetVariantHlsVideoPlaylist(System.Guid, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:14.693 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.FileContentResultExecutor: Executing "FileContentResult", sending file with download name '""' ... [2024-05-31 20:55:14.725 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)" in 57.2404ms [2024-05-31 20:55:14.736 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetVariantHlsVideoPlaylist (Jellyfin.Api)"' [2024-05-31 20:55:14.757 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/main.m3u8""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false" - 200 2420181 "application/vnd.apple.mpegurl" 108.3992ms [2024-05-31 20:55:14.794 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=0" - null null [2024-05-31 20:55:14.807 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.816 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:14.819 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"GetHlsVideoSegment\", controller = \"DynamicHls\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult] GetHlsVideoSegment(System.Guid, System.String, Int32, System.String, Int64, Int64, 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.DynamicHlsController" ("Jellyfin.Api"). [2024-05-31 20:55:14.828 -04:00] [INF] [13] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2024-05-31 20:55:14.833 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)" in 8.3828ms [2024-05-31 20:55:14.836 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.DynamicHlsController.GetHlsVideoSegment (Jellyfin.Api)"' [2024-05-31 20:55:14.840 -04:00] [ERR] [13] Jellyfin.Api.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4". System.NullReferenceException: Object reference not set to an instance of an object. at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.<>c.b__8_0(MediaAttachment a) at System.Linq.Enumerable.Any[TSource](IEnumerable`1 source, Func`2 predicate) at MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor.ExtractAllAttachments(String inputFile, MediaSourceInfo mediaSource, String outputPath, CancellationToken cancellationToken) at MediaBrowser.MediaEncoding.Transcoding.TranscodeManager.StartFfMpeg(StreamState state, String outputPath, String commandLineArguments, Guid userId, 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_method1107(Closure, Object) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(ActionContext actionContext, 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.InvokeInnerFilterAsync() --- End of stack trace from previous location --- 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.InvokeFilterPipelineAsync() --- End of stack trace from previous location --- at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.g__Logged|17_1(ResourceInvoker invoker) at Microsoft.AspNetCore.Routing.EndpointMiddleware.g__AwaitRequestTask|7_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Api.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Api.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Api.Middleware.IPBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Api.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Api.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.Api.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Api.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Api.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Api.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-05-31 20:55:14.857 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "GET" "http"://"localhost:8096""""/videos/7fca0e95-fe90-d17e-dec5-63c368fdd387/hls1/main/-1.mp4""?DeviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&MediaSourceId=7fca0e95fe90d17edec563c368fdd387&VideoCodec=av1,h264,h264&AudioCodec=aac&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=139616000&AudioBitrate=384000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=ec7c887ad93d4e66b8e9e5142babb6c5&api_key=17a4d109104d425d8e6cb382f79a8c8d&SubtitleMethod=Encode&TranscodingMaxAudioChannels=2&RequireAvc=false&Tag=12623ad513bc5f22549dd8cac18a0a9a&SegmentContainer=mp4&MinSegments=1&BreakOnNonKeyFrames=True&h264-level=30&h264-videobitdepth=8&h264-profile=main&h264-audiochannels=6&aac-profile=lc&h264-rangetype=SDR&h264-deinterlace=true&TranscodeReasons=SubtitleCodecNotSupported&allowVideoStreamCopy=false&allowAudioStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=0" - 500 null "text/plain" 62.8127ms [2024-05-31 20:55:14.892 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing/Stopped""" - "application/json" 580 [2024-05-31 20:55:14.893 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request starting "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=db02fcb450284f808270cfefcd31c115" - null null [2024-05-31 20:55:14.898 -04:00] [INF] [13] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:14.911 -04:00] [INF] [6] Microsoft.AspNetCore.Cors.Infrastructure.CorsService: CORS policy execution successful. [2024-05-31 20:55:14.917 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.929 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStopped (Jellyfin.Api)"' [2024-05-31 20:55:14.930 -04:00] [INF] [6] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("0"ms) [Parameters=["@__token_0='?' (Size = 32)"], CommandType='Text', CommandTimeout='30']" ""SELECT \"d\".\"Id\", \"d\".\"AccessToken\", \"d\".\"AppName\", \"d\".\"AppVersion\", \"d\".\"DateCreated\", \"d\".\"DateLastActivity\", \"d\".\"DateModified\", \"d\".\"DeviceId\", \"d\".\"DeviceName\", \"d\".\"IsActive\", \"d\".\"UserId\" FROM \"Devices\" AS \"d\" WHERE \"d\".\"AccessToken\" = @__token_0 LIMIT 1" [2024-05-31 20:55:14.933 -04:00] [INF] [13] 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-05-31 20:55:14.940 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executing endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.946 -04:00] [INF] [13] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Web" "10.9.3" playing "About Time". Stopped at "0" ms [2024-05-31 20:55:14.949 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Route matched with "{action = \"StopEncodingProcess\", controller = \"HlsSegment\"}". Executing controller action with signature "Microsoft.AspNetCore.Mvc.ActionResult StopEncodingProcess(System.String, System.String)" on controller "Jellyfin.Api.Controllers.HlsSegmentController" ("Jellyfin.Api"). [2024-05-31 20:55:14.961 -04:00] [INF] [13] Microsoft.EntityFrameworkCore.Database.Command: Executed DbCommand ("1"ms) [Parameters=["@p0='?' (DbType = DateTime), @p1='?' (Size = 32), @p2='?' (DbType = Int32), @p3='?' (Size = 45), @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\";" [2024-05-31 20:55:14.963 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.972 -04:00] [INF] [6] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)" in 9.0567ms [2024-05-31 20:55:14.975 -04:00] [INF] [6] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.HlsSegmentController.StopEncodingProcess (Jellyfin.Api)"' [2024-05-31 20:55:14.978 -04:00] [INF] [6] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "DELETE" "http"://"localhost:8096""""/Videos/ActiveEncodings""?deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzEyNS4wLjAuMCBTYWZhcmkvNTM3LjM2fDE3MTcxMTQyMTIyMTA1&PlaySessionId=db02fcb450284f808270cfefcd31c115" - 204 null null 84.5933ms [2024-05-31 20:55:14.992 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.StatusCodeResult: Executing StatusCodeResult, setting HTTP status code 204 [2024-05-31 20:55:14.995 -04:00] [INF] [13] Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker: Executed action "Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStopped (Jellyfin.Api)" in 50.0614ms [2024-05-31 20:55:15.000 -04:00] [INF] [13] Microsoft.AspNetCore.Routing.EndpointMiddleware: Executed endpoint '"Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStopped (Jellyfin.Api)"' [2024-05-31 20:55:15.003 -04:00] [INF] [13] Microsoft.AspNetCore.Hosting.Diagnostics: Request finished "HTTP/1.1" "POST" "http"://"localhost:8096""""/Sessions/Playing/Stopped""" - 204 null null 110.3172ms