tribuchet: building on eliza
[0.00s] Machine state will be reset. To keep it, pass --keep-machine-state
[0.00s] start all VLans
[0.02s] (finished: start all VLans, in 0.02 seconds)
[0.02s] start vhost-device-vsock
[0.02s] (finished: start vhost-device-vsock, in 0.00 seconds)
[0.02s] Test will time out and terminate in 600.0 seconds
[0.02s] run the VM test script
[0.02s] start all VMs
[0.70s] host1: starting vm
[0.70s] server: starting vm
server # Disk image does not exist, creating the virtualisation disk image...
[11.35s] server: QEMU running (pid 55)
server # Formatting '/build/vm-state-server/tmp.eWM9GwaFVX', 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: 8350eb8a-ec67-4f18-8423-c68962ef6b05
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-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-11T21:12:58Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-11T21:12:58Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-11T21:12:58Z 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/72aj54wlkwbsysz8s3ql4720gw77wvbs-nixos-system-server-test/init regInfo=/nix/.ro-store/whggkrwgp8j9cfly7127xgqrxr1l32yf-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/whggkrwgp8j9cfly7127xgqrxr1l32yf-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 @44ef0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44f00000 (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.000035] arm-pv: using stolen time PV
server # [    0.000458] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000659] Console: colour dummy device 80x25
server # [    0.000668] printk: legacy console [tty0] enabled
server # [    0.000857] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000865] pid_max: default: 32768 minimum: 301
server # [    0.001003] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
server # [    0.001143] landlock: Up and running.
server # [    0.001146] Yama: becoming mindful.
server # [    0.001650] LSM support for eBPF active
server # [    0.001797] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.001830] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.004948] rcu: Hierarchical SRCU implementation.
server # [    0.004957] rcu: 	Max phase no-delay instances is 1000.
server # [    0.006236] fsl-mc MSI: its@8080000 domain created
server # [    0.006363] EFI services will not be available.
server # [    0.006438] smp: Bringing up secondary CPUs ...
server # [    0.006448] smp: Brought up 1 node, 1 CPU
server # [    0.006452] SMP: Total of 1 processors activated.
server # [    0.006455] CPU: All CPU(s) started at EL1
server # [    0.006466] CPU features: detected: Branch Target Identification
server # [    0.006470] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.006473] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.006477] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.006485] CPU features: detected: Common not Private translations
server # [    0.006489] CPU features: detected: CRC32 instructions
server # [    0.006492] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.006495] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.006498] CPU features: detected: Data independent timing control (DIT)
server # [    0.006501] CPU features: detected: E0PD
server # [    0.006503] CPU features: detected: Enhanced Counter Virtualization
server # [    0.006506] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.006510] CPU features: detected: Enhanced Virtualization Traps
server # [    0.006513] CPU features: detected: Fine Grained Traps
server # [    0.006516] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.006521] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.006524] CPU features: detected: LSE atomic instructions
server # [    0.006527] CPU features: detected: Privileged Access Never
server # [    0.006530] CPU features: detected: PMUv3
server # [    0.006533] CPU features: detected: RAS Extension Support
server # [    0.006536] CPU features: detected: RASv1p1 Extension Support
server # [    0.006538] CPU features: detected: Random Number Generator
server # [    0.006543] CPU features: detected: Speculation barrier (SB)
server # [    0.006546] CPU features: detected: Stage-2 Force Write-Back
server # [    0.006549] CPU features: detected: TLB range maintenance instructions
server # [    0.006554] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.006594] alternatives: applying system-wide alternatives
server # [    0.009641] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.009870] Memory: 1914800K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138768K reserved, 32768K cma-reserved)
server # [    0.010339] devtmpfs: initialized
server # [    0.013771] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.013795] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.013983] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.013992] 0 pages in range for non-PLT usage
server # [    0.013993] 506368 pages in range for PLT usage
server # [    0.014088] pinctrl core: initialized pinctrl subsystem
server # [    0.015050] DMI not present or invalid.
server # [    0.019347] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.021711] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
server # [    0.021891] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.022098] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.022128] audit: initializing netlink subsys (disabled)
server # [    0.022813] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.022815] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.022819] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.022822] thermal_sys: Registered thermal governor 'user_space'
server # [    0.022824] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.022850] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
server # [    0.022860] cpuidle: using governor ladder
server # [    0.022867] cpuidle: using governor menu
server # [    0.023067] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.023085] ASID allocator initialised with 65536 entries
server # [    0.024308] Serial: AMBA PL011 UART driver
server # [    0.030946] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.031043] printk: console [ttyAMA0] enabled
server # [    0.161630] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.161640] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.161644] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.161647] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.161649] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.161652] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.161655] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.161658] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.163010] fbcon: Taking over console
server # [    0.163019] ACPI: Interpreter disabled.
server # [    0.177979] iommu: Default domain type: Translated
server # [    0.177985] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.178342] SCSI subsystem initialized
server # [    0.179018] usbcore: registered new interface driver usbfs
server # [    0.179041] usbcore: registered new interface driver hub
server # [    0.179070] usbcore: registered new device driver usb
server # [    0.180610] pps_core: LinuxPPS API ver. 1 registered
server # [    0.180615] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.180623] PTP clock support registered
server # [    0.180663] EDAC MC: Ver: 3.0.0
server # [    0.188158] scmi_core: SCMI protocol bus registered
server # [    0.190009] FPGA manager framework
server # [    0.191582] vgaarb: loaded
server # [    0.191879] clocksource: Switched to clocksource arch_sys_counter
server # [    0.198431] VFS: Disk quotas dquot_6.6.0
server # [    0.198464] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.202073] netfs: FS-Cache loaded
server # [    0.202193] pnp: PnP ACPI: disabled
server # [    0.207814] NET: Registered PF_INET protocol family
server # [    0.208739] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.242565] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.242609] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.242640] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.242755] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
server # [    0.242897] TCP: Hash tables configured (established 16384 bind 16384)
server # [    0.242987] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
server # [    0.243024] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.243059] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.243148] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.243189] NET: Registered PF_XDP protocol family
server # [    0.243206] PCI: CLS 0 bytes, default 64
server # [    0.243451] Trying to unpack rootfs image as initramfs...
server # [    0.262129] kvm [1]: HYP mode not available
server # [    0.372527] Initialise system trusted keyrings
server # [    0.372575] Key type blacklist registered
server # [    0.372717] workingset: timestamp_bits=42 max_order=19 bucket_order=0
server # [    0.373128] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.373198] 9p: Installing v9fs 9p2000 file system support
server # [    0.373287] integrity: Platform Keyring initialized
server # [    0.373297] integrity: Machine keyring initialized
server # [    0.405334] Key type asymmetric registered
server # [    0.405352] Asymmetric key parser 'x509' registered
server # [    0.405433] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.405601] io scheduler mq-deadline registered
server # [    0.405606] io scheduler kyber registered
server # [    0.419064] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.419664] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.421576] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.421594] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.421608] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.421614] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.421635] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.421676] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.421757] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.421765] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.421769] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.421772] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.421775] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.421868] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.422314] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.422501] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.422513] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.422539] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.422552] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.423027] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.423212] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.423224] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.423250] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.423715] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.451998] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.452022] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.452050] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.452640] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.452849] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.452861] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.452889] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.452902] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.453386] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.453591] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.453618] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.454114] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.454318] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.454346] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.454776] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    0.454975] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    0.455268] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.455464] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.455491] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.472376] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.472570] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.472596] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.473111] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.473300] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.473326] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.473794] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.474135] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.474153] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.474178] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.474749] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.474940] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.474951] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.474977] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.475442] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
server # [    0.475631] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.475657] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.496442] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.496458] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.496461] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.496511] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.496559] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.496603] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.496648] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.496691] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.496734] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.496778] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.496821] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.496865] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.496986] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.497031] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
server # [    0.497074] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.497091] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.497108] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.497125] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.497142] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.497159] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.497177] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.497196] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.497213] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.497231] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.497248] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.497266] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.497284] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
server # [    0.497301] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.497317] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.497334] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.497351] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.497368] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.497385] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.497408] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.497413] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.497416] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.498250] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.560408] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    2.189732] Freeing initrd memory: 25272K
server # [    2.193298] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    2.513306] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    2.515628] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    3.553512] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    3.557974] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
server # [    3.560816] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    4.995843] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    4.999362] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    5.002033] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    5.008126] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    5.013552] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
server # [    5.019662] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    5.022358] msm_serial: driver initialized
server # [    5.022558] SuperH (H)SCI(F) driver initialized
server # [    5.022633] STM32 USART driver initialized
server # [    5.042336] loop: module loaded
server # [    5.042513] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    5.043456] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    5.048127] megasas: 07.734.00.00-rc1
server # [    5.049108] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    5.058372] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    5.058393] Intel/Sharp Extended Query Table at 0x0031
server # [    6.576523] Using buffer write method
server # [    6.576623] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    6.582581] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    6.582614] Intel/Sharp Extended Query Table at 0x0031
server # [    6.599537] Using buffer write method
server # [    6.599563] Concatenating MTD devices:
server # [    6.599565] (0): "0.flash"
server # [    6.599568] (1): "0.flash"
server # [    6.599570] into device "0.flash"
server # [    6.607850] tun: Universal TUN/TAP device driver, 1.6
server # [    6.612937] thunder_xcv, ver 1.0
server # [    6.612978] thunder_bgx, ver 1.0
server # [    6.613000] nicpf, ver 1.0
server # [    6.613588] e1000: Intel(R) PRO/1000 Network Driver
server # [    6.613592] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    6.613619] e1000e: Intel(R) PRO/1000 Network Driver
server # [    6.613626] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    6.613656] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    6.613660] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    6.613683] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    6.613687] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    6.613832] sky2: driver version 1.30
server # [    6.615564] usbcore: registered new interface driver usb-storage
server # [    6.615667] usbcore: registered new interface driver usbserial_generic
server # [    6.615680] usbserial: USB Serial support registered for generic
server # [    6.616633] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    6.616661] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    6.616842] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    6.628613] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    6.629010] hub 1-0:1.0: USB hub found
server # [    6.629031] hub 1-0:1.0: 6 ports detected
server # [    6.629964] hv_vmbus: registering driver hyperv_keyboard
server # [    6.631062] rtc-pl031 9010000.pl031: registered as rtc0
server # [    6.631090] rtc-pl031 9010000.pl031: setting system clock to 2026-11-11T21:13:13 UTC (1794431593)
server # [    6.631413] i2c_dev: i2c /dev entries driver
server # [    6.639313] sdhci: Secure Digital Host Controller Interface driver
server # [    6.639319] sdhci: Copyright(c) Pierre Ossman
server # [    6.639597] Synopsys Designware Multimedia Card Interface Driver
server # [    6.642035] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    6.643631] hid: raw HID events driver (C) Jiri Kosina
server # [    6.645238] usbcore: registered new interface driver usbhid
server # [    6.645242] usbhid: USB HID core driver
server # [    6.646434] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    6.650370] drop_monitor: Initializing network drop monitor service
server # [    6.650527] NET: Registered PF_INET6 protocol family
server # [    6.651152] Segment Routing with IPv6
server # [    6.651177] In-situ OAM (IOAM) with IPv6
server # [    6.651222] NET: Registered PF_PACKET protocol family
server # [    6.651282] 9pnet: Installing 9P2000 support
server # [    6.651357] Key type dns_resolver registered
server # [    6.662410] registered taskstats version 1
server # [    6.662568] Loading compiled-in X.509 certificates
server # [    6.671986] Demotion targets for Node 0: null
server # [    6.672110] Key type .fscrypt registered
server # [    6.672113] Key type fscrypt-provisioning registered
server # [    6.672234] ima: No TPM chip found, activating TPM-bypass!
server # [    6.672261] ima: Allocated hash algorithm: sha1
server # [    6.672283] ima: No architecture policies found
server # [    6.673700] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    6.696613] clk: Disabling unused clocks
server # [    6.696632] PM: genpd: Disabling unused power domains
server # [    6.703154] Freeing unused kernel memory: 7808K
server # [    6.703378] Run /init as init process
server # [    6.722816] systemd[1]: Successfully made /usr/ read-only.
server # [    6.875941] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    7.028425] 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 # [    7.056794] 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 # [    7.056820] systemd[1]: Detected virtualization qemu.
server # [    7.056871] systemd[1]: Detected architecture arm64.
server # [    7.056879] systemd[1]: Running in initrd.
server # [    7.057445] systemd[1]: Initializing machine ID from random generator.
server # [    7.058392] systemd[1]: Hostname set to <server>.
server # [    7.120127] 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 # [    7.211545] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    7.239996] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    7.273152] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    7.280304] systemd[1]: Created slice Slice /system/modprobe.
server # [    7.280511] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    7.280544] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    7.280571] systemd[1]: Reached target Path Units.
server # [    7.280586] systemd[1]: Reached target Slice Units.
server # [    7.280603] systemd[1]: Reached target Swaps.
server # [    7.280618] systemd[1]: Reached target Timer Units.
server # [    7.280762] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    7.280918] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    7.281039] systemd[1]: Listening on Journal Sockets.
server # [    7.281113] systemd[1]: Listening on udev Kernel Socket.
server # [    7.281308] systemd[1]: Listening on udev Varlink Socket.
server # [    7.281325] systemd[1]: Reached target Socket Units.
server # [    7.282942] systemd[1]: Starting Create List of Static Device Nodes...
server # [    7.283012] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    7.313072] systemd[1]: Mounting Kernel Configuration File System...
server # [    7.328232] systemd[1]: Starting Journal Service...
server # [    7.332865] systemd[1]: Starting Load Kernel Modules...
server # [    7.333030] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    7.368170] systemd[1]: Starting Coldplug All udev Devices...
server # [    7.390100] systemd-journald[70]: Collecting audit messages is disabled.
server # [    7.392126] systemd[1]: Finished Create List of Static Device Nodes.
server # [    7.402374] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
server # [    7.408102] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    7.425725] 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 # [    7.425887] 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 # [    7.426461] systemd[1]: Mounted Kernel Configuration File System.
server # [    7.442053] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    7.442316] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    7.462272] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    7.462519] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    7.462522] [drm] features: -context_init
server # [    7.463401] [drm] number of scanouts: 1
server # [    7.463413] [drm] number of cap sets: 0
server # [    7.485547] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    7.485562] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    7.493091] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    7.495009] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    7.556024] Console: switching to colour frame buffer device 160x50
server # [    7.556748] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    7.565474] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    7.565715] systemd[1]: Reached target Preparation for Local File Systems.
server # [    7.565747] systemd[1]: Reached target Local File Systems.
server # [    7.572468] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    7.591473] NET: Registered PF_VSOCK protocol family
server # [    7.624349] systemd[1]: Started Journal Service.
server # [    7.506494] systemd-modules-load[71]: Inserted module 'dm_mod'
server # [    7.509578] systemd-modules-load[71]: Module 'virtio_balloon' is built in
server # [    7.510773] systemd-modules-load[71]: Module 'virtio_console' is built in
server # [    7.511882] systemd-modules-load[71]: Inserted module 'virtio_gpu'
server # [    7.525208] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [    7.526310] systemd[1]: Starting Create System Files and Directories...
server # [    7.527393] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
server # [    7.540557] systemd[1]: Finished Load Kernel Modules.
server # [    7.563405] systemd[1]: Starting Apply Kernel Variables...
server # [    7.576903] systemd-udevd[77]: Using default interface naming scheme 'v261'.
server # [    7.610037] systemd[1]: Finished Create System Files and Directories.
server # [    7.621963] systemd[1]: Finished Apply Kernel Variables.
server # [    7.639722] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    7.730261] systemd[1]: Starting Virtual Console Setup...
server # [    7.834192] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    7.836535] systemd[1]: Finished Virtual Console Setup.
server # [    8.543331] systemd[1]: Finished Coldplug All udev Devices.
server # [    8.544309] systemd[1]: Reached target System Initialization.
server # [    8.545110] systemd[1]: Reached target Basic System.
server # [    8.711862] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    8.753420] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.
server # [    8.757727] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.
server # [    8.828738] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    8.830564] systemd[1]: Reached target Initrd Root Device.
server # [    8.833915] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    8.897931] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    8.905490] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    8.914661] systemd[1]: Mounting /sysroot...
server # [    9.081671] EXT4-fs (vda): mounted filesystem 8350eb8a-ec67-4f18-8423-c68962ef6b05 r/w with ordered data mode. Quota mode: none.
server # [    8.963798] systemd[1]: Mounted /sysroot.
server # [    8.969332] systemd[1]: Reached target Initrd Root File System.
server # [    8.976146] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    9.011615] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    9.019851] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    9.025083] systemd[1]: Reloading...
server # [    9.264132] systemd[1]: Reloading finished in 240 ms.
server # [    9.291446] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...
server # [    9.305891] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...
server # [    9.315708] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    9.334095] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    9.352053] systemd[1]: Mounting /sysroot/run...
server # [    9.376823] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    9.428143] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    9.459266] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    9.486495] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    9.619576] fuse: init (API version 7.45)
server # [    9.499260] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    9.504164] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    9.632282] virtiofs virtio6: discovered new tag: nix-store
server # [    9.633097] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [    9.650120] virtiofs virtio7: discovered new tag: shared
server # [    9.650989] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # [    9.658202] virtiofs virtio8: discovered new tag: xchg
server # [    9.659297] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    9.540131] systemd[1]: Mounted /sysroot/run.
server # [    9.566715] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    9.571348] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    9.575712] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    9.584610] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    9.614344] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    9.617374] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    9.619539] systemd[1]: Mounting /sysroot/nix/store...
server # [    9.670382] systemd[1]: Mounted /sysroot/nix/store.
server # [    9.672975] systemd[1]: Reached target Initrd File Systems.
server # [    9.675310] systemd[1]: Starting Find NixOS closure...
server # [    9.686568] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    9.728924] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    9.744518] systemd[1]: Finished Find NixOS closure.
server # [    9.748192] systemd[1]: Reached target Initrd Default Target.
server # [    9.760604] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    9.790071] systemd[1]: Stopped target Initrd Default Target.
server # [    9.792912] systemd[1]: Stopped target Basic System.
server # [    9.797023] systemd[1]: Stopped target Initrd Root Device.
server # [    9.799025] systemd[1]: Stopped target Path Units.
server # [    9.801057] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [    9.804145] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [    9.808157] systemd[1]: Stopped target Slice Units.
server # [    9.810254] systemd[1]: Stopped target Socket Units.
server # [    9.819276] systemd[1]: Stopped target System Initialization.
server # [    9.821448] systemd[1]: Stopped target Swaps.
server # [    9.822095] systemd[1]: Stopped target Timer Units.
server # [    9.822890] systemd[1]: dbus.socket: Deactivated successfully.
server # [    9.823688] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [    9.826972] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [    9.829162] systemd[1]: Stopped Find NixOS closure.
server # [    9.832346] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    9.834433] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [    9.838378] systemd[1]: Stopped Apply Kernel Variables.
server # [    9.840929] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [    9.845167] systemd[1]: Stopped Load Kernel Modules.
server # [    9.847658] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [    9.851508] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [    9.855171] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [    9.859387] systemd[1]: Stopped Create System Files and Directories.
server # [    9.861790] systemd[1]: Stopped target Local File Systems.
server # [    9.863795] systemd[1]: Stopped target Preparation for Local File Systems.
server # [    9.869268] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [    9.870338] systemd[1]: Stopped Coldplug All udev Devices.
server # [    9.875686] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [    9.881179] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    9.882239] systemd[1]: Stopped Virtual Console Setup.
server # [    9.882988] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    9.883891] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    9.892876] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    9.893982] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    9.915999] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [    9.918887] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [    9.921401] systemd[1]: systemd-udevd.service: Consumed 1.020s CPU time over 2.467s wall clock time, 19.8M memory peak.
server # [    9.924627] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
server # [    9.928163] systemd[1]: Closed udev Varlink Socket.
server # [    9.928956] systemd[1]: Starting Cleanup udev Database...
server # [    9.930457] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [    9.931682] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [    9.932762] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [    9.933863] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [    9.934937] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [    9.935875] systemd[1]: Stopped Create List of Static Device Nodes.
server # [    9.963526] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [    9.967243] systemd[1]: Finished Cleanup udev Database.
server # [    9.968585] systemd[1]: Reached target Switch Root.
server # [    9.969762] systemd[1]: Starting NixOS Activation...
server # [   10.057519] initrd-nixos-activation-start[172]: booting system configuration /nix/store/72aj54wlkwbsysz8s3ql4720gw77wvbs-nixos-system-server-test
server # [   10.093253] initrd-nixos-activation-start[172]: running activation script...
server # [   10.499031] initrd-nixos-activation-start[195]: setting up /etc...
host1 # Disk image does not exist, creating the virtualisation disk image...
[22.30s] host1: QEMU running (pid 53)
host1 # Formatting '/build/vm-state-host1/tmp.pFnWl3OznS', 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: b7e3e7dc-4681-4e47-9e77-95ae4e00c035
host1 # Superblock backups stored on blocks:
[22.31s] (finished: start all VMs, in 22.29 seconds)
host1 # 	32768, 98304, 163840, 229376
[22.31s] server: waiting for unit step-ca.service
host1 # 
[22.32s] server: waiting for the VM to finish booting
host1 # Allocating group tables: 0/8   done
host1 # Writing inode tables: 0/8   done
host1 # Creating journal (8192 blocks): done
host1 # Writing superblocks and filesystem accounting information: 0/8   done
host1 # 
host1 # Virtualisation disk image created.
host1 # Starting virtiofs daemons...
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-11T21:12:57Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-11T21:12:57Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-11T21:12:58Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-11T21:12:58Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-11T21:12:58Z INFO  virtiofsd] Client connected, servicing requests
server # [   10.640460] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   10.643834] systemd[1]: Finished NixOS Activation.
server # [   10.645405] systemd[1]: Starting Switch Root...
server # [   10.670429] systemd[1]: Switching root.
server # [   10.970172] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
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
host1 # [    0.000000] CPU features: detected: Spectre-v4
host1 # [    0.000000] CPU features: detected: Spectre-BHB
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
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/1fxwp99qky3arlg1q5fssbv9zdfis035-nixos-system-host1-test/init regInfo=/nix/.ro-store/aiq3yn1p2rkvk1phw4bi0vfx6jick6sr-closure-info/registration console=ttyAMA0,115200n8 console=tty0
host1 # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/aiq3yn1p2rkvk1phw4bi0vfx6jick6sr-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.000038] arm-pv: using stolen time PV
host1 # [    0.000478] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
host1 # [    0.001683] Console: colour dummy device 80x25
host1 # [    0.001698] printk: legacy console [tty0] enabled
host1 # [    0.001922] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
host1 # [    0.001930] pid_max: default: 32768 minimum: 301
host1 # [    0.002049] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
host1 # [    0.002172] landlock: Up and running.
host1 # [    0.002176] Yama: becoming mindful.
host1 # [    0.002619] LSM support for eBPF active
host1 # [    0.002770] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.003082] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.005026] rcu: Hierarchical SRCU implementation.
host1 # [    0.005033] rcu: 	Max phase no-delay instances is 1000.
host1 # [    0.006472] fsl-mc MSI: its@8080000 domain created
host1 # [    0.006597] EFI services will not be available.
host1 # [    0.006693] smp: Bringing up secondary CPUs ...
host1 # [    0.006704] smp: Brought up 1 node, 1 CPU
host1 # [    0.006708] SMP: Total of 1 processors activated.
host1 # [    0.006711] CPU: All CPU(s) started at EL1
host1 # [    0.006721] CPU features: detected: Branch Target Identification
host1 # [    0.006725] CPU features: detected: ARMv8.4 Translation Table Level
host1 # [    0.006729] CPU features: detected: Instruction cache invalidation not required for I/D coherence
host1 # [    0.006732] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
host1 # [    0.006740] CPU features: detected: Common not Private translations
host1 # [    0.006743] CPU features: detected: CRC32 instructions
host1 # [    0.006746] CPU features: detected: Data cache clean to Point of Deep Persistence
host1 # [    0.006749] CPU features: detected: Data cache clean to Point of Persistence
host1 # [    0.006752] CPU features: detected: Data independent timing control (DIT)
host1 # [    0.006755] CPU features: detected: E0PD
host1 # [    0.006758] CPU features: detected: Enhanced Counter Virtualization
host1 # [    0.006761] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
host1 # [    0.006764] CPU features: detected: Enhanced Virtualization Traps
host1 # [    0.006767] CPU features: detected: Fine Grained Traps
host1 # [    0.006771] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
host1 # [    0.006776] CPU features: detected: RCpc load-acquire (LDAPR)
host1 # [    0.006779] CPU features: detected: LSE atomic instructions
host1 # [    0.006782] CPU features: detected: Privileged Access Never
host1 # [    0.006784] CPU features: detected: PMUv3
host1 # [    0.006787] CPU features: detected: RAS Extension Support
host1 # [    0.006790] CPU features: detected: RASv1p1 Extension Support
host1 # [    0.006793] CPU features: detected: Random Number Generator
host1 # [    0.006797] CPU features: detected: Speculation barrier (SB)
host1 # [    0.006800] CPU features: detected: Stage-2 Force Write-Back
host1 # [    0.006803] CPU features: detected: TLB range maintenance instructions
host1 # [    0.006817] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
host1 # [    0.006887] alternatives: applying system-wide alternatives
host1 # [    0.010163] CPU features: detected: BBM Level 2 without TLB conflict abort
host1 # [    0.010354] Memory: 1914824K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138760K reserved, 32768K cma-reserved)
host1 # [    0.011110] devtmpfs: initialized
host1 # [    0.013232] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
host1 # [    0.013254] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
host1 # [    0.013474] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
host1 # [    0.013484] 0 pages in range for non-PLT usage
host1 # [    0.013486] 506368 pages in range for PLT usage
host1 # [    0.015887] pinctrl core: initialized pinctrl subsystem
host1 # [    0.016713] DMI not present or invalid.
host1 # [    0.020390] NET: Registered PF_NETLINK/PF_ROUTE protocol family
host1 # [    0.022839] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
host1 # [    0.023027] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
host1 # [    0.023238] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
host1 # [    0.023269] audit: initializing netlink subsys (disabled)
host1 # [    0.023971] thermal_sys: Registered thermal governor 'fair_share'
host1 # [    0.023974] thermal_sys: Registered thermal governor 'bang_bang'
host1 # [    0.023979] thermal_sys: Registered thermal governor 'step_wise'
host1 # [    0.023982] thermal_sys: Registered thermal governor 'user_space'
host1 # [    0.023985] thermal_sys: Registered thermal governor 'power_allocator'
host1 # [    0.024012] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
host1 # [    0.024024] cpuidle: using governor ladder
host1 # [    0.024030] cpuidle: using governor menu
host1 # [    0.024252] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
host1 # [    0.024280] ASID allocator initialised with 65536 entries
host1 # [    0.025726] Serial: AMBA PL011 UART driver
host1 # [    0.031642] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
host1 # [    0.031740] printk: console [ttyAMA0] enabled
host1 # [    0.168953] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
host1 # [    0.168965] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
host1 # [    0.168968] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
host1 # [    0.168971] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
host1 # [    0.168974] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
host1 # [    0.168976] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
host1 # [    0.168979] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
host1 # [    0.168981] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
host1 # [    0.170867] fbcon: Taking over console
host1 # [    0.170884] ACPI: Interpreter disabled.
host1 # [    0.187938] iommu: Default domain type: Translated
host1 # [    0.187948] iommu: DMA domain TLB invalidation policy: strict mode
host1 # [    0.188733] SCSI subsystem initialized
host1 # [    0.191319] usbcore: registered new interface driver usbfs
host1 # [    0.191343] usbcore: registered new interface driver hub
host1 # [    0.191371] usbcore: registered new device driver usb
host1 # [    0.191736] pps_core: LinuxPPS API ver. 1 registered
host1 # [    0.191740] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
host1 # [    0.191748] PTP clock support registered
host1 # [    0.191794] EDAC MC: Ver: 3.0.0
host1 # [    0.191988] scmi_core: SCMI protocol bus registered
host1 # [    0.192356] FPGA manager framework
host1 # [    0.199180] vgaarb: loaded
host1 # [    0.199495] clocksource: Switched to clocksource arch_sys_counter
host1 # [    0.203684] VFS: Disk quotas dquot_6.6.0
host1 # [    0.203716] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
host1 # [    0.205966] netfs: FS-Cache loaded
host1 # [    0.206079] pnp: PnP ACPI: disabled
host1 # [    0.213021] NET: Registered PF_INET protocol family
host1 # [    0.213320] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
host1 # [    0.251430] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
host1 # [    0.251477] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
host1 # [    0.254005] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
host1 # [    0.254096] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
host1 # [    0.254242] TCP: Hash tables configured (established 16384 bind 16384)
host1 # [    0.254373] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
host1 # [    0.254417] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.254452] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.254549] NET: Registered PF_UNIX/PF_LOCAL protocol family
host1 # [    0.254579] NET: Registered PF_XDP protocol family
host1 # [    0.254596] PCI: CLS 0 bytes, default 64
host1 # [    0.254845] Trying to unpack rootfs image as initramfs...
host1 # [    0.271926] kvm [1]: HYP mode not available
host1 # [    0.428541] Initialise system trusted keyrings
host1 # [    0.428658] Key type blacklist registered
host1 # [    0.428869] workingset: timestamp_bits=42 max_order=19 bucket_order=0
host1 # [    0.429360] squashfs: version 4.0 (2009/01/31) Phillip Lougher
host1 # [    0.429442] 9p: Installing v9fs 9p2000 file system support
host1 # [    0.429545] integrity: Platform Keyring initialized
host1 # [    0.429558] integrity: Machine keyring initialized
host1 # [    0.462629] Key type asymmetric registered
host1 # [    0.462649] Asymmetric key parser 'x509' registered
host1 # [    0.463246] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
host1 # [    0.463396] io scheduler mq-deadline registered
host1 # [    0.463401] io scheduler kyber registered
host1 # [    0.481851] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
host1 # [    0.482542] ledtrig-cpu: registered to indicate activity on CPUs
host1 # [    0.491875] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
host1 # [    0.491904] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
host1 # [    0.491919] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [   11.466796] 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 # [    0.491926] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [   11.466864] systemd[1]: Detected virtualization qemu.
host1 # [    0.491949] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [   11.466951] systemd[1]: Detected architecture arm64.
host1 # [    0.491978] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [   11.467093] systemd[1]: Detected first boot.
host1 # [    0.492078] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
host1 # [    0.492086] pci_bus 0000:00: root bus resource [bus 00-ff]
host1 # [    0.492091] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
host1 # [    0.492094] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
host1 # [    0.492097] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
host1 # [    0.492197] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
host1 # [    0.492700] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.492895] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.492906] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.492932] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.492944] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.493420] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [   11.485599] systemd[1]: Initializing machine ID from random generator.
host1 # [    0.493611] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.493623] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.493650] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.494961] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
host1 # [    0.495171] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
host1 # [    0.495188] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.495221] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.519988] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.520187] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.520201] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.520227] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.520239] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.520716] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
host1 # [    0.520909] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.520935] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.521405] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
host1 # [    0.521593] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.521619] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.522092] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
host1 # [    0.522278] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
host1 # [    0.522538] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.522726] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.522751] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.523218] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.523403] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.523432] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.548091] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.548317] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.548344] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.548834] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.549157] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
host1 # [    0.549176] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.549201] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.549680] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
host1 # [    0.549883] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.549894] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.549920] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.550389] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.550577] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.550603] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.551226] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
host1 # [    0.551233] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
host1 # [    0.551237] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
host1 # [    0.551284] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
host1 # [    0.551336] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
host1 # [    0.551387] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
host1 # [    0.551432] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
host1 # [    0.551477] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
host1 # [    0.577561] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
host1 # [    0.577612] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
host1 # [    0.577655] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
host1 # [    0.577699] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
host1 # [    0.577895] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
host1 # [    0.577940] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
host1 # [    0.577983] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
host1 # [    0.578002] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
host1 # [    0.578020] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
host1 # [    0.578039] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
host1 # [    0.578057] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
host1 # [    0.578075] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
host1 # [    0.578093] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
host1 # [    0.578112] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
host1 # [    0.578130] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
host1 # [    0.578148] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
host1 # [    0.578166] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
host1 # [    0.578184] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
host1 # [    0.578202] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
host1 # [    0.578219] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
host1 # [    0.578236] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
host1 # [    0.578253] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
host1 # [    0.578270] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
host1 # [    0.578287] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
host1 # [    0.578304] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
host1 # [    0.578331] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
host1 # [    0.578336] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
host1 # [    0.578339] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
host1 # [    0.612470] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [   11.638033] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   11.904666] systemd[1]: Applying preset policy.
server # [   12.322874] systemd[1]: Populated /etc with preset unit settings.
server # [   12.573960] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   12.574859] systemd[1]: Stopped initrd-switch-root.service.
server # [   12.580600] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   12.582708] systemd[1]: Created slice Slice /system/getty.
server # [   12.586343] systemd[1]: Created slice User and Session Slice.
server # [   12.587022] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   12.587702] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   12.591017] systemd[1]: Expecting device /dev/hvc0...
server # [   12.591661] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   12.594159] systemd[1]: Reached target Local Encrypted Volumes.
server # [   12.594697] systemd[1]: Stopped target initrd-fs.target.
server # [   12.595206] systemd[1]: Stopped target initrd-root-fs.target.
server # [   12.595779] systemd[1]: Stopped target initrd-switch-root.target.
server # [   12.599874] systemd[1]: Reached target Virtual Machines and Containers.
server # [   12.602031] systemd[1]: Reached target Path Units.
server # [   12.602473] systemd[1]: Reached target Remote File Systems.
server # [   12.603196] systemd[1]: Reached target Slice Units.
server # [   12.603833] systemd[1]: Reached target Swaps.
server # [   12.608552] systemd[1]: Listening on Query the User Interactively for a Password.
server # [   12.611683] systemd[1]: Listening on Process Core Dump Socket.
server # [   12.615004] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   12.617517] systemd[1]: Listening on Factory Reset Management.
server # [   12.618049] systemd[1]: Listening on Hostname Service Socket.
server # [   12.638734] systemd[1]: Starting Journal Log Access Socket...
server # [   12.643404] systemd[1]: Listening on Journal Audit Socket.
server # [   12.648283] systemd[1]: Listening on Console Output Muting Service Socket.
server # [   12.648928] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   12.649279] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [   12.649556] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   12.662405] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [   12.663385] systemd[1]: Listening on udev Varlink Socket.
server # [   12.672290] systemd[1]: Mounting Huge Pages File System...
server # [   12.678303] systemd[1]: Mounting POSIX Message Queue File System...
server # [   12.692849] systemd[1]: Mounting Kernel Debug File System...
server # [   12.711659] systemd[1]: Mounting Kernel Trace File System...
server # [   12.727682] systemd[1]: Starting Create List of Static Device Nodes...
server # [   12.729448] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   12.746152] systemd[1]: Mounting Kernel Configuration File System...
server # [   12.746706] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   12.747036] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   12.747327] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   12.785177] systemd[1]: Mounting FUSE Control File System...
server # [   12.785647] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   12.811839] systemd[1]: Starting Journal Service...
server # [   12.835554] systemd[1]: Starting Load Kernel Modules...
server # [   12.862832] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   12.904747] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   12.905234] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   12.935058] systemd[1]: Starting Coldplug All udev Devices...
server # [   12.943197] systemd[1]: Listening on Journal Log Access Socket.
server # [   12.946957] systemd[1]: Mounted Huge Pages File System.
server # [   12.950797] systemd[1]: Mounted POSIX Message Queue File System.
server # [   12.953792] systemd[1]: Mounted Kernel Debug File System.
server # [   12.955534] systemd[1]: Mounted Kernel Trace File System.
server # [   12.959000] systemd[1]: Mounted Kernel Configuration File System.
server # [   12.961265] systemd[1]: Mounted FUSE Control File System.
server # [   12.994126] systemd[1]: Finished Create List of Static Device Nodes.
server # [   13.000102] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   13.085992] EXT4-fs (vda): re-mounted 8350eb8a-ec67-4f18-8423-c68962ef6b05.
server # [   13.090771] systemd[1]: Finished Load Kernel Modules.
server # [   13.097108] systemd[1]: Starting Firewall...
server # [   13.109471] systemd[1]: Starting Apply Kernel Variables...
server # [   13.110850] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   13.111590] systemd[1]: Listening on Disk Image Download Service Socket.
server # [   13.115260] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   13.124501] systemd-journald[267]: Collecting audit messages is enabled.
server # [   13.132961] systemd[1]: Starting Load/Save OS Random Seed...
server # [   13.134741] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   13.175544] systemd[1]: Started Journal Service.
server # [   13.069281] systemd[1]: Queued start job for default target Multi-User System.
server # [   13.070817] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   13.091311] systemd-modules-load[268]: Module 'atkbd' is built in
server # [   13.104393] systemd-modules-load[268]: Module 'loop' is built in
server # [   13.112155] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   13.159713] systemd-oomd[269]: No swap; memory pressure usage will be degraded
server # [   13.178326] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   13.220140] systemd[1]: Finished Load/Save OS Random Seed.
server # [   13.229140] systemd[1]: Reached target First Boot Complete.
server # [   13.231874] systemd[1]: Finished Apply Kernel Variables.
server # [   13.366117] systemd-journald[267]: Received client request to flush runtime journal.
server # [   13.306903] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   13.316589] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   13.320371] systemd[1]: Finished Flush Journal to Persistent Storage.
host1 # [    0.637375] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
host1 # [    2.501199] Freeing initrd memory: 25264K
host1 # [    2.506235] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [   13.448956] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   13.454423] systemd[1]: Reached target Preparation for Local File Systems.
server # [   13.468437] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   13.471564] systemd[1]: Mounting /run/wrappers...
server # [   13.526995] systemd[1]: Mounted /run/wrappers.
server # [   13.535265] systemd[1]: Reached target Local File Systems.
server # [   13.548397] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   13.561770] systemd[1]: Starting register-nix-paths.service...
server # [   13.571762] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   13.580525] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   13.586532] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   13.592820] systemd[1]: Starting Create System Files and Directories...
server # [   13.761305] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   13.771343] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   13.856218] systemd[1]: Finished Create System Files and Directories.
server # [   13.863530] systemd[1]: Starting Rebuild Journal Catalog...
server # [   13.877146] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   14.030945] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   14.152809] systemd[1]: Finished Rebuild Journal Catalog.
server # [   14.159314] systemd[1]: Starting Update is Completed...
server # [   14.304274] systemd[1]: Finished Update is Completed.
server # [   14.420328] systemd-udevd[307]: Using default interface naming scheme 'v261'.
host1 # [    3.979087] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
host1 # [    3.983227] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
host1 # [    3.998298] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
host1 # [    4.002464] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
host1 # [    4.005120] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
host1 # [    4.009859] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [   14.894736] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   15.156460] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   15.162770] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   15.586865] systemd[1]: Finished Coldplug All udev Devices.
server # [   15.793973] systemd[1]: Finished Firewall.
server # [   16.155662] systemd[1]: Finished register-nix-paths.service.
server # [   16.163557] systemd[1]: Reached target System Initialization.
server # [   16.167048] systemd[1]: Started Renew ACME Certificate for server.
server # [   16.169375] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   16.171964] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   16.176843] systemd[1]: Reached target Timer Units.
server # [   16.177807] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   16.178836] systemd[1]: Listening on Nix Daemon Socket.
server # [   16.179651] systemd[1]: Listening on Nix worker-protocol over gRPC.
server # [   16.192899] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
server # [   16.202579] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
server # [   16.207109] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   16.214189] systemd[1]: Starting D-Bus System Message Bus...
server # [   16.256938] systemd-ssh-issue[494]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
server # [   16.268529] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
server # [   16.272790] systemd[1]: Reached target Socket Units.
server # [   16.318838] dbus-broker-launch[495]: Looking up NSS user entry for 'systemd-timesync'...
server # [   16.339862] dbus-broker-launch[495]: NSS returned no entry for 'systemd-timesync'
server # [   16.344247] dbus-broker-launch[495]: Invalid user-name in /nix/store/c2mpdmjqkz1mxlsyhzsv6hnn4waavv8s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   16.359985] systemd[1]: Started D-Bus System Message Bus.
server # [   16.366660] systemd[1]: Reached target Basic System.
server # [   16.372366] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
server # [   16.384568] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   16.401556] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   16.410216] systemd[1]: Starting Post-Boot Actions...
server # [   16.425355] systemd[1]: Started Reset console on configuration changes.
server # [   16.440544] systemd[1]: Starting resolvconf update...
server # [   16.453992] systemd[1]: Starting SSH Host Keys Generation...
server # [   16.477335] systemd[1]: Starting step-ca-pki.service...
host1 # [    4.016000] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
host1 # [    4.018041] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
host1 # [    5.655013] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
host1 # [    5.658547] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
host1 # [    5.665137] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
host1 # [    5.667208] msm_serial: driver initialized
host1 # [    5.667419] SuperH (H)SCI(F) driver initialized
host1 # [    5.667484] STM32 USART driver initialized
server # [   16.540429] dbus-broker-launch[495]: Ready
host1 # [    5.688906] loop: module loaded
host1 # [    5.689103] virtio_blk virtio2: 1/0/0 default/read/poll queues
host1 # [    5.690076] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
host1 # [    5.697513] megasas: 07.734.00.00-rc1
host1 # [    5.699180] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
host1 # [    5.705884] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    5.705912] Intel/Sharp Extended Query Table at 0x0031
server # [   16.652677] systemd[1]: Finished Post-Boot Actions.
server # [   16.672778] acme-setup-privileged[498]: + set -euo pipefail
server # [   16.685734] acme-setup-privileged[498]: + cd /var/lib/acme
server # [   16.692612] acme-setup-privileged[498]: + chmod -R u=rwX,g=,o= .lego/accounts
server # [   16.706443] acme-setup-privileged[498]: + chown -R acme .lego/accounts
server # [   16.715266] nsncd[500]: Nov 11 21:13:23.697 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   16.735131] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   16.748949] systemd[1]: Reached target Host and Network Name Lookups.
server # [   16.753248] systemd[1]: Reached target User and Group Name Lookups.
server # [   16.756488] systemd[1]: Starting User Login Management...
server # [   16.768054] acme-setup-privileged[498]: + for fixpath in server .lego/server
server # [   16.778065] acme-setup-privileged[498]: + '[' -d server ']'
server # [   16.785269] acme-setup-privileged[498]: + for fixpath in server .lego/server
server # [   16.796418] acme-setup-privileged[498]: + '[' -d .lego/server ']'
server # [   16.808133] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   17.111590] acme-setup-start[541]: + set -euo pipefail
server # [   17.117883] acme-setup-start[541]: + test -e ca/key.pem
server # [   17.131847] acme-setup-start[541]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
server # [   17.145783] systemd-logind[524]: New seat seat0.
server # [   17.155724] systemd[1]: Started User Login Management.
server # [   17.161171] systemd[1]: Starting linger-users.service...
server # [   17.327501] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   17.342862] systemd[1]: Stopping Host and Network Name Lookups...
server # [   17.359834] systemd[1]: Stopped target User and Group Name Lookups.
server # [   17.372940] systemd[1]: Stopping User and Group Name Lookups...
server # [   17.380430] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   17.398196] systemd[1]: nscd.service: Deactivated successfully.
server # [   17.403335] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   17.409500] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   17.414303] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
server # [   17.425033] systemd[1]: Starting Ensure certificate for server...
server # [   17.429826] systemd[1]: linger-users.service: Deactivated successfully.
server # [   17.439776] systemd[1]: Finished linger-users.service.
server # [   17.572154] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   17.576629] systemd[1]: Reached target Host and Network Name Lookups.
server # [   17.589657] systemd[1]: Reached target User and Group Name Lookups.
server # [   17.593465] nsncd[600]: Nov 11 21:13:24.560 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   17.639852] systemd[1]: Finished resolvconf update.
server # [   17.647081] systemd[1]: Reached target Preparation for Network.
server # [   17.661812] systemd[1]: Starting DHCP Client...
server # [   17.664221] systemd[1]: Starting Extra networking commands....
server # [   17.709364] acme-server-start[604]: Waiting to acquire lock in /run/acme/
server # [   17.773624] acme-server-start[604]: + '[' -e out/acme-success ']'
server # [   17.780237] acme-server-start[604]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=
server # [   17.862267] step-ca-pki-start[521]: Your certificate has been saved in root_ca.crt.
server # [   17.873784] step-ca-pki-start[521]: Your private key has been saved in root_ca.key.
server # [   17.891220] acme-server-start[648]: + cd server
server # [   17.898250] acme-server-start[648]: + cp -vp cert.pem ../out/cert.pem
server # [   17.923367] acme-server-start[650]: 'cert.pem' -> '../out/cert.pem'
server # [   17.930903] acme-server-start[648]: + cp -vp key.pem ../out/key.pem
server # [   17.969565] acme-server-start[648]: 'key.pem' -> '../out/key.pem'
server # [   17.980154] acme-server-start[604]: + cat out/cert.pem ca/cert.pem
server # [   18.001757] acme-server-start[604]: + cp ca/cert.pem out/chain.pem
server # [   18.046694] acme-server-start[604]: + cat out/key.pem out/fullchain.pem
server # [   18.051704] acme-server-start[604]: + for fixpath in out certificates
server # [   18.060479] acme-server-start[604]: + '[' -d out ']'
server # [   18.066790] acme-server-start[604]: + chmod -R u=rwX,g=rX,o= out
server # [   18.073381] acme-server-start[604]: + chown -R acme:nix-grpc-daemon out
server # [   18.106324] acme-server-start[604]: + for fixpath in out certificates
server # [   18.115005] acme-server-start[604]: + '[' -d certificates ']'
server # [   18.125120] systemd[1]: Finished Ensure certificate for server.
server # [   18.273328] step-ca-pki-start[649]: Your certificate has been saved in intermediate_ca.crt.
server # [   18.278490] step-ca-pki-start[649]: Your private key has been saved in intermediate_ca.key.
server # [   18.298013] sshd-keygen-start[549]: Generating public/private rsa key pair.
server # [   18.304592] sshd-keygen-start[549]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
server # [   18.315842] sshd-keygen-start[549]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
server # [   18.327861] sshd-keygen-start[549]: The key fingerprint is:
server # [   18.331751] sshd-keygen-start[549]: SHA256:TkrqHM+KtegeRpp72j/8W5KHVQWXM68iMyHYWQHD3Z8 root@server
server # [   18.339909] sshd-keygen-start[549]: The key's randomart image is:
server # [   18.346043] sshd-keygen-start[549]: +---[RSA 4096]----+
server # [   18.350782] sshd-keygen-start[549]: |     .oo.o..o.   |
server # [   18.355783] sshd-keygen-start[549]: |      ..o .o+    |
server # [   18.362868] sshd-keygen-start[549]: |     o o  .. =   |
server # [   18.367696] sshd-keygen-start[549]: |    . + ..  E .  |
server # [   18.372963] sshd-keygen-start[549]: |  .   ..S.   .   |
server # [   18.375534] sshd-keygen-start[549]: | +   o B+ . .    |
server # [   18.378764] sshd-keygen-start[549]: |o o.+ = ++ .     |
server # [   18.383077] sshd-keygen-start[549]: | +.Bo= +         |
server # [   18.385626] sshd-keygen-start[549]: |o=*.*+=.         |
server # [   18.388420] sshd-keygen-start[549]: +----[SHA256]-----+
server # [   18.393109] dhcpcd[656]: dhcpcd-10.3.2 starting
server # [   18.396497] dhcpcd[721]: no valid interfaces found
server # [   18.401978] systemd[1]: Finished step-ca-pki.service.
server # [   18.405796] dhcpcd[721]: dev: loaded udev
server # [   18.412214] systemd[1]: Finished Extra networking commands..
server # [   18.415005] sshd-keygen-start[729]: Generating public/private ed25519 key pair.
server # [   18.420766] sshd-keygen-start[729]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
server # [   18.427378] sshd-keygen-start[729]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
server # [   18.437548] sshd-keygen-start[729]: The key fingerprint is:
server # [   18.440370] sshd-keygen-start[729]: SHA256:tMaf8iLvNfTKgj5TtSTaG2k5eyU+UTQwuYrZwDJM3K8 root@server
server # [   18.443633] sshd-keygen-start[729]: The key's randomart image is:
server # [   18.453305] sshd-keygen-start[729]: +--[ED25519 256]--+
server # [   18.456943] sshd-keygen-start[729]: |   . .    oo     |
server # [   18.461470] sshd-keygen-start[729]: |    o .   ..o    |
server # [   18.465095] sshd-keygen-start[729]: |   o . ..  o .   |
server # [   18.468700] sshd-keygen-start[729]: |    + ooo.+ .    |
server # [   18.471510] sshd-keygen-start[729]: |     o OSB.o     |
server # [   18.475775] sshd-keygen-start[729]: |      E.@o+o.    |
server # [   18.477961] sshd-keygen-start[729]: |       +.*=+.    |
server # [   18.481241] sshd-keygen-start[729]: |      = ==+o     |
server # [   18.484116] sshd-keygen-start[729]: |     ..*o++.     |
server # [   18.486910] sshd-keygen-start[729]: +----[SHA256]-----+
server # [   18.489806] dhcpcd[721]: no valid interfaces found
server # [   18.495580] systemd[1]: Reached target Network.
server # [   18.496652] systemd[1]: Starting Permit User Sessions...
server # [   18.498391] systemd[1]: Finished Permit User Sessions.
server # [   18.501977] systemd[1]: Started Getty on tty1.
server # [   18.503777] systemd[1]: Reached target Login Prompts.
server # [   18.510553] sshd-keygen-start[737]: Generating public/private mldsa44-ed25519 key pair.
server # [   18.521119] sshd-keygen-start[737]: Your identification has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key
server # [   18.528826] sshd-keygen-start[737]: Your public key has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key.pub
server # [   18.531456] sshd-keygen-start[737]: The key fingerprint is:
server # [   18.533580] sshd-keygen-start[737]: SHA256:eKRkssVCUXCd8HLvUkzcDFhG62NRPVze4JFfoFa0P84 root@server
server # [   18.536761] sshd-keygen-start[737]: The key's randomart image is:
server # [   18.540806] sshd-keygen-start[737]: +[MLDSA44-ED25519-+
server # [   18.542197] sshd-keygen-start[737]: |    +++o == .+*+.|
server # [   18.544446] sshd-keygen-start[737]: |   . o .+o * +==o|
server # [   18.546899] sshd-keygen-start[737]: |    o * + = = oo+|
server # [   18.549325] sshd-keygen-start[737]: |     B * = o   ..|
server # [   18.553259] sshd-keygen-start[737]: |    . o S B    ..|
server # [   18.554766] sshd-keygen-start[737]: |       . + .  o .|
server # [   18.559507] sshd-keygen-start[737]: |        . .    E |
server # [   18.561310] sshd-keygen-start[737]: |         .       |
server # [   18.564113] sshd-keygen-start[737]: |                 |
server # [   18.565484] sshd-keygen-start[737]: +----[SHA256]-----+
server # [   18.568192] systemd[1]: sshd-keygen.service: Deactivated successfully.
server # [   18.572911] systemd[1]: Finished SSH Host Keys Generation.
server # [   18.576574] systemd[1]: Starting SSH Daemon...
server # [   18.634741] sshd[739]: Server listening on 0.0.0.0 port 22.
server # [   18.638427] sshd[739]: Server listening on :: port 22.
server # [   18.640543] systemd[1]: Started SSH Daemon.
server # [   18.966569] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [    5.709484] Using buffer write method
host1 # [    5.709538] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
host1 # [    8.272519] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    8.272553] Intel/Sharp Extended Query Table at 0x0031
host1 # [    8.274343] Using buffer write method
host1 # [    8.274375] Concatenating MTD devices:
host1 # [    8.274378] (0): "0.flash"
host1 # [    8.274383] (1): "0.flash"
host1 # [    8.274385] into device "0.flash"
host1 # [    8.285866] tun: Universal TUN/TAP device driver, 1.6
host1 # [    8.292055] thunder_xcv, ver 1.0
host1 # [    8.292092] thunder_bgx, ver 1.0
host1 # [    8.292111] nicpf, ver 1.0
host1 # [    8.292755] e1000: Intel(R) PRO/1000 Network Driver
host1 # [    8.292761] e1000: Copyright (c) 1999-2006 Intel Corporation.
host1 # [    8.292811] e1000e: Intel(R) PRO/1000 Network Driver
host1 # [    8.292817] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
host1 # [    8.292852] igb: Intel(R) Gigabit Ethernet Network Driver
host1 # [    8.292858] igb: Copyright (c) 2007-2014 Intel Corporation.
host1 # [    8.292883] igbvf: Intel(R) Gigabit Virtual Function Network Driver
host1 # [    8.292890] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
host1 # [    8.293039] sky2: driver version 1.30
host1 # [    8.294846] usbcore: registered new interface driver usb-storage
host1 # [    8.294950] usbcore: registered new interface driver usbserial_generic
host1 # [    8.294961] usbserial: USB Serial support registered for generic
host1 # [    8.296216] ehci-pci 0000:00:07.0: EHCI Host Controller
host1 # [    8.296248] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
host1 # [    8.296448] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
host1 # [    8.308921] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
host1 # [    8.309490] hub 1-0:1.0: USB hub found
host1 # [    8.309522] hub 1-0:1.0: 6 ports detected
host1 # [    8.310221] hv_vmbus: registering driver hyperv_keyboard
host1 # [    8.311214] rtc-pl031 9010000.pl031: registered as rtc0
host1 # [    8.311237] rtc-pl031 9010000.pl031: setting system clock to 2026-11-11T21:13:26 UTC (1794431606)
host1 # [    8.311587] i2c_dev: i2c /dev entries driver
host1 # [    8.319949] sdhci: Secure Digital Host Controller Interface driver
host1 # [    8.319955] sdhci: Copyright(c) Pierre Ossman
host1 # [    8.320267] Synopsys Designware Multimedia Card Interface Driver
host1 # [    8.320690] sdhci-pltfm: SDHCI platform and OF driver helper
host1 # [    8.322500] hid: raw HID events driver (C) Jiri Kosina
host1 # [    8.322774] usbcore: registered new interface driver usbhid
host1 # [    8.322778] usbhid: USB HID core driver
host1 # [    8.329665] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
host1 # [    8.331435] drop_monitor: Initializing network drop monitor service
host1 # [    8.333797] NET: Registered PF_INET6 protocol family
host1 # [    8.334446] Segment Routing with IPv6
host1 # [    8.334469] In-situ OAM (IOAM) with IPv6
host1 # [    8.334501] NET: Registered PF_PACKET protocol family
host1 # [    8.334569] 9pnet: Installing 9P2000 support
host1 # [    8.334624] Key type dns_resolver registered
host1 # [    8.344522] registered taskstats version 1
host1 # [    8.344775] Loading compiled-in X.509 certificates
host1 # [    8.355258] Demotion targets for Node 0: null
host1 # [    8.355388] Key type .fscrypt registered
host1 # [    8.355392] Key type fscrypt-provisioning registered
host1 # [    8.357267] ima: No TPM chip found, activating TPM-bypass!
host1 # [    8.357304] ima: Allocated hash algorithm: sha1
host1 # [    8.357335] ima: No architecture policies found
host1 # [    8.358122] input: gpio-keys as /devices/platform/gpio-keys/input/input0
host1 # [    8.382436] clk: Disabling unused clocks
host1 # [    8.382455] PM: genpd: Disabling unused power domains
host1 # [    8.389587] Freeing unused kernel memory: 7808K
host1 # [    8.389921] Run /init as init process
server # [   19.252352] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   19.262130] systemd[1]: Starting Virtual Console Setup...
host1 # [    8.410844] systemd[1]: Successfully made /usr/ read-only.
server # [   19.292545] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   19.295986] systemd[1]: Stopped Virtual Console Setup.
server # [   19.299010] systemd[1]: Starting Virtual Console Setup...
host1 # [    8.555611] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [   19.515191] systemd-vconsole-setup[746]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   19.524421] systemd[1]: Finished Virtual Console Setup.
server # [   19.556859] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
host1 # [    8.707714] 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.596117] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [   19.602158] systemd[1]: Started backdoor.service.
host1 # [    8.744908] 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 # [    8.744938] systemd[1]: Detected virtualization qemu.
host1 # [    8.745001] systemd[1]: Detected architecture arm64.
host1 # [    8.745010] systemd[1]: Running in initrd.
host1 # [    8.745649] systemd[1]: Initializing machine ID from random generator.
host1 # [    8.745954] systemd[1]: Hostname set to <host1>.
host1 # [    8.803766] 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 # connecting to host...
[31.48s] server: Guest shell says: b'Spawning backdoor root shell...\n'
server # [   19.849024] 8021q: 802.1Q VLAN Support v1.8
[31.51s] server: connected to guest root shell
[31.51s] server: (connecting took 9.19 seconds)
[31.51s] server: (finished: waiting for the VM to finish booting, in 9.19 seconds)
host1 # [    8.893368] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   19.760503] (udev-worker)[676]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    8.923594] usb 1-2: new high-speed USB device number 3 using ehci-pci
host1 # [    8.956154] systemd[1]: Queued start job for default target Initrd Default Target.
server # [   19.813299] (udev-worker)[651]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [    8.965985] systemd[1]: Created slice Slice /system/modprobe.
host1 # [    8.966187] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [    8.966216] systemd[1]: Expecting device /dev/disk/by-label/nixos...
host1 # [    8.966238] systemd[1]: Reached target Path Units.
host1 # [    8.966252] systemd[1]: Reached target Slice Units.
host1 # [    8.966267] systemd[1]: Reached target Swaps.
host1 # [    8.966281] systemd[1]: Reached target Timer Units.
host1 # [    8.966435] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [    8.966585] systemd[1]: Listening on Journal Socket (/dev/log).
host1 # [    8.966701] systemd[1]: Listening on Journal Sockets.
host1 # [    8.966802] systemd[1]: Listening on udev Kernel Socket.
host1 # [    8.966962] systemd[1]: Listening on udev Varlink Socket.
host1 # [    8.966977] systemd[1]: Reached target Socket Units.
host1 # [    8.978604] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [    8.978680] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [    8.990185] systemd[1]: Mounting Kernel Configuration File System...
server # [   19.965031] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   19.966799] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   19.967272] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   19.973030] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   19.973359] cfg80211: failed to load regulatory.db
server # [   19.863733] (udev-worker)[651]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    9.015768] systemd[1]: Starting Journal Service...
host1 # [    9.023677] systemd[1]: Starting Load Kernel Modules...
host1 # [    9.023822] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    9.030752] systemd[1]: Starting Coldplug All udev Devices...
host1 # [    9.048001] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [    9.048848] systemd[1]: Mounted Kernel Configuration File System.
host1 # [    9.060043] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    9.100207] systemd-journald[70]: Collecting audit messages is disabled.
host1 # [    9.103975] 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 # [    9.104114] 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 # [    9.117927] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
host1 # [    9.136488] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
host1 # [    9.137382] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
host1 # [    9.139104] systemd[1]: Starting Create Static Device Nodes in /dev...
host1 # [    9.143096] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
host1 # [    9.161249] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
host1 # [    9.161497] [drm] features: -virgl +edid -resource_blob -host_visible
host1 # [    9.161500] [drm] features: -context_init
host1 # [    9.162271] [drm] number of scanouts: 1
host1 # [    9.162282] [drm] number of cap sets: 0
host1 # [    9.179914] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
host1 # [    9.179928] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
host1 # [    9.228252] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [    9.228663] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [    9.228687] systemd[1]: Reached target Local File Systems.
host1 # [    9.234520] systemd[1]: Starting Rule-based Manager for Device Events and Files...
host1 # [    9.237123] Console: switching to colour frame buffer device 160x50
host1 # [    9.237800] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
host1 # [    9.263751] NET: Registered PF_VSOCK protocol family
server # [   20.124347] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   20.132649] systemd[1]: Starting Address configuration of eth1...
server # [   20.155491] dhcpcd[721]: eth0: waiting for carrier[   20.277395] 8021q: adding VLAN 0 to HW filter on device eth0
server # 
server # [   20.160977] dhcpcd[721]: eth0: carrier acquired
host1 # [    9.304244] systemd[1]: Finished Load Kernel Modules.
server # [   20.161995] systemd-logind[524]: Watching system buttons on /dev/input/event0 (gpio-keys)
host1 # [    9.309844] systemd[1]: Starting Apply Kernel Variables...
host1 # [    9.310294] systemd[1]: Started Journal Service.
host1 # [    9.175835] systemd-modules-load[71]: Inserted module 'dm_mod'
host1 # [    9.183135] systemd-modules-load[71]: Module 'virtio_balloon' is built in
server # [   20.180136] dhcpcd[721]: DUID 00:01:00:01:32:87:96:f7:52:54:00:12:34:56
server # [   20.181182] dhcpcd[721]: eth0: IAID 00:12:34:56
host1 # [    9.196676] systemd-modules-load[71]: Module 'virtio_console' is built in
server # [   20.181876] dhcpcd[721]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [    9.197914] systemd-modules-load[71]: Inserted module 'virtio_gpu'
host1 # [    9.199057] systemd-modules-load[71]: Module 'virtio_rng' is built in
host1 # [    9.209105] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
host1 # [    9.235854] systemd[1]: Starting Create System Files and Directories...
host1 # [    9.240683] systemd-udevd[77]: Using default interface naming scheme 'v261'.
server # [   20.354617] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   20.249929] network-addresses-eth1-start[777]: adding address 192.168.1.2/24... done
host1 # [    9.273953] systemd[1]: Finished Apply Kernel Variables.
server # [   20.261557] network-addresses-eth1-start[777]: adding address 2001:db8:1::2/64... done
host1 # [    9.297840] systemd[1]: Finished Create System Files and Directories.
server # [   20.282934] systemd[1]: Finished Address configuration of eth1.
host1 # [    9.314054] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   20.504714] mousedev: PS/2 mouse device common for all mice
host1 # [    9.427308] systemd[1]: Starting Virtual Console Setup...
server # [   20.483391] systemd-logind[524]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
host1 # [    9.514233] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [    9.528415] systemd[1]: Finished Virtual Console Setup.
server # [   20.523224] dhcpcd[721]: eth0: soliciting a DHCP lease
server # [   20.529014] dhcpcd[721]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   20.536262] dhcpcd[721]: eth0: probing address 10.0.2.15/24
host1 # [   10.186821] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   10.187809] systemd[1]: Reached target System Initialization.
host1 # [   10.188787] systemd[1]: Reached target Basic System.
host1 # [   10.340382] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   10.382365] (udev-worker)[104]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   10.388716] (udev-worker)[104]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   10.529983] systemd[1]: Found device /dev/disk/by-label/nixos.
host1 # [   10.532316] systemd[1]: Reached target Initrd Root Device.
host1 # [   10.540354] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
host1 # [   10.585543] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks
host1 # [   10.592187] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
host1 # [   10.600363] systemd[1]: Mounting /sysroot...
host1 # [   10.773922] EXT4-fs (vda): mounted filesystem b7e3e7dc-4681-4e47-9e77-95ae4e00c035 r/w with ordered data mode. Quota mode: none.
host1 # [   10.650872] systemd[1]: Mounted /sysroot.
host1 # [   10.653083] systemd[1]: Reached target Initrd Root File System.
host1 # [   10.657720] systemd[1]: Starting Mountpoints Configured in the Real Root...
host1 # [   10.688525] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.
host1 # [   10.692896] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...
host1 # [   10.698953] systemd[1]: Reloading...
server # [   21.731221] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   21.742828] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   21.748631] systemd[1]: Stopped Virtual Console Setup.
server # [   21.749732] systemd[1]: Stopping Virtual Console Setup...
server # [   21.756234] systemd[1]: Starting Virtual Console Setup...
server # [   21.774226] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   21.781674] systemd[1]: Stopped Virtual Console Setup.
server # [   21.782550] systemd[1]: Starting Virtual Console Setup...
server # [   21.820544] systemd-logind[524]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   21.902630] systemd-vconsole-setup[820]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   21.907845] systemd[1]: Finished Virtual Console Setup.
host1 # [   10.926271] systemd[1]: Reloading finished in 228 ms.
host1 # [   10.962822] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...
host1 # [   10.967679] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...
host1 # [   10.976358] systemd[1]: Mounting /sysroot/nix/.ro-store...
host1 # [   10.995606] systemd[1]: Mounting /sysroot/nix/.rw-store...
host1 # [   11.007442] systemd[1]: Mounting /sysroot/run...
host1 # [   11.040295] systemd[1]: Mounting /sysroot/tmp/shared...
host1 # [   11.053580] systemd[1]: Mounting /sysroot/tmp/xchg...
host1 # [   11.056399] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
host1 # [   11.075946] systemd[1]: Finished Mountpoints Configured in the Real Root.
host1 # [   11.078805] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
host1 # [   11.098263] systemd[1]: Mounted /sysroot/nix/.rw-store.
host1 # [   11.285199] fuse: init (API version 7.45)
host1 # [   11.163767] systemd[1]: Mounted /sysroot/run.
host1 # [   11.300255] virtiofs virtio6: discovered new tag: nix-store
host1 # [   11.301087] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
host1 # [   11.320692] virtiofs virtio7: discovered new tag: shared
host1 # [   11.321523] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
host1 # [   11.332943] virtiofs virtio8: discovered new tag: xchg
host1 # [   11.333884] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
host1 # [   11.208819] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [   11.231576] systemd[1]: Mounted /sysroot/nix/.ro-store.
host1 # [   11.234456] systemd[1]: Mounted /sysroot/tmp/shared.
host1 # [   11.241434] systemd[1]: Mounted /sysroot/tmp/xchg.
host1 # [   11.257305] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [   11.260702] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   22.522547] dhcpcd[721]: eth0: soliciting an IPv6 router
server # [   22.524986] dhcpcd[721]: eth0: Router Advertisement from fe80::2
server # [   22.526397] dhcpcd[721]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   22.527886] dhcpcd[721]: eth0: adding route to fec0::/64
server # [   22.529169] dhcpcd[721]: eth0: adding default route via fe80::2
host1 # [   11.969045] systemd[1]: Mounting /sysroot/nix/store...
host1 # [   12.025046] systemd[1]: Mounted /sysroot/nix/store.
host1 # [   12.028133] systemd[1]: Reached target Initrd File Systems.
host1 # [   12.035051] systemd[1]: Starting Find NixOS closure...
host1 # [   12.045509] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
host1 # [   12.071445] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/rzzrvlm7r31iq3im3h66nhxc2zh996l9-systemd-262/lib/udev/mtd_probe": No such file or directory
host1 # [   12.080336] (udev-worker)[98]: 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
host1 # [   12.094518] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
host1 # [   12.100224] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
host1 # [   12.123445] systemd[1]: Finished Find NixOS closure.
host1 # [   12.124503] systemd[1]: Reached target Initrd Default Target.
host1 # [   12.125761] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
host1 # [   12.155542] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   12.156983] systemd[1]: Stopped Virtual Console Setup.
host1 # [   12.163008] systemd[1]: Stopping Virtual Console Setup...
host1 # [   12.164955] systemd[1]: Starting Virtual Console Setup...
host1 # [   12.179926] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   12.182003] systemd[1]: Stopped Virtual Console Setup.
host1 # [   12.190161] systemd[1]: Starting Virtual Console Setup...
host1 # [   12.202397] systemd[1]: initrd-cleanup.service: Deactivated successfully.
host1 # [   12.215360] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
host1 # [   12.217198] systemd[1]: Stopped target Initrd Default Target.
host1 # [   12.218072] systemd[1]: Stopped target Basic System.
host1 # [   12.218840] systemd[1]: Stopped target Initrd Root Device.
host1 # [   12.219678] systemd[1]: Stopped target Path Units.
host1 # [   12.230657] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
host1 # [   12.231780] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
host1 # [   12.241315] systemd[1]: Stopped target Slice Units.
host1 # [   12.242113] systemd[1]: Stopped target Socket Units.
host1 # [   12.242864] systemd[1]: Stopped target System Initialization.
host1 # [   12.243692] systemd[1]: Stopped target Swaps.
host1 # [   12.250304] systemd[1]: Stopped target Timer Units.
host1 # [   12.253473] systemd[1]: dbus.socket: Deactivated successfully.
host1 # [   12.257037] systemd[1]: Closed D-Bus System Message Bus Socket.
host1 # [   12.261105] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
host1 # [   12.264270] systemd[1]: Stopped Find NixOS closure.
host1 # [   12.266171] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [   12.267127] systemd[1]: systemd-sysctl.service: Deactivated successfully.
host1 # [   12.268424] systemd[1]: Stopped Apply Kernel Variables.
host1 # [   12.269196] systemd[1]: systemd-modules-load.service: Deactivated successfully.
host1 # [   12.270335] systemd[1]: Stopped Load Kernel Modules.
host1 # [   12.271074] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
host1 # [   12.277793] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
host1 # [   12.281088] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
host1 # [   12.287261] systemd[1]: Stopped Create System Files and Directories.
host1 # [   12.290533] systemd[1]: Stopped target Local File Systems.
host1 # [   12.291399] systemd[1]: Stopped target Preparation for Local File Systems.
host1 # [   12.296315] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
host1 # [   12.297403] systemd[1]: Stopped Coldplug All udev Devices.
host1 # [   12.298209] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
host1 # [   12.300369] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   12.303079] systemd[1]: Stopped Virtual Console Setup.
host1 # [   12.304099] systemd[1]: systemd-udevd.service: Deactivated successfully.
host1 # [   12.305086] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
host1 # [   12.306120] systemd[1]: systemd-udevd.service: Consumed 1.722s CPU time over 3.177s wall clock time, 26.9M memory peak.
host1 # [   12.307694] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
host1 # [   12.313479] systemd[1]: Closed udev Varlink Socket.
host1 # [   12.316238] systemd[1]: Starting Cleanup udev Database...
host1 # [   12.317296] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
host1 # [   12.320206] systemd[1]: Stopped Create Static Device Nodes in /dev.
host1 # [   12.324253] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
host1 # [   12.328127] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
host1 # [   12.329218] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
host1 # [   12.332223] systemd[1]: Stopped Create List of Static Device Nodes.
host1 # [   12.333163] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [   12.336311] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [   12.366382] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
host1 # [   12.369319] systemd[1]: Finished Cleanup udev Database.
host1 # [   12.371293] systemd[1]: Reached target Switch Root.
host1 # [   12.373232] systemd[1]: Starting NixOS Activation...
host1 # [   12.477220] initrd-nixos-activation-start[182]: booting system configuration /nix/store/1fxwp99qky3arlg1q5fssbv9zdfis035-nixos-system-host1-test
host1 # [   12.526496] initrd-nixos-activation-start[182]: running activation script...
host1 # [   12.949683] initrd-nixos-activation-start[205]: setting up /etc...
host1 # [   13.099028] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
host1 # [   13.102331] systemd[1]: Finished NixOS Activation.
host1 # [   13.103627] systemd[1]: Starting Switch Root...
host1 # [   13.129024] systemd[1]: Switching root.
host1 # [   13.433860] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
host1 # [   13.954816] 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 # [   13.954889] systemd[1]: Detected virtualization qemu.
host1 # [   13.954958] systemd[1]: Detected architecture arm64.
host1 # [   13.955126] systemd[1]: Detected first boot.
host1 # [   13.968865] systemd[1]: Initializing machine ID from random generator.
host1 # [   14.127917] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   24.988364] dhcpcd[721]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   24.988566] dhcpcd[721]: eth0: adding route to 10.0.2.0/24
server # [   24.988697] dhcpcd[721]: eth0: adding default route via 10.0.2.2
server # [   25.101015] systemd[1]: Started DHCP Client.
server # [   25.103598] systemd[1]: Reached target Network is Online.
server # [   25.109023] systemd[1]: Starting step-ca service...
host1 # [   14.499810] systemd[1]: Applying preset policy.
server # [   25.708376] step-ca[910]: badger 2026/11/11 21:13:32 INFO: All 0 tables opened in 0s
host1 # [   14.865780] systemd[1]: Populated /etc with preset unit settings.
server # [   25.730155] step-ca[910]: 2026/11/11 21:13:32 Building new tls configuration using step-ca x509 Signer Interface
server # [   25.754847] step-ca[910]: 2026/11/11 21:13:32 Starting Smallstep CA/0.30.2 (linux/arm64)
server # [   25.763068] step-ca[910]: 2026/11/11 21:13:32 Documentation: https://u.step.sm/docs/ca
server # [   25.765873] step-ca[910]: 2026/11/11 21:13:32 Community Discord: https://u.step.sm/discord
server # [   25.767878] step-ca[910]: 2026/11/11 21:13:32 Config file: /etc/smallstep/ca.json
server # [   25.769129] step-ca[910]: 2026/11/11 21:13:32 The primary server URL is https://server:8443
server # [   25.772908] step-ca[910]: 2026/11/11 21:13:32 Root certificates are available at https://server:8443/roots.pem
server # [   25.776208] step-ca[910]: 2026/11/11 21:13:32 X.509 Root Fingerprint: 1c937a709d9dc60d408f6efbb9ac1769597b94502970b8be58c754acf0b85596
server # [   25.777893] systemd[1]: Started step-ca service.
server # [   25.778683] step-ca[910]: 2026/11/11 21:13:32 Serving HTTPS on 0.0.0.0:8443 ...
server # [   25.779682] systemd[1]: Reached target Multi-User System.
server # [   25.786077] systemd[1]: Starting Order (and renew) ACME certificate for server...
server # [   25.842328] acme-order-renew-server-start[921]: Waiting to acquire lock in /run/acme/
server # [   25.849580] acme-order-renew-server-start[921]: + set -euo pipefail
server # [   25.850708] acme-order-renew-server-start[921]: + exec
server # [   25.851429] acme-order-renew-server-start[921]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
server # [   25.855687] acme-order-renew-server-start[929]: ++ find accounts -path '*/keys/*.key' -print -quit
server # [   25.865726] acme-order-renew-server-start[921]: + '[' -n '' ']'
server # [   25.866775] acme-order-renew-server-start[921]: + exec
server # [   25.867503] acme-order-renew-server-start[921]: + '[' -e certificates/server.key ']'
server # [   25.868653] acme-order-renew-server-start[921]: + 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
host1 # [   15.086880] systemd[1]: initrd-switch-root.service: Deactivated successfully.
host1 # [   15.090143] systemd[1]: Stopped initrd-switch-root.service.
host1 # [   15.094326] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
host1 # [   15.098294] systemd[1]: Created slice Slice /system/getty.
host1 # [   15.100742] systemd[1]: Created slice User and Session Slice.
host1 # [   15.101345] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [   15.102331] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
host1 # [   15.103008] systemd[1]: Expecting device /dev/hvc0...
host1 # [   15.107779] systemd[1]: Expecting device /dev/ttyAMA0...
host1 # [   15.108232] systemd[1]: Reached target Local Encrypted Volumes.
host1 # [   15.109005] systemd[1]: Stopped target initrd-fs.target.
host1 # [   15.109662] systemd[1]: Stopped target initrd-root-fs.target.
host1 # [   15.110330] systemd[1]: Stopped target initrd-switch-root.target.
host1 # [   15.110967] systemd[1]: Reached target Virtual Machines and Containers.
host1 # [   15.116765] systemd[1]: Reached target Path Units.
host1 # [   15.117207] systemd[1]: Reached target Remote File Systems.
host1 # [   15.118059] systemd[1]: Reached target Slice Units.
host1 # [   15.118713] systemd[1]: Reached target Swaps.
host1 # [   15.124172] systemd[1]: Listening on Query the User Interactively for a Password.
host1 # [   15.126417] systemd[1]: Listening on Process Core Dump Socket.
host1 # [   15.129581] systemd[1]: Listening on Credential Encryption/Decryption.
host1 # [   15.130964] systemd[1]: Listening on Factory Reset Management.
host1 # [   15.131483] systemd[1]: Listening on Hostname Service Socket.
host1 # [   15.138014] systemd[1]: Starting Journal Log Access Socket...
host1 # [   15.140471] systemd[1]: Listening on Journal Audit Socket.
host1 # [   15.142867] systemd[1]: Listening on Console Output Muting Service Socket.
host1 # [   15.145815] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
host1 # [   15.147011] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   15.151036] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
host1 # [   15.158688] systemd[1]: Listening on Disk Repartitioning Service Socket.
host1 # [   15.159365] systemd[1]: Listening on udev Varlink Socket.
host1 # [   15.164878] systemd[1]: Mounting Huge Pages File System...
host1 # [   15.169372] systemd[1]: Mounting POSIX Message Queue File System...
host1 # [   15.185094] systemd[1]: Mounting Kernel Debug File System...
host1 # [   15.196190] systemd[1]: Mounting Kernel Trace File System...
host1 # [   15.209255] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [   15.210635] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   15.227238] systemd[1]: Mounting Kernel Configuration File System...
host1 # [   15.240284] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
host1 # [   15.240953] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
host1 # [   15.243194] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [   15.275217] systemd[1]: Mounting FUSE Control File System...
host1 # [   15.277557] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
host1 # [   15.317350] systemd[1]: Starting Journal Service...
host1 # [   15.338404] systemd[1]: Starting Load Kernel Modules...
host1 # [   15.364005] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
host1 # [   15.389992] systemd[1]: Starting Remount Root and Kernel File Systems...
host1 # [   15.390435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   15.422265] systemd[1]: Starting Coldplug All udev Devices...
host1 # [   15.434240] systemd[1]: Listening on Journal Log Access Socket.
host1 # [   15.434777] systemd[1]: Mounted Huge Pages File System.
host1 # [   15.435225] systemd[1]: Mounted POSIX Message Queue File System.
host1 # [   15.449122] systemd-journald[276]: Collecting audit messages is enabled.
host1 # [   15.472071] systemd[1]: Mounted Kernel Debug File System.
host1 # [   15.472666] systemd[1]: Mounted Kernel Trace File System.
host1 # [   15.347769] systemd[1]: Queued start job for default target Multi-User System.
host1 # [   15.349882] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [   15.351501] systemd-modules-load[277]: Module 'atkbd' is built in
host1 # [   15.489241] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [   15.363071] systemd-modules-load[277]: Module 'loop' is built in
host1 # [   15.500609] systemd[1]: Started Journal Service.
host1 # [   15.377360] systemd[1]: Mounted FUSE Control File System.
server # [   26.371361] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.362349500Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
host1 # [   15.394339] systemd[1]: Finished Load Kernel Modules.
host1 # [   15.409512] systemd[1]: Mounted Kernel Configuration File System.
host1 # [   15.426967] systemd[1]: Starting Firewall...
server # [   26.411203] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.403909100Z INFO  Registering the account. email=root@example.org
host1 # [   15.436791] systemd-oomd[278]: No swap; memory pressure usage will be degraded
host1 # [   15.438433] systemd[1]: Starting Apply Kernel Variables...
host1 # [   15.449375] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [   15.579654] EXT4-fs (vda): re-mounted b7e3e7dc-4681-4e47-9e77-95ae4e00c035.
host1 # [   15.457231] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   26.442420] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.435139460Z WARN  !!!! HEADS UP !!!!
server # [   26.443843] acme-order-renew-server-start[930]: Your account credentials have been saved in your
server # [   26.446663] acme-order-renew-server-start[930]: configuration directory at "accounts".
server # [   26.447880] acme-order-renew-server-start[930]: You should make a secure backup of this folder now. This
server # [   26.449563] acme-order-renew-server-start[930]: configuration directory will also contain private keys
server # [   26.453925] acme-order-renew-server-start[930]: generated by lego and certificates obtained from the ACME
server # [   26.455357] acme-order-renew-server-start[930]: server. Making regular backups of this folder is ideal.
server # [   26.458507] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.438110480Z INFO  Obtaining bundled SAN certificate. domains=server
host1 # [   15.482807] systemd[1]: Finished Remount Root and Kernel File Systems.
host1 # [   15.483933] systemd[1]: Listening on Disk Image Download Service Socket.
host1 # [   15.501023] systemd[1]: Starting Flush Journal to Persistent Storage...
host1 # [   15.504720] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [   15.524404] systemd[1]: Starting Load/Save OS Random Seed...
[38.28s] server: (finished: waiting for unit step-ca.service, in 15.97 seconds)
[38.28s] server: waiting for unit nix-grpc-daemon.socket
host1 # [   15.532285] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   26.531293] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.522231340Z INFO  Use solver. domain=server type=http-01
server # [   26.536353] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.522290580Z INFO  http01: Trying to solve HTTP-01. domain=server
server # [   26.550962] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.541926480Z INFO  The server validated our request. domain=server
server # [   26.555789] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.542076660Z INFO  Validations succeeded; requesting certificates. domains=server
[38.35s] server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.06 seconds)
[38.35s] server: waiting for TCP port 50051 on localhost
server # [   26.589359] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.581456320Z INFO  Server responded with a certificate. domains=server
server # [   26.591084] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.581555440Z INFO  Writing file. filepath=certificates/server.crt
server # [   26.602094] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.581698360Z INFO  Writing file. filepath=certificates/server.issuer.crt
server # [   26.603795] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.581750540Z INFO  Writing file. filepath=certificates/server.key
server # [   26.606251] acme-order-renew-server-start[930]: 2026-11-11T21:13:33.585589580Z INFO  Writing file. filepath=certificates/server.json
server # [   26.610934] acme-order-renew-server-start[921]: + touch out/acme-success
server # [   26.614307] acme-order-renew-server-start[921]: + cmp -s certificates/server.crt out/fullchain.pem
host1 # [   15.761100] systemd-journald[276]: Received client request to flush runtime journal.
server # [   26.618006] acme-order-renew-server-start[921]: + touch out/renewed
server # [   26.627285] acme-order-renew-server-start[921]: + echo Installing new certificate
server # [   26.628747] acme-order-renew-server-start[921]: Installing new certificate
server # [   26.629690] acme-order-renew-server-start[921]: + cp -vp certificates/server.crt out/fullchain.pem
server # [   26.647025] acme-order-renew-server-start[953]: 'certificates/server.crt' -> 'out/fullchain.pem'
server # [   26.650265] acme-order-renew-server-start[921]: + cp -vp certificates/server.key out/key.pem
server # Connection to localhost[   26.656660] acme-order-renew-server-start[954]: 'certificates/server.key' -> 'out/key.pem'
server #  (127.0.0.1) 50051 port [tcp/*] succeeded!
server # [   26.660268] acme-order-renew-server-start[921]: + cp -vp certificates/server.issuer.crt out/chain.pem
[38.44s] server: (finished: waiting for TCP port 50051 on localhost, in 0.09 seconds)
server # [   26.666829] acme-order-renew-server-start[955]: 'certificates/server.issuer.crt' -> 'out/chain.pem'

