[2024-04-17 00:00:00.002 +02:00] [INF] [44] Emby.Server.Implementations.ScheduledTasks.TaskManager: "DailyTrigger" fired for task: "Playback Reporting Trim Db" [2024-04-17 00:00:00.002 +02:00] [INF] [44] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "TaskCleanDb" [2024-04-17 00:00:00.002 +02:00] [INF] [44] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Playback Reporting Trim Db" [2024-04-17 00:00:00.005 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.TaskCleanDb: Playback Reporting Data Trim [2024-04-17 00:00:00.006 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.TaskCleanDb: MaxDataAge : 3 [2024-04-17 00:00:00.009 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: DeleteOldData : "delete from PlaybackActivity where DateCreated < '2024-01-17 00:00:00.0064962'" [2024-04-17 00:00:00.010 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Default journal_mode for "/config/data/playback_reporting.db" is "delete" [2024-04-17 00:00:00.011 +02:00] [INF] [107] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Playback Reporting Trim Db" Completed after 0 minute(s) and 0 seconds [2024-04-17 00:00:00.012 +02:00] [INF] [107] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 00:00:01.002 +02:00] [INF] [78] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Playback Reporting Trim Db" set to fire at 2024-04-18 00:00:00.000 +02:00, which is 23:59:58.9970872 from now. [2024-04-17 01:59:59.999 +02:00] [INF] [61] Emby.Server.Implementations.ScheduledTasks.TaskManager: "DailyTrigger" fired for task: "Extract Chapter Images" [2024-04-17 01:59:59.999 +02:00] [INF] [61] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "ChapterImagesTask" [2024-04-17 02:00:00.000 +02:00] [INF] [79] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Extract Chapter Images" [2024-04-17 02:00:00.075 +02:00] [INF] [79] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Extract Chapter Images" Completed after 0 minute(s) and 0 seconds [2024-04-17 02:00:00.075 +02:00] [INF] [79] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 02:00:01.000 +02:00] [INF] [61] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for "Extract Chapter Images" set to fire at 2024-04-18 02:00:00.000 +02:00, which is 23:59:58.9994152 from now. [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Scan Media Library" [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "RefreshMediaLibraryTask" [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Scan Media Library" [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/movies" [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/music" [2024-04-17 07:33:50.406 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/documentaries" [2024-04-17 07:33:50.407 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/series" [2024-04-17 07:33:50.407 +02:00] [INF] [11] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/videos" [2024-04-17 07:33:50.407 +02:00] [INF] [11] Emby.Server.Implementations.Library.LibraryManager: Validating media library [2024-04-17 07:33:58.468 +02:00] [INF] [73] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Scan Media Library" Completed after 0 minute(s) and 8 seconds [2024-04-17 07:33:58.469 +02:00] [INF] [55] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/videos" [2024-04-17 07:33:58.470 +02:00] [INF] [73] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 07:33:58.494 +02:00] [INF] [101] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/music" [2024-04-17 07:33:58.498 +02:00] [INF] [89] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/series" [2024-04-17 07:33:58.503 +02:00] [INF] [82] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/documentaries" [2024-04-17 07:33:58.504 +02:00] [INF] [37] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/movies" [2024-04-17 09:26:54.722 +02:00] [INF] [85] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:26:54.722 +02:00] [INF] [85] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:26:54.722 +02:00] [INF] [85] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:26.051 +02:00] [INF] [25] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:26.052 +02:00] [INF] [25] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:27:26.052 +02:00] [INF] [25] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:28.055 +02:00] [INF] [65] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:28.055 +02:00] [INF] [65] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:27:28.055 +02:00] [INF] [65] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:59.296 +02:00] [INF] [74] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:27:59.297 +02:00] [INF] [74] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:27:59.297 +02:00] [INF] [74] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:07.376 +02:00] [INF] [84] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:07.376 +02:00] [INF] [84] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:29:07.376 +02:00] [INF] [84] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:09.379 +02:00] [INF] [21] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:09.379 +02:00] [INF] [21] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:29:09.379 +02:00] [INF] [21] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:48.993 +02:00] [INF] [109] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:29:48.993 +02:00] [INF] [109] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:29:48.993 +02:00] [INF] [109] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:31:40.014 +02:00] [INF] [100] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:31:40.015 +02:00] [INF] [100] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:31:40.015 +02:00] [INF] [100] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:31:42.019 +02:00] [INF] [92] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:31:42.019 +02:00] [INF] [92] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:31:42.019 +02:00] [INF] [92] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:33:48.305 +02:00] [INF] [72] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:33:48.305 +02:00] [INF] [72] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:33:48.305 +02:00] [INF] [72] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:33:50.307 +02:00] [INF] [88] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 09:33:50.307 +02:00] [INF] [88] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : "[]" [2024-04-17 09:33:50.307 +02:00] [INF] [88] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: "[10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-04-17 11:00:29.087 +02:00] [INF] [80] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Update Plugins" [2024-04-17 11:00:29.087 +02:00] [INF] [80] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "PluginUpdateTask" [2024-04-17 11:00:29.087 +02:00] [INF] [80] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Update Plugins" [2024-04-17 11:00:30.486 +02:00] [ERR] [80] Emby.Server.Implementations.Updates.InstallationManager: An error occurred while accessing the plugin manifest: "https://repo.codyrobibero.dev/manifest.json" System.Net.Http.HttpRequestException: Name or service not known (repo.codyrobibero.dev:443) ---> System.Net.Sockets.SocketException (0xFFFDFFFF): Name or service not known at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource.GetResult(Int16 token) at System.Net.Sockets.Socket.g__WaitForConnectWithCancellation|277_0(AwaitableSocketAsyncEventArgs saea, ValueTask connectTask, CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.ConnectToTcpHostAsync(String host, Int32 port, HttpRequestMessage initialRequest, Boolean async, CancellationToken cancellationToken) --- End of inner exception stack trace --- at System.Net.Http.HttpConnectionPool.ConnectToTcpHostAsync(String host, Int32 port, HttpRequestMessage initialRequest, Boolean async, CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.CreateHttp11ConnectionAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.AddHttp11ConnectionAsync(HttpRequestMessage request) at System.Threading.Tasks.TaskCompletionSourceWithCancellation`1.WaitWithCancellationAsync(CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.GetHttp11ConnectionAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken) at System.Net.Http.HttpConnectionPool.SendWithVersionDetectionAndRetryAsync(HttpRequestMessage request, Boolean async, Boolean doRequestAuth, CancellationToken cancellationToken) at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken) at System.Net.Http.DecompressionHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken) at Microsoft.Extensions.Http.Logging.LoggingHttpMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken) at Microsoft.Extensions.Http.Logging.LoggingScopeHttpMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken) at System.Net.Http.HttpClient.g__Core|83_0(HttpRequestMessage request, HttpCompletionOption completionOption, CancellationTokenSource cts, Boolean disposeCts, CancellationTokenSource pendingRequestsCts, CancellationToken originalCancellationToken) at System.Net.Http.Json.HttpClientJsonExtensions.GetFromJsonAsyncCore[T](Task`1 taskResponse, JsonSerializerOptions options, CancellationToken cancellationToken) at Emby.Server.Implementations.Updates.InstallationManager.GetPackages(String manifestName, String manifest, Boolean filterIncompatible, CancellationToken cancellationToken) [2024-04-17 11:00:30.489 +02:00] [INF] [80] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Update Plugins" Completed after 0 minute(s) and 1 seconds [2024-04-17 11:00:30.492 +02:00] [INF] [80] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks ... [2024-04-17 17:57:00.406 +02:00] [INF] [82] Emby.Server.Implementations.IO.LibraryMonitor: "movies" ("/data/media/movies") will be refreshed. [2024-04-17 18:05:59.022 +02:00] [INF] [110] Jellyfin.Server.Implementations.Users.UserManager: Authentication request for "root" has succeeded. [2024-04-17 18:05:59.022 +02:00] [INF] [110] Emby.Server.Implementations.Session.SessionManager: Current/Max sessions for user "root": 1/0 [2024-04-17 18:05:59.031 +02:00] [INF] [110] Emby.Server.Implementations.Session.SessionManager: Reissuing access token: "6c8c93a9141d499ea9e87a44345a027a" [2024-04-17 18:07:56.642 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Clean Log Directory" [2024-04-17 18:07:56.643 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "DeleteLogFileTask" [2024-04-17 18:07:56.643 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Clean Log Directory" [2024-04-17 18:07:56.660 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Clean Transcode Directory" [2024-04-17 18:07:56.660 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "DeleteTranscodeFileTask" [2024-04-17 18:07:56.660 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Clean Transcode Directory" [2024-04-17 18:07:56.665 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Clean Transcode Directory" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.667 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:56.707 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Clean Log Directory" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.709 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:56.738 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Clean Cache Directory" [2024-04-17 18:07:56.738 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "DeleteCacheFileTask" [2024-04-17 18:07:56.738 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Clean Cache Directory" [2024-04-17 18:07:56.744 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Clean Cache Directory" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.745 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:56.778 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Merge All Episodes" [2024-04-17 18:07:56.780 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "MergeEpisodesTask" [2024-04-17 18:07:56.780 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Merge All Episodes" [2024-04-17 18:07:56.780 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "TasksRefreshChannels" [2024-04-17 18:07:56.780 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "RefreshChannelsScheduledTask" [2024-04-17 18:07:56.780 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "TasksRefreshChannels" [2024-04-17 18:07:56.781 +02:00] [INF] [50] Jellyfin.Api.Controllers.VideosController: Starting plugin, Merging Episodes [2024-04-17 18:07:56.790 +02:00] [INF] [50] Jellyfin.Api.Controllers.VideosController: Scanning for repeated episodes [2024-04-17 18:07:56.790 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: "TasksRefreshChannels" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.790 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:56.825 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Merge All Movies" [2024-04-17 18:07:56.825 +02:00] [INF] [69] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "MergeMoviesTask" [2024-04-17 18:07:56.825 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Merge All Movies" [2024-04-17 18:07:56.826 +02:00] [INF] [50] Jellyfin.Api.Controllers.VideosController: Merging Episodes task finished [2024-04-17 18:07:56.826 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Merge All Episodes" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.826 +02:00] [INF] [38] Jellyfin.Api.Controllers.VideosController: Starting plugin, Merging Movies [2024-04-17 18:07:56.827 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:56.867 +02:00] [INF] [38] Jellyfin.Api.Controllers.VideosController: Scanning for repeated movies [2024-04-17 18:07:56.869 +02:00] [INF] [38] Jellyfin.Api.Controllers.VideosController: All movies merged [2024-04-17 18:07:56.869 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Merge All Movies" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:56.870 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:07:57.496 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Optimize database" [2024-04-17 18:07:57.496 +02:00] [INF] [38] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "OptimizeDatabaseTask" [2024-04-17 18:07:57.496 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Optimize database" [2024-04-17 18:07:57.498 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.Tasks.OptimizeDatabaseTask: Optimizing and vacuuming jellyfin.db... [2024-04-17 18:07:57.560 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.Tasks.OptimizeDatabaseTask: jellyfin.db optimized successfully! [2024-04-17 18:07:57.561 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Optimize database" Completed after 0 minute(s) and 0 seconds [2024-04-17 18:07:57.562 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:08:05.700 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Refresh Guide" [2024-04-17 18:08:05.700 +02:00] [INF] [50] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "RefreshGuideScheduledTask" [2024-04-17 18:08:05.700 +02:00] [INF] [23] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Refresh Guide" [2024-04-17 18:08:08.769 +02:00] [INF] [73] Emby.Server.Implementations.LiveTv.LiveTvManager: Refreshing guide with 7 days of guide data [2024-04-17 18:08:08.776 +02:00] [INF] [73] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Refresh Guide" Completed after 0 minute(s) and 3 seconds [2024-04-17 18:08:08.777 +02:00] [INF] [73] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 18:10:27.838 +02:00] [INF] [16] Emby.Server.Implementations.ScheduledTasks.TaskManager: "IntervalTrigger" fired for task: "Download missing subtitles" [2024-04-17 18:10:27.839 +02:00] [INF] [16] Emby.Server.Implementations.ScheduledTasks.TaskManager: Queuing task "SubtitleScheduledTask" [2024-04-17 18:10:27.839 +02:00] [INF] [110] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Download missing subtitles" [2024-04-17 18:11:23.308 +02:00] [INF] [18] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Download missing subtitles" Completed after 0 minute(s) and 55 seconds [2024-04-17 18:11:23.310 +02:00] [INF] [18] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 20:25:00.111 +02:00] [ERR] [30] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/Users/3ad0fd6b56f84a06967e211d2d329be8/Items/d732a93b2daa9e0da8f437b99daf666c". Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked For more information on this error code see https://www.sqlite.org/rescode.html'. at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db) at Microsoft.Data.Sqlite.SqliteConnection.Open() at System.Data.Common.DbConnection.OpenAsync(CancellationToken cancellationToken) --- End of stack trace from previous location --- at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenAsync(CancellationToken cancellationToken, Boolean errorsExpected) at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.InitializeReaderAsync(AsyncEnumerator enumerator, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.MoveNextAsync() at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfo(HttpRequest requestContext) at Emby.Server.Implementations.HttpServer.Security.AuthService.Authenticate(HttpRequest request) at Jellyfin.Api.Auth.CustomAuthenticationHandler.HandleAuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationHandler`1.AuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationService.AuthenticateAsync(HttpContext context, String scheme) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-04-17 20:25:05.449 +02:00] [ERR] [111] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/Users/3ad0fd6b56f84a06967e211d2d329be8/Items/30621cb29423629df126e128e792656a". Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'not an error'. at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db) at Microsoft.Data.Sqlite.SqliteConnection.Open() at System.Data.Common.DbConnection.OpenAsync(CancellationToken cancellationToken) --- End of stack trace from previous location --- at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenAsync(CancellationToken cancellationToken, Boolean errorsExpected) at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.InitializeReaderAsync(AsyncEnumerator enumerator, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.MoveNextAsync() at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfo(HttpRequest requestContext) at Emby.Server.Implementations.HttpServer.Security.AuthService.Authenticate(HttpRequest request) at Jellyfin.Api.Auth.CustomAuthenticationHandler.HandleAuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationHandler`1.AuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationService.AuthenticateAsync(HttpContext context, String scheme) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-04-17 20:30:00.038 +02:00] [ERR] [62] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL "GET" "/Users/3ad0fd6b56f84a06967e211d2d329be8/Items/Latest". System.ObjectDisposedException: Safe handle has been closed. Object name: 'SafeHandle'. at System.StubHelpers.StubHelpers.SafeHandleAddRef(SafeHandle pHandle, Boolean& success) at SQLitePCL.SQLite3Provider_e_sqlite3.NativeMethods.sqlite3_create_function_v2(sqlite3 db, Byte[] strName, Int32 nArgs, Int32 nType, hook_handle pvUser, IntPtr func, IntPtr fstep, IntPtr ffinal, IntPtr fdestroy) at SQLitePCL.SQLite3Provider_e_sqlite3.SQLitePCL.ISQLite3Provider.sqlite3_create_function(sqlite3 db, Byte[] name, Int32 nargs, Int32 flags, Object v, delegate_function_scalar func) at Microsoft.Data.Sqlite.SqliteConnection.Open() at System.Data.Common.DbConnection.OpenAsync(CancellationToken cancellationToken) --- End of stack trace from previous location --- at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenAsync(CancellationToken cancellationToken, Boolean errorsExpected) at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.InitializeReaderAsync(AsyncEnumerator enumerator, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.MoveNextAsync() at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Microsoft.EntityFrameworkCore.Query.ShapedQueryCompilingExpressionVisitor.SingleOrDefaultAsync[TSource](IAsyncEnumerable`1 asyncEnumerable, CancellationToken cancellationToken) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfoFromDictionary(IReadOnlyDictionary`2 auth, IHeaderDictionary headers, IQueryCollection queryString) at Jellyfin.Server.Implementations.Security.AuthorizationContext.GetAuthorizationInfo(HttpRequest requestContext) at Emby.Server.Implementations.HttpServer.Security.AuthService.Authenticate(HttpRequest request) at Jellyfin.Api.Auth.CustomAuthenticationHandler.HandleAuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationHandler`1.AuthenticateAsync() at Microsoft.AspNetCore.Authentication.AuthenticationService.AuthenticateAsync(HttpContext context, String scheme) at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context) at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext) at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext) at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.InvokeCore(HttpContext context) at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context, IServerConfigurationManager serverConfigurationManager) at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context) [2024-04-17 21:15:25.774 +02:00] [INF] [64] Emby.Server.Implementations.IO.LibraryMonitor: "Season 1" ("/data/media/tv/The Tudors/Season 01") will be refreshed. [2024-04-17 21:15:27.431 +02:00] [INF] [89] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Episode", Name: "Simply Henry", Path: "", Id: 85c169d3-299b-04fa-c9cf-5306168658ae [2024-04-17 21:15:27.549 +02:00] [INF] [58] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Episode", Name: "In Cold Blood", Path: "", Id: 36b6411e-0e2a-f89b-61ff-a9f8205bdd1d [2024-04-17 21:28:25.812 +02:00] [INF] [35] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.253.0.4" request [2024-04-17 21:28:30.521 +02:00] [INF] [58] Emby.Server.Implementations.ScheduledTasks.TaskManager: Executing "Scan Media Library" [2024-04-17 21:28:30.523 +02:00] [INF] [58] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/media/videos" [2024-04-17 21:28:30.523 +02:00] [INF] [58] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/media/tv" [2024-04-17 21:28:30.523 +02:00] [INF] [58] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/music" [2024-04-17 21:28:30.523 +02:00] [INF] [58] Emby.Server.Implementations.IO.LibraryMonitor: Stopping directory watching for path "/data/media/movies" [2024-04-17 21:28:30.523 +02:00] [INF] [58] Emby.Server.Implementations.Library.LibraryManager: Validating media library [2024-04-17 21:28:32.568 +02:00] [INF] [118] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Episode", Name: "Arise, My Lord", Path: "", Id: 47a028c9-07c3-fd72-9207-98658297639c [2024-04-17 21:28:33.647 +02:00] [INF] [67] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Episode", Name: "His Majesty, The King", Path: "", Id: 7e770003-8be1-3512-c42d-000cef2acecd [2024-04-17 21:28:43.674 +02:00] [INF] [30] Emby.Server.Implementations.ScheduledTasks.TaskManager: "Scan Media Library" Completed after 0 minute(s) and 13 seconds [2024-04-17 21:28:43.675 +02:00] [INF] [67] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/media/videos" [2024-04-17 21:28:43.676 +02:00] [INF] [34] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/music" [2024-04-17 21:28:43.676 +02:00] [INF] [30] Emby.Server.Implementations.ScheduledTasks.TaskManager: ExecuteQueuedTasks [2024-04-17 21:28:43.713 +02:00] [INF] [58] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/media/tv" [2024-04-17 21:28:43.713 +02:00] [INF] [18] Emby.Server.Implementations.IO.LibraryMonitor: Watching directory "/data/media/movies" [2024-04-17 21:29:03.025 +02:00] [INF] [30] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "10.253.0.4" closed [2024-04-17 21:31:43.907 +02:00] [INF] [33] Emby.Server.Implementations.IO.LibraryMonitor: "movies" ("/data/media/movies") will be refreshed. [2024-04-17 21:31:43.999 +02:00] [INF] [33] Emby.Server.Implementations.Library.LibraryManager: Removing item, Type: "Movie", Name: "Avatar", Path: "/data/media/movies/Avatar (2009)/Avatar (2009) - [Unknown][HDR10][TrueHD Atmos 7.1][h265]-MassModz.m2ts", Id: b5a940e7-968a-b071-a162-b82acf2cb167 [2024-04-17 21:39:17.988 +02:00] [INF] [111] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.102.151" request [2024-04-17 21:39:52.349 +02:00] [INF] [69] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 21:39:52.406 +02:00] [INF] [69] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 21:39:52.899 +02:00] [INF] [69] MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-dump_attachment:t \"\" -y -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -t 0 -f null null" [2024-04-17 21:39:53.041 +02:00] [INF] [87] MediaBrowser.MediaEncoding.Attachments.AttachmentExtractor: ffmpeg attachment extraction completed for "/cache/attachments/ff970ba6b426982b46e9c607f1faefcd" to "/cache/attachments/ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:39:53.047 +02:00] [INF] [87] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/84f9c6a55a9648579ef888ba5bb576b3.mkv\"" [2024-04-17 21:39:53.411 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd [2024-04-17 21:39:53.414 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 04/17/2024 21:39:53 [2024-04-17 21:39:53.414 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-04-17 21:39:53.418 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-04-17 21:39:53.512 +02:00] [INF] [96] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:39:54.200 +02:00] [WRN] [48] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&PlaySessionId=f3b7707b914046fe8f541186e9e94598&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.110.168" in 0:00:01.3548944 with Status Code 200 [2024-04-17 21:40:13.420 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "162.158.110.188" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 1 [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "Transcode (v:h264 a:direct)" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Chromecast" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Chromecast" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "The Tudors - s01e04 - His Majesty, The King" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:13.425 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-04-17 21:40:13.426 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-04-17 21:40:13.426 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:13.426 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 21:40:13.452 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-04-17 21:40:14.100 +02:00] [INF] [96] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:34.965 +02:00] [INF] [117] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:40:55.404 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:41:15.935 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:41:36.453 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:41:45.567 +02:00] [WRN] [43] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.102.151" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 21:41:45.580 +02:00] [INF] [43] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.102.151" closed [2024-04-17 21:41:56.867 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:42:17.704 +02:00] [INF] [52] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:42:38.197 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:42:58.703 +02:00] [INF] [127] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:43:19.438 +02:00] [INF] [94] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:43:40.203 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:44:00.989 +02:00] [INF] [91] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:44:21.585 +02:00] [INF] [76] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:44:41.867 +02:00] [INF] [80] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:45:02.201 +02:00] [INF] [114] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:45:13.097 +02:00] [INF] [8] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 21:45:22.589 +02:00] [INF] [94] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:45:43.170 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:46:03.968 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:46:24.745 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:46:45.117 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:47:05.634 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:47:26.417 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:47:47.138 +02:00] [INF] [93] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:48:07.978 +02:00] [INF] [55] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:48:28.378 +02:00] [INF] [52] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:48:49.230 +02:00] [INF] [55] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:49:09.535 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:49:10.275 +02:00] [INF] [55] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.102.43" request [2024-04-17 21:49:16.248 +02:00] [INF] [41] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 21:49:16.249 +02:00] [INF] [41] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 21:49:16.567 +02:00] [INF] [24] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:08:55.645 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv\"" [2024-04-17 21:49:17.896 +02:00] [WRN] [24] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=5356455999&PlaySessionId=a2e8a8f4d6e843cfbc2809d46db67f8e&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.111.89" in 0:00:01.3369016 with Status Code 200 [2024-04-17 21:49:30.411 +02:00] [INF] [47] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:49:50.941 +02:00] [INF] [41] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:49:58.294 +02:00] [INF] [55] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 21:50:10.294 +02:00] [INF] [40] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 21:50:11.572 +02:00] [INF] [47] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:50:32.010 +02:00] [INF] [40] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:50:52.456 +02:00] [INF] [24] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:51:12.988 +02:00] [INF] [74] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:51:33.499 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:51:40.957 +02:00] [WRN] [24] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.102.43" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 21:51:40.971 +02:00] [INF] [24] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.102.43" closed [2024-04-17 21:51:54.334 +02:00] [INF] [40] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:52:09.328 +02:00] [INF] [115] Jellyfin.Api.Helpers.TranscodingJobHelper: Transcoding kill timer stopped for JobId "9c75721ee5204f47bb5c905b812ca5f3" PlaySessionId "a2e8a8f4d6e843cfbc2809d46db67f8e". Killing transcoding [2024-04-17 21:52:09.334 +02:00] [INF] [115] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv" [2024-04-17 21:52:09.403 +02:00] [INF] [47] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 21:52:09.407 +02:00] [INF] [115] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv" [2024-04-17 21:52:15.124 +02:00] [INF] [24] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:52:35.759 +02:00] [INF] [40] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:52:56.300 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:53:16.781 +02:00] [INF] [62] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:53:37.777 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:53:58.254 +02:00] [INF] [14] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:54:18.853 +02:00] [INF] [40] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:54:39.242 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:54:59.807 +02:00] [INF] [14] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:55:20.348 +02:00] [INF] [88] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:55:30.886 +02:00] [WRN] [27] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/Sessions/Playing/Progress" to "162.158.110.189" in 0:00:00.9609753 with Status Code 204 [2024-04-17 21:55:41.151 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:56:01.841 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:56:22.560 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:56:43.074 +02:00] [INF] [52] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:57:03.814 +02:00] [INF] [88] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:57:24.303 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:57:44.723 +02:00] [INF] [88] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:58:05.532 +02:00] [INF] [123] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:58:22.605 +02:00] [INF] [123] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:08:55.645 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv\"" [2024-04-17 21:58:23.841 +02:00] [WRN] [62] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=5356455999&PlaySessionId=a2e8a8f4d6e843cfbc2809d46db67f8e&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.111.90" in 0:00:01.2421278 with Status Code 200 [2024-04-17 21:58:26.017 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:58:46.660 +02:00] [INF] [60] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:58:50.446 +02:00] [INF] [101] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.183.180" request [2024-04-17 21:58:52.758 +02:00] [INF] [11] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 21:58:52.759 +02:00] [INF] [11] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 21:58:53.268 +02:00] [INF] [123] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:18:08.304 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv\"" [2024-04-17 21:58:54.397 +02:00] [WRN] [101] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=10883040000&PlaySessionId=fd19f00bcd3f40daa6eeab5e8e172946&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.110.50" in 0:00:01.1374605 with Status Code 200 [2024-04-17 21:59:07.658 +02:00] [INF] [45] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:59:28.407 +02:00] [INF] [123] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:59:38.370 +02:00] [INF] [62] Jellyfin.Api.Helpers.TranscodingJobHelper: Transcoding kill timer stopped for JobId "51ac0669cdca428b826cb49e1870b62b" PlaySessionId "a2e8a8f4d6e843cfbc2809d46db67f8e". Killing transcoding [2024-04-17 21:59:38.370 +02:00] [INF] [62] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv" [2024-04-17 21:59:38.469 +02:00] [INF] [101] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 21:59:38.520 +02:00] [INF] [45] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 21:59:38.521 +02:00] [INF] [62] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/transcodes/0ca1e7589910c159ef938291e07eeff6.mkv" [2024-04-17 21:59:48.800 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 21:59:50.469 +02:00] [INF] [60] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:00:09.602 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:00:23.459 +02:00] [WRN] [11] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.183.180" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:00:23.472 +02:00] [INF] [11] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.183.180" closed [2024-04-17 22:00:29.903 +02:00] [INF] [60] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:00:50.872 +02:00] [INF] [33] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:01:11.360 +02:00] [INF] [111] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:01:31.702 +02:00] [INF] [29] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:01:52.247 +02:00] [INF] [111] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:02:12.519 +02:00] [INF] [88] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:02:25.089 +02:00] [INF] [85] Jellyfin.Api.Helpers.TranscodingJobHelper: Transcoding kill timer stopped for JobId "0e447100d89b479daee2e69786d29e58" PlaySessionId "fd19f00bcd3f40daa6eeab5e8e172946". Killing transcoding [2024-04-17 22:02:25.089 +02:00] [INF] [85] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv" [2024-04-17 22:02:25.162 +02:00] [INF] [85] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:02:25.163 +02:00] [INF] [85] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv" [2024-04-17 22:02:33.145 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:02:53.879 +02:00] [INF] [88] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:03:14.670 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:03:35.188 +02:00] [INF] [47] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:03:55.916 +02:00] [INF] [74] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:04:16.657 +02:00] [INF] [33] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:04:37.146 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:04:57.322 +02:00] [INF] [93] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:05:17.857 +02:00] [INF] [73] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:05:38.416 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:05:59.172 +02:00] [INF] [33] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:06:19.339 +02:00] [INF] [29] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:06:40.119 +02:00] [INF] [29] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:07:00.580 +02:00] [INF] [85] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:07:21.095 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:07:39.940 +02:00] [INF] [111] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:18:08.304 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv\"" [2024-04-17 22:07:41.167 +02:00] [WRN] [114] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=10883040000&PlaySessionId=fd19f00bcd3f40daa6eeab5e8e172946&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.110.50" in 0:00:01.2349369 with Status Code 200 [2024-04-17 22:07:41.713 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:08:02.449 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:08:09.338 +02:00] [INF] [85] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.80" request [2024-04-17 22:08:12.790 +02:00] [INF] [3] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 22:08:12.790 +02:00] [INF] [3] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 22:08:13.378 +02:00] [INF] [85] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:27:02.058 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/94b7fa40d54890d02778c5115669c726.mkv\"" [2024-04-17 22:08:14.507 +02:00] [WRN] [55] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=16220583440&PlaySessionId=9cf6eed47de647d7833d49989a070a93&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.110.30" in 0:00:01.1367876 with Status Code 200 [2024-04-17 22:08:22.835 +02:00] [INF] [29] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:08:43.426 +02:00] [INF] [41] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:08:51.903 +02:00] [INF] [3] Jellyfin.Api.Helpers.TranscodingJobHelper: Transcoding kill timer stopped for JobId "55eb1e11594f446bac7a83b289d70844" PlaySessionId "fd19f00bcd3f40daa6eeab5e8e172946". Killing transcoding [2024-04-17 22:08:51.903 +02:00] [INF] [3] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv" [2024-04-17 22:08:52.050 +02:00] [INF] [3] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:08:52.050 +02:00] [INF] [3] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/transcodes/dacca7d11227f7bc27456fcbc588384e.mkv" [2024-04-17 22:08:57.364 +02:00] [INF] [41] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:09:04.086 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:09:09.364 +02:00] [INF] [114] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:09:24.612 +02:00] [INF] [24] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:09:45.423 +02:00] [INF] [29] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:10:03.660 +02:00] [WRN] [80] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.46.80" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:10:03.663 +02:00] [INF] [80] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.80" closed [2024-04-17 22:10:05.687 +02:00] [INF] [76] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:10:26.165 +02:00] [INF] [33] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:10:46.691 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:11:07.170 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:11:12.373 +02:00] [INF] [11] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:11:27.853 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:11:48.752 +02:00] [INF] [111] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:12:09.434 +02:00] [INF] [60] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:12:29.927 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:12:50.558 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:13:10.948 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:13:31.424 +02:00] [INF] [111] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:13:51.570 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:14:11.596 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:14:32.193 +02:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:14:52.698 +02:00] [INF] [43] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:15:13.440 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:15:33.923 +02:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:15:53.936 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:16:14.122 +02:00] [INF] [81] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:16:34.313 +02:00] [INF] [51] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:16:55.174 +02:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:17:15.584 +02:00] [INF] [78] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:17:31.420 +02:00] [INF] [25] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "141.101.76.185" request [2024-04-17 22:17:34.282 +02:00] [INF] [92] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 22:17:34.282 +02:00] [INF] [92] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 22:17:34.746 +02:00] [INF] [25] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:35:59.976 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/e805eb44b9385c56d5b95b530c272084.mkv\"" [2024-04-17 22:17:35.979 +02:00] [WRN] [25] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=21599766000&PlaySessionId=83905331fd3a4ea3a7a5231f2054b04d&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.111.172" in 0:00:01.2401138 with Status Code 200 [2024-04-17 22:17:36.208 +02:00] [INF] [43] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:17:56.323 +02:00] [INF] [56] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:18:17.251 +02:00] [INF] [66] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:18:19.449 +02:00] [INF] [25] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:18:31.449 +02:00] [INF] [25] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:18:37.933 +02:00] [INF] [125] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:18:48.870 +02:00] [WRN] [66] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "141.101.76.185" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:18:48.884 +02:00] [INF] [66] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "141.101.76.185" closed [2024-04-17 22:18:58.394 +02:00] [INF] [56] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:19:19.134 +02:00] [INF] [78] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:19:26.433 +02:00] [INF] [75] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:19:39.689 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:20:00.670 +02:00] [INF] [54] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:20:21.315 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:20:42.228 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:21:02.941 +02:00] [INF] [57] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:21:23.667 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:21:44.110 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:22:05.061 +02:00] [INF] [96] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:22:25.361 +02:00] [INF] [106] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:22:45.388 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:23:06.210 +02:00] [INF] [54] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:23:26.946 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:23:47.105 +02:00] [INF] [60] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:24:08.055 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:24:28.715 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:24:49.257 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:25:09.955 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:25:30.422 +02:00] [INF] [57] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:25:50.863 +02:00] [INF] [117] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:26:11.506 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:26:32.228 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:26:52.973 +02:00] [INF] [51] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:26:55.078 +02:00] [INF] [51] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.243.43" request [2024-04-17 22:26:56.229 +02:00] [INF] [108] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 22:26:56.229 +02:00] [INF] [108] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 22:26:56.809 +02:00] [INF] [34] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:44:58.032 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/aaf7eff918b03ab105375187d1e704f6.mkv\"" [2024-04-17 22:26:58.025 +02:00] [WRN] [99] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=26980328280&PlaySessionId=151190b115db4fd4b0577865eadee82e&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.110.168" in 0:00:01.2243155 with Status Code 200 [2024-04-17 22:27:13.849 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:27:34.278 +02:00] [INF] [84] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:27:43.102 +02:00] [INF] [78] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:27:54.318 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:27:55.103 +02:00] [INF] [87] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:27:57.515 +02:00] [INF] [57] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:28:09.828 +02:00] [WRN] [87] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.243.43" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:28:09.836 +02:00] [INF] [87] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.243.43" closed [2024-04-17 22:28:15.124 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:28:35.127 +02:00] [INF] [34] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:28:55.897 +02:00] [INF] [63] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:29:16.053 +02:00] [INF] [89] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:29:36.678 +02:00] [INF] [34] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:29:57.072 +02:00] [INF] [89] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:30:17.140 +02:00] [INF] [125] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:30:37.875 +02:00] [INF] [125] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:30:57.942 +02:00] [INF] [117] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:31:18.322 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:31:21.454 +02:00] [INF] [87] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.87" request [2024-04-17 22:32:09.472 +02:00] [INF] [113] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:32:21.472 +02:00] [INF] [113] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:32:35.930 +02:00] [WRN] [113] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.98.87" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:32:36.163 +02:00] [INF] [113] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.87" closed [2024-04-17 22:32:50.746 +02:00] [INF] [84] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.68.192.130" request [2024-04-17 22:33:09.652 +02:00] [WRN] [78] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.68.192.130" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:33:09.667 +02:00] [INF] [78] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.68.192.130" closed [2024-04-17 22:34:09.217 +02:00] [INF] [82] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.149" request [2024-04-17 22:34:24.962 +02:00] [INF] [97] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:34:45.787 +02:00] [INF] [82] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:34:57.255 +02:00] [INF] [31] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:34:59.271 +02:00] [INF] [53] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 22:34:59.272 +02:00] [INF] [53] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=3 ) => ( PlayMethod=Transcode, TranscodeReason=SubtitleCodecNotSupported ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&api_key=&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" [2024-04-17 22:34:59.774 +02:00] [INF] [65] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -ss 00:49:36.688 -init_hw_device vaapi=va:,kernel_driver=i915,driver=iHD -init_hw_device qsv=qs@va -filter_hw_device qs -hwaccel vaapi -hwaccel_output_format vaapi -autorotate 0 -i file:\"/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv\" -autoscale 0 -map 0:0 -map 0:1 -map -0:0 -codec:v:0 h264_qsv -force_key_frames \"expr:gte(t,n_forced*5)\" -filter_complex \"[0:3]scale=flags=fast_bilinear,format=bgra,hwupload=derive_device=qsv:extra_hw_frames=64[sub];[0:0]setparams=color_primaries=bt709:color_trc=bt709:colorspace=bt709,scale_vaapi=format=nv12:extra_hw_frames=24,hwmap=derive_device=qsv,format=qsv[main];[main][sub]overlay_qsv=eof_action=endall:shortest=1:repeatlast=0:w=1916:h=1080\" -copyts -avoid_negative_ts disabled -start_at_zero -preset 7 -look_ahead 0 -b:v 7456714 -maxrate 7456714 -bufsize 14913428 -profile:v:0 high -level 41 -map_metadata -1 -map_chapters -1 -threads 0 -codec:a:0 copy -y \"/config/transcodes/e8beab9d6fee9f51e7dc9439470e92ad.mkv\"" [2024-04-17 22:35:00.910 +02:00] [WRN] [51] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?DeviceId=chromecast_1713382779005&MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&VideoCodec=h264,vp8,h264&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=3&VideoBitrate=10552000&AudioBitrate=448000&AudioSampleRate=48000&MaxFramerate=23.976025&StartTimeTicks=29766880000&PlaySessionId=edf1b1a15e024eeab12fcee64768a4e1&api_key=98c734074af14e6da1407bed1d719ae3&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&CopyTimestamps=true&RequireAvc=false&Tag=504934c273d63b68da7a8e120daa3093&h264-level=41&h264-videobitdepth=8&h264-profile=high&h264-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported" to "162.158.111.155" in 0:00:01.141586 with Status Code 200 [2024-04-17 22:35:06.404 +02:00] [INF] [51] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:35:09.255 +02:00] [INF] [51] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:35:26.734 +02:00] [INF] [51] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:35:35.481 +02:00] [INF] [116] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 0 [2024-04-17 22:35:46.954 +02:00] [INF] [53] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:36:07.757 +02:00] [INF] [102] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:36:28.154 +02:00] [INF] [70] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:36:48.918 +02:00] [INF] [53] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:37:09.818 +02:00] [INF] [67] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:37:30.197 +02:00] [INF] [67] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:37:39.222 +02:00] [WRN] [66] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.46.149" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:37:39.237 +02:00] [INF] [66] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.149" closed [2024-04-17 22:37:50.439 +02:00] [INF] [67] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:38:11.229 +02:00] [INF] [102] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:38:31.991 +02:00] [INF] [109] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:38:52.779 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:39:13.501 +02:00] [INF] [49] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:39:34.080 +02:00] [INF] [67] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:39:54.644 +02:00] [INF] [35] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:40:15.085 +02:00] [INF] [30] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:40:35.279 +02:00] [INF] [120] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:40:49.269 +02:00] [INF] [35] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.137" request [2024-04-17 22:40:53.951 +02:00] [INF] [35] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/transcodes/84f9c6a55a9648579ef888ba5bb576b3.mkv" [2024-04-17 22:40:55.773 +02:00] [INF] [120] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Chromecast" "2.1.0" playing "His Majesty, The King". Stopped at "3328084" ms [2024-04-17 22:40:55.828 +02:00] [WRN] [120] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/Sessions/Playing/Stopped" to "162.158.110.188" in 0:00:01.8885671 with Status Code 204 [2024-04-17 22:40:55.829 +02:00] [INF] [102] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop tracker found, processing stop : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 22:40:55.830 +02:00] [INF] [102] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Stop Event : 04/17/2024 22:40:55 [2024-04-17 22:40:55.830 +02:00] [INF] [102] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 22:41:22.888 +02:00] [INF] [11] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 22:41:22.889 +02:00] [INF] [11] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E05 - Arise, My Lord.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/e3621d23-cb2e-f21f-9bc1-f7e5fbf8ca74/stream.mkv?MediaSourceId=e3621d23cb2ef21f9bc1f7e5fbf8ca74&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=&SubtitleMethod=Encode&Tag=1fcfcccc56d21ada53997761c502af37" [2024-04-17 22:41:24.211 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74 [2024-04-17 22:41:24.211 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 04/17/2024 22:41:24 [2024-04-17 22:41:24.211 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-04-17 22:41:24.211 +02:00] [INF] [63] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-04-17 22:41:24.907 +02:00] [INF] [89] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:37.288 +02:00] [INF] [101] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "162.158.110.188" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 1 [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectStream" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Chromecast" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Chromecast" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "The Tudors - s01e05 - Arise, My Lord" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:44.212 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 22:41:44.231 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-04-17 22:41:45.570 +02:00] [INF] [58] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:41:49.290 +02:00] [INF] [58] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:42:06.010 +02:00] [INF] [108] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:42:26.501 +02:00] [INF] [96] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:42:38.373 +02:00] [WRN] [89] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.98.137" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:42:38.382 +02:00] [INF] [89] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.137" closed [2024-04-17 22:42:43.548 +02:00] [INF] [34] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.65" request [2024-04-17 22:42:47.190 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:43:08.068 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:43:28.787 +02:00] [INF] [54] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:43:49.276 +02:00] [INF] [107] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:44:09.998 +02:00] [INF] [57] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:44:30.494 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:44:50.963 +02:00] [INF] [57] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:44:57.699 +02:00] [WRN] [92] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.98.65" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:44:57.706 +02:00] [INF] [92] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.98.65" closed [2024-04-17 22:45:11.545 +02:00] [INF] [77] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:45:31.969 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:45:52.732 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:46:13.026 +02:00] [INF] [76] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:46:33.660 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:46:54.060 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:47:14.566 +02:00] [INF] [63] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:47:35.371 +02:00] [INF] [8] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:47:56.200 +02:00] [INF] [76] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:48:16.908 +02:00] [INF] [55] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:48:36.979 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:48:57.282 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:49:17.644 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:49:38.271 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:49:58.797 +02:00] [INF] [14] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:50:19.313 +02:00] [INF] [24] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:50:39.803 +02:00] [INF] [80] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:51:00.280 +02:00] [INF] [99] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:51:21.159 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:51:41.533 +02:00] [INF] [48] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:52:02.058 +02:00] [INF] [48] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:52:23.050 +02:00] [INF] [14] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:52:43.289 +02:00] [INF] [76] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:53:03.303 +02:00] [INF] [94] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:53:24.004 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:53:44.848 +02:00] [INF] [3] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:54:05.532 +02:00] [INF] [56] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:54:26.232 +02:00] [INF] [48] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:54:46.829 +02:00] [INF] [11] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:55:07.238 +02:00] [INF] [87] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:55:27.715 +02:00] [INF] [119] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:55:48.188 +02:00] [INF] [25] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:56:08.673 +02:00] [INF] [115] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:56:19.391 +02:00] [INF] [75] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.68.192.202" request [2024-04-17 22:56:28.951 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:56:49.550 +02:00] [INF] [92] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:57:07.412 +02:00] [INF] [92] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 22:57:10.475 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:57:19.413 +02:00] [INF] [74] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 22:57:31.033 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:57:34.274 +02:00] [WRN] [57] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.68.192.202" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 22:57:34.288 +02:00] [INF] [57] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.68.192.202" closed [2024-04-17 22:57:51.340 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:58:11.876 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:58:32.476 +02:00] [INF] [47] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:58:53.223 +02:00] [INF] [74] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:59:13.486 +02:00] [INF] [115] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:59:34.250 +02:00] [INF] [95] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 22:59:54.301 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:00:14.732 +02:00] [INF] [52] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:00:35.535 +02:00] [INF] [62] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:00:55.780 +02:00] [INF] [119] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:01:16.359 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:01:37.033 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:01:42.603 +02:00] [INF] [37] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.182.199" request [2024-04-17 23:02:30.625 +02:00] [INF] [117] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 23:02:36.999 +02:00] [INF] [111] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Chromecast" "2.1.0" playing "Arise, My Lord". Stopped at "1228037" ms [2024-04-17 23:02:37.063 +02:00] [INF] [119] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop tracker found, processing stop : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-e3621d23cb2ef21f9bc1f7e5fbf8ca74" [2024-04-17 23:02:37.063 +02:00] [INF] [119] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Stop Event : 04/17/2024 23:02:37 [2024-04-17 23:02:37.063 +02:00] [INF] [119] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 23:02:42.626 +02:00] [INF] [37] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2024-04-17 23:02:56.431 +02:00] [INF] [43] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "root". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-04-17 23:02:56.432 +02:00] [INF] [43] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/data/media/tv/The Tudors/Season 01/The Tudors - S01E04 - His Majesty, The King.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/ff970ba6-b426-982b-46e9-c607f1faefcd/stream.mkv?MediaSourceId=ff970ba6b426982b46e9c607f1faefcd&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=&SubtitleMethod=Encode&Tag=504934c273d63b68da7a8e120daa3093" [2024-04-17 23:02:57.990 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Adding playback tracker : chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd [2024-04-17 23:02:57.990 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Start Event : 04/17/2024 23:02:57 [2024-04-17 23:02:57.991 +02:00] [INF] [69] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Creating StartPlaybackTimer Task [2024-04-17 23:02:57.991 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Entered [2024-04-17 23:02:58.279 +02:00] [INF] [26] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:10.015 +02:00] [WRN] [94] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://jellyfin.mydomain.com/Items/ff970ba6b426982b46e9c607f1faefcd/RemoteSearch/Subtitles/dut" to "172.69.151.162" in 0:00:00.5243248 with Status Code 200 [2024-04-17 23:03:17.991 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: session.RemoteEndPoint : "162.158.110.188" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_playing_id = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : event_user_id_int = 1 [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_playing_id = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : session_user_id = "3ad0fd6b56f84a06967e211d2d329be8" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : play_method = "DirectStream" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.ClientName = "Chromecast" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : e.DeviceName = "Chromecast" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemName = "The Tudors - s01e04 - His Majesty, The King" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemId = "ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : ItemType = "Episode" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : All matches, playback registered [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback tracker found, adding playback info : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:17.992 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 23:03:18.012 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: StartPlaybackTimer : Exited [2024-04-17 23:03:18.365 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Processing playback tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:22.224 +02:00] [INF] [37] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Chromecast" "2.1.0" playing "His Majesty, The King". Stopped at "23707" ms [2024-04-17 23:03:22.274 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop tracker found, processing stop : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:22.274 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Stop Event : 04/17/2024 23:03:22 [2024-04-17 23:03:22.274 +02:00] [INF] [75] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB [2024-04-17 23:03:28.532 +02:00] [INF] [59] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Chromecast" "2.1.0" playing "His Majesty, The King". Stopped at "0" ms [2024-04-17 23:03:28.578 +02:00] [INF] [101] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop did not have a tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:03:29.520 +02:00] [INF] [48] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Chromecast" "2.1.0" playing "His Majesty, The King". Stopped at "0" ms [2024-04-17 23:03:29.569 +02:00] [INF] [37] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop did not have a tracker : "chromecast_1713382779005-3ad0fd6b56f84a06967e211d2d329be8-ff970ba6b426982b46e9c607f1faefcd" [2024-04-17 23:05:12.619 +02:00] [WRN] [87] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.182.199" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:05:12.636 +02:00] [INF] [87] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.182.199" closed [2024-04-17 23:06:36.874 +02:00] [INF] [18] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.242.15" request [2024-04-17 23:07:24.892 +02:00] [INF] [39] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2024-04-17 23:07:29.029 +02:00] [WRN] [42] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.242.15" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:07:29.043 +02:00] [INF] [42] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.242.15" closed [2024-04-17 23:11:57.949 +02:00] [INF] [83] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.81" request [2024-04-17 23:12:12.007 +02:00] [WRN] [17] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.46.81" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:12:12.014 +02:00] [INF] [17] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.46.81" closed [2024-04-17 23:22:02.796 +02:00] [INF] [11] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.94.87" request [2024-04-17 23:22:17.416 +02:00] [WRN] [95] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.94.87" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:22:17.429 +02:00] [INF] [95] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.94.87" closed [2024-04-17 23:22:18.716 +02:00] [INF] [93] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "162.158.110.69" request [2024-04-17 23:23:00.014 +02:00] [WRN] [95] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "162.158.110.69" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:23:00.022 +02:00] [INF] [95] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "162.158.110.69" closed [2024-04-17 23:23:01.709 +02:00] [INF] [115] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.47.11" request [2024-04-17 23:23:23.309 +02:00] [WRN] [73] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.70.47.11" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:23:23.324 +02:00] [INF] [73] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.70.47.11" closed [2024-04-17 23:27:44.804 +02:00] [INF] [100] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.99.172" request [2024-04-17 23:27:53.516 +02:00] [WRN] [115] Emby.Server.Implementations.HttpServer.WebSocketConnection: WS "172.71.99.172" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-04-17 23:27:53.531 +02:00] [INF] [115] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "172.71.99.172" closed [2024-04-17 23:57:16.288 +02:00] [INF] [75] Emby.Server.Implementations.IO.LibraryMonitor: "movies" ("/data/media/movies") will be refreshed.