tribuchet: building on eliza
[0.00s] Machine state will be reset. To keep it, pass --keep-machine-state
[0.00s] start all VLans
[1.71s] (finished: start all VLans, in 1.71 seconds)
[1.71s] start vhost-device-vsock
[1.71s] (finished: start vhost-device-vsock, in 0.00 seconds)
[1.71s] Test will time out and terminate in 600.0 seconds
[1.72s] run the VM test script
[1.72s] start all VMs
[1.75s] host1: starting vm
[1.75s] server: starting vm
server # Disk image does not exist, creating the virtualisation disk image...
[32.65s] server: QEMU running (pid 55)
server # Formatting '/build/vm-state-server/tmp.02p0n0dsS7', fmt=raw size=1073741824
server # mke2fs 1.47.4 (6-Mar-2025)
server # Discarding device blocks:      0/262144             done
server # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Filesystem UUID: e3c75a17-bc91-478b-8b8d-7f3094cf4b32
server # Superblock backups stored on blocks:
server # 	32768, 98304, 163840, 229376
server # 
server # Allocating group tables: 0/8   done
server # Writing inode tables: 0/8   done
server # Creating journal (8192 blocks): done
server # Writing superblocks and filesystem accounting information: 0/8   done
server # 
server # Virtualisation disk image created.
server # Starting virtiofs daemons...
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-12T10:11:45Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-12T10:11:45Z INFO  virtiofsd] Client connected, servicing requests
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
server # [    0.000000] Linux version 6.18.60 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1793362001
server # [    0.000000] KASLR enabled
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]
server # [    0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]
server # [    0.000000] Zone ranges:
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000bfffffff]
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   empty
server # [    0.000000]   Device   empty
server # [    0.000000] Movable zone start for each node
server # [    0.000000] Early memory node ranges
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000bfffffff]
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.1
server # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] CPU features: detected: Spectre-BHB
server # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] alternatives: applying boot alternatives
server # [    0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/dvigzws9yzcfwvywp5fs04s4ghf3fh17-nixos-system-server-test/init regInfo=/nix/.ro-store/f9fc1l0jd84xnhddm7q63ql7nxagzb5q-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/f9fc1l0jd84xnhddm7q63ql7nxagzb5q-closure-info/registration", will be passed to user space.
server # [    0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes
server # [    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
server # [    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB
server # [    0.000000] software IO TLB: area num 1.
server # [    0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)
server # [    0.000000] Fallback order for Node 0: 0
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 524288
server # [    0.000000] Policy zone: DMA
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
server # [    0.000000] allocated 4194304 bytes of page_ext
server # [    0.000000] ftrace: allocating 75323 entries in 296 pages
server # [    0.000000] ftrace: allocated 296 pages with 3 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ee0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44ef0000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000044f10000
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044f20000
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.000037] arm-pv: using stolen time PV
server # [    0.000421] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000714] Console: colour dummy device 80x25
server # [    0.000722] printk: legacy console [tty0] enabled
server # [    0.000924] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000931] pid_max: default: 32768 minimum: 301
server # [    0.001077] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
server # [    0.001222] landlock: Up and running.
server # [    0.001225] Yama: becoming mindful.
server # [    0.001678] LSM support for eBPF active
server # [    0.001828] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.001863] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.004703] rcu: Hierarchical SRCU implementation.
server # [    0.004710] rcu: 	Max phase no-delay instances is 1000.
server # [    0.006034] fsl-mc MSI: its@8080000 domain created
server # [    0.006161] EFI services will not be available.
server # [    0.006290] smp: Bringing up secondary CPUs ...
server # [    0.006300] smp: Brought up 1 node, 1 CPU
server # [    0.006303] SMP: Total of 1 processors activated.
server # [    0.006306] CPU: All CPU(s) started at EL1
server # [    0.006318] CPU features: detected: Branch Target Identification
server # [    0.006323] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.006326] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.006330] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.006337] CPU features: detected: Common not Private translations
server # [    0.006341] CPU features: detected: CRC32 instructions
server # [    0.006343] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.006347] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.006350] CPU features: detected: Data independent timing control (DIT)
server # [    0.006353] CPU features: detected: E0PD
server # [    0.006356] CPU features: detected: Enhanced Counter Virtualization
server # [    0.006358] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.006362] CPU features: detected: Enhanced Virtualization Traps
server # [    0.006365] CPU features: detected: Fine Grained Traps
server # [    0.006368] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.006373] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.006376] CPU features: detected: LSE atomic instructions
server # [    0.006379] CPU features: detected: Privileged Access Never
server # [    0.006381] CPU features: detected: PMUv3
server # [    0.006384] CPU features: detected: RAS Extension Support
server # [    0.006387] CPU features: detected: RASv1p1 Extension Support
server # [    0.006390] CPU features: detected: Random Number Generator
server # [    0.006395] CPU features: detected: Speculation barrier (SB)
server # [    0.006397] CPU features: detected: Stage-2 Force Write-Back
server # [    0.006400] CPU features: detected: TLB range maintenance instructions
server # [    0.006405] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.006446] alternatives: applying system-wide alternatives
server # [    0.009656] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.010255] Memory: 1914836K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138768K reserved, 32768K cma-reserved)
server # [    0.010781] devtmpfs: initialized
server # [    0.012797] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.012822] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.013019] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.013029] 0 pages in range for non-PLT usage
server # [    0.013030] 506368 pages in range for PLT usage
server # [    0.013146] pinctrl core: initialized pinctrl subsystem
server # [    0.014072] DMI not present or invalid.
server # [    0.018218] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.020667] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
server # [    0.020852] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.021063] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.021096] audit: initializing netlink subsys (disabled)
server # [    0.021746] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
server # [    0.021789] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.021791] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.021795] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.021798] thermal_sys: Registered thermal governor 'user_space'
server # [    0.021801] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.021827] cpuidle: using governor ladder
server # [    0.021835] cpuidle: using governor menu
server # [    0.022033] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.022050] ASID allocator initialised with 65536 entries
server # [    0.023321] Serial: AMBA PL011 UART driver
server # [    0.031928] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.032029] printk: console [ttyAMA0] enabled
server # [    0.164269] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.164281] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.164284] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.164287] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.164290] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.164293] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.164295] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.164298] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.165986] fbcon: Taking over console
server # [    0.165998] ACPI: Interpreter disabled.
server # [    0.175233] iommu: Default domain type: Translated
server # [    0.175240] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.175702] SCSI subsystem initialized
server # [    0.178106] usbcore: registered new interface driver usbfs
server # [    0.178129] usbcore: registered new interface driver hub
server # [    0.178159] usbcore: registered new device driver usb
server # [    0.178469] pps_core: LinuxPPS API ver. 1 registered
server # [    0.178473] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.178481] PTP clock support registered
server # [    0.178520] EDAC MC: Ver: 3.0.0
server # [    0.184677] scmi_core: SCMI protocol bus registered
server # [    0.185081] FPGA manager framework
server # [    0.188218] vgaarb: loaded
server # [    0.190398] clocksource: Switched to clocksource arch_sys_counter
server # [    0.196023] VFS: Disk quotas dquot_6.6.0
server # [    0.196060] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.198379] netfs: FS-Cache loaded
server # [    0.200307] pnp: PnP ACPI: disabled
server # [    0.204290] NET: Registered PF_INET protocol family
server # [    0.204600] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.242082] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.242133] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.242165] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.242252] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
server # [    0.247195] TCP: Hash tables configured (established 16384 bind 16384)
server # [    0.247322] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
server # [    0.247364] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.247401] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.247496] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.247547] NET: Registered PF_XDP protocol family
server # [    0.247564] PCI: CLS 0 bytes, default 64
server # [    0.247820] Trying to unpack rootfs image as initramfs...
server # [    0.262441] kvm [1]: HYP mode not available
server # [    0.436696] Initialise system trusted keyrings
server # [    0.436746] Key type blacklist registered
server # [    0.436888] workingset: timestamp_bits=42 max_order=19 bucket_order=0
server # [    0.437275] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.437349] 9p: Installing v9fs 9p2000 file system support
server # [    0.437441] integrity: Platform Keyring initialized
server # [    0.437451] integrity: Machine keyring initialized
server # [    0.469641] Key type asymmetric registered
server # [    0.469664] Asymmetric key parser 'x509' registered
server # [    0.469746] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.469882] io scheduler mq-deadline registered
server # [    0.469887] io scheduler kyber registered
server # [    0.482547] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.483205] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.483629] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.483644] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.483658] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.483664] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.483684] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.483707] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.483786] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.483793] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.483797] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.483800] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.483804] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.483928] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.484386] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.484595] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.484607] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.484634] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.484646] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.485136] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.485324] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.485336] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.485363] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.485860] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.486047] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.486058] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.486085] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.518299] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.519507] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.519520] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.519547] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.519559] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.520048] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.520241] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.520268] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.520836] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.521029] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.521055] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.521466] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    0.521655] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    0.521947] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.522142] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.522169] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.535422] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.535619] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.535646] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.536121] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.536315] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.536342] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.536900] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.537199] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.537214] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.537241] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.537728] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.537920] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.537932] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.537959] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.558536] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
server # [    0.558759] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.558788] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.559567] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.559574] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.559578] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.559626] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.559676] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.559722] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.559769] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.559816] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.559862] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.559909] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.559956] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.560002] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.560139] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.560186] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
server # [    0.560229] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.560247] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.560265] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.560283] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.560301] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.560319] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.560338] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.560358] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.560376] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.560395] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.560414] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.560432] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.560464] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
server # [    0.560482] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.560500] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.560517] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.560535] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.560552] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.560570] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.560595] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.560600] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.560603] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.561496] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.616971] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    4.526118] Freeing initrd memory: 25272K
server # [    4.530381] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [   10.776111] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [   10.780898] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [   10.784443] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [   10.789991] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
server # [   10.793947] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [   10.797441] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [   10.801897] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [   10.806376] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [   10.810271] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [   15.736164] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
server # [   15.742572] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [   15.744543] msm_serial: driver initialized
server # [   15.744689] SuperH (H)SCI(F) driver initialized
server # [   15.744746] STM32 USART driver initialized
server # [   15.765223] loop: module loaded
server # [   15.765420] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [   15.768081] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [   15.772319] megasas: 07.734.00.00-rc1
server # [   15.773068] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [   15.784998] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [   15.785069] Intel/Sharp Extended Query Table at 0x0031
server # [   18.816254] Using buffer write method
server # [   18.816352] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [   18.823582] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [   18.823609] Intel/Sharp Extended Query Table at 0x0031
server # [   18.828452] Using buffer write method
server # [   18.828478] Concatenating MTD devices:
server # [   18.828481] (0): "0.flash"
server # [   18.828483] (1): "0.flash"
server # [   18.828485] into device "0.flash"
server # [   18.837190] tun: Universal TUN/TAP device driver, 1.6
server # [   18.846315] thunder_xcv, ver 1.0
server # [   18.846363] thunder_bgx, ver 1.0
server # [   18.846385] nicpf, ver 1.0
server # [   18.848383] e1000: Intel(R) PRO/1000 Network Driver
server # [   18.848389] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [   18.848417] e1000e: Intel(R) PRO/1000 Network Driver
server # [   18.848425] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [   18.848460] igb: Intel(R) Gigabit Ethernet Network Driver
server # [   18.848464] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [   18.848487] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [   18.848491] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [   18.848642] sky2: driver version 1.30
server # [   18.851273] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [   18.851298] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [   18.851494] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [   18.859973] usbcore: registered new interface driver usb-storage
server # [   18.860041] usbcore: registered new interface driver usbserial_generic
server # [   18.860055] usbserial: USB Serial support registered for generic
server # [   18.860868] hv_vmbus: registering driver hyperv_keyboard
server # [   18.861975] rtc-pl031 9010000.pl031: registered as rtc0
server # [   18.862008] rtc-pl031 9010000.pl031: setting system clock to 2026-11-12T10:12:32 UTC (1794478352)
server # [   18.862355] i2c_dev: i2c /dev entries driver
server # [   18.862457] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [   18.869642] hub 1-0:1.0: USB hub found
server # [   18.869662] hub 1-0:1.0: 6 ports detected
server # [   18.873941] sdhci: Secure Digital Host Controller Interface driver
server # [   18.873950] sdhci: Copyright(c) Pierre Ossman
server # [   18.874246] Synopsys Designware Multimedia Card Interface Driver
server # [   18.876690] sdhci-pltfm: SDHCI platform and OF driver helper
server # [   18.879132] hid: raw HID events driver (C) Jiri Kosina
server # [   18.879412] usbcore: registered new interface driver usbhid
server # [   18.879416] usbhid: USB HID core driver
server # [   18.880779] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [   18.885302] drop_monitor: Initializing network drop monitor service
server # [   18.885463] NET: Registered PF_INET6 protocol family
server # [   18.888224] Segment Routing with IPv6
server # [   18.888239] In-situ OAM (IOAM) with IPv6
server # [   18.888374] NET: Registered PF_PACKET protocol family
server # [   18.888448] 9pnet: Installing 9P2000 support
server # [   18.888498] Key type dns_resolver registered
server # [   18.897660] registered taskstats version 1
server # [   18.897816] Loading compiled-in X.509 certificates
server # [   18.906856] Demotion targets for Node 0: null
server # [   18.906997] Key type .fscrypt registered
server # [   18.907001] Key type fscrypt-provisioning registered
server # [   18.907114] ima: No TPM chip found, activating TPM-bypass!
server # [   18.907140] ima: Allocated hash algorithm: sha1
server # [   18.907166] ima: No architecture policies found
server # [   18.908044] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [   18.935455] clk: Disabling unused clocks
server # [   18.935476] PM: genpd: Disabling unused power domains
server # [   18.941501] Freeing unused kernel memory: 7808K
server # [   18.941739] Run /init as init process
server # [   18.962072] systemd[1]: Successfully made /usr/ read-only.
server # [   19.114486] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [   19.264815] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
server # [   19.297017] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [   19.297049] systemd[1]: Detected virtualization qemu.
server # [   19.297123] systemd[1]: Detected architecture arm64.
server # [   19.297132] systemd[1]: Running in initrd.
server # [   19.297740] systemd[1]: Initializing machine ID from random generator.
server # [   19.297909] systemd[1]: Hostname set to <server>.
server # [   19.354677] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0
server # [   19.446149] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   19.474567] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [   19.509571] systemd[1]: Queued start job for default target Initrd Default Target.
server # [   19.513764] systemd[1]: Created slice Slice /system/modprobe.
server # [   19.513962] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   19.513990] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [   19.514019] systemd[1]: Reached target Path Units.
server # [   19.514032] systemd[1]: Reached target Slice Units.
server # [   19.514047] systemd[1]: Reached target Swaps.
server # [   19.514061] systemd[1]: Reached target Timer Units.
server # [   19.514205] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   19.514351] systemd[1]: Listening on Journal Socket (/dev/log).
server # [   19.520942] systemd[1]: Listening on Journal Sockets.
server # [   19.521054] systemd[1]: Listening on udev Kernel Socket.
server # [   19.521231] systemd[1]: Listening on udev Varlink Socket.
server # [   19.521249] systemd[1]: Reached target Socket Units.
server # [   19.526595] systemd[1]: Starting Create List of Static Device Nodes...
server # [   19.526687] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   19.534639] systemd[1]: Mounting Kernel Configuration File System...
server # [   19.554642] systemd[1]: Starting Journal Service...
server # [   19.557751] systemd[1]: Starting Load Kernel Modules...
server # [   19.557874] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   19.582969] systemd[1]: Starting Coldplug All udev Devices...
server # [   19.591504] systemd[1]: Finished Create List of Static Device Nodes.
server # [   19.620522] systemd-journald[70]: Collecting audit messages is disabled.
server # [   19.632885] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   19.633618] systemd[1]: Mounted Kernel Configuration File System.
server # [   19.640726] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
server # [   19.654637] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
server # [   19.654797] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0
server # [   19.672196] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [   19.672640] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [   19.683337] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [   19.683581] [drm] features: -virgl +edid -resource_blob -host_visible
server # [   19.683584] [drm] features: -context_init
server # [   19.684427] [drm] number of scanouts: 1
server # [   19.684439] [drm] number of cap sets: 0
server # [   19.703170] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   19.707744] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [   19.707756] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [   19.713022] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   19.746887] Console: switching to colour frame buffer device 160x50
server # [   19.775145] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [   19.778320] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   19.778647] systemd[1]: Reached target Preparation for Local File Systems.
server # [   19.778680] systemd[1]: Reached target Local File Systems.
server # [   19.790816] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   19.806600] NET: Registered PF_VSOCK protocol family
server # [   19.712569] systemd-modules-load[71]: Inserted module 'dm_mod'
server # [   19.840480] systemd[1]: Started Journal Service.
server # [   19.720090] systemd-modules-load[71]: Module 'virtio_balloon' is built in
server # [   19.728553] systemd-modules-load[71]: Module 'virtio_console' is built in
server # [   19.732369] systemd-modules-load[71]: Inserted module 'virtio_gpu'
server # [   19.736449] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [   19.744545] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
server # [   19.746973] systemd[1]: Starting Create System Files and Directories...
server # [   19.753167] systemd[1]: Finished Load Kernel Modules.
server # [   19.770540] systemd[1]: Starting Apply Kernel Variables...
server # [   19.804340] systemd-udevd[78]: Using default interface naming scheme 'v261'.
server # [   19.838997] systemd[1]: Finished Create System Files and Directories.
server # [   19.877158] systemd[1]: Finished Apply Kernel Variables.
server # [   19.903676] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   20.024316] systemd[1]: Starting Virtual Console Setup...
server # [   20.112592] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   20.125834] systemd[1]: Finished Virtual Console Setup.
server # [   20.756491] systemd[1]: Finished Coldplug All udev Devices.
server # [   20.758455] systemd[1]: Reached target System Initialization.
server # [   20.765416] systemd[1]: Reached target Basic System.
server # [   20.927467] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   20.953317] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.
server # [   20.957054] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.
server # [   21.063103] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [   21.065294] systemd[1]: Reached target Initrd Root Device.
server # [   21.071271] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [   21.128910] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [   21.137639] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [   21.139501] systemd[1]: Mounting /sysroot...
server # [   21.309655] EXT4-fs (vda): mounted filesystem e3c75a17-bc91-478b-8b8d-7f3094cf4b32 r/w with ordered data mode. Quota mode: none.
server # [   21.188896] systemd[1]: Mounted /sysroot.
server # [   21.191263] systemd[1]: Reached target Initrd Root File System.
server # [   21.198520] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [   21.228433] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [   21.236351] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [   21.241271] systemd[1]: Reloading...
server # [   21.469084] systemd[1]: Reloading finished in 228 ms.
server # [   21.502716] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...
server # [   21.509730] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...
server # [   21.516700] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [   21.536836] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [   21.554787] systemd[1]: Mounting /sysroot/run...
server # [   21.569738] systemd[1]: Mounting /sysroot/tmp/shared...
server # [   21.626015] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [   21.630643] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [   21.759796] fuse: init (API version 7.45)
server # [   21.767083] virtiofs virtio6: discovered new tag: nix-store
server # [   21.767894] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [   21.664280] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [   21.787139] virtiofs virtio7: discovered new tag: shared
server # [   21.788032] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # [   21.668199] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [   21.806279] virtiofs virtio8: discovered new tag: xchg
server # [   21.822790] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [   21.707589] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [   21.744772] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [   21.754551] systemd[1]: Mounted /sysroot/run.
server # [   21.756784] systemd[1]: Mounted /sysroot/tmp/shared.
server # [   21.766648] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [   21.781993] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   21.812569] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   21.814573] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   22.512282] systemd[1]: Mounting /sysroot/nix/store...
server # [   22.567785] systemd[1]: Mounted /sysroot/nix/store.
server # [   22.568830] systemd[1]: Reached target Initrd File Systems.
server # [   22.572209] systemd[1]: Starting Find NixOS closure...
server # [   22.577706] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
host1 # Disk image does not exist, creating the virtualisation disk image...
[55.66s] host1: QEMU running (pid 52)
host1 # Formatting '/build/vm-state-host1/tmp.GE5AKEqFMw', fmt=raw size=1073741824
host1 # mke2fs 1.47.4 (6-Mar-2025)
host1 # Discarding device blocks:      0/262144             done
host1 # Creating filesystem with 262144 4k blocks and 65536 inodes
host1 # Filesystem UUID: 01943825-328b-4608-8e46-f06fade03cb0
host1 # Superblock backups stored on blocks:
host1 # 	32768, 98304, 163840, 229376
host1 # 
[55.67s] (finished: start all VMs, in 53.95 seconds)
host1 # Allocating group tables: 0/8   done
host1 # Writing inode tables: 0/8   done
[55.67s] server: waiting for unit step-ca.service
host1 # Creating journal (8192 blocks): done
[55.67s] server: waiting for the VM to finish booting
host1 # Writing superblocks and filesystem accounting information: 0/8   done
host1 # 
host1 # Virtualisation disk image created.
host1 # Starting virtiofs daemons...
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-12T10:11:50Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-12T10:11:50Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-12T10:11:50Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-12T10:11:50Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-12T10:11:52Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-12T10:11:52Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-12T10:11:52Z INFO  virtiofsd] Client connected, servicing requests
server # [   22.633051] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [   22.636257] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
server # [   22.643190] (udev-worker)[90]: mtd0ro: Failed to find and pin callout binary "/nix/store/rzzrvlm7r31iq3im3h66nhxc2zh996l9-systemd-262/lib/udev/mtd_probe": No such file or directory
server # [   22.652933] (udev-worker)[90]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory
server # [   22.664919] systemd[1]: Finished Find NixOS closure.
server # [   22.668270] systemd[1]: Reached target Initrd Default Target.
server # [   22.669266] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   22.701749] systemd[1]: Stopped target Initrd Default Target.
server # [   22.704612] systemd[1]: Stopped target Basic System.
server # [   22.708420] systemd[1]: Stopped target Initrd Root Device.
server # [   22.715038] systemd[1]: Stopped target Path Units.
server # [   22.715917] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   22.717714] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   22.724218] systemd[1]: Stopped target Slice Units.
server # [   22.725138] systemd[1]: Stopped target Socket Units.
server # [   22.725928] systemd[1]: Stopped target System Initialization.
server # [   22.726767] systemd[1]: Stopped target Swaps.
server # [   22.727433] systemd[1]: Stopped target Timer Units.
server # [   22.729007] systemd[1]: dbus.socket: Deactivated successfully.
server # [   22.732322] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   22.737099] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   22.739941] systemd[1]: Stopped Find NixOS closure.
server # [   22.742946] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   22.746997] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   22.753639] systemd[1]: Stopped Apply Kernel Variables.
server # [   22.756317] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   22.760527] systemd[1]: Stopped Load Kernel Modules.
server # [   22.765681] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   22.768283] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   22.772311] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   22.774142] systemd[1]: Stopped Create System Files and Directories.
server # [   22.776324] systemd[1]: Stopped target Local File Systems.
server # [   22.777897] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   22.780332] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   22.784796] systemd[1]: Stopped Coldplug All udev Devices.
server # [   22.785733] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [   22.788415] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   22.792201] systemd[1]: Stopped Virtual Console Setup.
server # [   22.793100] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   22.795081] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   22.798482] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   22.802724] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   22.807729] systemd[1]: Starting Virtual Console Setup...
server # [   22.818697] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   22.828116] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   22.829326] systemd[1]: systemd-udevd.service: Consumed 1.700s CPU time over 3.155s wall clock time, 26.2M memory peak.
server # [   22.830953] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
server # [   22.836637] systemd[1]: Closed udev Varlink Socket.
server # [   22.840101] systemd[1]: Starting Cleanup udev Database...
server # [   22.841038] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   22.845767] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [   22.855303] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   22.856632] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   22.857647] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   22.858655] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   22.872609] systemd-vconsole-setup[173]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   22.880844] systemd[1]: Finished Virtual Console Setup.
host1 # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
host1 # [    0.000000] Linux version 6.18.60 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1793362001
host1 # [    0.000000] KASLR enabled
host1 # [    0.000000] random: crng init done
host1 # [    0.000000] Machine model: linux,dummy-virt
host1 # [    0.000000] efi: UEFI not found.
host1 # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
host1 # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]
host1 # [    0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]
host1 # [    0.000000] Zone ranges:
host1 # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000bfffffff]
host1 # [    0.000000]   DMA32    empty
host1 # [    0.000000]   Normal   empty
host1 # [    0.000000]   Device   empty
host1 # [    0.000000] Movable zone start for each node
host1 # [    0.000000] Early memory node ranges
host1 # [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000bfffffff]
host1 # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]
host1 # [    0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000
host1 # [    0.000000] psci: probing for conduit method from DT.
host1 # [    0.000000] psci: PSCIv1.3 detected in firmware.
host1 # [    0.000000] psci: Using standard PSCI v0.2 function IDs
host1 # [    0.000000] psci: Trusted OS migration not required
host1 # [    0.000000] psci: SMC Calling Convention v1.1
host1 # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
host1 # [    0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u311296
host1 # [    0.000000] Detected PIPT I-cache on CPU0
host1 # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
host1 # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [   22.917994] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
host1 # [    0.000000] CPU features: detected: Spectre-v4
host1 # [    0.000000] CPU features: detected: Spectre-BHB
server # [   22.920138] systemd[1]: Finished Cleanup udev Database.
host1 # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
host1 # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
host1 # [    0.000000] alternatives: applying boot alternatives
server # [   22.922317] systemd[1]: Reached target Switch Root.
server # [   22.923686] systemd[1]: Starting NixOS Activation...
host1 # [    0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/3q2k45y3674bv2nca39glacb1rpap6w3-nixos-system-host1-test/init regInfo=/nix/.ro-store/j295v7a70zz045ml40f1h4dvrbskr449-closure-info/registration console=ttyAMA0,115200n8 console=tty0
host1 # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/j295v7a70zz045ml40f1h4dvrbskr449-closure-info/registration", will be passed to user space.
host1 # [    0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes
host1 # [    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
host1 # [    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
host1 # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB
host1 # [    0.000000] software IO TLB: area num 1.
host1 # [    0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)
host1 # [    0.000000] Fallback order for Node 0: 0
host1 # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 524288
host1 # [    0.000000] Policy zone: DMA
host1 # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
host1 # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
host1 # [    0.000000] allocated 4194304 bytes of page_ext
host1 # [    0.000000] ftrace: allocating 75323 entries in 296 pages
host1 # [    0.000000] ftrace: allocated 296 pages with 3 groups
host1 # [    0.000000] rcu: Hierarchical RCU implementation.
host1 # [    0.000000] rcu: 	RCU event tracing is enabled.
host1 # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
host1 # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
host1 # [    0.000000] 	Rude variant of Tasks RCU enabled.
host1 # [    0.000000] 	Tracing variant of Tasks RCU enabled.
host1 # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
host1 # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
host1 # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
host1 # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
host1 # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
host1 # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
host1 # [    0.000000] GICv3: 256 SPIs implemented
host1 # [    0.000000] GICv3: 0 Extended SPIs implemented
host1 # [    0.000000] Root IRQ handler: gic_handle_irq
host1 # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
host1 # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
host1 # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
host1 # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
host1 # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ef0000 (indirect, esz 8, psz 64K, shr 1)
host1 # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44f00000 (flat, esz 8, psz 64K, shr 1)
host1 # [    0.000000] GICv3: using LPI property table @0x0000000044f10000
host1 # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044f20000
host1 # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
host1 # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
host1 # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
host1 # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
host1 # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
host1 # [    0.000036] arm-pv: using stolen time PV
host1 # [    0.000424] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
host1 # [    0.000614] Console: colour dummy device 80x25
host1 # [    0.000623] printk: legacy console [tty0] enabled
host1 # [    0.000829] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
host1 # [    0.000837] pid_max: default: 32768 minimum: 301
host1 # [    0.000926] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
host1 # [    0.001052] landlock: Up and running.
host1 # [    0.001055] Yama: becoming mindful.
host1 # [    0.001502] LSM support for eBPF active
host1 # [    0.001668] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.001703] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.004244] rcu: Hierarchical SRCU implementation.
host1 # [    0.004252] rcu: 	Max phase no-delay instances is 1000.
host1 # [    0.005666] fsl-mc MSI: its@8080000 domain created
host1 # [    0.005802] EFI services will not be available.
host1 # [    0.005900] smp: Bringing up secondary CPUs ...
host1 # [    0.005912] smp: Brought up 1 node, 1 CPU
host1 # [    0.005915] SMP: Total of 1 processors activated.
host1 # [    0.005918] CPU: All CPU(s) started at EL1
host1 # [    0.005931] CPU features: detected: Branch Target Identification
host1 # [    0.005935] CPU features: detected: ARMv8.4 Translation Table Level
host1 # [    0.005938] CPU features: detected: Instruction cache invalidation not required for I/D coherence
host1 # [    0.005942] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
host1 # [    0.005949] CPU features: detected: Common not Private translations
host1 # [    0.005953] CPU features: detected: CRC32 instructions
host1 # [    0.005960] CPU features: detected: Data cache clean to Point of Deep Persistence
host1 # [    0.005964] CPU features: detected: Data cache clean to Point of Persistence
host1 # [    0.005967] CPU features: detected: Data independent timing control (DIT)
host1 # [    0.005970] CPU features: detected: E0PD
host1 # [    0.005972] CPU features: detected: Enhanced Counter Virtualization
host1 # [    0.005975] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
host1 # [    0.005979] CPU features: detected: Enhanced Virtualization Traps
host1 # [    0.005982] CPU features: detected: Fine Grained Traps
host1 # [    0.005986] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
host1 # [    0.005991] CPU features: detected: RCpc load-acquire (LDAPR)
host1 # [    0.005994] CPU features: detected: LSE atomic instructions
host1 # [    0.005997] CPU features: detected: Privileged Access Never
host1 # [    0.005999] CPU features: detected: PMUv3
host1 # [    0.006002] CPU features: detected: RAS Extension Support
host1 # [    0.006005] CPU features: detected: RASv1p1 Extension Support
host1 # [    0.006008] CPU features: detected: Random Number Generator
host1 # [    0.006013] CPU features: detected: Speculation barrier (SB)
host1 # [    0.006017] CPU features: detected: Stage-2 Force Write-Back
host1 # [    0.006019] CPU features: detected: TLB range maintenance instructions
host1 # [    0.006025] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
host1 # [    0.006067] alternatives: applying system-wide alternatives
host1 # [    0.009386] CPU features: detected: BBM Level 2 without TLB conflict abort
host1 # [    0.009641] Memory: 1915032K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138760K reserved, 32768K cma-reserved)
host1 # [    0.010327] devtmpfs: initialized
host1 # [    0.014564] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
host1 # [    0.014589] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
host1 # [    0.014819] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
host1 # [    0.014826] 0 pages in range for non-PLT usage
host1 # [    0.014827] 506368 pages in range for PLT usage
host1 # [    0.014943] pinctrl core: initialized pinctrl subsystem
host1 # [    0.015812] DMI not present or invalid.
host1 # [    0.019722] NET: Registered PF_NETLINK/PF_ROUTE protocol family
host1 # [    0.022146] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
host1 # [    0.022352] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
host1 # [    0.022565] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
host1 # [    0.022597] audit: initializing netlink subsys (disabled)
host1 # [    0.023296] thermal_sys: Registered thermal governor 'fair_share'
host1 # [    0.023298] thermal_sys: Registered thermal governor 'bang_bang'
host1 # [    0.023302] thermal_sys: Registered thermal governor 'step_wise'
host1 # [    0.023305] thermal_sys: Registered thermal governor 'user_space'
host1 # [    0.023307] thermal_sys: Registered thermal governor 'power_allocator'
host1 # [    0.023346] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
host1 # [    0.023357] cpuidle: using governor ladder
host1 # [    0.023364] cpuidle: using governor menu
host1 # [    0.023551] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
host1 # [    0.023570] ASID allocator initialised with 65536 entries
host1 # [    0.024796] Serial: AMBA PL011 UART driver
host1 # [    0.030756] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
host1 # [    0.030815] printk: console [ttyAMA0] enabled
server # [   23.036184] initrd-nixos-activation-start[179]: booting system configuration /nix/store/dvigzws9yzcfwvywp5fs04s4ghf3fh17-nixos-system-server-test
host1 # [    0.167758] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
host1 # [    0.167769] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
host1 # [    0.167772] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
host1 # [    0.167775] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
host1 # [    0.167778] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
host1 # [    0.167781] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
host1 # [    0.167784] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
host1 # [    0.167786] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
host1 # [    0.169706] fbcon: Taking over console
host1 # [    0.169717] ACPI: Interpreter disabled.
host1 # [    0.188129] iommu: Default domain type: Translated
host1 # [    0.188137] iommu: DMA domain TLB invalidation policy: strict mode
host1 # [    0.188570] SCSI subsystem initialized
host1 # [    0.188765] usbcore: registered new interface driver usbfs
host1 # [    0.188789] usbcore: registered new interface driver hub
host1 # [    0.188811] usbcore: registered new device driver usb
host1 # [    0.189153] pps_core: LinuxPPS API ver. 1 registered
host1 # [    0.189156] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
host1 # [    0.189173] PTP clock support registered
host1 # [    0.189215] EDAC MC: Ver: 3.0.0
host1 # [    0.189412] scmi_core: SCMI protocol bus registered
host1 # [    0.189793] FPGA manager framework
host1 # [    0.191168] vgaarb: loaded
host1 # [    0.191472] clocksource: Switched to clocksource arch_sys_counter
server # [   23.074540] initrd-nixos-activation-start[179]: running activation script...
host1 # [    0.204028] VFS: Disk quotas dquot_6.6.0
host1 # [    0.204064] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
host1 # [    0.206356] netfs: FS-Cache loaded
host1 # [    0.206497] pnp: PnP ACPI: disabled
host1 # [    0.212296] NET: Registered PF_INET protocol family
host1 # [    0.212581] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
host1 # [    0.246752] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
host1 # [    0.246798] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
host1 # [    0.246829] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
host1 # [    0.246922] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
host1 # [    0.247063] TCP: Hash tables configured (established 16384 bind 16384)
host1 # [    0.247160] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
host1 # [    0.247198] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.247248] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.247352] NET: Registered PF_UNIX/PF_LOCAL protocol family
host1 # [    0.247377] NET: Registered PF_XDP protocol family
host1 # [    0.247395] PCI: CLS 0 bytes, default 64
host1 # [    0.247564] Trying to unpack rootfs image as initramfs...
host1 # [    0.266421] kvm [1]: HYP mode not available
host1 # [    0.440190] Initialise system trusted keyrings
host1 # [    0.440243] Key type blacklist registered
host1 # [    0.440390] workingset: timestamp_bits=42 max_order=19 bucket_order=0
host1 # [    0.440827] squashfs: version 4.0 (2009/01/31) Phillip Lougher
host1 # [    0.440893] 9p: Installing v9fs 9p2000 file system support
host1 # [    0.440989] integrity: Platform Keyring initialized
host1 # [    0.440999] integrity: Machine keyring initialized
host1 # [    0.473530] Key type asymmetric registered
host1 # [    0.473550] Asymmetric key parser 'x509' registered
host1 # [    0.473651] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
host1 # [    0.473814] io scheduler mq-deadline registered
host1 # [    0.473826] io scheduler kyber registered
host1 # [    0.486814] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
host1 # [    0.492347] ledtrig-cpu: registered to indicate activity on CPUs
host1 # [    0.492889] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
host1 # [    0.492907] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
host1 # [    0.492922] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
host1 # [    0.492928] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
host1 # [    0.492949] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
host1 # [    0.492975] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
host1 # [    0.493073] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
host1 # [    0.493080] pci_bus 0000:00: root bus resource [bus 00-ff]
host1 # [    0.493084] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
host1 # [    0.493087] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
host1 # [    0.493090] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
host1 # [    0.493156] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
host1 # [    0.493619] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.493807] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.493818] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.493844] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.493856] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.494351] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
host1 # [    0.494535] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.494547] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.494572] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.495043] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
host1 # [    0.495230] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
host1 # [    0.495241] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.495271] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.519670] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.519861] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.519873] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.519899] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.519910] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.520379] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
host1 # [    0.520567] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.520592] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.521062] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
host1 # [    0.521251] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.521276] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.521671] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
host1 # [    0.521856] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
host1 # [    0.522123] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.522314] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.522339] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.522800] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.522986] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.523012] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.547747] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.547956] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.547983] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.548481] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.548777] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
host1 # [    0.548793] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.548819] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.549282] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
host1 # [    0.549463] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.549475] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.549500] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.549955] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.550167] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.550193] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.550811] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
host1 # [    0.550818] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
host1 # [    0.550821] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
host1 # [    0.550866] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
host1 # [    0.550913] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
host1 # [    0.550958] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
host1 # [    0.551003] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
host1 # [    0.551048] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
host1 # [    0.551099] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
host1 # [    0.551145] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
host1 # [    0.551189] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
host1 # [    0.551231] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
host1 # [    0.551300] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
host1 # [    0.551343] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
host1 # [    0.551384] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
host1 # [    0.551401] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
host1 # [    0.551418] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
host1 # [    0.551436] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
host1 # [    0.551453] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
host1 # [    0.551470] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
host1 # [    0.587567] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
host1 # [    0.587590] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
host1 # [    0.587609] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
host1 # [    0.587628] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
host1 # [    0.587647] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
host1 # [    0.587666] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
host1 # [    0.587685] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
host1 # [    0.587704] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
host1 # [    0.587722] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
host1 # [    0.587739] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
host1 # [    0.587757] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
host1 # [    0.587776] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
host1 # [    0.587794] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
host1 # [    0.587823] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
host1 # [    0.587829] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
host1 # [    0.587832] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
host1 # [    0.588688] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [   23.516408] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
server # [   23.518820] initrd-nixos-activation-start[202]: setting up /etc...
server # [   23.677111] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   23.680347] systemd[1]: Finished NixOS Activation.
server # [   23.683014] systemd[1]: Starting Switch Root...
server # [   23.710219] systemd[1]: Switching root.
server # [   24.008578] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
server # [   24.543319] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [   24.543378] systemd[1]: Detected virtualization qemu.
server # [   24.543438] systemd[1]: Detected architecture arm64.
server # [   24.543562] systemd[1]: Detected first boot.
server # [   24.546273] systemd[1]: Initializing machine ID from random generator.
server # [   24.970718] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   25.323717] systemd[1]: Applying preset policy.
server # [   25.787747] systemd[1]: Populated /etc with preset unit settings.
server # [   26.040602] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   26.041477] systemd[1]: Stopped initrd-switch-root.service.
server # [   26.047418] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   26.049379] systemd[1]: Created slice Slice /system/getty.
server # [   26.053850] systemd[1]: Created slice User and Session Slice.
server # [   26.056332] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   26.056916] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   26.057718] systemd[1]: Expecting device /dev/hvc0...
server # [   26.061702] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   26.062170] systemd[1]: Reached target Local Encrypted Volumes.
server # [   26.065225] systemd[1]: Stopped target initrd-fs.target.
server # [   26.065657] systemd[1]: Stopped target initrd-root-fs.target.
server # [   26.068572] systemd[1]: Stopped target initrd-switch-root.target.
server # [   26.069039] systemd[1]: Reached target Virtual Machines and Containers.
server # [   26.069831] systemd[1]: Reached target Path Units.
server # [   26.073541] systemd[1]: Reached target Remote File Systems.
server # [   26.073984] systemd[1]: Reached target Slice Units.
server # [   26.076809] systemd[1]: Reached target Swaps.
server # [   26.079386] systemd[1]: Listening on Query the User Interactively for a Password.
server # [   26.081612] systemd[1]: Listening on Process Core Dump Socket.
server # [   26.085084] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   26.086363] systemd[1]: Listening on Factory Reset Management.
server # [   26.088615] systemd[1]: Listening on Hostname Service Socket.
server # [   26.092808] systemd[1]: Starting Journal Log Access Socket...
server # [   26.095922] systemd[1]: Listening on Journal Audit Socket.
server # [   26.098138] systemd[1]: Listening on Console Output Muting Service Socket.
server # [   26.100592] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   26.101964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [   26.102365] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   26.112857] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [   26.113562] systemd[1]: Listening on udev Varlink Socket.
server # [   26.120352] systemd[1]: Mounting Huge Pages File System...
server # [   26.134634] systemd[1]: Mounting POSIX Message Queue File System...
server # [   26.138229] systemd[1]: Mounting Kernel Debug File System...
server # [   26.150613] systemd[1]: Mounting Kernel Trace File System...
server # [   26.162594] systemd[1]: Starting Create List of Static Device Nodes...
server # [   26.163038] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   26.181234] systemd[1]: Mounting Kernel Configuration File System...
server # [   26.181728] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   26.182084] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   26.196976] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   26.219197] systemd[1]: Mounting FUSE Control File System...
server # [   26.219707] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   26.265112] systemd[1]: Starting Journal Service...
server # [   26.294989] systemd[1]: Starting Load Kernel Modules...
server # [   26.330555] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   26.344011] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   26.344600] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   26.361176] systemd[1]: Starting Coldplug All udev Devices...
server # [   26.361637] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   26.362057] systemd[1]: Stopped Virtual Console Setup.
server # [   26.373758] systemd[1]: Listening on Journal Log Access Socket.
server # [   26.377708] systemd[1]: Mounted Huge Pages File System.
server # [   26.383101] systemd[1]: Mounted POSIX Message Queue File System.
server # [   26.384017] systemd[1]: Mounted Kernel Debug File System.
server # [   26.385009] systemd[1]: Mounted Kernel Trace File System.
server # [   26.390852] systemd[1]: Mounted Kernel Configuration File System.
server # [   26.391703] systemd[1]: Mounted FUSE Control File System.
server # [   26.427676] systemd[1]: Finished Create List of Static Device Nodes.
server # [   26.434050] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   26.532374] systemd[1]: Finished Load Kernel Modules.
server # [   26.544046] systemd[1]: Starting Firewall...
server # [   26.552061] systemd[1]: Starting Apply Kernel Variables...
server # [   26.570793] EXT4-fs (vda): re-mounted e3c75a17-bc91-478b-8b8d-7f3094cf4b32.
server # [   26.583515] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   26.584589] systemd[1]: Listening on Disk Image Download Service Socket.
server # [   26.585134] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   26.603093] systemd[1]: Starting Load/Save OS Random Seed...
server # [   26.603655] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   26.627852] systemd-journald[273]: Collecting audit messages is enabled.
server # [   26.725951] systemd[1]: Started Journal Service.
server # [   26.612199] systemd[1]: Queued start job for default target Multi-User System.
server # [   26.613936] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   26.615307] systemd-modules-load[274]: Module 'atkbd' is built in
server # [   26.637527] systemd-modules-load[274]: Module 'loop' is built in
server # [   26.661159] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   26.673651] systemd-oomd[275]: No swap; memory pressure usage will be degraded
server # [   26.681300] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   26.696634] systemd[1]: Finished Apply Kernel Variables.
server # [   26.697881] systemd[1]: Finished Load/Save OS Random Seed.
server # [   26.698918] systemd[1]: Reached target First Boot Complete.
server # [   26.743333] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   26.753766] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   26.892686] systemd-journald[273]: Received client request to flush runtime journal.
server # [   26.870610] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   26.946237] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   26.947430] systemd[1]: Reached target Preparation for Local File Systems.
server # [   26.952764] systemd[1]: Mounting /run/wrappers...
server # [   26.964770] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   27.020223] systemd[1]: Mounted /run/wrappers.
server # [   27.021281] systemd[1]: Reached target Local File Systems.
server # [   27.036274] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   27.042818] systemd[1]: Starting register-nix-paths.service...
server # [   27.056750] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   27.068733] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   27.083567] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   27.087128] systemd[1]: Starting Create System Files and Directories...
host1 # [    0.632986] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
host1 # [    4.325964] Freeing initrd memory: 25264K
server # [   27.226756] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   27.237151] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   27.250996] systemd-udevd[314]: Using default interface naming scheme 'v261'.
server # [   27.362653] systemd[1]: Finished Create System Files and Directories.
server # [   27.369482] systemd[1]: Starting Rebuild Journal Catalog...
server # [   27.376329] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   27.541195] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   27.592123] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   27.631789] systemd[1]: Finished Rebuild Journal Catalog.
server # [   27.642335] systemd[1]: Starting Update is Completed...
server # [   27.963415] systemd[1]: Finished Update is Completed.
server # [   28.570990] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   28.576857] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   28.755379] systemd[1]: Finished Coldplug All udev Devices.
server # [   28.929942] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   29.002540] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   29.292552] systemd[1]: Finished Firewall.
server # [   29.329278] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [   29.418237] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [   29.662228] systemd[1]: Finished register-nix-paths.service.
server # [   29.666811] systemd[1]: Reached target System Initialization.
server # [   29.667923] systemd[1]: Started Renew ACME Certificate for server.
server # [   29.672170] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   29.675000] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   29.677757] systemd[1]: Reached target Timer Units.
server # [   29.678636] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   29.679596] systemd[1]: Listening on Nix Daemon Socket.
server # [   29.685285] systemd[1]: Listening on Nix worker-protocol over gRPC.
server # [   29.686328] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
server # [   29.700836] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
server # [   29.712253] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   29.720576] systemd[1]: Starting D-Bus System Message Bus...
server # [   29.768399] systemd-ssh-issue[500]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
server # [   29.779265] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
server # [   29.783189] systemd[1]: Reached target Socket Units.
server # [   29.819069] (udev-worker)[379]: Network interface NamePolicy= disabled on kernel command line.
server # [   29.825931] dbus-broker-launch[501]: Looking up NSS user entry for 'systemd-timesync'...
server # [   29.830491] dbus-broker-launch[501]: NSS returned no entry for 'systemd-timesync'
server # [   29.835230] dbus-broker-launch[501]: Invalid user-name in /nix/store/c2mpdmjqkz1mxlsyhzsv6hnn4waavv8s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   29.846819] (udev-worker)[378]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   29.864591] (udev-worker)[378]: Network interface NamePolicy= disabled on kernel command line.
server # [   29.885132] systemd[1]: Started D-Bus System Message Bus.
server # [   29.894999] systemd[1]: Reached target Basic System.
server # [   29.903271] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
server # [   29.918181] systemd[1]: Started backdoor.service.
server # [   29.932690] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   29.951064] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   29.965214] systemd[1]: Starting Post-Boot Actions...
server # [   29.987670] systemd[1]: Started Reset console on configuration changes.
server # [   30.003475] systemd[1]: Starting resolvconf update...
server # [   30.015297] systemd[1]: Starting SSH Host Keys Generation...
server # [   30.028111] systemd[1]: Starting step-ca-pki.service...
server # [   30.042223] dbus-broker-launch[501]: Ready
server # [   30.239307] acme-setup-privileged[505]: + set -euo pipefail
server # [   30.251429] acme-setup-privileged[505]: + cd /var/lib/acme
server # [   30.260520] acme-setup-privileged[505]: + chmod -R u=rwX,g=,o= .lego/accounts
server # connecting to host...
server # [   30.279259] acme-setup-privileged[505]: + chown -R acme .lego/accounts
server # [   30.292226] systemd[1]: Finished Post-Boot Actions.
server # [   30.301238] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   30.302309] systemd[1]: Reached target Host and Network Name Lookups.
server # [   30.303244] systemd[1]: Reached target User and Group Name Lookups.
server # [   30.319430] systemd[1]: Starting User Login Management...
server # [   30.328452] nsncd[509]: Nov 12 10:12:44.080 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   30.348526] acme-setup-privileged[505]: + for fixpath in server .lego/server
server # [   30.349655] acme-setup-privileged[505]: + '[' -d server ']'
server # [   30.350515] acme-setup-privileged[505]: + for fixpath in server .lego/server
server # [   30.351485] acme-setup-privileged[505]: + '[' -d .lego/server ']'
[63.46s] server: Guest shell says: b'Spawning backdoor root shell...\n'
[63.48s] server: connected to guest root shell
[63.48s] server: (connecting took 7.80 seconds)
[63.48s] server: (finished: waiting for the VM to finish booting, in 7.81 seconds)
server # [   30.414053] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   30.707098] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   30.790787] systemd-logind[539]: New seat seat0.
server # [   30.812139] systemd[1]: Started User Login Management.
server # [   30.818987] acme-setup-start[551]: + set -euo pipefail
server # [   30.819883] acme-setup-start[551]: + test -e ca/key.pem
server # [   30.839167] acme-setup-start[551]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
server # [   30.849686] systemd[1]: Starting linger-users.service...
server # [   30.912939] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   30.974222] systemd[1]: Stopping Host and Network Name Lookups...
server # [   30.988515] systemd[1]: Stopped target User and Group Name Lookups.
server # [   30.992678] systemd[1]: Stopping User and Group Name Lookups...
server # [   31.001954] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   31.011710] systemd[1]: nscd.service: Deactivated successfully.
server # [   31.017359] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   31.024566] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   31.033893] systemd[1]: linger-users.service: Deactivated successfully.
server # [   31.034983] systemd[1]: Finished linger-users.service.
server # [   31.124615] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
server # [   31.134769] systemd[1]: Starting Ensure certificate for server...
server # [   31.151676] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   31.160449] nsncd[619]: Nov 12 10:12:44.915 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   31.180558] systemd[1]: Reached target Host and Network Name Lookups.
server # [   31.181596] systemd[1]: Reached target User and Group Name Lookups.
server # [   31.312674] systemd[1]: Finished resolvconf update.
server # [   31.323300] systemd[1]: Reached target Preparation for Network.
server # [   31.328365] systemd[1]: Starting DHCP Client...
server # [   31.329125] systemd[1]: Starting Address configuration of eth1...
server # [   31.330065] systemd[1]: Starting Extra networking commands....
host1 # [    4.332489] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
host1 # [    8.466602] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
host1 # [    8.471254] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
host1 # [    8.505126] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
host1 # [    8.510685] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
host1 # [    8.514466] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
host1 # [    8.521396] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
host1 # [    8.525407] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
host1 # [    8.529886] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
host1 # [    8.542007] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
host1 # [    8.545643] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
host1 # [    8.553644] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
host1 # [    8.556607] msm_serial: driver initialized
host1 # [    8.556753] SuperH (H)SCI(F) driver initialized
host1 # [    8.556816] STM32 USART driver initialized
host1 # [    8.575127] loop: module loaded
host1 # [    8.575319] virtio_blk virtio2: 1/0/0 default/read/poll queues
host1 # [    8.577391] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
host1 # [    8.582993] megasas: 07.734.00.00-rc1
host1 # [    8.584296] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [   31.526238] acme-server-start[645]: Waiting to acquire lock in /run/acme/
server # [   31.593018] acme-server-start[645]: + '[' -e out/acme-success ']'
server # [   31.594115] acme-server-start[645]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=
server # [   31.616148] systemd-logind[539]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [   31.677271] network-addresses-eth1-start[666]: adding address 192.168.1.2/24... done
server # [   31.735217] network-addresses-eth1-start[666]: adding address 2001:db8:1::2/64... done
server # [   31.740973] acme-server-start[699]: + cd server
server # [   31.741739] acme-server-start[699]: + cp -vp cert.pem ../out/cert.pem
server # [   31.772596] acme-server-start[700]: 'cert.pem' -> '../out/cert.pem'
server # [   31.782405] acme-server-start[699]: + cp -vp key.pem ../out/key.pem
server # [   31.794207] acme-server-start[699]: 'key.pem' -> '../out/key.pem'
server # [   31.806546] systemd[1]: Finished Address configuration of eth1.
server # [   31.807568] acme-server-start[645]: + cat out/cert.pem ca/cert.pem
server # [   31.838836] acme-server-start[645]: + cp ca/cert.pem out/chain.pem
server # [   31.866743] acme-server-start[645]: + cat out/key.pem out/fullchain.pem
server # [   31.898521] step-ca-pki-start[532]: Your certificate has been saved in root_ca.crt.
server # [   31.899803] acme-server-start[645]: + for fixpath in out certificates
server # [   31.917772] acme-server-start[645]: + '[' -d out ']'
server # [   31.918604] acme-server-start[645]: + chmod -R u=rwX,g=rX,o= out
server # [   31.931315] step-ca-pki-start[532]: Your private key has been saved in root_ca.key.
server # [   31.938053] acme-server-start[645]: + chown -R acme:nix-grpc-daemon out
server # [   31.971099] acme-server-start[645]: + for fixpath in out certificates
server # [   31.980497] acme-server-start[645]: + '[' -d certificates ']'
server # [   31.981856] dhcpcd[678]: dhcpcd-10.3.2 starting
server # [   31.982602] systemd[1]: Finished Ensure certificate for server.
server # [   32.006710] dhcpcd[734]: dev: loaded udev
server # [   32.159225] 8021q: 802.1Q VLAN Support v1.8
server # [   32.159640] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   32.277111] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   32.280390] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   32.280893] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   32.284895] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   32.285272] cfg80211: failed to load regulatory.db
server # [   32.260919] step-ca-pki-start[725]: Your certificate has been saved in intermediate_ca.crt.
server # [   32.273955] step-ca-pki-start[725]: Your private key has been saved in intermediate_ca.key.
server # [   32.290067] systemd[1]: Finished Extra networking commands..
server # [   32.291107] systemd[1]: Reached target Network.
server # [   32.301413] systemd[1]: Starting Permit User Sessions...
server # [   32.351871] systemd[1]: Finished step-ca-pki.service.
server # [   32.524875] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   32.406596] dhcpcd[734]: eth0: waiting for carrier
server # [   32.407459] dhcpcd[734]: eth0: carrier acquired[   32.531325] mousedev: PS/2 mouse device common for all mice
server # 
server # [   32.419460] systemd[1]: Finished Permit User Sessions.
server # [   32.426038] systemd[1]: Started Getty on tty1.
server # [   32.426856] systemd[1]: Reached target Login Prompts.
server # [   32.445024] dhcpcd[734]: DUID 00:01:00:01:32:88:4d:9e:52:54:00:12:34:56
server # [   32.446200] dhcpcd[734]: eth0: IAID 00:12:34:56
server # [   32.446895] dhcpcd[734]: eth0: adding address fe80::5054:ff:fe12:3456
server # [   32.736662] systemd-logind[539]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   33.240537] dhcpcd[734]: eth0: soliciting a DHCP lease
server # [   33.245154] dhcpcd[734]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   33.258043] dhcpcd[734]: eth0: probing address 10.0.2.15/24
server # [   34.649414] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   34.538654] sshd-keygen-start[566]: Generating public/private rsa key pair.
server # [   34.539762] sshd-keygen-start[566]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
server # [   34.541129] sshd-keygen-start[566]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
server # [   34.542393] sshd-keygen-start[566]: The key fingerprint is:
server # [   34.543186] sshd-keygen-start[566]: SHA256:64EqLiKsnBapEIl0Xd9bbACA0BLn7hqTVew2gjQP50s root@server
server # [   34.552156] sshd-keygen-start[566]: The key's randomart image is:
server # [   34.553121] sshd-keygen-start[566]: +---[RSA 4096]----+
server # [   34.553976] sshd-keygen-start[566]: |   o=.oo....     |
server # [   34.554707] sshd-keygen-start[566]: | . oo+. . . o    |
server # [   34.555439] sshd-keygen-start[566]: |o..+.o o . . +   |
server # [   34.565245] sshd-keygen-start[566]: |+ . O o     +    |
server # [   34.566109] sshd-keygen-start[566]: | ... E +S  .     |
server # [   34.566844] sshd-keygen-start[566]: |.o  = +...       |
server # [   34.567569] sshd-keygen-start[566]: |+ .+ o. o        |
server # [   34.578550] sshd-keygen-start[566]: |*oo +. . .       |
server # [   34.579426] sshd-keygen-start[566]: |*=.o.   .        |
server # [   34.584898] sshd-keygen-start[566]: +----[SHA256]-----+
server # [   34.639437] sshd-keygen-start[813]: Generating public/private ed25519 key pair.
server # [   34.646839] sshd-keygen-start[813]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
server # [   34.656096] sshd-keygen-start[813]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
server # [   34.657478] sshd-keygen-start[813]: The key fingerprint is:
server # [   34.658286] sshd-keygen-start[813]: SHA256:Goi1PXamNsLPuyNdxv++IV4vQll/u2mr1l+K1dDh0Hk root@server
server # [   34.659499] sshd-keygen-start[813]: The key's randomart image is:
server # [   34.674636] sshd-keygen-start[813]: +--[ED25519 256]--+
server # [   34.675482] sshd-keygen-start[813]: |                 |
server # [   34.680546] sshd-keygen-start[813]: |              . .|
server # [   34.681387] sshd-keygen-start[813]: |    .        . +E|
server # [   34.682244] sshd-keygen-start[813]: |   o +      . o.o|
server # [   34.682978] sshd-keygen-start[813]: |  . o =.S  o ....|
server # [   34.683760] sshd-keygen-start[813]: |   . . B+ o   .o.|
server # [   34.697954] sshd-keygen-start[813]: |    o.=o o. o o.+|
server # [   34.698805] sshd-keygen-start[813]: |    .=o. .oo.* =o|
server # [   34.699553] sshd-keygen-start[813]: |     .=+  .+*+=+=|
server # [   34.711636] sshd-keygen-start[813]: +----[SHA256]-----+
server # [   34.744485] sshd-keygen-start[823]: Generating public/private mldsa44-ed25519 key pair.
server # [   34.745747] sshd-keygen-start[823]: Your identification has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key
server # [   34.747069] sshd-keygen-start[823]: Your public key has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key.pub
server # [   34.768406] sshd-keygen-start[823]: The key fingerprint is:
server # [   34.769300] sshd-keygen-start[823]: SHA256:tqUs8tuUXsbNaLLf+QiXCBdSG+Tl+0HNp0poZN00Ez8 root@server
server # [   34.770653] sshd-keygen-start[823]: The key's randomart image is:
server # [   34.771539] sshd-keygen-start[823]: +[MLDSA44-ED25519-+
server # [   34.784199] sshd-keygen-start[823]: |         .+ . =. |
server # [   34.785064] sshd-keygen-start[823]: |         o * o * |
server # [   34.785827] sshd-keygen-start[823]: |        . * o oE=|
server # [   34.786563] sshd-keygen-start[823]: |         + o o .o|
server # [   34.787306] sshd-keygen-start[823]: |        S = o o  |
server # [   34.795627] sshd-keygen-start[823]: |       o X * + . |
server # [   34.797439] sshd-keygen-start[823]: |    . . B O * .  |
server # [   34.798776] sshd-keygen-start[823]: |     o = * + o   |
server # [   34.804108] sshd-keygen-start[823]: |      o.+.. +..  |
server # [   34.805013] sshd-keygen-start[823]: +----[SHA256]-----+
server # [   34.806178] systemd[1]: sshd-keygen.service: Deactivated successfully.
server # [   34.812274] systemd[1]: Finished SSH Host Keys Generation.
server # [   34.816284] systemd[1]: sshd-keygen.service: Consumed 1.371s CPU time over 4.810s wall clock time, 2.5M memory peak.
server # [   34.818065] systemd[1]: Starting SSH Daemon...
server # [   34.856178] sshd[826]: Server listening on 0.0.0.0 port 22.
server # [   34.857197] systemd[1]: Started SSH Daemon.
server # [   34.857872] sshd[826]: Server listening on :: port 22.
server # [   35.131008] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   35.154953] systemd[1]: Starting Virtual Console Setup...
server # [   35.178988] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   35.186294] systemd[1]: Stopped Virtual Console Setup.
server # [   35.187198] systemd[1]: Starting Virtual Console Setup...
server # [   35.213559] dhcpcd[734]: eth0: soliciting an IPv6 router
server # [   35.214496] dhcpcd[734]: eth0: Router Advertisement from fe80::2
server # [   35.215407] dhcpcd[734]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   35.223372] dhcpcd[734]: eth0: adding route to fec0::/64
server # [   35.225293] dhcpcd[734]: eth0: adding default route via fe80::2
server # [   35.256604] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
host1 # [    8.588889] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    8.588920] Intel/Sharp Extended Query Table at 0x0031
server # [   35.330948] systemd-vconsole-setup[831]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   35.336496] systemd[1]: Finished Virtual Console Setup.
server # [   38.120981] dhcpcd[734]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   38.123549] dhcpcd[734]: eth0: adding route to 10.0.2.0/24
server # [   38.127043] dhcpcd[734]: eth0: adding default route via 10.0.2.2
server # [   38.267599] systemd[1]: Started DHCP Client.
server # [   38.273687] systemd[1]: Reached target Network is Online.
server # [   38.276455] systemd[1]: Starting step-ca service...
server # [   38.846171] step-ca[921]: badger 2026/11/12 10:12:52 INFO: All 0 tables opened in 0s
server # [   38.870050] step-ca[921]: 2026/11/12 10:12:52 Building new tls configuration using step-ca x509 Signer Interface
server # [   38.904935] step-ca[921]: 2026/11/12 10:12:52 Starting Smallstep CA/0.30.2 (linux/arm64)
server # [   38.906264] step-ca[921]: 2026/11/12 10:12:52 Documentation: https://u.step.sm/docs/ca
server # [   38.907362] step-ca[921]: 2026/11/12 10:12:52 Community Discord: https://u.step.sm/discord
server # [   38.917579] step-ca[921]: 2026/11/12 10:12:52 Config file: /etc/smallstep/ca.json
server # [   38.925204] step-ca[921]: 2026/11/12 10:12:52 The primary server URL is https://server:8443
server # [   38.926631] step-ca[921]: 2026/11/12 10:12:52 Root certificates are available at https://server:8443/roots.pem
server # [   38.933427] step-ca[921]: 2026/11/12 10:12:52 X.509 Root Fingerprint: a5399427d18393289614ad8120597a6ea17e7ec29fbd9c4ae84667ebc063e145
server # [   38.941245] step-ca[921]: 2026/11/12 10:12:52 Serving HTTPS on 0.0.0.0:8443 ...
server # [   38.942447] systemd[1]: Started step-ca service.
server # [   38.943174] systemd[1]: Reached target Multi-User System.
server # [   38.943962] systemd[1]: Starting Order (and renew) ACME certificate for server...
server # [   39.014075] acme-order-renew-server-start[928]: Waiting to acquire lock in /run/acme/
server # [   39.022189] acme-order-renew-server-start[928]: + set -euo pipefail
server # [   39.023326] acme-order-renew-server-start[928]: + exec
server # [   39.024348] acme-order-renew-server-start[928]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
server # [   39.029095] acme-order-renew-server-start[937]: ++ find accounts -path '*/keys/*.key' -print -quit
server # [   39.037984] acme-order-renew-server-start[928]: + '[' -n '' ']'
server # [   39.038989] acme-order-renew-server-start[928]: + exec
server # [   39.039748] acme-order-renew-server-start[928]: + '[' -e certificates/server.key ']'
server # [   39.040975] acme-order-renew-server-start[928]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server --no-random-sleep --renew-force --ari-disable --force-cert-domains
[72.31s] server: (finished: waiting for unit step-ca.service, in 16.63 seconds)
[72.31s] server: waiting for unit nix-grpc-daemon.socket
[72.51s] server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.21 seconds)
[72.51s] server: waiting for TCP port 50051 on localhost
server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!
[72.71s] server: (finished: waiting for TCP port 50051 on localhost, in 0.20 seconds)