running 4 tests
server # [   26.668638] acme-order-renew-server-start[921]: + ln -sf fullchain.pem out/cert.pem
server # [   26.673767] acme-order-renew-server-start[921]: + cat out/key.pem out/fullchain.pem
server # [   26.678832] acme-order-renew-server-start[921]: + for fixpath in out certificates
server # [   26.679947] acme-order-renew-server-start[921]: + '[' -d out ']'
server # [   26.680970] acme-order-renew-server-start[921]: + chmod -R u=rwX,g=rX,o= out
server # [   26.685476] acme-order-renew-server-start[921]: + chown -R acme:nix-grpc-daemon out
server # [   26.692780] acme-order-renew-server-start[921]: + for fixpath in out certificates
host1 # [   15.710552] systemd[1]: Finished Load/Save OS Random Seed.
server # [   26.694463] acme-order-renew-server-start[921]: + '[' -d certificates ']'
server # [   26.695469] acme-order-renew-server-start[921]: + chmod -R u=rwX,g=rX,o= certificates
host1 # [   15.711625] systemd[1]: Reached target First Boot Complete.
host1 # [   15.717571] systemd[1]: Finished Apply Kernel Variables.
server # [   26.699597] acme-order-renew-server-start[921]: + chown -R acme:nix-grpc-daemon certificates
host1 # [   15.721684] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   26.706271] acme-order-renew-server-start[921]: + chmod -R u=rwX,g=,o= accounts/.
server # [   26.767766] systemd[1]: acme-order-renew-server.service: Deactivated successfully.
server # [   26.771420] systemd[1]: Finished Order (and renew) ACME certificate for server.
server # [   26.774653] systemd[1]: acme-order-renew-server.service: Consumed 359ms CPU time over 1.004s wall clock time, 57.5M memory peak, 4K written to disk, 10.2K incoming IP traffic, 8.1K outgoing IP traffic.
server # [   26.785783] systemd[1]: Starting Nix worker-protocol over gRPC...
host1 # [   15.809906] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
host1 # [   15.820352] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   26.932664] nix-grpc-daemon[973]: ts=2026-11-11T21:13:33Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1
host1 # [   15.965954] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [   15.967327] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [   15.975146] systemd[1]: Mounting /run/wrappers...
server # [   26.959603] nix-grpc-daemon[973]: ts=2026-11-11T21:13:33Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket
server # [   26.964774] nix-grpc-daemon[973]: ts=2026-11-11T21:13:33Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0
host1 # [   15.981610] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   26.966732] systemd[1]: Started Nix worker-protocol over gRPC.
server # [   26.967657] nix-grpc-daemon[973]: ts=2026-11-11T21:13:33Z level=info event=unhealthy reason=min_free
server # [   26.969020] systemd[1]: Startup finished in 6.584s (kernel) + 4.339s (initrd) + 16.038s (userspace) = 26.961s.
host1 # [   16.066788] systemd[1]: Mounted /run/wrappers.
host1 # [   16.067697] systemd[1]: Reached target Local File Systems.
host1 # [   16.074293] systemd[1]: Listening on Boot Loader Control Service Socket.
host1 # [   16.086873] systemd[1]: Starting register-nix-paths.service...
host1 # [   16.095125] systemd[1]: Starting Create SUID/SGID Wrappers...
host1 # [   16.100829] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
host1 # [   16.109486] systemd[1]: Starting Save Transient machine-id to Disk...
host1 # [   16.140823] systemd[1]: Starting Create System Files and Directories...
host1 # [   16.206604] systemd-udevd[319]: Using default interface naming scheme 'v261'.
host1 # [   16.300952] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
host1 # [   16.319483] systemd[1]: Finished Save Transient machine-id to Disk.
host1 # [   16.449760] systemd[1]: Finished Create System Files and Directories.
host1 # [   16.468314] systemd[1]: Starting Rebuild Journal Catalog...
host1 # [   16.481469] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
host1 # [   16.492490] systemd[1]: Started Rule-based Manager for Device Events and Files.
host1 # [   16.689999] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
host1 # [   16.698445] systemd[1]: Finished Rebuild Journal Catalog.
host1 # [   16.711228] systemd[1]: Starting Update is Completed...
host1 # [   16.814849] systemd[1]: Finished Update is Completed.
host1 # [   17.451898] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   17.614118] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   17.681153] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [   17.733764] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
host1 # [   17.739349] systemd[1]: Finished Create SUID/SGID Wrappers.
host1 # [   18.015343] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
host1 # [   18.187068] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
host1 # [   18.580298] (udev-worker)[431]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   18.587375] (udev-worker)[431]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   18.622430] (udev-worker)[428]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   18.700567] systemd[1]: Finished register-nix-paths.service.
host1 # [   18.703998] systemd[1]: Reached target System Initialization.
host1 # [   18.705373] systemd[1]: Started Renew ACME Certificate for host1.
host1 # [   18.706354] systemd[1]: Started Discard unused filesystem blocks once a week.
host1 # [   18.707437] systemd[1]: Started Daily Cleanup of Temporary Directories.
host1 # [   18.720503] systemd[1]: Reached target Timer Units.
host1 # [   18.721334] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   18.722297] systemd[1]: Listening on Nix Daemon Socket.
host1 # [   18.723102] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
host1 # [   18.733663] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
host1 # [   18.735037] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
host1 # [   18.744445] systemd[1]: Starting D-Bus System Message Bus...
host1 # [   18.816564] systemd-ssh-issue[495]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
host1 # [   18.829583] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
host1 # [   18.832649] systemd[1]: Reached target Socket Units.
host1 # [   18.841679] systemd[1]: Finished Firewall.
host1 # [   18.928070] dbus-broker-launch[496]: Looking up NSS user entry for 'systemd-timesync'...
host1 # [   18.934996] dbus-broker-launch[496]: NSS returned no entry for 'systemd-timesync'
host1 # [   18.940254] dbus-broker-launch[496]: Invalid user-name in /nix/store/z6iifw9fw7ig2a8pkbbfxrjga9mrfywz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
host1 # [   18.960706] systemd[1]: Condition check resulted in Virtio network device being skipped.
host1 # [   19.101528] mousedev: PS/2 mouse device common for all mice
host1 # [   18.991389] systemd[1]: Started D-Bus System Message Bus.
host1 # [   18.992456] systemd[1]: Reached target Basic System.
host1 # [   18.998078] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
host1 # [   19.004350] systemd[1]: Started backdoor.service.
host1 # [   19.013375] systemd[1]: Starting Import lastlog data into lastlog2 database...
host1 # [   19.040126] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   19.046907] dbus-broker-launch[496]: Ready
host1 # [   19.081697] systemd[1]: Starting Post-Boot Actions...
host1 # [   19.123519] systemd[1]: Started Reset console on configuration changes.
host1 # [   19.151658] systemd[1]: Starting resolvconf update...
host1 # [   19.175495] acme-setup-privileged[506]: + set -euo pipefail
host1 # [   19.183877] acme-setup-privileged[506]: + cd /var/lib/acme
host1 # [   19.191984] acme-setup-privileged[506]: + chmod -R u=rwX,g=,o= .lego/accounts
host1 # [   19.208282] systemd[1]: Starting SSH Host Keys Generation...
host1 # [   19.216745] acme-setup-privileged[506]: + chown -R acme .lego/accounts
host1 # connecting to host...
host1 # [   19.243817] acme-setup-privileged[506]: + for fixpath in host1 .lego/host1
host1 # [   19.251081] acme-setup-privileged[506]: + '[' -d host1 ']'
host1 # [   19.251942] acme-setup-privileged[506]: + for fixpath in host1 .lego/host1
host1 # [   19.263030] acme-setup-privileged[506]: + '[' -d .lego/host1 ']'
host1 # [   19.326978] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   19.339814] nsncd[509]: Nov 11 21:13:37.632 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   19.352343] systemd[1]: Finished Post-Boot Actions.
host1 # [   19.437313] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   19.438627] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   19.452600] systemd[1]: Starting User Login Management...
host1 # [   19.523449] systemd[1]: Finished Import lastlog data into lastlog2 database.
host1 # [   19.639517] acme-setup-start[525]: + set -euo pipefail
host1 # [   19.640462] acme-setup-start[525]: + test -e ca/key.pem
host1 # [   19.641232] acme-setup-start[525]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
host1 # [   19.677972] systemd-logind[551]: Watching system buttons on /dev/input/event0 (gpio-keys)
host1 # [   19.693857] systemd-logind[551]: New seat seat0.
host1 # [   19.694681] systemd[1]: Started User Login Management.
host1 # [   19.720482] systemd[1]: Starting linger-users.service...
host1 # [   19.748087] systemd[1]: Stopped target Host and Network Name Lookups.
host1 # [   19.753778] systemd[1]: Stopping Host and Network Name Lookups...
host1 # [   19.761588] systemd[1]: Stopped target User and Group Name Lookups.
host1 # [   19.762770] systemd[1]: Stopping User and Group Name Lookups...
host1 # [   19.763646] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
host1 # [   19.777230] systemd[1]: nscd.service: Deactivated successfully.
host1 # [   19.781289] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
host1 # [   19.863244] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   19.872412] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
host1 # [   19.935884] systemd[1]: Starting Ensure certificate for host1...
host1 # [   19.940533] systemd[1]: linger-users.service: Deactivated successfully.
host1 # [   19.944368] systemd[1]: Finished linger-users.service.
host1 # [   20.038403] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   20.039429] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   20.046490] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   20.047856] nsncd[622]: Nov 11 21:13:38.364 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   20.179155] systemd[1]: Finished resolvconf update.
host1 # [   20.184166] systemd[1]: Reached target Preparation for Network.
host1 # [   20.200276] systemd[1]: Starting DHCP Client...
host1 # [   20.212214] systemd[1]: Starting Address configuration of eth1...
host1 # [   20.219703] systemd[1]: Starting Extra networking commands....
host1 # [   20.238269] acme-host1-start[633]: Waiting to acquire lock in /run/acme/
host1 # [   20.306497] acme-host1-start[633]: + '[' -e out/acme-success ']'
host1 # [   20.307498] acme-host1-start[633]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=
host1 # [   20.385336] systemd-logind[551]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
host1 # [   20.401656] acme-host1-start[662]: + cd host1
host1 # [   20.402436] acme-host1-start[662]: + cp -vp cert.pem ../out/cert.pem
host1 # [   20.418502] acme-host1-start[663]: 'cert.pem' -> '../out/cert.pem'
host1 # [   20.434739] acme-host1-start[662]: + cp -vp key.pem ../out/key.pem
host1 # [   20.449018] acme-host1-start[662]: 'key.pem' -> '../out/key.pem'
host1 # [   20.457843] acme-host1-start[633]: + cat out/cert.pem ca/cert.pem
host1 # [   20.484658] acme-host1-start[633]: + cp ca/cert.pem out/chain.pem
host1 # [   20.512928] acme-host1-start[633]: + cat out/key.pem out/fullchain.pem
host1 # [   20.567010] acme-host1-start[633]: + for fixpath in out certificates
host1 # [   20.574827] acme-host1-start[633]: + '[' -d out ']'
host1 # [   20.575693] acme-host1-start[633]: + chmod -R u=rwX,g=rX,o= out
host1 # [   20.600764] network-addresses-eth1-start[652]: adding address 192.168.1.1/24... done
host1 # [   20.612413] acme-host1-start[633]: + chown -R acme:acme out
host1 # [   20.662686] network-addresses-eth1-start[652]: adding address 2001:db8:1::1/64... done
host1 # [   20.674620] acme-host1-start[633]: + for fixpath in out certificates
host1 # [   20.675639] acme-host1-start[633]: + '[' -d certificates ']'
host1 # [   20.686625] systemd[1]: Finished Ensure certificate for host1.
host1 # [   20.780830] systemd[1]: Finished Address configuration of eth1.
host1 # [   20.809518] dhcpcd[667]: dhcpcd-10.3.2 starting
host1 # [   20.828822] dhcpcd[715]: dev: loaded udev
host1 # [   21.031787] 8021q: 802.1Q VLAN Support v1.8
host1 # [   21.032167] 8021q: adding VLAN 0 to HW filter on device eth1
host1 # [   20.961633] systemd[1]: Finished Extra networking commands..
host1 # [   20.963884] systemd[1]: Reached target Network.
host1 # [   20.975401] systemd[1]: Starting Permit User Sessions...
host1 # [   21.282232] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   21.297064] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
host1 # [   21.297572] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
host1 # [   21.303707] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
host1 # [   21.304068] cfg80211: failed to load regulatory.db
host1 # [   21.182519] systemd[1]: Finished Permit User Sessions.
host1 # [   21.195175] systemd[1]: Started Getty on tty1.
host1 # [   21.198543] systemd[1]: Reached target Login Prompts.
host1 # [   21.476943] sshd-keygen-start[571]: Generating public/private rsa key pair.
host1 # [   21.478070] sshd-keygen-start[571]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
host1 # [   21.479315] sshd-keygen-start[571]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
host1 # [   21.484948] sshd-keygen-start[571]: The key fingerprint is:
host1 # [   21.485834] sshd-keygen-start[571]: SHA256:mlWGl0nz7y5DDmn8QLYMYSKYEtGzOJ3r8cXM39yvBD4 root@host1
host1 # [   21.487123] sshd-keygen-start[571]: The key's randomart image is:
host1 # [   21.487968] sshd-keygen-start[571]: +---[RSA 4096]----+
host1 # [   21.497540] sshd-keygen-start[571]: |o+ o      o      |
host1 # [   21.498457] sshd-keygen-start[571]: |. = . . oo =     |
host1 # [   21.499190] sshd-keygen-start[571]: | + + . o..* .    |
host1 # [   21.499920] sshd-keygen-start[571]: |o +     .+o  .   |
host1 # [   21.505917] sshd-keygen-start[571]: | . . +  S*.o  .  |
host1 # [   21.506760] sshd-keygen-start[571]: |  o   =+ .O...   |
host1 # [   21.507537] sshd-keygen-start[571]: | . o .o. +EB. .  |
host1 # [   21.519427] sshd-keygen-start[571]: |  . .   . oo*.   |
host1 # [   21.523120] sshd-keygen-start[571]: |            .=o  |
host1 # [   21.523903] sshd-keygen-start[571]: +----[SHA256]-----+
host1 # [   21.658595] 8021q: adding VLAN 0 to HW filter on device eth0
host1 # [   21.530316] dhcpcd[715]: eth0: waiting for carrier
host1 # [   21.532193] dhcpcd[715]: eth0: carrier acquired
host1 # [   21.544991] dhcpcd[715]: DUID 00:01:00:01:32:87:97:03:52:54:00:12:34:56
host1 # [   21.546055] dhcpcd[715]: eth0: IAID 00:12:34:56
host1 # [   21.546794] dhcpcd[715]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   21.577097] sshd-keygen-start[751]: Generating public/private ed25519 key pair.
host1 # [   21.578800] sshd-keygen-start[751]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
host1 # [   21.591216] sshd-keygen-start[751]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
host1 # [   21.592638] sshd-keygen-start[751]: The key fingerprint is:
host1 # [   21.593413] sshd-keygen-start[751]: SHA256:CgEN7xYcXN4Zh9wA588ifddqE3hak5LUr5Smjpp1kek root@host1
host1 # [   21.594704] sshd-keygen-start[751]: The key's randomart image is:
host1 # [   21.595563] sshd-keygen-start[751]: +--[ED25519 256]--+
host1 # [   21.596392] sshd-keygen-start[751]: |  o+..oo++.      |
host1 # [   21.597120] sshd-keygen-start[751]: |   +oo +o+..     |
host1 # [   21.597847] sshd-keygen-start[751]: |    = . + . .    |
host1 # [   21.598582] sshd-keygen-start[751]: |   . o . + = =   |
host1 # [   21.599357] sshd-keygen-start[751]: |    + . S @ @ o  |
host1 # [   21.601644] sshd-keygen-start[751]: |   . . o + @ =   |
host1 # [   21.602520] sshd-keygen-start[751]: |      . . E =    |
host1 # [   21.603251] sshd-keygen-start[751]: |       o + . .   |
host1 # [   21.603977] sshd-keygen-start[751]: |      o.. .      |
host1 # [   21.609860] sshd-keygen-start[751]: +----[SHA256]-----+
host1 # [   21.674579] sshd-keygen-start[757]: Generating public/private mldsa44-ed25519 key pair.
host1 # [   21.675804] sshd-keygen-start[757]: Your identification has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key
host1 # [   21.680144] sshd-keygen-start[757]: Your public key has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key.pub
host1 # [   21.681561] sshd-keygen-start[757]: The key fingerprint is:
host1 # [   21.682350] sshd-keygen-start[757]: SHA256:jJzXePsp2DOV+DAupcmtPbkpXnXvKi/5swNHr/CzMXk root@host1
host1 # [   21.683531] sshd-keygen-start[757]: The key's randomart image is:
host1 # [   21.690968] sshd-keygen-start[757]: +[MLDSA44-ED25519-+
host1 # [   21.691797] sshd-keygen-start[757]: |                 |
host1 # [   21.693843] sshd-keygen-start[757]: |                 |
host1 # [   21.694626] sshd-keygen-start[757]: |                 |
host1 # [   21.695357] sshd-keygen-start[757]: |     . + o    .  |
host1 # [   21.698815] sshd-keygen-start[757]: |      + S o..o.. |
host1 # [   21.699600] sshd-keygen-start[757]: |       . .=o=..o.|
host1 # [   21.706878] sshd-keygen-start[757]: |       . Oo* *+.E|
host1 # [   21.707731] sshd-keygen-start[757]: |        BoXo=.*= |
host1 # [   21.711815] sshd-keygen-start[757]: |       .o++*o=*B.|
host1 # [   21.713767] sshd-keygen-start[757]: +----[SHA256]-----+
host1 # [   21.714777] systemd[1]: sshd-keygen.service: Deactivated successfully.
host1 # [   21.715720] systemd[1]: Finished SSH Host Keys Generation.
host1 # [   21.722916] systemd[1]: Starting SSH Daemon...
host1 # [   21.815761] sshd[759]: Server listening on 0.0.0.0 port 22.
host1 # [   21.819705] sshd[759]: Server listening on :: port 22.
host1 # [   21.822461] systemd[1]: Started SSH Daemon.
host1 # [   22.426214] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [   22.718639] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
host1 # [   22.723599] systemd[1]: Starting Virtual Console Setup...
host1 # [   22.749692] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   22.754351] systemd[1]: Stopped Virtual Console Setup.
host1 # [   22.759745] systemd[1]: Starting Virtual Console Setup...
host1 # [   22.813581] systemd-logind[551]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
host1 # [   22.892799] dhcpcd[715]: eth0: soliciting a DHCP lease
host1 # [   22.898070] dhcpcd[715]: eth0: offered 10.0.2.15 from 10.0.2.2
host1 # [   22.904557] dhcpcd[715]: eth0: probing address 10.0.2.15/24
host1 # [   22.909070] systemd-vconsole-setup[781]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   22.913578] systemd[1]: Finished Virtual Console Setup.
host1 # [   23.185963] systemd[1]: Created slice Slice /system/sshd-vsock.
host1 # [   23.190741] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   23.196982] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
host1 # [   23.336549] sshd-session[784]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   23.347106] sshd-session[784]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   23.356625] sshd-session[784]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   23.383466] systemd[1]: Created slice Slice /user/0.
host1 # [   23.387383] systemd[1]: Starting User Runtime Directory /run/user/0...
host1 # [   23.423687] systemd-logind[551]: New session '1' of user 'root' with class 'user' and type 'tty'.
host1 # [   23.440975] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   23.447543] systemd[1]: Starting User Manager for UID 0...
host1 # [   23.474743] (systemd)[793]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   23.480477] systemd-logind[551]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   23.574608] systemd[793]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   23.687622] systemd[793]: Queued start job for default target Main User Target.
host1 # [   23.697261] systemd[793]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   23.701643] systemd[793]: Created slice User Application Slice.
host1 # [   23.702727] systemd[793]: Started Daily Cleanup of User's Temporary Directories.
host1 # [   23.703764] systemd[793]: Reached target Paths.
host1 # [   23.704808] systemd[793]: Reached target Timers.
host1 # [   23.707271] systemd[793]: Starting D-Bus User Message Bus Socket...
host1 # [   23.709420] systemd[793]: Starting Create User Files and Directories...
host1 # [   23.755256] systemd[793]: Finished Create User Files and Directories.
host1 # [   23.757538] dhcpcd[715]: eth0: soliciting an IPv6 router
host1 # [   23.759765] dhcpcd[715]: eth0: Router Advertisement from fe80::2
host1 # [   23.761282] dhcpcd[715]: eth0: adding address fec0::5054:ff:fe12:3456/64
host1 # [   23.762760] dhcpcd[715]: eth0: adding route to fec0::/64
host1 # [   23.763908] dhcpcd[715]: eth0: adding default route via fe80::2
host1 # [   23.788651] systemd[793]: Listening on D-Bus User Message Bus Socket.
host1 # [   23.789760] systemd[793]: Reached target Sockets.
host1 # [   23.790493] systemd[793]: Reached target Basic System.
host1 # [   23.791247] systemd[793]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
host1 # [   23.797016] systemd[793]: Reached target Main User Target.
host1 # [   23.797936] systemd[793]: Startup finished in 291ms.
host1 # [   23.798704] systemd[1]: Started User Manager for UID 0.
host1 # [   23.804163] systemd[1]: Started Session 1 of User root.
host1 # [   23.823054] sshd-session[806]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   23.825785] sshd-session[806]: Disconnected from user root UNKNOWN port 65535
host1 # [   23.827221] sshd-session[784]: pam_unix(sshd:session): session closed for user root
host1 # [   23.831569] systemd[1]: sshd-vsock@0-1-3:22-2:2.service: Deactivated successfully.
host1 # [   23.837441] systemd[1]: session-1.scope: Deactivated successfully.
host1 # [   23.842437] systemd-logind[551]: Session 1 logged out. Waiting for processes to exit.
host1 # [   23.845532] systemd-logind[551]: Removed session 1.
server # [   35.497297] systemd[1]: Created slice Slice /system/sshd-vsock.
server # [   35.499510] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   24.514505] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   35.506197] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
host1 # [   24.524178] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
host1 # [   24.537284] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
host1 # [   24.548754] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).
server # [   35.662797] sshd-session[988]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   35.673597] sshd-session[988]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   35.685797] sshd-session[988]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   35.707125] systemd[1]: Created slice Slice /user/0.
server # [   35.711956] systemd[1]: Starting User Runtime Directory /run/user/0...
server # [   35.722105] systemd-logind[524]: New session '1' of user 'root' with class 'user' and type 'tty'.
server # [   35.759384] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   24.778485] sshd-session[812]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   35.766908] systemd[1]: Starting User Manager for UID 0...
host1 # [   24.787274] sshd-session[811]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   24.801180] sshd-session[812]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.805844] sshd-session[811]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   35.795954] (systemd)[996]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.812981] sshd-session[813]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   35.802143] systemd-logind[524]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   24.827188] sshd-session[813]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.833175] sshd-session[812]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.834575] sshd-session[811]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.851254] systemd-logind[551]: New session '3' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.857151] sshd-session[813]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.860613] systemd[1]: Started Session 3 of User root.
host1 # [   24.865260] systemd-logind[551]: New session '4' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.871487] systemd[1]: Started Session 4 of User root.
host1 # [   24.879455] systemd-logind[551]: New session '5' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.884254] systemd[1]: Started Session 5 of User root.
server # [   35.905076] systemd[996]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
server # [   36.029033] systemd[996]: Queued start job for default target Main User Target.
host1 # [   25.047003] sshd-session[829]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   25.050163] sshd-session[829]: Disconnected from user root UNKNOWN port 65535
host1 # [   25.053165] sshd-session[812]: pam_unix(sshd:session): session closed for user root
server # [   36.037379] systemd[996]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   25.056492] sshd-session[832]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   36.042091] systemd[996]: Created slice User Application Slice.
host1 # [   25.057902] sshd-session[832]: Disconnected from user root UNKNOWN port 65535
server # [   36.043157] systemd[996]: Started Daily Cleanup of User's Temporary Directories.
server # [   36.046411] systemd[996]: Reached target Paths.
server # [   36.047275] systemd[996]: Reached target Timers.
server # [   36.047977] systemd[996]: Starting D-Bus User Message Bus Socket...
host1 # [   25.064700] sshd-session[813]: pam_unix(sshd:session): session closed for user root
server # [   36.051306] systemd[996]: Starting Create User Files and Directories...
host1 # [   25.072138] systemd[1]: sshd-vsock@2-3-3:22-2:4.service: Deactivated successfully.
host1 # [   25.078192] sshd-session[830]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   25.079599] sshd-session[830]: Disconnected from user root UNKNOWN port 65535
host1 # [   25.083411] sshd-session[811]: pam_unix(sshd:session): session closed for user root
host1 # [   25.088830] systemd[1]: session-3.scope: Deactivated successfully.
host1 # [   25.089759] systemd[1]: sshd-vsock@3-4-3:22-2:5.service: Deactivated successfully.
host1 # [   25.090856] systemd[1]: session-5.scope: Deactivated successfully.
host1 # [   25.096565] systemd-logind[551]: Session 3 logged out. Waiting for processes to exit.
host1 # [   25.100673] systemd-logind[551]: Removed session 3.
host1 # [   25.101970] systemd-logind[551]: Session 5 logged out. Waiting for processes to exit.
host1 # [   25.105051] systemd-logind[551]: Removed session 5.
host1 # [   25.111103] systemd[1]: sshd-vsock@1-2-3:22-2:3.service: Deactivated successfully.
host1 # [   25.115144] systemd[1]: session-4.scope: Deactivated successfully.
server # [   36.103170] systemd[996]: Finished Create User Files and Directories.
host1 # [   25.118771] systemd-logind[551]: Session 4 logged out. Waiting for processes to exit.
host1 # [   25.123117] systemd-logind[551]: Removed session 4.
server # [   36.130671] systemd[996]: Listening on D-Bus User Message Bus Socket.
server # [   36.134068] systemd[996]: Reached target Sockets.
server # [   36.135011] systemd[996]: Reached target Basic System.
server # [   36.135773] systemd[996]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
server # [   36.141290] systemd[996]: Reached target Main User Target.
server # [   36.142233] systemd[996]: Startup finished in 311ms.
server # [   36.143029] systemd[1]: Started User Manager for UID 0.
server # [   36.145488] systemd[1]: Started Session 1 of User root.
server # [   36.164477] sshd-session[1009]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   36.167424] sshd-session[1009]: Disconnected from user root UNKNOWN port 65535
server # [   36.169192] sshd-session[988]: pam_unix(sshd:session): session closed for user root
server # [   36.173532] systemd[1]: sshd-vsock@0-1-4:22-2:0.service: Deactivated successfully.
server # [   36.179020] systemd[1]: session-1.scope: Deactivated successfully.
server # [   36.184655] systemd-logind[524]: Session 1 logged out. Waiting for processes to exit.
server # [   36.187189] systemd-logind[524]: Removed session 1.
host1 # [   26.137397] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   26.145911] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).
host1 # [   26.164126] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   26.176239] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).
host1 # [   26.188324] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).
host1 # [   26.444433] sshd-session[851]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   26.453414] sshd-session[849]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   26.463057] sshd-session[851]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   26.471400] sshd-session[849]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   26.476592] sshd-session[850]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   26.488597] sshd-session[850]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   26.493680] sshd-session[851]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.498462] sshd-session[849]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.509636] systemd-logind[551]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.519948] systemd[1]: Started Session 6 of User root.
host1 # [   26.520934] systemd[1]: Started Session 7 of User root.
host1 # [   26.521763] systemd-logind[551]: New session '7' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.535056] sshd-session[850]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.549868] systemd-logind[551]: New session '8' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.561376] systemd[1]: Started Session 8 of User root.
host1 # [   26.665716] sshd-session[867]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.667438] sshd-session[867]: Disconnected from user root UNKNOWN port 65535
host1 # [   26.670457] sshd-session[851]: pam_unix(sshd:session): session closed for user root
host1 # [   26.676951] sshd-session[868]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.678925] sshd-session[868]: Disconnected from user root UNKNOWN port 65535
host1 # [   26.681342] sshd-session[849]: pam_unix(sshd:session): session closed for user root
host1 # [   26.686838] systemd[1]: sshd-vsock@6-7-3:22-2:8.service: Deactivated successfully.
host1 # [   26.697402] systemd[1]: session-6.scope: Deactivated successfully.
host1 # [   26.701827] systemd-logind[551]: Session 6 logged out. Waiting for processes to exit.
host1 # [   26.708986] systemd[1]: sshd-vsock@4-5-3:22-2:6.service: Deactivated successfully.
host1 # [   26.710275] systemd-logind[551]: Removed session 6.
host1 # [   26.713595] systemd[1]: session-7.scope: Deactivated successfully.
host1 # [   26.720983] systemd-logind[551]: Session 7 logged out. Waiting for processes to exit.
host1 # [   26.722535] sshd-session[872]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.723804] sshd-session[872]: Disconnected from user root UNKNOWN port 65535
host1 # [   26.730608] sshd-session[850]: pam_unix(sshd:session): session closed for user root
host1 # [   26.731801] systemd-logind[551]: Removed session 7.
host1 # [   26.735118] systemd[1]: sshd-vsock@5-6-3:22-2:7.service: Deactivated successfully.
host1 # [   26.739386] systemd[1]: session-8.scope: Deactivated successfully.
host1 # [   26.741654] systemd-logind[551]: Session 8 logged out. Waiting for processes to exit.
host1 # [   26.745708] systemd-logind[551]: Removed session 8.
server # [   38.185446] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   38.197180] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
server # [   38.298728] sshd-session[1015]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   38.307151] sshd-session[1015]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   38.317883] sshd-session[1015]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   38.327636] systemd-logind[524]: New session '3' of user 'root' with class 'user' and type 'tty'.
server # [   38.334137] systemd[1]: Started Session 3 of User root.
host1 # [   27.699596] dhcpcd[715]: eth0: leased 10.0.2.15 for 86400 seconds
host1 # [   27.701207] dhcpcd[715]: eth0: adding route to 10.0.2.0/24
host1 # [   27.702033] dhcpcd[715]: eth0: adding default route via 10.0.2.2
host1 # [   27.803754] systemd[1]: Started DHCP Client.
host1 # [   27.808187] systemd[1]: Reached target Network is Online.
host1 # [   27.812191] systemd[1]: Starting fetch-ca-root.service...
host1 # [   27.934013] systemd[1]: Finished fetch-ca-root.service.
host1 # [   27.940211] systemd[1]: Reached target Multi-User System.
host1 # [   27.944683] systemd[1]: Starting Order (and renew) ACME certificate for host1...
host1 # [   28.024587] acme-order-renew-host1-start[942]: Waiting to acquire lock in /run/acme/
host1 # [   28.034612] acme-order-renew-host1-start[942]: + set -euo pipefail
host1 # [   28.037170] acme-order-renew-host1-start[942]: + exec
host1 # [   28.038358] acme-order-renew-host1-start[942]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
host1 # [   28.043042] acme-order-renew-host1-start[951]: ++ find accounts -path '*/keys/*.key' -print -quit
host1 # [   28.053433] acme-order-renew-host1-start[942]: + '[' -n '' ']'
host1 # [   28.054493] acme-order-renew-host1-start[942]: + exec
host1 # [   28.055229] acme-order-renew-host1-start[942]: + '[' -e certificates/host1.key ']'
host1 # [   28.056412] acme-order-renew-host1-start[942]: + 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 # [   28.276344] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.594909420Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
host1 # [   28.292636] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.612575840Z INFO  Registering the account. email=root@example.org
host1 # [   28.320306] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.640448400Z WARN  !!!! HEADS UP !!!!
host1 # [   28.321819] acme-order-renew-host1-start[952]: Your account credentials have been saved in your
host1 # [   28.323151] acme-order-renew-host1-start[952]: configuration directory at "accounts".
host1 # [   28.326712] acme-order-renew-host1-start[952]: You should make a secure backup of this folder now. This
host1 # [   28.328108] acme-order-renew-host1-start[952]: configuration directory will also contain private keys
host1 # [   28.329304] acme-order-renew-host1-start[952]: generated by lego and certificates obtained from the ACME
host1 # [   28.330833] acme-order-renew-host1-start[952]: server. Making regular backups of this folder is ideal.
host1 # [   28.332111] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.645625640Z INFO  Obtaining bundled SAN certificate. domains=host1
host1 # [   28.432085] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.751428580Z INFO  Use solver. domain=host1 type=http-01
host1 # [   28.435766] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.751507500Z INFO  http01: Trying to solve HTTP-01. domain=host1
host1 # [   28.475042] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   28.486679] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).
host1 # [   28.495502] systemd[1]: Started SSH per-connection Daemon (vsock:2:10).
host1 # [   28.501415] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.819647220Z INFO  The server validated our request. domain=host1
host1 # [   28.507290] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.819826580Z INFO  Validations succeeded; requesting certificates. domains=host1
host1 # [   28.568433] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.888533720Z INFO  Server responded with a certificate. domains=host1
host1 # [   28.584546] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.891320860Z INFO  Writing file. filepath=certificates/host1.crt
host1 # [   28.587199] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.891648420Z INFO  Writing file. filepath=certificates/host1.issuer.crt
host1 # [   28.601004] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.891778620Z INFO  Writing file. filepath=certificates/host1.key
host1 # [   28.603584] acme-order-renew-host1-start[952]: 2026-11-11T21:13:46.891974720Z INFO  Writing file. filepath=certificates/host1.json
host1 # [   28.620514] acme-order-renew-host1-start[942]: + touch out/acme-success
host1 # [   28.622266] acme-order-renew-host1-start[942]: + cmp -s certificates/host1.crt out/fullchain.pem
server # [   39.615861] sshd-session[1021]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   39.616518] sshd-session[1021]: Disconnected from user root UNKNOWN port 65535
server # [   39.622163] sshd-session[1015]: pam_unix(sshd:session): session closed for user root
server # [   39.627767] systemd[1]: sshd-vsock@1-2-4:22-2:1.service: Deactivated successfully.
server # [   39.635975] systemd[1]: session-3.scope: Deactivated successfully.
host1 # [   28.651580] acme-order-renew-host1-start[942]: + touch out/renewed
server # [   39.639115] systemd[1]: session-3.scope: Consumed 447ms CPU time over 1.303s wall clock time, 47.1M memory peak, 1.4K outgoing IP traffic.
server # [   39.649638] systemd-logind[524]: Session 3 logged out. Waiting for processes to exit.
server # [   39.651173] systemd-logind[524]: Removed session 3.
host1 # [   28.674187] acme-order-renew-host1-start[942]: + echo Installing new certificate
host1 # [   28.676207] acme-order-renew-host1-start[942]: Installing new certificate
host1 # [   28.678761] acme-order-renew-host1-start[942]: + cp -vp certificates/host1.crt out/fullchain.pem
host1 # [   28.716446] acme-order-renew-host1-start[964]: 'certificates/host1.crt' -> 'out/fullchain.pem'
host1 # [   28.717959] acme-order-renew-host1-start[942]: + cp -vp certificates/host1.key out/key.pem
host1 # [   28.732239] acme-order-renew-host1-start[969]: 'certificates/host1.key' -> 'out/key.pem'
host1 # [   28.737780] acme-order-renew-host1-start[942]: + cp -vp certificates/host1.issuer.crt out/chain.pem
host1 # [   28.751126] acme-order-renew-host1-start[970]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'
host1 # [   28.754252] acme-order-renew-host1-start[942]: + ln -sf fullchain.pem out/cert.pem
host1 # [   28.766738] acme-order-renew-host1-start[942]: + cat out/key.pem out/fullchain.pem
host1 # [   28.783917] acme-order-renew-host1-start[942]: + for fixpath in out certificates
host1 # [   28.789651] acme-order-renew-host1-start[942]: + '[' -d out ']'
host1 # [   28.790632] acme-order-renew-host1-start[942]: + chmod -R u=rwX,g=rX,o= out
host1 # [   28.798683] sshd-session[958]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   28.805845] sshd-session[957]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   28.807745] acme-order-renew-host1-start[942]: + chown -R acme:acme out
host1 # [   28.814342] sshd-session[958]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   28.823086] acme-order-renew-host1-start[942]: + for fixpath in out certificates
host1 # [   28.826098] acme-order-renew-host1-start[942]: + '[' -d certificates ']'
host1 # [   28.829500] acme-order-renew-host1-start[942]: + chmod -R u=rwX,g=rX,o= certificates
host1 # [   28.830873] sshd-session[957]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   28.841186] acme-order-renew-host1-start[942]: + chown -R acme:acme certificates
host1 # [   28.856991] sshd-session[957]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   28.862888] sshd-session[958]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   28.868576] acme-order-renew-host1-start[942]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   28.880765] systemd-logind[551]: New session '9' of user 'root' with class 'user' and type 'tty'.
host1 # [   28.892415] systemd[1]: Started Session 9 of User root.
host1 # [   28.908931] systemd-logind[551]: New session '10' of user 'root' with class 'user' and type 'tty'.
host1 # [   28.918488] systemd[1]: Started Session 10 of User root.
host1 # [   29.009612] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.
host1 # [   29.017618] systemd[1]: Finished Order (and renew) ACME certificate for host1.
host1 # [   29.019012] systemd[1]: Startup finished in 8.265s (kernel) + 5.122s (initrd) + 15.628s (userspace) = 29.016s.
host1 # [   29.022469] systemd[1]: acme-order-renew-host1.service: Consumed 278ms CPU time over 1.066s wall clock time, 55.7M memory peak, 4K written to disk, 10.5K incoming IP traffic, 8.1K outgoing IP traffic.
host1 # [   29.048940] sshd-session[984]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   29.056168] sshd-session[984]: Disconnected from user root UNKNOWN port 65535
host1 # [   29.057831] sshd-session[957]: pam_unix(sshd:session): session closed for user root
host1 # [   29.063543] systemd[1]: sshd-vsock@7-8-3:22-2:9.service: Deactivated successfully.
host1 # [   29.069652] systemd[1]: session-9.scope: Deactivated successfully.
host1 # [   29.077071] systemd-logind[551]: Session 9 logged out. Waiting for processes to exit.
host1 # [   29.081573] systemd-logind[551]: Removed session 9.
host1 # [   29.097838] sshd-session[986]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   29.100430] sshd-session[986]: Disconnected from user root UNKNOWN port 65535
host1 # [   29.101787] sshd-session[958]: pam_unix(sshd:session): session closed for user root
host1 # [   29.106426] systemd[1]: sshd-vsock@8-9-3:22-2:10.service: Deactivated successfully.
host1 # [   29.111005] systemd[1]: session-10.scope: Deactivated successfully.
host1 # [   29.115707] systemd-logind[551]: Session 10 logged out. Waiting for processes to exit.
host1 # [   29.118533] systemd-logind[551]: Removed session 10.
host1 # [   29.264578] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   29.273560] systemd[1]: Started SSH per-connection Daemon (vsock:2:11).
server # [   40.265331] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   29.284193] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   40.274661] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
host1 # [   29.292149] systemd[1]: Started SSH per-connection Daemon (vsock:2:12).
server # [   40.371792] sshd-session[1041]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   40.379585] sshd-session[1041]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   40.389921] sshd-session[1041]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   40.400141] systemd-logind[524]: New session '4' of user 'root' with class 'user' and type 'tty'.
server # [   40.408520] systemd[1]: Started Session 4 of User root.
host1 # [   29.434956] sshd-session[1003]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   29.441769] sshd-session[1002]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   29.450192] sshd-session[1003]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   29.454975] sshd-session[1002]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   29.465231] sshd-session[1003]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   29.469979] sshd-session[1002]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   29.477787] systemd-logind[551]: New session '11' of user 'root' with class 'user' and type 'tty'.
host1 # [   29.488574] systemd[1]: Started Session 11 of User root.
host1 # [   29.494616] systemd-logind[551]: New session '12' of user 'root' with class 'user' and type 'tty'.
host1 # [   29.501690] systemd[1]: Started Session 12 of User root.
server # [   40.564441] sshd-session[1047]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   40.566903] sshd-session[1047]: Disconnected from user root UNKNOWN port 65535
host1 # [   29.582858] sshd-session[1014]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   40.568692] sshd-session[1041]: pam_unix(sshd:session): session closed for user root
host1 # [   29.585328] sshd-session[1014]: Disconnected from user root UNKNOWN port 65535
host1 # [   29.586488] sshd-session[1015]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   29.587728] sshd-session[1015]: Disconnected from user root UNKNOWN port 65535
server # [   40.573245] systemd[1]: sshd-vsock@2-3-4:22-2:2.service: Deactivated successfully.
host1 # [   29.589931] sshd-session[1003]: pam_unix(sshd:session): session closed for user root
host1 # [   29.591153] sshd-session[1002]: pam_unix(sshd:session): session closed for user root
server # [   40.578114] systemd[1]: session-4.scope: Deactivated successfully.
host1 # [   29.596510] systemd[1]: sshd-vsock@9-10-3:22-2:11.service: Deactivated successfully.
server # [   40.582320] systemd-logind[524]: Session 4 logged out. Waiting for processes to exit.
server # [   40.584833] systemd-logind[524]: Removed session 4.
host1 # [   29.601377] systemd[1]: sshd-vsock@10-11-3:22-2:12.service: Deactivated successfully.
host1 # [   29.606701] systemd[1]: session-12.scope: Deactivated successfully.
host1 # [   29.609126] systemd[1]: session-11.scope: Deactivated successfully.
host1 # [   29.612235] systemd-logind[551]: Session 11 logged out. Waiting for processes to exit.
host1 # [   29.616496] systemd-logind[551]: Removed session 11.
host1 # [   29.618846] systemd-logind[551]: Session 12 logged out. Waiting for processes to exit.
host1 # [   29.620575] systemd-logind[551]: Removed session 12.
test acme::host1_obtains_a_certificate_via_acme ... ok
server # [   42.489746] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   31.506581] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   42.497748] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
host1 # [   31.516161] systemd[1]: Started SSH per-connection Daemon (vsock:2:13).
host1 # [   31.524170] systemd[1]: Started SSH per-connection Daemon (vsock:2:14).
server # [   42.605392] sshd-session[1054]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   42.613499] sshd-session[1054]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   42.621037] sshd-session[1054]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   42.631557] systemd-logind[524]: New session '5' of user 'root' with class 'user' and type 'tty'.
server # [   42.637437] systemd[1]: Started Session 5 of User root.
host1 # [   31.679376] sshd-session[1025]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   31.685047] sshd-session[1026]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   31.694545] sshd-session[1026]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   31.695749] sshd-session[1025]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   31.707000] sshd-session[1025]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   31.711016] sshd-session[1026]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   31.721321] systemd-logind[551]: New session '14' of user 'root' with class 'user' and type 'tty'.
host1 # [   31.728569] systemd[1]: Started Session 14 of User root.
host1 # [   31.734889] systemd-logind[551]: New session '13' of user 'root' with class 'user' and type 'tty'.
host1 # [   31.739636] systemd[1]: Started Session 13 of User root.
host1 # [   31.768175] sshd-session[1038]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   31.771323] sshd-session[1038]: Disconnected from user root UNKNOWN port 65535
host1 # [   31.773905] sshd-session[1025]: pam_unix(sshd:session): session closed for user root
host1 # [   31.779880] systemd[1]: sshd-vsock@11-12-3:22-2:13.service: Deactivated successfully.
host1 # [   31.786678] systemd[1]: session-13.scope: Deactivated successfully.
host1 # [   31.792271] systemd-logind[551]: Session 13 logged out. Waiting for processes to exit.
server # [   42.782490] sshd-session[1060]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   31.798709] sshd-session[1037]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   42.783882] sshd-session[1060]: Disconnected from user root UNKNOWN port 65535
host1 # [   31.801947] systemd-logind[551]: Removed session 13.
server # [   42.786063] sshd-session[1054]: pam_unix(sshd:session): session closed for user root
host1 # [   31.802862] sshd-session[1037]: Disconnected from user root UNKNOWN port 65535
host1 # [   31.803824] sshd-session[1026]: pam_unix(sshd:session): session closed for user root
server # [   42.789920] systemd[1]: sshd-vsock@3-4-4:22-2:3.service: Deactivated successfully.
host1 # [   31.806290] systemd[1]: sshd-vsock@12-13-3:22-2:14.service: Deactivated successfully.
host1 # [   31.810676] systemd[1]: session-14.scope: Deactivated successfully.
server # [   42.795042] systemd[1]: session-5.scope: Deactivated successfully.
host1 # [   31.815030] systemd-logind[551]: Session 14 logged out. Waiting for processes to exit.
server # [   42.799676] systemd-logind[524]: Session 5 logged out. Waiting for processes to exit.
host1 # [   31.817528] systemd-logind[551]: Removed session 14.
server # [   42.802558] systemd-logind[524]: Removed session 5.
test acme::server_builds_and_signs_a_path ... ok
host1 # [   32.421426] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   32.429693] systemd[1]: Started SSH per-connection Daemon (vsock:2:15).
host1 # [   32.439833] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   32.447416] systemd[1]: Started SSH per-connection Daemon (vsock:2:16).
host1 # [   32.591022] sshd-session[1047]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   32.595622] sshd-session[1048]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   32.603216] sshd-session[1047]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   32.610056] sshd-session[1048]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   32.618780] sshd-session[1047]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   32.625160] sshd-session[1048]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   32.630391] systemd-logind[551]: New session '15' of user 'root' with class 'user' and type 'tty'.
host1 # [   32.636781] systemd[1]: Started Session 15 of User root.
host1 # [   32.642917] systemd-logind[551]: New session '16' of user 'root' with class 'user' and type 'tty'.
host1 # [   32.648173] systemd[1]: Started Session 16 of User root.
server # [   44.005637] systemd[1]: Started Nix Daemon.
server # [   44.162153] nix-daemon[1069]: accepted connection from pid 973, user nix-grpc-daemon (trusted)
server # [   44.175956] nix-grpc-daemon[973]: ts=2026-11-11T21:13:51Z level=info event=denied method=Connect cn=host1 role=read-only
host1 # [   33.229743] sshd-session[1060]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   33.231919] sshd-session[1060]: Disconnected from user root UNKNOWN port 65535
host1 # [   33.234579] sshd-session[1048]: pam_unix(sshd:session): session closed for user root
host1 # [   33.242997] systemd[1]: sshd-vsock@14-15-3:22-2:16.service: Deactivated successfully.
host1 # [   33.247807] systemd[1]: session-16.scope: Deactivated successfully.
host1 # [   33.251444] systemd[1]: session-16.scope: Consumed 194ms CPU time over 602ms wall clock time, 33.8M memory peak, 5.2K incoming IP traffic, 4K outgoing IP traffic.
host1 # [   33.259203] systemd-logind[551]: Session 16 logged out. Waiting for processes to exit.
host1 # [   33.260954] systemd-logind[551]: Removed session 16.
server # [   44.337122] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   44.345150] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
server # [   44.405025] nix-daemon[1069]: accepted connection from pid 973, user nix-grpc-daemon (trusted)
server # [   44.428891] nix-grpc-daemon[973]: ts=2026-11-11T21:13:51Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:38386 duration_s=0 paths=1 nar_bytes_out=128
server # [   44.443125] nix-daemon[1069]: reaped child process 1075, status = succeeded
host1 # [   33.477239] sshd-session[1059]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   33.479491] sshd-session[1059]: Disconnected from user root UNKNOWN port 65535
host1 # [   33.482538] sshd-session[1047]: pam_unix(sshd:session): session closed for user root
host1 # [   33.487815] systemd[1]: sshd-vsock@13-14-3:22-2:15.service: Deactivated successfully.
server # [   44.473533] sshd-session[1073]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   33.495701] systemd[1]: session-15.scope: Deactivated successfully.
server # [   44.479734] sshd-session[1073]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   33.498386] systemd[1]: session-15.scope: Consumed 222ms CPU time over 861ms wall clock time, 43.6M memory peak, 10.2K incoming IP traffic, 9.3K outgoing IP traffic.
server # [   44.488808] sshd-session[1073]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   33.506637] systemd-logind[551]: Session 15 logged out. Waiting for processes to exit.
host1 # [   33.508525] systemd-logind[551]: Removed session 15.
server # [   44.499374] systemd-logind[524]: New session '6' of user 'root' with class 'user' and type 'tty'.
server # [   44.504553] systemd[1]: Started Session 6 of User root.
server # [   44.530931] sshd-session[1081]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   44.533688] sshd-session[1081]: Disconnected from user root UNKNOWN port 65535
server # [   44.534953] sshd-session[1073]: pam_unix(sshd:session): session closed for user root
server # [   44.538873] systemd[1]: sshd-vsock@4-5-4:22-2:4.service: Deactivated successfully.
server # [   44.544745] systemd[1]: session-6.scope: Deactivated successfully.
server # [   44.549635] systemd-logind[524]: Session 6 logged out. Waiting for processes to exit.
server # [   44.551864] systemd-logind[524]: Removed session 6.
test acme::a_read_only_host_cannot_write ... ok
host1 # [   33.857825] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   33.866572] systemd[1]: Started SSH per-connection Daemon (vsock:2:17).
host1 # [   33.963460] sshd-session[1094]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   33.985684] sshd-session[1094]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   33.995654] sshd-session[1094]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   34.008146] systemd-logind[551]: New session '17' of user 'root' with class 'user' and type 'tty'.
host1 # [   34.013391] systemd[1]: Started Session 17 of User root.
host1 # [   34.039476] sshd-session[1100]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   34.042636] sshd-session[1100]: Disconnected from user root UNKNOWN port 65535
host1 # [   34.044356] sshd-session[1094]: pam_unix(sshd:session): session closed for user root
host1 # [   34.049326] systemd[1]: sshd-vsock@15-16-3:22-2:17.service: Deactivated successfully.
host1 # [   34.054610] systemd[1]: session-17.scope: Deactivated successfully.
host1 # [   34.059172] systemd-logind[551]: Session 17 logged out. Waiting for processes to exit.
host1 # [   34.061576] systemd-logind[551]: Removed session 17.
test acme::host1_substitutes_the_signed_path_with_a_read_only_cert ... ok

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

[56.92s] (finished: run the VM test script, in 56.90 seconds)
[57.46s] test script finished in 57.44s
[57.46s] cleanup
[57.46s] kill QemuMachine (pid 53)
host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)
host1 # [2026-11-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
[58.17s] 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-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-11T21:13:53Z INFO  virtiofsd] Client disconnected, shutting down
[58.92s] (finished: cleanup, in 1.45 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/tmpjoeg3s4d/host1_host.socket
    server:  ssh -o User=root vsock-mux//build/tmpjoeg3s4d/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