Near 1000 lines written… plus ten (10) more multi-line, supposed log files and I haven’t even taken a snapshot. Almost ten years and this software still defaults to ‘debug.’
$HOME/.cache/kopia/cli-logs/kopia-20250320-064117-220796-server-start.0.log
2025-03-20T06:41:17.469576Z INFO kopia/cli
Server will allow connections from users whose accounts are stored in the repository.
User accounts can be added using 'kopia server user add'.
2025-03-20T06:41:17.472158Z INFO kopia/server Repository not configured.
2025-03-20T06:41:17.487688Z INFO kopia/cli Server will close when stdin is closed...
2025-03-20T06:41:17.489453Z DEBUG tls generating new TLS certificate
2025-03-20T06:41:20.804068Z DEBUG tls adding alternative IP to certificate: 127.0.0.1
2025-03-20T06:41:20.817598Z INFO kopia/cli Open the address above in a web browser to use the UI.
2025-03-20T06:48:23.367259Z DEBUG kopia/repo Creating cache directory '/home/user/.cache/kopia/9c1e8ae1881b8403' with max size 5242880000
2025-03-20T06:48:23.634200Z DEBUG kopia/repo throttling limits from connection info {"limits":{}}
2025-03-20T06:48:23.634800Z DEBUG cache finished initial cache scan {"cache":"contents","duration":"60.639µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.634984Z DEBUG cache finished initial cache scan {"cache":"metadata","duration":"39.32µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.635198Z DEBUG cache finished initial cache scan {"cache":"index-blobs","duration":"31.792µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.644087Z DEBUG passwordpersist Saving password to file /home/user/.config/kopia/repository.config.kopia-password.
2025-03-20T06:48:23.846304Z DEBUG kopia/repo throttling limits from connection info {"limits":{}}
2025-03-20T06:48:23.846609Z DEBUG cache finished initial cache scan {"cache":"contents","duration":"79.604µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.846757Z DEBUG cache finished initial cache scan {"cache":"metadata","duration":"70.348µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.846894Z DEBUG cache finished initial cache scan {"cache":"index-blobs","duration":"51.304µs","totalRetainedSize":0,"tooRecentBytes":0,"tooRecentCount":0,"maxSizeBytes":5242880000,"limitBytes":0,"inUsePercent":0}
2025-03-20T06:48:23.853406Z DEBUG kopia/server starting maintenance manager
2025-03-20T06:48:23.853535Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T03:48:23-06:00)
2025-03-20T06:48:23.853585Z DEBUG scheduler 2025-03-20T07:41:17-06:00 refresh
2025-03-20T06:48:23.853594Z DEBUG scheduler sleeping for 3h52m53.616236164s until 2025-03-20T07:41:17-06:00 (refresh)
2025-03-20T06:48:23.853600Z DEBUG scheduler schedule re-evaluation requested {"reason":"sources refreshed"}
2025-03-20T06:48:23.853607Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T03:48:23-06:00)
2025-03-20T06:48:23.853611Z DEBUG scheduler 2025-03-20T07:41:17-06:00 refresh
2025-03-20T06:48:23.853615Z DEBUG scheduler sleeping for 3h52m53.616137256s until 2025-03-20T07:41:17-06:00 (refresh)
2025-03-20T10:41:17.469868Z DEBUG scheduler triggering refresh
2025-03-20T10:41:17.469952Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T07:41:17-06:00)
2025-03-20T10:41:17.469962Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T10:41:17.469982Z DEBUG scheduler sleeping for 3h59m59.999982155s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T10:41:17.700008Z DEBUG scheduler schedule re-evaluation requested {"reason":"sources refreshed"}
2025-03-20T10:41:17.700532Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T07:41:17-06:00)
2025-03-20T10:41:17.700585Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T10:41:17.700596Z DEBUG scheduler 2025-03-20T07:41:17-06:00 maintenance
2025-03-20T10:41:17.700609Z DEBUG scheduler sleeping for 485.23µs until 2025-03-20T07:41:17-06:00 (maintenance)
2025-03-20T10:41:17.701691Z DEBUG scheduler triggering maintenance
2025-03-20T10:41:17.701727Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T07:41:17-06:00)
2025-03-20T10:41:17.701735Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T10:41:17.701744Z DEBUG scheduler sleeping for 3h59m59.768253716s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T10:41:17.701745Z DEBUG kopia/server starting maintenance task
2025-03-20T10:41:17.702562Z DEBUG - due for full maintenance cycle
2025-03-20T10:41:17.702611Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T10:41:17.703216Z DEBUG - scheduling next full cycle at 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T10:41:17.703243Z DEBUG - scheduling next quick cycle at 2025-03-20 08:41:17.70321101 -0300 ADT
2025-03-20T10:41:17.707158Z INFO - Running full maintenance...
2025-03-20T10:41:17.734867Z INFO - Looking for active contents...
2025-03-20T10:41:17.734951Z INFO - Looking for unreferenced contents...
2025-03-20T10:41:17.735063Z INFO - GC found 0 unused contents (0 B)
2025-03-20T10:41:17.735084Z INFO - GC found 0 unused contents that are too recent to delete (0 B)
2025-03-20T10:41:17.735100Z INFO - GC found 0 in-use contents (0 B)
2025-03-20T10:41:17.735118Z INFO - GC found 1 in-use system-contents (0.9 KB)
2025-03-20T10:41:17.737556Z INFO - Rewriting contents from short packs...
2025-03-20T10:41:17.737723Z INFO - Total bytes rewritten 0 B
2025-03-20T10:41:17.739773Z INFO - Not enough time has passed since previous successful Snapshot GC. Will try again next time.
2025-03-20T10:41:17.739852Z INFO - Skipping blob deletion because not enough time has passed yet (59m59s left).
2025-03-20T10:41:17.739888Z DEBUG - Extending object lock retention-period is disabled.
2025-03-20T10:41:17.739918Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T10:41:17.741741Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T10:41:17.743719Z INFO - Attempting to compact a range of epoch indexes ...
2025-03-20T10:41:17.745725Z INFO - Cleaning up unneeded epoch markers...
2025-03-20T10:41:17.747714Z INFO - Cleaning up old index blobs which have already been compacted...
2025-03-20T10:41:17.756892Z DEBUG - Keeping 0 logs of total size 0 B
2025-03-20T10:41:17.756973Z INFO - Cleaned up 0 logs.
2025-03-20T10:41:17.758769Z INFO - Finished full maintenance.
2025-03-20T10:41:17.759638Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T10:41:17.759677Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T07:41:17-06:00)
2025-03-20T10:41:17.759685Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T10:41:17.759692Z DEBUG scheduler 2025-03-20T08:41:17-06:00 maintenance
2025-03-20T10:41:17.759702Z DEBUG scheduler sleeping for 59m59.94355066s until 2025-03-20T08:41:17-06:00 (maintenance)
2025-03-20T11:41:17.707884Z DEBUG scheduler triggering maintenance
2025-03-20T11:41:17.711148Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T08:41:17-06:00)
2025-03-20T11:41:17.711157Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T11:41:17.711164Z DEBUG scheduler sleeping for 2h59m59.75883645s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T11:41:17.711214Z DEBUG kopia/server starting maintenance task
2025-03-20T11:41:17.750242Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T11:41:17.754480Z DEBUG - due for quick maintenance cycle
2025-03-20T11:41:17.754508Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T11:41:17.755403Z DEBUG - scheduling next quick cycle at 2025-03-20 08:41:17.70321101 -0300 ADT
2025-03-20T11:41:17.763960Z INFO - Running quick maintenance...
2025-03-20T11:41:17.821237Z DEBUG - running quick epoch maintenance only
2025-03-20T11:41:17.821268Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T11:41:17.824132Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T11:41:17.827625Z INFO - Finished quick maintenance.
2025-03-20T11:41:17.829065Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T11:41:17.829084Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T08:41:17-06:00)
2025-03-20T11:41:17.829098Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T11:41:17.829102Z DEBUG scheduler 2025-03-20T09:41:17-06:00 maintenance
2025-03-20T11:41:17.829107Z DEBUG scheduler sleeping for 59m59.926365604s until 2025-03-20T09:41:17-06:00 (maintenance)
2025-03-20T12:41:17.755570Z DEBUG scheduler triggering maintenance
2025-03-20T12:41:17.755645Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T09:41:17-06:00)
2025-03-20T12:41:17.755653Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T12:41:17.755662Z DEBUG scheduler sleeping for 1h59m59.714348846s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T12:41:17.755673Z DEBUG kopia/server starting maintenance task
2025-03-20T12:41:17.779353Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T12:41:17.780165Z DEBUG - due for quick maintenance cycle
2025-03-20T12:41:17.780195Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T12:41:17.781120Z DEBUG - scheduling next quick cycle at 2025-03-20 09:41:17.755445502 -0300 ADT
2025-03-20T12:41:17.786610Z INFO - Running quick maintenance...
2025-03-20T12:41:17.834429Z DEBUG - running quick epoch maintenance only
2025-03-20T12:41:17.834459Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T12:41:17.837955Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T12:41:17.841441Z INFO - Finished quick maintenance.
2025-03-20T12:41:17.842886Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T12:41:17.842903Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T09:41:17-06:00)
2025-03-20T12:41:17.842908Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T12:41:17.842911Z DEBUG scheduler 2025-03-20T10:41:17-06:00 maintenance
2025-03-20T12:41:17.842917Z DEBUG scheduler sleeping for 59m59.938255933s until 2025-03-20T10:41:17-06:00 (maintenance)
2025-03-20T13:41:17.781894Z DEBUG scheduler triggering maintenance
2025-03-20T13:41:17.781973Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T10:41:17-06:00)
2025-03-20T13:41:17.781980Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T13:41:17.781989Z DEBUG scheduler sleeping for 59m59.6880194s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T13:41:17.781998Z DEBUG kopia/server starting maintenance task
2025-03-20T13:41:17.802859Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T13:41:17.802922Z DEBUG - due for quick maintenance cycle
2025-03-20T13:41:17.802935Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T13:41:17.804142Z DEBUG - scheduling next quick cycle at 2025-03-20 10:41:17.78115502 -0300 ADT
2025-03-20T13:41:17.809480Z INFO - Running quick maintenance...
2025-03-20T13:41:17.844070Z DEBUG - running quick epoch maintenance only
2025-03-20T13:41:17.844098Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T13:41:17.847571Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T13:41:17.850378Z INFO - Finished quick maintenance.
2025-03-20T13:41:17.851799Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T13:41:17.851823Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T10:41:17-06:00)
2025-03-20T13:41:17.851829Z DEBUG scheduler 2025-03-20T11:41:17-06:00 refresh
2025-03-20T13:41:17.851835Z DEBUG scheduler 2025-03-20T11:41:17-06:00 maintenance
2025-03-20T13:41:17.851843Z DEBUG scheduler sleeping for 59m59.618158143s until 2025-03-20T11:41:17-06:00 (refresh)
2025-03-20T14:41:17.470041Z DEBUG scheduler triggering refresh
2025-03-20T14:41:17.473222Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T11:41:17-06:00)
2025-03-20T14:41:17.473254Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T14:41:17.473261Z DEBUG scheduler 2025-03-20T11:41:17-06:00 maintenance
2025-03-20T14:41:17.473270Z DEBUG scheduler sleeping for 330.969275ms until 2025-03-20T11:41:17-06:00 (maintenance)
2025-03-20T14:41:17.539671Z DEBUG scheduler schedule re-evaluation requested {"reason":"sources refreshed"}
2025-03-20T14:41:17.540930Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T11:41:17-06:00)
2025-03-20T14:41:17.540942Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T14:41:17.540947Z DEBUG scheduler 2025-03-20T11:41:17-06:00 maintenance
2025-03-20T14:41:17.540952Z DEBUG scheduler sleeping for 264.497036ms until 2025-03-20T11:41:17-06:00 (maintenance)
2025-03-20T14:41:17.806327Z DEBUG scheduler triggering maintenance
2025-03-20T14:41:17.806368Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T11:41:17-06:00)
2025-03-20T14:41:17.806374Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T14:41:17.806382Z DEBUG scheduler sleeping for 3h59m59.666931681s until 2025-03-20T15:41:17-06:00 (refresh)
2025-03-20T14:41:17.806391Z DEBUG kopia/server starting maintenance task
2025-03-20T14:41:17.808600Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T14:41:17.808635Z DEBUG - due for quick maintenance cycle
2025-03-20T14:41:17.808646Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T14:41:17.809800Z DEBUG - scheduling next quick cycle at 2025-03-20 11:41:17.804181121 -0300 ADT
2025-03-20T14:41:17.815913Z INFO - Running quick maintenance...
2025-03-20T14:41:17.827981Z DEBUG - running quick epoch maintenance only
2025-03-20T14:41:17.828006Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T14:41:17.830859Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T14:41:17.834337Z INFO - Finished quick maintenance.
2025-03-20T14:41:17.835738Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T14:41:17.835766Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T11:41:17-06:00)
2025-03-20T14:41:17.835772Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T14:41:17.835776Z DEBUG scheduler 2025-03-20T12:41:17-06:00 maintenance
2025-03-20T14:41:17.835793Z DEBUG scheduler sleeping for 59m59.97407658s until 2025-03-20T12:41:17-06:00 (maintenance)
2025-03-20T15:41:17.810482Z DEBUG scheduler triggering maintenance
2025-03-20T15:41:17.810578Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T12:41:17-06:00)
2025-03-20T15:41:17.810587Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T15:41:17.810595Z DEBUG scheduler sleeping for 2h59m59.662721922s until 2025-03-20T15:41:17-06:00 (refresh)
2025-03-20T15:41:17.810596Z DEBUG kopia/server starting maintenance task
2025-03-20T15:41:17.832158Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T15:41:17.832207Z DEBUG - due for quick maintenance cycle
2025-03-20T15:41:17.832221Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T15:41:17.833343Z DEBUG - scheduling next quick cycle at 2025-03-20 12:41:17.809839343 -0300 ADT
2025-03-20T15:41:17.838694Z INFO - Running quick maintenance...
2025-03-20T15:41:17.874572Z DEBUG - running quick epoch maintenance only
2025-03-20T15:41:17.874604Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T15:41:17.878185Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T15:41:17.880958Z INFO - Finished quick maintenance.
2025-03-20T15:41:17.882318Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T15:41:17.882334Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T12:41:17-06:00)
2025-03-20T15:41:17.882339Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T15:41:17.882343Z DEBUG scheduler 2025-03-20T13:41:17-06:00 maintenance
2025-03-20T15:41:17.882348Z DEBUG scheduler sleeping for 59m59.951050332s until 2025-03-20T13:41:17-06:00 (maintenance)
2025-03-20T16:41:17.833507Z DEBUG scheduler triggering maintenance
2025-03-20T16:41:17.833573Z DEBUG kopia/server starting maintenance task
2025-03-20T16:41:17.833570Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T13:41:17-06:00)
2025-03-20T16:41:17.833622Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T16:41:17.833632Z DEBUG scheduler sleeping for 1h59m59.639729001s until 2025-03-20T15:41:17-06:00 (refresh)
2025-03-20T16:41:17.855320Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T16:41:17.855375Z DEBUG - due for quick maintenance cycle
2025-03-20T16:41:17.855390Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T16:41:17.856532Z DEBUG - scheduling next quick cycle at 2025-03-20 13:41:17.833381321 -0300 ADT
2025-03-20T16:41:17.861883Z INFO - Running quick maintenance...
2025-03-20T16:41:17.895789Z DEBUG - running quick epoch maintenance only
2025-03-20T16:41:17.895829Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T16:41:17.899226Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T16:41:17.902022Z INFO - Finished quick maintenance.
2025-03-20T16:41:17.903412Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T16:41:17.903431Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T13:41:17-06:00)
2025-03-20T16:41:17.903444Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T16:41:17.903449Z DEBUG scheduler 2025-03-20T14:41:17-06:00 maintenance
2025-03-20T16:41:17.903455Z DEBUG scheduler sleeping for 59m59.953135469s until 2025-03-20T14:41:17-06:00 (maintenance)
2025-03-20T17:41:17.856958Z DEBUG scheduler triggering maintenance
2025-03-20T17:41:17.857020Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T14:41:17-06:00)
2025-03-20T17:41:17.857031Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T17:41:17.857030Z DEBUG kopia/server starting maintenance task
2025-03-20T17:41:17.857042Z DEBUG scheduler sleeping for 59m59.616271399s until 2025-03-20T15:41:17-06:00 (refresh)
2025-03-20T17:41:17.877948Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T17:41:17.877997Z DEBUG - due for quick maintenance cycle
2025-03-20T17:41:17.878011Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T17:41:17.879283Z DEBUG - scheduling next quick cycle at 2025-03-20 14:41:17.856563111 -0300 ADT
2025-03-20T17:41:17.884707Z INFO - Running quick maintenance...
2025-03-20T17:41:17.917297Z DEBUG - running quick epoch maintenance only
2025-03-20T17:41:17.917335Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T17:41:17.920611Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T17:41:17.924172Z INFO - Finished quick maintenance.
2025-03-20T17:41:17.925517Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T17:41:17.925537Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T14:41:17-06:00)
2025-03-20T17:41:17.925542Z DEBUG scheduler 2025-03-20T15:41:17-06:00 refresh
2025-03-20T17:41:17.925546Z DEBUG scheduler 2025-03-20T15:41:17-06:00 maintenance
2025-03-20T17:41:17.925561Z DEBUG scheduler sleeping for 59m59.547751842s until 2025-03-20T15:41:17-06:00 (refresh)
2025-03-20T18:41:17.473426Z DEBUG scheduler triggering refresh
2025-03-20T18:41:17.473508Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T15:41:17-06:00)
2025-03-20T18:41:17.473517Z DEBUG scheduler 2025-03-20T19:41:17-06:00 refresh
2025-03-20T18:41:17.473522Z DEBUG scheduler 2025-03-20T15:41:17-06:00 maintenance
2025-03-20T18:41:17.473529Z DEBUG scheduler sleeping for 405.819507ms until 2025-03-20T15:41:17-06:00 (maintenance)
2025-03-20T18:41:17.546424Z DEBUG scheduler schedule re-evaluation requested {"reason":"sources refreshed"}
2025-03-20T18:41:17.547344Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T15:41:17-06:00)
2025-03-20T18:41:17.547366Z DEBUG scheduler 2025-03-20T19:41:17-06:00 refresh
2025-03-20T18:41:17.547371Z DEBUG scheduler 2025-03-20T15:41:17-06:00 maintenance
2025-03-20T18:41:17.547377Z DEBUG scheduler sleeping for 332.875245ms until 2025-03-20T15:41:17-06:00 (maintenance)
2025-03-20T18:41:17.880697Z DEBUG scheduler triggering maintenance
2025-03-20T18:41:17.880749Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T15:41:17-06:00)
2025-03-20T18:41:17.880756Z DEBUG scheduler 2025-03-20T19:41:17-06:00 refresh
2025-03-20T18:41:17.880763Z DEBUG scheduler sleeping for 3h59m59.592782907s until 2025-03-20T19:41:17-06:00 (refresh)
2025-03-20T18:41:17.880771Z DEBUG kopia/server starting maintenance task
2025-03-20T18:41:17.882253Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T18:41:17.882294Z DEBUG - due for quick maintenance cycle
2025-03-20T18:41:17.882306Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T18:41:17.883454Z DEBUG - scheduling next quick cycle at 2025-03-20 15:41:17.879312085 -0300 ADT
2025-03-20T18:41:17.889036Z INFO - Running quick maintenance...
2025-03-20T18:41:17.901746Z DEBUG - running quick epoch maintenance only
2025-03-20T18:41:17.901771Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T18:41:17.905206Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T18:41:17.908016Z INFO - Finished quick maintenance.
2025-03-20T18:41:17.909409Z DEBUG scheduler schedule re-evaluation requested {"reason":"maintenance schedule changed"}
2025-03-20T18:41:17.909428Z DEBUG scheduler >>>> scheduling 2 items (now 2025-03-20T15:41:17-06:00)
2025-03-20T18:41:17.909434Z DEBUG scheduler 2025-03-20T19:41:17-06:00 refresh
2025-03-20T18:41:17.909449Z DEBUG scheduler 2025-03-20T16:41:17-06:00 maintenance
2025-03-20T18:41:17.909454Z DEBUG scheduler sleeping for 59m59.97407328s until 2025-03-20T16:41:17-06:00 (maintenance)
2025-03-20T19:41:17.884555Z DEBUG scheduler triggering maintenance
2025-03-20T19:41:17.884653Z DEBUG scheduler >>>> scheduling 1 items (now 2025-03-20T16:41:17-06:00)
2025-03-20T19:41:17.884661Z DEBUG scheduler 2025-03-20T19:41:17-06:00 refresh
2025-03-20T19:41:17.884669Z DEBUG scheduler sleeping for 2h59m59.588889463s until 2025-03-20T19:41:17-06:00 (refresh)
2025-03-20T19:41:17.884679Z DEBUG kopia/server starting maintenance task
2025-03-20T19:41:17.919838Z DEBUG - not due for full maintenance cycle until 2025-03-21 07:41:17.703210824 -0300 ADT
2025-03-20T19:41:17.919901Z DEBUG - due for quick maintenance cycle
2025-03-20T19:41:17.919915Z DEBUG - Acquiring maintenance lock in file /home/user/.config/kopia/repository.config.mlock
2025-03-20T19:41:17.921165Z DEBUG - scheduling next quick cycle at 2025-03-20 16:41:17.883496959 -0300 ADT
2025-03-20T19:41:17.926525Z INFO - Running quick maintenance...
2025-03-20T19:41:17.960821Z DEBUG - running quick epoch maintenance only
2025-03-20T19:41:17.960847Z INFO - Compacting an eligible uncompacted epoch...
2025-03-20T19:41:17.964419Z INFO - Cleaning up no-longer-needed epoch markers...
2025-03-20T19:41:17.967165Z INFO - Finished quick maintenance.
[...]