Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Upgrade Button Spins with No Progress or Changes #4818

Closed
2 tasks done
Normanras opened this issue May 21, 2024 · 11 comments
Closed
2 tasks done

Upgrade Button Spins with No Progress or Changes #4818

Normanras opened this issue May 21, 2024 · 11 comments
Labels
Status: Logs Needed Logs are needed to proceed with this issue Status: Needs Triage New Issue needing triage Status: Waiting for OP Action Required from OP Type: Bug Issue is a bug

Comments

@Normanras
Copy link

Normanras commented May 21, 2024

Is there an existing issue for this?

  • I have searched the existing open and closed issues

Current Behavior

I cannot update Lidarr from the UI despite it giving me the alert that I have a new version available for update.

Expected Behavior

When I click the update button within System > Updates, it successfully updates. This used to work until recently. I am still trying to track down the specific cause for this error.

Steps To Reproduce

  1. Ensure Lidarr is running
  2. Navigate to domain and/or IP & port for Lidarr
  3. Click System > Updates
  4. Click "Install Update"

Environment

- OS: Debian
- Lidarr: Version 2.1.7.4030
- Docker Install: No
- Using Reverse Proxy: No
- Browser: Chrome Version 125.0.6422.60
- Database: Sqlite 3.34.1

What branch are you running?

Master

Trace Logs?

Under systemctl status lidarr, this has been showing up, which I think is the main culprit.

May 21 16:23:12 media Lidarr[125]: SQLite error (1): near "SHOW": syntax error in "SHOW server_version"

However, looking through the log files, this one is a bit odd. Permissions haven't changed and (to my knowledge) I haven't tried installing Lidarr multiple times:

2024-05-21 15:59:22.3|Fatal|ConsoleApp|Failed to bind to address http://[::]:8686: address already in use. This can happen if another instance of Lidarr is already running another application is using the same port (default: 8686) or the user has insufficient permissions

I know that I'm running 2.1.7.4030, the latest update is 2.3.3.4204 and I'm skipping over 2.2.5.4141, but I could have sworn that I had skipped over versions in the past.

There are no logs in the file with trace.

Trace Logs have been provided as applicable. Reports may be closed if the required logs are not provided.

  • I have read and followed the steps in the wiki link above and provided the required trace logs - the logs contain trace - that are relevant and show this issue.
@Normanras Normanras added Status: Needs Triage New Issue needing triage Type: Bug Issue is a bug labels May 21, 2024
@bakerboy448 bakerboy448 added the Status: Logs Needed Logs are needed to proceed with this issue label May 21, 2024
Copy link

👋 @Normanras, In order to help you further we'll need to see logs. You'll need to enable trace logging and replicate the problem that you encountered. Guidance on how to enable trace logging can be found in our troubleshooting guide.

@bakerboy448
Copy link
Contributor

bakerboy448 commented May 21, 2024

Trace logs after hitting update and the update log as well

May 21 16:23:12 media Lidarr[125]: SQLite error (1): near "SHOW": syntax error in "SHOW server_version"

Not an issue for the upgrade and unrelated

@Normanras
Copy link
Author

Apologies. Here are the trace logs - totally glossed over the enabling part.

