tribuchet: building on eliza
Machine state will be reset. To keep it, pass --keep-machine-state
start all VLans
(finished: start all VLans, in 0.01 seconds)
start vhost-device-vsock
(finished: start vhost-device-vsock, in 0.00 seconds)
Test will time out and terminate in 600.0 seconds
run the VM test script
start all VMs
host1: starting vm
server: starting vm
server # Disk image does not exist, creating the virtualisation disk image...
server # Formatting '/build/vm-state-server/tmp.ZmlSAPxz0f', fmt=raw size=1073741824
server # mke2fs 1.47.4 (6-Mar-2025)
server # Discarding device blocks:      0/262144             done
server: QEMU running (pid 55)
server # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Filesystem UUID: fd3bafa2-c093-4635-918a-a521857783f0
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-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-11-06T08:43:41Z INFO  virtiofsd] Client connected, servicing requests
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
server # [    0.000000] Linux version 6.18.59 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1793027368
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/4gba48l6nd42fbq8svyfqflik32b4zmi-nixos-system-server-test/init regInfo=/nix/.ro-store/ybk690x2a8yckix5sq14pgry46hxskap-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ybk690x2a8yckix5sq14pgry46hxskap-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 75315 entries in 296 pages
server # [    0.000000] ftrace: allocated 296 pages with 3 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ee0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44ef0000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000044f00000
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044f10000
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.000034] arm-pv: using stolen time PV
server # [    0.000430] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000600] Console: colour dummy device 80x25
server # [    0.000608] printk: legacy console [tty0] enabled
server # [    0.000798] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000805] pid_max: default: 32768 minimum: 301
server # [    0.000892] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
server # [    0.001026] landlock: Up and running.
server # [    0.001030] Yama: becoming mindful.
server # [    0.001499] LSM support for eBPF active
server # [    0.001645] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.001686] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.003636] rcu: Hierarchical SRCU implementation.
server # [    0.003644] rcu: 	Max phase no-delay instances is 1000.
server # [    0.005042] fsl-mc MSI: its@8080000 domain created
server # [    0.005167] EFI services will not be available.
server # [    0.005259] smp: Bringing up secondary CPUs ...
server # [    0.005269] smp: Brought up 1 node, 1 CPU
server # [    0.005273] SMP: Total of 1 processors activated.
server # [    0.005276] CPU: All CPU(s) started at EL1
server # [    0.005286] CPU features: detected: Branch Target Identification
server # [    0.005291] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.005294] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.005298] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.005304] CPU features: detected: Common not Private translations
server # [    0.005308] CPU features: detected: CRC32 instructions
server # [    0.005310] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.005314] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.005317] CPU features: detected: Data independent timing control (DIT)
server # [    0.005320] CPU features: detected: E0PD
server # [    0.005322] CPU features: detected: Enhanced Counter Virtualization
server # [    0.005326] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.005329] CPU features: detected: Enhanced Virtualization Traps
server # [    0.005333] CPU features: detected: Fine Grained Traps
server # [    0.005336] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.005341] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.005344] CPU features: detected: LSE atomic instructions
server # [    0.005347] CPU features: detected: Privileged Access Never
server # [    0.005350] CPU features: detected: PMUv3
server # [    0.005353] CPU features: detected: RAS Extension Support
server # [    0.005356] CPU features: detected: RASv1p1 Extension Support
server # [    0.005358] CPU features: detected: Random Number Generator
server # [    0.005364] CPU features: detected: Speculation barrier (SB)
server # [    0.005366] CPU features: detected: Stage-2 Force Write-Back
server # [    0.005369] CPU features: detected: TLB range maintenance instructions
server # [    0.005374] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.005412] alternatives: applying system-wide alternatives
server # [    0.008520] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.008741] Memory: 1914820K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138768K reserved, 32768K cma-reserved)
server # [    0.009191] devtmpfs: initialized
server # [    0.011229] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.011254] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.011440] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.011444] 0 pages in range for non-PLT usage
server # [    0.011446] 506368 pages in range for PLT usage
server # [    0.011538] pinctrl core: initialized pinctrl subsystem
server # [    0.012471] DMI not present or invalid.
server # [    0.018129] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.021178] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
server # [    0.021393] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.021620] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.021651] audit: initializing netlink subsys (disabled)
server # [    0.022278] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.022281] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.022284] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.022287] thermal_sys: Registered thermal governor 'user_space'
server # [    0.022290] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.022319] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
server # [    0.022328] cpuidle: using governor ladder
server # [    0.022335] cpuidle: using governor menu
server # [    0.022534] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.022554] ASID allocator initialised with 65536 entries
server # [    0.023781] Serial: AMBA PL011 UART driver
server # [    0.030488] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.030588] printk: console [ttyAMA0] enabled
server # [    0.158246] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.158257] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.158261] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.158264] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.158266] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.158269] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.158272] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.158275] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.159533] fbcon: Taking over console
server # [    0.159544] ACPI: Interpreter disabled.
server # [    0.177388] iommu: Default domain type: Translated
server # [    0.177396] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.178160] SCSI subsystem initialized
server # [    0.180200] usbcore: registered new interface driver usbfs
server # [    0.180224] usbcore: registered new interface driver hub
server # [    0.180255] usbcore: registered new device driver usb
server # [    0.180618] pps_core: LinuxPPS API ver. 1 registered
server # [    0.180623] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.180643] PTP clock support registered
server # [    0.180696] EDAC MC: Ver: 3.0.0
server # [    0.180871] scmi_core: SCMI protocol bus registered
server # [    0.181231] FPGA manager framework
server # [    0.181823] vgaarb: loaded
server # [    0.188020] clocksource: Switched to clocksource arch_sys_counter
server # [    0.193323] VFS: Disk quotas dquot_6.6.0
server # [    0.193385] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.193804] netfs: FS-Cache loaded
server # [    0.193939] pnp: PnP ACPI: disabled
server # [    0.199491] NET: Registered PF_INET protocol family
server # [    0.199781] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.233596] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.233637] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.233665] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.233748] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
server # [    0.233901] TCP: Hash tables configured (established 16384 bind 16384)
server # [    0.234008] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
server # [    0.234052] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.234090] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.234190] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.234235] NET: Registered PF_XDP protocol family
server # [    0.234252] PCI: CLS 0 bytes, default 64
server # [    0.234503] Trying to unpack rootfs image as initramfs...
server # [    0.256065] kvm [1]: HYP mode not available
server # [    0.373516] Initialise system trusted keyrings
server # [    0.373561] Key type blacklist registered
server # [    0.373700] workingset: timestamp_bits=42 max_order=19 bucket_order=0
server # [    0.374072] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.374132] 9p: Installing v9fs 9p2000 file system support
server # [    0.374221] integrity: Platform Keyring initialized
server # [    0.374228] integrity: Machine keyring initialized
server # [    0.398702] Key type asymmetric registered
server # [    0.398717] Asymmetric key parser 'x509' registered
server # [    0.398798] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.408079] io scheduler mq-deadline registered
server # [    0.408093] io scheduler kyber registered
server # [    0.413635] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.416822] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.417278] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.417294] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.417308] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.417315] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.417334] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.417377] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.417464] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.417472] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.417476] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.417479] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.417482] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.418335] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.418784] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.418970] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.418982] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.419007] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.419019] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.419479] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.419663] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.419674] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.419700] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.445552] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.445750] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.445763] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.445788] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.446262] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.446446] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.446457] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.446483] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.446495] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.446941] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.447125] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.447150] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.447618] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.447802] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.447827] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.460188] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    0.460388] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    0.460674] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.460860] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.460885] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.461334] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.461518] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.461543] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.461991] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.462176] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.462201] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.462660] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.462945] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.462961] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.462986] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.463454] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.463635] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.463646] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.463671] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.484246] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
server # [    0.484560] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.484586] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.485277] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.485283] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.485287] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.485333] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.485383] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.485427] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.485473] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.485518] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.485563] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.485608] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.485653] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.485698] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.485856] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.485903] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
server # [    0.485945] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.485963] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.485980] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.485997] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.486015] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.486032] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.486050] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.486070] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.486088] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.486106] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.486124] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.486143] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.486161] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
server # [    0.486179] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.486196] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.486214] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.486231] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.486248] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.486266] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.486293] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.486298] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.486301] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.487138] pci 0000:00:07.0: enabling device (0000 -> 0002)
host1 # Disk image does not exist, creating the virtualisation disk image...
host1: QEMU running (pid 54)
host1 # Formatting '/build/vm-state-host1/tmp.weuZUXmnMA', 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
(finished: start all VMs, in 14.84 seconds)
host1 # Filesystem UUID: 7d173ddc-8e35-42f8-83d4-0c3a3e5304b6
server: waiting for unit step-ca.service
host1 # Superblock backups stored on blocks:
server: waiting for the VM to finish booting
host1 # 	32768, 98304, 163840, 229376
host1 # 
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-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-11-06T08:43:41Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-11-06T08:43:41Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-11-06T08:43:42Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-06T08:43:42Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-11-06T08:43:42Z INFO  virtiofsd] Client connected, servicing requests
server # [    0.548730] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    1.674435] Freeing initrd memory: 25272K
host1 # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
host1 # [    0.000000] Linux version 6.18.59 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1793027368
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/yawy7f20wczfgs8wmfnadz0ivq1m9mdk-nixos-system-host1-test/init regInfo=/nix/.ro-store/fzzwpws96xwf9258cl64j640fp1djv8k-closure-info/registration console=ttyAMA0,115200n8 console=tty0
host1 # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/fzzwpws96xwf9258cl64j640fp1djv8k-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 75315 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.000032] arm-pv: using stolen time PV
host1 # [    0.000517] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
host1 # [    0.002028] Console: colour dummy device 80x25
host1 # [    0.002037] printk: legacy console [tty0] enabled
host1 # [    0.002366] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
host1 # [    0.002373] pid_max: default: 32768 minimum: 301
host1 # [    0.002486] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima
host1 # [    0.002681] landlock: Up and running.
host1 # [    0.002687] Yama: becoming mindful.
host1 # [    0.003192] LSM support for eBPF active
host1 # [    0.003363] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.003431] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.006000] rcu: Hierarchical SRCU implementation.
host1 # [    0.006011] rcu: 	Max phase no-delay instances is 1000.
host1 # [    0.007513] fsl-mc MSI: its@8080000 domain created
host1 # [    0.007644] EFI services will not be available.
host1 # [    0.007726] smp: Bringing up secondary CPUs ...
host1 # [    0.007737] smp: Brought up 1 node, 1 CPU
host1 # [    0.007741] SMP: Total of 1 processors activated.
host1 # [    0.007744] CPU: All CPU(s) started at EL1
host1 # [    0.007760] CPU features: detected: Branch Target Identification
host1 # [    0.007765] CPU features: detected: ARMv8.4 Translation Table Level
host1 # [    0.007768] CPU features: detected: Instruction cache invalidation not required for I/D coherence
host1 # [    0.007772] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
host1 # [    0.007779] CPU features: detected: Common not Private translations
host1 # [    0.007782] CPU features: detected: CRC32 instructions
host1 # [    0.007785] CPU features: detected: Data cache clean to Point of Deep Persistence
host1 # [    0.007789] CPU features: detected: Data cache clean to Point of Persistence
host1 # [    0.007792] CPU features: detected: Data independent timing control (DIT)
host1 # [    0.007795] CPU features: detected: E0PD
host1 # [    0.007797] CPU features: detected: Enhanced Counter Virtualization
host1 # [    0.007800] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
host1 # [    0.007803] CPU features: detected: Enhanced Virtualization Traps
host1 # [    0.007807] CPU features: detected: Fine Grained Traps
host1 # [    0.007811] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
host1 # [    0.007816] CPU features: detected: RCpc load-acquire (LDAPR)
host1 # [    0.007819] CPU features: detected: LSE atomic instructions
host1 # [    0.007822] CPU features: detected: Privileged Access Never
host1 # [    0.007824] CPU features: detected: PMUv3
host1 # [    0.007827] CPU features: detected: RAS Extension Support
host1 # [    0.007830] CPU features: detected: RASv1p1 Extension Support
host1 # [    0.007833] CPU features: detected: Random Number Generator
host1 # [    0.007838] CPU features: detected: Speculation barrier (SB)
host1 # [    0.007841] CPU features: detected: Stage-2 Force Write-Back
host1 # [    0.007843] CPU features: detected: TLB range maintenance instructions
host1 # [    0.007849] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
host1 # [    0.007887] alternatives: applying system-wide alternatives
host1 # [    0.011733] CPU features: detected: BBM Level 2 without TLB conflict abort
host1 # [    0.012331] Memory: 1915032K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 138768K reserved, 32768K cma-reserved)
host1 # [    0.013419] devtmpfs: initialized
host1 # [    0.016033] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
host1 # [    0.016057] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
host1 # [    0.016284] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
host1 # [    0.016290] 0 pages in range for non-PLT usage
host1 # [    0.016291] 506368 pages in range for PLT usage
host1 # [    0.016411] pinctrl core: initialized pinctrl subsystem
host1 # [    0.017290] DMI not present or invalid.
host1 # [    0.020564] NET: Registered PF_NETLINK/PF_ROUTE protocol family
host1 # [    0.022853] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
host1 # [    0.023049] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
host1 # [    0.023253] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
host1 # [    0.023279] audit: initializing netlink subsys (disabled)
host1 # [    0.023760] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
host1 # [    0.023904] thermal_sys: Registered thermal governor 'fair_share'
host1 # [    0.023906] thermal_sys: Registered thermal governor 'bang_bang'
host1 # [    0.023909] thermal_sys: Registered thermal governor 'step_wise'
host1 # [    0.023912] thermal_sys: Registered thermal governor 'user_space'
host1 # [    0.023915] thermal_sys: Registered thermal governor 'power_allocator'
host1 # [    0.023938] cpuidle: using governor ladder
host1 # [    0.023946] cpuidle: using governor menu
host1 # [    0.024129] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
host1 # [    0.024147] ASID allocator initialised with 65536 entries
host1 # [    0.025425] Serial: AMBA PL011 UART driver
host1 # [    0.031538] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
host1 # [    0.031596] printk: console [ttyAMA0] enabled
host1 # [    0.165870] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
host1 # [    0.165892] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
host1 # [    0.165899] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
host1 # [    0.165905] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
host1 # [    0.165913] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
host1 # [    0.165916] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
host1 # [    0.165919] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
host1 # [    0.165922] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
host1 # [    0.168562] fbcon: Taking over console
host1 # [    0.168587] ACPI: Interpreter disabled.
host1 # [    0.187200] iommu: Default domain type: Translated
host1 # [    0.187216] iommu: DMA domain TLB invalidation policy: strict mode
host1 # [    0.187624] SCSI subsystem initialized
host1 # [    0.187842] usbcore: registered new interface driver usbfs
host1 # [    0.187878] usbcore: registered new interface driver hub
host1 # [    0.187894] usbcore: registered new device driver usb
host1 # [    0.188186] pps_core: LinuxPPS API ver. 1 registered
host1 # [    0.188190] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
host1 # [    0.188198] PTP clock support registered
host1 # [    0.188248] EDAC MC: Ver: 3.0.0
host1 # [    0.188439] scmi_core: SCMI protocol bus registered
host1 # [    0.188798] FPGA manager framework
host1 # [    0.189402] vgaarb: loaded
host1 # [    0.197955] clocksource: Switched to clocksource arch_sys_counter
host1 # [    0.206044] VFS: Disk quotas dquot_6.6.0
host1 # [    0.206083] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
host1 # [    0.208661] netfs: FS-Cache loaded
host1 # [    0.208808] pnp: PnP ACPI: disabled
host1 # [    0.215468] NET: Registered PF_INET protocol family
host1 # [    0.215900] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
host1 # [    0.254824] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
host1 # [    0.254887] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
host1 # [    0.254922] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
host1 # [    0.255012] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
host1 # [    0.255155] TCP: Hash tables configured (established 16384 bind 16384)
host1 # [    0.255266] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
host1 # [    0.255306] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.255345] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.255444] NET: Registered PF_UNIX/PF_LOCAL protocol family
host1 # [    0.255469] NET: Registered PF_XDP protocol family
host1 # [    0.255486] PCI: CLS 0 bytes, default 64
host1 # [    0.255762] Trying to unpack rootfs image as initramfs...
host1 # [    0.278335] kvm [1]: HYP mode not available
host1 # [    0.412932] Initialise system trusted keyrings
host1 # [    0.413008] Key type blacklist registered
host1 # [    0.413219] workingset: timestamp_bits=42 max_order=19 bucket_order=0
host1 # [    0.413684] squashfs: version 4.0 (2009/01/31) Phillip Lougher
host1 # [    0.413777] 9p: Installing v9fs 9p2000 file system support
host1 # [    0.413879] integrity: Platform Keyring initialized
host1 # [    0.413889] integrity: Machine keyring initialized
host1 # [    0.446487] Key type asymmetric registered
host1 # [    0.446506] Asymmetric key parser 'x509' registered
host1 # [    0.446623] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
host1 # [    0.446816] io scheduler mq-deadline registered
host1 # [    0.446821] io scheduler kyber registered
host1 # [    0.460961] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
host1 # [    0.469999] ledtrig-cpu: registered to indicate activity on CPUs
host1 # [    0.471243] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
host1 # [    0.471271] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
host1 # [    0.471299] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
host1 # [    0.471306] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
host1 # [    0.471336] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
host1 # [    0.471364] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
host1 # [    0.471492] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
host1 # [    0.471501] pci_bus 0000:00: root bus resource [bus 00-ff]
host1 # [    0.471515] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
host1 # [    0.471529] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
host1 # [    0.471536] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
host1 # [    0.471628] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
host1 # [    0.472106] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.472293] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.472306] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.472331] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.472343] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.472806] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
host1 # [    0.472988] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.473000] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.473025] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.473496] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
host1 # [    0.473681] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
host1 # [    0.473692] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.473720] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.497949] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.498222] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.498239] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.498265] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.498279] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.498744] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
host1 # [    0.498928] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.498953] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.499419] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
host1 # [    0.499604] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.499629] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.500060] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
host1 # [    0.500239] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
host1 # [    0.500487] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.500671] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.500697] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.501172] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.501360] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.501386] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.501865] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.502073] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.502102] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.502586] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.502874] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
host1 # [    0.502889] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.502914] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.503374] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
host1 # [    0.503554] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.503565] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.503590] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.504054] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
host1 # [    0.504243] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.504268] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.504865] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
host1 # [    0.504871] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
host1 # [    0.504875] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
host1 # [    0.504918] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
host1 # [    0.504965] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
host1 # [    0.505008] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
host1 # [    0.505050] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
host1 # [    0.505093] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
host1 # [    0.505136] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
host1 # [    0.505179] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
host1 # [    0.505222] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
host1 # [    0.505265] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
host1 # [    0.505332] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
host1 # [    0.505375] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
host1 # [    0.505417] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
host1 # [    0.505435] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
host1 # [    0.505453] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
host1 # [    0.505471] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
host1 # [    0.505488] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
host1 # [    0.505505] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
host1 # [    0.505522] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
host1 # [    0.505540] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
host1 # [    0.505557] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
host1 # [    0.505575] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
host1 # [    0.505593] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
host1 # [    0.505611] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
host1 # [    0.505629] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
host1 # [    0.505646] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
host1 # [    0.505662] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
host1 # [    0.505679] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
host1 # [    0.505696] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
host1 # [    0.505712] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
host1 # [    0.505729] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
host1 # [    0.505753] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
host1 # [    0.505759] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
host1 # [    0.505762] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
host1 # [    0.590668] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    1.678272] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
host1 # [    0.703174] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    2.396548] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    2.399390] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    2.405299] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
host1 # [    0.716353] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    2.414428] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
server # [    2.417671] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    2.421807] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
host1 # [    0.727607] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    2.429010] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    2.431425] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    2.807491] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    2.812578] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
server # [    2.818662] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    2.821378] msm_serial: driver initialized
server # [    2.821531] SuperH (H)SCI(F) driver initialized
server # [    2.821589] STM32 USART driver initialized
server # [    2.840216] loop: module loaded
server # [    2.840501] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    2.841365] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    2.843641] megasas: 07.734.00.00-rc1
server # [    2.847218] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    2.851408] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    2.851428] Intel/Sharp Extended Query Table at 0x0031
host1 # [    0.738049] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
host1 # [    0.740494] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
host1 # [    1.489890] Freeing initrd memory: 25272K
host1 # [    1.494723] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
host1 # [    1.496634] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    3.726939] Using buffer write method
server # [    3.727002] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    3.730814] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    3.730838] Intel/Sharp Extended Query Table at 0x0031
server # [    3.774373] Using buffer write method
server # [    3.774400] Concatenating MTD devices:
server # [    3.774403] (0): "0.flash"
server # [    3.774406] (1): "0.flash"
server # [    3.774408] into device "0.flash"
server # [    3.783895] tun: Universal TUN/TAP device driver, 1.6
server # [    3.790243] thunder_xcv, ver 1.0
server # [    3.790277] thunder_bgx, ver 1.0
server # [    3.790301] nicpf, ver 1.0
server # [    3.790892] e1000: Intel(R) PRO/1000 Network Driver
server # [    3.790898] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    3.790922] e1000e: Intel(R) PRO/1000 Network Driver
server # [    3.790928] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    3.790963] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    3.790967] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    3.790989] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    3.790992] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    3.791131] sky2: driver version 1.30
server # [    3.800920] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    3.800943] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    3.801154] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    3.801650] usbcore: registered new interface driver usb-storage
server # [    3.801772] usbcore: registered new interface driver usbserial_generic
server # [    3.801782] usbserial: USB Serial support registered for generic
server # [    3.802434] hv_vmbus: registering driver hyperv_keyboard
server # [    3.803349] rtc-pl031 9010000.pl031: registered as rtc0
server # [    3.803371] rtc-pl031 9010000.pl031: setting system clock to 2026-11-06T08:43:56 UTC (1793954636)
server # [    3.803682] i2c_dev: i2c /dev entries driver
server # [    3.812553] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    3.812867] hub 1-0:1.0: USB hub found
server # [    3.812882] hub 1-0:1.0: 6 ports detected
server # [    3.815846] sdhci: Secure Digital Host Controller Interface driver
server # [    3.815851] sdhci: Copyright(c) Pierre Ossman
server # [    3.819238] Synopsys Designware Multimedia Card Interface Driver
server # [    3.819655] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    3.822946] hid: raw HID events driver (C) Jiri Kosina
server # [    3.823194] usbcore: registered new interface driver usbhid
server # [    3.823198] usbhid: USB HID core driver
server # [    3.826335] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    3.827924] drop_monitor: Initializing network drop monitor service
server # [    3.830161] NET: Registered PF_INET6 protocol family
server # [    3.830811] Segment Routing with IPv6
server # [    3.830823] In-situ OAM (IOAM) with IPv6
server # [    3.830851] NET: Registered PF_PACKET protocol family
server # [    3.830911] 9pnet: Installing 9P2000 support
server # [    3.830959] Key type dns_resolver registered
server # [    3.840467] registered taskstats version 1
server # [    3.840628] Loading compiled-in X.509 certificates
server # [    3.849914] Demotion targets for Node 0: null
server # [    3.850059] Key type .fscrypt registered
server # [    3.850065] Key type fscrypt-provisioning registered
server # [    3.850181] ima: No TPM chip found, activating TPM-bypass!
server # [    3.850204] ima: Allocated hash algorithm: sha1
server # [    3.850230] ima: No architecture policies found
server # [    3.851029] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    3.874490] clk: Disabling unused clocks
server # [    3.874509] PM: genpd: Disabling unused power domains
server # [    3.880887] Freeing unused kernel memory: 7808K
server # [    3.881105] Run /init as init process
server # [    3.898762] systemd[1]: Successfully made /usr/ read-only.
server # [    4.064064] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    4.214389] 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 # [    4.232771] 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 # [    4.232801] systemd[1]: Detected virtualization qemu.
server # [    4.232872] systemd[1]: Detected architecture arm64.
server # [    4.232882] systemd[1]: Running in initrd.
server # [    4.233525] systemd[1]: Initializing machine ID from random generator.
server # [    4.233712] systemd[1]: Hostname set to <server>.
server # [    4.300265] 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 # [    4.373959] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    4.420132] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    4.436973] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    4.443438] systemd[1]: Created slice Slice /system/modprobe.
server # [    4.443732] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    4.443775] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    4.443806] systemd[1]: Reached target Path Units.
server # [    4.443820] systemd[1]: Reached target Slice Units.
server # [    4.443836] systemd[1]: Reached target Swaps.
server # [    4.443851] systemd[1]: Reached target Timer Units.
server # [    4.444003] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    4.450350] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    4.450475] systemd[1]: Listening on Journal Sockets.
server # [    4.450553] systemd[1]: Listening on udev Kernel Socket.
server # [    4.450747] systemd[1]: Listening on udev Varlink Socket.
server # [    4.450767] systemd[1]: Reached target Socket Units.
server # [    4.456199] systemd[1]: Starting Create List of Static Device Nodes...
server # [    4.456277] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    4.464234] systemd[1]: Mounting Kernel Configuration File System...
server # [    4.475002] systemd[1]: Starting Journal Service...
server # [    4.485845] systemd[1]: Starting Load Kernel Modules...
server # [    4.485975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    4.520253] systemd[1]: Starting Coldplug All udev Devices...
server # [    4.523805] systemd-journald[70]: Collecting audit messages is disabled.
server # [    4.532340] systemd[1]: Finished Create List of Static Device Nodes.
server # [    4.542134] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    4.542728] systemd[1]: Mounted Kernel Configuration File System.
server # [    4.595397] 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 # [    4.595575] 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 # [    4.615679] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
server # [    4.621195] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    4.628224] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    4.634485] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    4.640134] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    4.654688] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    4.654940] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    4.654943] [drm] features: -context_init
server # [    4.655761] [drm] number of scanouts: 1
server # [    4.655774] [drm] number of cap sets: 0
server # [    4.688331] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    4.688349] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    4.712860] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    4.713082] systemd[1]: Reached target Preparation for Local File Systems.
server # [    4.713107] systemd[1]: Reached target Local File Systems.
server # [    4.721590] Console: switching to colour frame buffer device 160x50
server # [    4.728401] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    4.749460] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    4.751430] systemd[1]: Started Journal Service.
server # [    4.634299] systemd-modules-load[71]: Inserted module 'dm_mod'
server # [    4.643492] systemd-modules-load[71]: Module 'virtio_balloon' is built in
server # [    4.653592] systemd-modules-load[71]: Module 'virtio_console' is built in
server # [    4.666430] systemd[1]: Starting Create System Files and Directories...
server # [    4.667783] systemd-modules-load[71]: Inserted module 'virtio_gpu'
server # [    4.676988] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [    4.800241] NET: Registered PF_VSOCK protocol family
server # [    4.729781] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
server # [    4.734160] systemd[1]: Finished Load Kernel Modules.
server # [    4.749800] systemd-udevd[77]: Using default interface naming scheme 'v261'.
server # [    4.755444] systemd[1]: Starting Apply Kernel Variables...
host1 # [    1.500293] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
host1 # [    3.186584] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
host1 # [    3.189196] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    4.773281] systemd[1]: Finished Create System Files and Directories.
server # [    4.799208] systemd[1]: Finished Apply Kernel Variables.
server # [    4.813986] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    4.892841] systemd[1]: Starting Virtual Console Setup...
server # [    4.985314] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    4.989572] systemd[1]: Finished Virtual Console Setup.
server # [    5.686242] systemd[1]: Finished Coldplug All udev Devices.
server # [    5.687245] systemd[1]: Reached target System Initialization.
server # [    5.688440] systemd[1]: Reached target Basic System.
server # [    5.846536] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    5.864236] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.
server # [    5.887116] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.
server # [    5.987815] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    5.993706] systemd[1]: Reached target Initrd Root Device.
server # [    5.996641] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    6.047912] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    6.057980] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    6.060988] systemd[1]: Mounting /sysroot...
server # [    6.225966] EXT4-fs (vda): mounted filesystem fd3bafa2-c093-4635-918a-a521857783f0 r/w with ordered data mode. Quota mode: none.
server # [    6.112171] systemd[1]: Mounted /sysroot.
server # [    6.113786] systemd[1]: Reached target Initrd Root File System.
server # [    6.119637] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    6.152431] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    6.159013] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    6.165006] systemd[1]: Reloading...
server # [    6.381674] systemd[1]: Reloading finished in 219 ms.
server # [    6.415353] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...
server # [    6.419811] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...
server # [    6.433774] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    6.444513] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    6.464116] systemd[1]: Mounting /sysroot/run...
server # [    6.478972] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    6.520393] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    6.522480] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    6.559843] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    6.561266] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    6.562359] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    6.713052] fuse: init (API version 7.45)
server # [    6.727991] virtiofs virtio6: discovered new tag: nix-store
server # [    6.615008] systemd[1]: Mounted /sysroot/run.
server # [    6.736798] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
host1 # [    3.193977] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
host1 # [    5.058864] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
server # [    6.754804] virtiofs virtio7: discovered new tag: shared
server # [    6.755649] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
host1 # [    5.065792] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
host1 # [    5.069255] msm_serial: driver initialized
host1 # [    5.069420] SuperH (H)SCI(F) driver initialized
host1 # [    5.069482] STM32 USART driver initialized
server # [    6.772371] virtiofs virtio8: discovered new tag: xchg
server # [    6.773497] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    6.661459] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [    5.089264] loop: module loaded
host1 # [    5.089448] virtio_blk virtio2: 1/0/0 default/read/poll queues
host1 # [    5.092514] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
host1 # [    5.096185] megasas: 07.734.00.00-rc1
host1 # [    5.096910] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
host1 # [    5.101826] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    5.101856] Intel/Sharp Extended Query Table at 0x0031
host1 # [    5.107417] Using buffer write method
host1 # [    5.107464] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
host1 # [    5.112234] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    5.112258] Intel/Sharp Extended Query Table at 0x0031
host1 # [    5.113922] Using buffer write method
host1 # [    5.113950] Concatenating MTD devices:
host1 # [    5.113953] (0): "0.flash"
host1 # [    5.113956] (1): "0.flash"
host1 # [    5.113958] into device "0.flash"
host1 # [    5.124967] tun: Universal TUN/TAP device driver, 1.6
host1 # [    5.128984] thunder_xcv, ver 1.0
host1 # [    5.129018] thunder_bgx, ver 1.0
host1 # [    5.129040] nicpf, ver 1.0
host1 # [    5.129656] e1000: Intel(R) PRO/1000 Network Driver
host1 # [    5.129660] e1000: Copyright (c) 1999-2006 Intel Corporation.
host1 # [    5.129724] e1000e: Intel(R) PRO/1000 Network Driver
host1 # [    5.129730] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
host1 # [    5.129761] igb: Intel(R) Gigabit Ethernet Network Driver
host1 # [    5.129768] igb: Copyright (c) 2007-2014 Intel Corporation.
host1 # [    5.129791] igbvf: Intel(R) Gigabit Virtual Function Network Driver
host1 # [    5.129797] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
host1 # [    5.129942] sky2: driver version 1.30
host1 # [    5.139338] usbcore: registered new interface driver usb-storage
host1 # [    5.139407] usbcore: registered new interface driver usbserial_generic
host1 # [    5.139419] usbserial: USB Serial support registered for generic
server # [    6.718638] systemd[1]: Mounted /sysroot/tmp/xchg.
host1 # [    5.140046] hv_vmbus: registering driver hyperv_keyboard
host1 # [    5.141907] ehci-pci 0000:00:07.0: EHCI Host Controller
host1 # [    5.141934] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
host1 # [    5.142288] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    6.721623] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [    5.147951] rtc-pl031 9010000.pl031: registered as rtc0
host1 # [    5.147982] rtc-pl031 9010000.pl031: setting system clock to 2026-11-06T08:43:59 UTC (1793954639)
host1 # [    5.148417] i2c_dev: i2c /dev entries driver
server # [    6.726577] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    6.728722] systemd[1]: Mounted /sysroot/tmp/shared.
host1 # [    5.154703] sdhci: Secure Digital Host Controller Interface driver
host1 # [    5.154709] sdhci: Copyright(c) Pierre Ossman
host1 # [    5.154996] Synopsys Designware Multimedia Card Interface Driver
host1 # [    5.155408] sdhci-pltfm: SDHCI platform and OF driver helper
host1 # [    5.157352] hid: raw HID events driver (C) Jiri Kosina
host1 # [    5.157606] usbcore: registered new interface driver usbhid
host1 # [    5.157610] usbhid: USB HID core driver
host1 # [    5.158031] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
host1 # [    5.163971] hub 1-0:1.0: USB hub found
host1 # [    5.163991] hub 1-0:1.0: 6 ports detected
server # [    6.741108] systemd[1]: Mounted /sysroot/nix/.ro-store.
host1 # [    5.165292] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
host1 # [    5.169164] drop_monitor: Initializing network drop monitor service
host1 # [    5.169914] NET: Registered PF_INET6 protocol family
host1 # [    5.172093] Segment Routing with IPv6
host1 # [    5.172120] In-situ OAM (IOAM) with IPv6
host1 # [    5.172149] NET: Registered PF_PACKET protocol family
host1 # [    5.172209] 9pnet: Installing 9P2000 support
host1 # [    5.172261] Key type dns_resolver registered
host1 # [    5.182050] registered taskstats version 1
host1 # [    5.182252] Loading compiled-in X.509 certificates
host1 # [    5.192124] Demotion targets for Node 0: null
host1 # [    5.192248] Key type .fscrypt registered
host1 # [    5.192252] Key type fscrypt-provisioning registered
host1 # [    5.192368] ima: No TPM chip found, activating TPM-bypass!
host1 # [    5.192393] ima: Allocated hash algorithm: sha1
host1 # [    5.192421] ima: No architecture policies found
host1 # [    5.193609] input: gpio-keys as /devices/platform/gpio-keys/input/input0
host1 # [    5.216704] clk: Disabling unused clocks
host1 # [    5.216722] PM: genpd: Disabling unused power domains
host1 # [    5.223768] Freeing unused kernel memory: 7808K
host1 # [    5.224052] Run /init as init process
host1 # [    5.246044] systemd[1]: Successfully made /usr/ read-only.
host1 # [    5.410022] usb 1-1: new high-speed USB device number 2 using ehci-pci
host1 # [    5.561791] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
host1 # [    5.580519] 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 # [    5.580545] systemd[1]: Detected virtualization qemu.
host1 # [    5.580598] systemd[1]: Detected architecture arm64.
host1 # [    5.580607] systemd[1]: Running in initrd.
host1 # [    5.581177] systemd[1]: Initializing machine ID from random generator.
host1 # [    5.581348] systemd[1]: Hostname set to <host1>.
host1 # [    5.650218] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0
host1 # [    5.726664] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [    5.770209] usb 1-2: new high-speed USB device number 3 using ehci-pci
host1 # [    5.790063] systemd[1]: Queued start job for default target Initrd Default Target.
host1 # [    5.800906] systemd[1]: Created slice Slice /system/modprobe.
host1 # [    5.801103] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [    5.801132] systemd[1]: Expecting device /dev/disk/by-label/nixos...
host1 # [    5.801156] systemd[1]: Reached target Path Units.
host1 # [    5.801171] systemd[1]: Reached target Slice Units.
host1 # [    5.801184] systemd[1]: Reached target Swaps.
host1 # [    5.801198] systemd[1]: Reached target Timer Units.
host1 # [    5.801341] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [    5.801503] systemd[1]: Listening on Journal Socket (/dev/log).
host1 # [    5.801617] systemd[1]: Listening on Journal Sockets.
host1 # [    5.801696] systemd[1]: Listening on udev Kernel Socket.
host1 # [    5.801904] systemd[1]: Listening on udev Varlink Socket.
host1 # [    5.801923] systemd[1]: Reached target Socket Units.
host1 # [    5.813399] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [    5.813482] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [    5.819521] systemd[1]: Mounting Kernel Configuration File System...
host1 # [    5.838291] systemd[1]: Starting Journal Service...
server # [    7.419633] systemd[1]: Mounting /sysroot/nix/store...
host1 # [    5.846454] systemd[1]: Starting Load Kernel Modules...
host1 # [    5.846586] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    5.890327] systemd[1]: Starting Coldplug All udev Devices...
server # [    7.472148] systemd[1]: Mounted /sysroot/nix/store.
server # [    7.475289] systemd[1]: Reached target Initrd File Systems.
host1 # [    5.895327] systemd[1]: Finished Create List of Static Device Nodes.
server # [    7.476711] systemd[1]: Starting Find NixOS closure...
host1 # [    5.909151] dm_mod: module verification failed: signature and/or required key missing - tainting kernel
server # [    7.489672] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
host1 # [    5.918277] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    5.921473] systemd-journald[70]: Collecting audit messages is disabled.
host1 # [    5.929660] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
host1 # [    5.934952] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
host1 # [    5.936651] systemd[1]: Mounted Kernel Configuration File System.
host1 # [    5.941119] 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 # [    5.942151] 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 # [    5.951817] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
host1 # [    5.952060] [drm] features: -virgl +edid -resource_blob -host_visible
host1 # [    5.952063] [drm] features: -context_init
host1 # [    5.952807] [drm] number of scanouts: 1
host1 # [    5.952819] [drm] number of cap sets: 0
server # [    7.536372] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    7.544224] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
host1 # [    5.978487] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
host1 # [    5.978502] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    7.558761] systemd[1]: Finished Find NixOS closure.
server # [    7.562273] systemd[1]: Reached target Initrd Default Target.
server # [    7.568516] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
host1 # [    6.014783] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    7.603078] systemd[1]: Stopped target Initrd Default Target.
server # [    7.605324] systemd[1]: Stopped target Basic System.
server # [    7.608158] systemd[1]: Stopped target Initrd Root Device.
host1 # [    6.027086] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    7.610418] systemd[1]: Stopped target Path Units.
server # [    7.611708] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [    7.616757] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [    7.620861] systemd[1]: Stopped target Slice Units.
server # [    7.622244] systemd[1]: Stopped target Socket Units.
host1 # [    6.046159] Console: switching to colour frame buffer device 160x50
host1 # [    6.046886] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    7.625453] systemd[1]: Stopped target System Initialization.
server # [    7.628940] systemd[1]: Stopped target Swaps.
server # [    7.630818] systemd[1]: Stopped target Timer Units.
server # [    7.636601] systemd[1]: dbus.socket: Deactivated successfully.
server # [    7.638578] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [    7.641219] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [    7.645002] systemd[1]: Stopped Find NixOS closure.
server # [    7.646294] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [    6.072346] NET: Registered PF_VSOCK protocol family
server # [    7.656184] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [    7.658360] systemd[1]: Stopped Apply Kernel Variables.
server # [    7.659195] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [    7.663049] systemd[1]: Stopped Load Kernel Modules.
server # [    7.663890] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [    7.666861] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [    7.668058] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
host1 # [    6.093293] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [    6.093541] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [    6.093573] systemd[1]: Reached target Local File Systems.
server # [    7.670907] systemd[1]: Stopped Create System Files and Directories.
server # [    7.671897] systemd[1]: Stopped target Local File Systems.
server # [    7.680356] systemd[1]: Stopped target Preparation for Local File Systems.
server # [    7.684492] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
host1 # [    6.107648] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    7.688865] systemd[1]: Stopped Coldplug All udev Devices.
server # [    7.691795] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [    7.695690] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    7.698546] systemd[1]: Stopped Virtual Console Setup.
server # [    7.700642] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    7.702529] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    7.704982] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    7.706743] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [    6.134332] systemd[1]: Finished Load Kernel Modules.
host1 # [    6.136198] systemd[1]: Starting Apply Kernel Variables...
host1 # [    6.144346] systemd[1]: Started Journal Service.
server # [    7.720197] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [    7.723250] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [    7.724566] systemd[1]: systemd-udevd.service: Consumed 1.673s CPU time over 3.111s wall clock time, 23M memory peak.
host1 # [    6.019544] systemd-modules-load[71]: Inserted module 'dm_mod'
host1 # [    6.021092] systemd-modules-load[71]: Module 'virtio_balloon' is built in
host1 # [    6.022270] systemd-modules-load[71]: Module 'virtio_console' is built in
host1 # [    6.023379] systemd-modules-load[71]: Inserted module 'virtio_gpu'
server # [    7.733597] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
server # [    7.736155] systemd[1]: Closed udev Varlink Socket.
server # [    7.739175] systemd[1]: Starting Cleanup udev Database...
server # [    7.740245] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [    7.741529] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [    7.742471] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [    7.743634] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [    7.744848] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
host1 # [    6.036766] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [    7.745883] systemd[1]: Stopped Create List of Static Device Nodes.
host1 # [    6.037883] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
host1 # [    6.053498] systemd[1]: Starting Create System Files and Directories...
server # [    7.791855] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [    7.794165] systemd[1]: Finished Cleanup udev Database.
server # [    7.796612] systemd[1]: Reached target Switch Root.
host1 # [    6.090771] systemd-udevd[78]: Using default interface naming scheme 'v261'.
server # [    7.799450] systemd[1]: Starting NixOS Activation...
host1 # [    6.093156] systemd[1]: Finished Apply Kernel Variables.
host1 # [    6.116931] systemd[1]: Finished Create System Files and Directories.
host1 # [    6.135336] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    7.908602] initrd-nixos-activation-start[176]: booting system configuration /nix/store/4gba48l6nd42fbq8svyfqflik32b4zmi-nixos-system-server-test
server # [    7.948478] initrd-nixos-activation-start[176]: running activation script...
host1 # [    6.292139] systemd[1]: Starting Virtual Console Setup...
host1 # [    6.385276] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [    6.390024] systemd[1]: Finished Virtual Console Setup.
server # [    8.375374] initrd-nixos-activation-start[199]: setting up /etc...
server # [    8.514135] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [    8.517255] systemd[1]: Finished NixOS Activation.
server # [    8.518560] systemd[1]: Starting Switch Root...
server # [    8.541580] systemd[1]: Switching root.
server # [    8.834106] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
host1 # [    7.120100] systemd[1]: Finished Coldplug All udev Devices.
host1 # [    7.122807] systemd[1]: Reached target System Initialization.
host1 # [    7.124940] systemd[1]: Reached target Basic System.
host1 # [    7.272315] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [    7.323251] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    7.344208] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    7.464990] systemd[1]: Found device /dev/disk/by-label/nixos.
host1 # [    7.468470] systemd[1]: Reached target Initrd Root Device.
host1 # [    7.472548] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    9.345810] 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 # [    9.345873] systemd[1]: Detected virtualization qemu.
host1 # [    7.526423] systemd-fsck[115]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    9.345922] systemd[1]: Detected architecture arm64.
server # [    9.346041] systemd[1]: Detected first boot.
server # [    9.356893] systemd[1]: Initializing machine ID from random generator.
host1 # [    7.535992] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
host1 # [    7.539586] systemd[1]: Mounting /sysroot...
host1 # [    7.723495] EXT4-fs (vda): mounted filesystem 7d173ddc-8e35-42f8-83d4-0c3a3e5304b6 r/w with ordered data mode. Quota mode: none.
host1 # [    7.594786] systemd[1]: Mounted /sysroot.
host1 # [    7.597678] systemd[1]: Reached target Initrd Root File System.
host1 # [    7.608206] systemd[1]: Starting Mountpoints Configured in the Real Root...
host1 # [    7.640763] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.
host1 # [    7.652096] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...
host1 # [    7.657225] systemd[1]: Reloading...
server # [    9.507136] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [    7.899556] systemd[1]: Reloading finished in 244 ms.
host1 # [    7.931655] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...
host1 # [    7.939002] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...
host1 # [    7.946287] systemd[1]: Mounting /sysroot/nix/.ro-store...
host1 # [    7.967838] systemd[1]: Mounting /sysroot/nix/.rw-store...
host1 # [    7.979576] systemd[1]: Mounting /sysroot/run...
server # [    9.811621] systemd[1]: Applying preset policy.
host1 # [    8.005222] systemd[1]: Mounting /sysroot/tmp/shared...
host1 # [    8.026547] systemd[1]: Mounting /sysroot/tmp/xchg...
host1 # [    8.050979] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
host1 # [    8.227321] fuse: init (API version 7.45)
host1 # [    8.098285] systemd[1]: Finished Mountpoints Configured in the Real Root.
host1 # [    8.100936] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
host1 # [    8.105067] systemd[1]: Mounted /sysroot/nix/.rw-store.
host1 # [    8.244162] virtiofs virtio6: discovered new tag: nix-store
host1 # [    8.245573] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
host1 # [    8.287636] virtiofs virtio7: discovered new tag: shared
host1 # [    8.288473] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
host1 # [    8.166516] systemd[1]: Mounted /sysroot/run.
host1 # [    8.309474] virtiofs virtio8: discovered new tag: xchg
host1 # [    8.323309] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
host1 # [    8.197622] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [    8.223831] systemd[1]: Mounted /sysroot/nix/.ro-store.
host1 # [    8.238630] systemd[1]: Mounted /sysroot/tmp/shared.
host1 # [    8.257227] systemd[1]: Mounted /sysroot/tmp/xchg.
host1 # [    8.261303] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [    8.263495] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   10.232604] systemd[1]: Populated /etc with preset unit settings.
server # [   10.455959] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   10.457830] systemd[1]: Stopped initrd-switch-root.service.
server # [   10.462716] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   10.466167] systemd[1]: Created slice Slice /system/getty.
server # [   10.467701] systemd[1]: Created slice User and Session Slice.
server # [   10.470640] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   10.471150] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   10.471816] systemd[1]: Expecting device /dev/hvc0...
server # [   10.475749] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   10.477604] systemd[1]: Reached target Local Encrypted Volumes.
server # [   10.478010] systemd[1]: Stopped target initrd-fs.target.
server # [   10.478669] systemd[1]: Stopped target initrd-root-fs.target.
server # [   10.479301] systemd[1]: Stopped target initrd-switch-root.target.
server # [   10.479943] systemd[1]: Reached target Virtual Machines and Containers.
server # [   10.485064] systemd[1]: Reached target Path Units.
server # [   10.485477] systemd[1]: Reached target Remote File Systems.
server # [   10.486205] systemd[1]: Reached target Slice Units.
server # [   10.486878] systemd[1]: Reached target Swaps.
server # [   10.491596] systemd[1]: Listening on Query the User Interactively for a Password.
server # [   10.495377] systemd[1]: Listening on Process Core Dump Socket.
server # [   10.498567] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   10.499870] systemd[1]: Listening on Factory Reset Management.
server # [   10.502002] systemd[1]: Listening on Hostname Service Socket.
server # [   10.506186] systemd[1]: Starting Journal Log Access Socket...
server # [   10.507806] systemd[1]: Listening on Journal Audit Socket.
server # [   10.512163] systemd[1]: Listening on Console Output Muting Service Socket.
server # [   10.513520] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   10.513918] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [   10.514182] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   10.522837] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [   10.523481] systemd[1]: Listening on udev Varlink Socket.
server # [   10.529336] systemd[1]: Mounting Huge Pages File System...
server # [   10.534398] systemd[1]: Mounting POSIX Message Queue File System...
server # [   10.547830] systemd[1]: Mounting Kernel Debug File System...
server # [   10.563188] systemd[1]: Mounting Kernel Trace File System...
server # [   10.582120] systemd[1]: Starting Create List of Static Device Nodes...
server # [   10.582574] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   10.597206] systemd[1]: Mounting Kernel Configuration File System...
server # [   10.597603] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   10.597886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   10.598179] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   10.616232] systemd[1]: Mounting FUSE Control File System...
server # [   10.616809] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   10.644584] systemd[1]: Starting Journal Service...
server # [   10.671375] systemd[1]: Starting Load Kernel Modules...
server # [   10.689966] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   10.717976] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   10.718412] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   10.733913] systemd[1]: Starting Coldplug All udev Devices...
server # [   10.741481] systemd[1]: Listening on Journal Log Access Socket.
server # [   10.742194] systemd[1]: Mounted Huge Pages File System.
server # [   10.743549] systemd[1]: Mounted POSIX Message Queue File System.
server # [   10.748465] systemd[1]: Mounted Kernel Debug File System.
server # [   10.749083] systemd[1]: Mounted Kernel Trace File System.
server # [   10.750499] systemd[1]: Mounted Kernel Configuration File System.
server # [   10.751850] systemd[1]: Mounted FUSE Control File System.
host1 # [    8.937964] systemd[1]: Mounting /sysroot/nix/store...
server # [   10.808356] systemd[1]: Finished Create List of Static Device Nodes.
server # [   10.813790] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    8.998960] systemd[1]: Mounted /sysroot/nix/store.
host1 # [    8.999878] systemd[1]: Reached target Initrd File Systems.
host1 # [    9.002260] systemd[1]: Starting Find NixOS closure...
host1 # [    9.010182] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [   10.862391] systemd-journald[271]: Collecting audit messages is enabled.
server # [   10.877466] systemd[1]: Finished Load Kernel Modules.
server # [   10.883990] systemd[1]: Starting Firewall...
host1 # [    9.062548] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [   10.893009] EXT4-fs (vda): re-mounted fd3bafa2-c093-4635-918a-a521857783f0.
server # [   10.894582] systemd[1]: Starting Apply Kernel Variables...
host1 # [    9.071106] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
host1 # [    9.085882] systemd[1]: Finished Find NixOS closure.
host1 # [    9.090341] systemd[1]: Reached target Initrd Default Target.
server # [   10.915442] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   10.916382] systemd[1]: Listening on Disk Image Download Service Socket.
server # [   10.916774] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [    9.098230] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   10.933024] systemd[1]: Starting Load/Save OS Random Seed...
server # [   10.934034] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   10.951323] systemd[1]: Started Journal Service.
server # [   10.845692] systemd[1]: Queued start job for default target Multi-User System.
server # [   10.846962] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [    9.139190] systemd[1]: Stopped target Initrd Default Target.
host1 # [    9.143062] systemd[1]: Stopped target Basic System.
host1 # [    9.144313] systemd[1]: Stopped target Initrd Root Device.
host1 # [    9.150018] systemd[1]: Stopped target Path Units.
server # [   10.859791] systemd-modules-load[272]: Module 'atkbd' is built in
host1 # [    9.151992] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
host1 # [    9.154589] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
host1 # [    9.164409] systemd[1]: Stopped target Slice Units.
server # [   10.872597] systemd-modules-load[272]: Module 'loop' is built in
host1 # [    9.165299] systemd[1]: Stopped target Socket Units.
host1 # [    9.166074] systemd[1]: Stopped target System Initialization.
host1 # [    9.167775] systemd[1]: Stopped target Swaps.
host1 # [    9.168671] systemd[1]: Stopped target Timer Units.
host1 # [    9.170133] systemd[1]: dbus.socket: Deactivated successfully.
host1 # [    9.172312] systemd[1]: Closed D-Bus System Message Bus Socket.
host1 # [    9.174327] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
host1 # [    9.177167] systemd[1]: Stopped Find NixOS closure.
host1 # [    9.179892] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   10.891010] systemd[1]: Starting Flush Journal to Persistent Storage...
host1 # [    9.183363] systemd[1]: systemd-sysctl.service: Deactivated successfully.
host1 # [    9.186051] systemd[1]: Stopped Apply Kernel Variables.
host1 # [    9.186881] systemd[1]: systemd-modules-load.service: Deactivated successfully.
host1 # [    9.187966] systemd[1]: Stopped Load Kernel Modules.
host1 # [    9.195449] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
host1 # [    9.201183] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
host1 # [    9.202513] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
host1 # [    9.212230] systemd[1]: Stopped Create System Files and Directories.
host1 # [    9.214717] systemd[1]: Stopped target Local File Systems.
host1 # [    9.220482] systemd[1]: Stopped target Preparation for Local File Systems.
host1 # [    9.221571] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
host1 # [    9.222563] systemd[1]: Stopped Coldplug All udev Devices.
host1 # [    9.223519] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [    9.225861] systemd[1]: Stopped Virtual Console Setup.
host1 # [    9.228252] systemd[1]: initrd-cleanup.service: Deactivated successfully.
host1 # [    9.230086] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
host1 # [    9.232306] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [    9.234630] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [    9.247318] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   10.957007] systemd-oomd[273]: No swap; memory pressure usage will be degraded
host1 # [    9.250867] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
host1 # [    9.251981] systemd[1]: systemd-udevd.service: Consumed 1.784s CPU time over 3.274s wall clock time, 53.2M memory peak.
host1 # [    9.256550] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.
host1 # [    9.257671] systemd[1]: Closed udev Varlink Socket.
host1 # [    9.260442] systemd[1]: Starting Cleanup udev Database...
host1 # [    9.261327] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
host1 # [    9.263792] systemd[1]: Stopped Create Static Device Nodes in /dev.
host1 # [    9.265201] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   10.974164] systemd[1]: Finished Load/Save OS Random Seed.
host1 # [    9.266385] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
host1 # [    9.267402] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
host1 # [    9.268573] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   10.982561] systemd[1]: Reached target First Boot Complete.
server # [   10.984898] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   11.129307] systemd-journald[271]: Received client request to flush runtime journal.
host1 # [    9.315922] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
host1 # [    9.318223] systemd[1]: Finished Cleanup udev Database.
host1 # [    9.320483] systemd[1]: Reached target Switch Root.
host1 # [    9.323130] systemd[1]: Starting NixOS Activation...
server # [   11.071150] systemd[1]: Finished Apply Kernel Variables.
server # [   11.084647] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   11.088104] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   11.095926] systemd[1]: Finished Flush Journal to Persistent Storage.
host1 # [    9.435601] initrd-nixos-activation-start[177]: booting system configuration /nix/store/yawy7f20wczfgs8wmfnadz0ivq1m9mdk-nixos-system-host1-test
host1 # [    9.472683] initrd-nixos-activation-start[177]: running activation script...
server # [   11.211779] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   11.220470] systemd[1]: Reached target Preparation for Local File Systems.
server # [   11.224326] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   11.342028] systemd[1]: Mounting /run/wrappers...
server # [   11.362974] systemd-udevd[313]: Using default interface naming scheme 'v261'.
server # [   11.413138] systemd[1]: Mounted /run/wrappers.
server # [   11.414065] systemd[1]: Reached target Local File Systems.
server # [   11.422694] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   11.423821] systemd[1]: Starting register-nix-paths.service...
server # [   11.446444] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   11.455788] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   11.463262] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   11.472498] systemd[1]: Starting Create System Files and Directories...
host1 # [    9.884815] initrd-nixos-activation-start[200]: setting up /etc...
server # [   11.633120] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   11.718849] systemd[1]: Finished Create System Files and Directories.
server # [   11.730695] systemd[1]: Starting Rebuild Journal Catalog...
host1 # [   10.030557] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
host1 # [   10.033741] systemd[1]: Finished NixOS Activation.
host1 # [   10.035048] systemd[1]: Starting Switch Root...
server # [   11.744478] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
host1 # [   10.061663] systemd[1]: Switching root.
host1 # [   10.364490] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
server # [   12.003539] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   12.052579] systemd[1]: Starting Virtual Console Setup...
server # [   12.082386] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   12.088530] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   12.124548] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   12.133090] systemd[1]: Stopped Virtual Console Setup.
server # [   12.140922] systemd[1]: Starting Virtual Console Setup...
server # [   12.152384] systemd[1]: Finished Rebuild Journal Catalog.
server # [   12.159253] systemd[1]: Starting Update is Completed...
server # [   12.500060] systemd[1]: Finished Update is Completed.
host1 # [   10.933821] 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 # [   10.933885] systemd[1]: Detected virtualization qemu.
host1 # [   10.933950] systemd[1]: Detected architecture arm64.
host1 # [   10.943226] systemd[1]: Detected first boot.
host1 # [   10.955866] systemd[1]: Initializing machine ID from random generator.
host1 # [   11.083634] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [   11.444841] systemd[1]: Applying preset policy.
server # [   13.070438] systemd-vconsole-setup[399]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   13.085091] systemd[1]: Finished Virtual Console Setup.
server # [   13.178433] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   11.707964] systemd[1]: Populated /etc with preset unit settings.
server # [   13.289857] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   13.298504] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   13.302820] systemd[1]: Finished Create SUID/SGID Wrappers.
host1 # [   11.935674] systemd[1]: initrd-switch-root.service: Deactivated successfully.
host1 # [   11.936478] systemd[1]: Stopped initrd-switch-root.service.
host1 # [   11.940712] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
host1 # [   11.943870] systemd[1]: Created slice Slice /system/getty.
host1 # [   11.945204] systemd[1]: Created slice User and Session Slice.
host1 # [   11.945764] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [   11.949435] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
host1 # [   11.949873] systemd[1]: Expecting device /dev/hvc0...
host1 # [   11.952613] systemd[1]: Expecting device /dev/ttyAMA0...
host1 # [   11.953009] systemd[1]: Reached target Local Encrypted Volumes.
host1 # [   11.953607] systemd[1]: Stopped target initrd-fs.target.
host1 # [   11.956859] systemd[1]: Stopped target initrd-root-fs.target.
host1 # [   11.957237] systemd[1]: Stopped target initrd-switch-root.target.
host1 # [   11.957866] systemd[1]: Reached target Virtual Machines and Containers.
host1 # [   11.961393] systemd[1]: Reached target Path Units.
host1 # [   11.961792] systemd[1]: Reached target Remote File Systems.
host1 # [   11.964479] systemd[1]: Reached target Slice Units.
host1 # [   11.964876] systemd[1]: Reached target Swaps.
host1 # [   11.969627] systemd[1]: Listening on Query the User Interactively for a Password.
host1 # [   11.973306] systemd[1]: Listening on Process Core Dump Socket.
host1 # [   11.975898] systemd[1]: Listening on Credential Encryption/Decryption.
host1 # [   11.977186] systemd[1]: Listening on Factory Reset Management.
host1 # [   11.977683] systemd[1]: Listening on Hostname Service Socket.
host1 # [   11.983497] systemd[1]: Starting Journal Log Access Socket...
host1 # [   11.985155] systemd[1]: Listening on Journal Audit Socket.
host1 # [   11.988931] systemd[1]: Listening on Console Output Muting Service Socket.
host1 # [   11.989655] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
host1 # [   11.993032] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   11.995713] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
host1 # [   12.001217] systemd[1]: Listening on Disk Repartitioning Service Socket.
host1 # [   12.001814] systemd[1]: Listening on udev Varlink Socket.
host1 # [   12.006857] systemd[1]: Mounting Huge Pages File System...
host1 # [   12.011196] systemd[1]: Mounting POSIX Message Queue File System...
host1 # [   12.030865] systemd[1]: Mounting Kernel Debug File System...
host1 # [   12.043720] systemd[1]: Mounting Kernel Trace File System...
host1 # [   12.057202] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [   12.061293] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   12.082815] systemd[1]: Mounting Kernel Configuration File System...
host1 # [   12.083605] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
host1 # [   12.091557] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
host1 # [   12.092143] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   13.685624] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
host1 # [   12.117709] systemd[1]: Mounting FUSE Control File System...
host1 # [   12.123957] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   13.724878] systemd[1]: Finished Firewall.
host1 # [   12.168470] systemd[1]: Starting Journal Service...
host1 # [   12.192582] systemd[1]: Starting Load Kernel Modules...
server # [   13.769512] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
host1 # [   12.216272] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
host1 # [   12.246006] systemd[1]: Starting Remount Root and Kernel File Systems...
host1 # [   12.246566] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   12.271205] systemd[1]: Starting Coldplug All udev Devices...
host1 # [   12.278410] systemd-journald[272]: Collecting audit messages is enabled.
host1 # [   12.304881] systemd[1]: Listening on Journal Log Access Socket.
host1 # [   12.305418] systemd[1]: Mounted Huge Pages File System.
host1 # [   12.305846] systemd[1]: Mounted POSIX Message Queue File System.
host1 # [   12.179813] systemd[1]: Queued start job for default target Multi-User System.
host1 # [   12.184519] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [   12.321221] systemd[1]: Started Journal Service.
host1 # [   12.203265] systemd-modules-load[273]: Module 'atkbd' is built in
host1 # [   12.206162] systemd-modules-load[273]: Module 'loop' is built in
host1 # [   12.216441] systemd[1]: Mounted Kernel Debug File System.
host1 # [   12.217439] systemd[1]: Mounted Kernel Trace File System.
host1 # [   12.218265] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [   12.238381] systemd[1]: Finished Load Kernel Modules.
host1 # [   12.239443] systemd[1]: Mounted Kernel Configuration File System.
host1 # [   12.270663] systemd[1]: Starting Firewall...
host1 # [   12.410326] EXT4-fs (vda): re-mounted 7d173ddc-8e35-42f8-83d4-0c3a3e5304b6.
host1 # [   12.283051] systemd[1]: Starting Apply Kernel Variables...
host1 # [   12.285421] systemd-oomd[275]: No swap; memory pressure usage will be degraded
host1 # [   12.294776] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [   12.297652] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
host1 # [   12.304483] systemd[1]: Mounted FUSE Control File System.
host1 # [   12.329242] systemd[1]: Finished Remount Root and Kernel File Systems.
host1 # [   12.344735] systemd[1]: Listening on Disk Image Download Service Socket.
host1 # [   12.364859] systemd[1]: Starting Flush Journal to Persistent Storage...
host1 # [   12.369369] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [   12.383743] systemd[1]: Starting Load/Save OS Random Seed...
server # [   14.090928] (udev-worker)[352]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   12.389219] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   14.106958] (udev-worker)[351]: Network interface NamePolicy= disabled on kernel command line.
server # [   14.134019] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line.
server # [   14.168000] systemd[1]: Finished register-nix-paths.service.
server # [   14.172847] systemd[1]: Reached target System Initialization.
server # [   14.174919] systemd[1]: Started Renew ACME Certificate for server.
server # [   14.178520] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   14.182451] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   14.183486] systemd[1]: Reached target Timer Units.
server # [   14.187477] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   14.190301] systemd[1]: Listening on Nix Daemon Socket.
server # [   14.191143] systemd[1]: Listening on Nix worker-protocol over gRPC.
server # [   14.195647] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
server # [   14.208242] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
server # [   14.213980] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   14.220195] systemd[1]: Starting D-Bus System Message Bus...
server # [   14.266870] systemd-ssh-issue[508]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
server # [   14.275503] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
server # [   14.279964] systemd[1]: Reached target Socket Units.
host1 # [   12.712862] systemd-journald[272]: Received client request to flush runtime journal.
server # [   14.321707] dbus-broker-launch[509]: Looking up NSS user entry for 'systemd-timesync'...
server # [   14.327183] dbus-broker-launch[509]: NSS returned no entry for 'systemd-timesync'
server # [   14.332123] dbus-broker-launch[509]: Invalid user-name in /nix/store/m54sg3phgklxvq3dkpwk18q981d0mraq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   14.344274] systemd[1]: Started D-Bus System Message Bus.
server # [   14.345231] systemd[1]: Reached target Basic System.
server # [   14.351791] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
server # [   14.371410] systemd[1]: Started backdoor.service.
server # [   14.375768] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   14.407024] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   14.414501] systemd[1]: Starting Post-Boot Actions...
host1 # [   12.695247] systemd[1]: Finished Load/Save OS Random Seed.
host1 # [   12.709423] systemd[1]: Reached target First Boot Complete.
host1 # [   12.710372] systemd[1]: Finished Apply Kernel Variables.
host1 # [   12.711194] systemd[1]: Finished Flush Journal to Persistent Storage.
host1 # [   12.730879] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   14.441487] systemd[1]: Started Reset console on configuration changes.
host1 # [   12.737621] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   14.454166] systemd[1]: Starting resolvconf update...
server # [   14.460254] systemd[1]: Starting SSH Host Keys Generation...
server # [   14.472063] systemd[1]: Starting step-ca-pki.service...
server # [   14.569010] dbus-broker-launch[509]: Ready
host1 # [   12.890577] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [   12.902574] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [   12.905071] systemd[1]: Mounting /run/wrappers...
host1 # [   12.916411] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   14.639675] systemd[1]: Finished Post-Boot Actions.
host1 # [   13.025048] systemd[1]: Mounted /run/wrappers.
host1 # [   13.025934] systemd[1]: Reached target Local File Systems.
host1 # [   13.032341] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   14.744402] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   14.749016] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   13.042695] systemd[1]: Starting register-nix-paths.service...
server # [   14.760613] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   13.052773] systemd[1]: Starting Create SUID/SGID Wrappers...
host1 # [   13.053846] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   14.773321] acme-setup-privileged[512]: + set -euo pipefail
host1 # [   13.071277] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   14.781160] acme-setup-privileged[512]: + cd /var/lib/acme
server # [   14.791099] acme-setup-privileged[512]: + chmod -R u=rwX,g=,o= .lego/accounts
host1 # [   13.085004] systemd[1]: Starting Create System Files and Directories...
server # [   14.800753] systemd[1]: Starting User Login Management...
server # [   14.807409] acme-setup-privileged[512]: + chown -R acme .lego/accounts
server # [   14.815790] nsncd[516]: Nov 06 08:44:07.618 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   13.127622] systemd-udevd[315]: Using default interface naming scheme 'v261'.
server # [   14.842059] acme-setup-privileged[512]: + for fixpath in server .lego/server
server # [   14.857008] acme-setup-privileged[512]: + '[' -d server ']'
server # [   14.865250] acme-setup-privileged[512]: + for fixpath in server .lego/server
server # [   14.873558] acme-setup-privileged[512]: + '[' -d .lego/server ']'
server # [   14.885488] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # connecting to host...
server # [   14.910163] systemd[1]: Condition check resulted in Virtio network device being skipped.
host1 # [   13.251974] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
host1 # [   13.266334] systemd[1]: Finished Save Transient machine-id to Disk.
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 13.75 seconds)
server: (finished: waiting for the VM to finish booting, in 13.75 seconds)
host1 # [   13.365269] systemd[1]: Started Rule-based Manager for Device Events and Files.
host1 # [   13.381197] systemd[1]: Finished Create System Files and Directories.
host1 # [   13.421210] systemd[1]: Starting Rebuild Journal Catalog...
host1 # [   13.430614] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   15.183945] systemd-logind[539]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [   15.194279] systemd-logind[539]: New seat seat0.
server # [   15.211606] systemd[1]: Started User Login Management.
server # [   15.220417] systemd[1]: Starting linger-users.service...
server # [   15.317860] acme-setup-start[562]: + set -euo pipefail
server # [   15.325450] acme-setup-start[562]: + test -e ca/key.pem
server # [   15.336134] acme-setup-start[562]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
host1 # [   13.648915] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   15.405779] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   15.406903] systemd[1]: Stopping Host and Network Name Lookups...
server # [   15.407771] systemd[1]: Stopped target User and Group Name Lookups.
host1 # [   13.704788] systemd[1]: Finished Rebuild Journal Catalog.
host1 # [   13.715453] systemd[1]: Starting Update is Completed...
server # [   15.424905] systemd[1]: Stopping User and Group Name Lookups...
server # [   15.434822] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   15.435846] systemd[1]: nscd.service: Deactivated successfully.
server # [   15.472438] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   15.480156] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   15.481301] systemd[1]: linger-users.service: Deactivated successfully.
server # [   15.482263] systemd[1]: Finished linger-users.service.
host1 # [   13.853319] systemd[1]: Finished Update is Completed.
server # [   15.566913] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
server # [   15.576597] systemd[1]: Starting Ensure certificate for server...
server # [   15.651649] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   15.663615] systemd[1]: Reached target Host and Network Name Lookups.
server # [   15.673502] nsncd[642]: Nov 06 08:44:08.471 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   15.675612] systemd[1]: Reached target User and Group Name Lookups.
server # [   15.756444] systemd[1]: Finished resolvconf update.
server # [   15.760730] systemd[1]: Reached target Preparation for Network.
server # [   15.781283] systemd[1]: Starting DHCP Client...
server # [   15.794324] systemd[1]: Starting Address configuration of eth1...
server # [   15.815301] sshd-keygen-start[564]: Generating public/private rsa key pair.
server # [   15.825076] sshd-keygen-start[564]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
server # [   15.826375] sshd-keygen-start[564]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
server # [   15.827590] sshd-keygen-start[564]: The key fingerprint is:
server # [   15.848988] sshd-keygen-start[564]: SHA256:RJeSsB7IQHblaA2qmWArIumHcCJkrfEGvI/sVqy85io root@server
server # [   15.850306] sshd-keygen-start[564]: The key's randomart image is:
server # [   15.851149] sshd-keygen-start[564]: +---[RSA 4096]----+
server # [   15.851884] sshd-keygen-start[564]: | .+ o.o.....     |
server # [   15.879770] sshd-keygen-start[564]: |...= * oo..      |
server # [   15.891235] sshd-keygen-start[564]: |.B..= = ..       |
host1 # [   14.189439] systemd[1]: Starting Virtual Console Setup...
server # [   15.898569] sshd-keygen-start[564]: |==B. . o         |
server # [   15.899442] sshd-keygen-start[564]: |%+oo  . S        |
server # [   15.916191] sshd-keygen-start[564]: |Oo=o             |
server # [   15.917090] sshd-keygen-start[564]: |.=oo             |
server # [   15.917884] sshd-keygen-start[564]: |E=.              |
server # [   15.918627] sshd-keygen-start[564]: |B+.              |
server # [   15.919358] sshd-keygen-start[564]: +----[SHA256]-----+
server # [   15.949455] systemd[1]: Starting Extra networking commands....
server # [   15.950788] acme-server-start[654]: Waiting to acquire lock in /run/acme/
server # [   15.969006] step-ca-pki-start[537]: Your certificate has been saved in root_ca.crt.
server # [   15.970238] step-ca-pki-start[537]: Your private key has been saved in root_ca.key.
server # [   15.993007] acme-server-start[654]: + '[' -e out/acme-success ']'
server # [   15.994066] acme-server-start[654]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=
host1 # [   14.287332] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   14.298300] systemd[1]: Stopped Virtual Console Setup.
host1 # [   14.340416] systemd[1]: Starting Virtual Console Setup...
server # [   16.103567] sshd-keygen-start[688]: Generating public/private ed25519 key pair.
server # [   16.117460] sshd-keygen-start[688]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
server # [   16.118832] sshd-keygen-start[688]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
server # [   16.138157] sshd-keygen-start[688]: The key fingerprint is:
server # [   16.139056] sshd-keygen-start[688]: SHA256:jEsJBDViNecMndiC9dn4Pj0bqVhRmuiHfrynAygIF9M root@server
server # [   16.154547] sshd-keygen-start[688]: The key's randomart image is:
server # [   16.155511] sshd-keygen-start[688]: +--[ED25519 256]--+
server # [   16.166210] sshd-keygen-start[688]: |  +BO+..         |
server # [   16.167036] sshd-keygen-start[688]: | .+oEO++         |
server # [   16.167765] sshd-keygen-start[688]: |   o..* . .      |
server # [   16.186348] sshd-keygen-start[688]: |. .  . * +       |
server # [   16.187179] sshd-keygen-start[688]: |.o   .= S        |
server # [   16.187919] sshd-keygen-start[688]: |. . .o.+ o .     |
server # [   16.204398] sshd-keygen-start[688]: |   .  +o= =      |
server # [   16.205252] sshd-keygen-start[688]: |     . ++o.+     |
server # [   16.205997] sshd-keygen-start[688]: |      o.+=.      |
server # [   16.206769] sshd-keygen-start[688]: +----[SHA256]-----+
server # [   16.230533] acme-server-start[705]: + cd server
server # [   16.231347] acme-server-start[705]: + cp -vp cert.pem ../out/cert.pem
server # [   16.243949] network-addresses-eth1-start[675]: adding address 192.168.1.2/24... done
server # [   16.260437] network-addresses-eth1-start[675]: adding address 2001:db8:1::2/64... done
server # [   16.262010] systemd[1]: sshd-keygen.service: Deactivated successfully.
server # [   16.263122] acme-server-start[706]: 'cert.pem' -> '../out/cert.pem'
server # [   16.390871] mousedev: PS/2 mouse device common for all mice
server # [   16.283225] systemd[1]: Finished SSH Host Keys Generation.
server # [   16.292229] acme-server-start[705]: + cp -vp key.pem ../out/key.pem
server # [   16.293216] acme-server-start[705]: 'key.pem' -> '../out/key.pem'
server # [   16.294182] systemd[1]: Finished Address configuration of eth1.
server # [   16.295047] acme-server-start[654]: + cat out/cert.pem ca/cert.pem
server # [   16.295850] acme-server-start[654]: + cp ca/cert.pem out/chain.pem
server # [   16.323325] acme-server-start[654]: + cat out/key.pem out/fullchain.pem
server # [   16.331384] acme-server-start[654]: + for fixpath in out certificates
server # [   16.336649] acme-server-start[654]: + '[' -d out ']'
server # [   16.337431] acme-server-start[654]: + chmod -R u=rwX,g=rX,o= out
server # [   16.338291] acme-server-start[654]: + chown -R acme:nix-grpc-daemon out
server # [   16.339346] step-ca-pki-start[685]: Your certificate has been saved in intermediate_ca.crt.
server # [   16.367411] step-ca-pki-start[685]: Your private key has been saved in intermediate_ca.key.
server # [   16.375406] systemd[1]: Finished step-ca-pki.service.
server # [   16.383057] acme-server-start[654]: + for fixpath in out certificates
server # [   16.385599] acme-server-start[654]: + '[' -d certificates ']'
server # [   16.390927] systemd[1]: Finished Ensure certificate for server.
host1 # [   14.749307] systemd[1]: Finished Coldplug All udev Devices.
server # [   16.464483] dhcpcd[700]: dhcpcd-10.3.2 starting
server # [   16.475077] dhcpcd[762]: dev: loaded udev
server # [   16.638837] 8021q: 802.1Q VLAN Support v1.8
server # [   16.639334] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   16.548662] systemd[1]: Finished Extra networking commands..
server # [   16.549701] systemd[1]: Reached target Network.
server # [   16.559458] systemd[1]: Starting SSH Daemon...
server # [   16.576716] systemd[1]: Starting Permit User Sessions...
host1 # [   14.887114] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
host1 # [   14.892394] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   16.774197] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   14.950611] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   16.778947] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   16.779495] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   16.784997] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   16.785379] cfg80211: failed to load regulatory.db
server # [   16.733378] systemd[1]: Finished Permit User Sessions.
server # [   16.741340] systemd[1]: Started Getty on tty1.
server # [   16.742237] systemd[1]: Reached target Login Prompts.
server # [   16.796602] sshd[771]: Server listening on 0.0.0.0 port 22.
server # [   16.797584] sshd[771]: Server listening on :: port 22.
server # [   16.811982] systemd[1]: Started SSH Daemon.
server # [   16.817760] systemd-logind[539]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   16.964529] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   16.850133] dhcpcd[762]: eth0: waiting for carrier
server # [   16.850945] dhcpcd[762]: eth0: carrier acquired
server # [   16.874123] dhcpcd[762]: DUID 00:01:00:01:32:80:4f:d9:52:54:00:12:34:56
server # [   16.875202] dhcpcd[762]: eth0: IAID 00:12:34:56
server # [   16.875936] dhcpcd[762]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   15.256123] systemd-vconsole-setup[428]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   15.271842] systemd[1]: Finished Virtual Console Setup.
host1 # [   15.338311] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
host1 # [   15.416246] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
host1 # [   15.702044] (udev-worker)[371]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   15.705892] (udev-worker)[365]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [   15.724883] (udev-worker)[365]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   15.874881] systemd[1]: Finished Firewall.
server # [   17.841579] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [   16.059319] systemd[1]: Condition check resulted in Virtio network device being skipped.
host1 # [   16.064504] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
host1 # [   16.071176] systemd[1]: Starting Create SUID/SGID Wrappers...
host1 # [   16.076534] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
host1 # [   16.077888] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
host1 # [   16.086670] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [   16.091089] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   16.094393] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [   16.097353] systemd[1]: Finished register-nix-paths.service.
host1 # [   16.279004] mousedev: PS/2 mouse device common for all mice
server # [   18.203296] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   18.208271] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   18.209450] systemd[1]: Stopped Virtual Console Setup.
server # [   18.210244] systemd[1]: Stopping Virtual Console Setup...
server # [   18.221219] systemd[1]: Starting Virtual Console Setup...
server # [   18.248621] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   18.251130] systemd[1]: Stopped Virtual Console Setup.
server # [   18.259089] systemd[1]: Starting Virtual Console Setup...
server # [   18.329617] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   18.400255] systemd-vconsole-setup[824]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   18.406190] systemd[1]: Finished Virtual Console Setup.
host1 # [   16.757184] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
host1 # [   16.760699] systemd[1]: Finished Create SUID/SGID Wrappers.
host1 # [   16.763511] systemd[1]: Reached target System Initialization.
host1 # [   16.766925] systemd[1]: Started Renew ACME Certificate for host1.
host1 # [   16.767949] systemd[1]: Started Discard unused filesystem blocks once a week.
host1 # [   16.773023] systemd[1]: Started Daily Cleanup of Temporary Directories.
host1 # [   16.774114] systemd[1]: Reached target Timer Units.
host1 # [   16.774881] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   16.775898] systemd[1]: Listening on Nix Daemon Socket.
host1 # [   16.782358] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
host1 # [   16.792264] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
host1 # [   16.795998] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
host1 # [   16.817603] systemd[1]: Starting D-Bus System Message Bus...
host1 # [   16.882972] systemd-ssh-issue[582]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
host1 # [   16.894018] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
host1 # [   16.895367] systemd[1]: Reached target Socket Units.
server # [   18.651808] dhcpcd[762]: eth0: soliciting a DHCP lease
server # [   18.661008] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   18.664295] dhcpcd[762]: eth0: probing address 10.0.2.15/24
host1 # [   16.977523] dbus-broker-launch[583]: Looking up NSS user entry for 'systemd-timesync'...
host1 # [   16.985801] dbus-broker-launch[583]: NSS returned no entry for 'systemd-timesync'
host1 # [   16.987022] dbus-broker-launch[583]: Invalid user-name in /nix/store/460n1wr7qz44n4vw52s35shazwxijrnn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
host1 # [   17.059486] systemd[1]: Started D-Bus System Message Bus.
host1 # [   17.061360] systemd[1]: Reached target Basic System.
host1 # [   17.067470] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
host1 # [   17.074684] systemd[1]: Started backdoor.service.
host1 # [   17.081569] systemd[1]: Starting Import lastlog data into lastlog2 database...
host1 # [   17.119138] dbus-broker-launch[583]: Ready
host1 # [   17.129440] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   17.161267] systemd[1]: Starting Post-Boot Actions...
host1 # [   17.195370] systemd[1]: Started Reset console on configuration changes.
host1 # [   17.248647] systemd[1]: Starting resolvconf update...
host1 # [   17.282649] systemd[1]: Starting SSH Host Keys Generation...
host1 # connecting to host...
host1 # [   17.321119] acme-setup-privileged[586]: + set -euo pipefail
host1 # [   17.322030] acme-setup-privileged[586]: + cd /var/lib/acme
host1 # [   17.322812] acme-setup-privileged[586]: + chmod -R u=rwX,g=,o= .lego/accounts
host1 # [   17.350440] acme-setup-privileged[586]: + chown -R acme .lego/accounts
host1 # [   17.392994] acme-setup-privileged[586]: + for fixpath in host1 .lego/host1
host1 # [   17.394074] acme-setup-privileged[586]: + '[' -d host1 ']'
host1 # [   17.394831] acme-setup-privileged[586]: + for fixpath in host1 .lego/host1
host1 # [   17.395751] acme-setup-privileged[586]: + '[' -d .lego/host1 ']'
host1 # [   17.416390] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   17.418247] nsncd[589]: Nov 06 08:44:11.891 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   17.440739] systemd[1]: Finished Post-Boot Actions.
host1 # [   17.506326] systemd[1]: Finished Import lastlog data into lastlog2 database.
host1 # [   17.513904] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   17.515018] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   17.540352] systemd[1]: Starting User Login Management...
server # [   19.297790] dhcpcd[762]: eth0: soliciting an IPv6 router
server # [   19.300060] dhcpcd[762]: eth0: Router Advertisement from fe80::2
server # [   19.302107] dhcpcd[762]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   19.303624] dhcpcd[762]: eth0: adding route to fec0::/64
server # [   19.304920] dhcpcd[762]: eth0: adding default route via fe80::2
host1 # [   17.787655] acme-setup-start[618]: + set -euo pipefail
host1 # [   17.797654] acme-setup-start[618]: + test -e ca/key.pem
host1 # [   17.798488] acme-setup-start[618]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
host1 # [   17.809435] systemd-logind[628]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
host1 # [   17.824447] systemd-logind[628]: Watching system buttons on /dev/input/event0 (gpio-keys)
host1 # [   17.834618] systemd-logind[628]: New seat seat0.
host1 # [   17.835698] systemd[1]: Started User Login Management.
host1 # [   17.847506] systemd[1]: Starting linger-users.service...
host1 # [   17.890243] systemd[1]: Stopped target Host and Network Name Lookups.
host1 # [   17.891368] systemd[1]: Stopping Host and Network Name Lookups...
host1 # [   17.900554] systemd[1]: Stopped target User and Group Name Lookups.
host1 # [   17.901589] systemd[1]: Stopping User and Group Name Lookups...
host1 # [   17.902433] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
host1 # [   17.915790] systemd[1]: nscd.service: Deactivated successfully.
host1 # [   17.920737] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
host1 # [   17.943331] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
host1 # [   17.969098] systemd[1]: Starting Ensure certificate for host1...
host1 # [   17.990634] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   18.055038] systemd[1]: linger-users.service: Deactivated successfully.
host1 # [   18.062845] systemd[1]: Finished linger-users.service.
host1 # [   18.162736] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   18.163794] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   18.175731] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   18.179811] nsncd[687]: Nov 06 08:44:12.646 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   18.215024] acme-host1-start[685]: Waiting to acquire lock in /run/acme/
host1 # [   18.252274] systemd[1]: Finished resolvconf update.
host1 # [   18.256676] acme-host1-start[685]: + '[' -e out/acme-success ']'
host1 # [   18.257655] acme-host1-start[685]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=
host1 # [   18.269678] systemd[1]: Reached target Preparation for Network.
host1 # [   18.276781] systemd[1]: Starting DHCP Client...
host1 # [   18.294085] systemd[1]: Starting Address configuration of eth1...
host1 # [   18.319164] systemd[1]: Starting Extra networking commands....
host1 # [   18.323197] acme-host1-start[723]: + cd host1
host1 # [   18.323944] acme-host1-start[723]: + cp -vp cert.pem ../out/cert.pem
host1 # [   18.357499] acme-host1-start[724]: 'cert.pem' -> '../out/cert.pem'
host1 # [   18.369473] acme-host1-start[723]: + cp -vp key.pem ../out/key.pem
host1 # [   18.385829] acme-host1-start[723]: 'key.pem' -> '../out/key.pem'
host1 # [   18.402459] acme-host1-start[685]: + cat out/cert.pem ca/cert.pem
host1 # [   18.440253] acme-host1-start[685]: + cp ca/cert.pem out/chain.pem
host1 # [   18.470370] acme-host1-start[685]: + cat out/key.pem out/fullchain.pem
host1 # [   18.489714] acme-host1-start[685]: + for fixpath in out certificates
host1 # [   18.490737] acme-host1-start[685]: + '[' -d out ']'
host1 # [   18.491431] acme-host1-start[685]: + chmod -R u=rwX,g=rX,o= out
host1 # [   18.509291] acme-host1-start[685]: + chown -R acme:acme out
host1 # [   18.564631] acme-host1-start[685]: + for fixpath in out certificates
host1 # [   18.565666] acme-host1-start[685]: + '[' -d certificates ']'
host1 # [   18.586475] systemd[1]: Finished Ensure certificate for host1.
host1 # [   18.595968] network-addresses-eth1-start[721]: adding address 192.168.1.1/24... done
host1 # [   18.630060] network-addresses-eth1-start[721]: adding address 2001:db8:1::1/64... done
host1 # [   18.702214] systemd[1]: Finished Address configuration of eth1.
host1 # [   18.813154] dhcpcd[735]: dhcpcd-10.3.2 starting
host1 # [   18.828487] dhcpcd[786]: dev: loaded udev
host1 # [   19.052996] 8021q: 802.1Q VLAN Support v1.8
host1 # [   19.053483] 8021q: adding VLAN 0 to HW filter on device eth1
host1 # [   18.939732] systemd[1]: Finished Extra networking commands..
host1 # [   18.942342] systemd[1]: Reached target Network.
host1 # [   18.953820] sshd-keygen-start[644]: Generating public/private rsa key pair.
host1 # [   18.954929] sshd-keygen-start[644]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
host1 # [   18.964970] sshd-keygen-start[644]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
host1 # [   18.966262] sshd-keygen-start[644]: The key fingerprint is:
host1 # [   18.967031] sshd-keygen-start[644]: SHA256:dcAf/nTGLvvWgdLVpzMGTKYJQp7TYy+MOWsb0rrLG5g root@host1
host1 # [   18.978806] sshd-keygen-start[644]: The key's randomart image is:
host1 # [   18.979779] sshd-keygen-start[644]: +---[RSA 4096]----+
host1 # [   18.988009] sshd-keygen-start[644]: |     ..  ..      |
host1 # [   18.988996] sshd-keygen-start[644]: |     ..o. ..+    |
host1 # [   18.989721] sshd-keygen-start[644]: |      +.+..O.. ..|
host1 # [   18.990443] sshd-keygen-start[644]: |       * +o.= ..*|
host1 # [   18.991163] sshd-keygen-start[644]: |      + S . .+o=.|
host1 # [   18.991891] sshd-keygen-start[644]: |   o . o . . oB..|
host1 # [   19.009747] sshd-keygen-start[644]: |  E o =     .. =o|
host1 # [   19.010578] sshd-keygen-start[644]: |   . = o      . o|
host1 # [   19.011298] sshd-keygen-start[644]: |    *+.        o.|
host1 # [   19.016380] sshd-keygen-start[644]: +----[SHA256]-----+
host1 # [   19.017285] systemd[1]: Starting Permit User Sessions...
host1 # [   19.248434] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   19.118437] systemd[1]: Finished Permit User Sessions.
host1 # [   19.258503] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
host1 # [   19.259027] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
host1 # [   19.130980] systemd[1]: Started Getty on tty1.
host1 # [   19.266308] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
host1 # [   19.266665] cfg80211: failed to load regulatory.db
host1 # [   19.140641] systemd[1]: Reached target Login Prompts.
host1 # [   19.163663] sshd-keygen-start[807]: Generating public/private ed25519 key pair.
host1 # [   19.170147] sshd-keygen-start[807]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
host1 # [   19.171481] sshd-keygen-start[807]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
host1 # [   19.178292] sshd-keygen-start[807]: The key fingerprint is:
host1 # [   19.179134] sshd-keygen-start[807]: SHA256:FAhX4wDgMCHuAWH/BrQzEqp2nu1+4Cl/j/hi/j9gt1Y root@host1
host1 # [   19.185146] sshd-keygen-start[807]: The key's randomart image is:
host1 # [   19.186097] sshd-keygen-start[807]: +--[ED25519 256]--+
host1 # [   19.186827] sshd-keygen-start[807]: |B=.ooooo+        |
host1 # [   19.187598] sshd-keygen-start[807]: |*++ ...o o       |
host1 # [   19.200634] sshd-keygen-start[807]: |.+.*    o        |
host1 # [   19.201456] sshd-keygen-start[807]: |o o =  .         |
host1 # [   19.202199] sshd-keygen-start[807]: |.o . o  S        |
host1 # [   19.202924] sshd-keygen-start[807]: |. o +. o . E     |
host1 # [   19.203650] sshd-keygen-start[807]: |   o..+ o o      |
host1 # [   19.212532] sshd-keygen-start[807]: |   ..=.o.+       |
host1 # [   19.213382] sshd-keygen-start[807]: |    ***++o.      |
host1 # [   19.214131] sshd-keygen-start[807]: +----[SHA256]-----+
host1 # [   19.215069] systemd[1]: sshd-keygen.service: Deactivated successfully.
host1 # [   19.215999] systemd[1]: Finished SSH Host Keys Generation.
host1 # [   19.226048] systemd[1]: Starting SSH Daemon...
host1 # [   19.305240] dhcpcd[786]: eth0: waiting for carrier
host1 # [   19.306732] dhcpcd[786]: eth0: carrier acquired
host1 # [   19.438266] 8021q: adding VLAN 0 to HW filter on device eth0
host1 # [   19.314487] sshd[811]: Server listening on 0.0.0.0 port 22.
host1 # [   19.315396] sshd[811]: Server listening on :: port 22.
host1 # [   19.320233] systemd[1]: Started SSH Daemon.
host1 # [   19.330347] dhcpcd[786]: DUID 00:01:00:01:32:80:4f:dd:52:54:00:12:34:56
host1 # [   19.331393] dhcpcd[786]: eth0: IAID 00:12:34:56
host1 # [   19.332334] dhcpcd[786]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   19.358556] dhcpcd[786]: eth0: soliciting a DHCP lease
host1 # [   19.365795] dhcpcd[786]: eth0: offered 10.0.2.15 from 10.0.2.2
host1 # [   19.372422] dhcpcd[786]: eth0: probing address 10.0.2.15/24
host1 # [   19.541567] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [   19.817758] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
host1 # [   19.820652] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   19.826320] systemd[1]: Stopped Virtual Console Setup.
host1 # [   19.827184] systemd[1]: Stopping Virtual Console Setup...
host1 # [   19.830509] systemd[1]: Starting Virtual Console Setup...
host1 # [   19.861528] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   19.866946] systemd[1]: Stopped Virtual Console Setup.
host1 # [   19.877621] systemd[1]: Starting Virtual Console Setup...
host1 # [   19.903216] systemd-logind[628]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
host1 # [   19.980355] systemd-vconsole-setup[839]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   19.985311] systemd[1]: Finished Virtual Console Setup.
server # [   22.680613] dhcpcd[762]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   22.682862] dhcpcd[762]: eth0: adding route to 10.0.2.0/24
server # [   22.685833] dhcpcd[762]: eth0: adding default route via 10.0.2.2
server # [   22.797167] systemd[1]: Started DHCP Client.
server # [   22.800496] systemd[1]: Reached target Network is Online.
server # [   22.805599] systemd[1]: Starting step-ca service...
host1 # [   21.576314] dhcpcd[786]: eth0: soliciting an IPv6 router
host1 # [   21.578360] dhcpcd[786]: eth0: Router Advertisement from fe80::2
host1 # [   21.579743] dhcpcd[786]: eth0: adding address fec0::5054:ff:fe12:3456/64
host1 # [   21.581548] dhcpcd[786]: eth0: adding route to fec0::/64
host1 # [   21.583225] dhcpcd[786]: eth0: adding default route via fe80::2
server # [   23.316526] step-ca[923]: badger 2026/11/06 08:44:16 INFO: All 0 tables opened in 0s
server # [   23.352219] step-ca[923]: 2026/11/06 08:44:16 Building new tls configuration using step-ca x509 Signer Interface
server # [   23.376927] step-ca[923]: 2026/11/06 08:44:16 Starting Smallstep CA/0.30.2 (linux/arm64)
server # [   23.386712] step-ca[923]: 2026/11/06 08:44:16 Documentation: https://u.step.sm/docs/ca
server # [   23.389027] step-ca[923]: 2026/11/06 08:44:16 Community Discord: https://u.step.sm/discord
server # [   23.396367] step-ca[923]: 2026/11/06 08:44:16 Config file: /etc/smallstep/ca.json
server # [   23.397490] step-ca[923]: 2026/11/06 08:44:16 The primary server URL is https://server:8443
server # [   23.398621] step-ca[923]: 2026/11/06 08:44:16 Root certificates are available at https://server:8443/roots.pem
server # [   23.399955] step-ca[923]: 2026/11/06 08:44:16 X.509 Root Fingerprint: a0fe798715039f3e6df05617a64f9b6b9ff27323d32a8ad9bb812967a7a75891
server # [   23.412616] systemd[1]: Started step-ca service.
server # [   23.413461] step-ca[923]: 2026/11/06 08:44:16 Serving HTTPS on 0.0.0.0:8443 ...
server # [   23.414502] systemd[1]: Reached target Multi-User System.
server # [   23.415351] systemd[1]: Starting Order (and renew) ACME certificate for server...
server: (finished: waiting for unit step-ca.service, in 22.16 seconds)
server: waiting for unit nix-grpc-daemon.socket
server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.07 seconds)
server: waiting for TCP port 50051 on localhost
server # [   23.514184] acme-order-renew-server-start[935]: Waiting to acquire lock in /run/acme/
server # [   23.530864] acme-order-renew-server-start[935]: + set -euo pipefail
server # [   23.531969] acme-order-renew-server-start[935]: + exec
server # [   23.536877] acme-order-renew-server-start[935]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
server # [   23.538795] acme-order-renew-server-start[951]: ++ find accounts -path '*/keys/*.key' -print -quit
server # [   23.551072] acme-order-renew-server-start[935]: + '[' -n '' ']'
server # [   23.553642] acme-order-renew-server-start[935]: + exec
server # [   23.554451] acme-order-renew-server-start[935]: + '[' -e certificates/server.key ']'
server # [   23.555516] acme-order-renew-server-start[935]: + 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
server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!
server: (finished: waiting for TCP port 50051 on localhost, in 0.10 seconds)

