[2024-03-30 00:01:00.002 +00:00] [INF] "DailyTrigger" fired for task: "Remove Old Cached Data" [2024-03-30 00:01:00.003 +00:00] [INF] Queuing task "HousekeepingTask" [2024-03-30 00:01:00.004 +00:00] [INF] Executing "Remove Old Cached Data" [2024-03-30 00:01:00.095 +00:00] [INF] "Remove Old Cached Data" Completed after 0 minute(s) and 0 seconds [2024-03-30 00:01:00.097 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 00:01:01.005 +00:00] [INF] Daily trigger for "Remove Old Cached Data" set to fire at 2024-03-31 00:01:00.000 +00:00, which is 23:59:58.9947434 from now. [2024-03-30 00:45:12.532 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 00:45:12.539 +00:00] [INF] Current/Max sessions for user "user": 0/0 [2024-03-30 00:45:12.752 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 00:45:13.422 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Users/AuthenticateByName" to "[client ip was here]" in 0:00:02.0269313 with Status Code 200 [2024-03-30 00:45:14.152 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Users/52d2257eddc34b96a1d3b1c4910f895e/Views?IncludeExternalContent=false" to "[client ip was here]" in 0:00:00.507329 with Status Code 200 [2024-03-30 00:45:14.793 +00:00] [WRN] The entity type '"AccessSchedule"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.794 +00:00] [WRN] The entity type '"ActivityLog"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.794 +00:00] [WRN] The entity type '"CustomItemDisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.794 +00:00] [WRN] The entity type '"DisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.794 +00:00] [WRN] The entity type '"HomeSection"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.795 +00:00] [WRN] The entity type '"ImageInfo"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.795 +00:00] [WRN] The entity type '"ItemDisplayPreferences"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.795 +00:00] [WRN] The entity type '"Permission"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.795 +00:00] [WRN] The entity type '"Preference"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.795 +00:00] [WRN] The entity type '"ApiKey"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.796 +00:00] [WRN] The entity type '"Device"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.796 +00:00] [WRN] The entity type '"DeviceOptions"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:14.796 +00:00] [WRN] The entity type '"User"' is configured to use schema '"jellyfin"', but SQLite does not support schemas. This configuration will be ignored by the SQLite provider. [2024-03-30 00:45:15.365 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/DisplayPreferences/usersettings?userId=52d2257eddc34b96a1d3b1c4910f895e&client=emby" to "[client ip was here]" in 0:00:00.82102 with Status Code 200 [2024-03-30 00:45:17.276 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 00:45:17.277 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 00:45:17.286 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 00:45:18.020 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Shows/NextUp?UserId=52d2257eddc34b96a1d3b1c4910f895e&Fields=DateCreated,Etag,Genres,MediaSources,Overview,ParentId,Path,People,ProviderIds,SortName,RecursiveItemCount,ChildCount&Limit=24" to "[client ip was here]" in 0:00:00.6884998 with Status Code 200 [2024-03-30 01:59:59.997 +00:00] [INF] "DailyTrigger" fired for task: "Extract Chapter Images" [2024-03-30 01:59:59.997 +00:00] [INF] Queuing task "ChapterImagesTask" [2024-03-30 01:59:59.998 +00:00] [INF] Executing "Extract Chapter Images" [2024-03-30 02:00:01.002 +00:00] [INF] Daily trigger for "Extract Chapter Images" set to fire at 2024-03-31 02:00:00.000 +00:00, which is 23:59:58.9975978 from now. [2024-03-30 02:00:01.863 +00:00] [INF] Stopping chapter extraction for "The Tale of The Princess Kaguya" because a chapter was found with a position greater than the runtime. [2024-03-30 02:00:02.297 +00:00] [INF] "Extract Chapter Images" Completed after 0 minute(s) and 2 seconds [2024-03-30 02:00:02.300 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 02:45:54.131 +00:00] [INF] "IntervalTrigger" fired for task: "Scan Media Library" [2024-03-30 02:45:54.132 +00:00] [INF] Queuing task "RefreshMediaLibraryTask" [2024-03-30 02:45:54.132 +00:00] [INF] Executing "Scan Media Library" [2024-03-30 02:45:54.143 +00:00] [INF] Stopping directory watching for path "/media/ssd/movies" [2024-03-30 02:45:54.146 +00:00] [INF] Stopping directory watching for path "/media/ssd/shows" [2024-03-30 02:45:54.156 +00:00] [INF] Validating media library [2024-03-30 02:46:12.923 +00:00] [INF] Creating image collage and saving to "/var/cache/jellyfin/temp/dde5802eae474263a73199d98f6e4e26.png" [2024-03-30 02:46:14.035 +00:00] [INF] Completed creation of image collage and saved to "/var/cache/jellyfin/temp/dde5802eae474263a73199d98f6e4e26.png" [2024-03-30 02:46:14.681 +00:00] [INF] "Scan Media Library" Completed after 0 minute(s) and 20 seconds [2024-03-30 02:46:14.684 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 02:46:14.684 +00:00] [INF] Watching directory "/media/ssd/movies" [2024-03-30 02:46:14.768 +00:00] [INF] Watching directory "/media/ssd/shows" [2024-03-30 09:02:49.076 +00:00] [INF] Defined LAN addresses : "[fc00::/7,fe80::/10,10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-03-30 09:02:49.076 +00:00] [INF] Defined LAN exclusions : "[]" [2024-03-30 09:02:49.076 +00:00] [INF] Using LAN addresses: "[fc00::/7,fe80::/10,10.0.0.0/8,172.16.0.0/12,192.168.0.0/16]" [2024-03-30 09:26:10.726 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 09:26:10.727 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 09:26:10.735 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 09:26:15.370 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 09:26:15.370 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 09:26:15.376 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 09:26:16.210 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Playlists/ad1dc302c8275897cf3495d9327b2d74/Items?UserId=52d2257eddc34b96a1d3b1c4910f895e&Fields=DateCreated,Etag,Genres,MediaSources,Overview,ParentId,Path,People,ProviderIds,SortName,RecursiveItemCount,ChildCount&StartIndex=0&Limit=50" to "[client ip was here]" in 0:00:00.8665861 with Status Code 200 [2024-03-30 09:26:19.992 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Playlists/ad1dc302c8275897cf3495d9327b2d74/Items?UserId=52d2257eddc34b96a1d3b1c4910f895e&Fields=DateCreated,Etag,Genres,MediaSources,Overview,ParentId,Path,People,ProviderIds,SortName,RecursiveItemCount,ChildCount&StartIndex=50&Limit=50" to "[client ip was here]" in 0:00:00.5057984 with Status Code 200 [2024-03-30 10:12:53.025 +00:00] [ERR] Error processing request: "Unexpected end of request content". URL "POST" "/Sessions/Playing/Progress". [2024-03-30 10:12:53.105 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Fastest Man Alive". Stopped at "2554517" ms [2024-03-30 10:12:54.448 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 10:12:54.449 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 10:12:54.455 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 10:33:41.459 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Sara". Stopped at "2092132" ms [2024-03-30 11:16:51.085 +00:00] [INF] WS "::ffff:192.168.1.75" request [2024-03-30 11:16:51.369 +00:00] [INF] WS "::ffff:192.168.1.75" closed [2024-03-30 11:16:57.392 +00:00] [INF] WS "::ffff:192.168.1.75" request [2024-03-30 11:16:57.809 +00:00] [INF] WS "::ffff:192.168.1.75" closed [2024-03-30 11:55:57.233 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 11:55:57.233 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 11:55:57.239 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 12:03:42.735 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Sara". Stopped at "2553257" ms [2024-03-30 12:03:44.010 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 12:03:44.011 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 12:03:44.017 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 12:06:35.644 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 12:06:35.645 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 12:06:35.652 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 12:23:11.812 +00:00] [INF] "IntervalTrigger" fired for task: "Update Plugins" [2024-03-30 12:23:11.813 +00:00] [INF] Queuing task "PluginUpdateTask" [2024-03-30 12:23:11.813 +00:00] [INF] Executing "Update Plugins" [2024-03-30 12:23:12.842 +00:00] [INF] "Update Plugins" Completed after 0 minute(s) and 1 seconds [2024-03-30 12:23:12.844 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 12:51:51.267 +00:00] [ERR] Error processing request: "Unexpected end of request content". URL "POST" "/Sessions/Playing/Progress". [2024-03-30 12:51:51.288 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Things You Can't Outrun". Stopped at "2549545" ms [2024-03-30 12:51:52.619 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 12:51:52.620 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 12:51:52.629 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 12:52:52.639 +00:00] [INF] WS "::ffff:[client ip was here]" request [2024-03-30 12:52:58.205 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Items/44229f4c7f5c9688db96ff8250ab87ff/Images/Primary?fillHeight=645&fillWidth=429&quality=96&tag=6abeed74cedbe781b2bf519aef406df7" to "[client ip was here]" in 0:00:00.50515 with Status Code 200 [2024-03-30 12:52:58.232 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Items/79adef8484c2b0260d186b0a8737fda3/Images/Primary?fillHeight=645&fillWidth=429&quality=96&tag=2f7643b0f9a149189d92e6873918e815" to "[client ip was here]" in 0:00:00.5361371 with Status Code 200 [2024-03-30 12:53:06.871 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Items/6fb814eff9fda2f6efa081b0e313e092/Images/Backdrop/0?maxWidth=4320&tag=1c286e032be21c8a4cb1b865323cea08&quality=80" to "[client ip was here]" in 0:00:02.2103931 with Status Code 200 [2024-03-30 12:53:31.078 +00:00] [WRN] WS "[client ip was here]" error receiving data: "The remote party closed the WebSocket connection without completing the close handshake." [2024-03-30 12:53:31.128 +00:00] [INF] WS "::ffff:[client ip was here]" closed [2024-03-30 13:34:26.539 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Corto Maltese". Stopped at "2552853" ms [2024-03-30 13:34:27.918 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 13:34:27.918 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 13:34:27.925 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 13:53:03.024 +00:00] [WRN] Slow HTTP Response from "http://[server ip was here]:8096/Sessions/Playing/Progress" to "[client ip was here]" in 0:00:00.6389745 with Status Code 204 [2024-03-30 14:17:40.021 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Non Est Asylum". Stopped at "2585118" ms [2024-03-30 14:17:41.381 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 14:17:41.381 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 14:17:41.388 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 14:17:47.048 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 14:17:47.048 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 14:17:47.054 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 14:40:34.865 +00:00] [INF] "IntervalTrigger" fired for task: "Download missing subtitles" [2024-03-30 14:40:34.865 +00:00] [INF] Queuing task "SubtitleScheduledTask" [2024-03-30 14:40:34.866 +00:00] [INF] Executing "Download missing subtitles" [2024-03-30 14:40:34.886 +00:00] [INF] "Download missing subtitles" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:34.887 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:40:36.741 +00:00] [INF] "IntervalTrigger" fired for task: "TasksRefreshChannels" [2024-03-30 14:40:36.741 +00:00] [INF] Queuing task "RefreshChannelsScheduledTask" [2024-03-30 14:40:36.742 +00:00] [INF] Executing "TasksRefreshChannels" [2024-03-30 14:40:36.770 +00:00] [INF] "TasksRefreshChannels" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:36.772 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:40:37.538 +00:00] [INF] "IntervalTrigger" fired for task: "Clean Log Directory" [2024-03-30 14:40:37.538 +00:00] [INF] Queuing task "DeleteLogFileTask" [2024-03-30 14:40:37.539 +00:00] [INF] Executing "Clean Log Directory" [2024-03-30 14:40:37.577 +00:00] [INF] "Clean Log Directory" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:37.578 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:40:39.288 +00:00] [INF] "IntervalTrigger" fired for task: "Clean Cache Directory" [2024-03-30 14:40:39.289 +00:00] [INF] Queuing task "DeleteCacheFileTask" [2024-03-30 14:40:39.289 +00:00] [INF] Executing "Clean Cache Directory" [2024-03-30 14:40:39.423 +00:00] [INF] "Clean Cache Directory" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:39.424 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:40:41.100 +00:00] [INF] "IntervalTrigger" fired for task: "Clean Transcode Directory" [2024-03-30 14:40:41.100 +00:00] [INF] Queuing task "DeleteTranscodeFileTask" [2024-03-30 14:40:41.101 +00:00] [INF] Executing "Clean Transcode Directory" [2024-03-30 14:40:41.112 +00:00] [INF] "Clean Transcode Directory" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:41.114 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:40:47.110 +00:00] [INF] "IntervalTrigger" fired for task: "Optimize database" [2024-03-30 14:40:47.111 +00:00] [INF] Queuing task "OptimizeDatabaseTask" [2024-03-30 14:40:47.112 +00:00] [INF] Executing "Optimize database" [2024-03-30 14:40:47.117 +00:00] [INF] Optimizing and vacuuming jellyfin.db... [2024-03-30 14:40:47.218 +00:00] [INF] jellyfin.db optimized successfully! [2024-03-30 14:40:47.218 +00:00] [INF] "Optimize database" Completed after 0 minute(s) and 0 seconds [2024-03-30 14:40:47.219 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:41:20.024 +00:00] [INF] "IntervalTrigger" fired for task: "Refresh Guide" [2024-03-30 14:41:20.024 +00:00] [INF] Queuing task "RefreshGuideScheduledTask" [2024-03-30 14:41:20.025 +00:00] [INF] Executing "Refresh Guide" [2024-03-30 14:41:23.191 +00:00] [INF] Refreshing guide with 7 days of guide data [2024-03-30 14:41:23.216 +00:00] [INF] "Refresh Guide" Completed after 0 minute(s) and 3 seconds [2024-03-30 14:41:23.230 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:45:54.127 +00:00] [INF] "IntervalTrigger" fired for task: "Scan Media Library" [2024-03-30 14:45:54.128 +00:00] [INF] Queuing task "RefreshMediaLibraryTask" [2024-03-30 14:45:54.128 +00:00] [INF] Executing "Scan Media Library" [2024-03-30 14:45:54.128 +00:00] [INF] Stopping directory watching for path "/media/ssd/movies" [2024-03-30 14:45:54.129 +00:00] [INF] Stopping directory watching for path "/media/ssd/shows" [2024-03-30 14:45:54.130 +00:00] [INF] Validating media library [2024-03-30 14:46:12.987 +00:00] [INF] "Scan Media Library" Completed after 0 minute(s) and 18 seconds [2024-03-30 14:46:12.991 +00:00] [INF] ExecuteQueuedTasks [2024-03-30 14:46:13.073 +00:00] [INF] Watching directory "/media/ssd/movies" [2024-03-30 14:46:13.084 +00:00] [INF] Watching directory "/media/ssd/shows" [2024-03-30 17:21:14.179 +00:00] [INF] Creating image collage and saving to "/var/cache/jellyfin/temp/91eae14099634b9482c5a595468563f0.png" [2024-03-30 17:21:15.059 +00:00] [INF] Completed creation of image collage and saved to "/var/cache/jellyfin/temp/91eae14099634b9482c5a595468563f0.png" [2024-03-30 17:21:16.118 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 17:21:16.118 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 17:21:16.125 +00:00] [INF] Reissuing access token: "[access token was here]" [2024-03-30 17:52:59.612 +00:00] [INF] Playback stopped reported by app "Infuse-Library" "7.7.2" playing "Going Rogue". Stopped at "1795419" ms [2024-03-30 17:53:00.997 +00:00] [INF] Authentication request for "user" has succeeded. [2024-03-30 17:53:00.997 +00:00] [INF] Current/Max sessions for user "user": 1/0 [2024-03-30 17:53:01.003 +00:00] [INF] Reissuing access token: "[access token was here]"