[2023-12-16 02:38:31.897 -06:00] [INF] [1] Main: Jellyfin version: "10.8.12" [2023-12-16 02:38:31.917 -06:00] [INF] [1] Main: Environment Variables: ["[JELLYFIN_LOG_DIR, C:\ProgramData\Jellyfin\Server\log]"] [2023-12-16 02:38:31.920 -06:00] [INF] [1] Main: Arguments: ["C:\Program Files\Jellyfin\Server\jellyfin.dll", "--datadir", "C:\ProgramData\Jellyfin\Server"] [2023-12-16 02:38:31.923 -06:00] [INF] [1] Main: Operating system: "Windows" [2023-12-16 02:38:31.924 -06:00] [INF] [1] Main: Architecture: X64 [2023-12-16 02:38:31.926 -06:00] [INF] [1] Main: 64-Bit Process: True [2023-12-16 02:38:31.927 -06:00] [INF] [1] Main: User Interactive: True [2023-12-16 02:38:31.928 -06:00] [INF] [1] Main: Processor count: 12 [2023-12-16 02:38:31.929 -06:00] [INF] [1] Main: Program data path: "C:\ProgramData\Jellyfin\Server" [2023-12-16 02:38:31.931 -06:00] [INF] [1] Main: Web resources path: "C:\Program Files\Jellyfin\Server\jellyfin-web" [2023-12-16 02:38:31.932 -06:00] [INF] [1] Main: Application directory: "C:\Program Files\Jellyfin\Server\" [2023-12-16 02:38:32.047 -06:00] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: "C:\ProgramData\Jellyfin\Server\cache" [2023-12-16 02:38:32.085 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies [2023-12-16 02:38:32.098 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly "Jellyfin.Plugin.SubtitleExtract, Version=2.0.0.0, Culture=neutral, PublicKeyToken=null" from "C:\ProgramData\Jellyfin\Server\plugins\Subtitle Extract_2.0.0.0\Jellyfin.Plugin.SubtitleExtract.dll" [2023-12-16 02:38:32.217 -06:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2023-12-16 02:38:32.218 -06:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2023-12-16 02:38:32.220 -06:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2023-12-16 02:38:32.232 -06:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind addresses: "[]" [2023-12-16 02:38:32.233 -06:00] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind exclusions: "[]" [2023-12-16 02:38:33.756 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Subtitle Extract" "2.0.0.0" [2023-12-16 02:38:33.758 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "TMDb" "10.8.12.0" [2023-12-16 02:38:33.760 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "Studio Images" "10.8.12.0" [2023-12-16 02:38:33.761 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "OMDb" "10.8.12.0" [2023-12-16 02:38:33.763 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "MusicBrainz" "10.8.12.0" [2023-12-16 02:38:33.764 -06:00] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: "AudioDB" "10.8.12.0" [2023-12-16 02:38:33.807 -06:00] [INF] [1] Main: Kestrel listening on "Any IP4 Address" [2023-12-16 02:38:34.074 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks [2023-12-16 02:38:34.099 -06:00] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Extract Chapter Images" set to fire at 2023-12-17 02:00:00.000 -06:00, which is 23:21:25.9006415 from now. [2023-12-16 02:38:34.295 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version "5.1.3" [2023-12-16 02:38:34.477 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "decoders": ["libdav1d", "av1", "av1_cuvid", "av1_qsv", "h264", "h264_qsv", "h264_cuvid", "hevc", "hevc_qsv", "hevc_cuvid", "mpeg2video", "mpeg2_qsv", "mpeg2_cuvid", "mpeg4", "mpeg4_cuvid", "msmpeg4", "vc1_qsv", "vc1_cuvid", "vp8", "libvpx", "vp8_cuvid", "vp8_qsv", "vp9", "libvpx-vp9", "vp9_cuvid", "vp9_qsv", "aac", "ac3", "dca", "flac", "mp3", "truehd"] [2023-12-16 02:38:34.656 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available "encoders": ["libx264", "h264_amf", "h264_nvenc", "h264_qsv", "libx265", "hevc_amf", "hevc_nvenc", "hevc_qsv", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "libfdk_aac", "ac3", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"] [2023-12-16 02:38:34.836 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available filters: ["deinterlace_qsv", "hwupload_cuda", "hwupload_vaapi", "overlay_opencl", "overlay_qsv", "overlay_cuda", "scale_cuda", "scale_opencl", "scale_qsv", "tonemap_cuda", "tonemap_opencl", "vpp_qsv", "yadif_cuda", "zscale", "alphasrc"] [2023-12-16 02:38:35.683 -06:00] [WRN] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Filter: "overlay_vaapi" with option "Action to take when encountering EOF from secondary input" is not available [2023-12-16 02:38:35.700 -06:00] [INF] [12] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "192.168.100.2" request [2023-12-16 02:38:35.861 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: ["cuda", "dxva2", "qsv", "d3d11va", "opencl"] [2023-12-16 02:38:36.264 -06:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: "ffmpeg" [2023-12-16 02:38:36.265 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: "2a224424c4c14f4694181423e7a02f86" [2023-12-16 02:38:36.351 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all pre-startup entry points in 0:00:00.0787429 [2023-12-16 02:38:36.353 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete [2023-12-16 02:38:36.495 -06:00] [INF] [12] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "B:\H games\Media\Videos" [2023-12-16 02:38:36.498 -06:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all post-startup entry points in 0:00:00.1444813 [2023-12-16 02:38:36.500 -06:00] [INF] [1] Main: Startup complete 0:00:04.7452642 [2023-12-16 02:38:37.108 -06:00] [INF] [12] Emby.Server.Implementations.ScheduledTasks.TaskManager: "StartupTrigger" fired for task: "Update Plugins" [2023-12-16 02:38:37.111 -06:00] [INF] [12] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "PluginUpdateTask" [2023-12-16 02:38:37.113 -06:00] [INF] [9] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Update Plugins" [2023-12-16 02:38:38.126 -06:00] [INF] [21] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Update Plugins" Completed after 0 minute(s) and 1 seconds [2023-12-16 02:38:38.133 -06:00] [INF] [21] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2023-12-16 02:38:38.199 -06:00] [INF] [9] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "rober". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2023-12-16 02:38:38.243 -06:00] [INF] [9] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Android External Player Stub", Path="B:\H games\Media\Videos\TestVideo.mp4", AudioStreamIndex=2, SubtitleStreamIndex=0 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/02216186-3342-b09e-a327-4bbc7aa54f2b/stream?MediaSourceId=022161863342b09ea3274bbc7aa54f2b&AudioStreamIndex=2&SubtitleStreamIndex=0&api_key=<token>&SubtitleMethod=Encode&RequireAvc=false&Tag=8fc85c753df487f722dd2736a566516f&TranscodeReasons=SubtitleCodecNotSupported" [2023-12-16 02:39:00.309 -06:00] [INF] [23] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Android" "2.6.0" playing "TestVideo". Stopped at "27000" ms [2023-12-16 02:39:04.705 -06:00] [INF] [21] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "rober". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2023-12-16 02:39:04.708 -06:00] [INF] [21] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Android External Player Stub", Path="B:\H games\Media\Videos\TestVideo.mp4", AudioStreamIndex=2, SubtitleStreamIndex=0 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/02216186-3342-b09e-a327-4bbc7aa54f2b/stream?MediaSourceId=022161863342b09ea3274bbc7aa54f2b&AudioStreamIndex=2&SubtitleStreamIndex=0&api_key=<token>&SubtitleMethod=Encode&RequireAvc=false&Tag=8fc85c753df487f722dd2736a566516f&TranscodeReasons=SubtitleCodecNotSupported" [2023-12-16 02:39:23.892 -06:00] [INF] [7] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2023-12-16 02:39:24.666 -06:00] [INF] [21] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Android" "2.6.0" playing "TestVideo". Stopped at "19222" ms [2023-12-16 02:39:26.259 -06:00] [INF] [12] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "rober". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2023-12-16 02:39:26.261 -06:00] [INF] [12] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Android External Player Stub", Path="B:\H games\Media\Videos\TestVideo.mp4", AudioStreamIndex=2, SubtitleStreamIndex=0 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/02216186-3342-b09e-a327-4bbc7aa54f2b/stream?MediaSourceId=022161863342b09ea3274bbc7aa54f2b&AudioStreamIndex=2&SubtitleStreamIndex=0&api_key=<token>&SubtitleMethod=Encode&RequireAvc=false&Tag=8fc85c753df487f722dd2736a566516f&TranscodeReasons=SubtitleCodecNotSupported" [2023-12-16 02:39:35.906 -06:00] [INF] [25] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2023-12-16 02:39:45.688 -06:00] [ERR] [23] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "POST" "/Sessions/Playing/Stopped". System.ArgumentOutOfRangeException: The PlaybackStopInfo's PositionTicks was negative. (Parameter 'info') at Emby.Server.Implementations.Session.SessionManager.OnPlaybackStopped(PlaybackStopInfo info) at Jellyfin.Api.Controllers.PlaystateController.ReportPlaybackStopped(PlaybackStopInfo playbackStopInfo) at lambda_method709(Closure , Object ) at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.TaskOfActionResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeActionMethodAsync>g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask) at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeNextActionFilterAsync>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.<InvokeNextResourceFilter>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.<InvokeAsync>g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.<InvokeAsync>g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope) at Microsoft.AspNetCore.Routing.EndpointMiddleware.<Invoke>g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger) at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager) at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager) at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager) at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager) at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult) at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.QueryStringDecodingMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext) at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context)