running 4 tests
server # [   23.838450] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.653622680Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
server # [   23.854969] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.671364020Z INFO  Registering the account. email=root@example.org
server # [   23.880335] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.696892460Z WARN  !!!! HEADS UP !!!!
server # [   23.881789] acme-order-renew-server-start[952]: Your account credentials have been saved in your
server # [   23.882979] acme-order-renew-server-start[952]: configuration directory at "accounts".
server # [   23.886390] acme-order-renew-server-start[952]: You should make a secure backup of this folder now. This
server # [   23.887859] acme-order-renew-server-start[952]: configuration directory will also contain private keys
server # [   23.889215] acme-order-renew-server-start[952]: generated by lego and certificates obtained from the ACME
server # [   23.890470] acme-order-renew-server-start[952]: server. Making regular backups of this folder is ideal.
server # [   23.891754] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.701405440Z INFO  Obtaining bundled SAN certificate. domains=server
server # [   23.967892] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.783540260Z INFO  Use solver. domain=server type=http-01
server # [   23.970162] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.783640040Z INFO  http01: Trying to solve HTTP-01. domain=server
server # [   24.000364] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.815657460Z INFO  The server validated our request. domain=server
server # [   24.003107] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.815807960Z INFO  Validations succeeded; requesting certificates. domains=server
server # [   24.032106] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.848226920Z INFO  Server responded with a certificate. domains=server
server # [   24.034979] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.848370020Z INFO  Writing file. filepath=certificates/server.crt
server # [   24.043934] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.848607180Z INFO  Writing file. filepath=certificates/server.issuer.crt
server # [   24.050900] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.854314220Z INFO  Writing file. filepath=certificates/server.key
server # [   24.055270] acme-order-renew-server-start[952]: 2026-11-06T08:44:16.854721640Z INFO  Writing file. filepath=certificates/server.json
server # [   24.057738] acme-order-renew-server-start[935]: + touch out/acme-success
server # [   24.061078] acme-order-renew-server-start[935]: + cmp -s certificates/server.crt out/fullchain.pem
server # [   24.063766] acme-order-renew-server-start[935]: + touch out/renewed
server # [   24.068797] acme-order-renew-server-start[935]: + echo Installing new certificate
server # [   24.070058] acme-order-renew-server-start[935]: Installing new certificate
server # [   24.071151] acme-order-renew-server-start[935]: + cp -vp certificates/server.crt out/fullchain.pem
server # [   24.076728] acme-order-renew-server-start[961]: 'certificates/server.crt' -> 'out/fullchain.pem'
server # [   24.078749] acme-order-renew-server-start[935]: + cp -vp certificates/server.key out/key.pem
server # [   24.084926] acme-order-renew-server-start[962]: 'certificates/server.key' -> 'out/key.pem'
server # [   24.086263] acme-order-renew-server-start[935]: + cp -vp certificates/server.issuer.crt out/chain.pem
server # [   24.091138] acme-order-renew-server-start[963]: 'certificates/server.issuer.crt' -> 'out/chain.pem'
server # [   24.093266] acme-order-renew-server-start[935]: + ln -sf fullchain.pem out/cert.pem
server # [   24.098089] acme-order-renew-server-start[935]: + cat out/key.pem out/fullchain.pem
server # [   24.103056] acme-order-renew-server-start[935]: + for fixpath in out certificates
server # [   24.104788] acme-order-renew-server-start[935]: + '[' -d out ']'
server # [   24.105683] acme-order-renew-server-start[935]: + chmod -R u=rwX,g=rX,o= out
server # [   24.110405] acme-order-renew-server-start[935]: + chown -R acme:nix-grpc-daemon out
server # [   24.117309] acme-order-renew-server-start[935]: + for fixpath in out certificates
server # [   24.118456] acme-order-renew-server-start[935]: + '[' -d certificates ']'
server # [   24.119421] acme-order-renew-server-start[935]: + chmod -R u=rwX,g=rX,o= certificates
server # [   24.124111] acme-order-renew-server-start[935]: + chown -R acme:nix-grpc-daemon certificates
server # [   24.130451] acme-order-renew-server-start[935]: + chmod -R u=rwX,g=,o= accounts/.
server # [   24.186140] systemd[1]: acme-order-renew-server.service: Deactivated successfully.
server # [   24.189580] systemd[1]: Finished Order (and renew) ACME certificate for server.
server # [   24.190804] systemd[1]: acme-order-renew-server.service: Consumed 300ms CPU time over 796ms wall clock time, 55.2M memory peak, 4K written to disk, 10.2K incoming IP traffic, 8.1K outgoing IP traffic.
server # [   24.202189] systemd[1]: Starting Nix worker-protocol over gRPC...
server # [   24.353225] nix-grpc-daemon[981]: ts=2026-11-06T08:44:17Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1
server # [   24.377582] nix-grpc-daemon[981]: ts=2026-11-06T08:44:17Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket
server # [   24.379429] nix-grpc-daemon[981]: ts=2026-11-06T08:44:17Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0
server # [   24.384417] systemd[1]: Started Nix worker-protocol over gRPC.
server # [   24.385822] nix-grpc-daemon[981]: ts=2026-11-06T08:44:17Z level=info event=unhealthy reason=min_free
server # [   24.387081] systemd[1]: Startup finished in 3.767s (kernel) + 5.029s (initrd) + 15.584s (userspace) = 24.381s.
host1 # [   23.905064] dhcpcd[786]: eth0: leased 10.0.2.15 for 86400 seconds
host1 # [   23.907201] dhcpcd[786]: eth0: adding route to 10.0.2.0/24
host1 # [   23.909243] dhcpcd[786]: eth0: adding default route via 10.0.2.2
host1 # [   24.021495] systemd[1]: Started DHCP Client.
host1 # [   24.024634] systemd[1]: Reached target Network is Online.
host1 # [   24.029384] systemd[1]: Starting fetch-ca-root.service...
host1 # [   24.110157] systemd[1]: Finished fetch-ca-root.service.
host1 # [   24.115426] systemd[1]: Reached target Multi-User System.
host1 # [   24.118471] systemd[1]: Starting Order (and renew) ACME certificate for host1...
host1 # [   24.168531] systemd[1]: Created slice Slice /system/sshd-vsock.
host1 # [   24.169552] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   24.181109] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
host1 # [   24.211234] acme-order-renew-host1-start[908]: Waiting to acquire lock in /run/acme/
host1 # [   24.228224] acme-order-renew-host1-start[908]: + set -euo pipefail
host1 # [   24.229240] acme-order-renew-host1-start[908]: + exec
host1 # [   24.229975] acme-order-renew-host1-start[908]: + /nix/store/gd2i0pr7i4hhzizkkaiv5phff9xybz68-flock-0.4.0/bin/flock 11
host1 # [   24.240945] acme-order-renew-host1-start[917]: ++ find accounts -path '*/keys/*.key' -print -quit
host1 # [   24.262465] acme-order-renew-host1-start[908]: + '[' -n '' ']'
host1 # [   24.263952] acme-order-renew-host1-start[908]: + exec
host1 # [   24.265191] acme-order-renew-host1-start[908]: + '[' -e certificates/host1.key ']'
host1 # [   24.266368] acme-order-renew-host1-start[908]: + 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 # [   24.388291] sshd-session[913]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   24.407015] sshd-session[913]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.435853] sshd-session[913]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.488715] systemd[1]: Created slice Slice /user/0.
host1 # [   24.496208] systemd[1]: Starting User Runtime Directory /run/user/0...
host1 # [   24.532964] systemd-logind[628]: New session '1' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.579644] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   24.586648] systemd[1]: Starting User Manager for UID 0...
host1 # [   24.647327] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.131825880Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
host1 # [   24.663084] (systemd)[931]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.670946] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.156130640Z INFO  Registering the account. email=root@example.org
host1 # [   24.674953] systemd-logind[628]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   24.694536] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.179410540Z WARN  !!!! HEADS UP !!!!
host1 # [   24.695997] acme-order-renew-host1-start[919]: Your account credentials have been saved in your
host1 # [   24.697412] acme-order-renew-host1-start[919]: configuration directory at "accounts".
host1 # [   24.698506] acme-order-renew-host1-start[919]: You should make a secure backup of this folder now. This
host1 # [   24.699777] acme-order-renew-host1-start[919]: configuration directory will also contain private keys
host1 # [   24.701373] acme-order-renew-host1-start[919]: generated by lego and certificates obtained from the ACME
host1 # [   24.702658] acme-order-renew-host1-start[919]: server. Making regular backups of this folder is ideal.
host1 # [   24.703901] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.179613020Z INFO  Obtaining bundled SAN certificate. domains=host1
host1 # [   24.776878] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.262578700Z INFO  Use solver. domain=host1 type=http-01
host1 # [   24.778800] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.264737200Z INFO  http01: Trying to solve HTTP-01. domain=host1
host1 # [   24.797269] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.282327400Z INFO  The server validated our request. domain=host1
host1 # [   24.798981] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.282444980Z INFO  Validations succeeded; requesting certificates. domains=host1
host1 # [   24.813302] systemd[931]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   24.826851] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.311127700Z INFO  Server responded with a certificate. domains=host1
host1 # [   24.832504] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.311255200Z INFO  Writing file. filepath=certificates/host1.crt
host1 # [   24.834114] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.311443540Z INFO  Writing file. filepath=certificates/host1.issuer.crt
host1 # [   24.835732] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.311526040Z INFO  Writing file. filepath=certificates/host1.key
host1 # [   24.838533] acme-order-renew-host1-start[919]: 2026-11-06T08:44:19.311719300Z INFO  Writing file. filepath=certificates/host1.json
host1 # [   24.841187] acme-order-renew-host1-start[908]: + touch out/acme-success
host1 # [   24.855835] acme-order-renew-host1-start[908]: + cmp -s certificates/host1.crt out/fullchain.pem
host1 # [   24.883006] acme-order-renew-host1-start[908]: + touch out/renewed
host1 # [   24.889729] acme-order-renew-host1-start[908]: + echo Installing new certificate
host1 # [   24.890845] acme-order-renew-host1-start[908]: Installing new certificate
host1 # [   24.891779] acme-order-renew-host1-start[908]: + cp -vp certificates/host1.crt out/fullchain.pem
host1 # [   24.900951] acme-order-renew-host1-start[941]: 'certificates/host1.crt' -> 'out/fullchain.pem'
host1 # [   24.903158] acme-order-renew-host1-start[908]: + cp -vp certificates/host1.key out/key.pem
host1 # [   24.910636] acme-order-renew-host1-start[942]: 'certificates/host1.key' -> 'out/key.pem'
host1 # [   24.912938] acme-order-renew-host1-start[908]: + cp -vp certificates/host1.issuer.crt out/chain.pem
host1 # [   24.918464] acme-order-renew-host1-start[943]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'
host1 # [   24.920901] acme-order-renew-host1-start[908]: + ln -sf fullchain.pem out/cert.pem
host1 # [   24.929034] acme-order-renew-host1-start[908]: + cat out/key.pem out/fullchain.pem
host1 # [   24.940665] acme-order-renew-host1-start[908]: + for fixpath in out certificates
host1 # [   24.941837] acme-order-renew-host1-start[908]: + '[' -d out ']'
host1 # [   24.942663] acme-order-renew-host1-start[908]: + chmod -R u=rwX,g=rX,o= out
host1 # [   24.952727] acme-order-renew-host1-start[908]: + chown -R acme:acme out
host1 # [   24.966905] acme-order-renew-host1-start[908]: + for fixpath in out certificates
host1 # [   24.970058] acme-order-renew-host1-start[908]: + '[' -d certificates ']'
host1 # [   24.971023] acme-order-renew-host1-start[908]: + chmod -R u=rwX,g=rX,o= certificates
host1 # [   24.979309] acme-order-renew-host1-start[908]: + chown -R acme:acme certificates
host1 # [   24.989373] acme-order-renew-host1-start[908]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   25.074346] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.
host1 # [   25.078613] systemd[1]: Finished Order (and renew) ACME certificate for host1.
host1 # [   25.079722] systemd[1]: acme-order-renew-host1.service: Consumed 286ms CPU time over 958ms wall clock time, 56.8M memory peak, 4K written to disk, 10.3K incoming IP traffic, 8.3K outgoing IP traffic.
host1 # [   25.100189] systemd[931]: Queued start job for default target Main User Target.
host1 # [   25.109095] systemd[931]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   25.113688] systemd[931]: Created slice User Application Slice.
host1 # [   25.114673] systemd[931]: Started Daily Cleanup of User's Temporary Directories.
host1 # [   25.115897] systemd[931]: Reached target Paths.
host1 # [   25.121207] systemd[931]: Reached target Timers.
host1 # [   25.121958] systemd[931]: Starting D-Bus User Message Bus Socket...
host1 # [   25.122839] systemd[931]: Starting Create User Files and Directories...
host1 # [   25.175837] systemd[931]: Listening on D-Bus User Message Bus Socket.
host1 # [   25.177699] systemd[931]: Reached target Sockets.
host1 # [   25.185055] systemd[931]: Finished Create User Files and Directories.
host1 # [   25.189989] systemd[931]: Reached target Basic System.
host1 # [   25.190873] systemd[931]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
host1 # [   25.192484] systemd[931]: Reached target Main User Target.
host1 # [   25.193326] systemd[931]: Startup finished in 475ms.
host1 # [   25.194065] systemd[1]: Started User Manager for UID 0.
host1 # [   25.197095] systemd[1]: Started Session 1 of User root.
host1 # [   25.201212] systemd[1]: Startup finished in 5.095s (kernel) + 5.239s (initrd) + 14.865s (userspace) = 25.200s.
host1 # [   25.217025] sshd-session[967]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   25.219419] sshd-session[967]: Disconnected from user root UNKNOWN port 65535
host1 # [   25.221343] sshd-session[913]: pam_unix(sshd:session): session closed for user root
host1 # [   25.225353] systemd[1]: sshd-vsock@0-1-3:22-2:0.service: Deactivated successfully.
host1 # [   25.229872] systemd[1]: session-1.scope: Deactivated successfully.
host1 # [   25.234344] systemd-logind[628]: Session 1 logged out. Waiting for processes to exit.
host1 # [   25.236416] systemd-logind[628]: Removed session 1.
server # [   27.683149] systemd[1]: Created slice Slice /system/sshd-vsock.
server # [   27.685704] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   25.979250] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   27.693328] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
host1 # [   25.986382] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
host1 # [   26.000708] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
host1 # [   26.012856] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
server # [   27.828771] sshd-session[995]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   27.837831] sshd-session[995]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   27.847067] sshd-session[995]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   27.868544] systemd-logind[539]: New session '1' of user 'root' with class 'user' and type 'tty'.
server # [   27.876378] systemd[1]: Created slice Slice /user/0.
server # [   27.879407] systemd[1]: Starting User Runtime Directory /run/user/0...
server # [   27.920551] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   26.212721] sshd-session[975]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   27.927474] systemd[1]: Starting User Manager for UID 0...
host1 # [   26.220920] sshd-session[973]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   26.232454] sshd-session[975]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   26.237339] sshd-session[973]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   26.238901] sshd-session[974]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   27.955582] (systemd)[1003]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.252774] sshd-session[974]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   27.962009] systemd-logind[539]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   26.257634] sshd-session[975]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.263618] sshd-session[973]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.275618] systemd-logind[628]: New session '3' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.281919] sshd-session[974]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   26.283554] systemd[1]: Started Session 3 of User root.
host1 # [   26.290588] systemd-logind[628]: New session '4' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.300441] systemd[1]: Started Session 4 of User root.
host1 # [   26.305982] systemd-logind[628]: New session '5' of user 'root' with class 'user' and type 'tty'.
host1 # [   26.310621] systemd[1]: Started Session 5 of User root.
server # [   28.058816] systemd[1003]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   26.466476] sshd-session[992]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.468771] sshd-session[992]: Disconnected from user root UNKNOWN port 65535
server # [   28.176885] systemd[1003]: Queued start job for default target Main User Target.
host1 # [   26.473569] sshd-session[973]: pam_unix(sshd:session): session closed for user root
host1 # [   26.477159] sshd-session[991]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   28.185394] systemd[1003]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   26.478574] sshd-session[991]: Disconnected from user root UNKNOWN port 65535
server # [   28.189850] systemd[1003]: Created slice User Application Slice.
server # [   28.190869] systemd[1003]: Started Daily Cleanup of User's Temporary Directories.
server # [   28.191918] systemd[1003]: Reached target Paths.
host1 # [   26.485316] sshd-session[975]: pam_unix(sshd:session): session closed for user root
server # [   28.195063] systemd[1003]: Reached target Timers.
server # [   28.195831] systemd[1003]: Starting D-Bus User Message Bus Socket...
host1 # [   26.489819] systemd[1]: sshd-vsock@1-2-3:22-2:1.service: Deactivated successfully.
server # [   28.199351] systemd[1003]: Starting Create User Files and Directories...
host1 # [   26.493860] sshd-session[994]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.495155] sshd-session[994]: Disconnected from user root UNKNOWN port 65535
host1 # [   26.500379] sshd-session[974]: pam_unix(sshd:session): session closed for user root
host1 # [   26.501524] systemd[1]: session-4.scope: Deactivated successfully.
host1 # [   26.502408] systemd-logind[628]: Session 4 logged out. Waiting for processes to exit.
host1 # [   26.505220] systemd-logind[628]: Removed session 4.
host1 # [   26.511179] systemd[1]: sshd-vsock@3-4-3:22-2:3.service: Deactivated successfully.
host1 # [   26.515104] systemd[1]: session-3.scope: Deactivated successfully.
host1 # [   26.517871] systemd[1]: sshd-vsock@2-3-3:22-2:2.service: Deactivated successfully.
host1 # [   26.522766] systemd[1]: session-5.scope: Deactivated successfully.
host1 # [   26.527196] systemd-logind[628]: Session 3 logged out. Waiting for processes to exit.
host1 # [   26.530694] systemd-logind[628]: Removed session 3.
host1 # [   26.533293] systemd-logind[628]: Session 5 logged out. Waiting for processes to exit.
host1 # [   26.534515] systemd-logind[628]: Removed session 5.
server # [   28.250113] systemd[1003]: Finished Create User Files and Directories.
server # [   28.281858] systemd[1003]: Listening on D-Bus User Message Bus Socket.
server # [   28.282938] systemd[1003]: Reached target Sockets.
server # [   28.283675] systemd[1003]: Reached target Basic System.
server # [   28.287435] systemd[1003]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
server # [   28.289785] systemd[1003]: Reached target Main User Target.
server # [   28.290644] systemd[1003]: Startup finished in 301ms.
server # [   28.291376] systemd[1]: Started User Manager for UID 0.
server # [   28.295854] systemd[1]: Started Session 1 of User root.
server # [   28.313126] sshd-session[1016]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   28.315413] sshd-session[1016]: Disconnected from user root UNKNOWN port 65535
server # [   28.317528] sshd-session[995]: pam_unix(sshd:session): session closed for user root
server # [   28.321020] systemd[1]: sshd-vsock@0-1-4:22-2:0.service: Deactivated successfully.
server # [   28.326222] systemd[1]: session-1.scope: Deactivated successfully.
server # [   28.330058] systemd-logind[539]: Session 1 logged out. Waiting for processes to exit.
server # [   28.332894] systemd-logind[539]: Removed session 1.
server # [   29.527451] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   27.821472] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   29.535519] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
host1 # [   27.831731] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
host1 # [   27.838378] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).
server # [   29.628981] sshd-session[1021]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   29.636261] sshd-session[1021]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   29.645914] sshd-session[1021]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   29.655014] systemd-logind[539]: New session '3' of user 'root' with class 'user' and type 'tty'.
server # [   29.664500] systemd[1]: Started Session 3 of User root.
host1 # [   27.978728] sshd-session[1007]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   27.984411] sshd-session[1006]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   27.992709] sshd-session[1006]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   27.995653] sshd-session[1007]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   28.006819] sshd-session[1007]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   28.010724] sshd-session[1006]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   28.019300] systemd-logind[628]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   28.024518] systemd[1]: Started Session 6 of User root.
host1 # [   28.029198] systemd-logind[628]: New session '7' of user 'root' with class 'user' and type 'tty'.
host1 # [   28.033199] systemd[1]: Started Session 7 of User root.
host1 # [   28.078726] sshd-session[1018]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   28.084282] sshd-session[1018]: Disconnected from user root UNKNOWN port 65535
host1 # [   28.085632] sshd-session[1007]: pam_unix(sshd:session): session closed for user root
host1 # [   28.094483] systemd[1]: sshd-vsock@5-6-3:22-2:5.service: Deactivated successfully.
host1 # [   28.101695] systemd[1]: session-6.scope: Deactivated successfully.
host1 # [   28.104929] systemd-logind[628]: Session 6 logged out. Waiting for processes to exit.
host1 # [   28.113513] systemd-logind[628]: Removed session 6.
host1 # [   28.120894] sshd-session[1019]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   28.123176] sshd-session[1019]: Disconnected from user root UNKNOWN port 65535
host1 # [   28.125043] sshd-session[1006]: pam_unix(sshd:session): session closed for user root
host1 # [   28.129987] systemd[1]: sshd-vsock@4-5-3:22-2:4.service: Deactivated successfully.
host1 # [   28.134298] systemd[1]: session-7.scope: Deactivated successfully.
host1 # [   28.138404] systemd-logind[628]: Session 7 logged out. Waiting for processes to exit.
host1 # [   28.141018] systemd-logind[628]: Removed session 7.
test acme::host1_obtains_a_certificate_via_acme ... ok
server # [   30.545391] sshd-session[1027]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   30.547651] sshd-session[1027]: Disconnected from user root UNKNOWN port 65535
server # [   30.549514] sshd-session[1021]: pam_unix(sshd:session): session closed for user root
server # [   30.554214] systemd[1]: sshd-vsock@1-2-4:22-2:1.service: Deactivated successfully.
server # [   30.559856] systemd[1]: session-3.scope: Deactivated successfully.
server # [   30.563739] systemd[1]: session-3.scope: Consumed 408ms CPU time over 896ms wall clock time, 47.1M memory peak, 1.4K outgoing IP traffic.
server # [   30.568581] systemd-logind[539]: Session 3 logged out. Waiting for processes to exit.
server # [   30.569771] systemd-logind[539]: Removed session 3.
server # [   30.663918] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   28.955302] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   30.670491] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
host1 # [   28.962854] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).
server # [   30.758744] sshd-session[1047]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   30.767470] sshd-session[1047]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   29.058389] sshd-session[1028]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   29.068463] sshd-session[1028]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   30.776687] sshd-session[1047]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   30.785290] systemd-logind[539]: New session '4' of user 'root' with class 'user' and type 'tty'.
host1 # [   29.077854] sshd-session[1028]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   30.792852] systemd[1]: Started Session 4 of User root.
host1 # [   29.087151] systemd-logind[628]: New session '8' of user 'root' with class 'user' and type 'tty'.
host1 # [   29.096523] systemd[1]: Started Session 8 of User root.
server # [   31.029645] systemd[1]: Started Nix Daemon.
server # [   31.141596] sshd-session[1053]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   31.147363] sshd-session[1053]: Disconnected from user root UNKNOWN port 65535
server # [   31.149100] sshd-session[1047]: pam_unix(sshd:session): session closed for user root
server # [   31.151610] systemd[1]: sshd-vsock@2-3-4:22-2:2.service: Deactivated successfully.
server # [   31.159300] systemd[1]: session-4.scope: Deactivated successfully.
server # [   31.167732] systemd-logind[539]: Session 4 logged out. Waiting for processes to exit.
server # [   31.173538] systemd-logind[539]: Removed session 4.
server # [   31.232127] nix-daemon[1059]: accepted connection from pid 981, user nix-grpc-daemon (trusted)
server # [   31.245530] nix-grpc-daemon[981]: ts=2026-11-06T08:44:24Z level=info event=denied method=Connect cn=host1 role=read-only
host1 # [   29.578862] sshd-session[1034]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   29.582952] sshd-session[1034]: Disconnected from user root UNKNOWN port 65535
host1 # [   29.585895] sshd-session[1028]: pam_unix(sshd:session): session closed for user root
host1 # [   29.590995] systemd[1]: sshd-vsock@6-7-3:22-2:6.service: Deactivated successfully.
host1 # [   29.598683] systemd[1]: session-8.scope: Deactivated successfully.
host1 # [   29.602452] systemd[1]: session-8.scope: Consumed 182ms CPU time over 504ms wall clock time, 36.8M memory peak, 5.1K incoming IP traffic, 4K outgoing IP traffic.
host1 # [   29.610656] systemd-logind[628]: Session 8 logged out. Waiting for processes to exit.
host1 # [   29.612749] systemd-logind[628]: Removed session 8.
server # [   31.399018] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   31.407910] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
server # [   31.500848] sshd-session[1065]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   31.508326] sshd-session[1065]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   31.517766] sshd-session[1065]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   31.528179] systemd-logind[539]: New session '5' of user 'root' with class 'user' and type 'tty'.
server # [   31.536906] systemd[1]: Started Session 5 of User root.
host1 # [   29.964377] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   29.967967] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).
server # [   31.681827] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   31.687519] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
server # [   31.749442] sshd-session[1071]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   31.750888] sshd-session[1071]: Disconnected from user root UNKNOWN port 65535
server # [   31.752729] sshd-session[1065]: pam_unix(sshd:session): session closed for user root
test acme::server_builds_and_signs_a_path ... ok
server # [   31.761255] systemd[1]: sshd-vsock@3-4-4:22-2:3.service: Deactivated successfully.
server # [   31.766796] systemd[1]: session-5.scope: Deactivated successfully.
server # [   31.773368] systemd-logind[539]: Session 5 logged out. Waiting for processes to exit.
server # [   31.777752] systemd-logind[539]: Removed session 5.
host1 # [   30.068498] sshd-session[1050]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   30.078008] sshd-session[1050]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   30.087137] sshd-session[1050]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   30.096873] systemd-logind[628]: New session '9' of user 'root' with class 'user' and type 'tty'.
server # [   31.806296] sshd-session[1076]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   31.813696] sshd-session[1076]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   30.108571] systemd[1]: Started Session 9 of User root.
server # [   31.821051] sshd-session[1076]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   31.829315] systemd-logind[539]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   30.128697] sshd-session[1056]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   30.131629] sshd-session[1056]: Disconnected from user root UNKNOWN port 65535
server # [   31.840616] systemd[1]: Started Session 6 of User root.
host1 # [   30.133288] sshd-session[1050]: pam_unix(sshd:session): session closed for user root
host1 # [   30.138166] systemd[1]: sshd-vsock@7-8-3:22-2:7.service: Deactivated successfully.
host1 # [   30.143113] systemd[1]: session-9.scope: Deactivated successfully.
host1 # [   30.147737] systemd-logind[628]: Session 9 logged out. Waiting for processes to exit.
host1 # [   30.150638] systemd-logind[628]: Removed session 9.
server # [   31.865630] sshd-session[1084]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   31.867925] sshd-session[1084]: Disconnected from user root UNKNOWN port 65535
server # [   31.869472] sshd-session[1076]: pam_unix(sshd:session): session closed for user root
server # [   31.873521] systemd[1]: sshd-vsock@4-5-4:22-2:4.service: Deactivated successfully.
server # [   31.878729] systemd[1]: session-6.scope: Deactivated successfully.
server # [   31.883024] systemd-logind[539]: Session 6 logged out. Waiting for processes to exit.
server # [   31.885518] systemd-logind[539]: Removed session 6.
test acme::a_read_only_host_cannot_write ... ok
host1 # [   30.661197] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   30.670418] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).
host1 # [   30.767563] sshd-session[1061]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   30.777864] sshd-session[1061]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   30.787564] sshd-session[1061]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   30.799717] systemd-logind[628]: New session '10' of user 'root' with class 'user' and type 'tty'.
host1 # [   30.805401] systemd[1]: Started Session 10 of User root.
server # [   33.560712] nix-daemon[1059]: accepted connection from pid 981, user nix-grpc-daemon (trusted)
server # [   33.573690] nix-grpc-daemon[981]: ts=2026-11-06T08:44:26Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:38552 duration_s=0 paths=1 nar_bytes_out=128
server # [   33.592647] nix-daemon[1059]: reaped child process 1090, status = succeeded
host1 # [   31.907120] sshd-session[1067]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   31.907392] sshd-session[1067]: Disconnected from user root UNKNOWN port 65535
host1 # [   31.912579] sshd-session[1061]: pam_unix(sshd:session): session closed for user root
host1 # [   31.918261] systemd[1]: sshd-vsock@8-9-3:22-2:8.service: Deactivated successfully.
host1 # [   31.925456] systemd[1]: session-10.scope: Deactivated successfully.
host1 # [   31.927567] systemd[1]: session-10.scope: Consumed 197ms CPU time over 1.122s wall clock time, 42.6M memory peak, 10.1K incoming IP traffic, 9.3K outgoing IP traffic.
host1 # [   31.935369] systemd-logind[628]: Session 10 logged out. Waiting for processes to exit.
host1 # [   31.937246] systemd-logind[628]: Removed session 10.
host1 # [   32.205607] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   32.220303] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).
host1 # [   32.315831] sshd-session[1086]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   32.326603] sshd-session[1086]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   32.335845] sshd-session[1086]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   32.345379] systemd-logind[628]: New session '11' of user 'root' with class 'user' and type 'tty'.
host1 # [   32.356777] systemd[1]: Started Session 11 of User root.
host1 # [   32.382949] sshd-session[1092]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   32.385970] sshd-session[1092]: Disconnected from user root UNKNOWN port 65535
host1 # [   32.387529] sshd-session[1086]: pam_unix(sshd:session): session closed for user root
host1 # [   32.392308] systemd[1]: sshd-vsock@9-10-3:22-2:9.service: Deactivated successfully.
host1 # [   32.398099] systemd[1]: session-11.scope: Deactivated successfully.
host1 # [   32.402068] systemd-logind[628]: Session 11 logged out. Waiting for processes to exit.
host1 # [   32.405709] systemd-logind[628]: Removed session 11.
test acme::host1_substitutes_the_signed_path_with_a_read_only_cert ... ok

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

(finished: run the VM test script, in 47.74 seconds)
test script finished in 47.98s
cleanup
kill QemuMachine (pid 54)
host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)
host1 # [2026-11-06T08:44:27Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-06T08:44:27Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-11-06T08:44:27Z INFO  virtiofsd] Client disconnected, shutting down
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-06T08:44:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-06T08:44:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-11-06T08:44:28Z INFO  virtiofsd] Client disconnected, shutting down
(finished: cleanup, in 1.59 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/tmp06abjyzq/host1_host.socket
    server:  ssh -o User=root vsock-mux//build/tmp06abjyzq/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