{"timestamp":"2026-05-22 14:48:36.221","source":"Auth.js:341","message":"[Auth] Failed to refresh token. No refresh token provided","levelName":"ERROR","level":4}
{"timestamp":"2026-05-22 14:49:28.038","source":"Server.js:220","message":"=== Starting Server ===","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.039","source":"Server.js:143","message":"[Server] Init v2.30.0","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.039","source":"Server.js:144","message":"[Server] Node.js Version: v20.19.5","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.039","source":"Server.js:145","message":"[Server] Platform: linux","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.040","source":"Server.js:146","message":"[Server] Arch: x64","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.045","source":"Database.js:217","message":"[Database] Initializing db at \"/config/absdatabase.sqlite\"","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.078","source":"Database.js:292","message":"[Database] Loading extension /usr/local/lib/nusqlite3/libnusqlite3.so","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.080","source":"Database.js:300","message":"[Database] Successfully loaded extension /usr/local/lib/nusqlite3/libnusqlite3.so","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.080","source":"Database.js:269","message":"[Database] Db supports unaccent and unicode foldings","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.080","source":"Database.js:273","message":"[Database] Db connection was successful","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.088","source":"MigrationManager.js:77","message":"[MigrationManager] Database is already up to date.","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.224","source":"Database.js:201","message":"[Database] Db initialized with models: user, session, apiKey, library, libraryFolder, book, podcast, podcastEpisode, libraryItem, mediaProgress, series, bookSeries, author, bookAuthor, collection, collectionBook, playlist, playlistMediaItem, device, playbackSession, feed, feedEpisode, setting, customMetadataProvider, mediaItemShare","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.264","source":"Database.js:207","message":"[Database] running ANALYZE","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.276","source":"Database.js:209","message":"[Database] ANALYZE completed","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.279","source":"LogManager.js:66","message":"[LogManager] Init current daily log filename: 2026-05-22.txt","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.287","source":"BackupManager.js:285","message":"[BackupManager] 0 Backups Found","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.287","source":"BackupManager.js:72","message":"[BackupManager] Auto Backups are disabled","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.307","source":"Server.js:423","message":"Listening on port :80","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:28.445","source":"Server.js:432","message":"[Server] Initializing new server","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:35.897","source":"LocalAuthStrategy.js:88","message":"[LocalAuth] User \"az-a\" logged in from ip ::ffff:172.29.211.227","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:36.091","source":"SocketAuthority.js:176","message":"[SocketAuthority] Socket Connected to /audiobookshelf/socket.io MUSTV1qaVG2h1rfQAAAB","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:58.486","source":"Watcher.js:58","message":"[Watcher] Initializing watcher for \"Audiobooks\".","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:49:58.508","source":"Watcher.js:89","message":"[Watcher] \"Audiobooks\" Ready","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:50:05.147","source":"LibraryScanner.js:65","message":"[LibraryScanner] Library metadata precedence changed since last scan. From [Unset] to [folderStructure,audioMetatags,nfoFile,txtFiles,opfFile,absMetadata]","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:50:05.151","source":"LibraryScanner.js:86","message":"[LibraryScanner] Starting (forced) library scan 006cb240-114c-4711-b446-6e85bf481a42 for Audiobooks","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:50:23.533","source":"LibraryScanner.js:92","message":"[LibraryScanner] Library scan \"006cb240-114c-4711-b446-6e85bf481a42\" completed in 0:18 | 3 Added | 0 Updated | 0 Missing","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:50:23.553","source":"LibraryScan.js:139","message":"[LibraryScan] Scan log saved \"/metadata/logs/scans/2026-05-22_006cb240-114c-4711-b446-6e85bf481a42.txt\"","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:50:23.553","source":"LibraryController.js:1275","message":"[LibraryController] Scan complete","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:01.597","source":"LocalAuthStrategy.js:88","message":"[LocalAuth] User \"az-a\" logged in from ip ::ffff:172.29.61.88","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:02.136","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:07.573","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:12.517","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:16.402","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:18.996","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:45.695","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:45.911","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:48.127","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:53:55.525","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 14:54:22.941","source":"SocketAuthority.js:207","message":"[SocketAuthority] Socket MUSTV1qaVG2h1rfQAAAB disconnected from client \"az-a\" after 286850ms (Reason: transport close)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:33.188","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:33.823","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:34.341","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:37.089","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:39.882","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:42.882","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:45.876","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:56:58.890","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:57:01.062","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:57:04.046","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:57:07.069","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 18:57:11.406","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:06.574","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:07.012","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:08.713","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:12.010","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:30.569","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:31.292","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:31.661","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:35.058","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:17:40.854","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:23.013","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:23.054","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:23.108","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:30.155","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:30.613","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:31.283","source":"Server.js:366","message":"Received ping","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.189","source":"PlaybackSessionManager.js:110","message":"[PlaybackSessionManager] Syncing local session \"Verbrechen und Strafe\" (1A415B42-C31D-4680-9650-F2949680889A) (updatedAt: 1779461621342)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.212","source":"PlaybackSessionManager.js:249","message":"[PlaybackSessionManager] Creating new media progress for media item \"Verbrechen und Strafe\"","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.230","source":"PlaybackSessionManager.js:110","message":"[PlaybackSessionManager] Syncing local session \"Verbrechen und Strafe\" (2FAC54B1-6F67-423B-8AAA-BC0AC1F31D62) (updatedAt: 1779481033026)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.248","source":"PlaybackSessionManager.js:233","message":"[PlaybackSessionManager] Not updating progress for \"Verbrechen und Strafe\" because it has been updated more recently (1779481120221 > 1779481033026) (incoming currentTime: 0) (current currentTime: 0)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.248","source":"PlaybackSessionManager.js:110","message":"[PlaybackSessionManager] Syncing local session \"Verbrechen und Strafe\" (EB5EB3B7-7AEA-4670-990B-11147ED670BD) (updatedAt: 1779481053761.0002)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.265","source":"PlaybackSessionManager.js:233","message":"[PlaybackSessionManager] Not updating progress for \"Verbrechen und Strafe\" because it has been updated more recently (1779481120221 > 1779481053761.0002) (incoming currentTime: 0) (current currentTime: 0)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.265","source":"PlaybackSessionManager.js:110","message":"[PlaybackSessionManager] Syncing local session \"Verbrechen und Strafe\" (779A82C7-4AF2-4C3C-9072-3FC1A2969FDA) (updatedAt: 1779481117021)","levelName":"INFO","level":2}
{"timestamp":"2026-05-22 20:18:40.289","source":"PlaybackSessionManager.js:233","message":"[PlaybackSessionManager] Not updating progress for \"Verbrechen und Strafe\" because it has been updated more recently (1779481120221 > 1779481117021) (incoming currentTime: 0) (current currentTime: 0)","levelName":"INFO","level":2}