[bug] "Too many open files" message appears when using the PlaybackReporting plugin API

[macarrie]

Describe the bug

I started using a Nagios/Shinken monitoring plugin of my own to get stats from Jellyfin to display in grafana dashboards.
It works great until Jellyfin starts throwing a "Too many open files" error, which causes the Web UI to be unavailable.

After a bit of investigating, it seems that the Playback reporting does not close some connections to its local db.

The Shinken plugin is executed every minute and performs http requests to the playback reporting plugin API.
The problem also appears when doing simple curl using a shell.

Please let me know if this is not the correct place to open this issue, and if you want me to open an issue on the playback_reporting repo instead.

System (please complete the following information):

• OS: CentOS 7.7.1908 (Core) (latest centos 7 release)
• Virtualization: KVM virtual machine hosted on Proxmox VE 6.1.-8
• Clients: Android, Chrome
• Browser: Chrome
• Jellyfin Version: 10.5.2
• Networking: HAProxy
• Storage: HDD SATA 3,0 TB Enterprise

To Reproduce

The simplest way to reproduce this error is by doing curls manually to the playback reporting plugin API. For example:
watch curl -v "http://jellyfin_addr:8096/emby/user_usage_stats/UserId/BreakDownReport?days=1&filter=Movie,Episode"
In parallel, you can see the open files list growing when doing the curls:
lsof -p JELLYFINPID | wc -l

The script I use for monitoring that caused the problem initially is available here: https://github.com/macarrie/check_jellyfin/blob/master/libexec/check_jellyfin.py

Expected behavior

Connections to playback reporting db are closed when necessary.

Logs

Journalctl logs at the moment the error appeared.

