======== felhom-pve (guest 9201) — night 2026-09-27/28, controller log 00:25Z–07:30Z (UTC; CEST = +2)
-- agent (host) whole-guest backups:
Sep 28 07:37:08 demo-felhom felhom-agent[2880126]: time=2026-09-28T07:37:08.524+02:00 level=INFO msg="janitor: stale-lock sweep deferred — a heavy operation is in flight" busy=backup:felhom-backup
Sep 28 07:37:50 demo-felhom felhom-agent[2880126]: time=2026-09-28T07:37:50.932+02:00 level=INFO msg="backup: completed" vmid=9201 target=felhom-backup archive=felhom-backup:backup/vzdump-lxc-9201-2026_09_28-07_36_39.tar.zst size_bytes=2868142737 uncovered_vol
Sep 28 07:37:50 demo-felhom felhom-agent[2880126]: time=2026-09-28T07:37:50.932+02:00 level=INFO msg="local-api: backup job complete" vmid=9201 target=felhom-backup job=backup-9201-1790573799307855304 archive=felhom-backup:backup/vzdump-lxc-9201-2026_09_28-07_
Sep 28 08:07:07 demo-felhom felhom-agent[2880126]: time=2026-09-28T08:07:07.696+02:00 level=INFO msg="backup: restore-test tier is DUE (per-archive; oldest-proven first among due tiers)" target=felhom-backup archive=felhom-backup:backup/vzdump-lxc-9201-2026_09
Sep 28 08:07:08 demo-felhom felhom-agent[2880126]: time=2026-09-28T08:07:08.522+02:00 level=INFO msg="janitor: stale-lock sweep deferred — a heavy operation is in flight" busy=restore-test
Sep 28 08:08:36 demo-felhom felhom-agent[2880126]: time=2026-09-28T08:08:36.439+02:00 level=INFO msg="audit: gate decision" class=guest_destroy host=demo-felhom-8363b5 guest=990000 source=one_shot_job disposition=benign allowed=true reason=benign key_id="" non
Sep 28 08:08:36 demo-felhom felhom-agent[2880126]: time=2026-09-28T08:08:36.439+02:00 level=INFO msg="gate decision" class=guest_destroy guest=990000 source=one_shot_job disposition=benign allowed=true reason=benign
Sep 28 08:08:42 demo-felhom felhom-agent[2880126]: time=2026-09-28T08:08:42.485+02:00 level=INFO msg="backup: scheduled restore-test passed" archive=felhom-backup:backup/vzdump-lxc-9201-2026_09_27-07_35_21.tar.zst duration_s=94.787284561
======== demo-hp (guest 9201) — night 2026-09-27/28, controller log 00:25Z–07:30Z (UTC; CEST = +2)
-- agent (host) whole-guest backups:
Sep 28 02:13:18 demo-hp felhom-agent[1370926]: time=2026-09-28T02:13:18.401+02:00 level=INFO msg="janitor: stale-lock sweep deferred — a heavy operation is in flight" busy=restore-test
Sep 28 04:43:18 demo-hp felhom-agent[1370926]: time=2026-09-28T04:43:18.400+02:00 level=INFO msg="janitor: stale-lock sweep deferred — a heavy operation is in flight" busy=backup:local
Sep 28 04:44:58 demo-hp felhom-agent[1370926]: time=2026-09-28T04:44:58.683+02:00 level=INFO msg="backup: completed" vmid=9201 target=local archive=local:backup/vzdump-lxc-9201-2026_09_28-04_37_06.tar.zst size_bytes=8825181955 uncovered_volumes=2
Sep 28 04:44:58 demo-hp felhom-agent[1370926]: time=2026-09-28T04:44:58.683+02:00 level=INFO msg="local-api: backup job complete" vmid=9201 target=local job=backup-9201-1790563025947283530 archive=local:backup/vzdump-lxc-9201-2026_09_28-04_37_06.tar.zst
Sep 28 08:13:18 demo-hp felhom-agent[1370926]: time=2026-09-28T08:13:18.401+02:00 level=INFO msg="janitor: stale-lock sweep deferred — a heavy operation is in flight" busy=restore-test
======== felhom-pve 9201 — debug-ring.log, night 2026-09-28 00:25Z–07:30Z
-rw-r--r-- 1 root root 632864 Sep 28 13:52 /var/lib/docker/volumes/felhom-controller-data/_data/data/debug-ring.log
{"timestamp":"2026-09-28T09:27:04Z","level":"INFO","message":"[scheduler] Running job: offsite-credential-retry","source":""}
{"timestamp":"2026-09-28T09:27:04Z","level":"INFO","message":"[scheduler] Job offsite-credential-retry completed (took 0s)","source":""}
======== demo-hp 9201 — debug-ring.log, night 2026-09-28 00:25Z–07:30Z
-rw-r--r-- 1 root root 902237 Sep 28 13:52 /var/lib/docker/volumes/felhom-controller-data/_data/data/debug-ring.log
{"timestamp":"2026-09-28T13:36:07Z","level":"DEBUG","message":"[report] BuildReport: complete — containers=23, health=ok, deployed=11, available=42, app_telemetry=12","source":"builder.go:201"}
{"timestamp":"2026-09-28T13:36:07Z","level":"DEBUG","message":"[report] Push: url=https://hub.felhom.eu/2026/09/28 02:30:00 [INFO] Event from demo-felhom: db_dump_completed (info) — Adatbázis mentés elkészült
2026/09/28 02:32:04 [INFO] Event from demo-hp: db_dump_completed (info) — Adatbázis mentés elkészült
2026/09/28 03:30:00 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: adventurelog
2026/09/28 03:30:00 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: bentopdf
2026/09/28 03:30:01 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: bookstack
2026/09/28 03:30:01 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: calibre-web
2026/09/28 03:30:01 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: docmost
2026/09/28 03:30:02 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: kimai
2026/09/28 03:30:02 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: opengist
2026/09/28 03:30:05 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: paperless-ngx
2026/09/28 03:30:05 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: privatebin
2026/09/28 03:30:06 [INFO] Event from demo-hp: crossdrive_completed (info) — Másodlagos mentés elkészült: romm
2026/09/28 06:00:35 [INFO] Event from demo-felhom: backup_integrity_ok (info) — A távoli mentés ellenőrzése rendben lezajlott. (33s, a mentett adatok 100%-át újraolvasva)

## SUMMARY — Part D2, read 2026-09-28 ~16:00 CEST for the night 2026-09-27/28 (not a later night: the operator asked
## to finish in the day). Sources, and why three: both controllers restarted at 10:11 and 15:36 (floor 0.277.0, 0.278.0),
## which dropped their docker logs, and the persisted debug ring starts after the restarts. So: (1) the agents' journals
## (above), (2) the hub's event log (above), (3) the demo-hp controller lines copied at 10:05 CEST, BEFORE the restarts
## (phaseD2-paperless-demo-hp.txt) and demo-hp's settings.json off-site record read at 09:30 CEST.
##
## demo-hp (W = 02:30 CEST):
##   02:32 db_dump_completed (hub event) · 03:30 crossdrive_completed ×10 (hub events) · off-site last_run 02:18:38Z =
##   04:18 CEST, status ok, 90 snapshots (settings) · update leg: paperless-ngx 16 → 18 04:22:44–04:23:54 CEST, "step
##   ended done after 70.1 s" (controller, copied before the restart) · whole-guest local backup 04:37:06 → completed
##   04:44:58 (agent), i.e. AFTER the gate opened (W+2h = 04:30) and after the leg ended → the gate had nothing to wait
##   for. R-687 item (4) (the gate waiting on a running leg) did NOT occur again.
## demo-felhom (W = 02:30 CEST):
##   02:30 db_dump_completed (hub event) · whole-guest backup to felhom-backup 07:36:39 → 07:37:50 (agent) · 06:00 off-site
##   integrity ok (hub event) · off-site leg and update leg: NOT READABLE (controller log dropped by today's restarts; no
##   hub event is sent for a successful off-site run or an update-leg step). Recorded as not read, not as fine.
## R-701 side finding: every refused restore test reaches the hub — "[WARN] host demo-hp-bb76ea restore-test FAILED …
##   needs 31.0 GiB free, has 21.1 GiB" at each host-report (every 15 min).