2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'autounmonitorpreviouslydownloadedtracks' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'retention' defaultValue:'0'
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigFileSavedEvent <~ ReconfigureLogging
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'recyclebin' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'recyclebincleanupdays' defaultValue:'7'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'maximumsize' defaultValue:'0'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'minimumage' defaultValue:'0'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'downloadpropersandrepacks' defaultValue:'PreferAndUpgrade'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'autoredownloadfailed' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'autoredownloadfailedfrominteractivesearch' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'deleteemptyfolders' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'filedate' defaultValue:'None'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'downloadclientworkingfolders' defaultValue:'_UNPACK_|_FAILED_'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'downloadclienthistorylimit' defaultValue:'60'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'skipfreespacecheckwhenimporting' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'minimumfreespacewhenimporting' defaultValue:'100'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'copyusinghardlinks' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'importextrafiles' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'extrafileextensions' defaultValue:'srt'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'watchlibraryforchanges' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'rescanafterrefresh' defaultValue:'Always'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'allowfingerprinting' defaultValue:'NewFiles'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'metadatasource' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'writeaudiotags' defaultValue:'No'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'scrubaudiotags' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'embedcoverart' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'firstdayofweek' defaultValue:'0'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'calendarweekcolumnheader' defaultValue:'ddd M/D'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'shortdateformat' defaultValue:'MMM D YYYY'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'longdateformat' defaultValue:'dddd, MMMM D YYYY'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'timeformat' defaultValue:'h(:mm)a'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'showrelativedates' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'enablecolorimpairedmode' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'expandalbumbydefault' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'expandepbydefault' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'expandsinglebydefault' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'expandbroadcastbydefault' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'expandotherbydefault' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 17:45:59.9|Trace|EventAggregator|Publishing ConfigSavedEvent
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent -> RootFolderWatchingService
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'watchlibraryforchanges' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent <- RootFolderWatchingService
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent -> UiAuthorizationHandler
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent <- UiAuthorizationHandler
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent ~> LocalizationService
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent <~ LocalizationService
2024-05-21 17:45:59.9|Trace|EventAggregator|ConfigSavedEvent ~> TaskManager
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 17:45:59.9|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 17:46:00.0|Trace|EventAggregator|ConfigSavedEvent <~ TaskManager
2024-05-21 17:46:00.0|Trace|Http|Res: 172 [PUT] /api/v1/config/host: 202.Accepted (98 ms)
2024-05-21 17:46:00.0|Debug|Api|[PUT] /api/v1/config/host: 202.Accepted (98 ms)
2024-05-21 17:46:04.9|Trace|HealthCheckService|Check health -> UpdateCheck
2024-05-21 17:46:05.1|Trace|HttpClient|Req: [GET] https://lidarr.servarr.com/v1/update/master?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&dbType=SQLite&active=true
2024-05-21 17:46:05.1|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 17:46:05.3|Trace|HttpClient|Res: HTTP/2.0 [GET] https://lidarr.servarr.com/v1/update/master?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&dbType=SQLite&active=true: 200.OK (1229 bytes) (187 ms)
2024-05-21 17:46:05.3|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health <- UpdateCheck
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health -> ApiKeyValidationCheck
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health <- ApiKeyValidationCheck
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health -> FpcalcCheck
2024-05-21 17:46:05.3|Trace|ConfigService|Using default config value for 'allowfingerprinting' defaultValue:'NewFiles'
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health <- FpcalcCheck
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health -> ImportMechanismCheck
2024-05-21 17:46:05.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health <- ImportMechanismCheck
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health -> ProxyCheck
2024-05-21 17:46:05.3|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 17:46:05.3|Trace|HealthCheckService|Check health <- ProxyCheck
2024-05-21 17:46:05.3|Trace|EventAggregator|Publishing HealthCheckCompleteEvent
2024-05-21 17:46:05.3|Trace|EventAggregator|HealthCheckCompleteEvent -> HealthController
2024-05-21 17:46:05.3|Trace|EventAggregator|HealthCheckCompleteEvent <- HealthController
2024-05-21 17:46:05.3|Trace|EventAggregator|HealthCheckCompleteEvent ~> NotificationService
2024-05-21 17:46:05.3|Trace|EventAggregator|HealthCheckCompleteEvent <~ NotificationService
2024-05-21 17:46:05.3|Trace|Http|Req: 173 [GET] /api/v1/health (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 17:46:05.3|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 17:46:05.3|Trace|Http|Res: 173 [GET] /api/v1/health: 200.OK (2 ms)
2024-05-21 17:46:05.3|Debug|Api|[GET] /api/v1/health: 200.OK (2 ms)
2024-05-21 17:46:17.0|Trace|Scheduler|Pending Tasks: 7
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing ImportListSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: ImportListSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: ImportListSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing RefreshArtist
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: RefreshArtist
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: RefreshArtist
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing Housekeeping
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: Housekeeping
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: Housekeeping
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing CheckHealth
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: CheckHealth
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: CheckHealth
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing RssSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: RssSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: RssSync
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing MessagingCleanup
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: MessagingCleanup
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: MessagingCleanup
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Publishing ApplicationUpdateCheck
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Checking if command is queued or started: ApplicationUpdateCheck
2024-05-21 17:46:17.0|Trace|CommandQueueManager|Command is already in progress: ApplicationUpdateCheck
2024-05-21 17:46:26.0|Trace|Http|Req: 174 [GET] /api/v1/health (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 17:46:26.0|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 17:46:26.0|Trace|Http|Res: 174 [GET] /api/v1/health: 200.OK (1 ms)
2024-05-21 17:46:26.0|Debug|Api|[GET] /api/v1/health: 200.OK (1 ms)
2024-05-21 17:46:26.0|Trace|Http|Req: 175 [GET] /api/v1/diskspace (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 17:46:26.0|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 17:46:26.0|Trace|Http|Req: 176 [GET] /api/v1/system/status (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 17:46:26.0|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 17:46:26.0|Trace|Http|Res: 176 [GET] /api/v1/system/status: 200.OK (3 ms)
2024-05-21 17:46:26.0|Debug|Api|[GET] /api/v1/system/status: 200.OK (3 ms)
2024-05-21 17:46:26.0|Debug|DiskProvider|path: /media/Music/
2024-05-21 17:46:26.0|Debug|DiskProvider|path: /
2024-05-21 17:46:26.0|Debug|DiskProvider|path: /media
2024-05-21 17:46:26.0|Trace|Http|Res: 175 [GET] /api/v1/diskspace: 200.OK (30 ms)
2024-05-21 17:46:26.0|Debug|Api|[GET] /api/v1/diskspace: 200.OK (30 ms)
2024-05-21 17:46:27.1|Trace|Http|Req: 177 [GET] /api/v1/log/file (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 17:46:27.1|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 17:46:27.1|Trace|Http|Res: 177 [GET] /api/v1/log/file: 200.OK (3 ms)
2024-05-21 17:46:27.1|Debug|Api|[GET] /api/v1/log/file: 200.OK (3 ms)
2024-05-21 17:46:30.4|Trace|Http|Req: 178 [GET] /logfile/lidarr.trace.txt (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)```

@bakerboy448
Copy link
Contributor

  • trace logs provided do not capture and update install being triggered
  • Updater logs not provided

@bakerboy448 bakerboy448 added the Status: Waiting for OP Action Required from OP label May 21, 2024
@Normanras
Copy link
Author

So the updater logs aren't showing at all - they just show the previous update log. Would you like me to include that? And I did trigger the update with trace logs activated, but it appears to not be showing. Let me restart everything and try again.

@bakerboy448
Copy link
Contributor

If the update logs aren't being made then the trace logs showing the start of the update dying or otherwise not starting show be what's needed - it's not even starting the updater

@Normanras
Copy link
Author

Okay, so let's see if this help. When I enabled trace logs, the Install update button was just spinning.

Screenshot 2024-05-21 at 4 07 34 PM

When I refreshed, the button became clickable, but nothing was added to the logs. I then restarted Lidarr, enabled trace logs, and looked at them. I do see some items for /v1/update and ApplicationUpdate, here are the logs. I've also attached the full file.

For what it's worth, I also noticed that if I click restart from within the Lidarr UI, the install button remains spinning when I navigate back to that page. Only when I systemctl restart lidarr does it seem to reset the spinning wheel.

2024-05-21 20:11:02.2|Trace|HttpClient|Req: [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true
2024-05-21 20:11:02.2|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:11:02.2|Trace|HttpClient|Res: HTTP/2.0 [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true: 200.OK (14011 bytes) (33 ms)
2024-05-21 20:11:02.2|Trace|Http|Res: 36 [GET] /api/v1/update: 200.OK (302 ms)
2024-05-21 20:11:02.2|Debug|Api|[GET] /api/v1/update: 200.OK (302 ms)
2024-05-21 20:11:02.7|Trace|Http|Res: 22 [GET] /api/v1/artist: 200.OK (915 ms)
2024-05-21 20:11:02.7|Debug|Api|[GET] /api/v1/artist: 200.OK (915 ms)
2024-05-21 20:11:03.1|Trace|Http|Req: 38 [POST] /api/v1/command (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:03.1|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Publishing ApplicationUpdate
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Checking if command is queued or started: ApplicationUpdate
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Command is already in progress: ApplicationUpdate
2024-05-21 20:11:03.1|Trace|Http|Res: 38 [POST] /api/v1/command: 201.Created (43 ms)
2024-05-21 20:11:03.1|Debug|Api|[POST] /api/v1/command: 201.Created (43 ms)
2024-05-21 20:11:09.4|Trace|Http|Req: 39 [GET] /api/v1/log/file (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:09.4|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:09.4|Trace|Http|Res: 39 [GET] /api/v1/log/file: 200.OK (10 ms)
2024-05-21 20:11:09.4|Debug|Api|[GET] /api/v1/log/file: 200.OK (10 ms)
2024-05-21 20:11:11.4|Trace|Http|Req: 40 [GET] /logfile/lidarr.trace.txt (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)

Full Trace Logs were too long so I cut it off a minute before I pressed the Install Button (20:10:30).

2024-05-21 20:09:56.2|Trace|ConfigService|Using default config value for 'downloadclienthistorylimit' defaultValue:'60'
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/movies/Split.2016.1080p.10bit.BluRay.6CH.x265.HEVC-PSA-xpost]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.2|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/movies/Split.2016.1080p.10bit.BluRay.6CH.x265.HEVC-PSA-xpost] to local path [/media/downloads/completed/movies/Split.2016.1080p.10bit.BluRay.6CH.x265.HEVC-PSA-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Josh White  Free and Equal Blues]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.2|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Josh White  Free and Equal Blues] to local path [/media/downloads/completed/music/Josh White  Free and Equal Blues] for host [192.168.200.42]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-Hey What-CD-FLAC-2021-401]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.2|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-Hey What-CD-FLAC-2021-401] to local path [/media/downloads/completed/music/Low-Hey What-CD-FLAC-2021-401] for host [192.168.200.42]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-Double Negative-CD-FLAC-2018-FAiNT-xpost]
2024-05-21 20:09:56.2|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.2|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-Double Negative-CD-FLAC-2018-FAiNT-xpost] to local path [/media/downloads/completed/music/Low-Double Negative-CD-FLAC-2018-FAiNT-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-Ones And Sixes-CD-FLAC-2015-JLM]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-Ones And Sixes-CD-FLAC-2015-JLM] to local path [/media/downloads/completed/music/Low-Ones And Sixes-CD-FLAC-2015-JLM] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-The Invisible Way-(SP1030)-CD-FLAC-2013-CUSTODES]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-The Invisible Way-(SP1030)-CD-FLAC-2013-CUSTODES] to local path [/media/downloads/completed/music/Low-The Invisible Way-(SP1030)-CD-FLAC-2013-CUSTODES] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-Trust-(EVERCD223)-CD-FLAC-2002-HOUND]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-Trust-(EVERCD223)-CD-FLAC-2002-HOUND] to local path [/media/downloads/completed/music/Low-Trust-(EVERCD223)-CD-FLAC-2002-HOUND] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-Drums And Guns-CD-FLAC-2007-401]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-Drums And Guns-CD-FLAC-2007-401] to local path [/media/downloads/completed/music/Low-Drums And Guns-CD-FLAC-2007-401] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-The Great Destroyer-2005-DeBT iNT]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-The Great Destroyer-2005-DeBT iNT] to local path [/media/downloads/completed/music/Low-The Great Destroyer-2005-DeBT iNT] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low-I Could Live In Hope-(YARDCD6)-CD-FLAC-1994-dL]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low-I Could Live In Hope-(YARDCD6)-CD-FLAC-1994-dL] to local path [/media/downloads/completed/music/Low-I Could Live In Hope-(YARDCD6)-CD-FLAC-1994-dL] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/music/Low--Long Division-(YARDCD14)-WEB-1995-BABAS INT-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/music/Low--Long Division-(YARDCD14)-WEB-1995-BABAS INT-xpost] to local path [/media/downloads/completed/music/Low--Long Division-(YARDCD14)-WEB-1995-BABAS INT-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/intermediate/Low-Things We Lost In The Fire-CD-FLAC-2001-401-xpost.#6225]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/intermediate/Low-Things We Lost In The Fire-CD-FLAC-2001-401-xpost.#6225] to local path [/media/downloads/intermediate/Low-Things We Lost In The Fire-CD-FLAC-2001-401-xpost.#6225] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E04.Thirst.Trap.A.Corporate.Love.Story.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E04.Thirst.Trap.A.Corporate.Love.Story.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E04.Thirst.Trap.A.Corporate.Love.Story.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E12.Lisa.Gets.an.F1.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E12.Lisa.Gets.an.F1.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E12.Lisa.Gets.an.F1.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E07.Its.a.Blunderful.Life.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E07.Its.a.Blunderful.Life.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E07.Its.a.Blunderful.Life.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E09.Murder.She.Boat.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E09.Murder.She.Boat.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E09.Murder.She.Boat.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E01.Homers.Crossing.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E01.Homers.Crossing.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E01.Homers.Crossing.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E06.Iron.Marge.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E06.Iron.Marge.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E06.Iron.Marge.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E02.A.Mid-Childhoods.Night.Dream.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E02.A.Mid-Childhoods.Night.Dream.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E02.A.Mid-Childhoods.Night.Dream.1080p.HULU.WEB-DL.DDP5.1.H.264-NTb[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/series/The.Simpsons.S35E18.WEB.x264-TORRENTGALAXY[TGx]-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/series/The.Simpsons.S35E18.WEB.x264-TORRENTGALAXY[TGx]-xpost] to local path [/media/downloads/completed/series/The.Simpsons.S35E18.WEB.x264-TORRENTGALAXY[TGx]-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.Cancer.Ward.A.Novel.2013.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.Cancer.Ward.A.Novel.2013.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.Cancer.Ward.A.Novel.2013.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.In.The.First.Circle.The.First.Uncensored.Edition.2012.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.In.The.First.Circle.The.First.Uncensored.Edition.2012.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.In.The.First.Circle.The.First.Uncensored.Edition.2012.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.November.1916.The.Red.Wheel.2.2014.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.November.1916.The.Red.Wheel.2.2014.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.November.1916.The.Red.Wheel.2.2014.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.August.1914.The.Red.Wheel.1.2014.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.August.1914.The.Red.Wheel.1.2014.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aleksandr.Solzhenitsyn.-.August.1914.The.Red.Wheel.1.2014.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Vasily.Grossman.-.An.Armenian.Sketchbook.2013.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Vasily.Grossman.-.An.Armenian.Sketchbook.2013.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Vasily.Grossman.-.An.Armenian.Sketchbook.2013.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Vasily.Grossman.-.Stalingrad.2019.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Vasily.Grossman.-.Stalingrad.2019.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Vasily.Grossman.-.Stalingrad.2019.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Bret.Easton.Ellis.-.The.Rules.of.Attraction.(azw3.epub.mobi)]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Bret.Easton.Ellis.-.The.Rules.of.Attraction.(azw3.epub.mobi)] to local path [/media/downloads/completed/ebooks/Bret.Easton.Ellis.-.The.Rules.of.Attraction.(azw3.epub.mobi)] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Knut.Hamsun.-.Mysteries.2001.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Knut.Hamsun.-.Mysteries.2001.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Knut.Hamsun.-.Mysteries.2001.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Albert.Camus.-.Caligula.And.Three.Other.Plays.2023.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Albert.Camus.-.Caligula.And.Three.Other.Plays.2023.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Albert.Camus.-.Caligula.And.Three.Other.Plays.2023.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Albert.Camus.-.A.Happy.Death.2012.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Albert.Camus.-.A.Happy.Death.2012.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Albert.Camus.-.A.Happy.Death.2012.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Thomas.Asbridge.-.The.Greatest.Knight.The.Remarkable.Life.Of.William.Marshal.The.Power.Behind.Five.English.Thrones.2014.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Thomas.Asbridge.-.The.Greatest.Knight.The.Remarkable.Life.Of.William.Marshal.The.Power.Behind.Five.English.Thrones.2014.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Thomas.Asbridge.-.The.Greatest.Knight.The.Remarkable.Life.Of.William.Marshal.The.Power.Behind.Five.English.Thrones.2014.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Christopher.Tyerman.-.The.World.Of.The.Crusades.An.Illustrated.History.2019.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Christopher.Tyerman.-.The.World.Of.The.Crusades.An.Illustrated.History.2019.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Christopher.Tyerman.-.The.World.Of.The.Crusades.An.Illustrated.History.2019.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/George.Orwell.-.Animal.Farm.A.Fairy.Story.2009.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/George.Orwell.-.Animal.Farm.A.Fairy.Story.2009.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/George.Orwell.-.Animal.Farm.A.Fairy.Story.2009.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Douglas.Preston.-.Extinction.(azw3.epub.mobi)]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Douglas.Preston.-.Extinction.(azw3.epub.mobi)] to local path [/media/downloads/completed/ebooks/Douglas.Preston.-.Extinction.(azw3.epub.mobi)] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Doors.Of.Perception.And.Heaven.And.Hell.2009.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Doors.Of.Perception.And.Heaven.And.Hell.2009.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Doors.Of.Perception.And.Heaven.And.Hell.2009.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Perennial.Philosophy.An.Interpretation.Of.The.Great.Mystics.East.And.West.2012.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Perennial.Philosophy.An.Interpretation.Of.The.Great.Mystics.East.And.West.2012.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Perennial.Philosophy.An.Interpretation.Of.The.Great.Mystics.East.And.West.2012.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Emily.Henry.-.Funny.Story.A.Novel.2024.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Emily.Henry.-.Funny.Story.A.Novel.2024.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Emily.Henry.-.Funny.Story.A.Novel.2024.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Island.2009.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Island.2009.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Island.2009.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Ape.And.Essence.2019.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Ape.And.Essence.2019.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Ape.And.Essence.2019.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Devils.Of.Loudun.A.True.Story.Of.Demonic.Possession.2015.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Devils.Of.Loudun.A.True.Story.Of.Demonic.Possession.2015.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.The.Devils.Of.Loudun.A.True.Story.Of.Demonic.Possession.2015.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Evaluating remote path remote mappings for match to host [192.168.200.42] and remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Point.Counter.Point.2023.RETAIL.EPUB.eBook-CTO-xpost]
2024-05-21 20:09:56.3|Trace|RemotePathMappingService|Checking configured remote path mapping: 192.168.200.42 - /media/downloads/
2024-05-21 20:09:56.3|Debug|RemotePathMappingService|Remapped remote path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Point.Counter.Point.2023.RETAIL.EPUB.eBook-CTO-xpost] to local path [/media/downloads/completed/ebooks/Aldous.Huxley.-.Point.Counter.Point.2023.RETAIL.EPUB.eBook-CTO-xpost] for host [192.168.200.42]
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:09:56.3|Trace|EventAggregator|Publishing TrackedDownloadRefreshedEvent
2024-05-21 20:09:56.3|Trace|EventAggregator|TrackedDownloadRefreshedEvent -> QueueService
2024-05-21 20:09:56.3|Trace|EventAggregator|Publishing QueueUpdatedEvent
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent -> QueueController
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent <- QueueController
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent -> QueueDetailsController
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent <- QueueDetailsController
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent -> QueueStatusController
2024-05-21 20:09:56.3|Trace|EventAggregator|QueueUpdatedEvent <- QueueStatusController
2024-05-21 20:09:56.3|Trace|EventAggregator|TrackedDownloadRefreshedEvent <- QueueService
2024-05-21 20:09:56.3|Trace|CommandQueueManager|Publishing ProcessMonitoredDownloads
2024-05-21 20:09:56.3|Trace|CommandQueueManager|Checking if command is queued or started: ProcessMonitoredDownloads
2024-05-21 20:09:56.3|Trace|CommandQueueManager|Command is already in progress: ProcessMonitoredDownloads
2024-05-21 20:09:56.3|Trace|CommandQueueManager|Updating command status
2024-05-21 20:09:56.3|Trace|EventAggregator|Publishing CommandExecutedEvent
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent -> TaskManager
2024-05-21 20:09:56.3|Trace|TaskManager|Updating last run time for: NzbDrone.Core.Download.RefreshMonitoredDownloadsCommand
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent <- TaskManager
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent -> TaskController
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent <- TaskController
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent -> QualityDefinitionController
2024-05-21 20:09:56.3|Trace|EventAggregator|CommandExecutedEvent <- QualityDefinitionController
2024-05-21 20:09:56.3|Trace|CommandExecutor|RefreshMonitoredDownloadsCommand <- DownloadMonitoringService [00:00:06.7340270]
2024-05-21 20:09:56.3|Trace|Http|Req: 507 [GET] /api/v1/command (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:09:56.3|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:09:56.3|Trace|CommandQueueManager|Getting all commands
2024-05-21 20:09:56.3|Trace|Http|Res: 507 [GET] /api/v1/command: 200.OK (5 ms)
2024-05-21 20:09:56.3|Debug|Api|[GET] /api/v1/command: 200.OK (5 ms)
2024-05-21 20:09:56.4|Trace|Http|Req: 508 [GET] /api/v1/command (from 192.168.200.199 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36)
2024-05-21 20:09:56.4|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:09:56.4|Trace|CommandQueueManager|Getting all commands
2024-05-21 20:09:56.4|Trace|Http|Res: 508 [GET] /api/v1/command: 200.OK (5 ms)
2024-05-21 20:09:56.4|Debug|Api|[GET] /api/v1/command: 200.OK (5 ms)
2024-05-21 20:10:08.9|Trace|Http|Req: 509 [GET] /api/v1/config/ui (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:08.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'firstdayofweek' defaultValue:'0'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'calendarweekcolumnheader' defaultValue:'ddd M/D'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'shortdateformat' defaultValue:'MMM D YYYY'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'longdateformat' defaultValue:'dddd, MMMM D YYYY'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'timeformat' defaultValue:'h(:mm)a'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'showrelativedates' defaultValue:'True'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'enablecolorimpairedmode' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'expandalbumbydefault' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'expandsinglebydefault' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'expandepbydefault' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'expandbroadcastbydefault' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|ConfigService|Using default config value for 'expandotherbydefault' defaultValue:'False'
2024-05-21 20:10:08.9|Trace|Http|Res: 509 [GET] /api/v1/config/ui: 200.OK (4 ms)
2024-05-21 20:10:08.9|Debug|Api|[GET] /api/v1/config/ui: 200.OK (4 ms)
2024-05-21 20:10:09.3|Trace|Http|Req: 510 [GET] /api/v1/config/host (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:09.3|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 20:10:09.3|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 20:10:09.3|Trace|Http|Res: 510 [GET] /api/v1/config/host: 200.OK (5 ms)
2024-05-21 20:10:09.3|Debug|Api|[GET] /api/v1/config/host: 200.OK (5 ms)
2024-05-21 20:10:15.6|Trace|Http|Req: 511 [PUT] /api/v1/config/host (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:15.6|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:15.6|Trace|EventAggregator|Publishing ConfigFileSavedEvent
2024-05-21 20:10:15.6|Trace|ConfigService|Using default config value for 'autounmonitorpreviouslydownloadedtracks' defaultValue:'False'
2024-05-21 20:10:15.6|Trace|EventAggregator|ConfigFileSavedEvent ~> ReconfigureLogging
2024-05-21 20:10:15.6|Trace|ConfigService|Using default config value for 'retention' defaultValue:'0'
2024-05-21 20:10:15.6|Trace|ConfigService|Using default config value for 'recyclebin' defaultValue:''
2024-05-21 20:10:15.6|Trace|ConfigService|Using default config value for 'recyclebincleanupdays' defaultValue:'7'
2024-05-21 20:10:15.6|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'autounmonitorpreviouslydownloadedtracks' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'retention' defaultValue:'0'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'recyclebin' defaultValue:''
2024-05-21 20:10:53.7|Trace|EventAggregator|ConfigFileSavedEvent <~ ReconfigureLogging
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'recyclebincleanupdays' defaultValue:'7'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'maximumsize' defaultValue:'0'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'minimumage' defaultValue:'0'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'downloadpropersandrepacks' defaultValue:'PreferAndUpgrade'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'autoredownloadfailed' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'autoredownloadfailedfrominteractivesearch' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'deleteemptyfolders' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'filedate' defaultValue:'None'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'downloadclientworkingfolders' defaultValue:'_UNPACK_|_FAILED_'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'downloadclienthistorylimit' defaultValue:'60'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'skipfreespacecheckwhenimporting' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'minimumfreespacewhenimporting' defaultValue:'100'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'copyusinghardlinks' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'importextrafiles' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'extrafileextensions' defaultValue:'srt'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'watchlibraryforchanges' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'rescanafterrefresh' defaultValue:'Always'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'allowfingerprinting' defaultValue:'NewFiles'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'metadatasource' defaultValue:''
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'writeaudiotags' defaultValue:'No'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'scrubaudiotags' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'embedcoverart' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'firstdayofweek' defaultValue:'0'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'calendarweekcolumnheader' defaultValue:'ddd M/D'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'shortdateformat' defaultValue:'MMM D YYYY'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'longdateformat' defaultValue:'dddd, MMMM D YYYY'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'timeformat' defaultValue:'h(:mm)a'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'showrelativedates' defaultValue:'True'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'enablecolorimpairedmode' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'expandalbumbydefault' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'expandepbydefault' defaultValue:'False'
2024-05-21 20:10:53.7|Trace|ConfigService|Using default config value for 'expandsinglebydefault' defaultValue:'False'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'expandbroadcastbydefault' defaultValue:'False'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'expandotherbydefault' defaultValue:'False'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 20:10:53.8|Trace|EventAggregator|Publishing ConfigSavedEvent
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent -> RootFolderWatchingService
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'watchlibraryforchanges' defaultValue:'True'
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent <- RootFolderWatchingService
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent -> UiAuthorizationHandler
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent <- UiAuthorizationHandler
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent ~> LocalizationService
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent <~ LocalizationService
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent ~> TaskManager
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 20:10:53.8|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 20:10:53.8|Trace|EventAggregator|ConfigSavedEvent <~ TaskManager
2024-05-21 20:10:53.8|Trace|Http|Res: 13 [PUT] /api/v1/config/host: 202.Accepted (155 ms)
2024-05-21 20:10:53.8|Debug|Api|[PUT] /api/v1/config/host: 202.Accepted (155 ms)
2024-05-21 20:10:55.1|Trace|Scheduler|Pending Tasks: 6
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing Housekeeping
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: Housekeeping
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: Housekeeping
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing ImportListSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: ImportListSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: ImportListSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing ApplicationUpdateCheck
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: ApplicationUpdateCheck
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: ApplicationUpdateCheck
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing RssSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: RssSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: RssSync
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing RefreshArtist
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: RefreshArtist
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: RefreshArtist
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Publishing CheckHealth
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Checking if command is queued or started: CheckHealth
2024-05-21 20:10:55.2|Trace|CommandQueueManager|Command is already in progress: CheckHealth
2024-05-21 20:10:56.2|Trace|Http|Req: 14 [GET] /api/v1/health (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:56.2|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:56.2|Trace|Http|Res: 14 [GET] /api/v1/health: 200.OK (5 ms)
2024-05-21 20:10:56.2|Debug|Api|[GET] /api/v1/health: 200.OK (5 ms)
2024-05-21 20:10:56.2|Trace|Http|Req: 15 [GET] /api/v1/system/status (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:56.2|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:56.2|Trace|Http|Req: 16 [GET] /api/v1/diskspace (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:56.2|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:56.2|Trace|Http|Res: 15 [GET] /api/v1/system/status: 200.OK (15 ms)
2024-05-21 20:10:56.2|Debug|Api|[GET] /api/v1/system/status: 200.OK (15 ms)
2024-05-21 20:10:56.2|Debug|DiskProvider|path: /media/Music/
2024-05-21 20:10:56.2|Debug|DiskProvider|path: /
2024-05-21 20:10:56.3|Debug|DiskProvider|path: /media
2024-05-21 20:10:56.3|Trace|Http|Res: 16 [GET] /api/v1/diskspace: 200.OK (60 ms)
2024-05-21 20:10:56.3|Debug|Api|[GET] /api/v1/diskspace: 200.OK (60 ms)
2024-05-21 20:10:58.6|Trace|Http|Req: 17 [GET] /api/v1/update (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:58.6|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:58.6|Trace|Http|Req: 18 [GET] /api/v1/config/host (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:58.6|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 20:10:58.6|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 20:10:58.6|Trace|Http|Res: 18 [GET] /api/v1/config/host: 200.OK (7 ms)
2024-05-21 20:10:58.6|Debug|Api|[GET] /api/v1/config/host: 200.OK (7 ms)
2024-05-21 20:10:58.7|Trace|HealthCheckService|Check health -> UpdateCheck
2024-05-21 20:10:58.9|Trace|HttpClient|Req: [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true
2024-05-21 20:10:58.9|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:58.9|Trace|HttpClient|Res: HTTP/2.0 [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true: 200.OK (14011 bytes) (46 ms)
2024-05-21 20:10:58.9|Trace|Http|Res: 17 [GET] /api/v1/update: 200.OK (345 ms)
2024-05-21 20:10:58.9|Debug|Api|[GET] /api/v1/update: 200.OK (345 ms)
2024-05-21 20:10:59.0|Trace|HttpClient|Req: [GET] https://lidarr.servarr.com/v1/update/master?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&dbType=SQLite&active=true
2024-05-21 20:10:59.0|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:59.0|Trace|HttpClient|Res: HTTP/2.0 [GET] https://lidarr.servarr.com/v1/update/master?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&dbType=SQLite&active=true: 200.OK (1229 bytes) (40 ms)
2024-05-21 20:10:59.0|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health <- UpdateCheck
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health -> ApiKeyValidationCheck
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health <- ApiKeyValidationCheck
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health -> FpcalcCheck
2024-05-21 20:10:59.0|Trace|ConfigService|Using default config value for 'allowfingerprinting' defaultValue:'NewFiles'
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health <- FpcalcCheck
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health -> ImportMechanismCheck
2024-05-21 20:10:59.0|Trace|ConfigService|Using default config value for 'enablecompleteddownloadhandling' defaultValue:'True'
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health <- ImportMechanismCheck
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health -> ProxyCheck
2024-05-21 20:10:59.0|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:10:59.0|Trace|HealthCheckService|Check health <- ProxyCheck
2024-05-21 20:10:59.0|Trace|EventAggregator|Publishing HealthCheckCompleteEvent
2024-05-21 20:10:59.0|Trace|EventAggregator|HealthCheckCompleteEvent -> HealthController
2024-05-21 20:10:59.0|Trace|EventAggregator|HealthCheckCompleteEvent <- HealthController
2024-05-21 20:10:59.0|Trace|EventAggregator|HealthCheckCompleteEvent ~> NotificationService
2024-05-21 20:10:59.0|Trace|EventAggregator|HealthCheckCompleteEvent <~ NotificationService
2024-05-21 20:10:59.0|Trace|Http|Req: 19 [GET] /api/v1/health (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:10:59.0|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:10:59.0|Trace|Http|Res: 19 [GET] /api/v1/health: 200.OK (1 ms)
2024-05-21 20:10:59.0|Debug|Api|[GET] /api/v1/health: 200.OK (1 ms)
2024-05-21 20:11:01.6|Trace|Http|Req: 20 [GET] /system/updates (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.6|Trace|Http|Res: 20 [GET] /system/updates: 200.OK (54 ms)
2024-05-21 20:11:01.6|Trace|Http|Res: 2 [GET] /signalr/messages?access_token=(removed)&id=(removed) 101.SwitchingProtocols (35958 ms)
2024-05-21 20:11:01.7|Trace|Http|Req: 21 [GET] /initialize.json?t=1716322261681 (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.7|Trace|Http|Res: 21 [GET] /initialize.json?t=1716322261681: 200.OK (5 ms)
2024-05-21 20:11:01.8|Trace|Http|Req: 22 [GET] /api/v1/artist (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Trace|Http|Req: 23 [GET] /api/v1/customFilter (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Req: 24 [GET] /api/v1/tag (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Req: 25 [GET] /api/v1/language (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Req: 26 [GET] /api/v1/metadataprofile (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Trace|Http|Req: 27 [GET] /api/v1/qualityprofile (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Res: 25 [GET] /api/v1/language: 200.OK (8 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/language: 200.OK (8 ms)
2024-05-21 20:11:01.8|Trace|Http|Res: 24 [GET] /api/v1/tag: 200.OK (13 ms)
2024-05-21 20:11:01.8|Trace|Http|Res: 23 [GET] /api/v1/customFilter: 200.OK (15 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/customFilter: 200.OK (15 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/tag: 200.OK (13 ms)
2024-05-21 20:11:01.8|Trace|Http|Req: 28 [GET] /api/v1/importlist (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Req: 29 [GET] /api/v1/system/status (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|Http|Req: 30 [GET] /api/v1/config/ui (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'firstdayofweek' defaultValue:'0'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'calendarweekcolumnheader' defaultValue:'ddd M/D'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'shortdateformat' defaultValue:'MMM D YYYY'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'longdateformat' defaultValue:'dddd, MMMM D YYYY'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'timeformat' defaultValue:'h(:mm)a'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'showrelativedates' defaultValue:'True'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'enablecolorimpairedmode' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'expandalbumbydefault' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'expandsinglebydefault' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'expandepbydefault' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'expandbroadcastbydefault' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'expandotherbydefault' defaultValue:'False'
2024-05-21 20:11:01.8|Trace|Http|Res: 29 [GET] /api/v1/system/status: 200.OK (9 ms)
2024-05-21 20:11:01.8|Trace|Http|Res: 30 [GET] /api/v1/config/ui: 200.OK (8 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/system/status: 200.OK (9 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/config/ui: 200.OK (8 ms)
2024-05-21 20:11:01.8|Trace|Http|Req: 31 [GET] /api/v1/localization (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.8|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.8|Trace|ConfigService|Using default config value for 'uilanguage' defaultValue:'1'
2024-05-21 20:11:01.8|Trace|Http|Res: 31 [GET] /api/v1/localization: 200.OK (9 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/localization: 200.OK (9 ms)
2024-05-21 20:11:01.8|Trace|Http|Res: 27 [GET] /api/v1/qualityprofile: 200.OK (45 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/qualityprofile: 200.OK (45 ms)
2024-05-21 20:11:01.8|Trace|Http|Res: 26 [GET] /api/v1/metadataprofile: 200.OK (52 ms)
2024-05-21 20:11:01.8|Debug|Api|[GET] /api/v1/metadataprofile: 200.OK (52 ms)
2024-05-21 20:11:01.9|Trace|Http|Res: 28 [GET] /api/v1/importlist: 200.OK (58 ms)
2024-05-21 20:11:01.9|Debug|Api|[GET] /api/v1/importlist: 200.OK (58 ms)
2024-05-21 20:11:01.9|Trace|Http|Req: 32 [POST] /signalr/messages/negotiate?access_token=(removed)&negotiateVersion=1 (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: SignalR was successfully authenticated.
2024-05-21 20:11:01.9|Trace|Http|Res: 32 [POST] /signalr/messages/negotiate?access_token=(removed)&negotiateVersion=1: 200.OK (1 ms)
2024-05-21 20:11:01.9|Trace|Http|Req: 33 [GET] /api/v1/queue/status (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Trace|Http|Req: 34 [GET] /api/v1/health (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.9|Trace|Http|Res: 34 [GET] /api/v1/health: 200.OK (2 ms)
2024-05-21 20:11:01.9|Debug|Api|[GET] /api/v1/health: 200.OK (2 ms)
2024-05-21 20:11:01.9|Trace|Http|Req: 35 [GET] /api/v1/config/host (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:11:01.9|Trace|Http|Res: 33 [GET] /api/v1/queue/status: 200.OK (5 ms)
2024-05-21 20:11:01.9|Trace|Http|Req: 36 [GET] /api/v1/update (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Debug|Api|[GET] /api/v1/queue/status: 200.OK (5 ms)
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxytype' defaultValue:'Http'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxyhostname' defaultValue:''
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxyport' defaultValue:'8080'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxyusername' defaultValue:''
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxypassword' defaultValue:''
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxybypassfilter' defaultValue:''
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'proxybypasslocaladdresses' defaultValue:'True'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'certificatevalidation' defaultValue:'Enabled'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'backupfolder' defaultValue:'Backups'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'backupinterval' defaultValue:'7'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'backupretention' defaultValue:'28'
2024-05-21 20:11:01.9|Trace|ConfigService|Using default config value for 'applicationurl' defaultValue:''
2024-05-21 20:11:01.9|Trace|Http|Req: 37 [GET] /signalr/messages?access_token=(removed)&id=(removed) (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:01.9|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: SignalR was successfully authenticated.
2024-05-21 20:11:01.9|Trace|Http|Res: 35 [GET] /api/v1/config/host: 200.OK (6 ms)
2024-05-21 20:11:01.9|Debug|Api|[GET] /api/v1/config/host: 200.OK (6 ms)
2024-05-21 20:11:02.2|Trace|HttpClient|Req: [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true
2024-05-21 20:11:02.2|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
2024-05-21 20:11:02.2|Trace|HttpClient|Res: HTTP/2.0 [GET] https://lidarr.servarr.com/v1/update/master/changes?version=2.1.7.4030&os=linux&arch=X64&runtime=netcore&runtimeVer=6.0.25&prevVersion=2.0.7.3849&active=true: 200.OK (14011 bytes) (33 ms)
2024-05-21 20:11:02.2|Trace|Http|Res: 36 [GET] /api/v1/update: 200.OK (302 ms)
2024-05-21 20:11:02.2|Debug|Api|[GET] /api/v1/update: 200.OK (302 ms)
2024-05-21 20:11:02.7|Trace|Http|Res: 22 [GET] /api/v1/artist: 200.OK (915 ms)
2024-05-21 20:11:02.7|Debug|Api|[GET] /api/v1/artist: 200.OK (915 ms)
2024-05-21 20:11:03.1|Trace|Http|Req: 38 [POST] /api/v1/command (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:03.1|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Publishing ApplicationUpdate
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Checking if command is queued or started: ApplicationUpdate
2024-05-21 20:11:03.1|Trace|CommandQueueManager|Command is already in progress: ApplicationUpdate
2024-05-21 20:11:03.1|Trace|Http|Res: 38 [POST] /api/v1/command: 201.Created (43 ms)
2024-05-21 20:11:03.1|Debug|Api|[POST] /api/v1/command: 201.Created (43 ms)
2024-05-21 20:11:09.4|Trace|Http|Req: 39 [GET] /api/v1/log/file (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)
2024-05-21 20:11:09.4|Debug|Lidarr.Http.Authentication.ApiKeyAuthenticationHandler|AuthenticationScheme: API was successfully authenticated.
2024-05-21 20:11:09.4|Trace|Http|Res: 39 [GET] /api/v1/log/file: 200.OK (10 ms)
2024-05-21 20:11:09.4|Debug|Api|[GET] /api/v1/log/file: 200.OK (10 ms)
2024-05-21 20:11:11.4|Trace|Http|Req: 40 [GET] /logfile/lidarr.trace.txt (from 192.168.200.147 Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36)```

@bakerboy448
Copy link
Contributor

So the update task is running. Anything after that?
Weird...

f12 browser dev console & network calls, anything breaking/erroring?

Quick and dirty workaround would be to just re-install in place and upgrade existing. Functionally the same thing the upgraded does

PS don't use the restart button in the UI it's less than great

@Normanras
Copy link
Author

Good to know about that restart button. I figured the answer to this was just a reinstall, but before I did that I at least wanted to post and see if I was missing something.

Only interesting thing in the network tab is a pending websocket for ws://192.168.200.42:8686/signalr/messages?access_token=token-id&id=id. I removed the random string for access token and id. Under that, it looks like createAjaxRequest.js tries to send api/v1/command every 30-60 seconds. If I leave the page it adds "command" to the network list. All are 200 responses. Here's a screenshot:
Screenshot 2024-05-21 at 5 29 34 PM

I've left the page open in case you want me to look into any specific there.

@bakerboy448
Copy link
Contributor

Hmm yeah. Okay one more thing and if we don't get anything out of it, I'd say blame this on gremlins and just re-install. Can re-visit if others see it or it reoccurs.

  • shutdown radarr via systemd
  • Start radarr
  • Clear logs
  • Install Update
  • Wait a few min and pull logs
  • also check System => Tasks => and see what's queued up, screenshot works

@Normanras
Copy link
Author

Yeah, I'm just going to reinstall. Didn't think to look at the tasks but the fact that some things show 20 days ago and other things in the queue with 2 months ago makes it seem something wonky is going on.
Screenshot 2024-05-21 at 5 42 15 PM

Always a bit nervous to reinstall, but that's how it goes. Thanks for your help bakerboy!

@bakerboy448 bakerboy448 closed this as not planned Won't fix, can't repro, duplicate, stale May 21, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Status: Logs Needed Logs are needed to proceed with this issue Status: Needs Triage New Issue needing triage Status: Waiting for OP Action Required from OP Type: Bug Issue is a bug
Projects
None yet
Development

No branches or pull requests

2 participants