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.00 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: QEMU running (pid 55)
server # Formatting '/build/vm-state-server/tmp.cYJXddh0RA', fmt=raw size=1073741824
host1 # Disk image does not exist, creating the virtualisation disk image...
server # mke2fs 1.47.4 (6-Mar-2025)
host1 # Formatting '/build/vm-state-host1/tmp.iOwgGObW5J', fmt=raw size=1073741824
server # Discarding device blocks:      0/262144             done
host1 # mke2fs 1.47.4 (6-Mar-2025)
server # Creating filesystem with 262144 4k blocks and 65536 inodes
host1 # Discarding device blocks:      0/262144             done
server # Filesystem UUID: bf7d758f-a1fd-4fc0-8b47-ed1ad787afd5
server # Superblock backups stored on blocks:
host1 # Creating filesystem with 262144 4k blocks and 65536 inodes
host1: QEMU running (pid 54)
host1 # Filesystem UUID: fc4e46fd-e703-4752-ad46-28d3bd24c708
host1 # Superblock backups stored on blocks:
server # 	32768, 98304, 163840, 229376
host1 # 	32768, 98304, 163840, 229376
server # 
host1 # 
server # Allocating group tables: 0/8   done
host1 # Allocating group tables: 0/8   done
server # Writing inode tables: 0/8   done
host1 # Writing inode tables: 0/8   done
server # Creating journal (8192 blocks): done
host1 # Creating journal (8192 blocks): done
server # Writing superblocks and filesystem accounting information: 0/8   done
host1 # Writing superblocks and filesystem accounting information: 0/8   done
server # 
host1 # 
server # Virtualisation disk image created.
host1 # Virtualisation disk image created.
server # Starting virtiofs daemons...
host1 # Starting virtiofs daemons...
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
host1 # [2026-10-27T20:04:52Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
host1 # [2026-10-27T20:04:52Z INFO  virtiofsd] Client connected, servicing requests
(finished: start all VMs, in 0.52 seconds)
server: waiting for unit step-ca.service
server: waiting for the VM to finish booting
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
server # [    0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1791725172
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 s186904 r8192 d116200 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/ahhd6ww9xv4am6f80mcfpn1lbb2m4mg3-nixos-system-server-test/init regInfo=/nix/.ro-store/wwiqs24v4xqd4rvd6yq4i41146jy6l7c-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/wwiqs24v4xqd4rvd6yq4i41146jy6l7c-closure-info/registration", will be passed to user space.
host1 # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
host1 # [    0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1791725172
server # [    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
host1 # [    0.000000] KASLR enabled
host1 # [    0.000000] random: crng init done
server # [    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
host1 # [    0.000000] Machine model: linux,dummy-virt
host1 # [    0.000000] efi: UEFI not found.
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB
server # [    0.000000] software IO TLB: area num 1.
host1 # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
server # [    0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)
host1 # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]
server # [    0.000000] Fallback order for Node 0: 0
host1 # [    0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]
host1 # [    0.000000] Zone ranges:
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 524288
server # [    0.000000] Policy zone: DMA
host1 # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000bfffffff]
host1 # [    0.000000]   DMA32    empty
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
host1 # [    0.000000]   Normal   empty
host1 # [    0.000000]   Device   empty
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
host1 # [    0.000000] Movable zone start for each node
server # [    0.000000] allocated 4194304 bytes of page_ext
server # [    0.000000] ftrace: allocating 75049 entries in 294 pages
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
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.
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
host1 # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
host1 # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
host1 # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
host1 # [    0.000000] psci: SMC Calling Convention v1.1
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
host1 # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
host1 # [    0.000000] percpu: Embedded 76 pages/cpu s186904 r8192 d116200 u311296
host1 # [    0.000000] Detected PIPT I-cache on CPU0
server # [    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] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    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] CPU features: detected: GICv3 CPU interface
host1 # [    0.000000] CPU features: detected: Spectre-v4
server # [    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] CPU features: detected: Spectre-BHB
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
host1 # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000] GICv3: 0 Extended SPIs implemented
host1 # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] Root IRQ handler: gic_handle_irq
host1 # [    0.000000] alternatives: applying boot alternatives
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 @44af0000 (indirect, esz 8, psz 64K, shr 1)
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/jzwn7x5v01ddgs50s4c5y733a6761lww-nixos-system-host1-test/init regInfo=/nix/.ro-store/zps5600bvcqgca615hcr1hmn1hp46wdb-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000044b10000
host1 # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/zps5600bvcqgca615hcr1hmn1hp46wdb-closure-info/registration", will be passed to user space.
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000
host1 # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
host1 # [    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
host1 # [    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
host1 # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB
host1 # [    0.000000] software IO TLB: area num 1.
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
host1 # [    0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
host1 # [    0.000000] Fallback order for Node 0: 0
server # [    0.000035] arm-pv: using stolen time PV
host1 # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 524288
host1 # [    0.000000] Policy zone: DMA
server # [    0.000516] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
host1 # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000717] Console: colour dummy device 80x25
server # [    0.000726] printk: legacy console [tty0] enabled
host1 # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
host1 # [    0.000000] allocated 4194304 bytes of page_ext
server # [    0.000944] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
host1 # [    0.000000] ftrace: allocating 75049 entries in 294 pages
server # [    0.000951] pid_max: default: 32768 minimum: 301
host1 # [    0.000000] ftrace: allocated 294 pages with 4 groups
host1 # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.001035] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.001182] landlock: Up and running.
host1 # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.001185] Yama: becoming mindful.
host1 # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
server # [    0.001719] LSM support for eBPF active
host1 # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.001877] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
host1 # [    0.000000] 	Rude variant of Tasks RCU enabled.
host1 # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.002252] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.004342] rcu: Hierarchical SRCU implementation.
host1 # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.004348] rcu: 	Max phase no-delay instances is 1000.
host1 # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.005616] fsl-mc MSI: its@8080000 domain created
server # [    0.005735] EFI services will not be available.
host1 # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.005821] smp: Bringing up secondary CPUs ...
server # [    0.005830] smp: Brought up 1 node, 1 CPU
host1 # [    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.005833] SMP: Total of 1 processors activated.
server # [    0.005836] CPU: All CPU(s) started at EL1
host1 # [    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.005845] CPU features: detected: Branch Target Identification
host1 # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.005850] CPU features: detected: ARMv8.4 Translation Table Level
host1 # [    0.000000] GICv3: 256 SPIs implemented
host1 # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.005853] CPU features: detected: Instruction cache invalidation not required for I/D coherence
host1 # [    0.000000] Root IRQ handler: gic_handle_irq
host1 # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.005857] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
host1 # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.005864] CPU features: detected: Common not Private translations
host1 # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.005867] CPU features: detected: CRC32 instructions
host1 # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.005869] CPU features: detected: Data cache clean to Point of Deep Persistence
host1 # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.005873] CPU features: detected: Data cache clean to Point of Persistence
host1 # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)
server # [    0.005876] CPU features: detected: Data independent timing control (DIT)
server # [    0.005879] CPU features: detected: E0PD
host1 # [    0.000000] GICv3: using LPI property table @0x0000000044b10000
server # [    0.005882] CPU features: detected: Enhanced Counter Virtualization
host1 # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000
server # [    0.005885] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
host1 # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.005888] CPU features: detected: Enhanced Virtualization Traps
server # [    0.005891] CPU features: detected: Fine Grained Traps
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).
server # [    0.005894] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.005899] CPU features: detected: RCpc load-acquire (LDAPR)
host1 # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.005902] CPU features: detected: LSE atomic instructions
server # [    0.005905] CPU features: detected: Privileged Access Never
host1 # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.005907] CPU features: detected: PMUv3
host1 # [    0.000033] arm-pv: using stolen time PV
server # [    0.005910] CPU features: detected: RAS Extension Support
host1 # [    0.000402] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.005913] CPU features: detected: RASv1p1 Extension Support
host1 # [    0.000591] Console: colour dummy device 80x25
server # [    0.005916] CPU features: detected: Random Number Generator
host1 # [    0.000599] printk: legacy console [tty0] enabled
server # [    0.005921] CPU features: detected: Speculation barrier (SB)
server # [    0.005924] CPU features: detected: Stage-2 Force Write-Back
host1 # [    0.000787] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.005926] CPU features: detected: TLB range maintenance instructions
host1 # [    0.000793] pid_max: default: 32768 minimum: 301
host1 # [    0.000867] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.005931] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
host1 # [    0.001038] landlock: Up and running.
server # [    0.005970] alternatives: applying system-wide alternatives
host1 # [    0.001041] Yama: becoming mindful.
host1 # [    0.001490] LSM support for eBPF active
server # [    0.009085] CPU features: detected: BBM Level 2 without TLB conflict abort
host1 # [    0.001624] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.009282] Memory: 1920368K/2097152K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 133196K reserved, 32768K cma-reserved)
host1 # [    0.001658] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
server # [    0.009752] devtmpfs: initialized
host1 # [    0.003823] rcu: Hierarchical SRCU implementation.
host1 # [    0.003830] rcu: 	Max phase no-delay instances is 1000.
server # [    0.011812] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
host1 # [    0.005123] fsl-mc MSI: its@8080000 domain created
server # [    0.011837] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
host1 # [    0.005248] EFI services will not be available.
host1 # [    0.005317] smp: Bringing up secondary CPUs ...
server # [    0.012046] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
host1 # [    0.005327] smp: Brought up 1 node, 1 CPU
server # [    0.012051] 0 pages in range for non-PLT usage
host1 # [    0.005330] SMP: Total of 1 processors activated.
server # [    0.012053] 508192 pages in range for PLT usage
host1 # [    0.005333] CPU: All CPU(s) started at EL1
server # [    0.012160] pinctrl core: initialized pinctrl subsystem
server # [    0.013064] DMI not present or invalid.
host1 # [    0.005342] CPU features: detected: Branch Target Identification
server # [    0.017720] NET: Registered PF_NETLINK/PF_ROUTE protocol family
host1 # [    0.005347] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.020120] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
host1 # [    0.005350] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.020294] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.020488] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
host1 # [    0.005354] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.020514] audit: initializing netlink subsys (disabled)
host1 # [    0.005361] CPU features: detected: Common not Private translations
server # [    0.021132] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
host1 # [    0.005364] CPU features: detected: CRC32 instructions
server # [    0.021207] thermal_sys: Registered thermal governor 'fair_share'
host1 # [    0.005367] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.021209] thermal_sys: Registered thermal governor 'bang_bang'
host1 # [    0.005371] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.021212] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.021215] thermal_sys: Registered thermal governor 'user_space'
host1 # [    0.005374] CPU features: detected: Data independent timing control (DIT)
host1 # [    0.005377] CPU features: detected: E0PD
server # [    0.021218] thermal_sys: Registered thermal governor 'power_allocator'
host1 # [    0.005379] CPU features: detected: Enhanced Counter Virtualization
server # [    0.021242] cpuidle: using governor ladder
server # [    0.021250] cpuidle: using governor menu
host1 # [    0.005382] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.021445] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
host1 # [    0.005386] CPU features: detected: Enhanced Virtualization Traps
server # [    0.021462] ASID allocator initialised with 65536 entries
host1 # [    0.005389] CPU features: detected: Fine Grained Traps
server # [    0.023689] Serial: AMBA PL011 UART driver
host1 # [    0.005393] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.029867] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
host1 # [    0.005398] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.030034] printk: console [ttyAMA0] enabled
host1 # [    0.005401] CPU features: detected: LSE atomic instructions
host1 # [    0.005403] CPU features: detected: Privileged Access Never
host1 # [    0.005406] CPU features: detected: PMUv3
host1 # [    0.005409] CPU features: detected: RAS Extension Support
host1 # [    0.005411] CPU features: detected: RASv1p1 Extension Support
host1 # [    0.005414] CPU features: detected: Random Number Generator
host1 # [    0.005419] CPU features: detected: Speculation barrier (SB)
host1 # [    0.005422] CPU features: detected: Stage-2 Force Write-Back
host1 # [    0.005425] CPU features: detected: TLB range maintenance instructions
host1 # [    0.005430] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
host1 # [    0.005468] alternatives: applying system-wide alternatives
host1 # [    0.008549] CPU features: detected: BBM Level 2 without TLB conflict abort
host1 # [    0.008709] Memory: 1920380K/2097152K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 133164K reserved, 32768K cma-reserved)
host1 # [    0.009170] devtmpfs: initialized
server # [    0.159975] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.159986] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
host1 # [    0.011319] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.159990] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
host1 # [    0.011345] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.159993] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
host1 # [    0.011533] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
host1 # [    0.011538] 0 pages in range for non-PLT usage
server # [    0.159996] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
host1 # [    0.011540] 508192 pages in range for PLT usage
server # [    0.159999] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
host1 # [    0.011650] pinctrl core: initialized pinctrl subsystem
server # [    0.160002] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
host1 # [    0.012611] DMI not present or invalid.
server # [    0.160004] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
host1 # [    0.016016] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.161217] fbcon: Taking over console
host1 # [    0.018420] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
server # [    0.161226] ACPI: Interpreter disabled.
host1 # [    0.018598] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.171183] iommu: Default domain type: Translated
host1 # [    0.018794] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.171190] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.171741] SCSI subsystem initialized
host1 # [    0.018821] audit: initializing netlink subsys (disabled)
host1 # [    0.019398] thermal_sys: Registered thermal governor 'fair_share'
host1 # [    0.019400] thermal_sys: Registered thermal governor 'bang_bang'
host1 # [    0.019404] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.173876] usbcore: registered new interface driver usbfs
host1 # [    0.019407] thermal_sys: Registered thermal governor 'user_space'
server # [    0.173901] usbcore: registered new interface driver hub
server # [    0.173924] usbcore: registered new device driver usb
host1 # [    0.019410] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.174224] pps_core: LinuxPPS API ver. 1 registered
host1 # [    0.019437] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
host1 # [    0.019446] cpuidle: using governor ladder
server # [    0.174228] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
host1 # [    0.019452] cpuidle: using governor menu
server # [    0.174237] PTP clock support registered
server # [    0.174277] EDAC MC: Ver: 3.0.0
host1 # [    0.019646] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
host1 # [    0.019664] ASID allocator initialised with 65536 entries
host1 # [    0.020974] Serial: AMBA PL011 UART driver
host1 # [    0.027055] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
host1 # [    0.027230] printk: console [ttyAMA0] enabled
server # [    0.180624] scmi_core: SCMI protocol bus registered
server # [    0.180996] FPGA manager framework
server # [    0.184154] vgaarb: loaded
server # [    0.185910] clocksource: Switched to clocksource arch_sys_counter
server # [    0.193186] VFS: Disk quotas dquot_6.6.0
host1 # [    0.157523] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.193220] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
host1 # [    0.157535] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
host1 # [    0.157538] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
host1 # [    0.157541] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
host1 # [    0.157544] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.197193] netfs: FS-Cache loaded
server # [    0.197323] pnp: PnP ACPI: disabled
host1 # [    0.157547] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
host1 # [    0.157550] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
host1 # [    0.157552] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
host1 # [    0.159202] fbcon: Taking over console
host1 # [    0.159212] ACPI: Interpreter disabled.
server # [    0.201538] NET: Registered PF_INET protocol family
host1 # [    0.168943] iommu: Default domain type: Translated
server # [    0.201805] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
host1 # [    0.168948] iommu: DMA domain TLB invalidation policy: strict mode
host1 # [    0.169317] SCSI subsystem initialized
host1 # [    0.171440] usbcore: registered new interface driver usbfs
host1 # [    0.171464] usbcore: registered new interface driver hub
host1 # [    0.171486] usbcore: registered new device driver usb
host1 # [    0.171775] pps_core: LinuxPPS API ver. 1 registered
host1 # [    0.171779] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
host1 # [    0.171787] PTP clock support registered
host1 # [    0.171832] EDAC MC: Ver: 3.0.0
host1 # [    0.178443] scmi_core: SCMI protocol bus registered
host1 # [    0.178818] FPGA manager framework
host1 # [    0.181937] vgaarb: loaded
host1 # [    0.183752] clocksource: Switched to clocksource arch_sys_counter
host1 # [    0.190462] VFS: Disk quotas dquot_6.6.0
host1 # [    0.190494] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
host1 # [    0.193353] netfs: FS-Cache loaded
host1 # [    0.193471] pnp: PnP ACPI: disabled
host1 # [    0.198824] NET: Registered PF_INET protocol family
host1 # [    0.199100] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.232165] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.232205] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.232234] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.232301] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
server # [    0.232441] TCP: Hash tables configured (established 16384 bind 16384)
server # [    0.232527] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
server # [    0.232562] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.232595] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
server # [    0.232681] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.232698] NET: Registered PF_XDP protocol family
server # [    0.232714] PCI: CLS 0 bytes, default 64
server # [    0.233131] Trying to unpack rootfs image as initramfs...
server # [    0.249935] kvm [1]: HYP mode not available
host1 # [    0.230506] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
host1 # [    0.230553] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
host1 # [    0.230582] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
host1 # [    0.230650] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
host1 # [    0.230790] TCP: Hash tables configured (established 16384 bind 16384)
host1 # [    0.230878] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
host1 # [    0.230931] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.230967] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
host1 # [    0.231054] NET: Registered PF_UNIX/PF_LOCAL protocol family
host1 # [    0.231078] NET: Registered PF_XDP protocol family
host1 # [    0.231096] PCI: CLS 0 bytes, default 64
host1 # [    0.231433] Trying to unpack rootfs image as initramfs...
host1 # [    0.247855] kvm [1]: HYP mode not available
server # [    0.346626] Initialise system trusted keyrings
server # [    0.346766] workingset: timestamp_bits=42 max_order=19 bucket_order=0
server # [    0.347129] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.347207] 9p: Installing v9fs 9p2000 file system support
server # [    0.375431] Key type asymmetric registered
server # [    0.375450] Asymmetric key parser 'x509' registered
server # [    0.375535] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.375714] io scheduler mq-deadline registered
server # [    0.375720] io scheduler kyber registered
host1 # [    0.344415] Initialise system trusted keyrings
host1 # [    0.347854] workingset: timestamp_bits=42 max_order=19 bucket_order=0
host1 # [    0.349665] squashfs: version 4.0 (2009/01/31) Phillip Lougher
host1 # [    0.349742] 9p: Installing v9fs 9p2000 file system support
server # [    0.394056] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.395157] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.395537] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.395551] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.395561] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.395566] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.395584] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
host1 # [    0.371424] Key type asymmetric registered
host1 # [    0.371435] Asymmetric key parser 'x509' registered
server # [    0.395609] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
host1 # [    0.371648] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.395692] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.395700] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.395705] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.395708] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.395711] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.395836] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.396289] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.396476] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.396488] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.396514] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.396525] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.396993] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.397176] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.379815] io scheduler mq-deadline registered
host1 # [    0.379825] io scheduler kyber registered
server # [    0.397187] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.397213] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.392210] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
host1 # [    0.392933] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.426133] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
host1 # [    0.393377] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.426336] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
host1 # [    0.393392] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.426349] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.426374] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.393403] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.426878] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.393408] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.427082] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.393427] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.427094] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.427121] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.393458] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.427133] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.393542] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
host1 # [    0.393549] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.427607] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
host1 # [    0.393553] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.427800] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.393557] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.427827] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.393560] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.428307] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.428498] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.393631] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.428525] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.394085] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
host1 # [    0.394293] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.428933] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
host1 # [    0.394305] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.429119] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
host1 # [    0.394331] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.429422] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.394343] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.429614] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.394839] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.429641] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.395029] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
host1 # [    0.395040] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.395066] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.395538] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.447787] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.395724] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.447984] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.395736] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.448011] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.419346] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.448497] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.448687] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.448714] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.449213] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.449513] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
host1 # [    0.420766] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.449525] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.420955] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.449552] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.420967] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.420992] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.421004] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
host1 # [    0.421476] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
host1 # [    0.421666] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.421692] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.422177] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
host1 # [    0.422368] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.422394] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
host1 # [    0.422801] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
host1 # [    0.422987] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
host1 # [    0.423276] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
host1 # [    0.423465] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.423491] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.466180] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.466386] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.466399] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.466426] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.466940] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
server # [    0.467157] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.467183] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.467829] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.467835] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.467839] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.467885] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.467930] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
host1 # [    0.444081] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.467976] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
host1 # [    0.444284] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.468022] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
host1 # [    0.444311] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.468070] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
host1 # [    0.444797] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.468116] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
host1 # [    0.444987] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.445013] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.468162] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
host1 # [    0.445503] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.468207] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
host1 # [    0.445767] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.468252] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
host1 # [    0.445779] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.468383] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
host1 # [    0.445805] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.468428] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
host1 # [    0.446304] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.468470] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
host1 # [    0.446493] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.468488] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
host1 # [    0.446505] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.468506] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
host1 # [    0.446530] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.468524] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
host1 # [    0.447006] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint
server # [    0.468541] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
host1 # [    0.447198] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]
host1 # [    0.447224] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.468559] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
host1 # [    0.462802] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.468578] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
host1 # [    0.462810] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.468598] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
host1 # [    0.462814] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.468616] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
host1 # [    0.462861] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.468634] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
host1 # [    0.462906] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.468652] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.468671] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
host1 # [    0.462950] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.468690] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
host1 # [    0.462996] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.468708] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
host1 # [    0.463045] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.468725] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.468743] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
host1 # [    0.463090] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.468760] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
host1 # [    0.463134] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.468778] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
host1 # [    0.463177] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.468795] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.468818] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
host1 # [    0.463221] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.468824] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
host1 # [    0.463301] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.468827] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
host1 # [    0.463345] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned
server # [    0.469696] pci 0000:00:07.0: enabling device (0000 -> 0002)
host1 # [    0.463388] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.494607] pci 0000:00:07.0: quirk_usb_early_handoff+0x0/0xa60 took 24333 usecs
host1 # [    0.463404] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
host1 # [    0.463422] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
host1 # [    0.463439] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
host1 # [    0.463456] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
host1 # [    0.463474] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
host1 # [    0.463492] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
host1 # [    0.463511] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
host1 # [    0.463528] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
host1 # [    0.463546] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
host1 # [    0.463564] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
host1 # [    0.463582] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
host1 # [    0.463601] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned
host1 # [    0.463618] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
host1 # [    0.463635] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
host1 # [    0.463653] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
host1 # [    0.463670] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
host1 # [    0.463687] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
host1 # [    0.463705] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
host1 # [    0.463728] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
host1 # [    0.463733] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
host1 # [    0.463736] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
host1 # [    0.504697] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.531447] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
host1 # [    0.527116] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
host1 # [    1.142407] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    1.207910] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
host1 # [    1.314085] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
host1 # [    1.437732] Freeing initrd memory: 26964K
host1 # [    1.438574] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    1.434462] Freeing initrd memory: 26996K
server # [    1.435288] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
host1 # [    1.442342] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    1.437380] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
host1 # [    1.669772] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
server # [    1.702303] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    1.704523] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
host1 # [    1.672590] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
host1 # [    1.674443] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    1.707989] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
host1 # [    1.678887] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    1.713258] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    1.717758] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    1.720778] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
host1 # [    1.685044] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
host1 # [    1.687586] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
host1 # [    1.714195] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
server # [    1.746153] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    1.748586] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)
host1 # [    1.720357] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
host1 # [    1.722107] msm_serial: driver initialized
host1 # [    1.722270] SuperH (H)SCI(F) driver initialized
server # [    1.756084] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
host1 # [    1.722332] STM32 USART driver initialized
server # [    1.757858] msm_serial: driver initialized
server # [    1.759517] SuperH (H)SCI(F) driver initialized
server # [    1.759580] STM32 USART driver initialized
host1 # [    1.740616] loop: module loaded
host1 # [    1.740784] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    1.776300] loop: module loaded
host1 # [    1.741516] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    1.776482] virtio_blk virtio2: 1/0/0 default/read/poll queues
host1 # [    1.743593] megasas: 07.734.00.00-rc1
server # [    1.777310] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
host1 # [    1.747087] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    1.782504] megasas: 07.734.00.00-rc1
server # [    1.783395] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    1.785498] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
host1 # [    1.750804] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.785521] Intel/Sharp Extended Query Table at 0x0031
host1 # [    1.750822] Intel/Sharp Extended Query Table at 0x0031
host1 # [    1.758136] Using buffer write method
host1 # [    1.758249] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    1.791002] Using buffer write method
server # [    1.791041] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    1.793678] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.793699] Intel/Sharp Extended Query Table at 0x0031
host1 # [    1.764585] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.800503] Using buffer write method
host1 # [    1.764665] Intel/Sharp Extended Query Table at 0x0031
server # [    1.800527] Concatenating MTD devices:
host1 # [    1.766151] Using buffer write method
server # [    1.800529] (0): "0.flash"
host1 # [    1.766248] Concatenating MTD devices:
server # [    1.800532] (1): "0.flash"
host1 # [    1.766251] (0): "0.flash"
server # [    1.800534] into device "0.flash"
host1 # [    1.766253] (1): "0.flash"
host1 # [    1.766255] into device "0.flash"
server # [    1.809598] tun: Universal TUN/TAP device driver, 1.6
host1 # [    1.776858] tun: Universal TUN/TAP device driver, 1.6
server # [    1.813742] thunder_xcv, ver 1.0
server # [    1.813782] thunder_bgx, ver 1.0
server # [    1.813802] nicpf, ver 1.0
host1 # [    1.780810] thunder_xcv, ver 1.0
host1 # [    1.780838] thunder_bgx, ver 1.0
server # [    1.815861] e1000: Intel(R) PRO/1000 Network Driver
host1 # [    1.780860] nicpf, ver 1.0
server # [    1.815867] e1000: Copyright (c) 1999-2006 Intel Corporation.
host1 # [    1.781458] e1000: Intel(R) PRO/1000 Network Driver
server # [    1.815894] e1000e: Intel(R) PRO/1000 Network Driver
host1 # [    1.781462] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    1.815900] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
host1 # [    1.781485] e1000e: Intel(R) PRO/1000 Network Driver
server # [    1.815933] igb: Intel(R) Gigabit Ethernet Network Driver
host1 # [    1.781491] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    1.815939] igb: Copyright (c) 2007-2014 Intel Corporation.
host1 # [    1.781522] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    1.815965] igbvf: Intel(R) Gigabit Virtual Function Network Driver
host1 # [    1.781525] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    1.815972] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
host1 # [    1.781546] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    1.816114] sky2: driver version 1.30
host1 # [    1.781550] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    1.817903] usbcore: registered new interface driver usb-storage
host1 # [    1.781693] sky2: driver version 1.30
host1 # [    1.783699] usbcore: registered new interface driver usb-storage
host1 # [    1.784432] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    1.825706] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    1.825731] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
host1 # [    1.784454] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    1.825983] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
host1 # [    1.784670] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
host1 # [    1.795623] usbcore: registered new interface driver usbserial_generic
server # [    1.828490] usbcore: registered new interface driver usbserial_generic
host1 # [    1.795638] usbserial: USB Serial support registered for generic
server # [    1.828503] usbserial: USB Serial support registered for generic
host1 # [    1.795804] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    1.829223] hv_vmbus: registering driver hyperv_keyboard
host1 # [    1.796193] hub 1-0:1.0: USB hub found
host1 # [    1.796211] hub 1-0:1.0: 6 ports detected
server # [    1.832620] rtc-pl031 9010000.pl031: registered as rtc0
server # [    1.832642] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T20:04:55 UTC (1793131495)
server # [    1.832975] i2c_dev: i2c /dev entries driver
host1 # [    1.800660] hv_vmbus: registering driver hyperv_keyboard
host1 # [    1.801551] rtc-pl031 9010000.pl031: registered as rtc0
host1 # [    1.801573] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T20:04:55 UTC (1793131495)
host1 # [    1.801882] i2c_dev: i2c /dev entries driver
server # [    1.838806] sdhci: Secure Digital Host Controller Interface driver
server # [    1.838813] sdhci: Copyright(c) Pierre Ossman
server # [    1.839175] Synopsys Designware Multimedia Card Interface Driver
server # [    1.839592] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    1.841234] hid: raw HID events driver (C) Jiri Kosina
host1 # [    1.808465] sdhci: Secure Digital Host Controller Interface driver
host1 # [    1.808471] sdhci: Copyright(c) Pierre Ossman
server # [    1.841499] usbcore: registered new interface driver usbhid
server # [    1.841503] usbhid: USB HID core driver
host1 # [    1.808801] Synopsys Designware Multimedia Card Interface Driver
host1 # [    1.809194] sdhci-pltfm: SDHCI platform and OF driver helper
host1 # [    1.810798] hid: raw HID events driver (C) Jiri Kosina
host1 # [    1.811087] usbcore: registered new interface driver usbhid
host1 # [    1.811091] usbhid: USB HID core driver
server # [    1.846821] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    1.847299] hub 1-0:1.0: USB hub found
server # [    1.847320] hub 1-0:1.0: 6 ports detected
server # [    1.848565] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
host1 # [    1.817153] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    1.853204] drop_monitor: Initializing network drop monitor service
host1 # [    1.818855] drop_monitor: Initializing network drop monitor service
server # [    1.853424] NET: Registered PF_INET6 protocol family
host1 # [    1.819066] NET: Registered PF_INET6 protocol family
host1 # [    1.819703] Segment Routing with IPv6
host1 # [    1.819717] In-situ OAM (IOAM) with IPv6
host1 # [    1.823491] NET: Registered PF_PACKET protocol family
host1 # [    1.823579] 9pnet: Installing 9P2000 support
host1 # [    1.823629] Key type dns_resolver registered
server # [    1.855545] Segment Routing with IPv6
server # [    1.855561] In-situ OAM (IOAM) with IPv6
server # [    1.855595] NET: Registered PF_PACKET protocol family
server # [    1.855664] 9pnet: Installing 9P2000 support
server # [    1.855717] Key type dns_resolver registered
host1 # [    1.831504] registered taskstats version 1
host1 # [    1.831706] Loading compiled-in X.509 certificates
server # [    1.864597] registered taskstats version 1
server # [    1.864790] Loading compiled-in X.509 certificates
server # [    1.873838] Demotion targets for Node 0: null
host1 # [    1.840581] Demotion targets for Node 0: null
host1 # [    1.840706] Key type .fscrypt registered
server # [    1.874539] Key type .fscrypt registered
host1 # [    1.840710] Key type fscrypt-provisioning registered
server # [    1.874544] Key type fscrypt-provisioning registered
host1 # [    1.840830] ima: No TPM chip found, activating TPM-bypass!
server # [    1.874680] ima: No TPM chip found, activating TPM-bypass!
host1 # [    1.840852] ima: Allocated hash algorithm: sha1
server # [    1.874701] ima: Allocated hash algorithm: sha1
host1 # [    1.840877] ima: No architecture policies found
server # [    1.874726] ima: No architecture policies found
host1 # [    1.841524] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.875388] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.897372] clk: Disabling unused clocks
server # [    1.897388] PM: genpd: Disabling unused power domains
host1 # [    1.864219] clk: Disabling unused clocks
host1 # [    1.864238] PM: genpd: Disabling unused power domains
host1 # [    1.867720] Freeing unused kernel memory: 4736K
host1 # [    1.869722] Run /init as init process
server # [    1.902025] Freeing unused kernel memory: 4736K
server # [    1.902237] Run /init as init process
host1 # [    1.886136] systemd[1]: Successfully made /usr/ read-only.
server # [    1.920402] systemd[1]: Successfully made /usr/ read-only.
host1 # [    2.043801] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    2.093990] usb 1-1: new high-speed USB device number 2 using ehci-pci
host1 # [    2.193579] 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 # [    2.243817] 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 # [    2.220267] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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 # [    2.220298] systemd[1]: Detected virtualization qemu.
server # [    2.254420] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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 # [    2.220342] systemd[1]: Detected architecture arm64.
server # [    2.254447] systemd[1]: Detected virtualization qemu.
server # [    2.254490] systemd[1]: Detected architecture arm64.
host1 # [    2.220351] systemd[1]: Running in initrd.
host1 # [    2.220931] systemd[1]: Initializing machine ID from random generator.
server # [    2.254499] systemd[1]: Running in initrd.
host1 # [    2.221092] systemd[1]: Hostname set to <host1>.
server # [    2.255135] systemd[1]: Initializing machine ID from random generator.
server # [    2.255293] systemd[1]: Hostname set to <server>.
host1 # [    2.287979] 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 # [    2.327603] 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 # [    2.381536] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [    2.349272] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    2.438470] systemd[1]: Queued start job for default target Initrd Default Target.
host1 # [    2.407823] usb 1-2: new high-speed USB device number 3 using ehci-pci
host1 # [    2.409597] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    2.448030] systemd[1]: Created slice Slice /system/modprobe.
server # [    2.448203] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    2.448229] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    2.448249] systemd[1]: Reached target Path Units.
host1 # [    2.417690] systemd[1]: Created slice Slice /system/modprobe.
server # [    2.448261] systemd[1]: Reached target Slice Units.
server # [    2.448274] systemd[1]: Reached target Swaps.
host1 # [    2.417848] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    2.448288] systemd[1]: Reached target Timer Units.
host1 # [    2.417873] systemd[1]: Expecting device /dev/disk/by-label/nixos...
host1 # [    2.417892] systemd[1]: Reached target Path Units.
server # [    2.448410] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [    2.417905] systemd[1]: Reached target Slice Units.
server # [    2.448548] systemd[1]: Listening on Journal Socket (/dev/log).
host1 # [    2.417919] systemd[1]: Reached target Swaps.
server # [    2.448687] systemd[1]: Listening on Journal Sockets.
server # [    2.448796] systemd[1]: Listening on udev Control Socket.
host1 # [    2.417932] systemd[1]: Reached target Timer Units.
server # [    2.448862] systemd[1]: Listening on udev Kernel Socket.
server # [    2.448876] systemd[1]: Reached target Socket Units.
host1 # [    2.418051] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    2.449831] usb 1-2: new high-speed USB device number 3 using ehci-pci
host1 # [    2.418272] systemd[1]: Listening on Journal Socket (/dev/log).
host1 # [    2.418407] systemd[1]: Listening on Journal Sockets.
host1 # [    2.418515] systemd[1]: Listening on udev Control Socket.
host1 # [    2.418581] systemd[1]: Listening on udev Kernel Socket.
server # [    2.461054] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [    2.418594] systemd[1]: Reached target Socket Units.
server # [    2.461117] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [    2.424480] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [    2.424541] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    2.466472] systemd[1]: Mounting Kernel Configuration File System...
host1 # [    2.439924] systemd[1]: Mounting Kernel Configuration File System...
host1 # [    2.447926] systemd[1]: Starting Journal Service...
server # [    2.484235] systemd[1]: Starting Journal Service...
server # [    2.485711] systemd[1]: Starting Load Kernel Modules...
server # [    2.485792] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    2.495530] systemd[1]: Starting Coldplug All udev Devices...
host1 # [    2.467938] systemd[1]: Starting Load Kernel Modules...
host1 # [    2.468054] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    2.472454] systemd[1]: Starting Coldplug All udev Devices...
host1 # [    2.485331] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [    2.490869] systemd-journald[70]: Collecting audit messages is disabled.
server # [    2.526363] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [    2.503979] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    2.504514] systemd[1]: Mounted Kernel Configuration File System.
server # [    2.534357] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    2.534623] systemd[1]: Mounted Kernel Configuration File System.
server # [    2.574598] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    2.577417] systemd-journald[70]: Collecting audit messages is disabled.
server # [    2.580204] systemd[1]: Starting Create Static Device Nodes in /dev...
host1 # [    2.551672] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    2.586637] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
host1 # [    2.560388] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    2.595889] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
host1 # [    2.562076] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
host1 # [    2.567368] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    2.611476] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    2.611719] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    2.611722] [drm] features: -context_init
server # [    2.612474] [drm] number of scanouts: 1
server # [    2.612488] [drm] number of cap sets: 0
host1 # [    2.581819] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
host1 # [    2.582055] [drm] features: -virgl +edid -resource_blob -host_visible
host1 # [    2.582057] [drm] features: -context_init
host1 # [    2.582905] [drm] number of scanouts: 1
host1 # [    2.582917] [drm] number of cap sets: 0
host1 # [    2.588078] 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 # [    2.596952] 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 # [    2.630924] 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 # [    2.631137] 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 # [    2.637507] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    2.637515] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
host1 # [    2.604165] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
host1 # [    2.604173] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    2.662641] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    2.662848] systemd[1]: Reached target Preparation for Local File Systems.
server # [    2.662872] systemd[1]: Reached target Local File Systems.
server # [    2.664886] Console: switching to colour frame buffer device 160x50
host1 # [    2.636189] Console: switching to colour frame buffer device 160x50
server # [    2.673193] systemd[1]: Starting Rule-based Manager for Device Events and Files...
host1 # [    2.652470] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [    2.652710] systemd[1]: Reached target Preparation for Local File Systems.
host1 # [    2.652734] systemd[1]: Reached target Local File Systems.
server # [    2.689470] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
host1 # [    2.654649] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
host1 # [    2.655710] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    2.706214] NET: Registered PF_VSOCK protocol family
host1 # [    2.679123] NET: Registered PF_VSOCK protocol family
host1 # [    2.680560] systemd-modules-load[71]: Inserted module 'dm_mod'
host1 # [    2.681742] systemd-modules-load[71]: Module 'virtio_balloon' is built in
host1 # [    2.682966] systemd-modules-load[71]: Module 'virtio_console' is built in
host1 # [    2.704493] systemd[1]: Started Journal Service.
host1 # [    2.690049] systemd-modules-load[71]: Inserted module 'virtio_gpu'
host1 # [    2.693253] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [    2.746559] systemd[1]: Finished Load Kernel Modules.
server # [    2.751005] systemd[1]: Starting Apply Kernel Variables...
host1 # [    2.704411] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
host1 # [    2.708246] systemd[1]: Starting Create System Files and Directories...
host1 # [    2.717155] systemd[1]: Finished Load Kernel Modules.
server # [    2.753128] systemd-modules-load[71]: Inserted module 'dm_mod'
server # [    2.754782] systemd-modules-load[71]: Module 'virtio_balloon' is built in
server # [    2.770170] systemd[1]: Started Journal Service.
host1 # [    2.725612] systemd[1]: Starting Apply Kernel Variables...
server # [    2.769177] systemd-modules-load[71]: Module 'virtio_console' is built in
server # [    2.777793] systemd-modules-load[71]: Inserted module 'virtio_gpu'
host1 # [    2.745358] systemd-udevd[77]: Using default interface naming scheme 'v261'.
server # [    2.784481] systemd-modules-load[71]: Module 'virtio_rng' is built in
server # [    2.791446] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'
server # [    2.796429] systemd[1]: Starting Create System Files and Directories...
server # [    2.797987] systemd-udevd[78]: Using default interface naming scheme 'v261'.
server # [    2.809578] systemd[1]: Finished Apply Kernel Variables.
host1 # [    2.775428] systemd[1]: Finished Apply Kernel Variables.
host1 # [    2.785297] systemd[1]: Finished Create System Files and Directories.
server # [    2.832137] systemd[1]: Finished Create System Files and Directories.
host1 # [    2.797993] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    2.845740] systemd[1]: Started Rule-based Manager for Device Events and Files.
host1 # [    2.872122] systemd[1]: Starting Virtual Console Setup...
server # [    2.936689] systemd[1]: Starting Virtual Console Setup...
host1 # [    2.948465] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [    2.952267] systemd[1]: Finished Virtual Console Setup.
server # [    3.024536] systemd-vconsole-setup[106]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    3.028143] systemd[1]: Finished Virtual Console Setup.
server # [    3.691184] systemd[1]: Finished Coldplug All udev Devices.
server # [    3.692183] systemd[1]: Reached target System Initialization.
server # [    3.693017] systemd[1]: Reached target Basic System.
host1 # [    3.662873] systemd[1]: Finished Coldplug All udev Devices.
host1 # [    3.663869] systemd[1]: Reached target System Initialization.
host1 # [    3.664813] systemd[1]: Reached target Basic System.
host1 # [    3.861362] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    3.863964] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    3.900436] (udev-worker)[105]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
host1 # [    3.869762] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.905323] (udev-worker)[105]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.921967] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.
host1 # [    4.020171] systemd[1]: Found device /dev/disk/by-label/nixos.
host1 # [    4.028094] systemd[1]: Reached target Initrd Root Device.
host1 # [    4.030159] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    4.079151] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    4.080743] systemd[1]: Reached target Initrd Root Device.
server # [    4.084879] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
host1 # [    4.080668] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks
host1 # [    4.088163] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
host1 # [    4.090921] systemd[1]: Mounting /sysroot...
server # [    4.131693] systemd-fsck[115]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    4.139326] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    4.144181] systemd[1]: Mounting /sysroot...
host1 # [    4.131832] systemd[1]: Mounted /sysroot.
host1 # [    4.148896] EXT4-fs (vda): mounted filesystem fc4e46fd-e703-4752-ad46-28d3bd24c708 r/w with ordered data mode. Quota mode: none.
host1 # [    4.135024] systemd[1]: Reached target Initrd Root File System.
host1 # [    4.140134] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    4.194532] EXT4-fs (vda): mounted filesystem bf7d758f-a1fd-4fc0-8b47-ed1ad787afd5 r/w with ordered data mode. Quota mode: none.
server # [    4.190416] systemd[1]: Mounted /sysroot.
server # [    4.192398] systemd[1]: Reached target Initrd Root File System.
server # [    4.196454] systemd[1]: Starting Mountpoints Configured in the Real Root...
host1 # [    4.169117] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.
host1 # [    4.178672] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...
host1 # [    4.181760] systemd[1]: Reloading...
server # [    4.227174] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    4.232407] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    4.237803] systemd[1]: Reloading...
host1 # [    4.430785] systemd[1]: Reloading finished in 250 ms.
server # [    4.485230] systemd[1]: Reloading finished in 248 ms.
host1 # [    4.464811] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...
host1 # [    4.468949] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...
host1 # [    4.478546] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    4.520447] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...
server # [    4.526859] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...
host1 # [    4.495502] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    4.531494] systemd[1]: Mounting /sysroot/nix/.ro-store...
host1 # [    4.509941] systemd[1]: Mounting /sysroot/run...
server # [    4.551983] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    4.563642] systemd[1]: Mounting /sysroot/run...
host1 # [    4.530782] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    4.590552] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    4.609406] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    4.611474] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
host1 # [    4.577707] systemd[1]: Mounting /sysroot/tmp/xchg...
host1 # [    4.580156] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
host1 # [    4.583936] systemd[1]: Finished Mountpoints Configured in the Real Root.
host1 # [    4.588696] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    4.632667] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    4.636337] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
host1 # [    4.603740] systemd[1]: Mounted /sysroot/nix/.rw-store.
host1 # [    4.639197] fuse: init (API version 7.45)
server # [    4.679629] fuse: init (API version 7.45)
host1 # [    4.648223] virtiofs virtio6: discovered new tag: nix-store
host1 # [    4.649054] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [    4.670285] systemd[1]: Mounted /sysroot/nix/.rw-store.
host1 # [    4.665820] virtiofs virtio7: discovered new tag: shared
host1 # [    4.667031] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # [    4.698290] virtiofs virtio6: discovered new tag: nix-store
server # [    4.699867] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
host1 # [    4.672759] virtiofs virtio8: discovered new tag: xchg
host1 # [    4.673532] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    4.717010] virtiofs virtio7: discovered new tag: shared
server # [    4.717816] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
host1 # [    4.677110] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    4.726740] virtiofs virtio8: discovered new tag: xchg
server # [    4.727606] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
host1 # [    4.680651] systemd[1]: Mounted /sysroot/run.
server # [    4.719900] systemd[1]: Mounted /sysroot/run.
host1 # [    4.697792] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    4.737393] systemd[1]: Mounted /sysroot/nix/.ro-store.
host1 # [    4.705621] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    4.743013] systemd[1]: Mounted /sysroot/tmp/shared.
host1 # [    4.708799] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    4.743863] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    4.754627] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [    4.724257] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [    4.725462] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [    4.732417] systemd[1]: Mounting /sysroot/nix/store...
server # [    4.778480] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    4.779939] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [    4.782122] systemd[1]: Mounted /sysroot/nix/store.
host1 # [    4.784075] systemd[1]: Reached target Initrd File Systems.
host1 # [    4.786985] systemd[1]: Starting Find NixOS closure...
host1 # [    4.803486] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
host1 # [    4.834984] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
host1 # [    4.854003] systemd[1]: Finished Find NixOS closure.
host1 # [    4.857023] systemd[1]: Reached target Initrd Default Target.
host1 # [    4.859592] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
host1 # [    4.898819] systemd[1]: Stopped target Initrd Default Target.
host1 # [    4.900460] systemd[1]: Stopped target Basic System.
host1 # [    4.901754] systemd[1]: Stopped target Initrd Root Device.
host1 # [    4.904503] systemd[1]: Stopped target Path Units.
host1 # [    4.909105] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
host1 # [    4.911081] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
host1 # [    4.914739] systemd[1]: Stopped target Slice Units.
host1 # [    4.920198] systemd[1]: Stopped target Socket Units.
host1 # [    4.922015] systemd[1]: Stopped target System Initialization.
host1 # [    4.924613] systemd[1]: Stopped target Swaps.
host1 # [    4.925809] systemd[1]: Stopped target Timer Units.
host1 # [    4.927411] systemd[1]: dbus.socket: Deactivated successfully.
host1 # [    4.933683] systemd[1]: Closed D-Bus System Message Bus Socket.
host1 # [    4.935651] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
host1 # [    4.938170] systemd[1]: Stopped Find NixOS closure.
host1 # [    4.941438] systemd[1]: Starting rw-sysroot-nix-store.service...
host1 # [    4.945234] systemd[1]: systemd-sysctl.service: Deactivated successfully.
host1 # [    4.954065] systemd[1]: Stopped Apply Kernel Variables.
host1 # [    4.958286] systemd[1]: systemd-modules-load.service: Deactivated successfully.
host1 # [    4.960489] systemd[1]: Stopped Load Kernel Modules.
host1 # [    4.967552] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
host1 # [    4.972580] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
host1 # [    4.975832] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
host1 # [    4.979242] systemd[1]: Stopped Create System Files and Directories.
host1 # [    4.984268] systemd[1]: Stopped target Local File Systems.
host1 # [    4.985178] systemd[1]: Stopped target Preparation for Local File Systems.
host1 # [    4.986171] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
host1 # [    4.988296] systemd[1]: Stopped Coldplug All udev Devices.
host1 # [    4.992318] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
host1 # [    4.993509] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [    4.994688] systemd[1]: Stopped Virtual Console Setup.
host1 # [    4.996141] systemd[1]: initrd-cleanup.service: Deactivated successfully.
host1 # [    4.999431] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
host1 # [    5.000786] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
host1 # [    5.004324] systemd[1]: Finished rw-sysroot-nix-store.service.
host1 # [    5.019255] systemd[1]: systemd-udevd.service: Deactivated successfully.
host1 # [    5.021990] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
host1 # [    5.023865] systemd[1]: systemd-udevd.service: Consumed 1.017s CPU time over 2.383s wall clock time, 19M memory peak.
host1 # [    5.028573] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
host1 # [    5.029639] systemd[1]: Closed udev Control Socket.
host1 # [    5.030355] systemd[1]: Starting Cleanup udev Database...
host1 # [    5.031145] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
host1 # [    5.033949] systemd[1]: Stopped Create Static Device Nodes in /dev.
host1 # [    5.034968] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
host1 # [    5.040203] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
host1 # [    5.041284] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
host1 # [    5.042947] systemd[1]: Stopped Create List of Static Device Nodes.
host1 # [    5.067326] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
host1 # [    5.070620] systemd[1]: Finished Cleanup udev Database.
host1 # [    5.071417] systemd[1]: Reached target Switch Root.
host1 # [    5.076260] systemd[1]: Starting NixOS Activation...
host1 # [    5.152204] initrd-nixos-activation-start[171]: booting system configuration /nix/store/jzwn7x5v01ddgs50s4c5y733a6761lww-nixos-system-host1-test
host1 # [    5.183978] initrd-nixos-activation-start[171]: running activation script...
server # [    5.449919] (udev-worker)[90]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory
server # [    5.456894] (udev-worker)[90]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory
host1 # [    5.430302] initrd-nixos-activation-start[194]: setting up /etc...
server # [    5.498616] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    5.499838] systemd[1]: Stopped Virtual Console Setup.
server # [    5.502429] systemd[1]: Stopping Virtual Console Setup...
server # [    5.504768] systemd[1]: Starting Virtual Console Setup...
server # [    5.514836] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    5.516939] systemd[1]: Stopped Virtual Console Setup.
server # [    5.523481] systemd[1]: Starting Virtual Console Setup...
server # [    5.532318] systemd[1]: Mounting /sysroot/nix/store...
server # [    5.587753] systemd[1]: Mounted /sysroot/nix/store.
server # [    5.588719] systemd[1]: Reached target Initrd File Systems.
server # [    5.592213] systemd[1]: Starting Find NixOS closure...
server # [    5.596646] systemd-vconsole-setup[157]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    5.598996] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    5.604363] systemd[1]: Finished Virtual Console Setup.
server # [    5.606387] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
host1 # [    5.579484] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
host1 # [    5.582708] systemd[1]: Finished NixOS Activation.
host1 # [    5.583965] systemd[1]: Starting Switch Root...
server # [    5.640600] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
host1 # [    5.611379] systemd[1]: Switching root.
server # [    5.650566] systemd[1]: Finished Find NixOS closure.
server # [    5.652438] systemd[1]: Reached target Initrd Default Target.
server # [    5.654814] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    5.677629] systemd[1]: Stopped target Initrd Default Target.
server # [    5.678902] systemd[1]: Stopped target Basic System.
server # [    5.679883] systemd[1]: Stopped target Initrd Root Device.
server # [    5.681080] systemd[1]: Stopped target Path Units.
server # [    5.682017] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [    5.684272] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [    5.687693] systemd[1]: Stopped target Slice Units.
server # [    5.688902] systemd[1]: Stopped target Socket Units.
server # [    5.692179] systemd[1]: Stopped target System Initialization.
server # [    5.693109] systemd[1]: Stopped target Swaps.
server # [    5.693878] systemd[1]: Stopped target Timer Units.
server # [    5.695509] systemd[1]: dbus.socket: Deactivated successfully.
server # [    5.699827] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [    5.705579] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [    5.711146] systemd[1]: Stopped Find NixOS closure.
server # [    5.712699] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    5.722133] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [    5.725685] systemd[1]: Stopped Apply Kernel Variables.
server # [    5.726996] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [    5.731249] systemd[1]: Stopped Load Kernel Modules.
server # [    5.735289] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [    5.737461] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [    5.739617] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [    5.742944] systemd[1]: Stopped Create System Files and Directories.
server # [    5.744805] systemd[1]: Stopped target Local File Systems.
server # [    5.748553] systemd[1]: Stopped target Preparation for Local File Systems.
server # [    5.749715] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [    5.752148] systemd[1]: Stopped Coldplug All udev Devices.
server # [    5.753022] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [    5.754351] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    5.755509] systemd[1]: Stopped Virtual Console Setup.
server # [    5.760258] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    5.761746] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    5.764456] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    5.768199] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    5.769147] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [    5.772179] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [    5.773442] systemd[1]: systemd-udevd.service: Consumed 1.638s CPU time over 3.083s wall clock time, 27.9M memory peak.
server # [    5.780171] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
server # [    5.781380] systemd[1]: Closed udev Control Socket.
server # [    5.782128] systemd[1]: Starting Cleanup udev Database...
server # [    5.782928] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [    5.788038] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [    5.789010] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [    5.790224] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [    5.791236] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [    5.796242] systemd[1]: Stopped Create List of Static Device Nodes.
server # [    5.814504] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [    5.818172] systemd[1]: Finished Cleanup udev Database.
server # [    5.819013] systemd[1]: Reached target Switch Root.
host1 # [    5.801356] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
server # [    5.824177] systemd[1]: Starting NixOS Activation...
server # [    5.896465] initrd-nixos-activation-start[180]: booting system configuration /nix/store/ahhd6ww9xv4am6f80mcfpn1lbb2m4mg3-nixos-system-server-test
server # [    5.927427] initrd-nixos-activation-start[180]: running activation script...
server # [    6.179635] initrd-nixos-activation-start[203]: setting up /etc...
server # [    6.296450] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [    6.299271] systemd[1]: Finished NixOS Activation.
server # [    6.304213] systemd[1]: Starting Switch Root...
server # [    6.323497] systemd[1]: Switching root.
host1 # [    6.307512] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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 # [    6.307575] systemd[1]: Detected virtualization qemu.
host1 # [    6.307630] systemd[1]: Detected architecture arm64.
host1 # [    6.317465] systemd[1]: Detected first boot.
host1 # [    6.320904] systemd[1]: Initializing machine ID from random generator.
host1 # [    6.454368] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    6.507516] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).
host1 # [    6.585578] systemd[1]: Applying preset policy.
host1 # [    6.787837] systemd[1]: Populated /etc with preset unit settings.
server # [    7.005345] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [    7.005405] systemd[1]: Detected virtualization qemu.
server # [    7.005461] systemd[1]: Detected architecture arm64.
server # [    7.005570] systemd[1]: Detected first boot.
server # [    7.018581] systemd[1]: Initializing machine ID from random generator.
host1 # [    7.013358] systemd[1]: initrd-switch-root.service: Deactivated successfully.
host1 # [    7.014164] systemd[1]: Stopped initrd-switch-root.service.
host1 # [    7.018771] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
host1 # [    7.022223] systemd[1]: Created slice Slice /system/getty.
host1 # [    7.023480] systemd[1]: Created slice User and Session Slice.
host1 # [    7.026181] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [    7.026661] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
host1 # [    7.027160] systemd[1]: Expecting device /dev/hvc0...
host1 # [    7.027649] systemd[1]: Expecting device /dev/ttyAMA0...
host1 # [    7.032058] systemd[1]: Reached target Local Encrypted Volumes.
host1 # [    7.032452] systemd[1]: Stopped target initrd-fs.target.
host1 # [    7.032969] systemd[1]: Stopped target initrd-root-fs.target.
host1 # [    7.033474] systemd[1]: Stopped target initrd-switch-root.target.
host1 # [    7.033994] systemd[1]: Reached target Virtual Machines and Containers.
host1 # [    7.034528] systemd[1]: Reached target Path Units.
host1 # [    7.035011] systemd[1]: Reached target Remote File Systems.
host1 # [    7.035504] systemd[1]: Reached target Slice Units.
host1 # [    7.042306] systemd[1]: Reached target Swaps.
host1 # [    7.044831] systemd[1]: Listening on Query the User Interactively for a Password.
host1 # [    7.046894] systemd[1]: Listening on Process Core Dump Socket.
host1 # [    7.050151] systemd[1]: Listening on Credential Encryption/Decryption.
host1 # [    7.051713] systemd[1]: Listening on Factory Reset Management.
host1 # [    7.053776] systemd[1]: Listening on Hostname Service Socket.
host1 # [    7.057772] systemd[1]: Starting Journal Log Access Socket...
host1 # [    7.059446] systemd[1]: Listening on Journal Audit Socket.
host1 # [    7.065032] systemd[1]: Listening on Console Output Muting Service Socket.
host1 # [    7.066755] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
host1 # [    7.069905] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    7.070586] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
host1 # [    7.076760] systemd[1]: Listening on Disk Repartitioning Service Socket.
host1 # [    7.077283] systemd[1]: Listening on udev Control Socket.
host1 # [    7.077947] systemd[1]: Listening on udev Varlink Socket.
host1 # [    7.082905] systemd[1]: Mounting Huge Pages File System...
host1 # [    7.086832] systemd[1]: Mounting POSIX Message Queue File System...
host1 # [    7.103914] systemd[1]: Mounting Kernel Debug File System...
host1 # [    7.110482] systemd[1]: Mounting Kernel Trace File System...
server # [    7.153864] systemd[1]: bpf-restrict-fs: LSM BPF program attached
host1 # [    7.124752] systemd[1]: Starting Create List of Static Device Nodes...
host1 # [    7.125214] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [    7.138201] systemd[1]: Mounting Kernel Configuration File System...
host1 # [    7.140829] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
host1 # [    7.149268] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
host1 # [    7.149720] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [    7.183407] systemd[1]: Mounting FUSE Control File System...
host1 # [    7.184725] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
host1 # [    7.220483] systemd[1]: Starting Journal Service...
host1 # [    7.244163] systemd[1]: Starting Load Kernel Modules...
host1 # [    7.272632] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [    7.312871] systemd[1]: Applying preset policy.
host1 # [    7.296371] systemd[1]: Starting Remount Root and Kernel File Systems...
host1 # [    7.296752] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    7.316709] systemd-journald[265]: Collecting audit messages is enabled.
host1 # [    7.338355] systemd[1]: Starting Coldplug All udev Devices...
host1 # [    7.323771] systemd[1]: Queued start job for default target Multi-User System.
host1 # [    7.325685] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [    7.327137] systemd-modules-load[266]: Module 'atkbd' is built in
host1 # [    7.349551] systemd[1]: Started Journal Service.
host1 # [    7.334272] systemd-modules-load[266]: Module 'loop' is built in
host1 # [    7.338598] systemd[1]: Listening on Journal Log Access Socket.
host1 # [    7.342492] systemd[1]: Mounted Huge Pages File System.
host1 # [    7.343541] systemd[1]: Mounted POSIX Message Queue File System.
host1 # [    7.352545] systemd[1]: Mounted Kernel Debug File System.
host1 # [    7.360119] systemd[1]: Finished Create List of Static Device Nodes.
host1 # [    7.362886] systemd[1]: Finished Load Kernel Modules.
host1 # [    7.411891] EXT4-fs (vda): re-mounted fc4e46fd-e703-4752-ad46-28d3bd24c708.
host1 # [    7.399809] systemd[1]: Starting Firewall...
host1 # [    7.403571] systemd[1]: Starting Apply Kernel Variables...
host1 # [    7.415502] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    7.419399] systemd[1]: Mounted Kernel Trace File System.
host1 # [    7.424241] systemd[1]: Mounted Kernel Configuration File System.
host1 # [    7.425158] systemd[1]: Mounted FUSE Control File System.
host1 # [    7.427917] systemd[1]: Finished Remount Root and Kernel File Systems.
host1 # [    7.461871] systemd-oomd[267]: No swap; memory pressure usage will be degraded
server # [    7.524507] systemd[1]: Populated /etc with preset unit settings.
host1 # [    7.474344] systemd[1]: Listening on Disk Image Download Service Socket.
host1 # [    7.483533] systemd[1]: Starting Flush Journal to Persistent Storage...
host1 # [    7.488979] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
host1 # [    7.524612] systemd[1]: Starting Load/Save OS Random Seed...
host1 # [    7.525546] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
host1 # [    7.526790] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
host1 # [    7.655386] systemd-journald[265]: Received client request to flush runtime journal.
server # [    7.779393] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [    7.780168] systemd[1]: Stopped initrd-switch-root.service.
host1 # [    7.732501] systemd[1]: Finished Apply Kernel Variables.
host1 # [    7.733389] systemd[1]: Finished Load/Save OS Random Seed.
host1 # [    7.734223] systemd[1]: Reached target First Boot Complete.
server # [    7.786673] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [    7.788265] systemd[1]: Created slice Slice /system/getty.
server # [    7.789338] systemd[1]: Created slice User and Session Slice.
server # [    7.789721] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
host1 # [    7.745907] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [    7.794630] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [    7.795061] systemd[1]: Expecting device /dev/hvc0...
server # [    7.795737] systemd[1]: Expecting device /dev/ttyAMA0...
server # [    7.796400] systemd[1]: Reached target Local Encrypted Volumes.
server # [    7.797045] systemd[1]: Stopped target initrd-fs.target.
server # [    7.797664] systemd[1]: Stopped target initrd-root-fs.target.
server # [    7.803437] systemd[1]: Stopped target initrd-switch-root.target.
server # [    7.803827] systemd[1]: Reached target Virtual Machines and Containers.
server # [    7.804478] systemd[1]: Reached target Path Units.
server # [    7.805091] systemd[1]: Reached target Remote File Systems.
server # [    7.805716] systemd[1]: Reached target Slice Units.
server # [    7.810688] systemd[1]: Reached target Swaps.
server # [    7.812514] systemd[1]: Listening on Query the User Interactively for a Password.
host1 # [    7.764232] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    7.816129] systemd[1]: Listening on Process Core Dump Socket.
server # [    7.817541] systemd[1]: Listening on Credential Encryption/Decryption.
server # [    7.821307] systemd[1]: Listening on Factory Reset Management.
server # [    7.821785] systemd[1]: Listening on Hostname Service Socket.
host1 # [    7.776188] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    7.826537] systemd[1]: Starting Journal Log Access Socket...
server # [    7.828852] systemd[1]: Listening on Journal Audit Socket.
server # [    7.833747] systemd[1]: Listening on Console Output Muting Service Socket.
server # [    7.836485] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [    7.837867] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [    7.842618] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [    7.847650] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [    7.848155] systemd[1]: Listening on udev Control Socket.
server # [    7.848814] systemd[1]: Listening on udev Varlink Socket.
server # [    7.853842] systemd[1]: Mounting Huge Pages File System...
server # [    7.859825] systemd[1]: Mounting POSIX Message Queue File System...
server # [    7.874077] systemd[1]: Mounting Kernel Debug File System...
server # [    7.877197] systemd[1]: Mounting Kernel Trace File System...
server # [    7.908515] systemd[1]: Starting Create List of Static Device Nodes...
server # [    7.908920] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    7.928435] systemd[1]: Mounting Kernel Configuration File System...
server # [    7.928797] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [    7.929057] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [    7.929381] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [    7.901050] systemd[1]: Finished Create Static Device Nodes in /dev.
host1 # [    7.904137] systemd[1]: Reached target Preparation for Local File Systems.
server # [    7.954524] systemd[1]: Mounting FUSE Control File System...
server # [    7.954928] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
host1 # [    7.913076] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    7.983282] systemd[1]: Starting Journal Service...
server # [    8.005085] systemd[1]: Starting Load Kernel Modules...
server # [    8.043809] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
host1 # [    8.000853] systemd[1]: Mounting /run/wrappers...
server # [    8.062723] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [    8.063134] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    8.073206] systemd[1]: Starting Coldplug All udev Devices...
server # [    8.080112] systemd[1]: Listening on Journal Log Access Socket.
server # [    8.080555] systemd[1]: Mounted Huge Pages File System.
server # [    8.081197] systemd[1]: Mounted POSIX Message Queue File System.
server # [    8.081603] systemd[1]: Mounted Kernel Debug File System.
server # [    8.088804] systemd[1]: Mounted Kernel Trace File System.
server # [    8.089484] systemd[1]: Mounted Kernel Configuration File System.
server # [    8.092269] systemd[1]: Mounted FUSE Control File System.
server # [    8.122566] systemd[1]: Finished Create List of Static Device Nodes.
server # [    8.127523] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
host1 # [    8.105307] systemd[1]: Mounted /run/wrappers.
host1 # [    8.106165] systemd[1]: Reached target Local File Systems.
host1 # [    8.110486] systemd[1]: Listening on Boot Loader Control Service Socket.
host1 # [    8.124170] systemd[1]: Starting register-nix-paths.service...
host1 # [    8.125125] systemd[1]: Starting Create SUID/SGID Wrappers...
host1 # [    8.126006] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
host1 # [    8.140801] systemd[1]: Starting Save Transient machine-id to Disk...
server # [    8.201848] systemd[1]: Finished Load Kernel Modules.
host1 # [    8.156224] systemd[1]: Starting Create System Files and Directories...
server # [    8.207716] EXT4-fs (vda): re-mounted bf7d758f-a1fd-4fc0-8b47-ed1ad787afd5.
server # [    8.211588] systemd[1]: Starting Firewall...
server # [    8.219304] systemd[1]: Starting Apply Kernel Variables...
server # [    8.223673] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [    8.224572] systemd[1]: Listening on Disk Image Download Service Socket.
server # [    8.225728] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [    8.238803] systemd[1]: Starting Load/Save OS Random Seed...
server # [    8.239204] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    8.247802] systemd-journald[273]: Collecting audit messages is enabled.
server # [    8.334153] systemd[1]: Started Journal Service.
server # [    8.327266] systemd[1]: Queued start job for default target Multi-User System.
host1 # [    8.295339] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [    8.332305] systemd[1]: systemd-journald.service: Deactivated successfully.
host1 # [    8.306905] systemd[1]: Finished Save Transient machine-id to Disk.
server # [    8.346080] systemd-modules-load[274]: Module 'atkbd' is built in
server # [    8.359745] systemd-modules-load[274]: Module 'loop' is built in
server # [    8.370723] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [    8.382157] systemd-oomd[275]: No swap; memory pressure usage will be degraded
server # [    8.383714] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    8.402550] systemd[1]: Finished Load/Save OS Random Seed.
server # [    8.413314] systemd[1]: Reached target First Boot Complete.
server # [    8.426332] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    8.429075] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [    8.433007] systemd[1]: Finished Apply Kernel Variables.
host1 # [    8.416207] systemd[1]: Finished Create System Files and Directories.
host1 # [    8.432130] systemd[1]: Starting Rebuild Journal Catalog...
host1 # [    8.440223] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [    8.494606] systemd-journald[273]: Received client request to flush runtime journal.
host1 # [    8.461339] systemd-udevd[310]: Using default interface naming scheme 'v261'.
server # [    8.576569] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [    8.587063] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    8.592648] systemd[1]: Reached target Preparation for Local File Systems.
server # [    8.597202] systemd[1]: Starting Rule-based Manager for Device Events and Files...
host1 # [    8.595198] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
host1 # [    8.650303] systemd[1]: Finished Rebuild Journal Catalog.
host1 # [    8.661052] systemd[1]: Starting Update is Completed...
server # [    8.714478] systemd-udevd[313]: Using default interface naming scheme 'v261'.
host1 # [    8.686607] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    8.764709] systemd[1]: Mounting /run/wrappers...
host1 # [    8.768622] systemd[1]: Finished Update is Completed.
server # [    8.834753] systemd[1]: Mounted /run/wrappers.
server # [    8.835637] systemd[1]: Reached target Local File Systems.
server # [    8.843045] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [    8.851015] systemd[1]: Starting register-nix-paths.service...
server # [    8.851956] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [    8.876654] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [    8.878035] systemd[1]: Starting Save Transient machine-id to Disk...
server # [    8.879006] systemd[1]: Starting Create System Files and Directories...
server # [    8.912088] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    8.990304] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [    8.998844] systemd[1]: Finished Save Transient machine-id to Disk.
server # [    9.116126] systemd[1]: Finished Create System Files and Directories.
server # [    9.128375] systemd[1]: Starting Rebuild Journal Catalog...
server # [    9.140346] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [    9.267016] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [    9.335726] systemd[1]: Finished Rebuild Journal Catalog.
server # [    9.348666] systemd[1]: Starting Update is Completed...
server # [    9.457108] systemd[1]: Finished Update is Completed.
host1 # [    9.564165] systemd[1]: Finished Coldplug All udev Devices.
host1 # [    9.591449] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
host1 # [    9.600149] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [    9.996249] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [    9.999746] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   10.449003] systemd[1]: Finished Firewall.
host1 # [   10.454107] systemd[1]: Finished register-nix-paths.service.
host1 # [   10.456157] systemd[1]: Reached target System Initialization.
host1 # [   10.459392] systemd[1]: Started Renew ACME Certificate for host1.
host1 # [   10.462415] systemd[1]: Started Discard unused filesystem blocks once a week.
host1 # [   10.463512] systemd[1]: Started Daily Cleanup of Temporary Directories.
host1 # [   10.470604] systemd[1]: Reached target Timer Units.
host1 # [   10.471399] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   10.478861] systemd[1]: Listening on Nix Daemon Socket.
host1 # [   10.479700] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
host1 # [   10.486466] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
host1 # [   10.487697] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
host1 # [   10.496466] systemd[1]: Starting D-Bus System Message Bus...
host1 # [   10.560112] systemd-ssh-issue[482]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
host1 # [   10.572302] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
host1 # [   10.573608] systemd[1]: Reached target Socket Units.
host1 # [   10.585101] systemd[1]: Finished Firewall.
host1 # [   10.660952] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'...
host1 # [   10.666723] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync'
host1 # [   10.669954] dbus-broker-launch[484]: Invalid user-name in /nix/store/x22q42php31hda5209nhwlyhgg3zcjz4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
host1 # [   10.712249] systemd[1]: Started D-Bus System Message Bus.
host1 # [   10.713279] systemd[1]: Reached target Basic System.
host1 # [   10.721907] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
host1 # [   10.728258] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   10.789499] systemd[1]: Finished Coldplug All udev Devices.
host1 # [   10.756702] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   10.766274] dbus-broker-launch[484]: Ready
host1 # [   10.772811] systemd[1]: Starting Post-Boot Actions...
host1 # [   10.810720] systemd[1]: Started Reset console on configuration changes.
host1 # [   10.836055] systemd[1]: Starting resolvconf update...
host1 # [   10.870321] systemd[1]: Starting SSH Host Keys Generation...
server # [   10.911061] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   10.958396] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
host1 # [   10.996955] acme-setup-privileged[492]: + set -euo pipefail
host1 # [   10.998007] acme-setup-privileged[492]: + cd /var/lib/acme
host1 # [   10.998841] acme-setup-privileged[492]: + chmod -R u=rwX,g=,o= .lego/accounts
server # [   11.060001] systemd[1]: Finished register-nix-paths.service.
server # [   11.063533] systemd[1]: Reached target System Initialization.
server # [   11.068789] systemd[1]: Started Renew ACME Certificate for server.
server # [   11.071603] systemd[1]: Started Discard unused filesystem blocks once a week.
host1 # [   11.037607] acme-setup-privileged[492]: + chown -R acme .lego/accounts
server # [   11.074881] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   11.078956] systemd[1]: Reached target Timer Units.
server # [   11.083564] systemd[1]: Listening on D-Bus System Message Bus Socket.
host1 # [   11.055218] systemd[1]: Finished Post-Boot Actions.
server # [   11.093785] systemd[1]: Listening on Nix Daemon Socket.
server # [   11.094685] systemd[1]: Listening on Nix worker-protocol over gRPC.
server # [   11.095634] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
host1 # [   11.067135] acme-setup-privileged[492]: + for fixpath in host1 .lego/host1
host1 # [   11.072214] acme-setup-privileged[492]: + '[' -d host1 ']'
host1 # [   11.073058] acme-setup-privileged[492]: + for fixpath in host1 .lego/host1
server # [   11.108212] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...
host1 # [   11.074020] acme-setup-privileged[492]: + '[' -d .lego/host1 ']'
server # [   11.113616] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   11.124227] systemd[1]: Starting D-Bus System Message Bus...
host1 # [   11.094282] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   11.131610] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   11.133249] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   11.147157] nsncd[494]: Oct 27 20:05:04.814 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   11.194492] systemd-ssh-issue[499]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.
server # [   11.202030] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
server # [   11.207442] systemd[1]: Reached target Socket Units.
host1 # [   11.177014] systemd[1]: Starting User Login Management...
server # [   11.238366] dbus-broker-launch[500]: Looking up NSS user entry for 'systemd-timesync'...
host1 # [   11.205879] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   11.244725] dbus-broker-launch[500]: NSS returned no entry for 'systemd-timesync'
server # [   11.246223] dbus-broker-launch[500]: Invalid user-name in /nix/store/5rbqnlcwa36b5kh8szwyp1z2glsjs0km-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   11.265166] systemd[1]: Started D-Bus System Message Bus.
server # [   11.266087] systemd[1]: Reached target Basic System.
server # [   11.277512] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...
server # [   11.285740] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   11.303431] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   11.317210] systemd[1]: Starting Post-Boot Actions...
server # [   11.340447] systemd[1]: Started Reset console on configuration changes.
server # [   11.348338] systemd[1]: Starting resolvconf update...
server # [   11.357379] systemd[1]: Starting SSH Host Keys Generation...
server # [   11.369187] systemd[1]: Starting step-ca-pki.service...
host1 # [   11.395223] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
host1 # [   11.459143] acme-setup-start[510]: + set -euo pipefail
host1 # [   11.464470] acme-setup-start[510]: + test -e ca/key.pem
server # [   11.500974] dbus-broker-launch[500]: Ready
host1 # [   11.469362] acme-setup-start[510]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
host1 # [   11.492056] systemd-logind[526]: New seat seat0.
host1 # [   11.504088] systemd[1]: Started User Login Management.
host1 # [   11.515863] systemd[1]: Starting linger-users.service...
server # [   11.553282] systemd[1]: Finished Post-Boot Actions.
server # [   11.584372] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [   11.616608] acme-setup-privileged[502]: + set -euo pipefail
server # [   11.629258] acme-setup-privileged[502]: + cd /var/lib/acme
host1 # [   11.596248] systemd[1]: Stopped target Host and Network Name Lookups.
host1 # [   11.597373] systemd[1]: Stopping Host and Network Name Lookups...
host1 # [   11.598281] systemd[1]: Stopped target User and Group Name Lookups.
host1 # [   11.599175] systemd[1]: Stopping User and Group Name Lookups...
server # [   11.642305] acme-setup-privileged[502]: + chmod -R u=rwX,g=,o= .lego/accounts
server # [   11.652277] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   11.624774] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
host1 # [   11.625949] systemd[1]: nscd.service: Deactivated successfully.
server # [   11.660148] nsncd[505]: Oct 27 20:05:05.303 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   11.626902] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   11.676604] acme-setup-privileged[502]: + chown -R acme .lego/accounts
server # [   11.688347] systemd[1]: Reached target Host and Network Name Lookups.
server # [   11.696718] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   11.664272] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   11.708527] acme-setup-privileged[502]: + for fixpath in server .lego/server
host1 # [   11.675218] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
server # [   11.721452] acme-setup-privileged[502]: + '[' -d server ']'
host1 # [   11.688110] systemd[1]: linger-users.service: Deactivated successfully.
server # [   11.725931] acme-setup-privileged[502]: + for fixpath in server .lego/server
host1 # [   11.693429] systemd[1]: Finished linger-users.service.
server # [   11.739924] acme-setup-privileged[502]: + '[' -d .lego/server ']'
server # [   11.744479] systemd[1]: Starting User Login Management...
server # [   11.752366] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   11.769579] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
host1 # [   11.740193] systemd[1]: Starting Ensure certificate for host1...
server # [   11.783693] systemd[1]: Started backdoor.service.
host1 # [   11.784769] systemd[1]: Started Name Service Cache Daemon (nsncd).
host1 # [   11.785831] systemd[1]: Reached target Host and Network Name Lookups.
host1 # [   11.786865] systemd[1]: Reached target User and Group Name Lookups.
host1 # [   11.802390] nsncd[592]: Oct 27 20:05:05.506 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
host1 # [   11.828431] systemd[1]: Finished resolvconf update.
host1 # [   11.836597] systemd[1]: Reached target Preparation for Network.
host1 # [   11.847290] systemd[1]: Starting DHCP Client...
host1 # [   11.854048] systemd[1]: Starting Extra networking commands....
host1 # [   11.928933] acme-host1-start[602]: Waiting to acquire lock in /run/acme/
host1 # [   11.960572] acme-host1-start[602]: + '[' -e out/acme-success ']'
host1 # [   11.961646] acme-host1-start[602]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=
host1 # [   12.019755] acme-host1-start[637]: + cd host1
host1 # [   12.022704] acme-host1-start[637]: + cp -vp cert.pem ../out/cert.pem
server # connecting to host...
host1 # [   12.045949] acme-host1-start[639]: 'cert.pem' -> '../out/cert.pem'
host1 # [   12.057928] acme-host1-start[637]: + cp -vp key.pem ../out/key.pem
host1 # [   12.059040] acme-host1-start[637]: 'key.pem' -> '../out/key.pem'
host1 # [   12.066812] acme-host1-start[602]: + cat out/cert.pem ca/cert.pem
host1 # [   12.084670] acme-host1-start[602]: + cp ca/cert.pem out/chain.pem
server # [   12.123000] systemd-logind[537]: New seat seat0.
server: Guest shell says: b'Spawning backdoor root shell...\n'
server # [   12.145514] systemd[1]: Started User Login Management.
host1 # [   12.110760] acme-host1-start[602]: + cat out/key.pem out/fullchain.pem
server # [   12.156589] acme-setup-start[546]: + set -euo pipefail
host1 # [   12.138463] acme-host1-start[602]: + for fixpath in out certificates
server: connected to guest root shell
host1 # [   12.139469] acme-host1-start[602]: + '[' -d out ']'
server: (connecting took 12.50 seconds)
host1 # [   12.148368] acme-host1-start[602]: + chmod -R u=rwX,g=rX,o= out
server: (finished: waiting for the VM to finish booting, in 12.50 seconds)
server # [   12.157455] acme-setup-start[546]: + test -e ca/key.pem
server # [   12.158139] acme-setup-start[546]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local
server # [   12.177607] systemd[1]: Starting linger-users.service...
host1 # [   12.181721] acme-host1-start[602]: + chown -R acme:acme out
host1 # [   12.243019] acme-host1-start[602]: + for fixpath in out certificates
host1 # [   12.252635] acme-host1-start[602]: + '[' -d certificates ']'
server # [   12.288580] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   12.289695] systemd[1]: Stopping Host and Network Name Lookups...
server # [   12.290625] systemd[1]: Stopped target User and Group Name Lookups.
server # [   12.291518] systemd[1]: Stopping User and Group Name Lookups...
host1 # [   12.258463] systemd[1]: Finished Ensure certificate for host1.
server # [   12.334271] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   12.342055] systemd[1]: nscd.service: Deactivated successfully.
server # [   12.342958] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   12.343829] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
host1 # [   12.309876] dhcpcd[638]: dhcpcd-10.3.2 starting
host1 # [   12.333415] dhcpcd[693]: dev: loaded udev
host1 # [   12.337216] dhcpcd[693]: no valid interfaces found
server # [   12.371971] systemd[1]: linger-users.service: Deactivated successfully.
host1 # [   12.344090] dhcpcd[693]: no valid interfaces found
server # [   12.383844] systemd[1]: Finished linger-users.service.
server # [   12.424331] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.
server # [   12.436368] systemd[1]: Starting Ensure certificate for server...
server # [   12.570607] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   12.585200] nsncd[620]: Oct 27 20:05:06.251 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   12.587413] systemd[1]: Reached target Host and Network Name Lookups.
server # [   12.612399] systemd[1]: Reached target User and Group Name Lookups.
server # [   12.650928] systemd[1]: Finished resolvconf update.
server # [   12.651854] systemd[1]: Reached target Preparation for Network.
server # [   12.667653] systemd[1]: Starting DHCP Client...
host1 # [   12.636597] systemd[1]: Finished Extra networking commands..
host1 # [   12.642975] systemd[1]: Reached target Network.
server # [   12.679158] systemd[1]: Starting Extra networking commands....
host1 # [   12.652950] systemd[1]: Starting Permit User Sessions...
server # [   12.814943] step-ca-pki-start[524]: Your certificate has been saved in root_ca.crt.
server # [   12.835356] step-ca-pki-start[524]: Your private key has been saved in root_ca.key.
server # [   12.855065] acme-server-start[635]: Waiting to acquire lock in /run/acme/
host1 # [   12.837110] systemd[1]: Finished Permit User Sessions.
host1 # [   12.852257] systemd[1]: Started Getty on tty1.
host1 # [   12.853532] systemd[1]: Reached target Login Prompts.
server # [   12.904660] acme-server-start[635]: + '[' -e out/acme-success ']'
server # [   12.905677] acme-server-start[635]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=
server # [   13.002315] acme-server-start[686]: + cd server
server # [   13.003131] acme-server-start[686]: + cp -vp cert.pem ../out/cert.pem
host1 # [   12.977582] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
host1 # [   12.990439] systemd[1]: Starting Virtual Console Setup...
server # [   13.038862] acme-server-start[687]: 'cert.pem' -> '../out/cert.pem'
server # [   13.039934] acme-server-start[686]: + cp -vp key.pem ../out/key.pem
server # [   13.052947] acme-server-start[686]: 'key.pem' -> '../out/key.pem'
server # [   13.064157] acme-server-start[635]: + cat out/cert.pem ca/cert.pem
host1 # [   13.028719] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   13.039109] systemd[1]: Stopped Virtual Console Setup.
host1 # [   13.044391] systemd[1]: Starting Virtual Console Setup...
server # [   13.085487] acme-server-start[635]: + cp ca/cert.pem out/chain.pem
server # [   13.116292] acme-server-start[635]: + cat out/key.pem out/fullchain.pem
server # [   13.139319] acme-server-start[635]: + for fixpath in out certificates
server # [   13.143168] acme-server-start[635]: + '[' -d out ']'
server # [   13.143897] acme-server-start[635]: + chmod -R u=rwX,g=rX,o= out
server # [   13.160482] acme-server-start[635]: + chown -R acme:nix-grpc-daemon out
server # [   13.176262] step-ca-pki-start[669]: Your certificate has been saved in intermediate_ca.crt.
server # [   13.190431] step-ca-pki-start[669]: Your private key has been saved in intermediate_ca.key.
server # [   13.205171] acme-server-start[635]: + for fixpath in out certificates
server # [   13.206254] acme-server-start[635]: + '[' -d certificates ']'
server # [   13.220626] systemd[1]: Finished Ensure certificate for server.
server # [   13.266090] systemd[1]: Finished step-ca-pki.service.
server # [   13.298429] dhcpcd[676]: dhcpcd-10.3.2 starting
server # [   13.329559] dhcpcd[724]: dev: loaded udev
server # [   13.410918] 8021q: 802.1Q VLAN Support v1.8
server # [   13.405151] (udev-worker)[624]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   13.399897] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [   13.492555] (udev-worker)[629]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   13.494940] (udev-worker)[629]: Network interface NamePolicy= disabled on kernel command line.
host1 # [   13.472502] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [   13.537540] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   13.488154] systemd[1]: Started backdoor.service.
server # [   13.559155] systemd[1]: Finished Extra networking commands..
server # [   13.563197] systemd[1]: Reached target Network.
server # [   13.563947] systemd[1]: Starting Permit User Sessions...
server # [   13.598336] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   13.598881] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   13.603986] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   13.604315] cfg80211: failed to load regulatory.db
host1 # connecting to host...
server # [   13.661657] systemd[1]: Finished Permit User Sessions.
server # [   13.669566] systemd[1]: Started Getty on tty1.
server # [   13.670413] systemd[1]: Reached target Login Prompts.
host1 # [   13.695209] 8021q: 802.1Q VLAN Support v1.8
host1 # [   13.705244] (udev-worker)[646]: Network interface NamePolicy= disabled on kernel command line.
server # [   13.761156] 8021q: adding VLAN 0 to HW filter on device eth0
host1 # [   13.713824] (udev-worker)[679]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   13.750827] dhcpcd[724]: eth0: waiting for carrier
server # [   13.751652] dhcpcd[724]: eth0: carrier acquired
host1 # [   13.728284] (udev-worker)[679]: Network interface NamePolicy= disabled on kernel command line.
server # [   13.777851] dhcpcd[724]: DUID 00:01:00:01:32:73:c0:73:52:54:00:12:34:56
server # [   13.778910] dhcpcd[724]: eth0: IAID 00:12:34:56
server # [   13.779574] dhcpcd[724]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   13.872071] cfg80211: Loading compiled-in X.509 certificates for regulatory database
host1 # [   13.920297] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
host1 # [   13.920790] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
host1 # [   13.922540] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
host1 # [   13.922836] cfg80211: failed to load regulatory.db
server # [   14.041738] dhcpcd[724]: eth0: IAID 00:12:34:56
server # [   14.136102] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   14.140469] systemd[1]: Starting Address configuration of eth1...
server # [   14.160562] systemd-logind[537]: Watching system buttons on /dev/input/event0 (gpio-keys)
host1 # [   14.194289] systemd-logind[526]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [   14.248394] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   14.250536] network-addresses-eth1-start[770]: adding address 192.168.1.2/24... done
server # [   14.266335] network-addresses-eth1-start[770]: adding address 2001:db8:1::2/64... done
server # [   14.288111] systemd[1]: Finished Address configuration of eth1.
host1 # [   14.269532] systemd[1]: Condition check resulted in Virtio network device being skipped.
host1 # [   14.274991] systemd[1]: Starting Address configuration of eth1...
host1 # [   14.390710] dhcpcd[693]: eth0: waiting for carrier
host1 # [   14.409534] 8021q: adding VLAN 0 to HW filter on device eth0
host1 # [   14.397252] dhcpcd[693]: eth0: carrier acquired
host1 # [   14.434778] 8021q: adding VLAN 0 to HW filter on device eth1
host1 # [   14.423250] dhcpcd[693]: DUID 00:01:00:01:32:73:c0:74:52:54:00:12:34:56
host1 # [   14.425261] dhcpcd[693]: eth0: IAID 00:12:34:56
host1 # [   14.425964] dhcpcd[693]: eth0: adding address fe80::5054:ff:fe12:3456
host1 # [   14.446782] network-addresses-eth1-start[730]: adding address 192.168.1.1/24... done
host1 # [   14.477571] network-addresses-eth1-start[730]: adding address 2001:db8:1::1/64... done
host1 # [   14.506964] systemd[1]: Finished Address configuration of eth1.
host1 # [   14.562845] mousedev: PS/2 mouse device common for all mice
server # [   14.595910] mousedev: PS/2 mouse device common for all mice
host1 # [   14.625203] systemd-vconsole-setup[711]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   14.669010] systemd-logind[537]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
host1 # [   14.639669] systemd[1]: Finished Virtual Console Setup.
host1 # [   14.953963] systemd-logind[526]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   15.419594] sshd-keygen-start[553]: Generating public/private rsa key pair.
host1 # [   15.386840] dhcpcd[693]: eth0: soliciting a DHCP lease
server # [   15.421544] sshd-keygen-start[553]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
server # [   15.422783] sshd-keygen-start[553]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
server # [   15.427694] sshd-keygen-start[553]: The key fingerprint is:
host1 # [   15.394004] dhcpcd[693]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   15.429720] sshd-keygen-start[553]: SHA256:91bPnnexEHSqYlF2J6+SiB2PYVw6G0UaJu+/dLx5hho root@server
server # [   15.430934] sshd-keygen-start[553]: The key's randomart image is:
server # [   15.431776] sshd-keygen-start[553]: +---[RSA 4096]----+
host1 # [   15.401409] dhcpcd[693]: eth0: probing address 10.0.2.15/24
server # [   15.440051] sshd-keygen-start[553]: |       . o..     |
server # [   15.440862] sshd-keygen-start[553]: |        + o= + o |
server # [   15.441628] sshd-keygen-start[553]: |        .o* o *  |
server # [   15.442367] sshd-keygen-start[553]: |        .X   o . |
server # [   15.443101] sshd-keygen-start[553]: |        S.% o +  |
server # [   15.443830] sshd-keygen-start[553]: |       . O.*.+ + |
server # [   15.454144] sshd-keygen-start[553]: |        . .E+oo =|
server # [   15.454999] sshd-keygen-start[553]: |          ..+.o=+|
server # [   15.455745] sshd-keygen-start[553]: |           o.oo.+|
server # [   15.461958] sshd-keygen-start[553]: +----[SHA256]-----+
server # [   15.484404] sshd-keygen-start[810]: Generating public/private ed25519 key pair.
server # [   15.485579] sshd-keygen-start[810]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
server # [   15.486825] sshd-keygen-start[810]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
server # [   15.496288] sshd-keygen-start[810]: The key fingerprint is:
server # [   15.503195] sshd-keygen-start[810]: SHA256:HAkiNzrlrQjg6FotyukNiw/ny8uRmpHdshwFZ7PJhKQ root@server
server # [   15.508844] sshd-keygen-start[810]: The key's randomart image is:
server # [   15.509842] sshd-keygen-start[810]: +--[ED25519 256]--+
server # [   15.510585] sshd-keygen-start[810]: |. o = .          |
server # [   15.511318] sshd-keygen-start[810]: |+o B + . .       |
server # [   15.517295] sshd-keygen-start[810]: |E.= * . o        |
server # [   15.518141] sshd-keygen-start[810]: |.. X = . .       |
server # [   15.518946] sshd-keygen-start[810]: | .+ B   S        |
server # [   15.519696] sshd-keygen-start[810]: |o=.=             |
server # [   15.524206] sshd-keygen-start[810]: |*+B .            |
server # [   15.525027] sshd-keygen-start[810]: |o@+=             |
server # [   15.525868] sshd-keygen-start[810]: |++X+             |
server # [   15.526628] sshd-keygen-start[810]: +----[SHA256]-----+
server # [   15.535297] systemd[1]: sshd-keygen.service: Deactivated successfully.
server # [   15.541268] systemd[1]: Finished SSH Host Keys Generation.
server # [   15.543451] systemd[1]: sshd-keygen.service: Consumed 1.101s CPU time over 4.155s wall clock time, 5M memory peak.
server # [   15.549604] systemd[1]: Starting SSH Daemon...
server # [   15.584147] sshd[812]: Server listening on 0.0.0.0 port 22.
server # [   15.585114] systemd[1]: Started SSH Daemon.
server # [   15.585801] sshd[812]: Server listening on :: port 22.
server # [   15.886532] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   15.956635] dhcpcd[724]: eth0: soliciting an IPv6 router
server # [   15.957581] dhcpcd[724]: eth0: Router Advertisement from fe80::2
server # [   15.958438] dhcpcd[724]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   15.959361] dhcpcd[724]: eth0: adding route to fec0::/64
server # [   15.964540] dhcpcd[724]: eth0: adding default route via fe80::2
server # [   15.965528] dhcpcd[724]: eth0: soliciting a DHCP lease
server # [   15.966319] dhcpcd[724]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   15.972254] dhcpcd[724]: eth0: probing address 10.0.2.15/24
server # [   16.258797] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   16.267868] systemd[1]: Starting Virtual Console Setup...
server # [   16.296813] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   16.303389] systemd[1]: Stopped Virtual Console Setup.
server # [   16.308359] systemd[1]: Starting Virtual Console Setup...
server # [   16.374783] systemd-logind[537]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   16.436754] systemd-vconsole-setup[829]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   16.440819] systemd[1]: Finished Virtual Console Setup.
host1 # [   16.772734] dhcpcd[693]: eth0: soliciting an IPv6 router
host1 # [   16.774039] dhcpcd[693]: eth0: Router Advertisement from fe80::2
host1 # [   16.774968] dhcpcd[693]: eth0: adding address fec0::5054:ff:fe12:3456/64
host1 # [   16.775889] dhcpcd[693]: eth0: adding route to fec0::/64
host1 # [   16.780929] dhcpcd[693]: eth0: adding default route via fe80::2
host1 # [   17.027290] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
host1 # [   17.031788] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   17.038755] systemd[1]: Stopped Virtual Console Setup.
host1 # [   17.039544] systemd[1]: Stopping Virtual Console Setup...
host1 # [   17.052155] systemd[1]: Starting Virtual Console Setup...
host1 # [   17.083253] systemd-logind[526]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
host1 # [   17.088307] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
host1 # [   17.089426] systemd[1]: Stopped Virtual Console Setup.
host1 # [   17.095206] systemd[1]: Starting Virtual Console Setup...
host1 # [   17.211155] sshd-keygen-start[542]: Generating public/private rsa key pair.
host1 # [   17.213997] sshd-keygen-start[542]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
host1 # [   17.215262] sshd-keygen-start[542]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
host1 # [   17.217673] sshd-keygen-start[542]: The key fingerprint is:
host1 # [   17.218539] sshd-keygen-start[542]: SHA256:zbH3YjyuAKVGRm7ovBDBW1Cp6kqBvuylC0WBCxUXNPQ root@host1
host1 # [   17.219722] sshd-keygen-start[542]: The key's randomart image is:
host1 # [   17.222086] sshd-keygen-start[542]: +---[RSA 4096]----+
host1 # [   17.222860] sshd-keygen-start[542]: | +**Bo.          |
host1 # [   17.223587] sshd-keygen-start[542]: |o .+o*           |
host1 # [   17.226661] sshd-keygen-start[542]: |..o+. E . .      |
host1 # [   17.227424] sshd-keygen-start[542]: |o.o+ + o o o     |
host1 # [   17.230507] sshd-keygen-start[542]: |.oo o + S + .    |
host1 # [   17.231283] sshd-keygen-start[542]: |o... o .   o .   |
host1 # [   17.236127] sshd-keygen-start[542]: |oo ..   .   = .  |
host1 # [   17.236927] sshd-keygen-start[542]: |+.+      . o o   |
host1 # [   17.237656] sshd-keygen-start[542]: |+*.       ...    |
host1 # [   17.238407] sshd-keygen-start[542]: +----[SHA256]-----+
host1 # [   17.263168] sshd-keygen-start[776]: Generating public/private ed25519 key pair.
host1 # [   17.264503] sshd-keygen-start[776]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
host1 # [   17.265770] sshd-keygen-start[776]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
host1 # [   17.267089] sshd-keygen-start[776]: The key fingerprint is:
host1 # [   17.267860] sshd-keygen-start[776]: SHA256:vrAplufpihO0PzkfzOkYHuCfQLkW3kO8VLmJ5h9aZf0 root@host1
host1 # [   17.272116] sshd-keygen-start[776]: The key's randomart image is:
host1 # [   17.273010] sshd-keygen-start[776]: +--[ED25519 256]--+
host1 # [   17.273736] sshd-keygen-start[776]: |                 |
host1 # [   17.274529] sshd-keygen-start[776]: |       .         |
host1 # [   17.275255] sshd-keygen-start[776]: |      o          |
host1 # [   17.275977] sshd-keygen-start[776]: |  .o o o .       |
host1 # [   17.284241] sshd-keygen-start[776]: | .=.* o S .      |
host1 # [   17.285044] sshd-keygen-start[776]: | +oX + =   .     |
host1 # [   17.285771] sshd-keygen-start[776]: |  *oBoO .   E    |
host1 # [   17.286511] sshd-keygen-start[776]: | ..=O@.B .       |
host1 # [   17.287277] sshd-keygen-start[776]: |  .oBXX .        |
host1 # [   17.289518] sshd-keygen-start[776]: +----[SHA256]-----+
host1 # [   17.290526] systemd[1]: sshd-keygen.service: Deactivated successfully.
host1 # [   17.291472] systemd[1]: Finished SSH Host Keys Generation.
host1 # [   17.292836] systemd[1]: sshd-keygen.service: Consumed 2.452s CPU time over 6.401s wall clock time, 3.2M memory peak.
host1 # [   17.294336] systemd[1]: Starting SSH Daemon...
host1 # [   17.324829] sshd[778]: Server listening on 0.0.0.0 port 22.
host1 # [   17.327086] sshd[778]: Server listening on :: port 22.
host1 # [   17.327897] systemd[1]: Started SSH Daemon.
host1 # [   17.376718] systemd-vconsole-setup[769]: Configuration of first virtual console was skipped, ignoring remaining ones.
host1 # [   17.380182] systemd[1]: Finished Virtual Console Setup.
host1 # [   21.050397] dhcpcd[693]: eth0: leased 10.0.2.15 for 86400 seconds
host1 # [   21.052313] dhcpcd[693]: eth0: adding route to 10.0.2.0/24
host1 # [   21.053545] dhcpcd[693]: eth0: adding default route via 10.0.2.2
host1 # [   21.156095] systemd[1]: Started DHCP Client.
host1 # [   21.159479] systemd[1]: Reached target Network is Online.
host1 # [   21.161595] systemd[1]: Starting fetch-ca-root.service...
host1 # [   21.209059] fetch-ca-root-start[843]: curl: (7) Failed to connect to server:8443 after 7 ms: Could not connect to server
server # [   21.528385] dhcpcd[724]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   21.530573] dhcpcd[724]: eth0: adding route to 10.0.2.0/24
server # [   21.531817] dhcpcd[724]: eth0: adding default route via 10.0.2.2
server # [   21.619696] systemd[1]: Started DHCP Client.
server # [   21.624564] systemd[1]: Reached target Network is Online.
server # [   21.627068] systemd[1]: Starting step-ca service...
server # [   21.892749] step-ca[938]: badger 2026/10/27 20:05:15 INFO: All 0 tables opened in 0s
server # [   21.906925] step-ca[938]: 2026/10/27 20:05:15 Building new tls configuration using step-ca x509 Signer Interface
server # [   21.919753] step-ca[938]: 2026/10/27 20:05:15 Starting Smallstep CA/0.30.2 (linux/arm64)
server # [   21.924940] step-ca[938]: 2026/10/27 20:05:15 Documentation: https://u.step.sm/docs/ca
server # [   21.926158] step-ca[938]: 2026/10/27 20:05:15 Community Discord: https://u.step.sm/discord
server # [   21.927260] step-ca[938]: 2026/10/27 20:05:15 Config file: /etc/smallstep/ca.json
server # [   21.930161] step-ca[938]: 2026/10/27 20:05:15 The primary server URL is https://server:8443
server # [   21.934611] step-ca[938]: 2026/10/27 20:05:15 Root certificates are available at https://server:8443/roots.pem
server # [   21.935998] step-ca[938]: 2026/10/27 20:05:15 X.509 Root Fingerprint: bd3c04f190b772e74e8a0975d0a730403a27c849883c7b0006e0304e8edeb7fc
server # [   21.940136] step-ca[938]: 2026/10/27 20:05:15 Serving HTTPS on 0.0.0.0:8443 ...
server # [   21.941359] systemd[1]: Started step-ca service.
server # [   21.942057] systemd[1]: Reached target Multi-User System.
server # [   21.942833] systemd[1]: Starting Order (and renew) ACME certificate for server...
server # [   21.990537] acme-order-renew-server-start[945]: Waiting to acquire lock in /run/acme/
server # [   21.996791] acme-order-renew-server-start[945]: + set -euo pipefail
server # [   21.997823] acme-order-renew-server-start[945]: + exec
server # [   21.998578] acme-order-renew-server-start[945]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 11
server # [   22.002061] acme-order-renew-server-start[954]: ++ find accounts -path '*/keys/*.key' -print -quit
server # [   22.008709] acme-order-renew-server-start[945]: + '[' -n '' ']'
server # [   22.009652] acme-order-renew-server-start[945]: + exec
server # [   22.010414] acme-order-renew-server-start[945]: + '[' -e certificates/server.key ']'
server # [   22.011480] acme-order-renew-server-start[945]: + 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 # [   22.222511] acme-order-renew-server-start[955]: 2026-10-27T20:05:15.906018960Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
server # [   22.238937] acme-order-renew-server-start[955]: 2026-10-27T20:05:15.924078920Z INFO  Registering the account. email=root@example.org
host1 # [   22.228943] systemd[1]: Finished fetch-ca-root.service.
host1 # [   22.231796] systemd[1]: Reached target Multi-User System.
host1 # [   22.238897] systemd[1]: Starting Order (and renew) ACME certificate for host1...
server # [   22.333244] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.017328300Z WARN  !!!! HEADS UP !!!!
server # [   22.335439] acme-order-renew-server-start[955]: Your account credentials have been saved in your
server # [   22.338124] acme-order-renew-server-start[955]: configuration directory at "accounts".
server # [   22.339987] acme-order-renew-server-start[955]: You should make a secure backup of this folder now. This
server # [   22.342201] acme-order-renew-server-start[955]: configuration directory will also contain private keys
server # [   22.344896] acme-order-renew-server-start[955]: generated by lego and certificates obtained from the ACME
host1 # [   22.312438] acme-order-renew-host1-start[847]: Waiting to acquire lock in /run/acme/
server # [   22.346892] acme-order-renew-server-start[955]: server. Making regular backups of this folder is ideal.
server # [   22.348957] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.017637520Z INFO  Obtaining bundled SAN certificate. domains=server
host1 # [   22.319793] acme-order-renew-host1-start[847]: + set -euo pipefail
host1 # [   22.321080] acme-order-renew-host1-start[847]: + exec
host1 # [   22.321892] acme-order-renew-host1-start[847]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 11
host1 # [   22.325650] acme-order-renew-host1-start[855]: ++ find accounts -path '*/keys/*.key' -print -quit
host1 # [   22.331927] acme-order-renew-host1-start[847]: + '[' -n '' ']'
host1 # [   22.333813] acme-order-renew-host1-start[847]: + exec
host1 # [   22.334868] acme-order-renew-host1-start[847]: + '[' -e certificates/host1.key ']'
host1 # [   22.336131] acme-order-renew-host1-start[847]: + 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
server # [   22.425579] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.109420460Z INFO  Use solver. domain=server type=http-01
server # [   22.428943] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.109486980Z INFO  http01: Trying to solve HTTP-01. domain=server
server # [   22.440126] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.124622440Z INFO  The server validated our request. domain=server
server # [   22.442699] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.124729520Z INFO  Validations succeeded; requesting certificates. domains=server
server # [   22.465438] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.146116300Z INFO  Server responded with a certificate. domains=server
server # [   22.468475] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.146338620Z INFO  Writing file. filepath=certificates/server.crt
server # [   22.470988] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.146558160Z INFO  Writing file. filepath=certificates/server.issuer.crt
server # [   22.474201] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.146652540Z INFO  Writing file. filepath=certificates/server.key
server # [   22.481490] acme-order-renew-server-start[955]: 2026-10-27T20:05:16.146864720Z INFO  Writing file. filepath=certificates/server.json
server # [   22.484840] acme-order-renew-server-start[945]: + touch out/acme-success
server # [   22.486217] acme-order-renew-server-start[945]: + cmp -s certificates/server.crt out/fullchain.pem
host1 # [   22.454654] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.172279260Z INFO  Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key
server # [   22.491388] acme-order-renew-server-start[945]: + touch out/renewed
server # [   22.496508] acme-order-renew-server-start[945]: + echo Installing new certificate
server # [   22.499503] acme-order-renew-server-start[945]: Installing new certificate
server # [   22.503182] acme-order-renew-server-start[945]: + cp -vp certificates/server.crt out/fullchain.pem
host1 # [   22.468730] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.186669200Z INFO  Registering the account. email=root@example.org
server # [   22.508210] acme-order-renew-server-start[964]: 'certificates/server.crt' -> 'out/fullchain.pem'
server # [   22.513195] acme-order-renew-server-start[945]: + cp -vp certificates/server.key out/key.pem
server # [   22.517559] acme-order-renew-server-start[965]: 'certificates/server.key' -> 'out/key.pem'
server # [   22.520143] acme-order-renew-server-start[945]: + cp -vp certificates/server.issuer.crt out/chain.pem
host1 # [   22.490381] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.208405340Z WARN  !!!! HEADS UP !!!!
server # [   22.526028] acme-order-renew-server-start[966]: 'certificates/server.issuer.crt' -> 'out/chain.pem'
host1 # [   22.491703] acme-order-renew-host1-start[856]: Your account credentials have been saved in your
server # [   22.527876] acme-order-renew-server-start[945]: + ln -sf fullchain.pem out/cert.pem
host1 # [   22.493778] acme-order-renew-host1-start[856]: configuration directory at "accounts".
host1 # [   22.494870] acme-order-renew-host1-start[856]: You should make a secure backup of this folder now. This
host1 # [   22.496185] acme-order-renew-host1-start[856]: configuration directory will also contain private keys
host1 # [   22.497396] acme-order-renew-host1-start[856]: generated by lego and certificates obtained from the ACME
host1 # [   22.498696] acme-order-renew-host1-start[856]: server. Making regular backups of this folder is ideal.
host1 # [   22.499936] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.211313700Z INFO  Obtaining bundled SAN certificate. domains=host1
server # [   22.535464] acme-order-renew-server-start[945]: + cat out/key.pem out/fullchain.pem
server # [   22.543411] acme-order-renew-server-start[945]: + for fixpath in out certificates
server # [   22.547697] acme-order-renew-server-start[945]: + '[' -d out ']'
server # [   22.551089] acme-order-renew-server-start[945]: + chmod -R u=rwX,g=rX,o= out
server # [   22.555848] acme-order-renew-server-start[945]: + chown -R acme:nix-grpc-daemon out
server # [   22.569153] acme-order-renew-server-start[945]: + for fixpath in out certificates
server # [   22.570356] acme-order-renew-server-start[945]: + '[' -d certificates ']'
server # [   22.571292] acme-order-renew-server-start[945]: + chmod -R u=rwX,g=rX,o= certificates
server # [   22.579955] acme-order-renew-server-start[945]: + chown -R acme:nix-grpc-daemon certificates
server # [   22.592689] acme-order-renew-server-start[945]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   22.577857] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.294494660Z INFO  Use solver. domain=host1 type=http-01
host1 # [   22.580809] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.294553600Z INFO  http01: Trying to solve HTTP-01. domain=host1
server: (finished: waiting for unit step-ca.service, in 22.93 seconds)
server: waiting for unit nix-grpc-daemon.socket
host1 # [   22.592150] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.309266560Z INFO  The server validated our request. domain=host1
host1 # [   22.594727] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.309388660Z INFO  Validations succeeded; requesting certificates. domains=host1
host1 # [   22.623676] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.341121900Z INFO  Server responded with a certificate. domains=host1
host1 # [   22.630877] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.341241660Z INFO  Writing file. filepath=certificates/host1.crt
host1 # [   22.634204] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.341431640Z INFO  Writing file. filepath=certificates/host1.issuer.crt
host1 # [   22.637297] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.341522940Z INFO  Writing file. filepath=certificates/host1.key
host1 # [   22.639726] acme-order-renew-host1-start[856]: 2026-10-27T20:05:16.341682660Z INFO  Writing file. filepath=certificates/host1.json
host1 # [   22.643158] acme-order-renew-host1-start[847]: + touch out/acme-success
server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.06 seconds)
server: waiting for TCP port 50051 on localhost
host1 # [   22.648676] acme-order-renew-host1-start[847]: + cmp -s certificates/host1.crt out/fullchain.pem
server # [   22.686552] systemd[1]: acme-order-renew-server.service: Deactivated successfully.
host1 # [   22.654903] acme-order-renew-host1-start[847]: + touch out/renewed
server # [   22.690723] systemd[1]: Finished Order (and renew) ACME certificate for server.
host1 # [   22.660270] acme-order-renew-host1-start[847]: + echo Installing new certificate
host1 # [   22.661915] acme-order-renew-host1-start[847]: Installing new certificate
host1 # [   22.663375] acme-order-renew-host1-start[847]: + cp -vp certificates/host1.crt out/fullchain.pem
host1 # [   22.669958] acme-order-renew-host1-start[863]: 'certificates/host1.crt' -> 'out/fullchain.pem'
server # [   22.705288] systemd[1]: Startup finished in 1.889s (kernel) + 4.682s (initrd) + 16.132s (userspace) = 22.704s.
server # [   22.706801] systemd[1]: acme-order-renew-server.service: Consumed 247ms CPU time over 754ms wall clock time, 56.4M memory peak, 4K written to disk, 10.4K incoming IP traffic, 8.1K outgoing IP traffic.
host1 # [   22.672984] acme-order-renew-host1-start[847]: + cp -vp certificates/host1.key out/key.pem
host1 # [   22.678533] acme-order-renew-host1-start[864]: 'certificates/host1.key' -> 'out/key.pem'
host1 # [   22.681142] acme-order-renew-host1-start[847]: + cp -vp certificates/host1.issuer.crt out/chain.pem
host1 # [   22.686340] acme-order-renew-host1-start[865]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'
host1 # [   22.688684] acme-order-renew-host1-start[847]: + ln -sf fullchain.pem out/cert.pem
host1 # [   22.693868] acme-order-renew-host1-start[847]: + cat out/key.pem out/fullchain.pem
server # [   22.729547] systemd[1]: Starting Order (and renew) ACME certificate for server...
server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!
host1 # [   22.699050] acme-order-renew-host1-start[847]: + for fixpath in out certificates
host1 # [   22.700589] acme-order-renew-host1-start[847]: + '[' -d out ']'
host1 # [   22.701561] acme-order-renew-host1-start[847]: + chmod -R u=rwX,g=rX,o= out
server: (finished: waiting for TCP port 50051 on localhost, in 0.06 seconds)