• Jellyfin logs
  journalctl -u jellyfin

Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [23] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [23] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [24] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [24] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:16 jellyfin jellyfin[19386]: [23:48:16] [INF] [20] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [INF] [18] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [INF] [18] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [INF] [23] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [INF] [23] PlaybackReporting - UserActivityAPI: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [INF] [23] PlaybackReporting - UserActivityAPI: UserActivityAPI Loaded
Apr 05 23:48:17 jellyfin jellyfin[19386]: [23:48:17] [ERR] [23] Emby.Server.Implementations.HttpServer.HttpListenerHost: Error processing request
Apr 05 23:48:17 jellyfin jellyfin[19386]: CannotOpen: SQLitePCL.pretty.SQLiteException: unable to open database file
Apr 05 23:48:17 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.Throw(Int32 rc, Int32 extended, String msg)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.CheckOk(sqlite3 db, Int32 rc)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteDatabaseConnectionBuilder.Build()
Apr 05 23:48:17 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLite3.Open(String filename, ConnectionFlags flags, String vfs)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Jellyfin.Plugin.PlaybackReporting.Data.BaseSqliteRepository.CreateConnection(Boolean isReadOnly)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository.GetBreakdownReport(Int32 days, DateTime endDate, String type)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Jellyfin.Plugin.PlaybackReporting.Api.UserActivityAPI.Get(GetBreakdownReport request)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Services.ServiceExecGeneral.Execute(Type serviceType, IRequest request, Object instance, Object requestDto, String requestName)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Services.ServiceController.Execute(HttpListenerHost httpHost, Object requestDto, IRequest req)
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Services.ServiceHandler.ProcessRequestAsync(HttpListenerHost httpHost, IRequest httpReq, HttpResponse httpRes, ILogger logger, CancellationToken cancellat
Apr 05 23:48:17 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.HttpListenerHost.RequestHandler(IHttpRequest httpReq, String urlString, String host, String localPath, CancellationToken cancellationToken)
Apr 05 23:49:15 jellyfin jellyfin[19386]: [23:49:15] [ERR] [9] Emby.Server.Implementations.HttpServer.HttpListenerHost: Error processing request
Apr 05 23:49:15 jellyfin jellyfin[19386]: CannotOpen: SQLitePCL.pretty.SQLiteException: unable to open database file
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.Throw(Int32 rc, Int32 extended, String msg)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.CheckOk(sqlite3 db, Int32 rc)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.StatementImpl.MoveNext()
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Security.AuthenticationRepository.<>c__DisplayClass4_0.<Update>b__0(IDatabaseConnection db)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.DatabaseConnection.<>c__DisplayClass20_0.<RunInTransaction>b__0(IDatabaseConnection db)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.DatabaseConnection.RunInTransaction[T](IDatabaseConnection This, Func`2 f, TransactionMode mode)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.DatabaseConnection.RunInTransaction(IDatabaseConnection This, Action`1 action, TransactionMode mode)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Security.AuthenticationRepository.Update(AuthenticationInfo info)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.Security.AuthorizationContext.GetAuthorization(IRequest httpReq)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.Security.AuthorizationContext.GetAuthorizationInfo(IRequest requestContext)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.Security.AuthService.ValidateUser(IRequest request, IAuthenticationAttributes authAttribtues)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.Security.AuthService.Authenticate(IRequest request, IAuthenticationAttributes authAttribtues)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.HttpListenerHost.ApplyRequestFilters(IRequest req, HttpResponse res, Object requestDto)
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Services.ServiceHandler.ProcessRequestAsync(HttpListenerHost httpHost, IRequest httpReq, HttpResponse httpRes, ILogger logger, CancellationToken cancellat
Apr 05 23:49:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.HttpServer.HttpListenerHost.RequestHandler(IHttpRequest httpReq, String urlString, String host, String localPath, CancellationToken cancellationToken)
Apr 05 23:50:15 jellyfin jellyfin[19386]: [23:50:15] [ERR] [18] Emby.Server.Implementations.HttpServer.HttpListenerHost: Error processing request
Apr 05 23:50:15 jellyfin jellyfin[19386]: CannotOpen: SQLitePCL.pretty.SQLiteException: unable to open database file
Apr 05 23:50:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.Throw(Int32 rc, Int32 extended, String msg)
Apr 05 23:50:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.SQLiteException.CheckOk(sqlite3 db, Int32 rc)
Apr 05 23:50:15 jellyfin jellyfin[19386]: at SQLitePCL.pretty.StatementImpl.MoveNext()
Apr 05 23:50:15 jellyfin jellyfin[19386]: at Emby.Server.Implementations.Security.AuthenticationRepository.<>c__DisplayClass4_0.<Update>b__0(IDatabaseConnection db)

• Jellyfin file descriptor list:
  lsof -p JELLYFINPID

jellyfin 19386 jellyfin  315r      REG              253,0   312192 51164839 /usr/lib64/jellyfin/System.Runtime.Serialization.Formatters.dll
jellyfin 19386 jellyfin  316r      REG              253,0  2946944 51164737 /usr/lib64/jellyfin/System.Data.Common.dll
jellyfin 19386 jellyfin  317r      REG              253,0   249856 51165414 /usr/lib64/jellyfin/UtfUnknown.dll
jellyfin 19386 jellyfin  318u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  319r      REG              253,0   249856 51165414 /usr/lib64/jellyfin/UtfUnknown.dll
jellyfin 19386 jellyfin  320r      REG              253,0   348536 51164796 /usr/lib64/jellyfin/System.Net.Requests.dll
jellyfin 19386 jellyfin  321u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  322u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  323u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  324u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  325u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  326u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  327u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  328u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  329u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  330u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  331u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  332u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  333u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  334u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  335u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  336u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  337u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  338u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  339u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  340u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  341u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  342u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  343u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  344u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  345u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  346u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  347u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  348u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db
jellyfin 19386 jellyfin  349u      REG              253,0    12288 17567406 /var/lib/jellyfin/data/playback_reporting.db

The playback_reporting open files lines occupy the major part on the fd list, with a total of elements being over 4000 items after the error appears:

# lsof -p 19386 | wc -l
4349

[JustAMan]

Great bug report! Moving it to the plugin's repo.

Also cc-ing @jellyfin/backend just in case.

[oddstr13]

Is this still an issue with current master?

[macarrie]

I will test this and get back to you in a few days.

[macarrie]

Hi,

Sorry it took so long for me to test.
In short, the issue is still present but does not have the same effect anymore.

I tested the same way on a CentOS 7.9 VM, with Jellyfin 10.7.0 RC2.

When the "too many open files" stacktrace happens, Jellyfin automatically restarts.
So the issue is still present but is almost unnoticeable in my case because Jellyfin restarts automatically.

This could be an issue for some people though (with big configuration that makes Jellyfin startup quite long for example).
To make jellyfin crash/restart, I launched a curl every 2s to the playback monitoring plugin and it took a few hours to reach the file descriptor usage problem. Even with monitoring querying the playback reporting plugin every minute, the issue only occurs after a few days, so I think it is unlikely that this problem will bother 99,9% of users in the future.

Thanks.

PS: Here is a log extract of the issue and Jellyfin restart:

Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.SelectEnumerableAsyncIterator`2.MoveNextCore()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncIteratorBase`1.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncIteratorBase`1.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.<ToListAsync>g__Core|620_0[TSource](IAsyncEnumerable`1 source, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.<ToListAsync>g__Core|620_0[TSource](IAsyncEnumerable`1 source, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Implementations.Activity.ActivityManager.GetPagedResultAsync(ActivityLogQuery query)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Implementations.Activity.ActivityManager.GetPagedResultAsync(ActivityLogQuery query)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries(Nullable`1 startIndex, Nullable`1 limit, Nullable`1 minDate, Nullable`1 hasUserId)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at lambda_method1363(Closure , Object )
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.AwaitableObjectResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeActionMethodAsync>g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeNextActionFilterAsync>g__Awaited|10_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Rethrow(ActionExecutedContextSealed context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.InvokeInnerFilterAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.<InvokeNextResourceFilter>g__Awaited|24_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Rethrow(ResourceExecutedContextSealed context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.InvokeFilterPipelineAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.<InvokeAsync>g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Routing.EndpointMiddleware.<Invoke>g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: [21:59:08] [ERR] [103] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request. URL GET /System/ActivityLog/Entries.
Jan 02 21:59:08 jellyfin jellyfin[11135]: Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 14: 'unable to open database file'.
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.Data.Sqlite.SqliteConnection.Open()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Data.Common.DbConnection.OpenAsync(CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenInternalAsync(Boolean errorsExpected, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Storage.RelationalConnection.OpenAsync(CancellationToken cancellationToken, Boolean errorsExpected)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.InitializeReaderAsync(DbContext _, Boolean result, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.EntityFrameworkCore.Query.Internal.SingleQueryingEnumerable`1.AsyncEnumerator.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.SelectEnumerableAsyncIterator`2.MoveNextCore()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncIteratorBase`1.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncIteratorBase`1.MoveNextAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.<ToListAsync>g__Core|620_0[TSource](IAsyncEnumerable`1 source, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at System.Linq.AsyncEnumerable.<ToListAsync>g__Core|620_0[TSource](IAsyncEnumerable`1 source, CancellationToken cancellationToken)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Implementations.Activity.ActivityManager.GetPagedResultAsync(ActivityLogQuery query)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Implementations.Activity.ActivityManager.GetPagedResultAsync(ActivityLogQuery query)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Api.Controllers.ActivityLogController.GetLogEntries(Nullable`1 startIndex, Nullable`1 limit, Nullable`1 minDate, Nullable`1 hasUserId)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at lambda_method1363(Closure , Object )
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ActionMethodExecutor.AwaitableObjectResultExecutor.Execute(IActionResultTypeMapper mapper, ObjectMethodExecutor executor, Object controller, Object[] arguments)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeActionMethodAsync>g__Awaited|12_0(ControllerActionInvoker invoker, ValueTask`1 actionResultValueTask)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.<InvokeNextActionFilterAsync>g__Awaited|10_0(ControllerActionInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Rethrow(ActionExecutedContextSealed context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker.InvokeInnerFilterAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.<InvokeNextResourceFilter>g__Awaited|24_0(ResourceInvoker invoker, Task lastTask, State next, Scope scope, Object state, Boolean isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Rethrow(ResourceExecutedContextSealed context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.Next(State& next, Scope& scope, Object& state, Boolean& isCompleted)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.InvokeFilterPipelineAsync()
Jan 02 21:59:08 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Mvc.Infrastructure.ResourceInvoker.<InvokeAsync>g__Awaited|17_0(ResourceInvoker invoker, Task task, IDisposable scope)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Routing.EndpointMiddleware.<Invoke>g__AwaitRequestTask|6_0(Endpoint endpoint, Task requestTask, ILogger logger)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ServerStartupMessageMiddleware.Invoke(HttpContext httpContext, IServerApplicationHost serverApplicationHost, ILocalizationManager localizationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.WebSocketHandlerMiddleware.Invoke(HttpContext httpContext, IWebSocketManager webSocketManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.IpBasedAccessValidationMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.LanFilteringMiddleware.Invoke(HttpContext httpContext, INetworkManager networkManager, IServerConfigurationManager serverConfigurationManager)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authorization.Policy.AuthorizationMiddlewareResultHandler.HandleAsync(RequestDelegate next, HttpContext context, AuthorizationPolicy policy, PolicyAuthorizationResult authorizeResult)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.ReDoc.ReDocMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.SwaggerUI.SwaggerUIMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Swashbuckle.AspNetCore.Swagger.SwaggerMiddleware.Invoke(HttpContext httpContext, ISwaggerProvider swaggerProvider)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.RobotsRedirectionMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.LegacyEmbyRouteRewriteMiddleware.Invoke(HttpContext httpContext)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Microsoft.AspNetCore.ResponseCompression.ResponseCompressionMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ResponseTimeMiddleware.Invoke(HttpContext context)
Jan 02 21:59:08 jellyfin jellyfin[11135]: at Jellyfin.Server.Middleware.ExceptionMiddleware.Invoke(HttpContext context)
Jan 02 21:59:10 jellyfin jellyfin[11135]: [21:59:10] [ERR] [55] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request: Too many open files. URL GET /Library/VirtualFolders.
Jan 02 21:59:21 jellyfin jellyfin[11135]: [21:59:21] [FTL] [7] Main: Unhandled Exception
Jan 02 21:59:21 jellyfin jellyfin[11135]: System.IO.IOException: Too many open files
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Interop.ThrowExceptionForIoErrno(ErrorInfo errorInfo, String path, Boolean isDirectory, Func`2 errorRewriter)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String path, OpenFlags flags, Int32 mode)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share, Int32 bufferSize, FileOptions options)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.StreamReader.ValidateArgsAndOpenPath(String path, Encoding encoding, Int32 bufferSize)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.File.InternalReadAllLines(String path, Encoding encoding)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.LinuxNetworkInterface.LinuxNetworkInterfaceSystemProperties..ctor()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.LinuxNetworkInterface.GetLinuxNetworkInterfaces()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.InitialiseInterfaces()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.OnNetworkChangeAsync()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.OnNetworkChanged()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
Jan 02 21:59:21 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.OnAddressChanged()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.OnSocketEvent(NetworkChangeKind kind)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.ProcessEvent(Int32 socket, NetworkChangeKind kind)
Jan 02 21:59:21 jellyfin jellyfin[11135]: Unhandled exception. System.IO.IOException: Too many open files
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Interop.ThrowExceptionForIoErrno(ErrorInfo errorInfo, String path, Boolean isDirectory, Func`2 errorRewriter)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String path, OpenFlags flags, Int32 mode)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share, Int32 bufferSize, FileOptions options)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.StreamReader.ValidateArgsAndOpenPath(String path, Encoding encoding, Int32 bufferSize)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.IO.File.InternalReadAllLines(String path, Encoding encoding)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.LinuxNetworkInterface.LinuxNetworkInterfaceSystemProperties..ctor()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.LinuxNetworkInterface.GetLinuxNetworkInterfaces()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.InitialiseInterfaces()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.OnNetworkChangeAsync()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at Jellyfin.Networking.Manager.NetworkManager.OnNetworkChanged()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
Jan 02 21:59:21 jellyfin jellyfin[11135]: --- End of stack trace from previous location ---
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.OnAddressChanged()
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.OnSocketEvent(NetworkChangeKind kind)
Jan 02 21:59:21 jellyfin jellyfin[11135]: at System.Net.NetworkInformation.NetworkChange.ProcessEvent(Int32 socket, NetworkChangeKind kind)

Jan 02 21:59:22 jellyfin systemd[1]: jellyfin.service: main process exited, code=killed, status=6/ABRT
Jan 02 21:59:22 jellyfin systemd[1]: Unit jellyfin.service entered failed state.
Jan 02 21:59:22 jellyfin systemd[1]: jellyfin.service failed.
Jan 02 21:59:22 jellyfin systemd[1]: jellyfin.service holdoff time over, scheduling restart.
Jan 02 21:59:22 jellyfin systemd[1]: Stopped Jellyfin is a free software media system that puts you in control of managing and streaming your media..
Jan 02 21:59:22 jellyfin systemd[1]: Started Jellyfin is a free software media system that puts you in control of managing and streaming your media..

Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Jellyfin version: 10.7.0
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Environment Variables: ["[JELLYFIN_RESTART_OPT, --restartpath=/usr/libexec/jellyfin/restart.sh]", "[JELLYFIN_WEB_OPT, --webdir=/usr/share/jellyfin-web]", "[JELLYFIN_LOG_DIR, /var/log/jellyfin]", "[JELLYFIN_DATA_DIR, /var/lib/jellyfin]", "[JELLYFIN_CACHE_DIR, /var/cache/jellyfin]", "[JELLYFIN_CONFIG_DIR, /etc/jellyfin]"]
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Arguments: ["/usr/lib64/jellyfin/jellyfin.dll", "--webdir=/usr/share/jellyfin-web", "--restartpath=/usr/libexec/jellyfin/restart.sh"]
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Operating system: Linux
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Architecture: X64
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: 64-Bit Process: True
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: User Interactive: True
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Processor count: 4
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Program data path: /var/lib/jellyfin
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Web resources path: /usr/share/jellyfin-web
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Main: Application directory: /usr/lib64/jellyfin/
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN addresses : [127.0.0.1/8,10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions : []
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using LAN addresses: [127.0.0.1/8,10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind addresses: []
Jan 02 21:59:24 jellyfin jellyfin[3514]: [21:59:24] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Using bind exclusions: []
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly Jellyfin.Plugin.Fanart, Version=6.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/Fanart_6.0.0.0/Jellyfin.Plugin.Fanart.dll
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly OpenSubtitlesHandler, Version=0.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/Open Subtitles_10.0.0.0/OpenSubtitlesHandler.dll
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly Jellyfin.Plugin.OpenSubtitles, Version=10.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/Open Subtitles_10.0.0.0/Jellyfin.Plugin.OpenSubtitles.dll
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly Jellyfin.Plugin.PlaybackReporting, Version=9.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/Playback Reporting_9.0.0.0/Jellyfin.Plugin.PlaybackReporting.dll
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly Jellyfin.Plugin.TMDbBoxSets, Version=7.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/TMDb Box Sets_7.0.0.0/Jellyfin.Plugin.TMDbBoxSets.dll
Jan 02 21:59:25 jellyfin jellyfin[3514]: [21:59:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded assembly Trakt, Version=11.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/jellyfin/plugins/Trakt_11.0.0.0/Trakt.dll
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Fanart 6.0.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Open Subtitles 10.0.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Playback Reporting 9.0.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: TMDb Box Sets 7.0.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Trakt 11.0.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: OMDb 10.7.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: MusicBrainz 10.7.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: AudioDB 10.7.0.0
Jan 02 21:59:32 jellyfin jellyfin[3514]: [21:59:32] [INF] [1] Main: Kestrel listening on Any IP4 Address
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Jellyfin.Plugin.PlaybackReporting.TaskCleanDb: TaskCleanDb Loaded
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Jellyfin.Plugin.PlaybackReporting.TaskRunBackup: TaskRunBackup Loaded
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Playback Reporting Trim Db set to fire at 01/03/2021 00:00, which is 2:00:26.4485945 from now.
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Extract Chapter Images set to fire at 01/03/2021 02:00, which is 4:00:26.3947473 from now.
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version 4.3.1
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available decoders: ["h264", "hevc", "mpeg2video", "mpeg4", "msmpeg4", "aac", "ac3", "flac", "mp3"]
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available encoders: ["libx264", "h264_v4l2m2m", "libx265", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "ac3", "flac", "libmp3lame", "libopus", "libvorbis", "srt"]
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: ["vdpau"]
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: Custom: /usr/bin/ffmpeg
Jan 02 21:59:33 jellyfin jellyfin[3514]: [21:59:33] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: c42934c8783a46cc9954e3d019a20354
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Emby.Dlna.Main.DlnaEntryPoint: Registering publisher for urn:schemas-upnp-org:device:MediaServer:1 on 192.168.2.176/24
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Emby.Dlna.Main.DlnaEntryPoint: Registering publisher for urn:schemas-upnp-org:device:MediaServer:1 on 10.84.0.14/24
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all pre-startup entry points in 0:00:00.8602003
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: EventMonitorEntryPoint Running
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Sqlite version: 3.33.0
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Sqlite compiler options: COMPILER=gcc-5.4.0 20160609,DEFAULT_FOREIGN_KEYS,ENABLE_COLUMN_METADATA,ENABLE_FTS3_PARENTHESIS,ENABLE_FTS4,ENABLE_FTS5,ENABLE_JSON1,ENABLE_RTREE,THREADSAFE=1
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Default journal_mode for /var/lib/jellyfin/data/playback_reporting.db is delete
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Initialize PlaybackActivity Repository
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: PlaybackActivity table schema OK
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Expected : datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int
Jan 02 21:59:34 jellyfin jellyfin[3514]: [21:59:34] [INF] [1] Jellyfin.Plugin.PlaybackReporting.Data.ActivityRepository: Received : datecreated:datetime|userid:text|itemid:text|itemtype:text|itemname:text|playbackmethod:text|clientname:text|devicename:text|playduration:int
Jan 02 21:59:35 jellyfin jellyfin[3514]: [21:59:35] [INF] [1] Emby.Server.Implementations.ApplicationHost: Executed all post-startup entry points in 0:00:00.2981479
Jan 02 21:59:35 jellyfin jellyfin[3514]: [21:59:35] [INF] [1] Main: Startup complete 0:00:11.501094