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)
Test will time out and terminate in 3600.0 seconds
run the VM test script
start all VMs
client: starting vm
server: starting vm
client: QEMU running (pid 47)
client # Disk image does not exist, creating the virtualisation disk image...
client # Formatting '/build/vm-state-client/tmp.HvObLGvxUx', fmt=raw size=1073741824
client # mke2fs 1.47.4 (6-Mar-2025)
client # Discarding device blocks:      0/262144             done
client # Creating filesystem with 262144 4k blocks and 65536 inodes
client # Filesystem UUID: 579fd726-d426-4465-b9f1-5e4ef7b014a8
server # Disk image does not exist, creating the virtualisation disk image...
client # Superblock backups stored on blocks:
server # Formatting '/build/vm-state-server/tmp.SU3G7PBlm5', fmt=raw size=1073741824
client # 	32768, 98304, 163840, 229376
server # mke2fs 1.47.4 (6-Mar-2025)
client # 
server # Discarding device blocks:      0/262144             done
server: QEMU running (pid 48)
server # Creating filesystem with 262144 4k blocks and 65536 inodes
client # Allocating group tables: 0/8   done
(finished: start all VMs, in 0.66 seconds)
client # Writing inode tables: 0/8   done
client: waiting for unit network.target
client # Creating journal (8192 blocks): done
client: waiting for the VM to finish booting
client # Writing superblocks and filesystem accounting information: 0/8   done
server # Filesystem UUID: 3cf15d86-f781-418c-91f9-42f28f61ca19
client # 
server # Superblock backups stored on blocks:
client # Virtualisation disk image created.
server # 	32768, 98304, 163840, 229376
client # Starting virtiofs daemons...
server # 
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # Allocating group tables: 0/8   done
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # Writing inode tables: 0/8   done
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # Creating journal (8192 blocks): done
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # Writing superblocks and filesystem accounting information: 0/8   done
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # 
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # Virtualisation disk image created.
client # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # Starting virtiofs daemons...
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-09-29T03:51:04Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-29T03:51:04Z INFO  virtiofsd] Client connected, servicing requests
client # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026
client # [    0.000000] KASLR enabled
client # [    0.000000] random: crng init done
client # [    0.000000] Machine model: linux,dummy-virt
client # [    0.000000] efi: UEFI not found.
client # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
client # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] NODE_DATA(0) allocated [mem 0x7fdee700-0x7fdf1e7f]
client # [    0.000000] Zone ranges:
client # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000]   DMA32    empty
client # [    0.000000]   Normal   empty
client # [    0.000000]   Device   empty
client # [    0.000000] Movable zone start for each node
client # [    0.000000] Early memory node ranges
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026
client # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
server # [    0.000000] KASLR enabled
client # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] random: crng init done
client # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
client # [    0.000000] psci: Using standard PSCI v0.2 function IDs
client # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
client # [    0.000000] psci: SMC Calling Convention v1.1
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] NODE_DATA(0) allocated [mem 0x7fdee700-0x7fdf1e7f]
server # [    0.000000] Zone ranges:
client # [    0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   empty
server # [    0.000000]   Device   empty
client # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] Movable zone start for each node
client # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000] Early memory node ranges
client # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] CPU features: detected: Spectre-BHB
client # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
client # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] psci: probing for conduit method from DT.
client # [    0.000000] alternatives: applying boot alternatives
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)
client # [    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/9j3nlflp3br9kbwm09hlmgf409yji1rx-nixos-system-client-test/init regInfo=/nix/.ro-store/as6ryw5q2346yfzvfid47z96agagx9pi-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
client # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/as6ryw5q2346yfzvfid47z96agagx9pi-closure-info/registration", will be passed to user space.
server # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
client # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] CPU features: detected: Spectre-BHB
client # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
client # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] alternatives: applying boot alternatives
client # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
client # [    0.000000] software IO TLB: area num 1.
client # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
client # [    0.000000] Fallback order for Node 0: 0
client # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
client # [    0.000000] Policy zone: DMA
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/kdk7ki33im0w5z8nr0dhs0hsg5pqdc50-nixos-system-server-test/init regInfo=/nix/.ro-store/r2gm9s4qv7rlr3g1llb8279qnvvsfzn2-closure-info/registration console=ttyAMA0,115200n8 console=tty0
client # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
client # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/r2gm9s4qv7rlr3g1llb8279qnvvsfzn2-closure-info/registration", will be passed to user space.
client # [    0.000000] allocated 2097152 bytes of page_ext
client # [    0.000000] ftrace: allocating 74966 entries in 294 pages
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
client # [    0.000000] ftrace: allocated 294 pages with 4 groups
server # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
client # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
client # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
client # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.000000] software IO TLB: area num 1.
client # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
client # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] Fallback order for Node 0: 0
client # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
server # [    0.000000] Policy zone: DMA
client # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
client # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
server # [    0.000000] allocated 2097152 bytes of page_ext
client # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] ftrace: allocating 74966 entries in 294 pages
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
client # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] rcu: 	RCU event tracing is enabled.
client # [    0.000000] GICv3: 256 SPIs implemented
client # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
client # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
client # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
client # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
client # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
client # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] GICv3: using LPI property table @0x0000000044d00000
server # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
client # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
client # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
client # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
client # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
client # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
client # [    0.000033] arm-pv: using stolen time PV
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
client # [    0.000442] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
client # [    0.000629] Console: colour dummy device 80x25
server # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
client # [    0.000637] printk: legacy console [tty0] enabled
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
client # [    0.000841] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
client # [    0.000848] pid_max: default: 32768 minimum: 301
client # [    0.000937] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
client # [    0.001120] landlock: Up and running.
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
client # [    0.001123] Yama: becoming mindful.
client # [    0.001591] LSM support for eBPF active
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client # [    0.001710] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
client # [    0.001730] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.000031] arm-pv: using stolen time PV
client # [    0.003668] rcu: Hierarchical SRCU implementation.
client # [    0.003674] rcu: 	Max phase no-delay instances is 1000.
server # [    0.000391] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
client # [    0.004940] fsl-mc MSI: its@8080000 domain created
server # [    0.000589] Console: colour dummy device 80x25
client # [    0.005064] EFI services will not be available.
server # [    0.000598] printk: legacy console [tty0] enabled
client # [    0.005140] smp: Bringing up secondary CPUs ...
client # [    0.005149] smp: Brought up 1 node, 1 CPU
client # [    0.005152] SMP: Total of 1 processors activated.
server # [    0.000797] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
client # [    0.005155] CPU: All CPU(s) started at EL1
server # [    0.000804] pid_max: default: 32768 minimum: 301
client # [    0.005170] CPU features: detected: Branch Target Identification
server # [    0.000891] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.001083] landlock: Up and running.
client # [    0.005175] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.001088] Yama: becoming mindful.
server # [    0.001537] LSM support for eBPF active
client # [    0.005179] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.001666] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.005182] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.001687] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.005185] CPU features: detected: Common not Private translations
server # [    0.003601] rcu: Hierarchical SRCU implementation.
client # [    0.005189] CPU features: detected: CRC32 instructions
server # [    0.003607] rcu: 	Max phase no-delay instances is 1000.
client # [    0.005191] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.005033] fsl-mc MSI: its@8080000 domain created
server # [    0.005158] EFI services will not be available.
client # [    0.005195] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.005237] smp: Bringing up secondary CPUs ...
client # [    0.005198] CPU features: detected: Data independent timing control (DIT)
server # [    0.005246] smp: Brought up 1 node, 1 CPU
client # [    0.005201] CPU features: detected: E0PD
server # [    0.005249] SMP: Total of 1 processors activated.
server # [    0.005252] CPU: All CPU(s) started at EL1
client # [    0.005203] CPU features: detected: Enhanced Counter Virtualization
server # [    0.005272] CPU features: detected: Branch Target Identification
client # [    0.005206] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.005276] CPU features: detected: ARMv8.4 Translation Table Level
client # [    0.005210] CPU features: detected: Enhanced Virtualization Traps
client # [    0.005213] CPU features: detected: Fine Grained Traps
server # [    0.005279] CPU features: detected: Instruction cache invalidation not required for I/D coherence
client # [    0.005216] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.005283] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
client # [    0.005222] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.005287] CPU features: detected: Common not Private translations
client # [    0.005225] CPU features: detected: LSE atomic instructions
server # [    0.005290] CPU features: detected: CRC32 instructions
client # [    0.005228] CPU features: detected: Privileged Access Never
client # [    0.005230] CPU features: detected: PMUv3
server # [    0.005293] CPU features: detected: Data cache clean to Point of Deep Persistence
client # [    0.005233] CPU features: detected: RAS Extension Support
server # [    0.005297] CPU features: detected: Data cache clean to Point of Persistence
client # [    0.005236] CPU features: detected: RASv1p1 Extension Support
client # [    0.005238] CPU features: detected: Random Number Generator
server # [    0.005300] CPU features: detected: Data independent timing control (DIT)
client # [    0.005241] CPU features: detected: Speculation barrier (SB)
server # [    0.005303] CPU features: detected: E0PD
client # [    0.005244] CPU features: detected: Stage-2 Force Write-Back
server # [    0.005305] CPU features: detected: Enhanced Counter Virtualization
client # [    0.005247] CPU features: detected: TLB range maintenance instructions
server # [    0.005309] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
client # [    0.005251] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.005312] CPU features: detected: Enhanced Virtualization Traps
client # [    0.005289] alternatives: applying system-wide alternatives
server # [    0.005315] CPU features: detected: Fine Grained Traps
client # [    0.008401] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.005319] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.005325] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.005328] CPU features: detected: LSE atomic instructions
client # [    0.008602] Memory: 893496K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 113540K reserved, 32768K cma-reserved)
client # [    0.008940] devtmpfs: initialized
server # [    0.005331] CPU features: detected: Privileged Access Never
server # [    0.005333] CPU features: detected: PMUv3
client # [    0.010715] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.005336] CPU features: detected: RAS Extension Support
server # [    0.005339] CPU features: detected: RASv1p1 Extension Support
server # [    0.005342] CPU features: detected: Random Number Generator
server # [    0.005344] CPU features: detected: Speculation barrier (SB)
server # [    0.005347] CPU features: detected: Stage-2 Force Write-Back
server # [    0.005350] CPU features: detected: TLB range maintenance instructions
server # [    0.005355] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.005393] alternatives: applying system-wide alternatives
server # [    0.008467] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.008651] Memory: 891864K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 115392K reserved, 32768K cma-reserved)
server # [    0.009033] devtmpfs: initialized
client # [    0.010737] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
client # [    0.010936] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.010822] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.010947] 0 pages in range for non-PLT usage
server # [    0.010846] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
client # [    0.010948] 508224 pages in range for PLT usage
client # [    0.011042] pinctrl core: initialized pinctrl subsystem
server # [    0.011036] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
client # [    0.011863] DMI not present or invalid.
server # [    0.011044] 0 pages in range for non-PLT usage
server # [    0.011045] 508224 pages in range for PLT usage
client # [    0.015126] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.011135] pinctrl core: initialized pinctrl subsystem
client # [    0.017503] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
server # [    0.011966] DMI not present or invalid.
client # [    0.017665] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.015402] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.017721] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
client # [    0.017829] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
client # [    0.017851] audit: initializing netlink subsys (disabled)
server # [    0.017886] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
client # [    0.018547] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.018053] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
client # [    0.018549] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.018078] audit: initializing netlink subsys (disabled)
client # [    0.018552] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.018721] thermal_sys: Registered thermal governor 'fair_share'
client # [    0.018555] thermal_sys: Registered thermal governor 'user_space'
server # [    0.018723] thermal_sys: Registered thermal governor 'bang_bang'
client # [    0.018558] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.018727] thermal_sys: Registered thermal governor 'step_wise'
client # [    0.018586] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
server # [    0.018730] thermal_sys: Registered thermal governor 'user_space'
client # [    0.018594] cpuidle: using governor ladder
server # [    0.018732] thermal_sys: Registered thermal governor 'power_allocator'
client # [    0.018600] cpuidle: using governor menu
client # [    0.018805] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.018768] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
server # [    0.018776] cpuidle: using governor ladder
client # [    0.018821] ASID allocator initialised with 65536 entries
server # [    0.018781] cpuidle: using governor menu
client # [    0.020063] Serial: AMBA PL011 UART driver
server # [    0.018991] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
client # [    0.025716] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.019006] ASID allocator initialised with 65536 entries
client # [    0.025901] printk: console [ttyAMA0] enabled
server # [    0.020232] Serial: AMBA PL011 UART driver
server # [    0.025915] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.026066] printk: console [ttyAMA0] enabled
client # [    0.159870] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
client # [    0.159882] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
client # [    0.159885] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
client # [    0.159888] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
client # [    0.159891] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
client # [    0.159894] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
client # [    0.159897] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
client # [    0.159899] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
client # [    0.161132] fbcon: Taking over console
client # [    0.161142] ACPI: Interpreter disabled.
client # [    0.170009] iommu: Default domain type: Translated
client # [    0.170015] iommu: DMA domain TLB invalidation policy: strict mode
client # [    0.171853] SCSI subsystem initialized
server # [    0.160064] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
client # [    0.172062] usbcore: registered new interface driver usbfs
server # [    0.160076] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
client # [    0.172092] usbcore: registered new interface driver hub
server # [    0.160079] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
client # [    0.172107] usbcore: registered new device driver usb
server # [    0.160082] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
client # [    0.172395] pps_core: LinuxPPS API ver. 1 registered
server # [    0.160085] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
client # [    0.172399] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.160088] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
client # [    0.172407] PTP clock support registered
client # [    0.172454] EDAC MC: Ver: 3.0.0
server # [    0.160091] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.160093] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.161337] fbcon: Taking over console
server # [    0.161347] ACPI: Interpreter disabled.
server # [    0.162338] iommu: Default domain type: Translated
client # [    0.179868] scmi_core: SCMI protocol bus registered
client # [    0.180265] FPGA manager framework
server # [    0.162343] iommu: DMA domain TLB invalidation policy: strict mode
client # [    0.180824] vgaarb: loaded
server # [    0.162729] SCSI subsystem initialized
client # [    0.181097] clocksource: Switched to clocksource arch_sys_counter
server # [    0.172802] usbcore: registered new interface driver usbfs
server # [    0.172830] usbcore: registered new interface driver hub
server # [    0.172848] usbcore: registered new device driver usb
server # [    0.173246] pps_core: LinuxPPS API ver. 1 registered
server # [    0.173249] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.173257] PTP clock support registered
server # [    0.173308] EDAC MC: Ver: 3.0.0
client # [    0.189965] VFS: Disk quotas dquot_6.6.0
client # [    0.189999] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
client # [    0.192501] netfs: FS-Cache loaded
client # [    0.192645] pnp: PnP ACPI: disabled
server # [    0.185173] scmi_core: SCMI protocol bus registered
server # [    0.185590] FPGA manager framework
server # [    0.186141] vgaarb: loaded
server # [    0.186422] clocksource: Switched to clocksource arch_sys_counter
client # [    0.198066] NET: Registered PF_INET protocol family
server # [    0.188289] VFS: Disk quotas dquot_6.6.0
client # [    0.198219] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.188319] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.188647] netfs: FS-Cache loaded
server # [    0.188763] pnp: PnP ACPI: disabled
server # [    0.198956] NET: Registered PF_INET protocol family
server # [    0.199122] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
client # [    0.229524] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.229565] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
client # [    0.229590] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
client # [    0.229633] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
client # [    0.229707] TCP: Hash tables configured (established 8192 bind 8192)
client # [    0.229795] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
client # [    0.229826] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.229849] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.229925] NET: Registered PF_UNIX/PF_LOCAL protocol family
client # [    0.229953] NET: Registered PF_XDP protocol family
client # [    0.229970] PCI: CLS 0 bytes, default 64
client # [    0.230227] Trying to unpack rootfs image as initramfs...
client # [    0.243801] kvm [1]: HYP mode not available
server # [    0.230593] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.230631] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.230669] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.230712] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    0.230786] TCP: Hash tables configured (established 8192 bind 8192)
server # [    0.230873] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
server # [    0.230903] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.230925] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.231000] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.231023] NET: Registered PF_XDP protocol family
server # [    0.231040] PCI: CLS 0 bytes, default 64
server # [    0.231326] Trying to unpack rootfs image as initramfs...
server # [    0.245244] kvm [1]: HYP mode not available
client # [    0.365695] Initialise system trusted keyrings
client # [    0.365843] workingset: timestamp_bits=42 max_order=18 bucket_order=0
client # [    0.366218] squashfs: version 4.0 (2009/01/31) Phillip Lougher
client # [    0.366264] 9p: Installing v9fs 9p2000 file system support
server # [    0.371048] Initialise system trusted keyrings
server # [    0.371192] workingset: timestamp_bits=42 max_order=18 bucket_order=0
server # [    0.371615] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.371663] 9p: Installing v9fs 9p2000 file system support
client # [    0.394497] Key type asymmetric registered
client # [    0.394514] Asymmetric key parser 'x509' registered
client # [    0.394596] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
client # [    0.394726] io scheduler mq-deadline registered
client # [    0.394731] io scheduler kyber registered
client # [    0.407242] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.407839] ledtrig-cpu: registered to indicate activity on CPUs
client # [    0.408199] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.399861] Key type asymmetric registered
client # [    0.408213] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.399889] Asymmetric key parser 'x509' registered
client # [    0.408222] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.399967] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
client # [    0.408227] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.400105] io scheduler mq-deadline registered
client # [    0.408254] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.400110] io scheduler kyber registered
client # [    0.408272] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
client # [    0.408350] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
client # [    0.408356] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.408360] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
client # [    0.408363] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
client # [    0.408366] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.408441] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
client # [    0.408908] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.412549] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.413254] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.413634] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.413647] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.413657] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.413662] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.413695] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.413714] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
client # [    0.429149] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.413787] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.413794] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.429210] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.413798] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
client # [    0.429238] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.429251] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.413801] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.413804] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.429821] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.430031] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.413874] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
client # [    0.430043] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.414326] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.430070] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.430565] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
client # [    0.430757] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
client # [    0.430769] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.430795] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.431385] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.431579] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
client # [    0.431591] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.431617] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.431633] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.432122] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.434598] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
client # [    0.432320] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.434621] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.432347] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.434648] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.432833] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.434661] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.433037] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.435239] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.433063] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.435441] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.435456] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.435487] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.435999] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.436194] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.436207] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.436233] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.436725] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.436997] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.437013] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.437039] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.437051] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.437561] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.437755] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.437783] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.453488] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    0.438277] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
client # [    0.453684] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.453956] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.454153] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.456824] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.454180] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.456852] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.454674] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.457312] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.454952] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.457503] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.454979] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.457769] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.457962] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.455476] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.455676] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.457988] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.455703] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.456191] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.456466] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.456478] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.456505] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.456992] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.480284] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
client # [    0.480307] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.480334] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.470537] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.483487] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.470749] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.483494] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.470777] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.483497] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.471326] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.483547] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.471521] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.471547] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.483592] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.472060] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.483639] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.472383] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.483687] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.472395] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.483733] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.472420] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.483780] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.472946] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.473137] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
client # [    0.483826] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.473149] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.483872] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.473178] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.483917] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.473821] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
client # [    0.484039] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.473827] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
client # [    0.484093] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.473831] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
client # [    0.484112] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.473878] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
client # [    0.484130] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.473923] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
client # [    0.484152] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
client # [    0.484169] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.473968] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
client # [    0.484188] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.474017] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
client # [    0.484206] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.474069] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
client # [    0.484225] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.474115] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
client # [    0.484249] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.474160] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
client # [    0.484268] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
client # [    0.484286] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.474206] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
client # [    0.484305] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.474250] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
client # [    0.484323] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.474325] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
client # [    0.484340] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.474369] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
client # [    0.484360] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.474387] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
client # [    0.484380] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.474407] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
client # [    0.484398] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
client # [    0.484416] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
client # [    0.484438] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
client # [    0.484443] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
client # [    0.484446] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
client # [    0.517311] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.510499] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.510588] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.510607] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.510627] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.510647] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.510671] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.510690] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.510710] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.510730] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.510748] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.510767] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
client # [    0.540665] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    0.510785] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.510804] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.510822] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.510840] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.510867] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.510872] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.510875] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.511762] pci 0000:00:07.0: enabling device (0000 -> 0002)
client # [    0.550683] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    0.548862] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.561814] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
client # [    0.563961] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
client # [    0.568144] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    0.559220] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    0.562347] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
client # [    0.578630] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
client # [    0.580480] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    0.571866] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
client # [    0.584214] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    0.575990] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    0.578125] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
client # [    0.587136] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.588475] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
client # [    0.597754] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
client # [    0.600372] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    0.598711] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    0.601141] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.604794] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
client # [    0.614027] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client # [    0.618901] msm_serial: driver initialized
client # [    0.619046] SuperH (H)SCI(F) driver initialized
client # [    0.619104] STM32 USART driver initialized
server # [    0.615776] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    0.622376] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    0.632454] msm_serial: driver initialized
server # [    0.632606] SuperH (H)SCI(F) driver initialized
server # [    0.632663] STM32 USART driver initialized
client # [    0.656112] loop: module loaded
client # [    0.656320] virtio_blk virtio2: 1/0/0 default/read/poll queues
client # [    0.658535] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
client # [    0.665809] megasas: 07.734.00.00-rc1
client # [    0.666557] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.668752] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.668770] Intel/Sharp Extended Query Table at 0x0031
server # [    0.665583] loop: module loaded
server # [    0.665781] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    0.667867] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
client # [    0.682285] Using buffer write method
client # [    0.682338] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
client # [    0.684245] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.675241] megasas: 07.734.00.00-rc1
client # [    0.684263] Intel/Sharp Extended Query Table at 0x0031
client # [    0.685997] Using buffer write method
server # [    0.675985] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.686015] Concatenating MTD devices:
client # [    0.686017] (0): "0.flash"
client # [    0.686019] (1): "0.flash"
server # [    0.678299] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.686021] into device "0.flash"
server # [    0.678320] Intel/Sharp Extended Query Table at 0x0031
server # [    0.691610] Using buffer write method
server # [    0.691660] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    0.693708] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.693725] Intel/Sharp Extended Query Table at 0x0031
server # [    0.695870] Using buffer write method
server # [    0.695887] Concatenating MTD devices:
server # [    0.695889] (0): "0.flash"
server # [    0.695891] (1): "0.flash"
server # [    0.695893] into device "0.flash"
client # [    0.996007] Freeing initrd memory: 26428K
client # [    1.002650] tun: Universal TUN/TAP device driver, 1.6
client # [    1.006921] thunder_xcv, ver 1.0
client # [    1.006951] thunder_bgx, ver 1.0
client # [    1.006972] nicpf, ver 1.0
client # [    1.007558] e1000: Intel(R) PRO/1000 Network Driver
client # [    1.007562] e1000: Copyright (c) 1999-2006 Intel Corporation.
client # [    1.007588] e1000e: Intel(R) PRO/1000 Network Driver
client # [    1.007598] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
client # [    1.007624] igb: Intel(R) Gigabit Ethernet Network Driver
client # [    1.007627] igb: Copyright (c) 2007-2014 Intel Corporation.
client # [    1.007649] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    1.007653] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
client # [    1.007793] sky2: driver version 1.30
client # [    1.017727] ehci-pci 0000:00:07.0: EHCI Host Controller
client # [    1.017748] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
client # [    1.017932] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
client # [    1.018520] usbcore: registered new interface driver usb-storage
client # [    1.018620] usbcore: registered new interface driver usbserial_generic
client # [    1.018632] usbserial: USB Serial support registered for generic
client # [    1.019364] hv_vmbus: registering driver hyperv_keyboard
client # [    1.020264] rtc-pl031 9010000.pl031: registered as rtc0
client # [    1.020292] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T03:51:06 UTC (1790653866)
client # [    1.020608] i2c_dev: i2c /dev entries driver
client # [    1.029730] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
client # [    1.030056] hub 1-0:1.0: USB hub found
client # [    1.032691] sdhci: Secure Digital Host Controller Interface driver
client # [    1.032696] sdhci: Copyright(c) Pierre Ossman
client # [    1.032993] Synopsys Designware Multimedia Card Interface Driver
client # [    1.033145] hub 1-0:1.0: 6 ports detected
client # [    1.037975] sdhci-pltfm: SDHCI platform and OF driver helper
client # [    1.039733] hid: raw HID events driver (C) Jiri Kosina
client # [    1.039976] usbcore: registered new interface driver usbhid
client # [    1.039987] usbhid: USB HID core driver
client # [    1.044084] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
client # [    1.047031] drop_monitor: Initializing network drop monitor service
client # [    1.047253] NET: Registered PF_INET6 protocol family
client # [    1.047850] Segment Routing with IPv6
client # [    1.047884] In-situ OAM (IOAM) with IPv6
client # [    1.047912] NET: Registered PF_PACKET protocol family
client # [    1.047976] 9pnet: Installing 9P2000 support
client # [    1.048017] Key type dns_resolver registered
server # [    1.047959] Freeing initrd memory: 28280K
client # [    1.058969] registered taskstats version 1
client # [    1.059134] Loading compiled-in X.509 certificates
server # [    1.054918] tun: Universal TUN/TAP device driver, 1.6
server # [    1.058395] thunder_xcv, ver 1.0
server # [    1.058424] thunder_bgx, ver 1.0
client # [    1.068406] Demotion targets for Node 0: null
client # [    1.068542] Key type .fscrypt registered
client # [    1.068551] Key type fscrypt-provisioning registered
client # [    1.068708] ima: No TPM chip found, activating TPM-bypass!
client # [    1.068727] ima: Allocated hash algorithm: sha1
server # [    1.060090] nicpf, ver 1.0
client # [    1.068751] ima: No architecture policies found
server # [    1.060693] e1000: Intel(R) PRO/1000 Network Driver
server # [    1.060698] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    1.060724] e1000e: Intel(R) PRO/1000 Network Driver
server # [    1.060736] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    1.060760] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    1.060763] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    1.060783] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    1.073597] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.060786] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    1.061060] sky2: driver version 1.30
server # [    1.070083] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    1.070109] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    1.070363] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    1.070933] usbcore: registered new interface driver usb-storage
server # [    1.071025] usbcore: registered new interface driver usbserial_generic
server # [    1.071037] usbserial: USB Serial support registered for generic
server # [    1.071687] hv_vmbus: registering driver hyperv_keyboard
server # [    1.078341] rtc-pl031 9010000.pl031: registered as rtc0
server # [    1.078373] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T03:51:06 UTC (1790653866)
server # [    1.078474] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    1.078800] hub 1-0:1.0: USB hub found
server # [    1.078815] hub 1-0:1.0: 6 ports detected
client # [    1.092935] clk: Disabling unused clocks
client # [    1.092952] PM: genpd: Disabling unused power domains
server # [    1.083368] i2c_dev: i2c /dev entries driver
server # [    1.087576] sdhci: Secure Digital Host Controller Interface driver
client # [    1.097385] Freeing unused kernel memory: 4736K
server # [    1.087582] sdhci: Copyright(c) Pierre Ossman
client # [    1.097566] Run /init as init process
server # [    1.087872] Synopsys Designware Multimedia Card Interface Driver
server # [    1.088281] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    1.089946] hid: raw HID events driver (C) Jiri Kosina
server # [    1.090180] usbcore: registered new interface driver usbhid
server # [    1.090190] usbhid: USB HID core driver
server # [    1.096400] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    1.098054] drop_monitor: Initializing network drop monitor service
server # [    1.098255] NET: Registered PF_INET6 protocol family
server # [    1.101537] Segment Routing with IPv6
server # [    1.101554] In-situ OAM (IOAM) with IPv6
server # [    1.101581] NET: Registered PF_PACKET protocol family
server # [    1.101637] 9pnet: Installing 9P2000 support
server # [    1.101679] Key type dns_resolver registered
client # [    1.115672] systemd[1]: Successfully made /usr/ read-only.
client # [    1.116107] systemd[1]: systemd 263-583679f running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
client # [    1.116120] systemd[1]: Detected virtualization qemu.
client # [    1.116157] systemd[1]: Detected architecture arm64.
client # [    1.116162] systemd[1]: Running in initrd.
client # [    1.116434] systemd[1]: Initializing machine ID from random generator.
client # [    1.116524] systemd[1]: Hostname set to <client>.
server # [    1.110651] registered taskstats version 1
server # [    1.110834] Loading compiled-in X.509 certificates
server # [    1.119727] Demotion targets for Node 0: null
server # [    1.119850] Key type .fscrypt registered
server # [    1.119857] Key type fscrypt-provisioning registered
server # [    1.119960] ima: No TPM chip found, activating TPM-bypass!
server # [    1.119978] ima: Allocated hash algorithm: sha1
server # [    1.119997] ima: No architecture policies found
server # [    1.120736] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.145073] clk: Disabling unused clocks
server # [    1.145091] PM: genpd: Disabling unused power domains
server # [    1.149477] Freeing unused kernel memory: 4736K
server # [    1.149680] Run /init as init process
server # [    1.160994] systemd[1]: Successfully made /usr/ read-only.
server # [    1.161420] systemd[1]: systemd 263-583679f running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [    1.161434] systemd[1]: Detected virtualization qemu.
server # [    1.161453] systemd[1]: Detected architecture arm64.
server # [    1.161458] systemd[1]: Running in initrd.
server # [    1.161740] systemd[1]: Initializing machine ID from random generator.
server # [    1.161834] systemd[1]: Hostname set to <server>.
client # [    1.222210] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.276024] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    1.267592] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.280247] systemd[1]: Created slice Slice /system/modprobe.
client # [    1.280414] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    1.280439] systemd[1]: Expecting device /dev/disk/by-label/nixos...
client # [    1.280461] systemd[1]: Reached target Path Units.
client # [    1.280473] systemd[1]: Reached target Slice Units.
client # [    1.280487] systemd[1]: Reached target Swaps.
client # [    1.280500] systemd[1]: Reached target Timer Units.
client # [    1.280625] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    1.280736] systemd[1]: Listening on Journal Socket (/dev/log).
client # [    1.280873] systemd[1]: Listening on Journal Sockets.
client # [    1.280942] systemd[1]: Listening on udev Kernel Socket.
client # [    1.280954] systemd[1]: Reached target Socket Units.
client # [    1.285188] usb 1-1: new high-speed USB device number 2 using ehci-pci
client # [    1.292814] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.292876] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.298414] systemd[1]: Mounting Kernel Configuration File System...
client # [    1.309227] systemd[1]: Starting Journal Service...
client # [    1.329290] systemd[1]: Starting Load Kernel Modules...
client # [    1.329402] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    1.329264] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    1.333770] systemd[1]: Created slice Slice /system/modprobe.
server # [    1.333954] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    1.333982] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    1.333992] systemd[1]: Expecting device /dev/hvc0...
server # [    1.334001] systemd[1]: Expecting device /dev/ttyAMA0...
server # [    1.334027] systemd[1]: Reached target Path Units.
client # [    1.347866] systemd[1]: Starting Coldplug All udev Devices...
server # [    1.334040] systemd[1]: Reached target Slice Units.
server # [    1.334056] systemd[1]: Reached target Swaps.
server # [    1.334069] systemd[1]: Reached target Timer Units.
server # [    1.334195] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    1.334343] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    1.338520] usb 1-1: new high-speed USB device number 2 using ehci-pci
client # [    1.352570] systemd-journald[71]: Collecting audit messages is disabled.
server # [    1.344275] systemd[1]: Listening on Journal Sockets.
server # [    1.344529] systemd[1]: Listening on Network Management Metrics Varlink Socket.
server # [    1.344739] systemd[1]: Listening on Network Management Varlink Socket.
server # [    1.344864] systemd[1]: Listening on Network Management Netlink Socket.
server # [    1.344985] systemd[1]: Listening on Resolve Monitor Varlink Socket.
server # [    1.345066] systemd[1]: Listening on Resolve Service Varlink Socket.
server # [    1.345131] systemd[1]: Listening on udev Kernel Socket.
server # [    1.345144] systemd[1]: Reached target Socket Units.
server # [    1.353360] systemd[1]: Starting Copy secrets into place...
server # [    1.362428] systemd[1]: Starting Create List of Static Device Nodes...
server # [    1.362747] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.377388] systemd[1]: Finished Create List of Static Device Nodes.
client # [    1.382483] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    1.382763] systemd[1]: Mounted Kernel Configuration File System.
server # [    1.375849] systemd[1]: Mounting Kernel Configuration File System...
server # [    1.392164] systemd[1]: Starting Journal Service...
server # [    1.408029] systemd[1]: Starting Load Kernel Modules...
client # [    1.428659] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    1.418854] systemd[1]: Starting Generate Network Units from Kernel Command Line...
server # [    1.418979] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    1.437342] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.440423] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    1.449391] systemd-journald[72]: Collecting audit messages is disabled.
client # [    1.455452] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    1.451640] systemd[1]: Starting Coldplug All udev Devices...
client # [    1.463300] 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
client # [    1.470571] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
client # [    1.470814] [drm] features: -virgl +edid -resource_blob -host_visible
client # [    1.470817] [drm] features: -context_init
client # [    1.471678] [drm] number of scanouts: 1
client # [    1.471689] [drm] number of cap sets: 0
server # [    1.470591] systemd[1]: Finished Copy secrets into place.
server # [    1.474706] systemd[1]: Finished Create List of Static Device Nodes.
client # [    1.485471] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
client # [    1.485485] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    1.483167] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    1.495205] systemd[1]: Mounted Kernel Configuration File System.
server # [    1.503756] 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
client # [    1.513440] Console: switching to colour frame buffer device 160x50
server # [    1.515024] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
client # [    1.530155] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
client # [    1.531963] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    1.532187] systemd[1]: Reached target Preparation for Local File Systems.
client # [    1.532216] systemd[1]: Reached target Local File Systems.
client # [    1.538012] 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 # [    1.527417] systemd[1]: Finished Generate Network Units from Kernel Command Line.
server # [    1.527784] systemd[1]: Reached target Preparation for Network.
server # [    1.527999] systemd[1]: Listening on Network Management Resolve Hook Socket.
server # [    1.534587] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.545254] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    1.545691] systemd[1]: Started Journal Service.
client # [    1.540252] systemd-modules-load[72]: Inserted module 'dm_mod'
client # [    1.541500] systemd-modules-load[72]: Module 'virtio_balloon' is built in
client # [    1.542831] systemd-modules-load[72]: Module 'virtio_console' is built in
client # [    1.543969] systemd-modules-load[72]: Inserted module 'virtio_gpu'
client # [    1.556457] systemd-modules-load[72]: Module 'virtio_rng' is built in
client # [    1.557942] systemd[1]: Finished Load Kernel Modules.
server # [    1.560796] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    1.561079] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    1.561083] [drm] features: -context_init
server # [    1.561834] [drm] number of scanouts: 1
server # [    1.561845] [drm] number of cap sets: 0
server # [    1.570050] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    1.572811] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    1.569594] systemd[1]: Starting Apply Kernel Variables...
server # [    1.578834] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    1.578848] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    1.590680] 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
client # [    1.589285] systemd[1]: Starting Create System Files and Directories...
server # [    1.610832] Console: switching to colour frame buffer device 160x50
server # [    1.628110] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
client # [    1.633876] systemd-udevd[78]: Using default interface naming scheme 'v261'.
client # [    1.636997] systemd[1]: Finished Create System Files and Directories.
server # [    1.643124] systemd[1]: Finished Load Kernel Modules.
server # [    1.645178] systemd[1]: Starting Apply Kernel Variables...
client # [    1.657223] usb 1-2: new high-speed USB device number 3 using ehci-pci
client # [    1.649343] systemd[1]: Finished Apply Kernel Variables.
server # [    1.645506] systemd-modules-load[74]: Module 'af_packet' is built in
server # [    1.646926] systemd-modules-load[74]: Inserted module 'dm_mod'
server # [    1.647965] systemd-modules-load[74]: Module 'virtio_balloon' is built in
server # [    1.663614] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    1.664159] systemd[1]: Started Journal Service.
server # [    1.662152] systemd-modules-load[74]: Module 'virtio_console' is built in
server # [    1.663572] systemd-modules-load[74]: Inserted module 'virtio_gpu'
client # [    1.673871] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    1.672464] systemd-modules-load[74]: Module 'virtio_rng' is built in
server # [    1.673585] systemd[1]: Reached target Preparation for Local File Systems.
server # [    1.674735] systemd[1]: Reached target Local File Systems.
server # [    1.675706] systemd[1]: Starting Create System Files and Directories...
server # [    1.693304] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    1.703525] systemd[1]: Finished Apply Kernel Variables.[    1.714491] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # 
server # [    1.741959] systemd[1]: Starting Network Name Resolution...
client # [    1.755360] systemd[1]: Starting Virtual Console Setup...
server # [    1.748992] systemd[1]: Finished Create System Files and Directories.
client # [    1.812010] 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
client # [    1.812249] 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 # [    1.798895] systemd-udevd[88]: Using default interface naming scheme 'v261'.
client # [    1.837468] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [    1.844484] systemd[1]: Finished Virtual Console Setup.
server # [    1.841892] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    1.849666] systemd[1]: Starting Network Management...
server # [    1.883525] 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 # [    1.883813] 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 # [    1.876874] systemd-resolved[97]: Positive Trust Anchors:
server # [    1.888194] systemd-resolved[97]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
server # [    1.893000] systemd-resolved[97]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
server # [    1.904367] systemd-resolved[97]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
server # [    1.938558] systemd-resolved[97]: Using system hostname 'server'.
server # [    1.939573] systemd[1]: Starting D-Bus System Message Bus...
server # [    1.951670] systemd[1]: Started Network Name Resolution.
server # [    1.960568] dbus-daemon[104]: dbus[104]: Unknown username "systemd-timesync" in message bus configuration file
server # [    1.962070] dbus-daemon[104]: dbus[104]: Unknown username "systemd-oom" in message bus configuration file
server # [    1.974998] systemd[1]: Reached target Host and Network Name Lookups.
server # [    1.985525] systemd[1]: Started D-Bus System Message Bus.
server # [    2.022013] systemd-networkd[100]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported
server # [    2.037669] systemd-networkd[100]: lo: Link UP
server # [    2.044163] systemd-networkd[100]: lo: Gained carrier
server # [    2.049115] systemd[1]: Started Network Management.
server # [    2.050027] systemd[1]: Reached target Network.
server # [    2.056153] systemd[1]: Starting SSH Daemon...
server # [    2.075712] systemd[1]: Starting Virtual Console Setup...
server # [    2.111935] systemd[1]: Started SSH Daemon.
server # [    2.173447] systemd-vconsole-setup[118]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    2.184257] systemd[1]: Finished Virtual Console Setup.
server # [    2.193952] sshd[120]: Server listening on 0.0.0.0 port 22.
server # [    2.195116] sshd[120]: Server listening on :: port 22.
client # [    2.533660] systemd[1]: Finished Coldplug All udev Devices.
client # [    2.534725] systemd[1]: Reached target System Initialization.
client # [    2.535627] systemd[1]: Reached target Basic System.
client # [    2.691376] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    2.712881] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.
client # [    2.779677] systemd[1]: Found device /dev/disk/by-label/nixos.
client # [    2.784153] systemd[1]: Reached target Initrd Root Device.
client # [    2.786788] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
client # [    2.845460] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks
client # [    2.851815] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
client # [    2.861735] systemd[1]: Mounting /sysroot...
server # [    2.882650] systemd[1]: Finished Coldplug All udev Devices.
server # [    2.883644] systemd[1]: Reached target System Initialization.
server # [    2.884581] systemd[1]: Reached target Basic System.
client # [    2.899339] systemd[1]: Mounted /sysroot.
client # [    2.913346] EXT4-fs (vda): mounted filesystem 579fd726-d426-4465-b9f1-5e4ef7b014a8 r/w with ordered data mode. Quota mode: none.
client # [    2.903945] systemd[1]: Reached target Initrd Root File System.
client # [    2.909419] systemd[1]: Starting Mountpoints Configured in the Real Root...
client # [    2.938583] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.
client # [    2.946260] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...
client # [    2.948872] systemd[1]: Reloading...
server # [    3.009732] systemd[1]: Found device /dev/hvc0.
server # [    3.041411] systemd[1]: Found device /dev/ttyAMA0.
server # [    3.042945] systemd[1]: Started backdoor.service.
server # [    3.074338] backdoor-start[130]: /nix/store/7ha5lhh89qiqfnvv3zlydbcanibmd4n6-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found
server # connecting to host...
server # [    3.086657] (udev-worker)[103]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    3.098356] systemd-networkd[100]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.
server # [    3.105738] systemd-networkd[100]: eth0: Link UP
server # [    3.106538] systemd-networkd[100]: eth0: Gained carrier
server # [    3.108706] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.120636] systemd-networkd[100]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.2
client # [    3.144902] systemd[1]: Reloading finished in 198 ms.
server # [    3.154342] systemd-networkd[100]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network
server # [    3.163059] systemd-networkd[100]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
server # [    3.165632] systemd-networkd[100]: eth1: Link UP
server # [    3.166341] systemd-networkd[100]: eth1: Gained carrier
server # [    3.167191] systemd-networkd[100]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network
client # [    3.176769] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...
client # [    3.181041] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...
client # [    3.188570] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    3.181469] systemd[1]: Found device /dev/disk/by-label/nixos.
client # [    3.190173] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    3.184640] systemd[1]: Reached target Initrd Root Device.
client # [    3.192418] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    3.192140] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    3.247017] systemd-fsck[136]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    3.254002] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    3.267697] systemd[1]: Mounting /sysroot...
server # [    3.314205] EXT4-fs (vda): mounted filesystem 3cf15d86-f781-418c-91f9-42f28f61ca19 r/w with ordered data mode. Quota mode: none.
server # [    3.307128] systemd[1]: Mounted /sysroot.
server # [    3.310972] systemd[1]: Reached target Initrd Root File System.
server # [    3.314007] systemd[1]: Starting Mountpoints Configured in the Real Root...
client # [    3.336145] systemd[1]: Mounting /sysroot/nix/.ro-store...
client # [    3.346147] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.347171] systemd-sysroot-fstab-check[144]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    3.354127] systemd[1]: Reload requested from client PID 144 ('systemd-sysroot') (unit initrd-parse-etc.service)...
client # [    3.362683] systemd[1]: Mounting /sysroot/run...
server # [    3.356075] systemd[1]: Reloading...
client # [    3.382204] systemd[1]: Mounting /sysroot/tmp/shared...
client # [    3.405894] systemd[1]: Mounting /sysroot/tmp/xchg...
client # [    3.463668] fuse: init (API version 7.45)
client # [    3.480121] virtiofs virtio6: discovered new tag: nix-store
client # [    3.480944] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
client # [    3.478741] systemd[1]: Mounted /sysroot/run.[    3.494801] virtiofs virtio7: discovered new tag: shared
client # [    3.495700] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
client # 
client # [    3.504051] virtiofs virtio8: discovered new tag: xchg
client # [    3.504871] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
client # [    3.506322] systemd[1]: Mounted /sysroot/nix/.ro-store.
client # [    3.519124] systemd[1]: Mounted /sysroot/nix/.rw-store.
client # [    3.521552] systemd[1]: Mounted /sysroot/tmp/shared.
client # [    3.526834] systemd[1]: Mounted /sysroot/tmp/xchg.
client # [    3.536358] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    3.570183] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    3.571724] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    3.591405] systemd[1]: Reloading finished in 233 ms.
server # [    3.629346] systemd-sysroot-fstab-check[144]: Requesting initrd-fs.target/start/replace...
server # [    3.634528] systemd-sysroot-fstab-check[144]: Requesting swap.target/start/replace...
server # [    3.641782] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    3.655493] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.667829] systemd[1]: Mounting /sysroot/run...
server # [    3.696340] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    3.726590] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    3.758808] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    3.791933] fuse: init (API version 7.45)
server # [    3.797137] virtiofs virtio6: discovered new tag: nix-store
server # [    3.798025] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [    3.788662] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    3.789716] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    3.799105] systemd[1]: Mounted /sysroot/nix/.rw-store.[    3.812382] virtiofs virtio7: discovered new tag: shared
server # [    3.813301] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # 
server # [    3.811100] systemd[1]: Mounted /sysroot/run.
server # [    3.828172] virtiofs virtio8: discovered new tag: xchg
server # [    3.829056] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    3.827969] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    3.831584] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    3.855644] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    3.859435] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    3.886583] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    3.888173] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    4.082508] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/xv59xsz850c5vh4bpnm18knf45vr4kwl-systemd-263-583679f/lib/udev/mtd_probe": No such file or directory
client # [    4.090303] (udev-worker)[93]: 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
client # [    4.121369] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.124291] systemd[1]: Stopped Virtual Console Setup.
client # [    4.128187] systemd[1]: Stopping Virtual Console Setup...
client # [    4.129102] systemd[1]: Starting Virtual Console Setup...
client # [    4.144968] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.146634] systemd[1]: Stopped Virtual Console Setup.
client # [    4.150242] systemd[1]: Starting Virtual Console Setup...
client # [    4.178091] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [    4.181686] systemd[1]: Finished Virtual Console Setup.
client # [    4.335590] systemd[1]: Mounting /sysroot/nix/store...
client # [    4.379181] systemd[1]: Mounted /sysroot/nix/store.
client # [    4.383389] systemd[1]: Reached target Initrd File Systems.
client # [    4.388328] systemd[1]: Starting Find NixOS closure...
client # [    4.395777] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
client # [    4.433270] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
client # [    4.439329] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
client # [    4.446784] systemd[1]: Finished Find NixOS closure.
client # [    4.448314] systemd[1]: Reached target Initrd Default Target.
client # [    4.450890] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    4.450079] systemd-networkd[100]: eth0: Gained IPv6LL
client # [    4.478215] systemd[1]: Stopped target Initrd Default Target.
client # [    4.479814] systemd[1]: Stopped target Basic System.
client # [    4.481178] systemd[1]: Stopped target Initrd Root Device.
client # [    4.482357] systemd[1]: Stopped target Path Units.
client # [    4.484210] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
client # [    4.488400] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
client # [    4.489823] systemd[1]: Stopped target Slice Units.
client # [    4.492130] systemd[1]: Stopped target Socket Units.
client # [    4.493588] systemd[1]: Stopped target System Initialization.
client # [    4.496126] systemd[1]: Stopped target Swaps.
client # [    4.497553] systemd[1]: Stopped target Timer Units.
client # [    4.503473] systemd[1]: dbus.socket: Deactivated successfully.
client # [    4.505580] systemd[1]: Closed D-Bus System Message Bus Socket.
client # [    4.506593] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
client # [    4.507707] systemd[1]: Stopped Find NixOS closure.
client # [    4.520341] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    4.521290] systemd[1]: systemd-sysctl.service: Deactivated successfully.
client # [    4.522406] systemd[1]: Stopped Apply Kernel Variables.
client # [    4.523175] systemd[1]: systemd-modules-load.service: Deactivated successfully.
client # [    4.533057] systemd[1]: Stopped Load Kernel Modules.
client # [    4.534113] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
client # [    4.538523] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
client # [    4.542142] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
client # [    4.543738] systemd[1]: Stopped Create System Files and Directories.
client # [    4.546268] systemd[1]: Stopped target Local File Systems.
client # [    4.547922] systemd[1]: Stopped target Preparation for Local File Systems.
client # [    4.552522] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
client # [    4.553604] systemd[1]: Stopped Coldplug All udev Devices.
client # [    4.554495] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
client # [    4.555547] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.558428] systemd[1]: Stopped Virtual Console Setup.
client # [    4.559230] systemd[1]: initrd-cleanup.service: Deactivated successfully.
client # [    4.560330] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
client # [    4.561278] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    4.562323] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    4.563173] systemd[1]: systemd-udevd.service: Deactivated successfully.
client # [    4.568272] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
client # [    4.569386] systemd[1]: systemd-udevd.service: Consumed 1.539s CPU time over 3.012s wall clock time, 22.5M memory peak.
client # [    4.572720] systemd[1]: Starting Cleanup udev Database...
client # [    4.576259] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
client # [    4.577443] systemd[1]: Stopped Create Static Device Nodes in /dev.
client # [    4.580150] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
client # [    4.584145] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
client # [    4.585198] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
client # [    4.586238] systemd[1]: Stopped Create List of Static Device Nodes.
server # [    4.588756] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/xv59xsz850c5vh4bpnm18knf45vr4kwl-systemd-263-583679f/lib/udev/mtd_probe": No such file or directory
server # [    4.595896] (udev-worker)[102]: 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
client # [    4.614705] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
client # [    4.618361] systemd[1]: Finished Cleanup udev Database.
client # [    4.619250] systemd[1]: Reached target Switch Root.
client # [    4.620953] systemd[1]: Starting NixOS Activation...
server # [    4.644410] systemd[1]: Mounting /sysroot/nix/store...
server # [    4.648148] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.649275] systemd[1]: Stopped Virtual Console Setup.
server # [    4.650014] systemd[1]: Stopping Virtual Console Setup...
server # [    4.652127] systemd[1]: Starting Virtual Console Setup...
client # [    4.697086] initrd-nixos-activation-start[175]: booting system configuration /nix/store/9j3nlflp3br9kbwm09hlmgf409yji1rx-nixos-system-client-test
server # [    4.702737] systemd-vconsole-setup[185]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    4.705977] systemd[1]: Finished Virtual Console Setup.
server # [    4.708713] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
server # [    4.712103] systemd[1]: Mounted /sysroot/nix/store.
server # [    4.713862] systemd[1]: Reached target Initrd File Systems.
client # [    4.728001] initrd-nixos-activation-start[175]: running activation script...
server # [    4.721279] systemd[1]: Starting Find NixOS closure...
server # [    4.722493] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    4.749952] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    4.762109] systemd[1]: Finished Find NixOS closure.
server # [    4.764155] systemd[1]: Reached target Initrd Default Target.
server # [    4.765951] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    4.784409] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    4.785672] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    4.800677] systemd[1]: Startup finished in 1.140s (kernel) + 0 (initrd) + 3.659s (userspace) = 4.800s.
server # [    4.929179] systemd-networkd[100]: eth1: Gained IPv6LL
client # [    4.949100] initrd-nixos-activation-start[198]: setting up /etc...
client # [    5.064202] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
client # [    5.067072] systemd[1]: Finished NixOS Activation.
client # [    5.068402] systemd[1]: Starting Switch Root...
client # [    5.092168] systemd[1]: Switching root.
client # [    5.274594] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).
client # [    5.436571] systemd[1]: systemd 263-583679f running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
client # [    5.444823] systemd[1]: Detected virtualization qemu.
client # [    5.444885] systemd[1]: Detected architecture arm64.
client # [    5.444983] systemd[1]: Detected first boot.
client # [    5.450142] systemd[1]: Initializing machine ID from random generator.
client # [    5.580018] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    5.634822] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
client # [    5.723506] systemd[1]: Applying preset policy.
client # [    5.918811] systemd[1]: Populated /etc with preset unit settings.
client # [    6.115313] systemd[1]: initrd-switch-root.service: Deactivated successfully.
client # [    6.116134] systemd[1]: Stopped initrd-switch-root.service.
client # [    6.120868] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
client # [    6.124938] systemd[1]: Created slice Slice /system/getty.
client # [    6.127891] systemd[1]: Created slice User and Session Slice.
client # [    6.128458] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    6.131411] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
client # [    6.131839] systemd[1]: Expecting device /dev/hvc0...
client # [    6.132405] systemd[1]: Expecting device /dev/ttyAMA0...
client # [    6.132981] systemd[1]: Reached target Local Encrypted Volumes.
client # [    6.137283] systemd[1]: Stopped target initrd-fs.target.
client # [    6.137681] systemd[1]: Stopped target initrd-root-fs.target.
client # [    6.138251] systemd[1]: Stopped target initrd-switch-root.target.
client # [    6.138863] systemd[1]: Reached target Virtual Machines and Containers.
client # [    6.139440] systemd[1]: Reached target Path Units.
client # [    6.139974] systemd[1]: Reached target Remote File Systems.
client # [    6.140509] systemd[1]: Reached target Slice Units.
client # [    6.141061] systemd[1]: Reached target Swaps.
client # [    6.149004] systemd[1]: Listening on Query the User Interactively for a Password.
client # [    6.152070] systemd[1]: Listening on Process Core Dump Socket.
client # [    6.154280] systemd[1]: Listening on Credential Encryption/Decryption.
client # [    6.155540] systemd[1]: Listening on Factory Reset Management.
client # [    6.156040] systemd[1]: Listening on Hostname Service Socket.
client # [    6.161929] systemd[1]: Starting Journal Log Access Socket...
client # [    6.163313] systemd[1]: Listening on Journal Audit Socket.
client # [    6.166784] systemd[1]: Listening on Console Output Muting Service Socket.
client # [    6.167580] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
client # [    6.167919] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.168234] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
client # [    6.177617] systemd[1]: Listening on Disk Repartitioning Service Socket.
client # [    6.178249] systemd[1]: Listening on udev Varlink Socket.
client # [    6.183254] systemd[1]: Mounting Huge Pages File System...
client # [    6.187004] systemd[1]: Mounting POSIX Message Queue File System...
client # [    6.201318] systemd[1]: Mounting Kernel Debug File System...
client # [    6.211017] systemd[1]: Mounting Kernel Trace File System...
client # [    6.229252] systemd[1]: Starting Create List of Static Device Nodes...
client # [    6.229799] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    6.242345] systemd[1]: Mounting Kernel Configuration File System...
client # [    6.244062] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
client # [    6.251314] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
client # [    6.256042] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [    6.286394] systemd[1]: Mounting FUSE Control File System...
client # [    6.286930] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
client # [    6.310426] systemd[1]: Starting Journal Service...
client # [    6.328730] systemd[1]: Starting Load Kernel Modules...
client # [    6.348545] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
client # [    6.381383] systemd[1]: Starting Remount Root and Kernel File Systems...
client # [    6.381808] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.401983] systemd[1]: Starting Coldplug All udev Devices...
client # [    6.404891] systemd[1]: Listening on Journal Log Access Socket.
client # [    6.410838] systemd-journald[269]: Collecting audit messages is enabled.
client # [    6.417921] systemd[1]: Mounted Huge Pages File System.
client # [    6.418435] systemd[1]: Mounted POSIX Message Queue File System.
client # [    6.418913] systemd[1]: Mounted Kernel Debug File System.
client # [    6.419310] systemd[1]: Mounted Kernel Trace File System.
client # [    6.409261] systemd[1]: Queued start job for default target Multi-User System.
client # [    6.430840] systemd[1]: Finished Create List of Static Device Nodes.
client # [    6.431505] systemd[1]: Started Journal Service.
client # [    6.420544] systemd[1]: systemd-journald.service: Deactivated successfully.
client # [    6.430887] systemd-modules-load[270]: Module 'atkbd' is built in
client # [    6.435051] systemd-modules-load[270]: Module 'loop' is built in
client # [    6.445645] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    6.452185] systemd[1]: Finished Load Kernel Modules.
client # [    6.498368] systemd[1]: Starting Firewall...
client # [    6.513241] EXT4-fs (vda): re-mounted 579fd726-d426-4465-b9f1-5e4ef7b014a8.
client # [    6.514592] systemd-oomd[271]: No swap; memory pressure usage will be degraded
client # [    6.520404] systemd[1]: Starting Apply Kernel Variables...
client # [    6.521314] systemd[1]: Mounted Kernel Configuration File System.
client # [    6.522304] systemd[1]: Mounted FUSE Control File System.
client # [    6.527764] systemd[1]: Finished Remount Root and Kernel File Systems.
client # [    6.534862] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
client # [    6.553296] systemd[1]: Listening on Disk Image Download Service Socket.
client # [    6.562697] systemd[1]: Starting Flush Journal to Persistent Storage...
client # [    6.563811] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
client # [    6.579390] systemd[1]: Starting Load/Save OS Random Seed...
client # [    6.587502] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.685944] systemd-journald[269]: Received client request to flush runtime journal.
client # [    6.749388] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    6.750783] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    6.751876] systemd[1]: Finished Load/Save OS Random Seed.
client # [    6.764382] systemd[1]: Reached target First Boot Complete.
client # [    6.765251] systemd[1]: Finished Apply Kernel Variables.
client # [    6.766089] systemd[1]: Finished Flush Journal to Persistent Storage.
client # [    6.888968] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    6.892141] systemd[1]: Reached target Preparation for Local File Systems.
client # [    6.897056] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    7.044870] systemd-udevd[304]: Using default interface naming scheme 'v261'.
client # [    7.106749] systemd[1]: Mounting /run/wrappers...
client # [    7.162471] systemd[1]: Mounted /run/wrappers.
client # [    7.163417] systemd[1]: Reached target Local File Systems.
client # [    7.168263] systemd[1]: Listening on Boot Loader Control Service Socket.
client # [    7.173584] systemd[1]: Starting Create SUID/SGID Wrappers...
client # [    7.174627] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
client # [    7.184173] systemd[1]: Starting Save Transient machine-id to Disk...
client # [    7.185254] systemd[1]: Starting Create System Files and Directories...
client # [    7.197133] systemd[1]: Started Rule-based Manager for Device Events and Files.
client # [    7.314384] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
client # [    7.323564] systemd[1]: Finished Save Transient machine-id to Disk.
client # [    7.385326] systemd[1]: Finished Create System Files and Directories.
client # [    7.399106] systemd[1]: Starting Rebuild Journal Catalog...
client # [    7.405266] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
client # [    7.529250] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
client # [    7.540644] systemd[1]: Finished Rebuild Journal Catalog.
client # [    7.552329] systemd[1]: Starting Update is Completed...
client # [    7.624461] systemd[1]: Finished Update is Completed.
client # [    8.068373] systemd[1]: Finished Coldplug All udev Devices.
client # [    8.151191] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    8.205254] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [    8.209664] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
client # [    8.216107] systemd[1]: Finished Create SUID/SGID Wrappers.
client # [    8.217126] systemd[1]: Reached target System Initialization.
client # [    8.218047] systemd[1]: Started Discard unused filesystem blocks once a week.
client # [    8.219090] systemd[1]: Started Daily Cleanup of Temporary Directories.
client # [    8.228829] systemd[1]: Reached target Timer Units.
client # [    8.230066] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    8.231002] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
client # [    8.241455] systemd[1]: Reached target Socket Units.
client # [    8.242348] systemd[1]: Reached target Basic System.
client # [    8.243126] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [    8.256063] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [    8.257221] systemd[1]: Starting Post-Boot Actions...
client # [    8.265783] systemd[1]: Started Reset console on configuration changes.
client # [    8.305340] systemd[1]: Starting resolvconf update...
client # [    8.353908] systemd[1]: Starting D-Bus System Message Bus...
client # [    8.375397] systemd[1]: Finished Post-Boot Actions.
client # [    8.441884] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    8.448898] systemd[1]: Reached target Host and Network Name Lookups.
client # [    8.450370] nsncd[441]: Sep 29 03:51:13.935 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    8.468248] systemd[1]: Reached target User and Group Name Lookups.
client # [    8.480692] systemd[1]: Starting User Login Management...
client # [    8.575920] systemd[1]: Finished Import lastlog data into lastlog2 database.
client # [    8.598909] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'...
client # [    8.611242] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync'
client # [    8.617366] dbus-broker-launch[447]: Invalid user-name in /nix/store/0wzpy01spp8y5fh7ys04p3kvysprhmsi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
client # [    8.665313] systemd[1]: Started D-Bus System Message Bus.
client # [    8.711178] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
client # [    8.722381] dbus-broker-launch[447]: Ready
client # [    8.753819] systemd-logind[467]: New seat seat0.
client # [    8.762156] systemd[1]: Started User Login Management.
client # [    8.769759] systemd[1]: Starting linger-users.service...
client # [    8.804269] systemd[1]: Stopped target Host and Network Name Lookups.
client # [    8.805449] systemd[1]: Stopping Host and Network Name Lookups...
client # [    8.806492] systemd[1]: Stopped target User and Group Name Lookups.
client # [    8.807459] systemd[1]: Stopping User and Group Name Lookups...
client # [    8.820855] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
client # [    8.822050] systemd[1]: nscd.service: Deactivated successfully.
client # [    8.823113] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
client # [    8.852404] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
client # [    8.870999] systemd[1]: Started backdoor.service.
client # [    8.901674] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [    8.902926] systemd[1]: linger-users.service: Deactivated successfully.
client # [    8.908966] systemd[1]: Finished linger-users.service.
client # [    8.991001] systemd[1]: Finished resolvconf update.
client # [    9.007408] systemd[1]: Starting DHCP Client...
client # [    9.013480] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    9.025112] nsncd[537]: Sep 29 03:51:14.510 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    9.035991] systemd[1]: Reached target Host and Network Name Lookups.
client # [    9.042127] systemd[1]: Reached target User and Group Name Lookups.
client # connecting to host...
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 9.43 seconds)
client: (finished: waiting for the VM to finish booting, in 9.43 seconds)
client # [    9.154122] (udev-worker)[390]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    9.167765] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line.
client # [    9.174153] systemd[1]: Finished Firewall.
client # [    9.174875] systemd[1]: Reached target Preparation for Network.
client # [    9.182969] systemd[1]: Starting Extra networking commands....
client # [    9.335507] dhcpcd[579]: dhcpcd-10.3.2 starting
client # [    9.352808] dhcpcd[599]: dev: loaded udev
client # [    9.426775] 8021q: 802.1Q VLAN Support v1.8
client # [    9.567293] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client # [    9.583932] systemd[1]: Finished Extra networking commands..
client # [    9.590250] systemd[1]: Reached target Network.
client # [    9.593594] systemd[1]: Starting Permit User Sessions...
client # [    9.625503] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client # [    9.625995] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
client # [    9.627225] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
client # [    9.627514] cfg80211: failed to load regulatory.db
client # [    9.634584] systemd[1]: Condition check resulted in Virtio network device being skipped.
client # [    9.643532] systemd[1]: Starting Address configuration of eth1...
client # [    9.679734] systemd-logind[467]: Watching system buttons on /dev/input/event0 (gpio-keys)
client # [    9.685099] systemd[1]: Finished Permit User Sessions.
client # [    9.700980] systemd[1]: Started Getty on tty1.
client # [    9.701929] systemd[1]: Reached target Login Prompts.
client # [    9.738860] dhcpcd[599]: eth0: waiting for carrier[    9.754400] 8021q: adding VLAN 0 to HW filter on device eth0
client # 
client # [    9.744408] dhcpcd[599]: eth0: waiting for carrier
client # [    9.745204] dhcpcd[599]: eth0: carrier acquired
client # [    9.762122] dhcpcd[599]: DUID 00:01:00:01:32:4d:f2:33:52:54:00:12:34:56
client # [    9.763168] dhcpcd[599]: eth0: IAID 00:12:34:56
client # [    9.763822] dhcpcd[599]: eth0: adding address fe80::5054:ff:fe12:3456
client # [    9.805598] 8021q: adding VLAN 0 to HW filter on device eth1
client # [    9.810016] network-addresses-eth1-start[656]: adding address 192.168.1.1/24... done
client # [    9.828841] network-addresses-eth1-start[656]: adding address 2001:db8:1::1/64... done
client # [    9.848156] systemd[1]: Finished Address configuration of eth1.
client # [    9.878448] mousedev: PS/2 mouse device common for all mice
client # [    9.959811] dhcpcd[599]: eth0: soliciting a DHCP lease
client # [    9.964490] dhcpcd[599]: eth0: offered 10.0.2.15 from 10.0.2.2
client # [    9.972250] dhcpcd[599]: eth0: probing address 10.0.2.15/24
client # [    9.974402] systemd-logind[467]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
client: (finished: waiting for unit network.target, in 10.76 seconds)
client: waiting for SSH server to come up
client # Connection to server (2001:db8:1::2) 22 port [tcp/ssh] succeeded!
client: (finished: waiting for SSH server to come up, in 0.07 seconds)
client: must succeed: ssh -i /etc/sshKey -o UserKnownHostsFile=/etc/knownHosts server 'cat /etc/msg'
server # [   10.535038] sshd-session[201]: Connection closed by 2001:db8:1::1 port 41904 [preauth]
server # [   10.701935] sshd-session[203]: Accepted publickey for root from 2001:db8:1::1 port 41908 ssh2: ED25519 SHA256:Du3JdgNSW22b+NOGBZzlhBt3FKLjV6HeV/QEF2L7Xg4
client # [   10.728496] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   10.723053] sshd-session[205]: Received disconnect from 2001:db8:1::1 port 41908:11: disconnected by user
server # [   10.726069] sshd-session[205]: Disconnected from user root 2001:db8:1::1 port 41908
client: (finished: must succeed: ssh -i /etc/sshKey -o UserKnownHostsFile=/etc/knownHosts server 'cat /etc/msg', in 0.20 seconds)
server: waiting for unit initrd.target
server: waiting for the VM to finish booting
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 0.00 seconds)
server: (finished: waiting for the VM to finish booting, in 0.00 seconds)
server: (finished: waiting for unit initrd.target, in 0.02 seconds)
server: waiting for the VM to finish booting
server # [   10.776655] systemd[1]: Stopped target Initrd Default Target.
server # [   10.780124] systemd[1]: Stopped target Basic System.
server # [   10.784210] systemd[1]: Stopped target Initrd Root Device.
server # [   10.785372] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   10.786624] systemd[1]: Stopped target Path Units.
server # [   10.787574] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   10.796292] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   10.799526] systemd[1]: Stopped target Slice Units.
server # [   10.804395] systemd[1]: Stopped target Socket Units.
server # [   10.805401] systemd[1]: Stopped target System Initialization.
server # [   10.806481] systemd[1]: Stopped target Swaps.
server # [   10.807359] systemd[1]: Stopped target Timer Units.
server # [   10.812276] systemd[1]: Stopping backdoor.service...
server # [   10.813208] systemd[1]: Stopping D-Bus System Message Bus...
server # [   10.814168] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   10.815359] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   10.820514] systemd[1]: Stopped Find NixOS closure.
server # [   10.823020] sshd[120]: Received signal 15; terminating.
server # [   10.824749] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   10.826393] systemd[1]: Stopping SSH Daemon...
server # [   10.827225] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   10.842829] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   10.846037] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   10.847454] systemd[1]: Stopped Create System Files and Directories.
server # [   10.852471] systemd[1]: Stopped target Local File Systems.
server # [   10.855148] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   10.859235] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   10.863949] systemd[1]: Stopped Coldplug All udev Devices.
server # [   10.867245] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   10.868896] systemd[1]: Stopped Virtual Console Setup.
server # [   10.869673] systemd[1]: dbus.service: Deactivated successfully.
server # [   10.870612] systemd[1]: Stopped D-Bus System Message Bus.
server # [   10.871411] systemd[1]: sshd.service: Deactivated successfully.
server # [   10.875796] systemd[1]: Stopped SSH Daemon.
server # [   10.878089] systemd[1]: backdoor.service: Deactivated successfully.
server # [   10.879962] systemd[1]: Stopped backdoor.service.
server # [   10.884499] systemd[1]: Stopped target Network.
server # [   10.885237] systemd[1]: dbus.socket: Deactivated successfully.
server # [   10.886079] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   10.887042] systemd[1]: initrd-nixos-copy-secrets.service: Deactivated successfully.
server # [   10.892265] systemd[1]: Stopped Copy secrets into place.
server # [   10.893872] systemd[1]: Stopping Network Management...
server # [   10.895716] systemd[1]: Stopping Network Name Resolution...
server # [   10.900630] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   10.901645] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   10.902707] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   10.903749] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   10.905533] systemd[1]: systemd-resolved.service: Deactivated successfully.
server # [   10.906586] systemd[1]: Stopped Network Name Resolution.
server # [   10.907373] systemd[1]: sysroot-run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
server # [   10.909006] systemd[1]: systemd-networkd.service: Deactivated successfully.
server # [   10.910029] systemd[1]: Stopped Network Management.
server # [   10.910838] systemd[1]: sysroot-run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
server # [   10.916275] systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully.
server # [   10.917524] systemd[1]: Closed Network Management Resolve Hook Socket.
server # [   10.919533] systemd[1]: Stopped target Preparation for Network.
server # [   10.924307] systemd[1]: systemd-networkd-varlink-metrics.socket: Deactivated successfully.
server # [   10.925477] systemd[1]: Closed Network Management Metrics Varlink Socket.
server # [   10.926523] systemd[1]: systemd-networkd-varlink.socket: Deactivated successfully.
server # [   10.927604] systemd[1]: Closed Network Management Varlink Socket.
server # [   10.932200] systemd[1]: systemd-networkd.socket: Deactivated successfully.
server # [   10.933212] systemd[1]: Closed Network Management Netlink Socket.
server # [   10.934103] systemd[1]: systemd-resolved-monitor.socket: Deactivated successfully.
server # [   10.936161] systemd[1]: Closed Resolve Monitor Varlink Socket.
server # [   10.940397] systemd[1]: systemd-resolved-varlink.socket: Deactivated successfully.
server # [   10.941507] systemd[1]: Closed Resolve Service Varlink Socket.
server # [   10.942387] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   10.948387] systemd[1]: Stopped Apply Kernel Variables.
server # [   10.949357] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   10.950435] systemd[1]: Stopped Load Kernel Modules.
server # [   10.951193] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [   10.956519] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   10.957505] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   10.958564] systemd[1]: systemd-udevd.service: Consumed 1.636s CPU time over 9.198s wall clock time, 22.2M memory peak.
server # [   10.960121] systemd[1]: Starting Cleanup udev Database...
server # [   10.964480] systemd[1]: systemd-network-generator.service: Deactivated successfully.
server # [   10.965632] systemd[1]: Stopped Generate Network Units from Kernel Command Line.
server # [   10.968351] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   10.969494] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [   10.972238] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   10.976257] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   10.977320] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   10.978321] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   10.985603] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [   10.988569] systemd[1]: Finished Cleanup udev Database.
server # [   10.990141] systemd[1]: Reached target Switch Root.
server # [   10.992307] systemd[1]: Starting NixOS Activation...
client # [   11.046639] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client # [   11.054072] systemd[1]: Starting Virtual Console Setup...
server # [   11.073024] initrd-nixos-activation-start[230]: booting system configuration /nix/store/kdk7ki33im0w5z8nr0dhs0hsg5pqdc50-nixos-system-server-test
client # [   11.085036] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [   11.090061] systemd[1]: Stopped Virtual Console Setup.
client # [   11.100679] systemd[1]: Starting Virtual Console Setup...
server # [   11.105837] initrd-nixos-activation-start[230]: running activation script...
client # [   11.147348] systemd-logind[467]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
client # [   11.278661] systemd-vconsole-setup[702]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [   11.283606] systemd[1]: Finished Virtual Console Setup.
server # [   11.318151] initrd-nixos-activation-start[253]: setting up /etc...
server # [   11.437767] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   11.440988] systemd[1]: Finished NixOS Activation.
server # [   11.442285] systemd[1]: Starting Switch Root...
server # [   11.461162] systemd[1]: Switching root.
client # [   11.609089] dhcpcd[599]: eth0: soliciting an IPv6 router
client # [   11.611390] dhcpcd[599]: eth0: Router Advertisement from fe80::2
client # [   11.612962] dhcpcd[599]: eth0: adding address fec0::5054:ff:fe12:3456/64
client # [   11.614533] dhcpcd[599]: eth0: adding route to fec0::/64
client # [   11.615745] dhcpcd[599]: eth0: adding default route via fe80::2
server # [   11.632070] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).
server # [   11.793626] systemd[1]: systemd 263-583679f running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [   11.801997] systemd[1]: Detected virtualization qemu.
server # [   11.802078] systemd[1]: Detected architecture arm64.
server # [   11.802188] systemd[1]: Detected first boot.
server # [   11.806805] systemd[1]: Initializing machine ID from random generator.
server # [   11.947099] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   12.093919] systemd[1]: Applying preset policy.
server # [   12.320955] systemd[1]: Populated /etc with preset unit settings.
server # [   12.520296] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   12.521125] systemd[1]: Stopped initrd-switch-root.service.
server # [   12.525447] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   12.529000] systemd[1]: Created slice Slice /system/getty.
server # [   12.530247] systemd[1]: Created slice User and Session Slice.
server # [   12.533200] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   12.533709] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   12.534297] systemd[1]: Expecting device /dev/hvc0...
server # [   12.538171] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   12.539963] systemd[1]: Reached target Local Encrypted Volumes.
server # [   12.540365] systemd[1]: Stopped target initrd-fs.target.
server # [   12.541048] systemd[1]: Stopped target initrd-root-fs.target.
server # [   12.541625] systemd[1]: Stopped target initrd-switch-root.target.
server # [   12.542186] systemd[1]: Reached target Virtual Machines and Containers.
server # [   12.547226] systemd[1]: Reached target Path Units.
server # [   12.547626] systemd[1]: Reached target Remote File Systems.
server # [   12.548233] systemd[1]: Reached target Slice Units.
server # [   12.548893] systemd[1]: Reached target Swaps.
server # [   12.553339] systemd[1]: Listening on Query the User Interactively for a Password.
server # [   12.556384] systemd[1]: Listening on Process Core Dump Socket.
server # [   12.557780] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   12.561053] systemd[1]: Listening on Factory Reset Management.
server # [   12.561551] systemd[1]: Listening on Hostname Service Socket.
server # [   12.567020] systemd[1]: Starting Journal Log Access Socket...
server # [   12.567883] systemd[1]: Listening on Journal Audit Socket.
server # [   12.569964] systemd[1]: Listening on Console Output Muting Service Socket.
server # [   12.573763] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   12.574176] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [   12.574426] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   12.582673] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [   12.583250] systemd[1]: Listening on udev Varlink Socket.
server # [   12.585805] systemd[1]: Mounting Huge Pages File System...
server # [   12.598551] systemd[1]: Mounting POSIX Message Queue File System...
server # [   12.610556] systemd[1]: Mounting Kernel Debug File System...
server # [   12.618290] systemd[1]: Mounting Kernel Trace File System...
server # [   12.631335] systemd[1]: Starting Create List of Static Device Nodes...
server # [   12.632628] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   12.666133] systemd[1]: Mounting Kernel Configuration File System...
server # [   12.670689] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   12.671069] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   12.671355] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [   12.703741] systemd[1]: Mounting FUSE Control File System...
server # [   12.704335] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   12.725241] systemd[1]: Starting Journal Service...
server # [   12.742866] systemd[1]: Starting Load Kernel Modules...
server # [   12.756987] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   12.791288] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   12.791718] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   12.797652] systemd[1]: Starting Coldplug All udev Devices...
server # [   12.801395] systemd[1]: Listening on Journal Log Access Socket.
server # [   12.801851] systemd[1]: Mounted Huge Pages File System.
server # [   12.802253] systemd[1]: Mounted POSIX Message Queue File System.
server # [   12.817356] systemd[1]: Mounted Kernel Debug File System.
server # [   12.817869] systemd[1]: Mounted Kernel Trace File System.
server # [   12.826308] systemd-journald[324]: Collecting audit messages is enabled.
server # [   12.832401] systemd[1]: Queued start job for default target Multi-User System.
server # [   12.833937] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   12.842599] systemd-modules-load[325]: Module 'atkbd' is built in
server # [   12.847174] systemd-modules-load[325]: Module 'loop' is built in[   12.858791] systemd[1]: Finished Create List of Static Device Nodes.
server # [   12.860761] systemd[1]: Started Journal Service.
server # 
server # [   12.855349] systemd[1]: Mounted Kernel Configuration File System.
server # [   12.861331] systemd[1]: Mounted FUSE Control File System.
server # [   12.867379] systemd[1]: Finished Load Kernel Modules.
server # [   12.893536] systemd[1]: Starting Firewall...
server # [   12.902285] systemd[1]: Starting Apply Kernel Variables...
server # [   12.911563] systemd-oomd[326]: No swap; memory pressure usage will be degraded
server # [   12.921089] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   12.925068] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   12.942671] EXT4-fs (vda): re-mounted 3cf15d86-f781-418c-91f9-42f28f61ca19.
server # [   12.954576] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   12.971875] systemd[1]: Listening on Disk Image Download Service Socket.
server # [   12.980195] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   12.981266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   12.997521] systemd[1]: Starting Load/Save OS Random Seed...
server # [   12.998631] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   13.085326] systemd[1]: Finished Apply Kernel Variables.
server # [   13.106875] systemd-journald[324]: Received client request to flush runtime journal.
server # [   13.196545] systemd[1]: Finished Load/Save OS Random Seed.
server # [   13.201879] systemd[1]: Reached target First Boot Complete.
server # [   13.202945] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   13.203990] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   13.209303] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   13.323025] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   13.324301] systemd[1]: Reached target Preparation for Local File Systems.
server # [   13.330281] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   13.501465] systemd-udevd[363]: Using default interface naming scheme 'v261'.
server # [   13.517658] systemd[1]: Mounting /run/wrappers...
server # [   13.585401] systemd[1]: Mounted /run/wrappers.
server # [   13.586294] systemd[1]: Reached target Local File Systems.
server # [   13.595341] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   13.600200] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   13.601159] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   13.610576] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   13.624368] systemd[1]: Starting Create System Files and Directories...
server # [   13.650043] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   13.798094] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   13.809715] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   13.855643] systemd[1]: Finished Create System Files and Directories.
server # [   13.862915] systemd[1]: Starting Rebuild Journal Catalog...
server # [   13.872300] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   13.981136] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   14.012831] systemd[1]: Finished Rebuild Journal Catalog.
server # [   14.025817] systemd[1]: Starting Update is Completed...
server # [   14.084852] systemd[1]: Finished Update is Completed.
server # [   14.665402] systemd[1]: Finished Coldplug All udev Devices.
server # [   14.722266] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   14.756429] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   14.760233] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   14.765380] systemd[1]: Reached target System Initialization.
server # [   14.768255] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   14.775737] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   14.778117] systemd[1]: Reached target Timer Units.
server # [   14.778969] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   14.779941] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   14.793721] systemd[1]: Reached target Socket Units.
server # [   14.794654] systemd[1]: Reached target Basic System.
client # [   14.804315] dhcpcd[599]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   14.795435] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [   14.806679] dhcpcd[599]: eth0: adding route to 10.0.2.0/24
server # [   14.800491] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   14.801551] systemd[1]: Starting Post-Boot Actions...
client # [   14.807987] dhcpcd[599]: eth0: adding default route via 10.0.2.2
server # [   14.815748] systemd[1]: Started Reset console on configuration changes.
server # [   14.842995] systemd[1]: Starting resolvconf update...
client # [   14.915102] systemd[1]: Started DHCP Client.
server # [   14.909696] systemd[1]: Starting D-Bus System Message Bus...
client # [   14.917387] systemd[1]: Reached target Multi-User System.
server # [   14.910871] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [   14.918906] systemd[1]: Startup finished in 1.085s (kernel) + 4.245s (initrd) + 9.587s (userspace) = 14.918s.
server # [   14.976179] systemd[1]: Finished Post-Boot Actions.
server # [   15.003053] nsncd[497]: Sep 29 03:51:20.436 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   15.017066] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   15.025091] systemd[1]: Reached target Host and Network Name Lookups.
server # [   15.026254] systemd[1]: Reached target User and Group Name Lookups.
server # [   15.059486] systemd[1]: Starting User Login Management...
server # [   15.125136] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   15.146222] dbus-broker-launch[505]: Looking up NSS user entry for 'systemd-timesync'...
server # [   15.147612] dbus-broker-launch[505]: NSS returned no entry for 'systemd-timesync'
server # [   15.161959] dbus-broker-launch[505]: Invalid user-name in /nix/store/0wzpy01spp8y5fh7ys04p3kvysprhmsi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   15.201273] systemd[1]: Started D-Bus System Message Bus.
server # [   15.264001] dbus-broker-launch[505]: Ready
server # [   15.312570] systemd-logind[525]: New seat seat0.
server # [   15.321100] systemd[1]: Started User Login Management.
server # [   15.341788] systemd[1]: Starting linger-users.service...
server # [   15.363151] systemd[1]: Found device /dev/hvc0.
server # [   15.393410] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   15.400693] systemd[1]: Stopping Host and Network Name Lookups...
server # [   15.401821] systemd[1]: Stopped target User and Group Name Lookups.
server # [   15.402806] systemd[1]: Stopping User and Group Name Lookups...
server # [   15.417160] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   15.424406] systemd[1]: nscd.service: Deactivated successfully.
server # [   15.425467] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   15.458514] systemd[1]: linger-users.service: Deactivated successfully.
server # [   15.464261] systemd[1]: Finished linger-users.service.
server # [   15.484649] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   15.540673] systemd[1]: Found device /dev/ttyAMA0.
server # [   15.556972] systemd[1]: Started backdoor.service.
server # [   15.592515] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   15.601798] nsncd[593]: Sep 29 03:51:21.031 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   15.613550] systemd[1]: Reached target Host and Network Name Lookups.
server # [   15.614823] systemd[1]: Reached target User and Group Name Lookups.
server # [   15.638678] systemd[1]: Finished resolvconf update.
server # [   15.659966] systemd[1]: Starting DHCP Client...
server # connecting to host...
server # [   15.726648] systemd[1]: Finished Firewall.
server # [   15.734359] systemd[1]: Reached target Preparation for Network.
server # [   15.744220] systemd[1]: Starting Extra networking commands....
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 5.01 seconds)
server: (finished: waiting for the VM to finish booting, in 5.01 seconds)
server: waiting for unit multi-user.target
server # [   15.816857] (udev-worker)[385]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   15.841423] (udev-worker)[385]: Network interface NamePolicy= disabled on kernel command line.
server # [   15.992527] dhcpcd[641]: dhcpcd-10.3.2 starting
server # [   16.006017] dhcpcd[671]: dev: loaded udev
server # [   16.082715] 8021q: 802.1Q VLAN Support v1.8
server # [   16.083089] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   16.083398] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   16.244076] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   16.243785] systemd[1]: Finished Extra networking commands..
server # [   16.248393] systemd[1]: Reached target Network.
server # [   16.253991] systemd[1]: Starting Permit User Sessions...
server # [   16.307345] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   16.307848] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   16.309988] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   16.310310] cfg80211: failed to load regulatory.db
server # [   16.309013] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   16.323102] systemd[1]: Starting Address configuration of eth1...
server # [   16.351061] systemd[1]: Finished Permit User Sessions.
server # [   16.359746] systemd[1]: Started Getty on tty1.
server # [   16.370384] dhcpcd[671]: DUID 00:01:00:01:32:4d:f2:39:52:54:00:12:34:56
server # [   16.371525] dhcpcd[671]: eth0: IAID 00:12:34:56
server # [   16.380311] dhcpcd[671]: eth0: IAID 00:12:34:56
server # [   16.381101] systemd[1]: Reached target Login Prompts.
server # [   16.451339] systemd-logind[525]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [   16.487133] network-addresses-eth1-start[710]: adding address 192.168.1.2/24... done
server # [   16.503139] network-addresses-eth1-start[710]: adding address 2001:db8:1::2/64... done[   16.515605] mousedev: PS/2 mouse device common for all mice
server # 
server # [   16.522141] systemd[1]: Finished Address configuration of eth1.
server # [   16.536853] dhcpcd[671]: eth0: soliciting an IPv6 router
server # [   16.542746] dhcpcd[671]: eth0: Router Advertisement from fe80::2
server # [   16.543779] dhcpcd[671]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   16.546865] dhcpcd[671]: eth0: adding route to fec0::/64
server # [   16.547710] dhcpcd[671]: eth0: adding default route via fe80::2
server # [   16.687870] systemd-logind[525]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   17.424113] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   17.464382] dhcpcd[671]: eth0: soliciting a DHCP lease
server # [   17.468543] dhcpcd[671]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   17.477430] dhcpcd[671]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   17.478502] dhcpcd[671]: eth0: adding route to 10.0.2.0/24
server # [   17.479346] dhcpcd[671]: eth0: adding default route via 10.0.2.2
server # [   17.761617] systemd[1]: Started DHCP Client.
server # [   17.764498] dhcpcd[671]: eth0: pid 0 deleted route to 10.0.2.0/24
server # [   17.771434] systemd[1]: Reached target Multi-User System.
server # [   17.774179] systemd[1]: Startup finished in 1.140s (kernel) + 10.555s (initrd) + 6.072s (userspace) = 17.767s.
server # [   17.884500] systemd[1]: Starting Virtual Console Setup...
server # [   17.918070] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   17.935638] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   17.938284] systemd[1]: Stopped Virtual Console Setup.
server # [   17.950140] systemd[1]: Starting Virtual Console Setup...
server # [   18.000127] systemd-logind[525]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   18.117480] systemd-vconsole-setup[810]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   18.120896] systemd[1]: Finished Virtual Console Setup.
server: (finished: waiting for unit multi-user.target, in 2.56 seconds)
(finished: run the VM test script, in 19.28 seconds)
test script finished in 19.38s
cleanup
kill QemuMachine (pid 47)
client # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)
client # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
kill QemuMachine (pid 48)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)
server # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-09-29T03:51:23Z INFO  virtiofsd] Client disconnected, shutting down
(finished: cleanup, in 0.27 seconds)
additionally exposed symbols:
    client, 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