running 4 tests
host1 # [   22.705780] acme-order-renew-host1-start[847]: + chown -R acme:acme out
host1 # [   22.712077] acme-order-renew-host1-start[847]: + for fixpath in out certificates
host1 # [   22.713228] acme-order-renew-host1-start[847]: + '[' -d certificates ']'
host1 # [   22.714190] acme-order-renew-host1-start[847]: + chmod -R u=rwX,g=rX,o= certificates
host1 # [   22.718137] acme-order-renew-host1-start[847]: + chown -R acme:acme certificates
host1 # [   22.723778] acme-order-renew-host1-start[847]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   22.741030] systemd[1]: Created slice Slice /system/sshd-vsock.
host1 # [   22.743748] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   22.746212] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
server # [   22.784585] acme-order-renew-server-start[996]: Waiting to acquire lock in /run/acme/
server # [   22.790797] acme-order-renew-server-start[996]: + set -euo pipefail
server # [   22.791769] acme-order-renew-server-start[996]: + exec
server # [   22.792726] acme-order-renew-server-start[996]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 11
server # [   22.796244] acme-order-renew-server-start[1004]: ++ find accounts -path '*/keys/*.key' -print -quit
server # [   22.801288] acme-order-renew-server-start[996]: + '[' -n '' ']'
server # [   22.802200] acme-order-renew-server-start[996]: + exec
server # [   22.802924] acme-order-renew-server-start[996]: + '[' -e certificates/server.key ']'
server # [   22.803965] acme-order-renew-server-start[996]: + '[' -e certificates/server.crt ']'
server # [   22.806083] acme-order-renew-server-start[1005]: ++ find accounts -name root@example.org.key
server # [   22.810851] acme-order-renew-server-start[996]: + '[' -n accounts/server_8443/root@example.org/root@example.org.key ']'
server # [   22.812631] acme-order-renew-server-start[996]: + 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 --force-cert-domains
host1 # [   22.806364] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.
server # [   22.842455] acme-order-renew-server-start[1006]: 2026-10-27T20:05:16.526571280Z INFO  Renewing certificate cert-name=server
host1 # [   22.811221] systemd[1]: Finished Order (and renew) ACME certificate for host1.
host1 # [   22.812811] systemd[1]: Startup finished in 1.854s (kernel) + 4.007s (initrd) + 16.948s (userspace) = 22.810s.
server # [   22.849391] acme-order-renew-server-start[1006]: 2026-10-27T20:05:16.534501820Z WARN  The server does not advertise a renewal info endpoint. cert-name=server error="renewalInfo[get/post]: server does not advertise a renewal info endpoint"
host1 # [   22.815510] systemd[1]: acme-order-renew-host1.service: Consumed 228ms CPU time over 567ms wall clock time, 54.6M memory peak, 4K written to disk, 10.3K incoming IP traffic, 8.3K outgoing IP traffic.
server # [   22.855417] acme-order-renew-server-start[1006]: 2026-10-27T20:05:16.534591760Z INFO  Skip renewal: The certificate expires at 2026-10-28T20:05:16Z, the renewal can be performed in 11h59m29s465420920ns. cert-name=server
server # [   22.859994] acme-order-renew-server-start[996]: + touch out/acme-success
server # [   22.863273] acme-order-renew-server-start[996]: + cmp -s certificates/server.crt out/fullchain.pem
server # [   22.866572] acme-order-renew-server-start[996]: + for fixpath in out certificates
server # [   22.867660] acme-order-renew-server-start[996]: + '[' -d out ']'
server # [   22.868649] acme-order-renew-server-start[996]: + chmod -R u=rwX,g=rX,o= out
server # [   22.872723] acme-order-renew-server-start[996]: + chown -R acme:nix-grpc-daemon out
server # [   22.878648] acme-order-renew-server-start[996]: + for fixpath in out certificates
server # [   22.879742] acme-order-renew-server-start[996]: + '[' -d certificates ']'
server # [   22.880926] acme-order-renew-server-start[996]: + chmod -R u=rwX,g=rX,o= certificates
server # [   22.884657] acme-order-renew-server-start[996]: + chown -R acme:nix-grpc-daemon certificates
server # [   22.890190] acme-order-renew-server-start[996]: + chmod -R u=rwX,g=,o= accounts/.
host1 # [   22.860195] sshd-session[875]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   22.866693] sshd-session[875]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   22.873670] sshd-session[875]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   22.927881] systemd[1]: acme-order-renew-server.service: Deactivated successfully.
host1 # [   22.893888] systemd-logind[526]: New session '1' of user 'root' with class 'user' and type 'tty'.
server # [   22.931177] systemd[1]: Finished Order (and renew) ACME certificate for server.
server # [   22.933735] systemd[1]: acme-order-renew-server.service: Consumed 121ms CPU time over 200ms wall clock time, 15.8M memory peak, 3.3K incoming IP traffic, 2.2K outgoing IP traffic.
host1 # [   22.902927] systemd[1]: Created slice Slice /user/0.
server # [   22.941034] systemd[1]: Starting Nix worker-protocol over gRPC...
host1 # [   22.908199] systemd[1]: Starting User Runtime Directory /run/user/0...
host1 # [   22.943403] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   22.949819] systemd[1]: Starting User Manager for UID 0...
host1 # [   22.973756] (systemd)[892]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   22.979827] systemd-logind[526]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
server # [   23.065434] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:16Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1
server # [   23.080066] nix-grpc-daemon[1027]: WARNING: All log messages before absl::InitializeLog() is called are written to STDERR
server # [   23.081668] nix-grpc-daemon[1027]: E0000 00:00:1793131516.764806    1027 tls_security_connector.cc:771] TlsServerCertificateWatcher getting identity_cert_error: UNKNOWN:Unable to get latest identity certificates.
server # [   23.088227] nix-grpc-daemon[1027]: E0000 00:00:1793131516.773178    1027 tls_security_connector.cc:767] TlsServerCertificateWatcher getting root_cert_error: UNKNOWN:Unable to get latest root certificates.
server # [   23.091635] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:16Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket
server # [   23.096397] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:16Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0
server # [   23.098205] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:16Z level=info event=unhealthy reason=min_free
server # [   23.099448] systemd[1]: Started Nix worker-protocol over gRPC.
host1 # [   23.069899] systemd[892]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   23.205203] systemd[892]: Queued start job for default target Main User Target.
host1 # [   23.208955] systemd[892]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   23.212964] systemd[892]: Created slice User Application Slice.
host1 # [   23.213893] systemd[892]: Started Daily Cleanup of User's Temporary Directories.
host1 # [   23.214989] systemd[892]: Reached target Paths.
host1 # [   23.215656] systemd[892]: Reached target Timers.
host1 # [   23.219846] systemd[892]: Starting D-Bus User Message Bus Socket...
host1 # [   23.224173] systemd[892]: Starting Create User Files and Directories...
host1 # [   23.263563] systemd[892]: Finished Create User Files and Directories.
host1 # [   23.277935] systemd[892]: Listening on D-Bus User Message Bus Socket.
host1 # [   23.282476] systemd[892]: Reached target Sockets.
host1 # [   23.283262] systemd[892]: Reached target Basic System.
host1 # [   23.284001] systemd[892]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
host1 # [   23.285485] systemd[892]: Reached target Main User Target.
host1 # [   23.286275] systemd[892]: Startup finished in 284ms.
host1 # [   23.287242] systemd[1]: Started User Manager for UID 0.
host1 # [   23.289214] systemd[1]: Started Session 1 of User root.
host1 # [   23.305077] sshd-session[905]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   23.307371] sshd-session[905]: Disconnected from user root UNKNOWN port 65535
host1 # [   23.308653] sshd-session[875]: pam_unix(sshd:session): session closed for user root
host1 # [   23.313646] systemd[1]: sshd-vsock@0-1-3:22-2:0.service: Deactivated successfully.
host1 # [   23.317074] systemd[1]: session-1.scope: Deactivated successfully.
host1 # [   23.319884] systemd-logind[526]: Session 1 logged out. Waiting for processes to exit.
host1 # [   23.323323] systemd-logind[526]: Removed session 1.
host1 # [   23.338750] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   23.374830] systemd[1]: Created slice Slice /system/sshd-vsock.
server # [   23.376841] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   23.344270] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
host1 # [   23.348414] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
server # [   23.384385] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).
host1 # [   23.356835] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
server # [   23.496642] sshd-session[1040]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   23.504246] sshd-session[1040]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   23.513946] sshd-session[1040]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   23.543532] systemd[1]: Created slice Slice /user/0.
server # [   23.548777] systemd[1]: Starting User Runtime Directory /run/user/0...
server # [   23.561241] systemd-logind[537]: New session '1' of user 'root' with class 'user' and type 'tty'.
host1 # [   23.531354] sshd-session[912]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   23.538742] sshd-session[910]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   23.546880] sshd-session[911]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   23.560599] sshd-session[911]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   23.561736] sshd-session[910]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   23.562851] sshd-session[912]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   23.598479] systemd[1]: Finished User Runtime Directory /run/user/0.
host1 # [   23.573610] sshd-session[911]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   23.608883] systemd[1]: Starting User Manager for UID 0...
host1 # [   23.575086] sshd-session[910]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   23.582642] sshd-session[912]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   23.587852] systemd-logind[526]: New session '3' of user 'root' with class 'user' and type 'tty'.
host1 # [   23.592402] systemd[1]: Started Session 3 of User root.
host1 # [   23.597393] systemd-logind[526]: New session '4' of user 'root' with class 'user' and type 'tty'.
server # [   23.634118] (systemd)[1048]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
host1 # [   23.602561] systemd[1]: Started Session 4 of User root.
host1 # [   23.605197] systemd-logind[526]: New session '5' of user 'root' with class 'user' and type 'tty'.
server # [   23.640153] systemd-logind[537]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.
host1 # [   23.610105] systemd[1]: Started Session 5 of User root.
server # [   23.729610] systemd[1048]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
host1 # [   23.739964] sshd-session[931]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   23.742939] sshd-session[931]: Disconnected from user root UNKNOWN port 65535
host1 # [   23.745219] sshd-session[912]: pam_unix(sshd:session): session closed for user root
host1 # [   23.749332] sshd-session[928]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   23.750682] sshd-session[928]: Disconnected from user root UNKNOWN port 65535
host1 # [   23.755071] sshd-session[911]: pam_unix(sshd:session): session closed for user root
host1 # [   23.758966] sshd-session[929]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   23.762083] systemd[1]: sshd-vsock@3-4-3:22-2:3.service: Deactivated successfully.
host1 # [   23.763254] sshd-session[929]: Disconnected from user root UNKNOWN port 65535
host1 # [   23.766818] systemd[1]: session-5.scope: Deactivated successfully.
host1 # [   23.767741] sshd-session[910]: pam_unix(sshd:session): session closed for user root
host1 # [   23.769958] systemd-logind[526]: Session 5 logged out. Waiting for processes to exit.
host1 # [   23.771171] systemd-logind[526]: Removed session 5.
host1 # [   23.784548] systemd[1]: sshd-vsock@2-3-3:22-2:2.service: Deactivated successfully.
host1 # [   23.785669] systemd[1]: session-3.scope: Deactivated successfully.
host1 # [   23.786635] systemd[1]: sshd-vsock@1-2-3:22-2:1.service: Deactivated successfully.
host1 # [   23.791177] systemd[1]: session-4.scope: Deactivated successfully.
host1 # [   23.795392] systemd-logind[526]: Session 3 logged out. Waiting for processes to exit.
host1 # [   23.799245] systemd-logind[526]: Removed session 3.
host1 # [   23.803875] systemd-logind[526]: Session 4 logged out. Waiting for processes to exit.
host1 # [   23.805791] systemd-logind[526]: Removed session 4.
server # [   23.867704] systemd[1048]: Queued start job for default target Main User Target.
server # [   23.877061] systemd[1048]: Failed to adjust io pressure threshold, ignoring: Device or resource busy
server # [   23.879967] systemd[1048]: Created slice User Application Slice.
server # [   23.882441] systemd[1048]: Started Daily Cleanup of User's Temporary Directories.
server # [   23.883517] systemd[1048]: Reached target Paths.
server # [   23.886309] systemd[1048]: Reached target Timers.
server # [   23.887047] systemd[1048]: Starting D-Bus User Message Bus Socket...
server # [   23.889516] systemd[1048]: Starting Create User Files and Directories...
server # [   23.931939] systemd[1048]: Finished Create User Files and Directories.
server # [   23.946405] systemd[1048]: Listening on D-Bus User Message Bus Socket.
server # [   23.947439] systemd[1048]: Reached target Sockets.
server # [   23.950405] systemd[1048]: Reached target Basic System.
server # [   23.951288] systemd[1048]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system
server # [   23.954600] systemd[1048]: Reached target Main User Target.
server # [   23.955509] systemd[1048]: Startup finished in 290ms.
server # [   23.961480] systemd[1]: Started User Manager for UID 0.
server # [   23.963036] systemd[1]: Started Session 1 of User root.
server # [   23.974704] sshd-session[1062]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   23.977169] sshd-session[1062]: Disconnected from user root UNKNOWN port 65535
server # [   23.978896] sshd-session[1040]: pam_unix(sshd:session): session closed for user root
server # [   23.982176] systemd[1]: sshd-vsock@0-1-4:22-2:0.service: Deactivated successfully.
server # [   23.986709] systemd[1]: session-1.scope: Deactivated successfully.
server # [   23.990802] systemd-logind[537]: Session 1 logged out. Waiting for processes to exit.
server # [   23.993072] systemd-logind[537]: Removed session 1.
server # [   24.063061] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   24.067772] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).
host1 # [   24.035960] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   24.044392] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
host1 # [   24.050968] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).
server # [   24.157481] sshd-session[1067]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   24.164334] sshd-session[1067]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   24.174060] sshd-session[1067]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   24.182214] systemd-logind[537]: New session '3' of user 'root' with class 'user' and type 'tty'.
server # [   24.189326] systemd[1]: Started Session 3 of User root.
host1 # [   24.188200] sshd-session[944]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   24.192893] sshd-session[945]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   24.200222] sshd-session[945]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.203372] sshd-session[944]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.214633] sshd-session[944]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.218731] sshd-session[945]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.225622] systemd-logind[526]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.237902] systemd[1]: Started Session 6 of User root.
host1 # [   24.242450] systemd-logind[526]: New session '7' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.245027] systemd[1]: Started Session 7 of User root.
host1 # [   24.283554] sshd-session[957]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   24.288226] sshd-session[957]: Disconnected from user root UNKNOWN port 65535
host1 # [   24.289726] sshd-session[945]: pam_unix(sshd:session): session closed for user root
host1 # [   24.303217] systemd[1]: sshd-vsock@5-6-3:22-2:5.service: Deactivated successfully.
host1 # [   24.308681] systemd[1]: session-7.scope: Deactivated successfully.
host1 # [   24.313785] systemd-logind[526]: Session 7 logged out. Waiting for processes to exit.
host1 # [   24.321115] systemd-logind[526]: Removed session 7.
host1 # [   24.324877] sshd-session[956]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   24.326476] sshd-session[956]: Disconnected from user root UNKNOWN port 65535
host1 # [   24.328606] sshd-session[944]: pam_unix(sshd:session): session closed for user root
host1 # [   24.333745] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   24.340641] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).
host1 # [   24.341680] systemd[1]: sshd-vsock@4-5-3:22-2:4.service: Deactivated successfully.
host1 # [   24.351352] systemd[1]: session-6.scope: Deactivated successfully.
host1 # [   24.355181] systemd-logind[526]: Session 6 logged out. Waiting for processes to exit.
host1 # [   24.356724] systemd-logind[526]: Removed session 6.
test acme::host1_obtains_a_certificate_via_acme ... ok
host1 # [   24.428325] sshd-session[964]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   24.435192] sshd-session[964]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   24.441984] sshd-session[964]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   24.451051] systemd-logind[526]: New session '8' of user 'root' with class 'user' and type 'tty'.
host1 # [   24.457209] systemd[1]: Started Session 8 of User root.
server # [   24.653983] systemd[1]: Started Nix Daemon.
server # [   24.939193] nix-daemon[1082]: accepted connection from pid 1027, user nix-grpc-daemon (trusted)
server # [   24.950565] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:18Z level=info event=denied method=Connect cn=host1 role=read-only
host1 # [   24.950925] sshd-session[972]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   24.953650] sshd-session[972]: Disconnected from user root UNKNOWN port 65535
host1 # [   24.955633] sshd-session[964]: pam_unix(sshd:session): session closed for user root
host1 # [   24.961971] systemd[1]: sshd-vsock@6-7-3:22-2:6.service: Deactivated successfully.
host1 # [   24.968360] systemd[1]: session-8.scope: Deactivated successfully.
server # [   25.003086] sshd-session[1073]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   25.006528] sshd-session[1073]: Disconnected from user root UNKNOWN port 65535
server # [   25.007573] sshd-session[1067]: pam_unix(sshd:session): session closed for user root
host1 # [   24.972886] systemd[1]: session-8.scope: Consumed 160ms CPU time over 513ms wall clock time, 38.8M memory peak, 5.2K incoming IP traffic, 4.1K outgoing IP traffic.
server # [   25.011185] systemd[1]: sshd-vsock@1-2-4:22-2:1.service: Deactivated successfully.
host1 # [   24.978845] systemd-logind[526]: Session 8 logged out. Waiting for processes to exit.
host1 # [   24.980607] systemd-logind[526]: Removed session 8.
server # [   25.016087] systemd[1]: session-3.scope: Deactivated successfully.
server # [   25.017559] systemd[1]: session-3.scope: Consumed 317ms CPU time over 828ms wall clock time, 47.3M memory peak, 1.4K outgoing IP traffic.
server # [   25.021800] systemd-logind[537]: Session 3 logged out. Waiting for processes to exit.
server # [   25.023897] systemd-logind[537]: Removed session 3.
server # [   25.069829] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   25.077650] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).
server # [   25.087837] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   25.093629] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).
server # [   25.220786] sshd-session[1098]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   25.225540] sshd-session[1097]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   25.233375] sshd-session[1098]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   25.235907] sshd-session[1097]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   25.246735] sshd-session[1097]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   25.250212] sshd-session[1098]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   25.258505] systemd-logind[537]: New session '4' of user 'root' with class 'user' and type 'tty'.
server # [   25.264858] systemd[1]: Started Session 4 of User root.
server # [   25.267892] systemd-logind[537]: New session '5' of user 'root' with class 'user' and type 'tty'.
server # [   25.275840] systemd[1]: Started Session 5 of User root.
server # [   25.309070] sshd-session[1109]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   25.310418] sshd-session[1109]: Disconnected from user root UNKNOWN port 65535
server # [   25.312431] sshd-session[1097]: pam_unix(sshd:session): session closed for user root
server # [   25.318822] systemd[1]: sshd-vsock@2-3-4:22-2:2.service: Deactivated successfully.
server # [   25.322391] systemd[1]: session-4.scope: Deactivated successfully.
server # [   25.327683] systemd-logind[537]: Session 4 logged out. Waiting for processes to exit.
server # [   25.331806] systemd-logind[537]: Removed session 4.
test acme::a_read_only_host_cannot_write ... ok
server # [   25.439673] sshd-session[1110]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   25.441441] sshd-session[1110]: Disconnected from user root UNKNOWN port 65535
server # [   25.443110] sshd-session[1098]: pam_unix(sshd:session): session closed for user root
server # [   25.446667] systemd[1]: sshd-vsock@3-4-4:22-2:3.service: Deactivated successfully.
server # [   25.451526] systemd[1]: session-5.scope: Deactivated successfully.
server # [   25.455359] systemd-logind[537]: Session 5 logged out. Waiting for processes to exit.
server # [   25.457781] systemd-logind[537]: Removed session 5.
server # [   25.462101] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   25.429170] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
server # [   25.467510] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).
host1 # [   25.436557] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).
server # [   25.542286] sshd-session[1121]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   25.549844] sshd-session[1121]: Accepted none for root from UNKNOWN port 65535 ssh2
server # [   25.557438] sshd-session[1121]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
server # [   25.567807] systemd-logind[537]: New session '6' of user 'root' with class 'user' and type 'tty'.
host1 # [   25.534241] sshd-session[987]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
server # [   25.572562] systemd[1]: Started Session 6 of User root.
host1 # [   25.543330] sshd-session[987]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   25.552444] sshd-session[987]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   25.561292] systemd-logind[526]: New session '9' of user 'root' with class 'user' and type 'tty'.
host1 # [   25.572496] systemd[1]: Started Session 9 of User root.
host1 # [   25.589545] sshd-session[993]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   25.592141] sshd-session[993]: Disconnected from user root UNKNOWN port 65535
host1 # [   25.593640] sshd-session[987]: pam_unix(sshd:session): session closed for user root
host1 # [   25.598257] systemd[1]: sshd-vsock@7-8-3:22-2:7.service: Deactivated successfully.
host1 # [   25.603237] systemd[1]: session-9.scope: Deactivated successfully.
host1 # [   25.607390] systemd-logind[526]: Session 9 logged out. Waiting for processes to exit.
host1 # [   25.610025] systemd-logind[526]: Removed session 9.
host1 # [   25.628708] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   25.634600] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).
server # [   25.699461] sshd-session[1127]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
server # [   25.701300] sshd-session[1127]: Disconnected from user root UNKNOWN port 65535
server # [   25.702597] sshd-session[1121]: pam_unix(sshd:session): session closed for user root
server # [   25.706294] systemd[1]: sshd-vsock@4-5-4:22-2:4.service: Deactivated successfully.
server # [   25.711273] systemd[1]: session-6.scope: Deactivated successfully.
server # [   25.715058] systemd-logind[537]: Session 6 logged out. Waiting for processes to exit.
server # [   25.717479] systemd-logind[537]: Removed session 6.
test acme::server_builds_and_signs_a_path ... ok
host1 # [   25.715427] sshd-session[998]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   25.722555] sshd-session[998]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   25.729774] sshd-session[998]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   25.737091] systemd-logind[526]: New session '10' of user 'root' with class 'user' and type 'tty'.
host1 # [   25.748397] systemd[1]: Started Session 10 of User root.
server # [   26.889515] nix-grpc-daemon[1027]: ts=2026-10-27T20:05:20Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:38820 duration_s=0 paths=1 nar_bytes_out=128
host1 # [   26.893149] sshd-session[1004]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   26.896597] sshd-session[1004]: Disconnected from user root UNKNOWN port 65535
host1 # [   26.897572] sshd-session[998]: pam_unix(sshd:session): session closed for user root
host1 # [   26.905566] systemd[1]: sshd-vsock@8-9-3:22-2:8.service: Deactivated successfully.
host1 # [   26.912544] systemd[1]: session-10.scope: Deactivated successfully.
host1 # [   26.914653] systemd[1]: session-10.scope: Consumed 165ms CPU time over 1.165s wall clock time, 40.6M memory peak, 10K incoming IP traffic, 9.1K outgoing IP traffic.
host1 # [   26.921529] systemd-logind[526]: Session 10 logged out. Waiting for processes to exit.
host1 # [   26.924467] systemd-logind[526]: Removed session 10.
host1 # [   26.929881] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
host1 # [   26.936304] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).
host1 # [   27.010290] sshd-session[1025]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it
host1 # [   27.017380] sshd-session[1025]: Accepted none for root from UNKNOWN port 65535 ssh2
host1 # [   27.025011] sshd-session[1025]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
host1 # [   27.034654] systemd-logind[526]: New session '11' of user 'root' with class 'user' and type 'tty'.
host1 # [   27.040421] systemd[1]: Started Session 11 of User root.
host1 # [   27.060126] sshd-session[1031]: Received disconnect from UNKNOWN port 65535:11: disconnected by user
host1 # [   27.062341] sshd-session[1031]: Disconnected from user root UNKNOWN port 65535
host1 # [   27.063623] sshd-session[1025]: pam_unix(sshd:session): session closed for user root
host1 # [   27.067969] systemd[1]: sshd-vsock@9-10-3:22-2:9.service: Deactivated successfully.
host1 # [   27.072563] systemd[1]: session-11.scope: Deactivated successfully.
host1 # [   27.076793] systemd-logind[526]: Session 11 logged out. Waiting for processes to exit.
host1 # [   27.078925] systemd-logind[526]: 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; 54 filtered out; finished in 4.41s

(finished: run the VM test script, in 28.00 seconds)
test script finished in 28.16s
cleanup
kill QemuMachine (pid 54)
host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)
host1 # [2026-10-27T20:05:20Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-10-27T20:05:20Z INFO  virtiofsd] Client disconnected, shutting down
host1 # [2026-10-27T20:05:20Z INFO  virtiofsd] Client disconnected, shutting down
kill QemuMachine (pid 55)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)
server # [2026-10-27T20:05:21Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-10-27T20:05:21Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-10-27T20:05:21Z INFO  virtiofsd] Client disconnected, shutting down
(finished: cleanup, in 0.45 seconds)
SSH backdoor enabled, the machines can be accessed like this:
Note: this requires systemd-ssh-proxy(1) to be enabled (default on NixOS 25.05 and newer).
    host1:   ssh -o User=root vsock-mux//build/tmpumteekyt/host1_host.socket
    server:  ssh -o User=root vsock-mux//build/tmpumteekyt/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