running 4 tests
server # [   39.648651] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.411319760Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
server # [   39.678091] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.442343980Z INFO  Registering the account. email=root@example.org
server # [   39.868149] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.631544360Z WARN  !!!! HEADS UP !!!!
server # [   39.870396] acme-order-renew-server-start[938]: Your account credentials have been saved in your
server # [   39.875508] acme-order-renew-server-start[938]: configuration directory at "accounts".
server # [   39.877811] acme-order-renew-server-start[938]: You should make a secure backup of this folder now. This
server # [   39.879893] acme-order-renew-server-start[938]: configuration directory will also contain private keys
server # [   39.882112] acme-order-renew-server-start[938]: generated by lego and certificates obtained from the ACME
server # [   39.884219] acme-order-renew-server-start[938]: server. Making regular backups of this folder is ideal.
server # [   39.886310] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.631926940Z INFO  Obtaining bundled SAN certificate. domains=server
server # [   40.011523] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.775542840Z INFO  Use solver. domain=server type=http-01
server # [   40.016117] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.775647320Z INFO  http01: Trying to solve HTTP-01. domain=server
server # [   40.034561] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.797158380Z INFO  The server validated our request. domain=server
server # [   40.037932] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.797312860Z INFO  Validations succeeded; requesting certificates. domains=server
server # [   40.062017] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.825300020Z INFO  Server responded with a certificate. domains=server
server # [   40.071244] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.825453840Z INFO  Writing file. filepath=certificates/server.crt
server # [   40.075811] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.825703580Z INFO  Writing file. filepath=certificates/server.issuer.crt
server # [   40.082214] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.825799440Z INFO  Writing file. filepath=certificates/server.key
server # [   40.086182] acme-order-renew-server-start[938]: 2026-11-12T10:12:53.826025900Z INFO  Writing file. filepath=certificates/server.json
server # [   40.090151] acme-order-renew-server-start[928]: + touch out/acme-success
server # [   40.093656] acme-order-renew-server-start[928]: + cmp -s certificates/server.crt out/fullchain.pem
server # [   40.098095] acme-order-renew-server-start[928]: + touch out/renewed
server # [   40.103104] acme-order-renew-server-start[928]: + echo Installing new certificate
server # [   40.104683] acme-order-renew-server-start[928]: Installing new certificate
server # [   40.105956] acme-order-renew-server-start[928]: + cp -vp certificates/server.crt out/fullchain.pem
server # [   40.112494] acme-order-renew-server-start[959]: 'certificates/server.crt' -> 'out/fullchain.pem'
server # [   40.115912] acme-order-renew-server-start[928]: + cp -vp certificates/server.key out/key.pem
server # [   40.120859] acme-order-renew-server-start[960]: 'certificates/server.key' -> 'out/key.pem'
server # [   40.123461] acme-order-renew-server-start[928]: + cp -vp certificates/server.issuer.crt out/chain.pem
server # [   40.129126] acme-order-renew-server-start[961]: 'certificates/server.issuer.crt' -> 'out/chain.pem'
server # [   40.131191] acme-order-renew-server-start[928]: + ln -sf fullchain.pem out/cert.pem
server # [   40.136718] acme-order-renew-server-start[928]: + cat out/key.pem out/fullchain.pem
server # [   40.142392] acme-order-renew-server-start[928]: + for fixpath in out certificates
server # [   40.143603] acme-order-renew-server-start[928]: + '[' -d out ']'
server # [   40.144609] acme-order-renew-server-start[928]: + chmod -R u=rwX,g=rX,o= out
server # [   40.149292] acme-order-renew-server-start[928]: + chown -R acme:nix-grpc-daemon out
server # [   40.156570] acme-order-renew-server-start[928]: + for fixpath in out certificates
server # [   40.157774] acme-order-renew-server-start[928]: + '[' -d certificates ']'
server # [   40.158728] acme-order-renew-server-start[928]: + chmod -R u=rwX,g=rX,o= certificates
server # [   40.163514] acme-order-renew-server-start[928]: + chown -R acme:nix-grpc-daemon certificates
server # [   40.170812] acme-order-renew-server-start[928]: + chmod -R u=rwX,g=,o= accounts/.
server # [   40.223183] systemd[1]: acme-order-renew-server.service: Deactivated successfully.
server # [   40.226802] systemd[1]: Finished Order (and renew) ACME certificate for server.
server # [   40.227996] systemd[1]: acme-order-renew-server.service: Consumed 345ms CPU time over 1.303s wall clock time, 56.7M memory peak, 4K written to disk, 10.5K incoming IP traffic, 8.1K outgoing IP traffic.
server # [   40.239170] systemd[1]: Starting Nix worker-protocol over gRPC...
server # [   40.429836] nix-grpc-daemon[979]: ts=2026-11-12T10:12:54Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1
server # [   40.465077] nix-grpc-daemon[979]: ts=2026-11-12T10:12:54Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket
server # [   40.466983] nix-grpc-daemon[979]: ts=2026-11-12T10:12:54Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0
server # [   40.472878] systemd[1]: Started Nix worker-protocol over gRPC.
server # [   40.473973] nix-grpc-daemon[979]: ts=2026-11-12T10:12:54Z level=info event=unhealthy reason=min_free
server # [   40.475243] systemd[1]: Startup finished in 18.821s (kernel) + 5.159s (initrd) + 16.488s (userspace) = 40.469s.
host1 # [   12.459888] Using buffer write method
host1 # [   12.459978] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
host1 # [   12.461802] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [   12.461837] Intel/Sharp Extended Query Table at 0x0031
host1 # [   19.588218] Using buffer write method
host1 # [   19.589277] Concatenating MTD devices:
host1 # [   19.589280] (0): "0.flash"
host1 # [   19.589283] (1): "0.flash"
host1 # [   19.589285] into device "0.flash"
host1 # [   19.599100] tun: Universal TUN/TAP device driver, 1.6
host1 # [   19.605041] thunder_xcv, ver 1.0
host1 # [   19.605082] thunder_bgx, ver 1.0
host1 # [   19.605103] nicpf, ver 1.0
host1 # [   19.605742] e1000: Intel(R) PRO/1000 Network Driver
host1 # [   19.605749] e1000: Copyright (c) 1999-2006 Intel Corporation.
host1 # [   19.605777] e1000e: Intel(R) PRO/1000 Network Driver
host1 # [   19.605782] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
host1 # [   19.605818] igb: Intel(R) Gigabit Ethernet Network Driver
host1 # [   19.605824] igb: Copyright (c) 2007-2014 Intel Corporation.
host1 # [   19.605849] igbvf: Intel(R) Gigabit Virtual Function Network Driver
host1 # [   19.605857] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
host1 # [   19.606139] sky2: driver version 1.30
host1 # [   19.608317] ehci-pci 0000:00:07.0: EHCI Host Controller
host1 # [   19.608346] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
host1 # [   19.608582] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
host1 # [   19.619377] usbcore: registered new interface driver usb-storage
host1 # [   19.620294] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
host1 # [   19.621264] hub 1-0:1.0: USB hub found
host1 # [   19.621291] hub 1-0:1.0: 6 ports detected
host1 # [   19.621761] usbcore: registered new interface driver usbserial_generic
host1 # [   19.621774] usbserial: USB Serial support registered for generic
host1 # [   19.622614] hv_vmbus: registering driver hyperv_keyboard
host1 # [   19.628151] rtc-pl031 9010000.pl031: registered as rtc0
host1 # [   19.628177] rtc-pl031 9010000.pl031: setting system clock to 2026-11-12T10:12:55 UTC (1794478375)
host1 # [   19.628586] i2c_dev: i2c /dev entries driver
host1 # [   19.634686] sdhci: Secure Digital Host Controller Interface driver
host1 # [   19.634693] sdhci: Copyright(c) Pierre Ossman
host1 # [   19.634987] Synopsys Designware Multimedia Card Interface Driver
host1 # [   19.635394] sdhci-pltfm: SDHCI platform and OF driver helper
host1 # [   19.640038] hid: raw HID events driver (C) Jiri Kosina
host1 # [   19.640307] usbcore: registered new interface driver usbhid
host1 # [   19.640310] usbhid: USB HID core driver
host1 # [   19.641595] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
host1 # [   19.643421] drop_monitor: Initializing network drop monitor service
host1 # [   19.647671] NET: Registered PF_INET6 protocol family
host1 # [   19.649018] Segment Routing with IPv6
host1 # [   19.649030] In-situ OAM (IOAM) with IPv6
host1 # [   19.649055] NET: Registered PF_PACKET protocol family
host1 # [   19.649135] 9pnet: Installing 9P2000 support
host1 # [   19.649186] Key type dns_resolver registered
host1 # [   19.659337] registered taskstats version 1
host1 # [   19.660557] Loading compiled-in X.509 certificates
host1 # [   19.670225] Demotion targets for Node 0: null
host1 # [   19.670377] Key type .fscrypt registered
host1 # [   19.670381] Key type fscrypt-provisioning registered
host1 # [   19.670497] ima: No TPM chip found, activating TPM-bypass!
host1 # [   19.670521] ima: Allocated hash algorithm: sha1
host1 # [   19.670549] ima: No architecture policies found
host1 # [   19.671454] input: gpio-keys as /devices/platform/gpio-keys/input/input0
host1 # [   19.698541] clk: Disabling unused clocks
host1 # [   19.698561] PM: genpd: Disabling unused power domains
host1 # [   19.705827] Freeing unused kernel memory: 7808K
host1 # [   19.706193] Run /init as init process
host1 # [   19.726481] systemd[1]: Successfully made /usr/ read-only.
host1 # [   19.867567] usb 1-1: new high-speed USB device number 2 using ehci-pci
host1 # [   20.020038] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
host1 # [   20.060567] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
host1 # [   20.060596] systemd[1]: Detected virtualization qemu.
host1 # [   20.060669] systemd[1]: Detected architecture arm64.
host1 # [   20.060677] systemd[1]: Running in initrd.
host1 # [   20.061299] systemd[1]: Initializing machine ID from random generator.
host1 # [   20.062493] systemd[1]: Hostname set to <host1>.
host1 # [   20.111831] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0
host1 # [   20.213029] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [   20.235607] usb 1-2: new high-speed USB device number 3 using ehci-pci
host1 # [   20.280169] systemd[1]: Queued start job for default target Initrd Default Target.
host1 # [   20.287400] systemd[1]: Created slice Slice /system/modprobe.
host1 # [   20.288505] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [   20.288543] systemd[1]: Expecting device /dev/disk/by-label/nixos...
host1 # [   20.288580] systemd[1]: Reached target Path Units.
host1 # [   20.288597] systemd[1]: Reached target Slice Units.
host1 # [   20.288615] systemd[1]: Reached target Swaps.
host1 # [   20.288633] systemd[1]: Reached target Timer Units.
host1 # [   20.288809] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   20.289355] systemd[1]: Listening on Journal Socket (/dev/log).
host1 # [   20.289483] systemd[1]: Listening on Journal Sockets.
host1 # [   20.289564] systemd[1]: Listening on udev Kernel Socket.
host1 # [   20.289771] systemd[1]: Listening on udev Varlink Socket.
host1 # [   20.289791] systemd[1]: Reached target Socket Units.
host1 # [   20.300320] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [   20.300410] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   20.307689] systemd[1]: Mounting Kernel Configuration File System...
host1 # [   20.319836] systemd[1]: Starting Journal Service...
host1 # [   20.345003] systemd[1]: Starting Load Kernel Modules...
host1 # [   20.345133] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   20.359856] systemd[1]: Starting Coldplug All udev Devices...
host1 # [   20.371373] systemd-journald[70]: Collecting audit messages is disabled.
host1 # [   20.380699] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [   20.398271] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [   20.398840] systemd[1]: Mounted Kernel Configuration File System.
host1 # [   20.413937] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
host1 # [   20.414105] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0
host1 # [   20.471093] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
host1 # [   20.474259] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
host1 # [   20.484873] systemd[1]: Starting Create Static Device Nodes in /dev...
host1 # [   20.491203] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
host1 # [   20.501727] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
host1 # [   20.513496] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
host1 # [   20.513749] [drm] features: -virgl +edid -resource_blob -host_visible
host1 # [   20.513752] [drm] features: -context_init
host1 # [   20.514559] [drm] number of scanouts: 1
host1 # [   20.514570] [drm] number of cap sets: 0
host1 # [   20.541006] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
host1 # [   20.541020] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
host1 # [   20.567633] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [   20.567878] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [   20.567907] systemd[1]: Reached target Local File Systems.
host1 # [   20.575973] Console: switching to colour frame buffer device 160x50
host1 # [   20.585523] systemd[1]: Starting Rule-based Manager for Device Events and Files...
host1 # [   20.595845] systemd[1]: Started Journal Service.
host1 # [   20.473057] systemd-modules-load[72]: Inserted module 'dm_mod'
host1 # [   20.474567] systemd-modules-load[72]: Module 'virtio_balloon' is built in
host1 # [   20.475721] systemd-modules-load[72]: Module 'virtio_console' is built in
host1 # [   20.612228] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
host1 # [   20.492672] systemd-modules-load[72]: Inserted module 'virtio_gpu'
host1 # [   20.497163] systemd-modules-load[72]: Module 'virtio_rng' is built in
host1 # [   20.499397] systemd[1]: Starting Create System Files and Directories...
host1 # [   20.637581] NET: Registered PF_VSOCK protocol family
host1 # [   20.565723] systemd[1]: Finished Create System Files and Directories.
host1 # [   20.576406] systemd-modules-load[72]: Inserted module 'vmw_vsock_virtio_transport'
host1 # [   20.580180] systemd[1]: Finished Load Kernel Modules.
host1 # [   20.592182] systemd[1]: Starting Apply Kernel Variables...
host1 # [   20.606664] systemd-udevd[77]: Using default interface naming scheme 'v261'.
host1 # [   20.643602] systemd[1]: Finished Apply Kernel Variables.
host1 # [   20.657982] systemd[1]: Started Rule-based Manager for Device Events and Files.
host1 # [   20.772820] systemd[1]: Starting Virtual Console Setup...
host1 # [   20.869118] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   20.873181] systemd[1]: Finished Virtual Console Setup.
host1 # [   21.555552] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   21.556703] systemd[1]: Reached target System Initialization.
host1 # [   21.557542] systemd[1]: Reached target Basic System.
host1 # [   21.787383] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   21.800372] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   21.807014] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   21.951854] systemd[1]: Found device /dev/disk/by-label/nixos.
host1 # [   21.955476] systemd[1]: Reached target Initrd Root Device.
host1 # [   21.960326] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
host1 # [   22.012428] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks
host1 # [   22.020213] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
host1 # [   22.027226] systemd[1]: Mounting /sysroot...
host1 # [   22.203022] EXT4-fs (vda): mounted filesystem 01943825-328b-4608-8e46-f06fade03cb0 r/w with ordered data mode. Quota mode: none.
host1 # [   22.078979] systemd[1]: Mounted /sysroot.
host1 # [   22.081244] systemd[1]: Reached target Initrd Root File System.
host1 # [   22.086875] systemd[1]: Starting Mountpoints Configured in the Real Root...
host1 # [   22.122127] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.
host1 # [   22.128396] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...
host1 # [   22.133339] systemd[1]: Reloading...
host1 # [   22.366007] systemd[1]: Reloading finished in 234 ms.
host1 # [   22.399154] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...
host1 # [   22.403452] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...
host1 # [   22.413223] systemd[1]: Mounting /sysroot/nix/.ro-store...
host1 # [   22.425259] systemd[1]: Mounting /sysroot/nix/.rw-store...
host1 # [   22.454711] systemd[1]: Mounting /sysroot/run...
host1 # [   22.486637] systemd[1]: Mounting /sysroot/tmp/shared...
host1 # [   22.507327] systemd[1]: Mounting /sysroot/tmp/xchg...
host1 # [   22.510932] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
host1 # [   22.540128] systemd[1]: Finished Mountpoints Configured in the Real Root.
host1 # [   22.542218] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
host1 # [   22.561093] systemd[1]: Mounted /sysroot/nix/.rw-store.
host1 # [   22.707352] fuse: init (API version 7.45)
host1 # [   22.716643] virtiofs virtio6: discovered new tag: nix-store
host1 # [   22.717478] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
host1 # [   22.738357] virtiofs virtio7: discovered new tag: shared
host1 # [   22.739189] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
host1 # [   22.619177] systemd[1]: Mounted /sysroot/run.
host1 # [   22.756394] virtiofs virtio8: discovered new tag: xchg
host1 # [   22.757280] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
host1 # [   22.661586] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [   22.669465] systemd[1]: Mounted /sysroot/nix/.ro-store.
host1 # [   22.672363] systemd[1]: Mounted /sysroot/tmp/shared.
host1 # [   22.686214] systemd[1]: Mounted /sysroot/tmp/xchg.
host1 # [   22.710990] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [   22.714918] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [   22.717597] systemd[1]: Mounting /sysroot/nix/store...
host1 # [   22.782082] systemd[1]: Mounted /sysroot/nix/store.
host1 # [   22.784315] systemd[1]: Reached target Initrd File Systems.
host1 # [   22.788300] systemd[1]: Starting Find NixOS closure...
host1 # [   22.795038] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
host1 # [   22.852614] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
host1 # [   22.868257] systemd[1]: Finished Find NixOS closure.
host1 # [   22.871979] systemd[1]: Reached target Initrd Default Target.
host1 # [   22.883101] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
host1 # [   22.918214] systemd[1]: Stopped target Initrd Default Target.
host1 # [   22.921415] systemd[1]: Stopped target Basic System.
host1 # [   22.925041] systemd[1]: Stopped target Initrd Root Device.
host1 # [   22.927268] systemd[1]: Stopped target Path Units.
host1 # [   22.930023] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
host1 # [   22.933968] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
host1 # [   22.941348] systemd[1]: Stopped target Slice Units.
host1 # [   22.943060] systemd[1]: Stopped target Socket Units.
host1 # [   22.945081] systemd[1]: Stopped target System Initialization.
host1 # [   22.945984] systemd[1]: Stopped target Swaps.
host1 # [   22.948550] systemd[1]: Stopped target Timer Units.
host1 # [   22.953016] systemd[1]: dbus.socket: Deactivated successfully.
host1 # [   22.954546] systemd[1]: Closed D-Bus System Message Bus Socket.
host1 # [   22.956671] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
host1 # [   22.961903] systemd[1]: Stopped Find NixOS closure.
host1 # [   22.966720] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [   22.985410] systemd[1]: systemd-sysctl.service: Deactivated successfully.
host1 # [   22.989012] systemd[1]: Stopped Apply Kernel Variables.
host1 # [   22.992774] systemd[1]: systemd-modules-load.service: Deactivated successfully.
host1 # [   22.999439] systemd[1]: Stopped Load Kernel Modules.
host1 # [   23.000670] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
host1 # [   23.003782] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
host1 # [   23.008560] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
host1 # [   23.009704] systemd[1]: Stopped Create System Files and Directories.
host1 # [   23.012355] systemd[1]: Stopped target Local File Systems.
host1 # [   23.013220] systemd[1]: Stopped target Preparation for Local File Systems.
host1 # [   23.016797] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
host1 # [   23.017903] systemd[1]: Stopped Coldplug All udev Devices.
host1 # [   23.020165] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
host1 # [   23.021290] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   23.024126] systemd[1]: Stopped Virtual Console Setup.
host1 # [   23.025873] systemd[1]: initrd-cleanup.service: Deactivated successfully.
host1 # [   23.028181] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
host1 # [   23.030656] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [   23.031871] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [   23.046902] systemd[1]: systemd-udevd.service: Deactivated successfully.
host1 # [   23.048740] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
host1 # [   23.052134] systemd[1]: systemd-udevd.service: Consumed 1.135s CPU time over 2.594s wall clock time, 18M memory peak.
host1 # [   23.053691] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
host1 # [   23.056260] systemd[1]: Closed udev Varlink Socket.
host1 # [   23.060539] systemd[1]: Starting Cleanup udev Database...
host1 # [   23.061481] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
host1 # [   23.062723] systemd[1]: Stopped Create Static Device Nodes in /dev.
host1 # [   23.064747] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
host1 # [   23.067695] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
host1 # [   23.069061] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
host1 # [   23.070077] systemd[1]: Stopped Create List of Static Device Nodes.
host1 # [   23.107374] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
host1 # [   23.109678] systemd[1]: Finished Cleanup udev Database.
host1 # [   23.112535] systemd[1]: Reached target Switch Root.
host1 # [   23.113835] systemd[1]: Starting NixOS Activation...
host1 # [   23.238169] initrd-nixos-activation-start[171]: booting system configuration /nix/store/3q2k45y3674bv2nca39glacb1rpap6w3-nixos-system-host1-test
host1 # [   23.279888] initrd-nixos-activation-start[171]: running activation script...
host1 # [   23.759063] initrd-nixos-activation-start[194]: setting up /etc...
host1 # [   23.907689] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
host1 # [   23.911320] systemd[1]: Finished NixOS Activation.
host1 # [   23.916567] systemd[1]: Starting Switch Root...
host1 # [   23.937999] systemd[1]: Switching root.
host1 # [   24.234168] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
host1 # [   24.766898] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
host1 # [   24.766960] systemd[1]: Detected virtualization qemu.
host1 # [   24.767043] systemd[1]: Detected architecture arm64.
host1 # [   24.767176] systemd[1]: Detected first boot.
host1 # [   24.780775] systemd[1]: Initializing machine ID from random generator.
host1 # [   24.953249] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [   25.331898] systemd[1]: Applying preset policy.
host1 # [   25.766178] systemd[1]: Populated /etc with preset unit settings.
host1 # [   25.988020] systemd[1]: initrd-switch-root.service: Deactivated successfully.
host1 # [   25.988512] systemd[1]: Stopped initrd-switch-root.service.
host1 # [   25.994159] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
host1 # [   25.997410] systemd[1]: Created slice Slice /system/getty.
host1 # [   25.999221] systemd[1]: Created slice User and Session Slice.
host1 # [   26.002399] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [   26.002937] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
host1 # [   26.006861] systemd[1]: Expecting device /dev/hvc0...
host1 # [   26.007355] systemd[1]: Expecting device /dev/ttyAMA0...
host1 # [   26.009178] systemd[1]: Reached target Local Encrypted Volumes.
host1 # [   26.009572] systemd[1]: Stopped target initrd-fs.target.
host1 # [   26.013936] systemd[1]: Stopped target initrd-root-fs.target.
host1 # [   26.014384] systemd[1]: Stopped target initrd-switch-root.target.
host1 # [   26.015144] systemd[1]: Reached target Virtual Machines and Containers.
host1 # [   26.018593] systemd[1]: Reached target Path Units.
host1 # [   26.019014] systemd[1]: Reached target Remote File Systems.
host1 # [   26.021683] systemd[1]: Reached target Slice Units.
host1 # [   26.022183] systemd[1]: Reached target Swaps.
host1 # [   26.025535] systemd[1]: Listening on Query the User Interactively for a Password.
host1 # [   26.028486] systemd[1]: Listening on Process Core Dump Socket.
host1 # [   26.029820] systemd[1]: Listening on Credential Encryption/Decryption.
host1 # [   26.031362] systemd[1]: Listening on Factory Reset Management.
host1 # [   26.035024] systemd[1]: Listening on Hostname Service Socket.
host1 # [   26.040887] systemd[1]: Starting Journal Log Access Socket...
host1 # [   26.042150] systemd[1]: Listening on Journal Audit Socket.
host1 # [   26.046217] systemd[1]: Listening on Console Output Muting Service Socket.
host1 # [   26.046982] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
host1 # [   26.050271] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   26.051151] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
host1 # [   26.059353] systemd[1]: Listening on Disk Repartitioning Service Socket.
host1 # [   26.060928] systemd[1]: Listening on udev Varlink Socket.
host1 # [   26.065340] systemd[1]: Mounting Huge Pages File System...
host1 # [   26.070242] systemd[1]: Mounting POSIX Message Queue File System...
host1 # [   26.087822] systemd[1]: Mounting Kernel Debug File System...
host1 # [   26.099185] systemd[1]: Mounting Kernel Trace File System...
host1 # [   26.115720] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [   26.121238] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   26.132282] systemd[1]: Mounting Kernel Configuration File System...
host1 # [   26.133423] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
host1 # [   26.144343] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
host1 # [   26.144930] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [   26.162924] systemd[1]: Mounting FUSE Control File System...
host1 # [   26.167723] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
host1 # [   26.214384] systemd[1]: Starting Journal Service...
host1 # [   26.236772] systemd[1]: Starting Load Kernel Modules...
host1 # [   26.266734] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
host1 # [   26.289039] systemd[1]: Starting Remount Root and Kernel File Systems...
host1 # [   26.289467] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   26.305810] systemd[1]: Starting Coldplug All udev Devices...
host1 # [   26.318138] systemd[1]: Listening on Journal Log Access Socket.
host1 # [   26.318666] systemd[1]: Mounted Huge Pages File System.
host1 # [   26.319120] systemd[1]: Mounted POSIX Message Queue File System.
host1 # [   26.327869] systemd[1]: Mounted Kernel Debug File System.
host1 # [   26.328524] systemd[1]: Mounted Kernel Trace File System.
host1 # [   26.335971] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [   26.361397] systemd-journald[266]: Collecting audit messages is enabled.
host1 # [   26.365754] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [   26.420222] systemd[1]: Mounted Kernel Configuration File System.
host1 # [   26.298567] systemd[1]: Queued start job for default target Multi-User System.
host1 # [   26.432692] systemd[1]: Started Journal Service.
host1 # [   26.316290] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [   26.317772] systemd-modules-load[267]: Module 'atkbd' is built in
host1 # [   26.318876] systemd-modules-load[267]: Module 'loop' is built in
host1 # [   26.319864] systemd[1]: Mounted FUSE Control File System.
host1 # [   26.344612] systemd[1]: Finished Load Kernel Modules.
host1 # [   26.345606] systemd[1]: Starting Firewall...
host1 # [   26.346869] systemd-oomd[268]: No swap; memory pressure usage will be degraded
host1 # [   26.361777] systemd[1]: Starting Apply Kernel Variables...
host1 # [   26.362961] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
host1 # [   26.504281] EXT4-fs (vda): re-mounted 01943825-328b-4608-8e46-f06fade03cb0.
host1 # [   26.395021] systemd[1]: Finished Remount Root and Kernel File Systems.
host1 # [   26.411634] systemd[1]: Listening on Disk Image Download Service Socket.
host1 # [   26.429470] systemd[1]: Starting Flush Journal to Persistent Storage...
host1 # [   26.437176] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [   26.447618] systemd[1]: Starting Load/Save OS Random Seed...
host1 # [   26.456337] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   26.677338] systemd-journald[266]: Received client request to flush runtime journal.
host1 # [   26.677695] systemd[1]: Finished Load/Save OS Random Seed.
host1 # [   26.678911] systemd[1]: Reached target First Boot Complete.
host1 # [   26.679773] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
host1 # [   26.692433] systemd[1]: Starting Create Static Device Nodes in /dev...
host1 # [   26.693591] systemd[1]: Finished Apply Kernel Variables.
host1 # [   26.694516] systemd[1]: Finished Flush Journal to Persistent Storage.
host1 # [   26.837571] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [   26.844192] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [   26.864755] systemd[1]: Starting Rule-based Manager for Device Events and Files...
host1 # [   26.873236] systemd[1]: Mounting /run/wrappers...
host1 # [   26.986831] systemd[1]: Mounted /run/wrappers.
host1 # [   26.987728] systemd[1]: Reached target Local File Systems.
host1 # [   26.996545] systemd[1]: Listening on Boot Loader Control Service Socket.
host1 # [   27.002104] systemd[1]: Starting register-nix-paths.service...
host1 # [   27.011637] systemd[1]: Starting Create SUID/SGID Wrappers...
host1 # [   27.016377] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
host1 # [   27.040144] systemd[1]: Starting Save Transient machine-id to Disk...
host1 # [   27.050193] systemd[1]: Starting Create System Files and Directories...
host1 # [   27.287287] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
host1 # [   27.300964] systemd[1]: Finished Save Transient machine-id to Disk.
host1 # [   27.411783] systemd[1]: Finished Create System Files and Directories.
host1 # [   27.426443] systemd[1]: Starting Rebuild Journal Catalog...
host1 # [   27.436167] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
host1 # [   27.484944] systemd-udevd[304]: Using default interface naming scheme 'v261'.
host1 # [   27.606694] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
host1 # [   27.690520] systemd[1]: Finished Rebuild Journal Catalog.
host1 # [   27.706529] systemd[1]: Starting Update is Completed...
host1 # [   27.802750] systemd[1]: Started Rule-based Manager for Device Events and Files.
host1 # [   27.829270] systemd[1]: Finished Update is Completed.
host1 # [   28.687108] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   28.902671] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
host1 # [   28.910623] systemd[1]: Finished Create SUID/SGID Wrappers.
host1 # [   29.695960] systemd[1]: Finished register-nix-paths.service.
host1 # [   29.699286] systemd[1]: Reached target System Initialization.
host1 # [   29.702787] systemd[1]: Started Renew ACME Certificate for host1.
host1 # [   29.703769] systemd[1]: Started Discard unused filesystem blocks once a week.
host1 # [   29.712356] systemd[1]: Started Daily Cleanup of Temporary Directories.
host1 # [   29.713400] systemd[1]: Reached target Timer Units.
host1 # [   29.714167] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   29.715090] systemd[1]: Listening on Nix Daemon Socket.
host1 # [   29.715885] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
host1 # [   29.728373] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
host1 # [   29.729731] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
host1 # [   29.740691] systemd[1]: Starting D-Bus System Message Bus...
host1 # [   29.796250] systemd-ssh-issue[479]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
host1 # [   29.812403] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
host1 # [   29.813779] systemd[1]: Reached target Socket Units.
host1 # [   29.887207] systemd[1]: Finished Firewall.
host1 # [   29.902486] dbus-broker-launch[481]: Looking up NSS user entry for 'systemd-timesync'...
host1 # [   29.907798] dbus-broker-launch[481]: NSS returned no entry for 'systemd-timesync'
host1 # [   29.910477] dbus-broker-launch[481]: Invalid user-name in /nix/store/z6iifw9fw7ig2a8pkbbfxrjga9mrfywz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
host1 # [   29.969893] systemd[1]: Started D-Bus System Message Bus.
host1 # [   29.978460] systemd[1]: Reached target Basic System.
host1 # [   29.988758] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
host1 # [   29.996233] systemd[1]: Starting Import lastlog data into lastlog2 database...
host1 # [   30.003805] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   30.011394] systemd[1]: Starting Post-Boot Actions...
host1 # [   30.114030] dbus-broker-launch[481]: Ready
host1 # [   30.284403] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [   30.213147] systemd[1]: Started Reset console on configuration changes.
host1 # [   30.260466] systemd[1]: Starting resolvconf update...
host1 # [   30.290699] systemd[1]: Starting SSH Host Keys Generation...
host1 # [   30.389890] acme-setup-privileged[494]: + set -euo pipefail
host1 # [   30.391143] acme-setup-privileged[494]: + cd /var/lib/acme
host1 # [   30.391997] acme-setup-privileged[494]: + chmod -R u=rwX,g=,o= .lego/accounts
host1 # [   30.436970] acme-setup-privileged[494]: + chown -R acme .lego/accounts
host1 # [   30.468131] systemd[1]: Finished Post-Boot Actions.
host1 # [   30.486588] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   30.496546] acme-setup-privileged[494]: + for fixpath in host1 .lego/host1
host1 # [   30.497713] acme-setup-privileged[494]: + '[' -d host1 ']'
host1 # [   30.498575] acme-setup-privileged[494]: + for fixpath in host1 .lego/host1
host1 # [   30.499542] acme-setup-privileged[494]: + '[' -d .lego/host1 ']'
host1 # [   30.525320] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   30.526391] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   30.532457] nsncd[496]: Nov 12 10:13:06.533 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   30.543754] systemd[1]: Starting User Login Management...
host1 # [   30.582898] systemd[1]: Finished Import lastlog data into lastlog2 database.
host1 # [   30.678473] systemd[1]: Created slice Slice /system/sshd-vsock.
host1 # [   30.842888] systemd-logind[525]: New seat seat0.
host1 # [   30.851916] systemd[1]: Started User Login Management.
host1 # [   30.865836] systemd[1]: Starting linger-users.service...
host1 # [   30.870403] acme-setup-start[526]: + set -euo pipefail
host1 # [   30.871318] acme-setup-start[526]: + test -e ca/key.pem
host1 # [   30.881151] acme-setup-start[526]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
host1 # [   31.014207] systemd[1]: Stopped target Host and Network Name Lookups.
host1 # [   31.020098] systemd[1]: Stopping Host and Network Name Lookups...
host1 # [   31.030825] systemd[1]: Stopped target User and Group Name Lookups.
host1 # [   31.031939] systemd[1]: Stopping User and Group Name Lookups...
host1 # [   31.037568] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
host1 # [   31.038694] systemd[1]: linger-users.service: Deactivated successfully.
host1 # [   31.039689] systemd[1]: Finished linger-users.service.
host1 # [   31.055883] systemd[1]: nscd.service: Deactivated successfully.
host1 # [   31.060550] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
host1 # [   31.076108] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
host1 # [   31.102536] systemd[1]: Starting Ensure certificate for host1...
host1 # [   31.115466] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   31.416162] systemd[1]: Finished resolvconf update.
host1 # [   31.424458] systemd[1]: Reached target Preparation for Network.
host1 # [   31.438495] systemd[1]: Starting DHCP Client...
host1 # [   31.454902] nsncd[602]: Nov 12 10:13:07.438 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   31.472437] systemd[1]: Starting Extra networking commands....
host1 # [   31.473809] acme-host1-start[597]: Waiting to acquire lock in /run/acme/
host1 # [   31.474863] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   31.475778] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   31.486974] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   31.541929] acme-host1-start[597]: + '[' -e out/acme-success ']'
host1 # [   31.543056] acme-host1-start[597]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=
host1 # [   31.624666] acme-host1-start[644]: + cd host1
host1 # [   31.625506] acme-host1-start[644]: + cp -vp cert.pem ../out/cert.pem
host1 # [   31.636622] acme-host1-start[645]: 'cert.pem' -> '../out/cert.pem'
host1 # [   31.648384] acme-host1-start[644]: + cp -vp key.pem ../out/key.pem
host1 # [   31.649448] acme-host1-start[644]: 'key.pem' -> '../out/key.pem'
host1 # [   31.664225] acme-host1-start[597]: + cat out/cert.pem ca/cert.pem
host1 # [   31.685661] acme-host1-start[597]: + cp ca/cert.pem out/chain.pem
host1 # [   31.702119] acme-host1-start[597]: + cat out/key.pem out/fullchain.pem
host1 # [   31.729742] acme-host1-start[597]: + for fixpath in out certificates
host1 # [   31.730863] acme-host1-start[597]: + '[' -d out ']'
host1 # [   31.731583] acme-host1-start[597]: + chmod -R u=rwX,g=rX,o= out
host1 # [   31.752319] acme-host1-start[597]: + chown -R acme:acme out
host1 # [   31.781306] acme-host1-start[597]: + for fixpath in out certificates
host1 # [   31.782526] acme-host1-start[597]: + '[' -d certificates ']'
host1 # [   31.798295] systemd[1]: Finished Ensure certificate for host1.
host1 # [   31.926634] dhcpcd[648]: dhcpcd-10.3.2 starting
host1 # [   31.957590] dhcpcd[687]: dev: loaded udev
host1 # [   31.964135] dhcpcd[687]: no valid interfaces found
host1 # [   31.965781] dhcpcd[687]: no valid interfaces found
host1 # [   32.123924] systemd[1]: Starting Virtual Console Setup...
host1 # [   32.167388] systemd[1]: Finished Extra networking commands..
host1 # [   32.168754] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   32.169885] systemd[1]: Stopped Virtual Console Setup.
host1 # [   32.180723] systemd[1]: Reached target Network.
host1 # [   32.182213] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   32.198908] systemd[1]: Starting Permit User Sessions...
host1 # [   32.205384] systemd[1]: Starting Virtual Console Setup...
host1 # [   32.316268] systemd[1]: Finished Permit User Sessions.
host1 # [   32.336320] systemd[1]: Started Getty on tty1.
host1 # [   32.337190] systemd[1]: Reached target Login Prompts.
host1 # [   32.556710] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
host1 # [   32.704700] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
host1 # [   32.719311] systemd[1]: Started backdoor.service.
host1 # connecting to host...
host1 # [   32.919134] (udev-worker)[587]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   32.932221] (udev-worker)[611]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   32.937501] (udev-worker)[587]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   33.146508] 8021q: 802.1Q VLAN Support v1.8
host1 # [   33.329743] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   33.209298] sshd-keygen-start[547]: Generating public/private rsa key pair.
host1 # [   33.210459] sshd-keygen-start[547]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
host1 # [   33.211654] sshd-keygen-start[547]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
host1 # [   33.348522] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
host1 # [   33.349046] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
host1 # [   33.354777] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
host1 # [   33.355156] cfg80211: failed to load regulatory.db
host1 # [   33.227854] sshd-keygen-start[547]: The key fingerprint is:
host1 # [   33.237636] sshd-keygen-start[547]: SHA256:XWFtiUFfd3bpZvqBYDxKEpT9+PW1bn94VAdBBd3PfXo root@host1
host1 # [   33.238964] sshd-keygen-start[547]: The key's randomart image is:
host1 # [   33.239836] sshd-keygen-start[547]: +---[RSA 4096]----+
host1 # [   33.247361] sshd-keygen-start[547]: |      ..o  .==+*X|
host1 # [   33.250794] sshd-keygen-start[547]: |       o . ..o=+*|
host1 # [   33.251600] sshd-keygen-start[547]: |        . + ..ooo|
host1 # [   33.255541] sshd-keygen-start[547]: |       . + B . +O|
host1 # [   33.259213] sshd-keygen-start[547]: |        S = + *.*|
host1 # [   33.263423] sshd-keygen-start[547]: |         . . o.+E|
host1 # [   33.267430] sshd-keygen-start[547]: |              o+.|
host1 # [   33.270878] sshd-keygen-start[547]: |              .+o|
host1 # [   33.271707] sshd-keygen-start[547]: |              ..+|
host1 # [   33.276406] sshd-keygen-start[547]: +----[SHA256]-----+
host1 # [   33.304429] sshd-keygen-start[730]: Generating public/private ed25519 key pair.
host1 # [   33.305571] sshd-keygen-start[730]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
host1 # [   33.306836] sshd-keygen-start[730]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
host1 # [   33.315512] sshd-keygen-start[730]: The key fingerprint is:
host1 # [   33.318591] sshd-keygen-start[730]: SHA256:6YMCyUIkTfwmf+GrCD/Fkej+Rwytv++lxgaRfsofd7M root@host1
host1 # [   33.319850] sshd-keygen-start[730]: The key's randomart image is:
host1 # [   33.326548] sshd-keygen-start[730]: +--[ED25519 256]--+
host1 # [   33.327376] sshd-keygen-start[730]: |.=.              |
host1 # [   33.330905] sshd-keygen-start[730]: |o o              |
host1 # [   33.331749] sshd-keygen-start[730]: | . o o .         |
host1 # [   33.338673] sshd-keygen-start[730]: |..o.* =  .       |
host1 # [   33.339502] sshd-keygen-start[730]: |..+= B oS        |
host1 # [   33.343433] sshd-keygen-start[730]: | ...= Bo.        |
host1 # [   33.346153] sshd-keygen-start[730]: |.. ..=.*+ o o    |
host1 # [   33.346923] sshd-keygen-start[730]: | oo. .* +* . o   |
host1 # [   33.347642] sshd-keygen-start[730]: |  oooo.B=   E    |
host1 # [   33.354181] sshd-keygen-start[730]: +----[SHA256]-----+
host1 # [   33.377330] sshd-keygen-start[738]: Generating public/private mldsa44-ed25519 key pair.
host1 # [   33.378715] sshd-keygen-start[738]: Your identification has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key
host1 # [   33.382540] sshd-keygen-start[738]: Your public key has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key.pub
host1 # [   33.383955] sshd-keygen-start[738]: The key fingerprint is:
host1 # [   33.387311] sshd-keygen-start[738]: SHA256:N1RJ6S+91qzppPym//pRyVUvFwLp2pJUe4iybkpZQ1Q root@host1
host1 # [   33.393706] sshd-keygen-start[738]: The key's randomart image is:
host1 # [   33.394833] sshd-keygen-start[738]: +[MLDSA44-ED25519-+
host1 # [   33.395574] sshd-keygen-start[738]: |       ..E o=+ ..|
host1 # [   33.402013] sshd-keygen-start[738]: |      .    +o . +|
host1 # [   33.402874] sshd-keygen-start[738]: |       .  =.o . +|
host1 # [   33.403575] sshd-keygen-start[738]: |      .. + +...oo|
host1 # [   33.409958] sshd-keygen-start[738]: |       oS * .o o.|
host1 # [   33.410862] sshd-keygen-start[738]: |      o..= o. o .|
host1 # [   33.411605] sshd-keygen-start[738]: |     o.   .  ..= |
host1 # [   33.419930] sshd-keygen-start[738]: |    .  o   . o+.+|
host1 # [   33.424205] sshd-keygen-start[738]: |     .o     +BB=o|
host1 # [   33.425031] sshd-keygen-start[738]: +----[SHA256]-----+
host1 # [   33.426195] systemd[1]: sshd-keygen.service: Deactivated successfully.
host1 # [   33.427166] systemd[1]: Finished SSH Host Keys Generation.
host1 # [   33.427944] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
host1 # [   33.438433] systemd[1]: Starting SSH Daemon...
host1 # [   33.547059] sshd[741]: Server listening on 0.0.0.0 port 22.
host1 # [   33.552251] systemd[1]: Started SSH Daemon.
host1 # [   33.553034] sshd[741]: Server listening on :: port 22.
host1 # [   33.608216] systemd[1]: Condition check resulted in Virtio network device being skipped.
host1 # [   33.620176] systemd[1]: Starting Address configuration of eth1...
host1 # [   33.709661] systemd-vconsole-setup[709]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   33.725503] sshd-session[740]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   33.727512] systemd[1]: Finished Virtual Console Setup.
host1 # [   33.748842] sshd-session[740]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   33.776284] sshd-session[740]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   33.920514] 8021q: adding VLAN 0 to HW filter on device eth0
host1 # [   33.808890] dhcpcd[687]: eth0: waiting for carrier
host1 # [   33.942351] 8021q: adding VLAN 0 to HW filter on device eth1
host1 # [   33.816165] dhcpcd[687]: eth0: carrier acquired
host1 # [   33.837952] dhcpcd[687]: DUID 00:01:00:01:32:88:4d:b5:52:54:00:12:34:56
host1 # [   33.839178] dhcpcd[687]: eth0: IAID 00:12:34:56
host1 # [   33.839865] dhcpcd[687]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   33.852751] network-addresses-eth1-start[745]: adding address 192.168.1.1/24... done
host1 # [   33.866908] systemd-logind[525]: New session '1' of user 'root' with class 'user' and type 'tty'.
host1 # [   33.900240] systemd[1]: Created slice Slice /user/0.
host1 # [   33.901158] systemd[1]: Starting User Runtime Directory /run/user/0...
host1 # [   33.921983] network-addresses-eth1-start[745]: adding address 2001:db8:1::1/64... done
host1 # [   34.019997] systemd-logind[525]: Watching system buttons on /dev/input/event0 (gpio-keys)
host1 # [   34.069661] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   34.070808] systemd[1]: Starting User Manager for UID 0...
host1 # [   34.107184] systemd[1]: Finished Address configuration of eth1.
host1 # [   34.279778] mousedev: PS/2 mouse device common for all mice
host1 # [   34.168774] (systemd)[783]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   34.184652] systemd-logind[525]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   34.403611] systemd[783]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   34.466549] systemd-logind[525]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
host1 # [   34.764482] systemd[783]: Queued start job for default target Main User Target.
host1 # [   34.765690] systemd[783]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   34.767264] systemd[783]: Created slice User Application Slice.
host1 # [   34.866027] systemd[783]: Started Daily Cleanup of User's Temporary Directories.
host1 # [   34.867281] systemd[783]: Reached target Paths.
host1 # [   34.932527] systemd[783]: Reached target Timers.
host1 # [   34.963933] systemd[783]: Starting D-Bus User Message Bus Socket...
host1 # [   34.988399] systemd[783]: Starting Create User Files and Directories...
host1 # [   34.989458] systemd[783]: Finished Create User Files and Directories.
host1 # [   34.990493] systemd[783]: Listening on D-Bus User Message Bus Socket.
host1 # [   34.991348] systemd[783]: Reached target Sockets.
host1 # [   35.048778] systemd[783]: Reached target Basic System.
host1 # [   35.049826] sshd-session[795]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   35.051281] systemd[783]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
host1 # [   35.089759] sshd-session[795]: Disconnected from user root UNKNOWN port 65535
host1 # [   35.090894] systemd[783]: Reached target Main User Target.
host1 # [   35.127398] sshd-session[740]: pam_unix(sshd:session): session closed for user root
host1 # [   35.161471] systemd[783]: Startup finished in 677ms.
host1 # [   35.162742] systemd[1]: Started User Manager for UID 0.
host1 # [   35.163540] systemd[1]: Started Session 1 of User root.
host1 # [   35.199675] systemd[1]: sshd-vsock@0-1-3:22-2:4.service: Deactivated successfully.
host1 # [   35.218101] dhcpcd[687]: eth0: soliciting a DHCP lease
host1 # [   35.219046] systemd[1]: session-1.scope: Deactivated successfully.
host1 # [   35.219931] dhcpcd[687]: eth0: offered 10.0.2.15 from 10.0.2.2
host1 # [   35.276643] systemd-logind[525]: Session 1 logged out. Waiting for processes to exit.
host1 # [   35.277826] dhcpcd[687]: eth0: probing address 10.0.2.15/24
host1 # [   35.278751] systemd-logind[525]: Removed session 1.
host1 # [   36.006234] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
host1 # [   36.018539] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   36.019770] systemd[1]: Stopped Virtual Console Setup.
host1 # [   36.044588] systemd[1]: Stopping Virtual Console Setup...
host1 # [   36.045473] systemd[1]: Starting Virtual Console Setup...
host1 # [   36.080487] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   36.081689] systemd[1]: Stopped Virtual Console Setup.
host1 # [   36.082463] systemd-logind[525]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
host1 # [   36.091389] systemd[1]: Starting Virtual Console Setup...
host1 # [   36.111204] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   59.110096] systemd[1]: Created slice Slice /system/sshd-vsock.
server # [   59.114994] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   36.117570] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).
server # [   59.121227] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
host1 # [   36.239751] sshd-session[809]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   36.251580] sshd-session[809]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   59.255645] sshd-session[998]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   36.264800] sshd-session[809]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   59.264262] sshd-session[998]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   59.274158] sshd-session[998]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   36.276956] systemd-logind[525]: New session '3' of user 'root' with class 'user' and type 'tty'.
host1 # [   36.289725] systemd[1]: Started Session 3 of User root.
server # [   59.295824] systemd[1]: Created slice Slice /user/0.
server # [   59.301123] systemd[1]: Starting User Runtime Directory /run/user/0...
server # [   59.310054] systemd-logind[539]: New session '1' of user 'root' with class 'user' and type 'tty'.
host1 # [   36.321894] systemd-vconsole-setup[808]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   36.327953] systemd[1]: Finished Virtual Console Setup.
server # [   59.346409] systemd[1]: Finished User Runtime Directory /run/user/0.
server # [   59.354011] systemd[1]: Starting User Manager for UID 0...
host1 # [   36.367745] sshd-session[816]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   36.370369] sshd-session[816]: Disconnected from user root UNKNOWN port 65535
host1 # [   36.372102] sshd-session[809]: pam_unix(sshd:session): session closed for user root
host1 # [   36.375927] systemd[1]: sshd-vsock@1-2-3:22-2:5.service: Deactivated successfully.
host1 # [   36.381718] systemd[1]: session-3.scope: Deactivated successfully.
server # [   59.382983] (systemd)[1006]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   36.386244] systemd-logind[525]: Session 3 logged out. Waiting for processes to exit.
host1 # [   36.388241] systemd-logind[525]: Removed session 3.
server # [   59.390039] systemd-logind[539]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
server # [   59.486912] systemd[1006]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   36.522985] dhcpcd[687]: eth0: soliciting an IPv6 router
host1 # [   36.524390] dhcpcd[687]: eth0: Router Advertisement from fe80::2
host1 # [   36.525741] dhcpcd[687]: eth0: adding address fec0::5054:ff:fe12:3456/64
host1 # [   36.527205] dhcpcd[687]: eth0: adding route to fec0::/64
host1 # [   36.528455] dhcpcd[687]: eth0: adding default route via fe80::2
server # [   59.610353] systemd[1006]: Queued start job for default target Main User Target.
server # [   59.617165] systemd[1006]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
server # [   59.621811] systemd[1006]: Created slice User Application Slice.
server # [   59.622872] systemd[1006]: Started Daily Cleanup of User's Temporary Directories.
server # [   59.623940] systemd[1006]: Reached target Paths.
server # [   59.627205] systemd[1006]: Reached target Timers.
server # [   59.629630] systemd[1006]: Starting D-Bus User Message Bus Socket...
server # [   59.631210] systemd[1006]: Starting Create User Files and Directories...
server # [   59.685059] systemd[1006]: Finished Create User Files and Directories.
server # [   59.712352] systemd[1006]: Listening on D-Bus User Message Bus Socket.
server # [   59.717471] systemd[1006]: Reached target Sockets.
server # [   59.718487] systemd[1006]: Reached target Basic System.
server # [   59.719329] systemd[1]: Started User Manager for UID 0.
server # [   59.722558] systemd[1006]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
server # [   59.726764] systemd[1006]: Reached target Main User Target.
server # [   59.727693] systemd[1006]: Startup finished in 308ms.
server # [   59.728713] systemd[1]: Started Session 1 of User root.
server # [   59.765371] sshd-session[1019]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   59.768109] sshd-session[1019]: Disconnected from user root UNKNOWN port 65535
server # [   59.770234] sshd-session[998]: pam_unix(sshd:session): session closed for user root
server # [   59.773903] systemd[1]: sshd-vsock@0-1-4:22-2:0.service: Deactivated successfully.
server # [   59.779016] systemd[1]: session-1.scope: Deactivated successfully.
server # [   59.783692] systemd-logind[539]: Session 1 logged out. Waiting for processes to exit.
server # [   59.786463] systemd-logind[539]: Removed session 1.
server # [   60.873802] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   60.882258] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
host1 # [   37.879728] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   37.887958] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).
host1 # [   37.909118] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).
host1 # [   37.915599] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   37.928106] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).
server # [   60.984695] sshd-session[1024]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   60.992306] sshd-session[1024]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   61.001980] sshd-session[1024]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   61.012669] systemd-logind[539]: New session '3' of user 'root' with class 'user' and type 'tty'.
server # [   61.020957] systemd[1]: Started Session 3 of User root.
host1 # [   38.106643] sshd-session[823]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   38.113514] sshd-session[824]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   38.125425] sshd-session[823]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   38.133022] sshd-session[824]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   38.139317] sshd-session[825]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   38.151723] sshd-session[823]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   38.157542] sshd-session[825]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   38.158727] sshd-session[824]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   38.175843] systemd-logind[525]: New session '4' of user 'root' with class 'user' and type 'tty'.
host1 # [   38.178474] sshd-session[825]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   38.182602] systemd[1]: Started Session 4 of User root.
host1 # [   38.188992] systemd-logind[525]: New session '5' of user 'root' with class 'user' and type 'tty'.
host1 # [   38.194658] systemd[1]: Started Session 5 of User root.
host1 # [   38.199990] systemd-logind[525]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   38.206732] systemd[1]: Started Session 6 of User root.
host1 # [   38.346527] sshd-session[842]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   38.350518] sshd-session[841]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   38.351873] sshd-session[841]: Disconnected from user root UNKNOWN port 65535
host1 # [   38.355397] sshd-session[842]: Disconnected from user root UNKNOWN port 65535
host1 # [   38.360382] sshd-session[823]: pam_unix(sshd:session): session closed for user root
host1 # [   38.361537] sshd-session[824]: pam_unix(sshd:session): session closed for user root
host1 # [   38.362734] sshd-session[843]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   38.367105] sshd-session[843]: Disconnected from user root UNKNOWN port 65535
host1 # [   38.372532] sshd-session[825]: pam_unix(sshd:session): session closed for user root
host1 # [   38.373717] systemd[1]: sshd-vsock@3-4-3:22-2:7.service: Deactivated successfully.
host1 # [   38.378573] systemd[1]: sshd-vsock@2-3-3:22-2:6.service: Deactivated successfully.
host1 # [   38.383347] systemd[1]: session-4.scope: Deactivated successfully.
host1 # [   38.387237] systemd[1]: sshd-vsock@4-5-3:22-2:8.service: Deactivated successfully.
host1 # [   38.393278] systemd[1]: session-6.scope: Deactivated successfully.
host1 # [   38.396410] systemd[1]: session-5.scope: Deactivated successfully.
host1 # [   38.401121] systemd-logind[525]: Session 5 logged out. Waiting for processes to exit.
host1 # [   38.403802] systemd-logind[525]: Removed session 5.
host1 # [   38.405976] systemd-logind[525]: Session 4 logged out. Waiting for processes to exit.
host1 # [   38.407819] systemd-logind[525]: Removed session 4.
host1 # [   38.409633] systemd-logind[525]: Session 6 logged out. Waiting for processes to exit.
host1 # [   38.411729] systemd-logind[525]: Removed session 6.
server # [   62.703928] sshd-session[1030]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   62.706708] sshd-session[1030]: Disconnected from user root UNKNOWN port 65535
server # [   62.708702] sshd-session[1024]: pam_unix(sshd:session): session closed for user root
server # [   62.713307] systemd[1]: sshd-vsock@1-2-4:22-2:1.service: Deactivated successfully.
server # [   62.719321] systemd[1]: session-3.scope: Deactivated successfully.
server # [   62.721089] systemd[1]: session-3.scope: Consumed 377ms CPU time over 1.700s wall clock time, 47.1M memory peak, 1.4K outgoing IP traffic.
server # [   62.726514] systemd-logind[539]: Session 3 logged out. Waiting for processes to exit.
server # [   62.729322] systemd-logind[539]: Removed session 3.
server # [   62.808629] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   62.815016] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
server # [   62.920886] sshd-session[1050]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   62.931207] sshd-session[1050]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   62.940745] sshd-session[1050]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   62.951941] systemd-logind[539]: New session '4' of user 'root' with class 'user' and type 'tty'.
server # [   62.956605] systemd[1]: Started Session 4 of User root.
server # [   63.153949] sshd-session[1056]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   63.156647] sshd-session[1056]: Disconnected from user root UNKNOWN port 65535
server # [   63.158457] sshd-session[1050]: pam_unix(sshd:session): session closed for user root
server # [   63.163925] systemd[1]: sshd-vsock@2-3-4:22-2:2.service: Deactivated successfully.
server # [   63.169846] systemd[1]: session-4.scope: Deactivated successfully.
server # [   63.174794] systemd-logind[539]: Session 4 logged out. Waiting for processes to exit.
server # [   63.177564] systemd-logind[539]: Removed session 4.
server # [   63.206954] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   63.212966] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
server # [   63.301096] sshd-session[1063]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   63.308798] sshd-session[1063]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   63.317253] sshd-session[1063]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   63.325347] systemd-logind[539]: New session '5' of user 'root' with class 'user' and type 'tty'.
host1 # [   40.335304] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   63.339770] systemd[1]: Started Session 5 of User root.
host1 # [   40.343057] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).
host1 # [   40.354387] systemd[1]: Started SSH per-connection Daemon (vsock:2:10).
host1 # [   40.372427] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   40.374489] systemd[1]: Started SSH per-connection Daemon (vsock:2:11).
host1 # [   40.445940] dhcpcd[687]: eth0: leased 10.0.2.15 for 86400 seconds
host1 # [   40.447116] dhcpcd[687]: eth0: adding route to 10.0.2.0/24
host1 # [   40.460592] dhcpcd[687]: eth0: adding default route via 10.0.2.2
server # [   63.480730] sshd-session[1069]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   63.482339] sshd-session[1069]: Disconnected from user root UNKNOWN port 65535
server # [   63.484115] sshd-session[1063]: pam_unix(sshd:session): session closed for user root
server # [   63.489293] systemd[1]: sshd-vsock@3-4-4:22-2:3.service: Deactivated successfully.
test acme::server_builds_and_signs_a_path ... ok
server # [   63.494226] systemd[1]: session-5.scope: Deactivated successfully.
server # [   63.499048] systemd-logind[539]: Session 5 logged out. Waiting for processes to exit.
server # [   63.501942] systemd-logind[539]: Removed session 5.
host1 # [   40.626944] sshd-session[863]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   40.635731] sshd-session[862]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   40.650101] sshd-session[864]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   40.651830] sshd-session[863]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   40.665525] sshd-session[862]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   40.675740] sshd-session[864]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   40.684906] sshd-session[863]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   40.694333] sshd-session[862]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   40.712342] systemd-logind[525]: New session '7' of user 'root' with class 'user' and type 'tty'.
host1 # [   40.726832] systemd[1]: Started Session 7 of User root.
host1 # [   40.727798] sshd-session[864]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   40.740566] systemd[1]: Started Session 8 of User root.
host1 # [   40.741455] systemd-logind[525]: New session '8' of user 'root' with class 'user' and type 'tty'.
host1 # [   40.755287] systemd-logind[525]: New session '9' of user 'root' with class 'user' and type 'tty'.
host1 # [   40.765351] systemd[1]: Started Session 9 of User root.
host1 # [   40.830687] systemd[1]: Started DHCP Client.
host1 # [   40.836088] systemd[1]: Reached target Network is Online.
host1 # [   40.845886] systemd[1]: Starting fetch-ca-root.service...
host1 # [   40.901901] sshd-session[920]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   40.904786] sshd-session[920]: Disconnected from user root UNKNOWN port 65535
host1 # [   40.909162] sshd-session[863]: pam_unix(sshd:session): session closed for user root
host1 # [   40.935601] systemd[1]: sshd-vsock@6-7-3:22-2:10.service: Deactivated successfully.
host1 # [   40.945191] systemd[1]: session-7.scope: Deactivated successfully.
host1 # [   40.949356] systemd-logind[525]: Session 7 logged out. Waiting for processes to exit.
host1 # [   40.957837] systemd-logind[525]: Removed session 7.
host1 # [   40.981271] sshd-session[927]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   40.982705] sshd-session[927]: Disconnected from user root UNKNOWN port 65535
host1 # [   40.983708] sshd-session[864]: pam_unix(sshd:session): session closed for user root
host1 # [   40.996453] sshd-session[926]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   40.997806] systemd[1]: sshd-vsock@7-8-3:22-2:11.service: Deactivated successfully.
host1 # [   40.998967] sshd-session[926]: Disconnected from user root UNKNOWN port 65535
host1 # [   40.999954] systemd[1]: sshd-vsock@5-6-3:22-2:9.service: Deactivated successfully.
host1 # [   41.006893] sshd-session[862]: pam_unix(sshd:session): session closed for user root
host1 # [   41.011579] systemd[1]: session-8.scope: Deactivated successfully.
host1 # [   41.018271] systemd[1]: session-9.scope: Deactivated successfully.
host1 # [   41.019251] systemd-logind[525]: Session 9 logged out. Waiting for processes to exit.
host1 # [   41.020857] systemd-logind[525]: Removed session 9.
host1 # [   41.021788] systemd-logind[525]: Session 8 logged out. Waiting for processes to exit.
host1 # [   41.023381] systemd-logind[525]: Removed session 8.
host1 # [   41.044814] systemd[1]: Finished fetch-ca-root.service.
host1 # [   41.048132] systemd[1]: Reached target Multi-User System.
host1 # [   41.051749] systemd[1]: Starting Order (and renew) ACME certificate for host1...
host1 # [   41.118408] acme-order-renew-host1-start[955]: Waiting to acquire lock in /run/acme/
host1 # [   41.127030] acme-order-renew-host1-start[955]: + set -euo pipefail
host1 # [   41.128863] acme-order-renew-host1-start[955]: + exec
host1 # [   41.129657] acme-order-renew-host1-start[955]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
host1 # [   41.133120] acme-order-renew-host1-start[963]: ++ find accounts -path '*/keys/*.key' -print -quit
host1 # [   41.141459] acme-order-renew-host1-start[955]: + '[' -n '' ']'
host1 # [   41.142519] acme-order-renew-host1-start[955]: + exec
host1 # [   41.143249] acme-order-renew-host1-start[955]: + '[' -e certificates/host1.key ']'
host1 # [   41.144423] acme-order-renew-host1-start[955]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 --no-random-sleep --renew-force --ari-disable --force-cert-domains
host1 # [   41.494345] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.495772760Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
host1 # [   41.515509] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.518512480Z INFO  Registering the account. email=root@example.org
host1 # [   41.528458] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.531127060Z WARN  !!!! HEADS UP !!!!
host1 # [   41.530617] acme-order-renew-host1-start[964]: Your account credentials have been saved in your
host1 # [   41.533611] acme-order-renew-host1-start[964]: configuration directory at "accounts".
host1 # [   41.535214] acme-order-renew-host1-start[964]: You should make a secure backup of this folder now. This
host1 # [   41.536992] acme-order-renew-host1-start[964]: configuration directory will also contain private keys
host1 # [   41.538675] acme-order-renew-host1-start[964]: generated by lego and certificates obtained from the ACME
host1 # [   41.540346] acme-order-renew-host1-start[964]: server. Making regular backups of this folder is ideal.
host1 # [   41.541995] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.535910960Z INFO  Obtaining bundled SAN certificate. domains=host1
host1 # [   41.611954] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.614236300Z INFO  Use solver. domain=host1 type=http-01
host1 # [   41.616306] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.614318940Z INFO  http01: Trying to solve HTTP-01. domain=host1
host1 # [   41.627451] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.629359940Z INFO  The server validated our request. domain=host1
host1 # [   41.630336] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.629639000Z INFO  Validations succeeded; requesting certificates. domains=host1
host1 # [   41.649902] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.652253360Z INFO  Server responded with a certificate. domains=host1
host1 # [   41.658314] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.652402940Z INFO  Writing file. filepath=certificates/host1.crt
host1 # [   41.661904] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.652624800Z INFO  Writing file. filepath=certificates/host1.issuer.crt
host1 # [   41.669603] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.652716220Z INFO  Writing file. filepath=certificates/host1.key
host1 # [   41.673999] acme-order-renew-host1-start[964]: 2026-11-12T10:13:17.652919640Z INFO  Writing file. filepath=certificates/host1.json
host1 # [   41.677345] acme-order-renew-host1-start[955]: + touch out/acme-success
host1 # [   41.678808] acme-order-renew-host1-start[955]: + cmp -s certificates/host1.crt out/fullchain.pem
host1 # [   41.684745] acme-order-renew-host1-start[955]: + touch out/renewed
host1 # [   41.689052] acme-order-renew-host1-start[955]: + echo Installing new certificate
host1 # [   41.690661] acme-order-renew-host1-start[955]: Installing new certificate
host1 # [   41.691867] acme-order-renew-host1-start[955]: + cp -vp certificates/host1.crt out/fullchain.pem
host1 # [   41.698373] acme-order-renew-host1-start[971]: 'certificates/host1.crt' -> 'out/fullchain.pem'
host1 # [   41.700875] acme-order-renew-host1-start[955]: + cp -vp certificates/host1.key out/key.pem
host1 # [   41.705930] acme-order-renew-host1-start[972]: 'certificates/host1.key' -> 'out/key.pem'
host1 # [   41.708280] acme-order-renew-host1-start[955]: + cp -vp certificates/host1.issuer.crt out/chain.pem
host1 # [   41.713207] acme-order-renew-host1-start[973]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'
host1 # [   41.715137] acme-order-renew-host1-start[955]: + ln -sf fullchain.pem out/cert.pem
host1 # [   41.720284] acme-order-renew-host1-start[955]: + cat out/key.pem out/fullchain.pem
host1 # [   41.725552] acme-order-renew-host1-start[955]: + for fixpath in out certificates
host1 # [   41.726823] acme-order-renew-host1-start[955]: + '[' -d out ']'
host1 # [   41.727656] acme-order-renew-host1-start[955]: + chmod -R u=rwX,g=rX,o= out
host1 # [   41.732461] acme-order-renew-host1-start[955]: + chown -R acme:acme out
host1 # [   41.739727] acme-order-renew-host1-start[955]: + for fixpath in out certificates
host1 # [   41.741753] acme-order-renew-host1-start[955]: + '[' -d certificates ']'
host1 # [   41.742847] acme-order-renew-host1-start[955]: + chmod -R u=rwX,g=rX,o= certificates
host1 # [   41.746614] acme-order-renew-host1-start[955]: + chown -R acme:acme certificates
host1 # [   41.752927] acme-order-renew-host1-start[955]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   41.801608] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.
host1 # [   41.805109] systemd[1]: Finished Order (and renew) ACME certificate for host1.
host1 # [   41.806326] systemd[1]: Startup finished in 19.580s (kernel) + 4.610s (initrd) + 17.612s (userspace) = 41.803s.
host1 # [   41.807708] systemd[1]: acme-order-renew-host1.service: Consumed 295ms CPU time over 751ms wall clock time, 55.3M memory peak, 4K written to disk, 10.3K incoming IP traffic, 8.3K outgoing IP traffic.
host1 # [   42.400629] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   42.412213] systemd[1]: Started SSH per-connection Daemon (vsock:2:14).
host1 # [   42.427351] systemd[1]: Started SSH per-connection Daemon (vsock:2:12).
host1 # [   42.436410] systemd[1]: Started SSH per-connection Daemon (vsock:2:13).
host1 # [   42.628718] sshd-session[991]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   42.645951] sshd-session[993]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   42.647776] sshd-session[991]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   42.657014] sshd-session[992]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   42.672272] sshd-session[993]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   42.678444] sshd-session[992]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   42.683829] sshd-session[991]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   42.697387] systemd-logind[525]: New session '10' of user 'root' with class 'user' and type 'tty'.
host1 # [   42.707015] systemd[1]: Started Session 10 of User root.
host1 # [   42.712666] sshd-session[993]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   42.721876] sshd-session[992]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   42.738708] systemd-logind[525]: New session '11' of user 'root' with class 'user' and type 'tty'.
host1 # [   42.748185] systemd[1]: Started Session 11 of User root.
host1 # [   42.756092] systemd-logind[525]: New session '12' of user 'root' with class 'user' and type 'tty'.
host1 # [   42.765360] systemd[1]: Started Session 12 of User root.
host1 # [   42.823317] sshd-session[1009]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   42.825890] sshd-session[1009]: Disconnected from user root UNKNOWN port 65535
host1 # [   42.831947] sshd-session[991]: pam_unix(sshd:session): session closed for user root
host1 # [   42.842351] systemd[1]: sshd-vsock@10-11-3:22-2:14.service: Deactivated successfully.
host1 # [   42.846671] systemd[1]: session-10.scope: Deactivated successfully.
host1 # [   42.856137] systemd-logind[525]: Session 10 logged out. Waiting for processes to exit.
host1 # [   42.859161] systemd-logind[525]: Removed session 10.
host1 # [   42.908363] sshd-session[1012]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   42.910833] sshd-session[1012]: Disconnected from user root UNKNOWN port 65535
host1 # [   42.912552] sshd-session[993]: pam_unix(sshd:session): session closed for user root
host1 # [   42.917326] sshd-session[1013]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   42.918734] sshd-session[1013]: Disconnected from user root UNKNOWN port 65535
host1 # [   42.922587] sshd-session[992]: pam_unix(sshd:session): session closed for user root
host1 # [   42.926741] systemd[1]: sshd-vsock@9-10-3:22-2:13.service: Deactivated successfully.
host1 # [   42.931516] systemd[1]: session-11.scope: Deactivated successfully.
host1 # [   42.934262] systemd[1]: sshd-vsock@8-9-3:22-2:12.service: Deactivated successfully.
host1 # [   42.939566] systemd[1]: session-12.scope: Deactivated successfully.
host1 # [   42.945291] systemd-logind[525]: Session 11 logged out. Waiting for processes to exit.
host1 # [   42.949229] systemd-logind[525]: Removed session 11.
host1 # [   42.951022] systemd-logind[525]: Session 12 logged out. Waiting for processes to exit.
host1 # [   42.953730] systemd-logind[525]: Removed session 12.
host1 # [   44.578375] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   44.588449] systemd[1]: Started SSH per-connection Daemon (vsock:2:15).
host1 # [   44.597144] systemd[1]: Started SSH per-connection Daemon (vsock:2:16).
host1 # [   44.603613] systemd[1]: Started SSH per-connection Daemon (vsock:2:17).
host1 # [   44.810780] sshd-session[1027]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   44.818459] sshd-session[1026]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   44.827770] sshd-session[1025]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   44.835959] sshd-session[1027]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   44.843763] sshd-session[1026]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   44.847722] sshd-session[1025]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   44.860622] sshd-session[1027]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   44.866784] sshd-session[1025]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   44.874493] sshd-session[1026]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   44.881535] systemd-logind[525]: New session '13' of user 'root' with class 'user' and type 'tty'.
host1 # [   44.892516] systemd[1]: Started Session 13 of User root.
host1 # [   44.900155] systemd-logind[525]: New session '14' of user 'root' with class 'user' and type 'tty'.
host1 # [   44.904903] systemd[1]: Started Session 14 of User root.
host1 # [   44.909940] systemd-logind[525]: New session '15' of user 'root' with class 'user' and type 'tty'.
host1 # [   44.916656] systemd[1]: Started Session 15 of User root.
host1 # [   44.968189] sshd-session[1045]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   44.972239] sshd-session[1045]: Disconnected from user root UNKNOWN port 65535
host1 # [   44.976813] sshd-session[1026]: pam_unix(sshd:session): session closed for user root
host1 # [   44.987963] sshd-session[1043]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   44.993258] sshd-session[1043]: Disconnected from user root UNKNOWN port 65535
host1 # [   44.994541] systemd[1]: sshd-vsock@12-13-3:22-2:16.service: Deactivated successfully.
host1 # [   45.002409] systemd[1]: session-14.scope: Deactivated successfully.
host1 # [   45.008542] sshd-session[1027]: pam_unix(sshd:session): session closed for user root
host1 # [   45.013507] systemd-logind[525]: Session 14 logged out. Waiting for processes to exit.
host1 # [   45.021588] systemd-logind[525]: Removed session 14.
host1 # [   45.033656] systemd[1]: sshd-vsock@13-14-3:22-2:17.service: Deactivated successfully.
host1 # [   45.039436] systemd[1]: session-13.scope: Deactivated successfully.
host1 # [   45.045305] systemd-logind[525]: Session 13 logged out. Waiting for processes to exit.
host1 # [   45.050557] sshd-session[1046]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   45.051876] sshd-session[1046]: Disconnected from user root UNKNOWN port 65535
host1 # [   45.056602] sshd-session[1025]: pam_unix(sshd:session): session closed for user root
host1 # [   45.057791] systemd-logind[525]: Removed session 13.
host1 # [   45.059795] systemd[1]: sshd-vsock@11-12-3:22-2:15.service: Deactivated successfully.
host1 # [   45.065035] systemd[1]: session-15.scope: Deactivated successfully.
host1 # [   45.069409] systemd-logind[525]: Session 15 logged out. Waiting for processes to exit.
host1 # [   45.071584] systemd-logind[525]: Removed session 15.
test acme::host1_obtains_a_certificate_via_acme ... ok
host1 # [   45.933107] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   45.940656] systemd[1]: Started SSH per-connection Daemon (vsock:2:18).
host1 # [   45.949621] systemd[1]: Started SSH per-connection Daemon (vsock:2:19).
host1 # [   46.105115] sshd-session[1059]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   46.110395] sshd-session[1058]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   46.118594] sshd-session[1059]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   46.122110] sshd-session[1058]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   46.133550] sshd-session[1059]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   46.138453] sshd-session[1058]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   46.147080] systemd-logind[525]: New session '16' of user 'root' with class 'user' and type 'tty'.
host1 # [   46.156571] systemd[1]: Started Session 16 of User root.
host1 # [   46.162031] systemd-logind[525]: New session '17' of user 'root' with class 'user' and type 'tty'.
host1 # [   46.168602] systemd[1]: Started Session 17 of User root.
server # [   69.562702] systemd[1]: Started Nix Daemon.
server # [   69.719412] nix-daemon[1078]: accepted connection from pid 979, user nix-grpc-daemon (trusted)
server # [   69.733831] nix-grpc-daemon[979]: ts=2026-11-12T10:13:23Z level=info event=denied method=Connect cn=host1 role=read-only
host1 # [   46.773010] sshd-session[1070]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   46.775825] sshd-session[1070]: Disconnected from user root UNKNOWN port 65535
host1 # [   46.778735] sshd-session[1059]: pam_unix(sshd:session): session closed for user root
host1 # [   46.784769] systemd[1]: sshd-vsock@15-16-3:22-2:19.service: Deactivated successfully.
host1 # [   46.790841] systemd[1]: session-16.scope: Deactivated successfully.
host1 # [   46.795278] systemd[1]: session-16.scope: Consumed 206ms CPU time over 636ms wall clock time, 36M memory peak, 5.1K incoming IP traffic, 4K outgoing IP traffic.
host1 # [   46.802370] systemd-logind[525]: Session 16 logged out. Waiting for processes to exit.
host1 # [   46.803993] systemd-logind[525]: Removed session 16.
server # [   70.232753] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   70.242044] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
server # [   70.300334] nix-daemon[1078]: accepted connection from pid 979, user nix-grpc-daemon (trusted)
server # [   70.320868] nix-grpc-daemon[979]: ts=2026-11-12T10:13:24Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:37508 duration_s=0 paths=1 nar_bytes_out=128
server # [   70.343169] nix-daemon[1078]: reaped child process 1083, status = succeeded
host1 # [   47.357196] sshd-session[1071]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   47.358719] sshd-session[1071]: Disconnected from user root UNKNOWN port 65535
host1 # [   47.361327] sshd-session[1058]: pam_unix(sshd:session): session closed for user root
host1 # [   47.365891] systemd[1]: sshd-vsock@14-15-3:22-2:18.service: Deactivated successfully.
host1 # [   47.372003] systemd[1]: session-17.scope: Deactivated successfully.
server # [   70.373788] sshd-session[1082]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   47.375614] systemd[1]: session-17.scope: Consumed 217ms CPU time over 1.208s wall clock time, 43.5M memory peak, 10.1K incoming IP traffic, 9.4K outgoing IP traffic.
host1 # [   47.381857] systemd-logind[525]: Session 17 logged out. Waiting for processes to exit.
host1 # [   47.383106] systemd-logind[525]: Removed session 17.
server # [   70.381957] sshd-session[1082]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   70.389803] sshd-session[1082]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   70.400484] systemd-logind[539]: New session '6' of user 'root' with class 'user' and type 'tty'.
server # [   70.408946] systemd[1]: Started Session 6 of User root.
server # [   70.436606] sshd-session[1090]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   70.438968] sshd-session[1090]: Disconnected from user root UNKNOWN port 65535
server # [   70.440489] sshd-session[1082]: pam_unix(sshd:session): session closed for user root
server # [   70.445453] systemd[1]: sshd-vsock@4-5-4:22-2:4.service: Deactivated successfully.
server # [   70.451267] systemd[1]: session-6.scope: Deactivated successfully.
server # [   70.456642] systemd-logind[539]: Session 6 logged out. Waiting for processes to exit.
server # [   70.459335] systemd-logind[539]: Removed session 6.
test acme::a_read_only_host_cannot_write ... ok
[e2e] heartbeat t=30s
host1 # [   51.256788] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   51.265808] systemd[1]: Started SSH per-connection Daemon (vsock:2:20).
host1 # [   51.367100] sshd-session[1107]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   51.377325] sshd-session[1107]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   51.386333] sshd-session[1107]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   51.395578] systemd-logind[525]: New session '18' of user 'root' with class 'user' and type 'tty'.
host1 # [   51.404554] systemd[1]: Started Session 18 of User root.
host1 # [   51.434210] sshd-session[1113]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   51.437091] sshd-session[1113]: Disconnected from user root UNKNOWN port 65535
host1 # [   51.438643] sshd-session[1107]: pam_unix(sshd:session): session closed for user root
host1 # [   51.443135] systemd[1]: sshd-vsock@16-17-3:22-2:20.service: Deactivated successfully.
host1 # [   51.449127] systemd[1]: session-18.scope: Deactivated successfully.
host1 # [   51.454022] systemd-logind[525]: Session 18 logged out. Waiting for processes to exit.
host1 # [   51.456631] systemd-logind[525]: Removed session 18.
test acme::host1_substitutes_the_signed_path_with_a_read_only_cert ... ok

test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 60 filtered out; finished in 34.87s

[107.64s] (finished: run the VM test script, in 105.92 seconds)
[107.90s] test script finished in 106.19s
[107.91s] cleanup
[107.91s] kill QemuMachine (pid 52)
host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)
host1 # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
[108.74s] kill QemuMachine (pid 55)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)
server # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-12T10:13:28Z INFO  virtiofsd] Client disconnected, shutting down
[109.75s] (finished: cleanup, in 1.84 seconds)
SSH backdoor enabled, the machines can be accessed like this:
Note: this requires systemd-ssh-proxy(1) to be enabled (default on NixOS 25.05 and newer).
    host1:   ssh -o User=root vsock-mux//build/tmp9d00ejur/host1_host.socket
    server:  ssh -o User=root vsock-mux//build/tmp9d00ejur/server_host.socket
additionally exposed symbols:
    host1, server,
    vlan1,
    start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh