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 # Disk image does not exist, creating the virtualisation disk image...
server # Disk image does not exist, creating the virtualisation disk image...
client: QEMU running (pid 47)
server: QEMU running (pid 48)
client # Formatting '/build/vm-state-client/tmp.K5Myjl0V9W', fmt=raw size=1073741824
server # Formatting '/build/vm-state-server/tmp.yxyLjnOg7R', fmt=raw size=1073741824
client # mke2fs 1.47.4 (6-Mar-2025)
server # mke2fs 1.47.4 (6-Mar-2025)
client # Discarding device blocks:      0/262144             done
server # Discarding device blocks:      0/262144             done
client # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Creating filesystem with 262144 4k blocks and 65536 inodes
client # Filesystem UUID: 1026ab4f-3b59-4460-844f-66360f1cb756
server # Filesystem UUID: cf3681e3-c51c-4e5d-8416-32d84258555b
client # Superblock backups stored on blocks:
server # Superblock backups stored on blocks:
client # 	32768, 98304, 163840, 229376
server # 	32768, 98304, 163840, 229376
client # 
server # 
client # Allocating group tables: 0/8   done
server # Allocating group tables: 0/8   done
client # Writing inode tables: 0/8   done
server # Writing inode tables: 0/8   done
client # Creating journal (8192 blocks): done
server # Creating journal (8192 blocks): done
client # Writing superblocks and filesystem accounting information: 0/8   done
server # Writing superblocks and filesystem accounting information: 0/8   done
client # 
server # 
client # Virtualisation disk image created.
server # Virtualisation disk image created.
(finished: start all VMs, in 0.46 seconds)
client: waiting for unit network.target
client: waiting for the VM to finish booting
client # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep  2 12:31:51 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 0x7fded700-0x7fdf0e7f]
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
client # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
client # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep  2 12:31:51 UTC 2026
client # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] KASLR enabled
client # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
client # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] efi: UEFI not found.
client # [    0.000000] psci: SMC Calling Convention v1.1
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
client # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296
server # [    0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]
client # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000] Zone ranges:
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   empty
client # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000]   Device   empty
client # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] Movable zone start for each node
client # [    0.000000] CPU features: detected: Spectre-BHB
server # [    0.000000] Early memory node ranges
client # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] alternatives: applying boot alternatives
server # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.1
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/5lq13cfhni906x2qszq9vjz040vz8asp-nixos-system-client-test/init regInfo=/nix/store/0cw0gsa7vwcyfhdpd3p2ga4vxmzxksba-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
client # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/0cw0gsa7vwcyfhdpd3p2ga4vxmzxksba-closure-info/registration", will be passed to user space.
client # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
client # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] CPU features: detected: Spectre-BHB
client # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
client # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
client # [    0.000000] software IO TLB: area num 1.
server # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] alternatives: applying boot alternatives
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
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] 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/kwvz3sg4safjly8dhn2yc0wr29xgy2sb-nixos-system-server-test/init regInfo=/nix/store/lh8fym979xx54v1ac59w9l4s82w4cdyw-closure-info/registration console=ttyAMA0,115200n8 console=tty0
client # [    0.000000] allocated 2097152 bytes of page_ext
client # [    0.000000] ftrace: allocating 74886 entries in 294 pages
client # [    0.000000] ftrace: allocated 294 pages with 4 groups
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/lh8fym979xx54v1ac59w9l4s82w4cdyw-closure-info/registration", will be passed to user space.
client # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
client # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
server # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
client # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
client # [    0.000000] 	Rude variant of Tasks RCU enabled.
client # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
server # [    0.000000] software IO TLB: area num 1.
client # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
client # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] Fallback order for Node 0: 0
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] Built 1 zonelists, mobility grouping on.  Total pages: 262144
server # [    0.000000] Policy zone: DMA
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] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
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] allocated 2097152 bytes of page_ext
client # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] ftrace: allocating 74886 entries in 294 pages
client # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
client # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] rcu: 	RCU event tracing is enabled.
client # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
client # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
client # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
client # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
client # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
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] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
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] rcu: srcu_init: Setting srcu_struct sizes based on contention.
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] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
client # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
client # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
client # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
client # [    0.000032] arm-pv: using stolen time PV
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
client # [    0.000453] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
client # [    0.000641] Console: colour dummy device 80x25
client # [    0.000674] printk: legacy console [tty0] enabled
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
client # [    0.000864] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
client # [    0.000871] pid_max: default: 32768 minimum: 301
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
client # [    0.000947] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
client # [    0.001120] landlock: Up and running.
client # [    0.001123] Yama: becoming mindful.
client # [    0.001595] LSM support for eBPF active
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
client # [    0.001703] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.001722] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client # [    0.002796] cacheinfo: Unable to detect cache hierarchy for CPU 0
client # [    0.003467] rcu: Hierarchical SRCU implementation.
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.000027] arm-pv: using stolen time PV
client # [    0.003471] rcu: 	Max phase no-delay instances is 1000.
client # [    0.004635] fsl-mc MSI: its@8080000 domain created
server # [    0.000394] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
client # [    0.004732] EFI services will not be available.
server # [    0.000563] Console: colour dummy device 80x25
client # [    0.004807] smp: Bringing up secondary CPUs ...
server # [    0.000571] printk: legacy console [tty0] enabled
client # [    0.004815] smp: Brought up 1 node, 1 CPU
client # [    0.004818] SMP: Total of 1 processors activated.
client # [    0.004821] CPU: All CPU(s) started at EL1
server # [    0.000754] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000760] pid_max: default: 32768 minimum: 301
client # [    0.004834] CPU features: detected: Branch Target Identification
server # [    0.000830] LSM: initializing lsm=capability,landlock,yama,bpf,ima
client # [    0.004839] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.001002] landlock: Up and running.
server # [    0.001005] Yama: becoming mindful.
client # [    0.004842] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.001450] LSM support for eBPF active
client # [    0.004846] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.001550] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.004849] CPU features: detected: Common not Private translations
server # [    0.001569] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.004852] CPU features: detected: CRC32 instructions
server # [    0.002628] cacheinfo: Unable to detect cache hierarchy for CPU 0
client # [    0.004855] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.003314] rcu: Hierarchical SRCU implementation.
server # [    0.003317] rcu: 	Max phase no-delay instances is 1000.
client # [    0.004859] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.004485] fsl-mc MSI: its@8080000 domain created
client # [    0.004862] CPU features: detected: Data independent timing control (DIT)
server # [    0.004573] EFI services will not be available.
client # [    0.004865] CPU features: detected: E0PD
server # [    0.004649] smp: Bringing up secondary CPUs ...
server # [    0.004658] smp: Brought up 1 node, 1 CPU
client # [    0.004867] CPU features: detected: Enhanced Counter Virtualization
server # [    0.004661] SMP: Total of 1 processors activated.
client # [    0.004870] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.004664] CPU: All CPU(s) started at EL1
client # [    0.004874] CPU features: detected: Enhanced Virtualization Traps
server # [    0.004676] CPU features: detected: Branch Target Identification
client # [    0.004877] CPU features: detected: Fine Grained Traps
server # [    0.004681] CPU features: detected: ARMv8.4 Translation Table Level
client # [    0.004881] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.004684] CPU features: detected: Instruction cache invalidation not required for I/D coherence
client # [    0.004885] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.004687] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
client # [    0.004889] CPU features: detected: LSE atomic instructions
client # [    0.004892] CPU features: detected: Privileged Access Never
server # [    0.004691] CPU features: detected: Common not Private translations
client # [    0.004894] CPU features: detected: PMUv3
server # [    0.004694] CPU features: detected: CRC32 instructions
server # [    0.004697] CPU features: detected: Data cache clean to Point of Deep Persistence
client # [    0.004897] CPU features: detected: RAS Extension Support
server # [    0.004701] CPU features: detected: Data cache clean to Point of Persistence
client # [    0.004900] CPU features: detected: RASv1p1 Extension Support
server # [    0.004704] CPU features: detected: Data independent timing control (DIT)
client # [    0.004902] CPU features: detected: Random Number Generator
server # [    0.004707] CPU features: detected: E0PD
client # [    0.004905] CPU features: detected: Speculation barrier (SB)
server # [    0.004710] CPU features: detected: Enhanced Counter Virtualization
client # [    0.004908] CPU features: detected: Stage-2 Force Write-Back
server # [    0.004713] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
client # [    0.004911] CPU features: detected: TLB range maintenance instructions
server # [    0.004716] CPU features: detected: Enhanced Virtualization Traps
client # [    0.004915] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.004719] CPU features: detected: Fine Grained Traps
client # [    0.004951] alternatives: applying system-wide alternatives
server # [    0.004723] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
client # [    0.007862] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.004728] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.004731] CPU features: detected: LSE atomic instructions
client # [    0.008101] Memory: 894276K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112964K reserved, 32768K cma-reserved)
server # [    0.004734] CPU features: detected: Privileged Access Never
client # [    0.008400] devtmpfs: initialized
server # [    0.004737] CPU features: detected: PMUv3
server # [    0.004740] CPU features: detected: RAS Extension Support
client # [    0.010002] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.004742] CPU features: detected: RASv1p1 Extension Support
client # [    0.010023] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.004745] CPU features: detected: Random Number Generator
client # [    0.010197] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.004748] CPU features: detected: Speculation barrier (SB)
client # [    0.010201] 0 pages in range for non-PLT usage
server # [    0.004750] CPU features: detected: Stage-2 Force Write-Back
client # [    0.010202] 508288 pages in range for PLT usage
server # [    0.004753] CPU features: detected: TLB range maintenance instructions
client # [    0.010303] pinctrl core: initialized pinctrl subsystem
client # [    0.010977] DMI not present or invalid.
server # [    0.004758] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
client # [    0.013973] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.004796] alternatives: applying system-wide alternatives
client # [    0.016204] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
server # [    0.007684] CPU features: detected: BBM Level 2 without TLB conflict abort
client # [    0.016343] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.007911] Memory: 892964K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114268K reserved, 32768K cma-reserved)
client # [    0.016502] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.008283] devtmpfs: initialized
client # [    0.016524] audit: initializing netlink subsys (disabled)
server # [    0.009953] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.017085] thermal_sys: Registered thermal governor 'fair_share'
client # [    0.017087] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.009979] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
client # [    0.017090] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.010174] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
client # [    0.017093] thermal_sys: Registered thermal governor 'user_space'
server # [    0.010178] 0 pages in range for non-PLT usage
server # [    0.010179] 508288 pages in range for PLT usage
client # [    0.017098] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.010311] pinctrl core: initialized pinctrl subsystem
server # [    0.011052] DMI not present or invalid.
client # [    0.017127] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
client # [    0.017137] cpuidle: using governor ladder
server # [    0.014010] NET: Registered PF_NETLINK/PF_ROUTE protocol family
client # [    0.017142] cpuidle: using governor menu
server # [    0.016327] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
client # [    0.017326] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.016477] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
client # [    0.017342] ASID allocator initialised with 65536 entries
client # [    0.018465] Serial: AMBA PL011 UART driver
server # [    0.016632] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.016651] audit: initializing netlink subsys (disabled)
client # [    0.023581] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
client # [    0.023709] printk: console [ttyAMA0] enabled
server # [    0.017226] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.017228] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.017232] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.017234] thermal_sys: Registered thermal governor 'user_space'
server # [    0.017239] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.017262] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
server # [    0.017271] cpuidle: using governor ladder
server # [    0.017276] cpuidle: using governor menu
server # [    0.017480] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.017495] ASID allocator initialised with 65536 entries
server # [    0.018625] Serial: AMBA PL011 UART driver
server # [    0.023643] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
client # [    0.147566] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.023791] printk: console [ttyAMA0] enabled
client # [    0.147587] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
client # [    0.147592] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
client # [    0.147597] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
client # [    0.147601] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
client # [    0.147606] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
client # [    0.147610] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
client # [    0.147614] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
client # [    0.155051] fbcon: Taking over console
client # [    0.155067] ACPI: Interpreter disabled.
client # [    0.156950] iommu: Default domain type: Translated
server # [    0.146439] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
client # [    0.156959] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.146459] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.146464] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.146469] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.146473] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.146478] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.146482] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.146486] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
client # [    0.164150] SCSI subsystem initialized
server # [    0.153876] fbcon: Taking over console
server # [    0.153892] ACPI: Interpreter disabled.
client # [    0.164846] usbcore: registered new interface driver usbfs
client # [    0.164877] usbcore: registered new interface driver hub
server # [    0.155754] iommu: Default domain type: Translated
client # [    0.164893] usbcore: registered new device driver usb
server # [    0.155764] iommu: DMA domain TLB invalidation policy: strict mode
client # [    0.165139] pps_core: LinuxPPS API ver. 1 registered
server # [    0.157441] SCSI subsystem initialized
client # [    0.165145] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
client # [    0.165155] PTP clock support registered
client # [    0.165202] EDAC MC: Ver: 3.0.0
client # [    0.170129] scmi_core: SCMI protocol bus registered
client # [    0.171187] FPGA manager framework
client # [    0.172284] vgaarb: loaded
client # [    0.172967] clocksource: Switched to clocksource arch_sys_counter
server # [    0.162841] usbcore: registered new interface driver usbfs
server # [    0.162877] usbcore: registered new interface driver hub
server # [    0.162892] usbcore: registered new device driver usb
server # [    0.163166] pps_core: LinuxPPS API ver. 1 registered
server # [    0.163172] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.163182] PTP clock support registered
server # [    0.163236] EDAC MC: Ver: 3.0.0
server # [    0.167814] scmi_core: SCMI protocol bus registered
client # [    0.178511] VFS: Disk quotas dquot_6.6.0
server # [    0.168741] FPGA manager framework
client # [    0.178559] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.169691] vgaarb: loaded
client # [    0.180216] netfs: FS-Cache loaded
client # [    0.180341] pnp: PnP ACPI: disabled
server # [    0.170319] clocksource: Switched to clocksource arch_sys_counter
client # [    0.184251] NET: Registered PF_INET protocol family
client # [    0.184419] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.176588] VFS: Disk quotas dquot_6.6.0
server # [    0.176630] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.178248] netfs: FS-Cache loaded
server # [    0.178799] pnp: PnP ACPI: disabled
server # [    0.182200] NET: Registered PF_INET protocol family
server # [    0.182997] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
client # [    0.214174] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.214225] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
client # [    0.214255] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
client # [    0.214299] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
client # [    0.214376] TCP: Hash tables configured (established 8192 bind 8192)
client # [    0.214474] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
client # [    0.214540] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.214568] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.214665] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.211560] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.214693] NET: Registered PF_XDP protocol family
client # [    0.214717] PCI: CLS 0 bytes, default 64
server # [    0.211606] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
client # [    0.214980] Trying to unpack rootfs image as initramfs...
server # [    0.211634] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.211678] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    0.211754] TCP: Hash tables configured (established 8192 bind 8192)
server # [    0.211842] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
server # [    0.211876] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.211901] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.211982] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.212024] NET: Registered PF_XDP protocol family
server # [    0.212047] PCI: CLS 0 bytes, default 64
client # [    0.231283] kvm [1]: HYP mode not available
server # [    0.212313] Trying to unpack rootfs image as initramfs...
server # [    0.227862] kvm [1]: HYP mode not available
client # [    0.325556] Initialise system trusted keyrings
client # [    0.326325] workingset: timestamp_bits=42 max_order=18 bucket_order=0
client # [    0.327597] squashfs: version 4.0 (2009/01/31) Phillip Lougher
client # [    0.328372] 9p: Installing v9fs 9p2000 file system support
server # [    0.318885] Initialise system trusted keyrings
server # [    0.319634] workingset: timestamp_bits=42 max_order=18 bucket_order=0
server # [    0.320916] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.321671] 9p: Installing v9fs 9p2000 file system support
client # [    0.357058] Key type asymmetric registered
client # [    0.357088] Asymmetric key parser 'x509' registered
client # [    0.357170] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
client # [    0.359296] io scheduler mq-deadline registered
client # [    0.359308] io scheduler kyber registered
server # [    0.350709] Key type asymmetric registered
server # [    0.350735] Asymmetric key parser 'x509' registered
server # [    0.350801] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.352898] io scheduler mq-deadline registered
server # [    0.352909] io scheduler kyber registered
client # [    0.369138] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.370590] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.362442] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.371013] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
client # [    0.371033] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
client # [    0.371050] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.363824] ledtrig-cpu: registered to indicate activity on CPUs
client # [    0.371059] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.364196] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
client # [    0.371086] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.364212] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
client # [    0.371113] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.364228] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
client # [    0.371196] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.364236] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
client # [    0.371205] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.371212] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.364256] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
client # [    0.371218] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.364287] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
client # [    0.371223] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.364370] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
client # [    0.371281] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.364379] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.364386] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
client # [    0.371712] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.371896] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.364391] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
client # [    0.371914] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.364396] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.371944] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.364452] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
client # [    0.371960] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.364884] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.372411] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.365068] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
client # [    0.372592] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.365085] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.372609] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.365115] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.372639] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.365131] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.365587] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.392417] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    0.365769] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
client # [    0.392610] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]
server # [    0.365785] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.392628] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.365814] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.392664] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.366266] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
client # [    0.396276] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
client # [    0.396463] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
client # [    0.396480] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.396511] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.386601] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]
server # [    0.386621] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.386651] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.387109] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    0.387293] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.387309] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.387338] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.387796] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    0.387977] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]
server # [    0.387993] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.388023] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.405024] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    0.388474] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
client # [    0.405245] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]
server # [    0.388656] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]
client # [    0.405261] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.388672] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.405291] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.388702] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.405793] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.389148] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.405978] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]
server # [    0.389330] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]
client # [    0.405994] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.389346] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.406024] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.389375] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.389392] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.406473] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.406656] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]
server # [    0.389839] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
client # [    0.406673] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.390021] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.406704] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.390051] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.406720] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.407178] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
client # [    0.407365] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.407396] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.407845] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
client # [    0.408031] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.408062] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.408446] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.408628] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.408902] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.427261] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.414574] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
client # [    0.427283] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.414789] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.427313] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.414820] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.427774] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.415214] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.427957] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.415395] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.427973] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.415641] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.428003] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.415901] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.428591] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.415919] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.428603] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.415949] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.428610] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.416402] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.416584] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
client # [    0.428659] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.416600] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.428707] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.416630] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.428753] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.417203] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
client # [    0.428800] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.417215] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.417221] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
client # [    0.428846] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.417265] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
client # [    0.428892] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.417312] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
client # [    0.428938] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.417359] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.417406] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.417453] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.417501] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.417550] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.417597] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.417643] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.417704] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.417749] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.417772] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
client # [    0.449046] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.417793] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
client # [    0.449115] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.417815] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
client # [    0.449214] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.417837] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
client # [    0.449265] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.417862] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
client # [    0.449288] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.417884] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned
client # [    0.449311] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.417906] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
client # [    0.449333] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.417928] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
client # [    0.449356] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.417950] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned
client # [    0.449381] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.417973] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
client # [    0.449405] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned
server # [    0.417995] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.418017] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned
client # [    0.449428] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.418038] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned
client # [    0.449450] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.418060] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned
client # [    0.449472] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned
server # [    0.418082] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned
client # [    0.449496] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.418103] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned
client # [    0.449518] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.418125] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned
client # [    0.449540] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.418147] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned
client # [    0.449562] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.418169] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned
client # [    0.449583] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned
server # [    0.418191] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned
client # [    0.449605] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.418217] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
client # [    0.449627] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.418226] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
client # [    0.449649] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned
server # [    0.418231] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
client # [    0.449671] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned
client # [    0.449693] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned
client # [    0.449715] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned
client # [    0.449745] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
client # [    0.449756] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
client # [    0.449761] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
client # [    0.450927] pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.467722] pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.488380] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.499172] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.502502] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
client # [    0.504509] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    0.498554] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    0.502054] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    0.506154] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
client # [    0.514451] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
client # [    0.516421] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
server # [    0.511587] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
client # [    0.527955] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)
client # [    0.530870] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)
server # [    0.522870] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)
server # [    0.524942] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)
server # [    0.535240] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
client # [    0.541050] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    0.537972] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
client # [    0.543472] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
client # [    0.545403] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
client # [    0.548051] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    0.549049] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    0.552241] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
client # [    0.566213] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client # [    0.568911] msm_serial: driver initialized
server # [    0.565094] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client # [    0.573154] SuperH (H)SCI(F) driver initialized
client # [    0.573224] STM32 USART driver initialized
server # [    0.567581] msm_serial: driver initialized
server # [    0.567723] SuperH (H)SCI(F) driver initialized
server # [    0.567774] STM32 USART driver initialized
client # [    0.600076] loop: module loaded
client # [    0.600252] virtio_blk virtio5: 1/0/0 default/read/poll queues
client # [    0.609090] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    0.601130] loop: module loaded
server # [    0.601299] virtio_blk virtio5: 1/0/0 default/read/poll queues
server # [    0.602031] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    0.606876] megasas: 07.734.00.00-rc1
client # [    0.613537] megasas: 07.734.00.00-rc1
server # [    0.607544] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.614236] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.618389] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.618420] Intel/Sharp Extended Query Table at 0x0031
client # [    0.620002] Using buffer write method
client # [    0.620079] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
client # [    0.631664] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.631697] Intel/Sharp Extended Query Table at 0x0031
server # [    0.619406] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.619437] Intel/Sharp Extended Query Table at 0x0031
server # [    0.621163] Using buffer write method
server # [    0.621222] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
client # [    0.640995] Using buffer write method
client # [    0.641023] Concatenating MTD devices:
client # [    0.641027] (0): "0.flash"
client # [    0.641032] (1): "0.flash"
client # [    0.641035] into device "0.flash"
server # [    0.636373] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.636403] Intel/Sharp Extended Query Table at 0x0031
server # [    0.640421] Using buffer write method
server # [    0.640444] Concatenating MTD devices:
server # [    0.640448] (0): "0.flash"
server # [    0.640452] (1): "0.flash"
server # [    0.640455] into device "0.flash"
client # [    0.865932] Freeing initrd memory: 26104K
client # [    0.871877] tun: Universal TUN/TAP device driver, 1.6
client # [    0.875645] thunder_xcv, ver 1.0
client # [    0.875687] thunder_bgx, ver 1.0
client # [    0.875709] nicpf, ver 1.0
client # [    0.876244] e1000: Intel(R) PRO/1000 Network Driver
client # [    0.876251] e1000: Copyright (c) 1999-2006 Intel Corporation.
client # [    0.876278] e1000e: Intel(R) PRO/1000 Network Driver
client # [    0.876286] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
client # [    0.876310] igb: Intel(R) Gigabit Ethernet Network Driver
client # [    0.876316] igb: Copyright (c) 2007-2014 Intel Corporation.
client # [    0.876337] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    0.876343] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
client # [    0.876481] sky2: driver version 1.30
client # [    0.885651] ehci-pci 0000:00:0a.0: EHCI Host Controller
client # [    0.885685] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1
client # [    0.885940] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000
client # [    0.888407] usbcore: registered new interface driver usb-storage
client # [    0.888552] usbcore: registered new interface driver usbserial_generic
client # [    0.888566] usbserial: USB Serial support registered for generic
client # [    0.891421] hv_vmbus: registering driver hyperv_keyboard
client # [    0.892926] rtc-pl031 9010000.pl031: registered as rtc0
client # [    0.892954] rtc-pl031 9010000.pl031: setting system clock to 2026-09-07T13:35:49 UTC (1788788149)
client # [    0.895001] i2c_dev: i2c /dev entries driver
client # [    0.898222] sdhci: Secure Digital Host Controller Interface driver
client # [    0.898233] sdhci: Copyright(c) Pierre Ossman
server # [    0.891063] Freeing initrd memory: 27408K
client # [    0.898494] Synopsys Designware Multimedia Card Interface Driver
client # [    0.898858] sdhci-pltfm: SDHCI platform and OF driver helper
client # [    0.900521] hid: raw HID events driver (C) Jiri Kosina
client # [    0.900771] usbcore: registered new interface driver usbhid
client # [    0.900777] usbhid: USB HID core driver
client # [    0.901016] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00
client # [    0.901321] hub 1-0:1.0: USB hub found
client # [    0.901340] hub 1-0:1.0: 6 ports detected
server # [    0.897112] tun: Universal TUN/TAP device driver, 1.6
client # [    0.908786] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
client # [    0.911354] drop_monitor: Initializing network drop monitor service
client # [    0.911537] NET: Registered PF_INET6 protocol family
server # [    0.900728] thunder_xcv, ver 1.0
server # [    0.900763] thunder_bgx, ver 1.0
server # [    0.900786] nicpf, ver 1.0
client # [    0.913498] Segment Routing with IPv6
server # [    0.901314] e1000: Intel(R) PRO/1000 Network Driver
client # [    0.913516] In-situ OAM (IOAM) with IPv6
server # [    0.901321] e1000: Copyright (c) 1999-2006 Intel Corporation.
client # [    0.913543] NET: Registered PF_PACKET protocol family
server # [    0.901351] e1000e: Intel(R) PRO/1000 Network Driver
server # [    0.901359] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    0.901384] igb: Intel(R) Gigabit Ethernet Network Driver
client # [    0.915210] 9pnet: Installing 9P2000 support
server # [    0.901390] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    0.901411] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    0.901417] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    0.901546] sky2: driver version 1.30
server # [    0.910128] usbcore: registered new interface driver usb-storage
client # [    0.917931] Key type dns_resolver registered
server # [    0.910249] usbcore: registered new interface driver usbserial_generic
server # [    0.910263] usbserial: USB Serial support registered for generic
server # [    0.913236] ehci-pci 0000:00:0a.0: EHCI Host Controller
client # [    0.924111] registered taskstats version 1
server # [    0.913264] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1
client # [    0.924293] Loading compiled-in X.509 certificates
server # [    0.913511] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000
server # [    0.916492] hv_vmbus: registering driver hyperv_keyboard
server # [    0.917989] rtc-pl031 9010000.pl031: registered as rtc0
server # [    0.918015] rtc-pl031 9010000.pl031: setting system clock to 2026-09-07T13:35:49 UTC (1788788149)
server # [    0.920014] i2c_dev: i2c /dev entries driver
client # [    0.932839] Demotion targets for Node 0: null
client # [    0.932949] Key type .fscrypt registered
client # [    0.932955] Key type fscrypt-provisioning registered
client # [    0.934805] ima: No TPM chip found, activating TPM-bypass!
client # [    0.934828] ima: Allocated hash algorithm: sha1
client # [    0.934849] ima: No architecture policies found
server # [    0.923170] sdhci: Secure Digital Host Controller Interface driver
server # [    0.923180] sdhci: Copyright(c) Pierre Ossman
client # [    0.937206] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    0.923436] Synopsys Designware Multimedia Card Interface Driver
server # [    0.923790] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    0.925401] hid: raw HID events driver (C) Jiri Kosina
server # [    0.925625] usbcore: registered new interface driver usbhid
server # [    0.925633] usbhid: USB HID core driver
server # [    0.930810] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00
server # [    0.931136] hub 1-0:1.0: USB hub found
server # [    0.931156] hub 1-0:1.0: 6 ports detected
server # [    0.933541] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    0.936119] drop_monitor: Initializing network drop monitor service
server # [    0.936272] NET: Registered PF_INET6 protocol family
server # [    0.938128] Segment Routing with IPv6
server # [    0.938147] In-situ OAM (IOAM) with IPv6
server # [    0.938174] NET: Registered PF_PACKET protocol family
server # [    0.939859] 9pnet: Installing 9P2000 support
server # [    0.941895] Key type dns_resolver registered
client # [    0.954867] clk: Disabling unused clocks
client # [    0.954893] PM: genpd: Disabling unused power domains
client # [    0.959028] Freeing unused kernel memory: 4736K
client # [    0.959225] Run /init as init process
server # [    0.948875] registered taskstats version 1
server # [    0.949025] Loading compiled-in X.509 certificates
server # [    0.957635] Demotion targets for Node 0: null
server # [    0.957749] Key type .fscrypt registered
server # [    0.957755] Key type fscrypt-provisioning registered
server # [    0.957849] ima: No TPM chip found, activating TPM-bypass!
server # [    0.957869] ima: Allocated hash algorithm: sha1
server # [    0.957887] ima: No architecture policies found
server # [    0.961910] input: gpio-keys as /devices/platform/gpio-keys/input/input0
client # [    0.975172] systemd[1]: Successfully made /usr/ read-only.
server # [    0.979129] clk: Disabling unused clocks
server # [    0.979155] PM: genpd: Disabling unused power domains
server # [    0.983362] Freeing unused kernel memory: 4736K
server # [    0.983670] Run /init as init process
server # [    1.000460] systemd[1]: Successfully made /usr/ read-only.
client # [    1.153047] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    1.178393] usb 1-1: new high-speed USB device number 2 using ehci-pci
client # [    1.305320] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
client # [    1.311351] systemd[1]: systemd 262-9457f81 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.311411] systemd[1]: Detected virtualization qemu.
client # [    1.311481] systemd[1]: Detected architecture arm64.
client # [    1.311504] systemd[1]: Running in initrd.
client # [    1.312404] systemd[1]: Initializing machine ID from random generator.
client # [    1.312689] systemd[1]: Hostname set to <client>.
server # [    1.330657] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
server # [    1.336496] systemd[1]: systemd 262-9457f81 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.348694] systemd[1]: Detected virtualization qemu.
server # [    1.350953] systemd[1]: Detected architecture arm64.
server # [    1.351013] systemd[1]: Running in initrd.
server # [    1.351998] systemd[1]: Initializing machine ID from random generator.
server # [    1.352281] systemd[1]: Hostname set to <server>.
client # [    1.385219] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0
server # [    1.414631] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0
client # [    1.478604] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.509050] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    1.506489] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.530429] systemd[1]: Queued start job for default target Initrd Default Target.
client # [    1.539538] systemd[1]: Created slice Slice /system/modprobe.
client # [    1.540826] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    1.542221] systemd[1]: Expecting device /dev/disk/by-label/nixos...
client # [    1.543237] systemd[1]: Reached target Path Units.
client # [    1.544017] systemd[1]: Reached target Slice Units.
client # [    1.544824] systemd[1]: Reached target Swaps.
client # [    1.545608] systemd[1]: Reached target Timer Units.
client # [    1.546542] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    1.547807] systemd[1]: Listening on Journal Socket (/dev/log).
client # [    1.548913] systemd[1]: Listening on Journal Sockets.
server # [    1.538375] usb 1-2: new high-speed USB device number 3 using ehci-pci
client # [    1.549914] systemd[1]: Listening on udev Kernel Socket.
client # [    1.549938] systemd[1]: Reached target Socket Units.
client # [    1.553092] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.561126] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
client # [    1.562188] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.569202] systemd[1]: Mounting Kernel Configuration File System...
server # [    1.565642] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    1.576298] systemd[1]: Created slice Slice /system/modprobe.
server # [    1.577303] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    1.578348] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    1.579161] systemd[1]: Expecting device /dev/hvc0...
server # [    1.579811] systemd[1]: Expecting device /dev/ttyAMA0...
server # [    1.580513] systemd[1]: Reached target Path Units.
server # [    1.581141] systemd[1]: Reached target Slice Units.
server # [    1.581785] systemd[1]: Reached target Swaps.
server # [    1.582393] systemd[1]: Reached target Timer Units.
client # [    1.593181] systemd[1]: Starting Journal Service...
server # [    1.583228] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    1.584207] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    1.585099] systemd[1]: Listening on Journal Sockets.
server # [    1.585934] systemd[1]: Listening on Network Management Metrics Varlink Socket.
server # [    1.587176] systemd[1]: Listening on Network Management Varlink Socket.
server # [    1.588157] systemd[1]: Listening on Network Management Netlink Socket.
server # [    1.589110] systemd[1]: Listening on Resolve Monitor Varlink Socket.
server # [    1.590067] systemd[1]: Listening on Resolve Service Varlink Socket.
server # [    1.591019] systemd[1]: Listening on udev Kernel Socket.
server # [    1.591039] systemd[1]: Reached target Socket Units.
server # [    1.593617] systemd[1]: Starting Copy secrets into place...
client # [    1.605147] systemd[1]: Starting Load Kernel Modules...
client # [    1.605253] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    1.601685] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.614854] systemd[1]: Starting Coldplug All udev Devices...
server # [    1.615546] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [    1.615616] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.633113] systemd[1]: Finished Create List of Static Device Nodes.
client # [    1.634248] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [    1.630512] systemd[1]: Mounting Kernel Configuration File System...
client # [    1.641405] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
client # [    1.641761] systemd[1]: Mounted Kernel Configuration File System.
client # [    1.653619] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    1.647012] systemd[1]: Starting Journal Service...
client # [    1.655673] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    1.664803] systemd-journald[73]: Collecting audit messages is disabled.
client # [    1.669103] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    1.666545] systemd[1]: Starting Load Kernel Modules...
client # [    1.676736] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
client # [    1.681369] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0
client # [    1.685834] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0
client # [    1.686060] [drm] features: -virgl +edid -resource_blob -host_visible
client # [    1.686069] [drm] features: -context_init
client # [    1.686760] [drm] number of scanouts: 1
client # [    1.686778] [drm] number of cap sets: 0
server # [    1.681493] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    1.683528] systemd[1]: Starting Generate Network Units from Kernel Command Line...
server # [    1.683652] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    1.695108] systemd[1]: Starting Coldplug All udev Devices...
client # [    1.705262] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic
server # [    1.697752] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.705281] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0
server # [    1.702194] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
server # [    1.702434] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0
client # [    1.721608] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    1.727654] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    1.716314] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0
server # [    1.716548] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    1.716557] [drm] features: -context_init
server # [    1.717258] [drm] number of scanouts: 1
server # [    1.717274] [drm] number of cap sets: 0
server # [    1.722488] systemd[1]: Finished Copy secrets into place.
client # [    1.737232] Console: switching to colour frame buffer device 160x50
server # [    1.730725] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic
server # [    1.730745] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0
client # [    1.743672] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    1.736318] systemd[1]: Finished Create List of Static Device Nodes.
server # [    1.736976] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [    1.737256] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [    1.737486] systemd[1]: Mounted Kernel Configuration File System.
server # [    1.742486] systemd[1]: Finished Generate Network Units from Kernel Command Line.
server # [    1.743928] systemd[1]: Reached target Preparation for Network.
server # [    1.744898] systemd[1]: Listening on Network Management Resolve Hook Socket.
server # [    1.754839] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    1.763764] systemd-journald[76]: Collecting audit messages is disabled.
client # [    1.773566] systemd[1]: Finished Load Kernel Modules.
client # [    1.776520] systemd[1]: Starting Apply Kernel Variables...
server # [    1.765580] Console: switching to colour frame buffer device 160x50
client # [    1.790375] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    1.792485] systemd[1]: Reached target Preparation for Local File Systems.
client # [    1.792524] systemd[1]: Reached target Local File Systems.
server # [    1.794900] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device
client # [    1.805290] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    1.803555] systemd[1]: Finished Load Kernel Modules.
server # [    1.806479] systemd[1]: Starting Apply Kernel Variables...
client # [    1.826520] systemd[1]: Finished Apply Kernel Variables.
server # [    1.822542] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    1.833961] systemd-modules-load[74]: Inserted module 'dm_mod'
client # [    1.834996] systemd-modules-load[74]: Module 'virtio_balloon' is built in
server # [    1.839439] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    1.853229] systemd[1]: Started Journal Service.
client # [    1.839120] systemd-modules-load[74]: Module 'virtio_console' is built in
client # [    1.847784] systemd-modules-load[74]: Inserted module 'virtio_gpu'
client # [    1.852324] systemd-modules-load[74]: Module 'virtio_rng' is built in
client # [    1.853341] systemd[1]: Starting Create System Files and Directories...
server # [    1.867093] systemd[1]: Finished Apply Kernel Variables.
server # [    1.871051] systemd[1]: Starting Network Name Resolution...
client # [    1.876413] systemd-udevd[82]: Using default interface naming scheme 'v261'.
server # [    1.890437] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    1.890610] systemd[1]: Reached target Preparation for Local File Systems.
server # [    1.890642] systemd[1]: Reached target Local File Systems.
server # [    1.895423] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    1.902529] systemd[1]: Finished Create System Files and Directories.
client # [    1.916773] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    1.932691] systemd[1]: Started Journal Service.
server # [    1.930247] systemd-modules-load[79]: Module 'af_packet' is built in
server # [    1.932237] systemd-modules-load[79]: Inserted module 'dm_mod'
server # [    1.936087] systemd-modules-load[79]: Module 'virtio_balloon' is built in
server # [    1.941249] systemd-modules-load[79]: Module 'virtio_console' is built in
server # [    1.948373] systemd-modules-load[79]: Inserted module 'virtio_gpu'
server # [    1.950127] systemd-modules-load[79]: Module 'virtio_rng' is built in
server # [    1.951156] systemd[1]: Starting Create System Files and Directories...
client # [    1.987752] systemd[1]: Starting Virtual Console Setup...
server # [    1.990120] systemd[1]: Finished Create System Files and Directories.
server # [    1.996594] systemd-udevd[88]: Using default interface naming scheme 'v261'.
server # [    2.008339] systemd-resolved[87]: Positive Trust Anchors:
server # [    2.013917] systemd-resolved[87]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
server # [    2.019507] systemd-resolved[87]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
server # [    2.028253] systemd-resolved[87]: 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
client # [    2.061435] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    2.052813] systemd-resolved[87]: Using system hostname 'server'.
server # [    2.053716] systemd[1]: Starting D-Bus System Message Bus...
client # [    2.065625] systemd[1]: Finished Virtual Console Setup.
server # [    2.060055] systemd[1]: Started Network Name Resolution.
server # [    2.068122] systemd[1]: Reached target Host and Network Name Lookups.
server # [    2.072302] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    2.080089] systemd[1]: Starting Network Management...
server # [    2.083596] dbus-daemon[101]: dbus[101]: Unknown username "systemd-timesync" in message bus configuration file
server # [    2.087018] dbus-daemon[101]: dbus[101]: Unknown username "systemd-oom" in message bus configuration file
server # [    2.092816] systemd[1]: Started D-Bus System Message Bus.
server # [    2.171042] systemd-networkd[102]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported
server # [    2.181640] systemd[1]: Starting Virtual Console Setup...
server # [    2.188677] systemd-networkd[102]: lo: Link UP
server # [    2.192150] systemd-networkd[102]: lo: Gained carrier
server # [    2.196154] systemd[1]: Started Network Management.
server # [    2.196912] systemd[1]: Reached target Network.
server # [    2.209537] systemd[1]: Starting SSH Daemon...
server # [    2.257941] systemd[1]: Started SSH Daemon.
server # [    2.285855] systemd-vconsole-setup[118]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    2.292341] systemd[1]: Finished Virtual Console Setup.
server # [    2.305499] sshd[124]: Server listening on 0.0.0.0 port 22.
server # [    2.308293] sshd[124]: Server listening on :: port 22.
client # [    2.660978] systemd[1]: Finished Coldplug All udev Devices.
client # [    2.662982] systemd[1]: Reached target System Initialization.
client # [    2.668121] systemd[1]: Reached target Basic System.
client # [    2.787863] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    2.826307] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.
client # [    2.832520] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.
client # [    2.880082] systemd[1]: Found device /dev/disk/by-label/nixos.
client # [    2.882922] systemd[1]: Reached target Initrd Root Device.
client # [    2.888538] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    2.897288] systemd[1]: Finished Coldplug All udev Devices.
server # [    2.900131] systemd[1]: Reached target System Initialization.
server # [    2.900958] systemd[1]: Reached target Basic System.
client # [    2.929732] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks
client # [    2.934206] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
client # [    2.940197] systemd[1]: Mounting /sysroot...
client # [    3.002112] EXT4-fs (vda): mounted filesystem 1026ab4f-3b59-4460-844f-66360f1cb756 r/w with ordered data mode. Quota mode: none.
client # [    2.990867] systemd[1]: Mounted /sysroot.
client # [    2.992470] systemd[1]: Reached target Initrd Root File System.
client # [    2.996952] systemd[1]: Starting Mountpoints Configured in the Real Root...
client # [    3.023158] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.
client # [    3.031687] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...
client # [    3.033480] systemd[1]: Reloading...
server # [    3.023456] systemd[1]: Found device /dev/hvc0.
server # [    3.042309] systemd[1]: Found device /dev/ttyAMA0.
server # [    3.047367] systemd[1]: Started backdoor.service.
server # [    3.071400] (udev-worker)[112]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.077841] (udev-worker)[110]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # connecting to host...
server # [    3.084286] backdoor-start[129]: /nix/store/5ch6a58ajz4w5gxfgjlb1n2jy5qxi4va-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found
server # [    3.107184] (udev-worker)[110]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.118095] systemd-networkd[102]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network
server # [    3.120618] systemd-networkd[102]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
server # [    3.128746] systemd-networkd[102]: eth1: Link UP
server # [    3.131703] systemd-networkd[102]: eth1: Gained carrier
server # [    3.133123] systemd-networkd[102]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network
server # [    3.141213] systemd-networkd[102]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.
server # [    3.142549] systemd-networkd[102]: eth0: Link UP
server # [    3.143172] systemd-networkd[102]: eth0: Gained carrier
server # [    3.156507] systemd-networkd[102]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.2
server # [    3.193352] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    3.197550] systemd[1]: Reached target Initrd Root Device.
server # [    3.202356] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
client # [    3.219112] systemd[1]: Reloading finished in 187 ms.
client # [    3.252107] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...
client # [    3.256117] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...
client # [    3.261648] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [    3.251577] systemd-fsck[136]: nixos: clean, 12/65536 files, 13019/262144 blocks
client # [    3.264118] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    3.259109] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
client # [    3.270958] systemd[1]: Finished Mountpoints Configured in the Real Root.
client # [    3.272313] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    3.261712] systemd[1]: Mounting /sysroot...
client # [    3.296470] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
client # [    3.299685] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [    3.318109] EXT4-fs (vda): mounted filesystem cf3681e3-c51c-4e5d-8416-32d84258555b r/w with ordered data mode. Quota mode: none.
server # [    3.307437] systemd[1]: Mounted /sysroot.
server # [    3.310232] systemd[1]: Reached target Initrd Root File System.
server # [    3.313074] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    3.339163] systemd-sysroot-fstab-check[144]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    3.345349] systemd[1]: Reload requested from client PID 144 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    3.349143] systemd[1]: Reloading...
server # [    3.563645] systemd[1]: Reloading finished in 212 ms.
client # [    3.604129] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    3.600325] systemd-sysroot-fstab-check[144]: Requesting initrd-fs.target/start/replace...
client # [    3.612435] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.607681] systemd-sysroot-fstab-check[144]: Requesting swap.target/start/replace...
server # [    3.612837] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [    3.618219] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
client # [    3.630708] systemd[1]: Mounting /sysroot/run...
server # [    3.622762] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    3.623726] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
client # [    3.645875] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    3.644571] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [    3.647671] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
client # [    3.670271] systemd[1]: Mounting /sysroot/tmp/xchg...
client # [    3.692796] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    3.681337] systemd[1]: Mounting /sysroot/nix/.ro-store...
client # [    3.701697] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    3.699642] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.703468] systemd[1]: Mounting /sysroot/run...
client # [    3.725434] systemd[1]: Mounted /sysroot/run.
client # [    3.738443] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    3.728295] systemd[1]: Mounting /sysroot/tmp/shared...
client # [    3.743538] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    3.736105] systemd[1]: Mounting /sysroot/tmp/xchg...
client # [    3.750596] systemd[1]: Mounted /sysroot/tmp/xchg.
client # [    3.778642] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    3.779772] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    3.777673] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    3.797348] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    3.811796] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    3.816361] systemd[1]: Mounted /sysroot/run.
server # [    3.817067] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    3.840595] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    3.844720] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    3.849048] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    3.852163] systemd[1]: Mounting /sysroot/nix/store...
server # [    3.890962] systemd[1]: Mounted /sysroot/nix/store.
server # [    3.892680] systemd[1]: Reached target Initrd File Systems.
server # [    3.896764] systemd[1]: Starting Find NixOS closure...
server # [    3.914018] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    3.943123] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    3.960153] systemd[1]: Finished Find NixOS closure.
server # [    3.962118] systemd[1]: Reached target Initrd Default Target.
server # [    3.966978] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    3.988688] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    3.991572] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    4.004472] systemd[1]: Startup finished in 969ms (kernel) + 0 (initrd) + 3.034s (userspace) = 4.004s.
client # [    4.149886] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/mtd_probe": No such file or directory
client # [    4.156262] (udev-worker)[102]: mtd0ro: /nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/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.181647] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.185138] systemd[1]: Stopped Virtual Console Setup.
client # [    4.185961] systemd[1]: Stopping Virtual Console Setup...
client # [    4.191680] systemd[1]: Starting Virtual Console Setup...
client # [    4.197795] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.200118] systemd[1]: Stopped Virtual Console Setup.
client # [    4.205009] systemd[1]: Starting Virtual Console Setup...
client # [    4.232607] systemd-vconsole-setup[156]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [    4.235952] systemd[1]: Finished Virtual Console Setup.
server # [    4.226197] systemd-networkd[102]: eth0: Gained IPv6LL
client # [    4.605690] systemd[1]: Mounting /sysroot/nix/store...
server # [    4.597548] (udev-worker)[107]: mtd0ro: Failed to find and pin callout binary "/nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/mtd_probe": No such file or directory
server # [    4.603515] (udev-worker)[107]: mtd0ro: /nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory
server # [    4.620930] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.624138] systemd[1]: Stopped Virtual Console Setup.
server # [    4.624893] systemd[1]: Stopping Virtual Console Setup...
server # [    4.628228] systemd[1]: Starting Virtual Console Setup...
server # [    4.646021] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.647049] systemd[1]: Stopped Virtual Console Setup.
server # [    4.651265] systemd[1]: Starting Virtual Console Setup...
client # [    4.669380] systemd[1]: Mounted /sysroot/nix/store.
client # [    4.675256] systemd[1]: Reached target Initrd File Systems.
client # [    4.677886] systemd[1]: Starting Find NixOS closure...
server # [    4.668369] systemd-vconsole-setup[197]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    4.671571] systemd[1]: Finished Virtual Console Setup.
server # [    4.674218] systemd-networkd[102]: eth1: Gained IPv6LL
client # [    4.685861] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
client # [    4.732153] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
client # [    4.734525] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
client # [    4.751984] systemd[1]: Finished Find NixOS closure.
client # [    4.755379] systemd[1]: Reached target Initrd Default Target.
client # [    4.760517] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
client # [    4.796380] systemd[1]: initrd-cleanup.service: Deactivated successfully.
client # [    4.800139] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
client # [    4.802556] systemd[1]: Stopped target Initrd Default Target.
client # [    4.806630] systemd[1]: Stopped target Basic System.
client # [    4.807701] systemd[1]: Stopped target Initrd Root Device.
client # [    4.812249] systemd[1]: Stopped target Path Units.
client # [    4.813165] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
client # [    4.814485] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
client # [    4.815828] systemd[1]: Stopped target Slice Units.
client # [    4.820089] systemd[1]: Stopped target Socket Units.
client # [    4.824623] systemd[1]: Stopped target System Initialization.
client # [    4.826471] systemd[1]: Stopped target Swaps.
client # [    4.828001] systemd[1]: Stopped target Timer Units.
client # [    4.830539] systemd[1]: dbus.socket: Deactivated successfully.
client # [    4.835537] systemd[1]: Closed D-Bus System Message Bus Socket.
client # [    4.838051] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
client # [    4.839179] systemd[1]: Stopped Find NixOS closure.
client # [    4.839933] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
client # [    4.841884] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    4.842774] systemd[1]: systemd-sysctl.service: Deactivated successfully.
client # [    4.843757] systemd[1]: Stopped Apply Kernel Variables.
client # [    4.851720] systemd[1]: systemd-modules-load.service: Deactivated successfully.
client # [    4.858474] systemd[1]: Stopped Load Kernel Modules.
client # [    4.859344] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
client # [    4.864552] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
client # [    4.868260] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
client # [    4.869350] systemd[1]: Stopped Create System Files and Directories.
client # [    4.870954] systemd[1]: Stopped target Local File Systems.
client # [    4.872873] systemd[1]: Stopped target Preparation for Local File Systems.
client # [    4.875310] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
client # [    4.877332] systemd[1]: Stopped Coldplug All udev Devices.
client # [    4.878552] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
client # [    4.879596] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.880808] systemd[1]: Stopped Virtual Console Setup.
client # [    4.881534] systemd[1]: systemd-udevd.service: Deactivated successfully.
client # [    4.882438] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
client # [    4.883411] systemd[1]: systemd-udevd.service: Consumed 1.426s CPU time over 3.067s wall clock time, 22.1M memory peak.
client # [    4.888303] systemd[1]: Starting Cleanup udev Database...
client # [    4.892170] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
client # [    4.893388] systemd[1]: Stopped Create Static Device Nodes in /dev.
client # [    4.894401] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
client # [    4.900156] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
client # [    4.901180] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
client # [    4.902129] systemd[1]: Stopped Create List of Static Device Nodes.
client # [    4.902988] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
client # [    4.908383] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
client # [    4.909332] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    4.910313] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    4.930906] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
client # [    4.934003] systemd[1]: Finished Cleanup udev Database.
client # [    4.934821] systemd[1]: Reached target Switch Root.
client # [    4.936450] systemd[1]: Starting NixOS Activation...
client # [    5.102578] initrd-nixos-activation-start[181]: booting system configuration /nix/store/5lq13cfhni906x2qszq9vjz040vz8asp-nixos-system-client-test
client # [    5.166755] initrd-nixos-activation-start[181]: running activation script...
client # [    5.550904] initrd-nixos-activation-start[204]: setting up /etc...
client # [    5.818278] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
client # [    5.821026] systemd[1]: Finished NixOS Activation.
client # [    5.822129] systemd[1]: Starting Switch Root...
client # [    5.843405] systemd[1]: Switching root.
client # [    6.040188] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).
client # [    6.640955] systemd[1]: systemd 262-9457f81 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 # [    6.653078] systemd[1]: Detected virtualization qemu.
client # [    6.656553] systemd[1]: Detected architecture arm64.
client # [    6.658708] systemd[1]: Detected first boot.
client # [    6.664755] systemd[1]: Initializing machine ID from random generator.
client # [    6.834245] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    6.989250] systemd[1]: Applying preset policy.
client # [    7.505203] systemd[1]: Populated /etc with preset unit settings.
client # [    8.041981] systemd[1]: initrd-switch-root.service: Deactivated successfully.
client # [    8.043390] systemd[1]: Stopped initrd-switch-root.service.
client # [    8.047712] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
client # [    8.050723] systemd[1]: Created slice Slice /system/getty.
client # [    8.052698] systemd[1]: Created slice User and Session Slice.
client # [    8.054095] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    8.055867] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
client # [    8.058471] systemd[1]: Expecting device /dev/hvc0...
client # [    8.059521] systemd[1]: Expecting device /dev/ttyAMA0...
client # [    8.061934] systemd[1]: Reached target Local Encrypted Volumes.
client # [    8.063446] systemd[1]: Stopped target initrd-fs.target.
client # [    8.064864] systemd[1]: Stopped target initrd-root-fs.target.
client # [    8.066408] systemd[1]: Stopped target initrd-switch-root.target.
client # [    8.067931] systemd[1]: Reached target Virtual Machines and Containers.
client # [    8.069667] systemd[1]: Reached target Path Units.
client # [    8.071766] systemd[1]: Reached target Remote File Systems.
client # [    8.072885] systemd[1]: Reached target Slice Units.
client # [    8.074281] systemd[1]: Reached target Swaps.
client # [    8.078789] systemd[1]: Listening on Query the User Interactively for a Password.
client # [    8.083912] systemd[1]: Listening on Process Core Dump Socket.
client # [    8.088022] systemd[1]: Listening on Credential Encryption/Decryption.
client # [    8.091926] systemd[1]: Listening on Factory Reset Management.
client # [    8.093512] systemd[1]: Listening on Hostname Service Socket.
client # [    8.099155] systemd[1]: Starting Journal Log Access Socket...
client # [    8.101519] systemd[1]: Listening on Journal Audit Socket.
client # [    8.105525] systemd[1]: Listening on Console Output Muting Service Socket.
client # [    8.107538] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
client # [    8.109049] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
client # [    8.111760] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
client # [    8.123515] systemd[1]: Listening on Disk Repartitioning Service Socket.
client # [    8.125026] systemd[1]: Listening on udev Varlink Socket.
client # [    8.129600] systemd[1]: Mounting Huge Pages File System...
client # [    8.133669] systemd[1]: Mounting POSIX Message Queue File System...
client # [    8.144189] systemd[1]: Mounting Kernel Debug File System...
client # [    8.156218] systemd[1]: Mounting Kernel Trace File System...
client # [    8.166768] systemd[1]: Starting Create List of Static Device Nodes...
client # [    8.182203] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
client # [    8.183779] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    8.203953] systemd[1]: Mounting Kernel Configuration File System...
client # [    8.205518] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
client # [    8.208183] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
client # [    8.279324] systemd[1]: Starting Load Kernel Module fuse...
client # [    8.281617] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
client # [    8.339044] systemd[1]: Starting Journal Service...
client # [    8.362219] systemd[1]: Starting Load Kernel Modules...
client # [    8.399426] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
client # [    8.419731] systemd[1]: Starting Remount Root and Kernel File Systems...
client # [    8.434385] fuse: init (API version 7.45)
client # [    8.436843] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    8.445393] systemd[1]: Starting Coldplug All udev Devices...
client # [    8.464433] systemd-journald[276]: Collecting audit messages is enabled.
client # [    8.466181] systemd[1]: Queued start job for default target Multi-User System.
client # [    8.469851] systemd[1]: systemd-journald.service: Deactivated successfully.
client # [    8.486193] systemd[1]: Started Journal Service.
client # [    8.475978] systemd[1]: Listening on Journal Log Access Socket.
client # [    8.482888] systemd[1]: Mounted Huge Pages File System.
client # [    8.489240] systemd[1]: Mounted POSIX Message Queue File System.
client # [    8.498023] systemd[1]: Mounted Kernel Debug File System.
client # [    8.505417] systemd[1]: Mounted Kernel Trace File System.
client # [    8.509792] systemd[1]: Finished Create List of Static Device Nodes.
client # [    8.514557] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
client # [    8.523084] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
client # [    8.526053] systemd[1]: Mounted Kernel Configuration File System.
client # [    8.533386] systemd[1]: modprobe@fuse.service: Deactivated successfully.
client # [    8.534468] systemd-modules-load[277]: Module 'atkbd' is built in
client # [    8.535314] systemd-modules-load[277]: Module 'loop' is built in
client # [    8.559391] EXT4-fs (vda): re-mounted 1026ab4f-3b59-4460-844f-66360f1cb756.
client # [    8.548289] systemd[1]: Finished Load Kernel Module fuse.
client # [    8.549141] systemd[1]: Finished Load Kernel Modules.
client # [    8.556551] systemd[1]: Mounting FUSE Control File System...
client # [    8.567130] systemd[1]: Starting Firewall...
client # [    8.581883] systemd[1]: Starting Apply Kernel Variables...
client # [    8.615066] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    8.616936] systemd[1]: Finished Remount Root and Kernel File Systems.
client # [    8.629316] systemd-oomd[279]: No swap; memory pressure usage will be degraded
client # [    8.658925] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
client # [    8.668545] systemd[1]: Listening on Disk Image Download Service Socket.
client # [    8.688125] systemd[1]: Starting Flush Journal to Persistent Storage...
client # [    8.689939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
client # [    8.719850] systemd[1]: Starting Load/Save OS Random Seed...
client # [    8.728363] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    8.768688] systemd[1]: Mounted FUSE Control File System.
client # [    8.785599] systemd[1]: Finished Apply Kernel Variables.
client # [    8.844216] systemd-journald[276]: Received client request to flush runtime journal.
client # [    8.908316] systemd[1]: Finished Load/Save OS Random Seed.
client # [    8.910653] systemd[1]: Reached target First Boot Complete.
client # [    8.912997] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    8.916876] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    8.922145] systemd[1]: Finished Flush Journal to Persistent Storage.
client # [    8.991297] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    8.995285] systemd[1]: Reached target Preparation for Local File Systems.
client # [    9.003242] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    9.037032] systemd[1]: Mounting /run/wrappers...
client # [    9.123351] systemd[1]: Mounted /run/wrappers.
client # [    9.128829] systemd[1]: Reached target Local File Systems.
client # [    9.134056] systemd[1]: Listening on Boot Loader Control Service Socket.
client # [    9.144087] systemd[1]: Starting register-nix-paths.service...
client # [    9.156761] systemd[1]: Starting Create SUID/SGID Wrappers...
client # [    9.161241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
client # [    9.170933] systemd-udevd[319]: Using default interface naming scheme 'v261'.
client # [    9.181974] systemd[1]: Starting Save Transient machine-id to Disk...
client # [    9.230240] systemd[1]: Starting Create System Files and Directories...
client # [    9.348189] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
client # [    9.363323] systemd[1]: Finished Save Transient machine-id to Disk.
client # [    9.478434] systemd[1]: Finished Create System Files and Directories.
client # [    9.496729] systemd[1]: Starting Rebuild Journal Catalog...
client # [    9.507562] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
client # [    9.520594] systemd[1]: Started Rule-based Manager for Device Events and Files.
client # [    9.677415] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
client # [    9.759679] systemd[1]: Finished Rebuild Journal Catalog.
client # [    9.769974] systemd[1]: Starting Update is Completed...
client # [    9.850673] systemd[1]: Finished Update is Completed.
client # [   10.264486] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
client # [   10.269792] systemd[1]: Finished Create SUID/SGID Wrappers.
client # [   10.585403] systemd[1]: Finished register-nix-paths.service.
client # [   10.880804] systemd[1]: Finished Firewall.
client # [   10.905539] systemd[1]: Finished Coldplug All udev Devices.
client # [   10.906735] systemd[1]: Reached target System Initialization.
client # [   10.907573] systemd[1]: Started Discard unused filesystem blocks once a week.
client # [   10.910824] systemd[1]: Started Daily Cleanup of Temporary Directories.
client # [   10.911796] systemd[1]: Reached target Timer Units.
client # [   10.916388] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [   10.920140] systemd[1]: Listening on Nix Daemon Socket.
client # [   10.921017] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
client # [   10.922594] systemd[1]: Reached target Socket Units.
client # [   10.928207] systemd[1]: Reached target Basic System.
client # [   10.928962] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [   10.929932] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [   10.936090] systemd[1]: Starting Post-Boot Actions...
client # [   10.954299] systemd[1]: Started Reset console on configuration changes.
client # [   10.981442] systemd[1]: Starting resolvconf update...
client # [   11.025260] systemd[1]: Starting D-Bus System Message Bus...
client # [   11.033630] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [   11.060638] systemd[1]: Finished Post-Boot Actions.
client # [   11.086783] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [   11.091323] nsncd[492]: Sep 07 13:35:59.710 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [   11.100914] systemd[1]: Reached target Host and Network Name Lookups.
client # [   11.108472] systemd[1]: Reached target User and Group Name Lookups.
client # [   11.124436] systemd[1]: Starting User Login Management...
client # [   11.177157] systemd[1]: Finished Import lastlog data into lastlog2 database.
client # [   11.248784] dbus-broker-launch[497]: Looking up NSS user entry for 'systemd-timesync'...
client # [   11.255707] dbus-broker-launch[497]: NSS returned no entry for 'systemd-timesync'
client # [   11.262088] dbus-broker-launch[497]: Invalid user-name in /nix/store/v3mlfznwlfywigxsg9va44lq8gsrcg44-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
client # [   11.300144] systemd[1]: Started D-Bus System Message Bus.
client # [   11.304435] systemd-logind[513]: New seat seat0.
client # [   11.310389] systemd[1]: Started User Login Management.
client # [   11.319036] systemd[1]: Starting linger-users.service...
client # [   11.348780] systemd[1]: Stopped target Host and Network Name Lookups.
client # [   11.353147] systemd[1]: Stopping Host and Network Name Lookups...
client # [   11.359118] systemd[1]: Stopped target User and Group Name Lookups.
client # [   11.363775] systemd[1]: Stopping User and Group Name Lookups...
client # [   11.367142] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
client # [   11.376339] dbus-broker-launch[497]: Ready
client # [   11.380759] systemd[1]: nscd.service: Deactivated successfully.
client # [   11.385875] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
client # [   11.400284] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [   11.423548] systemd[1]: linger-users.service: Deactivated successfully.
client # [   11.433869] systemd[1]: Finished linger-users.service.
client # [   11.482911] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [   11.488243] systemd[1]: Reached target Host and Network Name Lookups.
client # [   11.491539] nsncd[563]: Sep 07 13:36:00.109 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [   11.498341] systemd[1]: Reached target User and Group Name Lookups.
client # [   11.502678] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
client # [   11.514294] systemd[1]: Finished resolvconf update.
client # [   11.516669] systemd[1]: Reached target Preparation for Network.
client # [   11.524378] systemd[1]: Starting DHCP Client...
client # [   11.530790] systemd[1]: Starting Extra networking commands....
client # [   11.547131] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
client # [   11.563253] systemd[1]: Started backdoor.service.
client # connecting to host...
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 12.08 seconds)
client: (finished: waiting for the VM to finish booting, in 12.08 seconds)
client # [   11.850000] dhcpcd[597]: dhcpcd-10.3.2 starting
client # [   11.870111] dhcpcd[646]: dev: loaded udev
client # [   11.897205] systemd[1]: Finished Extra networking commands..
client # [   11.904641] systemd[1]: Reached target Network.
client # [   11.942699] 8021q: 802.1Q VLAN Support v1.8
client # [   11.927996] systemd[1]: Starting Permit User Sessions...
client # [   12.015630] systemd[1]: Finished Permit User Sessions.
client # [   12.025715] systemd[1]: Started Getty on tty1.
client # [   12.029076] systemd[1]: Reached target Login Prompts.
client # [   12.085457] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client # [   12.079362] (udev-worker)[375]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [   12.087809] (udev-worker)[370]: Network interface NamePolicy= disabled on kernel command line.
client # [   12.092918] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line.
client # [   12.126593] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client # [   12.127119] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
client # [   12.132478] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
client # [   12.132809] cfg80211: failed to load regulatory.db
client # [   12.215537] 8021q: adding VLAN 0 to HW filter on device eth0
client # [   12.202072] dhcpcd[646]: eth0: waiting for carrier
client # [   12.206235] dhcpcd[646]: libudev: received NULL device
client # [   12.207086] dhcpcd[646]: libudev: received NULL device
client # [   12.207955] dhcpcd[646]: eth0: carrier acquired
client # [   12.217761] systemd[1]: Condition check resulted in Virtio network device being skipped.
client # [   12.223983] dhcpcd[646]: DUID 00:01:00:01:32:31:7a:40:52:54:00:12:34:56
client # [   12.228180] dhcpcd[646]: eth0: IAID 00:12:34:56
client # [   12.231990] dhcpcd[646]: eth0: adding address fe80::5054:ff:fe12:3456
client # [   12.233226] systemd[1]: Starting Address configuration of eth1...
client # [   12.234721] dhcpcd[646]: eth0: IAID 00:12:34:56
client # [   12.330776] 8021q: adding VLAN 0 to HW filter on device eth1
client # [   12.340831] network-addresses-eth1-start[679]: adding address 192.168.1.1/24... done
client # [   12.355121] network-addresses-eth1-start[679]: adding address 2001:db8:1::1/64... done
client # [   12.377640] systemd[1]: Finished Address configuration of eth1.
client # [   12.410224] systemd-logind[513]: Watching system buttons on /dev/input/event0 (gpio-keys)
client # [   12.490376] mousedev: PS/2 mouse device common for all mice
client # [   12.510024] systemd-logind[513]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
client: (finished: waiting for unit network.target, in 13.39 seconds)
client: waiting for SSH server to come up
client # [   13.117744] dhcpcd[646]: eth0: soliciting a DHCP lease
client # [   13.124727] dhcpcd[646]: eth0: offered 10.0.2.15 from 10.0.2.2
client # [   13.132336] dhcpcd[646]: eth0: probing address 10.0.2.15/24
client # Connection to server (2001:db8:1::2) 22 port [tcp/ssh] succeeded!
client: (finished: waiting for SSH server to come up, in 0.09 seconds)
client: must succeed: ssh -i /etc/sshKey -o UserKnownHostsFile=/etc/knownHosts server 'cat /etc/msg'
server # [   13.174960] sshd-session[200]: Connection closed by 2001:db8:1::1 port 36898 [preauth]
client # [   13.321175] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3
server # [   13.339507] sshd-session[202]: Accepted publickey for root from 2001:db8:1::1 port 36902 ssh2: ED25519 SHA256:Du3JdgNSW22b+NOGBZzlhBt3FKLjV6HeV/QEF2L7Xg4
client: (finished: must succeed: ssh -i /etc/sshKey -o UserKnownHostsFile=/etc/knownHosts server 'cat /etc/msg', in 0.23 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 # [   13.369497] sshd-session[204]: Received disconnect from 2001:db8:1::1 port 36902:11: disconnected by user
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 # [   13.377162] sshd-session[204]: Disconnected from user root 2001:db8:1::1 port 36902
server: (finished: waiting for unit initrd.target, in 0.04 seconds)
server: waiting for the VM to finish booting
server # [   13.447039] systemd[1]: Stopped target Initrd Default Target.
server # [   13.450841] systemd[1]: Stopped target Basic System.
server # [   13.456465] systemd[1]: Stopped target Initrd Root Device.
server # [   13.460249] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   13.462038] systemd[1]: Stopped target Path Units.
server # [   13.464162] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   13.467692] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   13.472314] systemd[1]: Stopped target Slice Units.
server # [   13.473298] systemd[1]: Stopped target Socket Units.
server # [   13.474180] systemd[1]: Stopped target System Initialization.
server # [   13.475170] systemd[1]: Stopped target Swaps.
server # [   13.475996] systemd[1]: Stopped target Timer Units.
server # [   13.480989] systemd[1]: Stopping backdoor.service...
server # [   13.481930] systemd[1]: Stopping D-Bus System Message Bus...
server # [   13.484196] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   13.487028] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   13.492205] systemd[1]: Stopped Find NixOS closure.
server # [   13.492979] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   13.494083] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   13.504774] sshd[124]: Received signal 15; terminating.
server # [   13.507243] systemd[1]: Stopping SSH Daemon...
server # [   13.508177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   13.517793] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   13.520961] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   13.523219] systemd[1]: Stopped Create System Files and Directories.
server # [   13.525920] systemd[1]: Stopped target Local File Systems.
server # [   13.529353] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   13.530642] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   13.532998] systemd[1]: Stopped Coldplug All udev Devices.
server # [   13.535244] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   13.537846] systemd[1]: Stopped Virtual Console Setup.
server # [   13.539045] systemd[1]: dbus.service: Deactivated successfully.
server # [   13.539899] systemd[1]: Stopped D-Bus System Message Bus.
server # [   13.540901] systemd[1]: sshd.service: Deactivated successfully.
server # [   13.541709] systemd[1]: Stopped SSH Daemon.
server # [   13.542315] systemd[1]: backdoor.service: Deactivated successfully.
server # [   13.543175] systemd[1]: Stopped backdoor.service.
server # [   13.543841] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   13.545586] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   13.546502] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   13.547473] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   13.548640] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   13.549625] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   13.550451] systemd[1]: Stopped target Network.
server # [   13.551113] systemd[1]: dbus.socket: Deactivated successfully.
server # [   13.551924] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   13.558012] systemd[1]: initrd-nixos-copy-secrets.service: Deactivated successfully.
server # [   13.559117] systemd[1]: Stopped Copy secrets into place.
server # [   13.559878] systemd[1]: Stopping Network Management...
server # [   13.563185] systemd[1]: Stopping Network Name Resolution...
server # [   13.567250] systemd[1]: systemd-resolved.service: Deactivated successfully.
server # [   13.568383] systemd[1]: Stopped Network Name Resolution.
server # [   13.569127] systemd[1]: sysroot-run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
server # [   13.570379] systemd[1]: systemd-resolved-monitor.socket: Deactivated successfully.
server # [   13.571377] systemd[1]: Closed Resolve Monitor Varlink Socket.
server # [   13.575987] systemd[1]: systemd-resolved-varlink.socket: Deactivated successfully.
server # [   13.579160] systemd[1]: Closed Resolve Service Varlink Socket.
server # [   13.580070] systemd[1]: systemd-networkd.service: Deactivated successfully.
server # [   13.581005] systemd[1]: Stopped Network Management.
server # [   13.581704] systemd[1]: sysroot-run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
server # [   13.582973] systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully.
server # [   13.584382] systemd[1]: Closed Network Management Resolve Hook Socket.
server # [   13.586694] systemd[1]: Stopped target Preparation for Network.
server # [   13.590525] systemd[1]: systemd-networkd-varlink-metrics.socket: Deactivated successfully.
server # [   13.592673] systemd[1]: Closed Network Management Metrics Varlink Socket.
server # [   13.596410] systemd[1]: systemd-networkd-varlink.socket: Deactivated successfully.
server # [   13.597492] systemd[1]: Closed Network Management Varlink Socket.
server # [   13.598319] systemd[1]: systemd-networkd.socket: Deactivated successfully.
server # [   13.600249] systemd[1]: Closed Network Management Netlink Socket.
server # [   13.601983] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   13.603015] systemd[1]: Stopped Apply Kernel Variables.
server # [   13.603771] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   13.604909] systemd[1]: Stopped Load Kernel Modules.
server # [   13.605607] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [   13.606610] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   13.607513] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   13.612206] systemd[1]: systemd-udevd.service: Consumed 1.484s CPU time over 11.711s wall clock time, 22.1M memory peak.
server # [   13.613655] systemd[1]: Starting Cleanup udev Database...
server # [   13.614682] systemd[1]: systemd-network-generator.service: Deactivated successfully.
server # [   13.616401] systemd[1]: Stopped Generate Network Units from Kernel Command Line.
server # [   13.620180] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   13.621280] systemd[1]: Stopped Create Static Device Nodes in /dev.
client # [   13.633871] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   13.624131] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   13.625261] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   13.628133] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   13.629101] systemd[1]: Stopped Create List of Static Device Nodes.
client # [   13.642279] systemd[1]: Starting Virtual Console Setup...
client # [   13.665534] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [   13.666618] systemd[1]: Stopped Virtual Console Setup.
server # [   13.655877] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
client # [   13.669826] systemd[1]: Starting Virtual Console Setup...
server # [   13.659197] systemd[1]: Finished Cleanup udev Database.
server # [   13.659984] systemd[1]: Reached target Switch Root.
server # [   13.664128] systemd[1]: Starting NixOS Activation...
client # [   13.723766] systemd-logind[513]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   13.832201] initrd-nixos-activation-start[231]: booting system configuration /nix/store/kwvz3sg4safjly8dhn2yc0wr29xgy2sb-nixos-system-server-test
server # [   13.896487] initrd-nixos-activation-start[231]: running activation script...
client # [   14.090898] systemd-vconsole-setup[717]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [   14.095415] systemd[1]: Finished Virtual Console Setup.
client # [   14.106426] dhcpcd[646]: eth0: soliciting an IPv6 router
client # [   14.108100] dhcpcd[646]: eth0: Router Advertisement from fe80::2
client # [   14.108971] dhcpcd[646]: eth0: adding address fec0::5054:ff:fe12:3456/64
client # [   14.110052] dhcpcd[646]: eth0: adding route to fec0::/64
client # [   14.110847] dhcpcd[646]: eth0: adding default route via fe80::2
server # [   14.314372] initrd-nixos-activation-start[254]: setting up /etc...
server # [   14.580283] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   14.583116] systemd[1]: Finished NixOS Activation.
server # [   14.584430] systemd[1]: Starting Switch Root...
server # [   14.608301] systemd[1]: Switching root.
server # [   14.785613] systemd-journald[76]: Received SIGTERM from PID 1 (systemd).
server # [   15.386297] systemd[1]: systemd 262-9457f81 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 # [   15.399642] systemd[1]: Detected virtualization qemu.
server # [   15.402638] systemd[1]: Detected architecture arm64.
server # [   15.404809] systemd[1]: Detected first boot.
server # [   15.411571] systemd[1]: Initializing machine ID from random generator.
server # [   15.567647] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   15.729592] systemd[1]: Applying preset policy.
server # [   16.216792] systemd[1]: Populated /etc with preset unit settings.
server # [   16.722127] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   16.724057] systemd[1]: Stopped initrd-switch-root.service.
server # [   16.726955] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   16.730055] systemd[1]: Created slice Slice /system/getty.
server # [   16.732146] systemd[1]: Created slice User and Session Slice.
server # [   16.734257] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   16.736689] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   16.738899] systemd[1]: Expecting device /dev/hvc0...
server # [   16.739883] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   16.742042] systemd[1]: Reached target Local Encrypted Volumes.
server # [   16.743215] systemd[1]: Stopped target initrd-fs.target.
server # [   16.744650] systemd[1]: Stopped target initrd-root-fs.target.
server # [   16.746122] systemd[1]: Stopped target initrd-switch-root.target.
server # [   16.748320] systemd[1]: Reached target Virtual Machines and Containers.
server # [   16.750251] systemd[1]: Reached target Path Units.
server # [   16.751975] systemd[1]: Reached target Remote File Systems.
server # [   16.753750] systemd[1]: Reached target Slice Units.
server # [   16.755561] systemd[1]: Reached target Swaps.
server # [   16.759393] systemd[1]: Listening on Query the User Interactively for a Password.
server # [   16.764109] systemd[1]: Listening on Process Core Dump Socket.
server # [   16.767968] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   16.771674] systemd[1]: Listening on Factory Reset Management.
server # [   16.772904] systemd[1]: Listening on Hostname Service Socket.
server # [   16.778089] systemd[1]: Starting Journal Log Access Socket...
server # [   16.780302] systemd[1]: Listening on Journal Audit Socket.
server # [   16.783982] systemd[1]: Listening on Console Output Muting Service Socket.
server # [   16.785454] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   16.787290] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [   16.789035] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   16.800243] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [   16.801604] systemd[1]: Listening on udev Varlink Socket.
server # [   16.806588] systemd[1]: Mounting Huge Pages File System...
server # [   16.810590] systemd[1]: Mounting POSIX Message Queue File System...
server # [   16.815990] systemd[1]: Mounting Kernel Debug File System...
server # [   16.826388] systemd[1]: Mounting Kernel Trace File System...
server # [   16.840571] systemd[1]: Starting Create List of Static Device Nodes...
server # [   16.846542] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   16.848195] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   16.857780] systemd[1]: Mounting Kernel Configuration File System...
server # [   16.862564] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   16.865063] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   16.883755] systemd[1]: Starting Load Kernel Module fuse...
server # [   16.886676] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   16.900967] systemd[1]: Starting Journal Service...
server # [   16.971389] systemd[1]: Starting Load Kernel Modules...
server # [   17.012156] fuse: init (API version 7.45)
server # [   17.023151] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   17.050503] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   17.055670] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   17.078517] systemd[1]: Starting Coldplug All udev Devices...
server # [   17.099778] systemd[1]: Listening on Journal Log Access Socket.
server # [   17.100248] systemd[1]: Mounted Huge Pages File System.
server # [   17.100647] systemd[1]: Mounted POSIX Message Queue File System.
server # [   17.101015] systemd[1]: Mounted Kernel Debug File System.
server # [   17.101380] systemd[1]: Mounted Kernel Trace File System.
server # [   17.111119] systemd-journald[326]: Collecting audit messages is enabled.
server # [   17.117788] systemd[1]: Finished Create List of Static Device Nodes.
server # [   17.122773] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   17.127903] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   17.134784] systemd[1]: Started Journal Service.
server # [   17.119690] systemd[1]: Queued start job for default target Multi-User System.
server # [   17.121232] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   17.122554] systemd-modules-load[327]: Module 'atkbd' is built in
server # [   17.123542] systemd-modules-load[327]: Module 'loop' is built in
server # [   17.134123] systemd[1]: Mounted Kernel Configuration File System.
server # [   17.139744] systemd[1]: modprobe@fuse.service: Deactivated successfully.
server # [   17.148808] systemd[1]: Finished Load Kernel Module fuse.
server # [   17.149705] systemd[1]: Finished Load Kernel Modules.
server # [   17.159646] systemd[1]: Mounting FUSE Control File System...
server # [   17.179055] EXT4-fs (vda): re-mounted cf3681e3-c51c-4e5d-8416-32d84258555b.
server # [   17.165572] systemd[1]: Starting Firewall...
server # [   17.182372] systemd[1]: Starting Apply Kernel Variables...
server # [   17.201605] systemd-oomd[328]: No swap; memory pressure usage will be degraded
server # [   17.216939] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   17.220124] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   17.226435] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   17.283542] systemd[1]: Listening on Disk Image Download Service Socket.
server # [   17.304294] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   17.310501] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   17.330063] systemd[1]: Starting Load/Save OS Random Seed...
server # [   17.340848] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [   17.367703] systemd[1]: Mounted FUSE Control File System.
server # [   17.379365] systemd[1]: Finished Apply Kernel Variables.
server # [   17.413328] systemd-journald[326]: Received client request to flush runtime journal.
server # [   17.484550] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   17.485671] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   17.486548] systemd[1]: Finished Load/Save OS Random Seed.
server # [   17.487291] systemd[1]: Reached target First Boot Complete.
server # [   17.494047] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   17.577804] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   17.580140] systemd[1]: Reached target Preparation for Local File Systems.
server # [   17.586145] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   17.712188] systemd-udevd[371]: Using default interface naming scheme 'v261'.
server # [   17.715362] systemd[1]: Mounting /run/wrappers...
server # [   17.767211] systemd[1]: Mounted /run/wrappers.
client # [   17.781837] dhcpcd[646]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   17.773144] systemd[1]: Reached target Local File Systems.
server # [   17.777660] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   17.791311] systemd[1]: Starting register-nix-paths.service...
server # [   17.795629] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   17.796996] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   17.803319] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   17.846951] systemd[1]: Starting Create System Files and Directories...
client # [   17.785781] dhcpcd[646]: eth0: adding route to 10.0.2.0/24
client # [   17.785964] dhcpcd[646]: eth0: adding default route via 10.0.2.2
client # [   17.957470] systemd[1]: Started DHCP Client.
client # [   17.962481] systemd[1]: Reached target Multi-User System.
client # [   17.963375] systemd[1]: Startup finished in 946ms (kernel) + 5.197s (initrd) + 11.817s (userspace) = 17.961s.
server # [   17.962568] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   17.973018] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   18.011423] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   18.089645] systemd[1]: Finished Create System Files and Directories.
server # [   18.113318] systemd[1]: Starting Rebuild Journal Catalog...
server # [   18.161326] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   18.275822] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   18.310257] systemd[1]: Finished Rebuild Journal Catalog.
server # [   18.323216] systemd[1]: Starting Update is Completed...
server # [   18.402458] systemd[1]: Finished Update is Completed.
server # [   18.780161] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   18.783696] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   19.085210] systemd[1]: Finished register-nix-paths.service.
server # [   19.272441] systemd[1]: Finished Coldplug All udev Devices.
server # [   19.273588] systemd[1]: Reached target System Initialization.
server # [   19.275640] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   19.279281] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   19.284585] systemd[1]: Reached target Timer Units.
server # [   19.285950] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   19.293298] systemd[1]: Listening on Nix Daemon Socket.
server # [   19.297493] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [   19.305445] systemd[1]: Reached target Socket Units.
server # [   19.306237] systemd[1]: Reached target Basic System.
server # [   19.306959] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   19.307969] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   19.319765] systemd[1]: Starting Post-Boot Actions...
server # [   19.326677] systemd[1]: Started Reset console on configuration changes.
server # [   19.356075] systemd[1]: Starting resolvconf update...
server # [   19.370262] systemd[1]: Finished Firewall.
server # [   19.441377] systemd[1]: Starting D-Bus System Message Bus...
server # [   19.447689] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   19.457961] systemd[1]: Finished Post-Boot Actions.
server # [   19.467914] nsncd[542]: Sep 07 13:36:08.066 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   19.475121] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   19.481714] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   19.486854] systemd[1]: Reached target Host and Network Name Lookups.
server # [   19.492969] systemd[1]: Reached target User and Group Name Lookups.
server # [   19.499225] systemd[1]: Starting User Login Management...
server # [   19.653353] dbus-broker-launch[550]: Looking up NSS user entry for 'systemd-timesync'...
server # [   19.660254] dbus-broker-launch[550]: NSS returned no entry for 'systemd-timesync'
server # [   19.665749] dbus-broker-launch[550]: Invalid user-name in /nix/store/v3mlfznwlfywigxsg9va44lq8gsrcg44-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   19.678758] systemd-logind[565]: New seat seat0.
server # [   19.682696] systemd[1]: Started User Login Management.
server # [   19.687262] systemd[1]: Starting linger-users.service...
server # [   19.715262] systemd[1]: Started D-Bus System Message Bus.
server # [   19.721858] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   19.732479] systemd[1]: Stopping Host and Network Name Lookups...
server # [   19.742530] systemd[1]: Stopped target User and Group Name Lookups.
server # [   19.743512] systemd[1]: Stopping User and Group Name Lookups...
server # [   19.753714] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   19.762227] systemd[1]: nscd.service: Deactivated successfully.
server # [   19.768503] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   19.777432] dbus-broker-launch[550]: Ready
server # [   19.782531] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   19.802931] systemd[1]: linger-users.service: Deactivated successfully.
server # [   19.806358] systemd[1]: Finished linger-users.service.
server # [   19.868351] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   19.871989] systemd[1]: Reached target Host and Network Name Lookups.
server # [   19.876604] nsncd[616]: Sep 07 13:36:08.471 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   19.882096] systemd[1]: Reached target User and Group Name Lookups.
server # [   19.898577] systemd[1]: Finished resolvconf update.
server # [   19.901737] systemd[1]: Reached target Preparation for Network.
server # [   19.912971] systemd[1]: Starting DHCP Client...
server # [   19.924965] systemd[1]: Starting Extra networking commands....
server # [   19.946673] systemd[1]: Found device /dev/hvc0.
server # [   19.964892] systemd[1]: Found device /dev/ttyAMA0.
server # [   19.980860] systemd[1]: Started backdoor.service.
server # connecting to host...
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 6.78 seconds)
server: (finished: waiting for the VM to finish booting, in 6.78 seconds)
server: waiting for unit multi-user.target
server # [   20.250536] dhcpcd[646]: dhcpcd-10.3.2 starting
server # [   20.268428] dhcpcd[689]: dev: loaded udev
server # [   20.338686] 8021q: 802.1Q VLAN Support v1.8
server # [   20.339045] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   20.339326] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   20.392373] systemd[1]: Finished Extra networking commands..
server # [   20.424932] systemd[1]: Reached target Network.
server # [   20.442838] systemd[1]: Starting Permit User Sessions...
server # [   20.482424] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   20.517414] systemd[1]: Finished Permit User Sessions.
server # [   20.537614] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   20.538122] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   20.525586] (udev-worker)[422]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   20.527684] (udev-worker)[422]: Network interface NamePolicy= disabled on kernel command line.
server # [   20.553118] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   20.553438] cfg80211: failed to load regulatory.db
server # [   20.540970] systemd[1]: Started Getty on tty1.
server # [   20.542035] systemd[1]: Reached target Login Prompts.
server # [   20.550721] (udev-worker)[417]: Network interface NamePolicy= disabled on kernel command line.
server # [   20.586429] dhcpcd[689]: DUID 00:01:00:01:32:31:7a:49:52:54:00:12:34:56
server # [   20.589118] dhcpcd[689]: eth0: IAID 00:12:34:56
server # [   20.589807] dhcpcd[689]: libudev: received NULL device
server # [   20.590655] dhcpcd[689]: libudev: received NULL device
server # [   20.646906] systemd-logind[565]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [   20.678892] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   20.686812] dhcpcd[689]: eth0: IAID 00:12:34:56
server # [   20.687594] systemd[1]: Starting Address configuration of eth1...
server # [   20.744859] mousedev: PS/2 mouse device common for all mice
server # [   20.797153] network-addresses-eth1-start[724]: adding address 192.168.1.2/24... done
server # [   20.814081] network-addresses-eth1-start[724]: adding address 2001:db8:1::2/64... done
server # [   20.834447] systemd[1]: Finished Address configuration of eth1.
server # [   20.897513] systemd-logind[565]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   21.613279] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3
server # [   21.678523] dhcpcd[689]: eth0: soliciting an IPv6 router
server # [   21.679990] dhcpcd[689]: eth0: Router Advertisement from fe80::2
server # [   21.681342] dhcpcd[689]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   21.684143] dhcpcd[689]: eth0: adding route to fec0::/64
server # [   21.685116] dhcpcd[689]: eth0: adding default route via fe80::2
server # [   21.940866] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   21.949560] systemd[1]: Starting Virtual Console Setup...
server # [   21.968074] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   21.972933] systemd[1]: Stopped Virtual Console Setup.
server # [   21.976598] systemd[1]: Starting Virtual Console Setup...
server # [   22.042562] systemd-logind[565]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [   22.327146] dhcpcd[689]: eth0: soliciting a DHCP lease
server # [   22.332523] dhcpcd[689]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   22.340622] dhcpcd[689]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   22.341595] dhcpcd[689]: eth0: adding route to 10.0.2.0/24
server # [   22.342697] dhcpcd[689]: eth0: adding default route via 10.0.2.2
server # [   22.413304] systemd-vconsole-setup[765]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   22.419570] systemd[1]: Finished Virtual Console Setup.
server # [   22.469948] systemd[1]: Started DHCP Client.
server # [   22.472832] systemd[1]: Reached target Multi-User System.
server # [   22.477699] systemd[1]: Startup finished in 969ms (kernel) + 13.922s (initrd) + 7.583s (userspace) = 22.475s.
server # [   22.479700] dhcpcd[689]: eth0: pid 0 deleted route to 10.0.2.0/24
server: (finished: waiting for unit multi-user.target, in 2.53 seconds)
(finished: run the VM test script, in 23.51 seconds)
test script finished in 23.65s
cleanup
kill QemuMachine (pid 47)
client # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)
kill QemuMachine (pid 48)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)
(finished: cleanup, in 0.34 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