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...
client # Formatting '/build/vm-state-client/tmp.8V4v17O72g', fmt=raw size=1073741824
client: QEMU running (pid 47)
client # mke2fs 1.47.4 (6-Mar-2025)
client # Discarding device blocks:      0/262144             done
server # Disk image does not exist, creating the virtualisation disk image...
client # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Formatting '/build/vm-state-server/tmp.PSUemKaVRo', fmt=raw size=1073741824
client # Filesystem UUID: d89c7bc0-4905-43bc-a399-7bf0fce5c819
server # mke2fs 1.47.4 (6-Mar-2025)
client # Superblock backups stored on blocks:
server # Discarding device blocks:      0/262144             done
client # 	32768, 98304, 163840, 229376
server # Creating filesystem with 262144 4k blocks and 65536 inodes
client # 
server # Filesystem UUID: 690f34bb-d2cc-4167-b091-6c2453fe0960
client # Allocating group tables: 0/8   done
server # Superblock backups stored on blocks:
client # Writing inode tables: 0/8   done
server # 	32768, 98304, 163840, 229376
client # Creating journal (8192 blocks): done
server # 
client # Writing superblocks and filesystem accounting information: 0/8   done
server # Allocating group tables: 0/8   done
client # 
server # Writing inode tables: 0/8   done
client # Virtualisation disk image created.
server # Creating journal (8192 blocks): done
client # Starting virtiofs daemons...
server # Writing superblocks and filesystem accounting information: 0/8   done
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # 
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # Virtualisation disk image created.
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # Starting virtiofs daemons...
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-28T03:11:06Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server: QEMU running (pid 48)
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-09-28T03:11:06Z INFO  virtiofsd] Client connected, servicing requests
(finished: start all VMs, in 0.60 seconds)
server: waiting for unit nginx.service
server: waiting for the VM to finish booting
client # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026
client # [    0.000000] KASLR enabled
client # [    0.000000] random: crng init done
client # [    0.000000] Machine model: linux,dummy-virt
client # [    0.000000] efi: UEFI not found.
client # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
client # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] NODE_DATA(0) allocated [mem 0x7fdee700-0x7fdf1e7f]
client # [    0.000000] Zone ranges:
client # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000]   DMA32    empty
client # [    0.000000]   Normal   empty
client # [    0.000000]   Device   empty
client # [    0.000000] Movable zone start for each node
client # [    0.000000] Early memory node ranges
client # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
client # [    0.000000] psci: probing for conduit method from DT.
client # [    0.000000] psci: PSCIv1.3 detected in firmware.
client # [    0.000000] psci: Using standard PSCI v0.2 function IDs
client # [    0.000000] psci: Trusted OS migration not required
client # [    0.000000] psci: SMC Calling Convention v1.1
client # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
client # [    0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296
client # [    0.000000] Detected PIPT I-cache on CPU0
client # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
client # [    0.000000] CPU features: detected: GICv3 CPU interface
client # [    0.000000] CPU features: detected: Spectre-v4
client # [    0.000000] CPU features: detected: Spectre-BHB
client # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
client # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
client # [    0.000000] alternatives: applying boot alternatives
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/q06p1ia41llfsd0bfg99am6a1n3jf09d-nixos-system-client-test/init regInfo=/nix/.ro-store/d9bfjhgyli0h4575n82sjzkxvrigysvq-closure-info/registration console=ttyAMA0,115200n8 console=tty0
client # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/d9bfjhgyli0h4575n82sjzkxvrigysvq-closure-info/registration", will be passed to user space.
client # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
client # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
client # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
client # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
client # [    0.000000] software IO TLB: area num 1.
client # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
client # [    0.000000] Fallback order for Node 0: 0
client # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
client # [    0.000000] Policy zone: DMA
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
client # [    0.000000] allocated 2097152 bytes of page_ext
client # [    0.000000] ftrace: allocating 74966 entries in 294 pages
client # [    0.000000] ftrace: allocated 294 pages with 4 groups
client # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.000000] rcu: 	RCU event tracing is enabled.
client # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
client # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
client # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] 	Tracing variant of Tasks RCU enabled.
client # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026
server # [    0.000000] KASLR enabled
client # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
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] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
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] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
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] NODE_DATA(0) allocated [mem 0x7fdee700-0x7fdf1e7f]
server # [    0.000000] Zone ranges:
client # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
client # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000]   DMA32    empty
client # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000]   Normal   empty
client # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000]   Device   empty
client # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] Movable zone start for each node
server # [    0.000000] Early memory node ranges
client # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
client # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.3 detected in firmware.
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
client # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.1
client # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
client # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296
client # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] Detected PIPT I-cache on CPU0
client # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
client # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] CPU features: detected: Spectre-BHB
client # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
client # [    0.000059] arm-pv: using stolen time PV
server # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
client # [    0.001697] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000000] alternatives: applying boot alternatives
client # [    0.001896] Console: colour dummy device 80x25
client # [    0.001904] printk: legacy console [tty0] enabled
client # [    0.002133] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
client # [    0.002140] pid_max: default: 32768 minimum: 301
client # [    0.002222] LSM: initializing lsm=capability,landlock,yama,bpf,ima
client # [    0.002543] landlock: Up and running.
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/a154zaahkyrha63zd82c4x1ksspgiz6x-nixos-system-server-test/init regInfo=/nix/.ro-store/d7ijy7kbwywk0qr6dxc5hqhxwwq4z8mg-closure-info/registration console=ttyAMA0,115200n8 console=tty0
client # [    0.002546] Yama: becoming mindful.
client # [    0.004217] LSM support for eBPF active
client # [    0.004464] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/d7ijy7kbwywk0qr6dxc5hqhxwwq4z8mg-closure-info/registration", will be passed to user space.
client # [    0.004487] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
client # [    0.006618] rcu: Hierarchical SRCU implementation.
server # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
client # [    0.006625] rcu: 	Max phase no-delay instances is 1000.
client # [    0.007963] fsl-mc MSI: its@8080000 domain created
server # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
client # [    0.008109] EFI services will not be available.
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
client # [    0.008186] smp: Bringing up secondary CPUs ...
server # [    0.000000] software IO TLB: area num 1.
client # [    0.008196] smp: Brought up 1 node, 1 CPU
client # [    0.008199] SMP: Total of 1 processors activated.
server # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
client # [    0.008202] CPU: All CPU(s) started at EL1
server # [    0.000000] Fallback order for Node 0: 0
client # [    0.008216] CPU features: detected: Branch Target Identification
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
server # [    0.000000] Policy zone: DMA
client # [    0.008222] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
client # [    0.008225] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
client # [    0.008228] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.000000] allocated 2097152 bytes of page_ext
server # [    0.000000] ftrace: allocating 74966 entries in 294 pages
client # [    0.008232] CPU features: detected: Common not Private translations
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
client # [    0.008235] CPU features: detected: CRC32 instructions
server # [    0.000000] rcu: Hierarchical RCU implementation.
client # [    0.008238] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.000000] rcu: 	RCU event tracing is enabled.
client # [    0.008241] CPU features: detected: Data cache clean to Point of Persistence
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.008244] CPU features: detected: Data independent timing control (DIT)
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
client # [    0.008247] CPU features: detected: E0PD
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
client # [    0.008250] CPU features: detected: Enhanced Counter Virtualization
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
client # [    0.008253] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
client # [    0.008256] CPU features: detected: Enhanced Virtualization Traps
client # [    0.008259] CPU features: detected: Fine Grained Traps
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
client # [    0.008263] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
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.008269] CPU features: detected: RCpc load-acquire (LDAPR)
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.008272] CPU features: detected: LSE atomic instructions
client # [    0.008275] CPU features: detected: Privileged Access Never
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.008277] CPU features: detected: PMUv3
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
client # [    0.008280] CPU features: detected: RAS Extension Support
server # [    0.000000] GICv3: 256 SPIs implemented
client # [    0.008283] CPU features: detected: RASv1p1 Extension Support
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
client # [    0.008286] CPU features: detected: Random Number Generator
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
client # [    0.008288] CPU features: detected: Speculation barrier (SB)
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
client # [    0.008291] CPU features: detected: Stage-2 Force Write-Back
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
client # [    0.008294] CPU features: detected: TLB range maintenance instructions
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
client # [    0.008299] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
client # [    0.008351] alternatives: applying system-wide alternatives
client # [    0.011516] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
client # [    0.011679] Memory: 893736K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 113556K reserved, 32768K cma-reserved)
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
client # [    0.012107] devtmpfs: initialized
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
client # [    0.013986] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
client # [    0.014013] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
client # [    0.014208] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
client # [    0.014217] 0 pages in range for non-PLT usage
client # [    0.014219] 508224 pages in range for PLT usage
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client # [    0.014325] pinctrl core: initialized pinctrl subsystem
client # [    0.015269] DMI not present or invalid.
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.000054] arm-pv: using stolen time PV
client # [    0.020905] NET: Registered PF_NETLINK/PF_ROUTE protocol family
client # [    0.023399] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
server # [    0.001546] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.001769] Console: colour dummy device 80x25
client # [    0.023553] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.001778] printk: legacy console [tty0] enabled
client # [    0.023722] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
client # [    0.023748] audit: initializing netlink subsys (disabled)
server # [    0.001986] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.001993] pid_max: default: 32768 minimum: 301
client # [    0.024128] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
server # [    0.002082] LSM: initializing lsm=capability,landlock,yama,bpf,ima
client # [    0.024442] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.002414] landlock: Up and running.
server # [    0.002417] Yama: becoming mindful.
client # [    0.024444] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.003840] LSM support for eBPF active
client # [    0.024448] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.004107] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.024451] thermal_sys: Registered thermal governor 'user_space'
server # [    0.004128] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.024457] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.006185] rcu: Hierarchical SRCU implementation.
client # [    0.024482] cpuidle: using governor ladder
client # [    0.024490] cpuidle: using governor menu
server # [    0.006192] rcu: 	Max phase no-delay instances is 1000.
server # [    0.007610] fsl-mc MSI: its@8080000 domain created
client # [    0.024713] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.007733] EFI services will not be available.
client # [    0.024731] ASID allocator initialised with 65536 entries
server # [    0.007823] smp: Bringing up secondary CPUs ...
client # [    0.026085] Serial: AMBA PL011 UART driver
server # [    0.007833] smp: Brought up 1 node, 1 CPU
server # [    0.007836] SMP: Total of 1 processors activated.
client # [    0.032095] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.007839] CPU: All CPU(s) started at EL1
client # [    0.032280] printk: console [ttyAMA0] enabled
server # [    0.007854] CPU features: detected: Branch Target Identification
server # [    0.007859] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.007862] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.007866] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.007869] CPU features: detected: Common not Private translations
server # [    0.007872] CPU features: detected: CRC32 instructions
server # [    0.007875] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.007879] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.007882] CPU features: detected: Data independent timing control (DIT)
server # [    0.007885] CPU features: detected: E0PD
server # [    0.007888] CPU features: detected: Enhanced Counter Virtualization
server # [    0.007891] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.007894] CPU features: detected: Enhanced Virtualization Traps
server # [    0.007897] CPU features: detected: Fine Grained Traps
client # [    0.166395] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.007901] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
client # [    0.166406] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.007907] CPU features: detected: RCpc load-acquire (LDAPR)
client # [    0.166410] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.007910] CPU features: detected: LSE atomic instructions
client # [    0.166413] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.007913] CPU features: detected: Privileged Access Never
server # [    0.007916] CPU features: detected: PMUv3
client # [    0.166416] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.007918] CPU features: detected: RAS Extension Support
client # [    0.166418] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.007921] CPU features: detected: RASv1p1 Extension Support
client # [    0.166422] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.007924] CPU features: detected: Random Number Generator
client # [    0.166424] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.007927] CPU features: detected: Speculation barrier (SB)
client # [    0.167768] fbcon: Taking over console
server # [    0.007930] CPU features: detected: Stage-2 Force Write-Back
client # [    0.167778] ACPI: Interpreter disabled.
server # [    0.007933] CPU features: detected: TLB range maintenance instructions
server # [    0.007937] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.007991] alternatives: applying system-wide alternatives
server # [    0.011152] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.011345] Memory: 893724K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 113532K reserved, 32768K cma-reserved)
server # [    0.011736] devtmpfs: initialized
server # [    0.013606] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.013636] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.013844] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.013857] 0 pages in range for non-PLT usage
server # [    0.013859] 508224 pages in range for PLT usage
client # [    0.185634] iommu: Default domain type: Translated
server # [    0.013975] pinctrl core: initialized pinctrl subsystem
client # [    0.185644] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.014967] DMI not present or invalid.
client # [    0.186200] SCSI subsystem initialized
server # [    0.020311] NET: Registered PF_NETLINK/PF_ROUTE protocol family
client # [    0.186441] usbcore: registered new interface driver usbfs
client # [    0.186471] usbcore: registered new interface driver hub
server # [    0.022832] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
client # [    0.186486] usbcore: registered new device driver usb
server # [    0.023006] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
client # [    0.186837] pps_core: LinuxPPS API ver. 1 registered
server # [    0.023173] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
client # [    0.186841] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.023219] audit: initializing netlink subsys (disabled)
client # [    0.186849] PTP clock support registered
client # [    0.186888] EDAC MC: Ver: 3.0.0
server # [    0.023916] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.023918] thermal_sys: Registered thermal governor 'bang_bang'
client # [    0.194075] scmi_core: SCMI protocol bus registered
client # [    0.194463] FPGA manager framework
server # [    0.023922] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.023925] thermal_sys: Registered thermal governor 'user_space'
server # [    0.023928] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.023970] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
client # [    0.196277] vgaarb: loaded
server # [    0.023981] cpuidle: using governor ladder
server # [    0.023986] cpuidle: using governor menu
client # [    0.196568] clocksource: Switched to clocksource arch_sys_counter
client # [    0.197219] VFS: Disk quotas dquot_6.6.0
server # [    0.024205] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
client # [    0.197250] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.024221] ASID allocator initialised with 65536 entries
client # [    0.197519] netfs: FS-Cache loaded
server # [    0.025555] Serial: AMBA PL011 UART driver
client # [    0.197628] pnp: PnP ACPI: disabled
server # [    0.031594] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.031784] printk: console [ttyAMA0] enabled
client # [    0.206855] NET: Registered PF_INET protocol family
client # [    0.207041] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.165969] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.165979] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.165983] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.165986] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.165989] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.165992] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.165994] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.165997] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.167374] fbcon: Taking over console
server # [    0.167383] ACPI: Interpreter disabled.
server # [    0.177658] iommu: Default domain type: Translated
server # [    0.177665] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.178088] SCSI subsystem initialized
server # [    0.180268] usbcore: registered new interface driver usbfs
server # [    0.180302] usbcore: registered new interface driver hub
server # [    0.180320] usbcore: registered new device driver usb
server # [    0.180627] pps_core: LinuxPPS API ver. 1 registered
server # [    0.180631] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.180639] PTP clock support registered
server # [    0.180677] EDAC MC: Ver: 3.0.0
server # [    0.182131] scmi_core: SCMI protocol bus registered
server # [    0.188367] FPGA manager framework
server # [    0.191028] vgaarb: loaded
server # [    0.191372] clocksource: Switched to clocksource arch_sys_counter
server # [    0.198687] VFS: Disk quotas dquot_6.6.0
server # [    0.198722] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.202808] netfs: FS-Cache loaded
server # [    0.202920] pnp: PnP ACPI: disabled
client # [    0.239821] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.239872] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
client # [    0.239896] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.207124] NET: Registered PF_INET protocol family
client # [    0.239950] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    0.207282] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
client # [    0.240026] TCP: Hash tables configured (established 8192 bind 8192)
client # [    0.240163] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
client # [    0.240197] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.240251] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.240328] NET: Registered PF_UNIX/PF_LOCAL protocol family
client # [    0.240379] NET: Registered PF_XDP protocol family
client # [    0.240395] PCI: CLS 0 bytes, default 64
client # [    0.240678] Trying to unpack rootfs image as initramfs...
client # [    0.259486] kvm [1]: HYP mode not available
server # [    0.238517] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.238561] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.238586] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.238631] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    0.238712] TCP: Hash tables configured (established 8192 bind 8192)
server # [    0.238885] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
server # [    0.238929] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.238989] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.239077] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.239349] NET: Registered PF_XDP protocol family
server # [    0.239367] PCI: CLS 0 bytes, default 64
server # [    0.249491] Trying to unpack rootfs image as initramfs...
server # [    0.252436] kvm [1]: HYP mode not available
client # [    0.389918] Initialise system trusted keyrings
client # [    0.390066] workingset: timestamp_bits=42 max_order=18 bucket_order=0
client # [    0.390494] squashfs: version 4.0 (2009/01/31) Phillip Lougher
client # [    0.390539] 9p: Installing v9fs 9p2000 file system support
client # [    0.419387] Key type asymmetric registered
client # [    0.419407] Asymmetric key parser 'x509' registered
client # [    0.419492] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
client # [    0.419645] io scheduler mq-deadline registered
client # [    0.419650] io scheduler kyber registered
client # [    0.432741] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.433442] ledtrig-cpu: registered to indicate activity on CPUs
client # [    0.433870] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.392877] Initialise system trusted keyrings
client # [    0.433894] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.393036] workingset: timestamp_bits=42 max_order=18 bucket_order=0
client # [    0.433906] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.393430] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.393475] 9p: Installing v9fs 9p2000 file system support
client # [    0.433911] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
client # [    0.433930] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
client # [    0.433958] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
client # [    0.434043] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
client # [    0.434050] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.434054] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
client # [    0.434058] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
client # [    0.434061] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.434146] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
client # [    0.434627] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.434820] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
client # [    0.434832] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.434858] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.434870] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.435443] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.435628] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
client # [    0.435640] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.435666] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.436151] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
client # [    0.436340] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
client # [    0.436351] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.436377] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.416659] Key type asymmetric registered
server # [    0.416678] Asymmetric key parser 'x509' registered
server # [    0.416767] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.421662] io scheduler mq-deadline registered
server # [    0.421668] io scheduler kyber registered
client # [    0.469072] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.469286] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
client # [    0.469301] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.469332] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.469344] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.469866] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
client # [    0.470064] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.470091] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.434149] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.470590] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.434735] ledtrig-cpu: registered to indicate activity on CPUs
client # [    0.470786] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.435136] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
client # [    0.470814] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.435150] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
client # [    0.471255] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.471450] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    0.435170] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
client # [    0.471730] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.435176] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
client # [    0.471928] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.435193] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
client # [    0.471957] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.472440] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.435211] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.435287] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
client # [    0.488145] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.435294] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.488172] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.435298] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.435301] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.435304] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.490391] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.490582] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.490608] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.491193] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.491495] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.491507] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.491535] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.492044] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.492236] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
client # [    0.492249] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.492276] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.455500] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.456042] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.456236] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.456250] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.456276] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.456289] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.456780] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.456974] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.456986] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.457012] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.457512] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
client # [    0.509085] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.457700] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
client # [    0.509103] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.457711] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509107] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.457737] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509158] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.458214] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.458400] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
client # [    0.509203] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.458411] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509249] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.458437] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509294] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.458449] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.509339] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.458975] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.459171] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509384] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.459197] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509431] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
client # [    0.509477] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.478960] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
client # [    0.509521] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.479156] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.479182] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509640] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
client # [    0.509684] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
client # [    0.509708] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.482278] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.509726] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.482465] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.509743] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.482795] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.509761] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.482991] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509781] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.483020] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509799] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
client # [    0.509820] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
client # [    0.509843] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
client # [    0.509861] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
client # [    0.509879] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.488076] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.509898] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.488269] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509915] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.488294] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.509933] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
client # [    0.509950] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.488774] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.509967] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.488963] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509987] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.488990] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.510006] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.489492] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.510029] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.489889] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.510034] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.489901] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.510037] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.489927] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.510917] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.490414] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.490601] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.490612] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.490638] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.491317] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.491323] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.491327] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.491372] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.515527] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.515589] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.515635] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.515682] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.515734] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.515780] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
client # [    0.565178] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.568119] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    0.515825] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.515870] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.515987] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.516034] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.516053] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.516071] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.516094] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.516111] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.516129] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.516147] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.516167] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.516189] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.516207] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.516226] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.516244] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.516261] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.516278] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.516296] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.516313] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.516330] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.516347] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.516376] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.516381] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
client # [    0.586107] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    0.516384] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
client # [    0.588513] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    0.517269] pci 0000:00:07.0: enabling device (0000 -> 0002)
client # [    0.592918] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
client # [    0.595385] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
client # [    0.606080] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
client # [    0.608094] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    0.567352] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.619094] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.577864] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
client # [    0.629407] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
client # [    0.632069] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    0.588771] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    0.591017] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    0.595536] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    0.598004] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
client # [    0.645884] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client # [    0.647818] msm_serial: driver initialized
client # [    0.647992] SuperH (H)SCI(F) driver initialized
client # [    0.648049] STM32 USART driver initialized
server # [    0.608892] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    0.610935] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    0.621428] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.631604] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    0.634389] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
client # [    0.686472] loop: module loaded
client # [    0.686694] virtio_blk virtio2: 1/0/0 default/read/poll queues
client # [    0.687651] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    0.648648] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    0.650570] msm_serial: driver initialized
server # [    0.650704] SuperH (H)SCI(F) driver initialized
server # [    0.650788] STM32 USART driver initialized
client # [    0.701397] megasas: 07.734.00.00-rc1
client # [    0.702175] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.704243] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.704265] Intel/Sharp Extended Query Table at 0x0031
client # [    0.709728] Using buffer write method
client # [    0.709772] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
client # [    0.711591] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.711609] Intel/Sharp Extended Query Table at 0x0031
client # [    0.727151] Using buffer write method
client # [    0.727177] Concatenating MTD devices:
client # [    0.727180] (0): "0.flash"
client # [    0.727183] (1): "0.flash"
client # [    0.727185] into device "0.flash"
server # [    0.693012] loop: module loaded
server # [    0.693227] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    0.694138] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    0.700137] megasas: 07.734.00.00-rc1
server # [    0.700917] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    0.712255] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.712278] Intel/Sharp Extended Query Table at 0x0031
server # [    0.714032] Using buffer write method
server # [    0.714076] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    0.719782] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.719798] Intel/Sharp Extended Query Table at 0x0031
server # [    0.721561] Using buffer write method
server # [    0.721578] Concatenating MTD devices:
server # [    0.721580] (0): "0.flash"
server # [    0.721583] (1): "0.flash"
server # [    0.721584] into device "0.flash"
client # [    1.026700] Freeing initrd memory: 26444K
client # [    1.033060] tun: Universal TUN/TAP device driver, 1.6
client # [    1.036451] thunder_xcv, ver 1.0
client # [    1.036478] thunder_bgx, ver 1.0
client # [    1.036497] nicpf, ver 1.0
client # [    1.039114] e1000: Intel(R) PRO/1000 Network Driver
client # [    1.039119] e1000: Copyright (c) 1999-2006 Intel Corporation.
client # [    1.039145] e1000e: Intel(R) PRO/1000 Network Driver
client # [    1.039154] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
client # [    1.039177] igb: Intel(R) Gigabit Ethernet Network Driver
client # [    1.039181] igb: Copyright (c) 2007-2014 Intel Corporation.
client # [    1.039201] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    1.039204] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
client # [    1.039347] sky2: driver version 1.30
client # [    1.047884] ehci-pci 0000:00:07.0: EHCI Host Controller
client # [    1.047937] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
client # [    1.048114] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
client # [    1.051234] usbcore: registered new interface driver usb-storage
client # [    1.051282] usbcore: registered new interface driver usbserial_generic
client # [    1.051292] usbserial: USB Serial support registered for generic
client # [    1.051913] hv_vmbus: registering driver hyperv_keyboard
client # [    1.055947] rtc-pl031 9010000.pl031: registered as rtc0
client # [    1.055972] rtc-pl031 9010000.pl031: setting system clock to 2026-09-28T03:11:08 UTC (1790565068)
client # [    1.056298] i2c_dev: i2c /dev entries driver
client # [    1.056607] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
client # [    1.056906] hub 1-0:1.0: USB hub found
client # [    1.056922] hub 1-0:1.0: 6 ports detected
server # [    1.019074] Freeing initrd memory: 26420K
client # [    1.064706] sdhci: Secure Digital Host Controller Interface driver
client # [    1.064712] sdhci: Copyright(c) Pierre Ossman
client # [    1.064998] Synopsys Designware Multimedia Card Interface Driver
client # [    1.065386] sdhci-pltfm: SDHCI platform and OF driver helper
client # [    1.066978] hid: raw HID events driver (C) Jiri Kosina
server # [    1.025502] tun: Universal TUN/TAP device driver, 1.6
client # [    1.067290] usbcore: registered new interface driver usbhid
client # [    1.067299] usbhid: USB HID core driver
client # [    1.068480] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    1.029593] thunder_xcv, ver 1.0
server # [    1.029622] thunder_bgx, ver 1.0
server # [    1.029642] nicpf, ver 1.0
client # [    1.076193] drop_monitor: Initializing network drop monitor service
server # [    1.030219] e1000: Intel(R) PRO/1000 Network Driver
client # [    1.076421] NET: Registered PF_INET6 protocol family
server # [    1.030223] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    1.030245] e1000e: Intel(R) PRO/1000 Network Driver
server # [    1.030254] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    1.030282] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    1.030285] igb: Copyright (c) 2007-2014 Intel Corporation.
client # [    1.078516] Segment Routing with IPv6
client # [    1.078543] In-situ OAM (IOAM) with IPv6
server # [    1.030306] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    1.078571] NET: Registered PF_PACKET protocol family
server # [    1.030310] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
client # [    1.078623] 9pnet: Installing 9P2000 support
server # [    1.030450] sky2: driver version 1.30
client # [    1.078669] Key type dns_resolver registered
server # [    1.039992] usbcore: registered new interface driver usb-storage
server # [    1.040112] usbcore: registered new interface driver usbserial_generic
client # [    1.087524] registered taskstats version 1
client # [    1.087663] Loading compiled-in X.509 certificates
server # [    1.040124] usbserial: USB Serial support registered for generic
server # [    1.040758] hv_vmbus: registering driver hyperv_keyboard
server # [    1.042069] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    1.042086] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    1.042312] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    1.042619] rtc-pl031 9010000.pl031: registered as rtc0
server # [    1.042646] rtc-pl031 9010000.pl031: setting system clock to 2026-09-28T03:11:08 UTC (1790565068)
server # [    1.043048] i2c_dev: i2c /dev entries driver
server # [    1.051937] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    1.052265] hub 1-0:1.0: USB hub found
client # [    1.096657] Demotion targets for Node 0: null
server # [    1.052280] hub 1-0:1.0: 6 ports detected
client # [    1.096787] Key type .fscrypt registered
server # [    1.055269] sdhci: Secure Digital Host Controller Interface driver
client # [    1.096794] Key type fscrypt-provisioning registered
server # [    1.055275] sdhci: Copyright(c) Pierre Ossman
client # [    1.096896] ima: No TPM chip found, activating TPM-bypass!
client # [    1.096913] ima: Allocated hash algorithm: sha1
client # [    1.096943] ima: No architecture policies found
server # [    1.058730] Synopsys Designware Multimedia Card Interface Driver
server # [    1.059152] sdhci-pltfm: SDHCI platform and OF driver helper
client # [    1.097671] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.062359] hid: raw HID events driver (C) Jiri Kosina
server # [    1.062641] usbcore: registered new interface driver usbhid
server # [    1.062647] usbhid: USB HID core driver
server # [    1.065823] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    1.068663] drop_monitor: Initializing network drop monitor service
server # [    1.068809] NET: Registered PF_INET6 protocol family
server # [    1.069378] Segment Routing with IPv6
server # [    1.069393] In-situ OAM (IOAM) with IPv6
server # [    1.069420] NET: Registered PF_PACKET protocol family
server # [    1.069474] 9pnet: Installing 9P2000 support
server # [    1.069512] Key type dns_resolver registered
client # [    1.120737] clk: Disabling unused clocks
client # [    1.120754] PM: genpd: Disabling unused power domains
client # [    1.123848] Freeing unused kernel memory: 4736K
client # [    1.124036] Run /init as init process
server # [    1.080188] registered taskstats version 1
server # [    1.080345] Loading compiled-in X.509 certificates
server # [    1.089146] Demotion targets for Node 0: null
server # [    1.089271] Key type .fscrypt registered
server # [    1.089278] Key type fscrypt-provisioning registered
server # [    1.089383] ima: No TPM chip found, activating TPM-bypass!
server # [    1.089401] ima: Allocated hash algorithm: sha1
server # [    1.089422] ima: No architecture policies found
server # [    1.090082] input: gpio-keys as /devices/platform/gpio-keys/input/input0
client # [    1.143088] systemd[1]: Successfully made /usr/ read-only.
client # [    1.143530] systemd[1]: systemd 263-885fe07 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.143545] systemd[1]: Detected virtualization qemu.
client # [    1.143584] systemd[1]: Detected architecture arm64.
client # [    1.143589] systemd[1]: Running in initrd.
client # [    1.143878] systemd[1]: Initializing machine ID from random generator.
client # [    1.143972] systemd[1]: Hostname set to <client>.
server # [    1.112575] clk: Disabling unused clocks
server # [    1.112591] PM: genpd: Disabling unused power domains
server # [    1.116879] Freeing unused kernel memory: 4736K
server # [    1.117069] Run /init as init process
server # [    1.133740] systemd[1]: Successfully made /usr/ read-only.
server # [    1.134166] systemd[1]: systemd 263-885fe07 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.134180] systemd[1]: Detected virtualization qemu.
server # [    1.134217] systemd[1]: Detected architecture arm64.
server # [    1.134222] systemd[1]: Running in initrd.
server # [    1.134493] systemd[1]: Initializing machine ID from random generator.
server # [    1.134587] systemd[1]: Hostname set to <server>.
client # [    1.247649] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    1.237726] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.302262] systemd[1]: Queued start job for default target Initrd Default Target.
client # [    1.304653] usb 1-1: new high-speed USB device number 2 using ehci-pci
client # [    1.309089] systemd[1]: Created slice Slice /system/modprobe.
client # [    1.309266] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    1.309292] systemd[1]: Expecting device /dev/disk/by-label/nixos...
client # [    1.309311] systemd[1]: Reached target Path Units.
client # [    1.309324] systemd[1]: Reached target Slice Units.
client # [    1.309336] systemd[1]: Reached target Swaps.
client # [    1.309349] systemd[1]: Reached target Timer Units.
client # [    1.309477] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    1.309596] systemd[1]: Listening on Journal Socket (/dev/log).
client # [    1.309711] systemd[1]: Listening on Journal Sockets.
client # [    1.309781] systemd[1]: Listening on udev Kernel Socket.
client # [    1.309794] systemd[1]: Reached target Socket Units.
client # [    1.311153] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.311211] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.332145] systemd[1]: Mounting Kernel Configuration File System...
server # [    1.292625] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    1.301393] systemd[1]: Created slice Slice /system/modprobe.
client # [    1.344739] systemd[1]: Starting Journal Service...
server # [    1.301579] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    1.301605] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    1.301625] systemd[1]: Reached target Path Units.
server # [    1.301636] systemd[1]: Reached target Slice Units.
server # [    1.301649] systemd[1]: Reached target Swaps.
server # [    1.301663] systemd[1]: Reached target Timer Units.
server # [    1.301797] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    1.301917] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    1.302059] systemd[1]: Listening on Journal Sockets.
server # [    1.302129] systemd[1]: Listening on udev Kernel Socket.
server # [    1.302142] systemd[1]: Reached target Socket Units.
server # [    1.303230] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    1.313957] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.356846] systemd[1]: Starting Load Kernel Modules...
server # [    1.314027] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.356965] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    1.323291] systemd[1]: Mounting Kernel Configuration File System...
client # [    1.368938] systemd[1]: Starting Coldplug All udev Devices...
client # [    1.382274] systemd[1]: Finished Create List of Static Device Nodes.
client # [    1.382956] systemd[1]: Mounted Kernel Configuration File System.
server # [    1.343648] systemd[1]: Starting Journal Service...
server # [    1.355236] systemd[1]: Starting Load Kernel Modules...
server # [    1.355356] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    1.397062] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    1.371845] systemd[1]: Starting Coldplug All udev Devices...
server # [    1.395604] systemd[1]: Finished Create List of Static Device Nodes.
server # [    1.396532] systemd[1]: Mounted Kernel Configuration File System.
client # [    1.441705] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
client # [    1.453048] systemd-journald[71]: Collecting audit messages is disabled.
server # [    1.407914] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    1.419154] systemd-journald[71]: Collecting audit messages is disabled.
client # [    1.460680] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.463333] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
server # [    1.430018] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
client # [    1.478408] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
client # [    1.478657] [drm] features: -virgl +edid -resource_blob -host_visible
client # [    1.478660] [drm] features: -context_init
client # [    1.479456] [drm] number of scanouts: 1
client # [    1.479467] [drm] number of cap sets: 0
client # [    1.480453] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    1.486613] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    1.455540] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.505071] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
client # [    1.505088] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    1.461447] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    1.470663] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    1.481267] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    1.481523] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    1.481526] [drm] features: -context_init
server # [    1.482293] [drm] number of scanouts: 1
server # [    1.482304] [drm] number of cap sets: 0
server # [    1.492916] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
client # [    1.537316] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    1.537557] systemd[1]: Reached target Preparation for Local File Systems.
client # [    1.537579] systemd[1]: Reached target Local File Systems.
server # [    1.497592] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    1.497604] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
client # [    1.543520] Console: switching to colour frame buffer device 160x50
client # [    1.549458] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0
client # [    1.551694] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    1.569211] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    1.531732] Console: switching to colour frame buffer device 160x50
client # [    1.585327] systemd[1]: Finished Load Kernel Modules.
server # [    1.544112] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    1.590176] systemd[1]: Starting Apply Kernel Variables...
server # [    1.544487] systemd[1]: Reached target Preparation for Local File Systems.
server # [    1.544505] systemd[1]: Reached target Local File Systems.
server # [    1.550662] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    1.556241] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    1.579742] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0
server # [    1.580332] systemd[1]: Finished Load Kernel Modules.
client # [    1.637926] systemd[1]: Started Journal Service.
client # [    1.624753] systemd-modules-load[72]: Inserted module 'dm_mod'
client # [    1.625933] systemd-modules-load[72]: Module 'virtio_balloon' is built in
server # [    1.595815] systemd[1]: Starting Apply Kernel Variables...
client # [    1.640229] systemd-modules-load[72]: Module 'virtio_console' is built in
client # [    1.644441] systemd-modules-load[72]: Inserted module 'virtio_gpu'
client # [    1.646710] systemd-modules-load[72]: Module 'virtio_rng' is built in
server # [    1.615700] systemd[1]: Started Journal Service.
server # [    1.604331] systemd-modules-load[72]: Inserted module 'dm_mod'
server # [    1.605830] systemd-modules-load[72]: Module 'virtio_balloon' is built in
server # [    1.607045] systemd-modules-load[72]: Module 'virtio_console' is built in
client # [    1.668644] usb 1-2: new high-speed USB device number 3 using ehci-pci
client # [    1.660616] systemd[1]: Starting Create System Files and Directories...
client # [    1.664902] systemd-udevd[78]: Using default interface naming scheme 'v261'.
server # [    1.624699] systemd-modules-load[72]: Inserted module 'virtio_gpu'
server # [    1.625796] systemd-modules-load[72]: Module 'virtio_rng' is built in
client # [    1.680209] systemd[1]: Finished Apply Kernel Variables.
server # [    1.636122] systemd[1]: Starting Create System Files and Directories...
client # [    1.693175] systemd[1]: Finished Create System Files and Directories.
server # [    1.653879] systemd-udevd[78]: Using default interface naming scheme 'v261'.
server # [    1.656038] systemd[1]: Finished Apply Kernel Variables.
client # [    1.711299] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    1.678360] systemd[1]: Finished Create System Files and Directories.
server # [    1.699502] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    1.704146] systemd[1]: Started Rule-based Manager for Device Events and Files.
client # [    1.809275] systemd[1]: Starting Virtual Console Setup...
client # [    1.839960] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
client # [    1.840256] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0
server # [    1.785175] systemd[1]: Starting Virtual Console Setup...
server # [    1.870936] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
client # [    1.900586] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    1.874183] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0
client # [    1.908189] systemd[1]: Finished Virtual Console Setup.
server # [    1.879079] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    1.884450] systemd[1]: Finished Virtual Console Setup.
client # [    2.603646] systemd[1]: Finished Coldplug All udev Devices.
client # [    2.604737] systemd[1]: Reached target System Initialization.
client # [    2.608156] systemd[1]: Reached target Basic System.
server # [    2.608911] systemd[1]: Finished Coldplug All udev Devices.
server # [    2.612207] systemd[1]: Reached target System Initialization.
server # [    2.613089] systemd[1]: Reached target Basic System.
server # [    2.736290] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    2.789161] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    2.793271] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.
server # [    2.778168] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.
client # [    2.853767] systemd[1]: Found device /dev/disk/by-label/nixos.
client # [    2.855798] systemd[1]: Reached target Initrd Root Device.
client # [    2.859918] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    2.844500] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    2.847901] systemd[1]: Reached target Initrd Root Device.
server # [    2.850650] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
client # [    2.915990] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks
client # [    2.931214] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
client # [    2.942758] systemd[1]: Mounting /sysroot...
server # [    2.902071] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    2.910607] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    2.927192] systemd[1]: Mounting /sysroot...
client # [    2.993181] EXT4-fs (vda): mounted filesystem d89c7bc0-4905-43bc-a399-7bf0fce5c819 r/w with ordered data mode. Quota mode: none.
client # [    2.983669] systemd[1]: Mounted /sysroot.
client # [    2.986056] systemd[1]: Reached target Initrd Root File System.
client # [    2.990502] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    2.974250] EXT4-fs (vda): mounted filesystem 690f34bb-d2cc-4167-b091-6c2453fe0960 r/w with ordered data mode. Quota mode: none.
server # [    2.961574] systemd[1]: Mounted /sysroot.
server # [    2.964229] systemd[1]: Reached target Initrd Root File System.
server # [    2.967948] systemd[1]: Starting Mountpoints Configured in the Real Root...
client # [    3.022845] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.
client # [    3.029296] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...
client # [    3.034257] systemd[1]: Reloading...
server # [    3.002870] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    3.008105] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    3.013260] systemd[1]: Reloading...
client # [    3.243591] systemd[1]: Reloading finished in 210 ms.
server # [    3.227283] systemd[1]: Reloading finished in 215 ms.
client # [    3.277583] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...
client # [    3.284870] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...
client # [    3.288213] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
client # [    3.291487] systemd[1]: Finished Mountpoints Configured in the Real Root.
client # [    3.294715] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    3.256618] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...
server # [    3.261810] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...
server # [    3.267544] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    3.272091] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    3.273684] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
client # [    3.372466] systemd[1]: Mounting /sysroot/nix/.ro-store...
client # [    3.393220] systemd[1]: Mounting /sysroot/nix/.rw-store...
client # [    3.399595] systemd[1]: Mounting /sysroot/run...
server # [    3.358670] systemd[1]: Mounting /sysroot/nix/.ro-store...
client # [    3.423289] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    3.378177] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.386416] systemd[1]: Mounting /sysroot/run...
client # [    3.446582] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    3.410401] systemd[1]: Mounting /sysroot/tmp/shared...
client # [    3.514301] fuse: init (API version 7.45)
client # [    3.501615] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    3.461969] systemd[1]: Mounting /sysroot/tmp/xchg...
client # [    3.531737] virtiofs virtio6: discovered new tag: nix-store
client # [    3.532552] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [    3.493838] fuse: init (API version 7.45)
client # [    3.530754] systemd[1]: Mounted /sysroot/run.
server # [    3.503333] virtiofs virtio6: discovered new tag: nix-store
server # [    3.490412] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    3.512235] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
client # [    3.558522] virtiofs virtio7: discovered new tag: shared
client # [    3.559349] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
client # [    3.566863] virtiofs virtio8: discovered new tag: xchg
client # [    3.567830] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    3.529237] virtiofs virtio7: discovered new tag: shared
client # [    3.559672] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    3.530109] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # [    3.536157] virtiofs virtio8: discovered new tag: xchg
server # [    3.537078] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
client # [    3.571436] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    3.524770] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    3.580809] systemd[1]: Mounted /sysroot/nix/.ro-store.
client # [    3.584530] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    3.543816] systemd[1]: Mounted /sysroot/run.
server # [    3.555587] systemd[1]: Mounted /sysroot/nix/.ro-store.
client # [    3.606464] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    3.611238] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    3.564658] systemd[1]: Mounted /sysroot/tmp/shared.
client # [    3.616298] systemd[1]: Mounting /sysroot/nix/store...
server # [    3.574848] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    3.591985] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    3.594737] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    3.670090] systemd[1]: Mounted /sysroot/nix/store.
client # [    3.672142] systemd[1]: Reached target Initrd File Systems.
client # [    3.674684] systemd[1]: Starting Find NixOS closure...
client # [    3.684892] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
client # [    3.727325] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
client # [    3.745723] systemd[1]: Finished Find NixOS closure.
client # [    3.747817] systemd[1]: Reached target Initrd Default Target.
client # [    3.753104] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
client # [    3.786309] systemd[1]: Stopped target Initrd Default Target.
client # [    3.790210] systemd[1]: Stopped target Basic System.
client # [    3.792851] systemd[1]: Stopped target Initrd Root Device.
client # [    3.794548] systemd[1]: Stopped target Path Units.
client # [    3.799522] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
client # [    3.801686] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
client # [    3.805246] systemd[1]: Stopped target Slice Units.
client # [    3.810138] systemd[1]: Stopped target Socket Units.
client # [    3.811030] systemd[1]: Stopped target System Initialization.
client # [    3.816827] systemd[1]: Stopped target Swaps.
client # [    3.818914] systemd[1]: Stopped target Timer Units.
client # [    3.819822] systemd[1]: dbus.socket: Deactivated successfully.
client # [    3.822493] systemd[1]: Closed D-Bus System Message Bus Socket.
client # [    3.831059] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
client # [    3.832437] systemd[1]: Stopped Find NixOS closure.
client # [    3.839061] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    3.842203] systemd[1]: systemd-sysctl.service: Deactivated successfully.
client # [    3.848228] systemd[1]: Stopped Apply Kernel Variables.
client # [    3.851166] systemd[1]: systemd-modules-load.service: Deactivated successfully.
client # [    3.852565] systemd[1]: Stopped Load Kernel Modules.
client # [    3.856719] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
client # [    3.857943] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
client # [    3.860136] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
client # [    3.863863] systemd[1]: Stopped Create System Files and Directories.
client # [    3.865125] systemd[1]: Stopped target Local File Systems.
client # [    3.865959] systemd[1]: Stopped target Preparation for Local File Systems.
client # [    3.868138] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
client # [    3.871082] systemd[1]: Stopped Coldplug All udev Devices.
client # [    3.871980] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
client # [    3.873160] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    3.874234] systemd[1]: Stopped Virtual Console Setup.
client # [    3.875023] systemd[1]: initrd-cleanup.service: Deactivated successfully.
client # [    3.875993] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
client # [    3.885143] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    3.886272] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    3.888470] systemd[1]: systemd-udevd.service: Deactivated successfully.
client # [    3.890023] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
client # [    3.891200] systemd[1]: systemd-udevd.service: Consumed 1.071s CPU time over 2.343s wall clock time, 16M memory peak.
client # [    3.892823] systemd[1]: Starting Cleanup udev Database...
client # [    3.893631] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
client # [    3.894809] systemd[1]: Stopped Create Static Device Nodes in /dev.
client # [    3.895718] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
client # [    3.900210] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
client # [    3.901318] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
client # [    3.904035] systemd[1]: Stopped Create List of Static Device Nodes.
client # [    3.929084] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
client # [    3.932566] systemd[1]: Finished Cleanup udev Database.
client # [    3.933461] systemd[1]: Reached target Switch Root.
client # [    3.936481] systemd[1]: Starting NixOS Activation...
client # [    4.007004] initrd-nixos-activation-start[169]: booting system configuration /nix/store/q06p1ia41llfsd0bfg99am6a1n3jf09d-nixos-system-client-test
client # [    4.037591] initrd-nixos-activation-start[169]: running activation script...
server # [    4.192870] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/h0gamn89nms8prhnc5v8m85jslcyklhg-systemd-263-885fe07/lib/udev/mtd_probe": No such file or directory
client # [    4.248543] initrd-nixos-activation-start[192]: setting up /etc...
server # [    4.200286] (udev-worker)[93]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory
server # [    4.230262] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.234738] systemd[1]: Stopped Virtual Console Setup.
server # [    4.236135] systemd[1]: Stopping Virtual Console Setup...
server # [    4.240899] systemd[1]: Starting Virtual Console Setup...
server # [    4.244951] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.246493] systemd[1]: Stopped Virtual Console Setup.
server # [    4.255088] systemd[1]: Starting Virtual Console Setup...
server # [    4.288386] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    4.292380] systemd[1]: Finished Virtual Console Setup.
client # [    4.359269] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
client # [    4.362302] systemd[1]: Finished NixOS Activation.
client # [    4.363539] systemd[1]: Starting Switch Root...
client # [    4.388117] systemd[1]: Switching root.
server # [    4.357429] systemd[1]: Mounting /sysroot/nix/store...
server # [    4.400387] systemd[1]: Mounted /sysroot/nix/store.
server # [    4.402118] systemd[1]: Reached target Initrd File Systems.
server # [    4.405339] systemd[1]: Starting Find NixOS closure...
server # [    4.416330] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    4.453964] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    4.459474] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
server # [    4.466831] systemd[1]: Finished Find NixOS closure.
server # [    4.468897] systemd[1]: Reached target Initrd Default Target.
server # [    4.471607] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    4.490994] systemd[1]: Stopped target Initrd Default Target.
server # [    4.492904] systemd[1]: Stopped target Basic System.
server # [    4.493894] systemd[1]: Stopped target Initrd Root Device.
server # [    4.496359] systemd[1]: Stopped target Path Units.
server # [    4.497135] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [    4.500189] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [    4.501976] systemd[1]: Stopped target Slice Units.
server # [    4.504146] systemd[1]: Stopped target Socket Units.
server # [    4.505454] systemd[1]: Stopped target System Initialization.
server # [    4.508490] systemd[1]: Stopped target Swaps.
server # [    4.512607] systemd[1]: Stopped target Timer Units.
client # [    4.573964] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).
server # [    4.514351] systemd[1]: dbus.socket: Deactivated successfully.
server # [    4.516152] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [    4.518655] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [    4.528353] systemd[1]: Stopped Find NixOS closure.
server # [    4.531222] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    4.534632] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [    4.540163] systemd[1]: Stopped Apply Kernel Variables.
server # [    4.542339] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [    4.545386] systemd[1]: Stopped Load Kernel Modules.
server # [    4.546255] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [    4.549623] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [    4.552143] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [    4.553815] systemd[1]: Stopped Create System Files and Directories.
server # [    4.555813] systemd[1]: Stopped target Local File Systems.
server # [    4.560208] systemd[1]: Stopped target Preparation for Local File Systems.
server # [    4.561223] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [    4.562231] systemd[1]: Stopped Coldplug All udev Devices.
server # [    4.563020] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [    4.565626] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.566709] systemd[1]: Stopped Virtual Console Setup.
server # [    4.567490] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    4.568555] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    4.569493] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [    4.570441] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [    4.571541] systemd[1]: systemd-udevd.service: Consumed 1.573s CPU time over 3.008s wall clock time, 22.3M memory peak.
server # [    4.578989] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    4.584224] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    4.585292] systemd[1]: Starting Cleanup udev Database...
server # [    4.586114] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [    4.587449] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [    4.592184] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [    4.593341] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [    4.594358] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [    4.595407] systemd[1]: Stopped Create List of Static Device Nodes.
server # [    4.623450] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [    4.626595] systemd[1]: Finished Cleanup udev Database.
server # [    4.627573] systemd[1]: Reached target Switch Root.
server # [    4.629182] systemd[1]: Starting NixOS Activation...
client # [    4.730986] systemd[1]: systemd 263-885fe07 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 # [    4.731968] systemd[1]: Detected virtualization qemu.
client # [    4.732019] systemd[1]: Detected architecture arm64.
client # [    4.732108] systemd[1]: Detected first boot.
client # [    4.743915] systemd[1]: Initializing machine ID from random generator.
server # [    4.708471] initrd-nixos-activation-start[175]: booting system configuration /nix/store/a154zaahkyrha63zd82c4x1ksspgiz6x-nixos-system-server-test
server # [    4.740722] initrd-nixos-activation-start[175]: running activation script...
client # [    4.876282] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    4.966524] initrd-nixos-activation-start[198]: setting up /etc...
client # [    5.031095] systemd[1]: Applying preset policy.
server # [    5.079461] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [    5.082398] systemd[1]: Finished NixOS Activation.
server # [    5.083675] systemd[1]: Starting Switch Root...
server # [    5.107704] systemd[1]: Switching root.
client # [    5.243156] systemd[1]: Populated /etc with preset unit settings.
server # [    5.292591] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).
client # [    5.426214] systemd[1]: initrd-switch-root.service: Deactivated successfully.
client # [    5.427056] systemd[1]: Stopped initrd-switch-root.service.
client # [    5.431139] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
client # [    5.434169] systemd[1]: Created slice Slice /system/getty.
client # [    5.435416] systemd[1]: Created slice User and Session Slice.
client # [    5.435949] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    5.439598] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
client # [    5.440011] systemd[1]: Expecting device /dev/hvc0...
client # [    5.442805] systemd[1]: Expecting device /dev/ttyAMA0...
client # [    5.443206] systemd[1]: Reached target Local Encrypted Volumes.
client # [    5.443829] systemd[1]: Stopped target initrd-fs.target.
client # [    5.444401] systemd[1]: Stopped target initrd-root-fs.target.
client # [    5.448435] systemd[1]: Stopped target initrd-switch-root.target.
client # [    5.450418] systemd[1]: Reached target Virtual Machines and Containers.
client # [    5.450819] systemd[1]: Reached target Path Units.
client # [    5.451545] systemd[1]: Reached target Remote File Systems.
client # [    5.452138] systemd[1]: Reached target Slice Units.
client # [    5.456155] systemd[1]: Reached target Swaps.
client # [    5.458749] systemd[1]: Listening on Query the User Interactively for a Password.
client # [    5.460525] systemd[1]: Listening on Process Core Dump Socket.
client # [    5.464217] systemd[1]: Listening on Credential Encryption/Decryption.
client # [    5.466859] systemd[1]: Listening on Factory Reset Management.
client # [    5.467364] systemd[1]: Listening on Hostname Service Socket.
client # [    5.471848] systemd[1]: Starting Journal Log Access Socket...
client # [    5.474342] systemd[1]: Listening on Journal Audit Socket.
client # [    5.476120] systemd[1]: Listening on Console Output Muting Service Socket.
client # [    5.479019] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
client # [    5.479421] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
client # [    5.479678] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
client # [    5.487857] systemd[1]: Listening on Disk Repartitioning Service Socket.
client # [    5.488418] systemd[1]: Listening on udev Varlink Socket.
client # [    5.492561] systemd[1]: Mounting Huge Pages File System...
client # [    5.497413] systemd[1]: Mounting POSIX Message Queue File System...
server # [    5.449387] systemd[1]: systemd 263-885fe07 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 # [    5.450320] systemd[1]: Detected virtualization qemu.
server # [    5.450887] systemd[1]: Detected architecture arm64.
server # [    5.451366] systemd[1]: Detected first boot.
server # [    5.462452] systemd[1]: Initializing machine ID from random generator.
client # [    5.508034] systemd[1]: Mounting Kernel Debug File System...
client # [    5.521324] systemd[1]: Mounting Kernel Trace File System...
client # [    5.533938] systemd[1]: Starting Create List of Static Device Nodes...
client # [    5.534413] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    5.552475] systemd[1]: Mounting Kernel Configuration File System...
client # [    5.556744] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
client # [    5.562039] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
client # [    5.562486] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [    5.591500] systemd[1]: Mounting FUSE Control File System...
client # [    5.592149] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
client # [    5.623556] systemd[1]: Starting Journal Service...
server # [    5.591781] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    5.639913] systemd[1]: Starting Load Kernel Modules...
client # [    5.657300] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
client # [    5.666996] systemd[1]: Starting Remount Root and Kernel File Systems...
client # [    5.672498] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    5.695116] systemd-journald[264]: Collecting audit messages is enabled.
client # [    5.690288] systemd[1]: Queued start job for default target Multi-User System.
client # [    5.702169] systemd[1]: Starting Coldplug All udev Devices...
client # [    5.693712] systemd[1]: systemd-journald.service: Deactivated successfully.
client # [    5.723917] systemd[1]: Started Journal Service.
client # [    5.715546] systemd[1]: Listening on Journal Log Access Socket.
client # [    5.723676] systemd[1]: Mounted Huge Pages File System.
client # [    5.728696] systemd[1]: Mounted POSIX Message Queue File System.
client # [    5.729617] systemd[1]: Mounted Kernel Debug File System.
client # [    5.730449] systemd[1]: Mounted Kernel Trace File System.
client # [    5.742826] systemd[1]: Finished Create List of Static Device Nodes.
client # [    5.748806] systemd-modules-load[265]: Module 'atkbd' is built in
client # [    5.749779] systemd-modules-load[265]: Module 'loop' is built in
client # [    5.764681] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    5.771512] systemd[1]: Finished Load Kernel Modules.
client # [    5.779995] systemd[1]: Starting Firewall...
server # [    5.753884] systemd[1]: Applying preset policy.
client # [    5.800381] systemd[1]: Starting Apply Kernel Variables...
client # [    5.820615] EXT4-fs (vda): re-mounted d89c7bc0-4905-43bc-a399-7bf0fce5c819.
client # [    5.830255] systemd[1]: Finished Remount Root and Kernel File Systems.
client # [    5.836951] systemd[1]: Mounted FUSE Control File System.
client # [    5.839086] systemd[1]: Mounted Kernel Configuration File System.
client # [    5.842619] systemd[1]: Listening on Disk Image Download Service Socket.
client # [    5.865198] systemd-oomd[267]: No swap; memory pressure usage will be degraded
client # [    5.866683] systemd[1]: Starting Flush Journal to Persistent Storage...
client # [    5.867632] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
client # [    5.893396] systemd[1]: Starting Load/Save OS Random Seed...
client # [    5.894320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    5.902621] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [    5.944126] systemd[1]: Populated /etc with preset unit settings.
client # [    5.999622] systemd-journald[264]: Received client request to flush runtime journal.
client # [    6.061777] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    6.068886] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    6.069988] systemd[1]: Finished Load/Save OS Random Seed.
client # [    6.070876] systemd[1]: Reached target First Boot Complete.
client # [    6.071693] systemd[1]: Finished Apply Kernel Variables.
client # [    6.076251] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [    6.132624] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [    6.133396] systemd[1]: Stopped initrd-switch-root.service.
server # [    6.137683] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [    6.139295] systemd[1]: Created slice Slice /system/getty.
server # [    6.142539] systemd[1]: Created slice User and Session Slice.
server # [    6.143159] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    6.146091] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [    6.146501] systemd[1]: Expecting device /dev/hvc0...
server # [    6.147046] systemd[1]: Expecting device /dev/ttyAMA0...
server # [    6.150406] systemd[1]: Reached target Local Encrypted Volumes.
server # [    6.150866] systemd[1]: Stopped target initrd-fs.target.
server # [    6.153356] systemd[1]: Stopped target initrd-root-fs.target.
server # [    6.153741] systemd[1]: Stopped target initrd-switch-root.target.
server # [    6.154273] systemd[1]: Reached target Virtual Machines and Containers.
server # [    6.154826] systemd[1]: Reached target Path Units.
server # [    6.155318] systemd[1]: Reached target Remote File Systems.
client # [    6.188761] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    6.190229] systemd[1]: Reached target Preparation for Local File Systems.
server # [    6.160070] systemd[1]: Reached target Slice Units.
server # [    6.160454] systemd[1]: Reached target Swaps.
server # [    6.162114] systemd[1]: Listening on Query the User Interactively for a Password.
server # [    6.166269] systemd[1]: Listening on Process Core Dump Socket.
server # [    6.168337] systemd[1]: Listening on Credential Encryption/Decryption.
client # [    6.199289] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    6.169519] systemd[1]: Listening on Factory Reset Management.
server # [    6.169999] systemd[1]: Listening on Hostname Service Socket.
server # [    6.175227] systemd[1]: Starting Journal Log Access Socket...
server # [    6.177324] systemd[1]: Listening on Journal Audit Socket.
server # [    6.179176] systemd[1]: Listening on Console Output Muting Service Socket.
server # [    6.181498] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [    6.181975] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [    6.182505] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [    6.190821] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [    6.191375] systemd[1]: Listening on udev Varlink Socket.
server # [    6.195483] systemd[1]: Mounting Huge Pages File System...
server # [    6.197743] systemd[1]: Mounting POSIX Message Queue File System...
server # [    6.211949] systemd[1]: Mounting Kernel Debug File System...
server # [    6.219972] systemd[1]: Mounting Kernel Trace File System...
server # [    6.232292] systemd[1]: Starting Create List of Static Device Nodes...
server # [    6.236329] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    6.247628] systemd[1]: Mounting Kernel Configuration File System...
server # [    6.250879] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [    6.258819] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [    6.262628] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [    6.287890] systemd[1]: Mounting FUSE Control File System...
server # [    6.288295] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [    6.319095] systemd[1]: Starting Journal Service...
server # [    6.335275] systemd[1]: Starting Load Kernel Modules...
server # [    6.366040] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [    6.379243] systemd-journald[269]: Collecting audit messages is enabled.
server # [    6.373911] systemd[1]: Queued start job for default target Multi-User System.
server # [    6.377610] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [    6.399105] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [    6.401741] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.434282] systemd[1]: Mounting /run/wrappers...
server # [    6.432909] systemd[1]: Starting Coldplug All udev Devices...
server # [    6.426458] systemd-modules-load[270]: Module 'atkbd' is built in
server # [    6.447454] systemd[1]: Started Journal Service.
server # [    6.433588] systemd-modules-load[270]: Module 'loop' is built in
server # [    6.443557] systemd[1]: Listening on Journal Log Access Socket.
server # [    6.447620] systemd[1]: Mounted Huge Pages File System.
server # [    6.450595] systemd[1]: Mounted POSIX Message Queue File System.
server # [    6.451583] systemd[1]: Mounted Kernel Debug File System.
server # [    6.460357] systemd[1]: Mounted Kernel Trace File System.
server # [    6.461208] systemd[1]: Finished Create List of Static Device Nodes.
server # [    6.462119] systemd[1]: Mounted FUSE Control File System.
client # [    6.513024] systemd[1]: Mounted /run/wrappers.
client # [    6.513886] systemd[1]: Reached target Local File Systems.
server # [    6.467673] systemd-modules-load[270]: Inserted module 'tls'
server # [    6.471950] systemd[1]: Mounted Kernel Configuration File System.
client # [    6.520712] systemd-udevd[301]: Using default interface naming scheme 'v261'.
client # [    6.521844] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [    6.492291] EXT4-fs (vda): re-mounted 690f34bb-d2cc-4167-b091-6c2453fe0960.
client # [    6.532216] systemd[1]: Starting Create SUID/SGID Wrappers...
client # [    6.533228] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [    6.489248] systemd[1]: Finished Load Kernel Modules.
client # [    6.544153] systemd[1]: Starting Save Transient machine-id to Disk...
server # [    6.498158] systemd[1]: Finished Remount Root and Kernel File Systems.
client # [    6.547502] systemd[1]: Starting Create System Files and Directories...
server # [    6.500781] systemd[1]: Listening on Disk Image Download Service Socket.
server # [    6.508367] systemd[1]: Starting Firewall...
server # [    6.514567] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [    6.515712] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [    6.526808] systemd[1]: Starting Load/Save OS Random Seed...
server # [    6.531684] systemd-oomd[272]: No swap; memory pressure usage will be degraded
server # [    6.545527] systemd[1]: Starting Apply Kernel Variables...
server # [    6.569094] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    6.570297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    6.571640] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [    6.651479] systemd-journald[269]: Received client request to flush runtime journal.
client # [    6.686136] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
client # [    6.700786] systemd[1]: Finished Save Transient machine-id to Disk.
client # [    6.712381] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    6.712731] systemd[1]: Finished Load/Save OS Random Seed.
server # [    6.713808] systemd[1]: Reached target First Boot Complete.
server # [    6.726155] systemd[1]: Finished Flush Journal to Persistent Storage.
client # [    6.789196] systemd[1]: Finished Create System Files and Directories.
server # [    6.750274] systemd[1]: Finished Apply Kernel Variables.
client # [    6.804243] systemd[1]: Starting Rebuild Journal Catalog...
client # [    6.813958] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [    6.833976] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    6.840892] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    6.982469] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
client # [    7.002253] systemd[1]: Finished Rebuild Journal Catalog.
server # [    6.965955] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    6.967044] systemd[1]: Reached target Preparation for Local File Systems.
client # [    7.016128] systemd[1]: Starting Update is Completed...
server # [    6.968854] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    7.103053] systemd[1]: Finished Update is Completed.
server # [    7.120837] systemd[1]: Mounting /run/wrappers...
server # [    7.136943] systemd-udevd[311]: Using default interface naming scheme 'v261'.
server # [    7.189088] systemd[1]: Mounted /run/wrappers.
server # [    7.189933] systemd[1]: Reached target Local File Systems.
server # [    7.198339] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [    7.204137] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [    7.205143] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [    7.213088] systemd[1]: Starting Save Transient machine-id to Disk...
server # [    7.220807] systemd[1]: Starting Create System Files and Directories...
server # [    7.308570] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    7.434806] systemd[1]: Finished Create System Files and Directories.
server # [    7.451150] systemd[1]: Starting Rebuild Journal Catalog...
server # [    7.461559] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
client # [    7.577714] systemd[1]: Finished Coldplug All udev Devices.
server # [    7.608441] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [    7.617769] systemd[1]: Finished Rebuild Journal Catalog.
server # [    7.629267] systemd[1]: Starting Update is Completed...
client # [    7.732602] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
client # [    7.737955] systemd[1]: Finished Create SUID/SGID Wrappers.
client # [    7.739010] systemd[1]: Reached target System Initialization.
client # [    7.739924] systemd[1]: Started Discard unused filesystem blocks once a week.
client # [    7.750927] systemd[1]: Started Daily Cleanup of Temporary Directories.
client # [    7.751957] systemd[1]: Reached target Timer Units.
server # [    7.707766] systemd[1]: Finished Update is Completed.
client # [    7.756468] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    7.757495] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
client # [    7.758778] systemd[1]: Reached target Socket Units.
client # [    7.759552] systemd[1]: Reached target Basic System.
client # [    7.771399] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [    7.774231] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [    7.775271] systemd[1]: Starting Post-Boot Actions...
client # [    7.794752] systemd[1]: Started Reset console on configuration changes.
client # [    7.839116] systemd[1]: Starting resolvconf update...
client # [    7.914118] systemd[1]: Starting D-Bus System Message Bus...
client # [    7.921440] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    7.931004] systemd[1]: Reached target Host and Network Name Lookups.
client # [    7.939820] nsncd[437]: Sep 28 03:11:15.383 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    7.953684] systemd[1]: Reached target User and Group Name Lookups.
client # [    7.954949] systemd[1]: Starting User Login Management...
client # [    7.981115] systemd[1]: Finished Post-Boot Actions.
client # [    8.137925] systemd[1]: Finished Import lastlog data into lastlog2 database.
client # [    8.185611] dbus-broker-launch[444]: Looking up NSS user entry for 'systemd-timesync'...
client # [    8.190981] dbus-broker-launch[444]: NSS returned no entry for 'systemd-timesync'
client # [    8.197930] dbus-broker-launch[444]: Invalid user-name in /nix/store/ic30nhd7xkhyyz16nj42ghrqs0airv8i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [    8.160320] systemd[1]: Finished Coldplug All udev Devices.
server # [    8.168444] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [    8.180124] systemd[1]: Finished Save Transient machine-id to Disk.
client # [    8.252161] systemd[1]: Started D-Bus System Message Bus.
client # [    8.264259] systemd-logind[455]: New seat seat0.
client # [    8.271181] systemd[1]: Started User Login Management.
client # [    8.280271] systemd[1]: Starting linger-users.service...
server # [    8.246329] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    8.316543] dbus-broker-launch[444]: Ready
server # [    8.305624] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [    8.319808] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [    8.324326] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [    8.327713] systemd[1]: Reached target System Initialization.
server # [    8.331996] systemd[1]: Started Discard unused filesystem blocks once a week.
client # [    8.379776] systemd[1]: linger-users.service: Deactivated successfully.
server # [    8.333326] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [    8.334373] systemd[1]: Reached target Timer Units.
server # [    8.335137] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    8.384624] systemd[1]: Finished linger-users.service.
server # [    8.343756] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
client # [    8.392307] systemd[1]: Stopped target Host and Network Name Lookups.
server # [    8.349286] systemd[1]: Reached target Socket Units.
server # [    8.350176] systemd[1]: Reached target Basic System.
client # [    8.397450] systemd[1]: Stopping Host and Network Name Lookups...
server # [    8.350965] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [    8.398581] systemd[1]: Stopped target User and Group Name Lookups.
client # [    8.399539] systemd[1]: Stopping User and Group Name Lookups...
server # [    8.360769] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [    8.361902] systemd[1]: Starting Post-Boot Actions...
client # [    8.409623] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
client # [    8.410739] systemd[1]: nscd.service: Deactivated successfully.
server # [    8.367395] systemd[1]: Started Reset console on configuration changes.
client # [    8.419709] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
client # [    8.448812] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [    8.414482] systemd[1]: Starting resolvconf update...
server # [    8.454569] systemd[1]: Starting D-Bus System Message Bus...
client # [    8.548222] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    8.553803] nsncd[532]: Sep 28 03:11:16.008 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    8.565716] systemd[1]: Reached target Host and Network Name Lookups.
client # [    8.566803] systemd[1]: Reached target User and Group Name Lookups.
client # [    8.567778] systemd[1]: Finished resolvconf update.
client # [    8.577494] systemd[1]: Starting DHCP Client...
server # [    8.543585] systemd[1]: Finished Post-Boot Actions.
server # [    8.569324] nsncd[443]: Sep 28 03:11:16.041 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [    8.584412] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [    8.592297] systemd[1]: Reached target Host and Network Name Lookups.
server # [    8.593456] systemd[1]: Reached target User and Group Name Lookups.
server # [    8.630494] systemd[1]: Starting User Login Management...
client # [    8.718666] systemd[1]: Finished Firewall.
client # [    8.722811] systemd[1]: Reached target Preparation for Network.
client # [    8.730149] systemd[1]: Starting Extra networking commands....
server # [    8.702299] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [    8.726369] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'...
server # [    8.734184] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync'
server # [    8.735463] dbus-broker-launch[447]: Invalid user-name in /nix/store/2z5va9bn4gyq1xk0mwqmqr1r6s4q95i5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
client # [    8.818698] dhcpcd[570]: dhcpcd-10.3.2 starting
client # [    8.828820] dhcpcd[578]: dev: loaded udev
client # [    8.833038] dhcpcd[578]: no valid interfaces found
client # [    8.837151] dhcpcd[578]: libudev: received NULL device
client # [    8.838501] dhcpcd[578]: no valid interfaces found
client # [    8.839406] dhcpcd[578]: libudev: received NULL device
server # [    8.815461] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [    8.822749] systemd[1]: Started D-Bus System Message Bus.
server # [    8.875977] systemd-logind[469]: New seat seat0.
server # [    8.881818] systemd[1]: Started User Login Management.
server # [    8.889836] dbus-broker-launch[447]: Ready
server # [    8.898791] systemd[1]: Starting linger-users.service...
server # [    8.928369] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [    8.947673] systemd[1]: Started backdoor.service.
client # [    9.029599] systemd[1]: Finished Extra networking commands..
client # [    9.033631] systemd[1]: Reached target Network.
server # [    8.990536] systemd[1]: Stopped target Host and Network Name Lookups.
client # [    9.038009] systemd[1]: Starting Permit User Sessions...
server # [    9.000240] systemd[1]: Stopping Host and Network Name Lookups...
server # [    9.001312] systemd[1]: Stopped target User and Group Name Lookups.
server # [    9.002241] systemd[1]: Stopping User and Group Name Lookups...
server # [    9.003088] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [    9.021507] systemd[1]: nscd.service: Deactivated successfully.
server # [    9.030088] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
client # [    9.104743] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [    9.066840] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [    9.074629] systemd[1]: linger-users.service: Deactivated successfully.
client # [    9.122250] systemd[1]: Finished Permit User Sessions.
client # [    9.130299] systemd[1]: Started Getty on tty1.
server # [    9.083856] systemd[1]: Finished linger-users.service.
client # [    9.137391] systemd[1]: Reached target Login Prompts.
server # connecting to host...
server: Guest shell says: b'Spawning backdoor root shell...\n'
server # [    9.197121] systemd[1]: Started Name Service Cache Daemon (nsncd).
server: connected to guest root shell
server: (connecting took 10.01 seconds)
server: (finished: waiting for the VM to finish booting, in 10.01 seconds)
server # [    9.201488] nsncd[539]: Sep 28 03:11:16.677 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [    9.210750] systemd[1]: Reached target Host and Network Name Lookups.
server # [    9.216432] systemd[1]: Reached target User and Group Name Lookups.
server # [    9.222193] systemd[1]: Finished resolvconf update.
server # [    9.241350] systemd[1]: Starting DHCP Client...
server # [    9.328514] (udev-worker)[334]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    9.330850] (udev-worker)[334]: Network interface NamePolicy= disabled on kernel command line.
client # [    9.458150] systemd[1]: Starting Virtual Console Setup...
server # [    9.419221] systemd[1]: Finished Firewall.
server # [    9.426637] systemd[1]: Reached target Preparation for Network.
server # [    9.446027] systemd[1]: Starting Extra networking commands....
client # [    9.494452] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    9.498508] systemd[1]: Stopped Virtual Console Setup.
client # [    9.512539] systemd[1]: Starting Virtual Console Setup...
client # [    9.606283] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    9.592889] dhcpcd[593]: dhcpcd-10.3.2 starting
server # [    9.606005] dhcpcd[604]: dev: loaded udev
server # [    9.675508] 8021q: 802.1Q VLAN Support v1.8
client # [    9.777173] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
client # [    9.837392] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
client # [    9.844829] systemd[1]: Started backdoor.service.
server # [    9.818151] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [    9.824753] systemd[1]: Starting Address configuration of eth1...
server # [    9.857646] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client # connecting to host...
server # [    9.886377] systemd[1]: Finished Extra networking commands..
server # [    9.892193] systemd[1]: Reached target Network.
server # [    9.913974] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [    9.914478] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [    9.918860] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [    9.919175] cfg80211: failed to load regulatory.db
client # [    9.967346] 8021q: 802.1Q VLAN Support v1.8
server # [    9.911051] systemd[1]: Starting Nginx Web Server...
server # [    9.924211] systemd-logind[469]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # [    9.942025] systemd[1]: Starting Permit User Sessions...
client # [   10.005040] (udev-worker)[644]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [   10.014778] (udev-worker)[644]: Network interface NamePolicy= disabled on kernel command line.
server # [   10.008406] 8021q: adding VLAN 0 to HW filter on device eth1
server # [   10.017774] systemd[1]: Finished Permit User Sessions.
client # [   10.084137] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   10.029985] network-addresses-eth1-start[644]: adding address 192.168.1.2/24... done
server # [   10.040770] systemd[1]: Started Getty on tty1.
server # [   10.041567] systemd[1]: Reached target Login Prompts.
client # [   10.111806] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client # [   10.112341] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
client # [   10.117052] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
client # [   10.117412] cfg80211: failed to load regulatory.db
server # [   10.077582] network-addresses-eth1-start[644]: adding address 2001:db8:1::2/64... done
server # [   10.098522] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   10.084797] dhcpcd[604]: eth0: waiting for carrier
server # [   10.086004] dhcpcd[604]: eth0: waiting for carrier
server # [   10.086666] dhcpcd[604]: eth0: carrier acquired
server # [   10.104598] dhcpcd[604]: DUID 00:01:00:01:32:4c:97:55:52:54:00:12:34:56
server # [   10.105723] dhcpcd[604]: eth0: IAID 00:12:34:56
server # [   10.106409] dhcpcd[604]: eth0: adding address fe80::5054:ff:fe12:3456
server # [   10.114734] systemd[1]: Finished Address configuration of eth1.
server # [   10.168717] mousedev: PS/2 mouse device common for all mice
client # [   10.242594] systemd[1]: Condition check resulted in Virtio network device being skipped.
client # [   10.251377] systemd[1]: Starting Address configuration of eth1...
client # [   10.279278] systemd-vconsole-setup[634]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [   10.289372] systemd[1]: Finished Virtual Console Setup.
server # [   10.252370] nginx-pre-start[681]: nginx: the configuration file /nix/store/g3f78glxbrs0dwjv347ml213l44jp9g1-nginx.conf syntax is ok
server # [   10.254148] nginx-pre-start[681]: nginx: configuration file /nix/store/g3f78glxbrs0dwjv347ml213l44jp9g1-nginx.conf test is successful
server # [   10.272491] systemd[1]: Started Nginx Web Server.
client # [   10.354527] dhcpcd[578]: eth0: waiting for carrier
client # [   10.368979] 8021q: adding VLAN 0 to HW filter on device eth0
client # [   10.361395] dhcpcd[578]: eth0: carrier acquired
client # [   10.374394] dhcpcd[578]: DUID 00:01:00:01:32:4c:97:55:52:54:00:12:34:56
client # [   10.375477] dhcpcd[578]: eth0: IAID 00:12:34:56[   10.390096] 8021q: adding VLAN 0 to HW filter on device eth1
client # 
client # [   10.379458] dhcpcd[578]: eth0: adding address fe80::5054:ff:fe12:3456
client # [   10.398382] systemd-logind[455]: Watching system buttons on /dev/input/event0 (gpio-keys)
client # [   10.405728] network-addresses-eth1-start[662]: adding address 192.168.1.1/24... done
server # [   10.367046] systemd-logind[469]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
client # [   10.429734] network-addresses-eth1-start[662]: adding address 2001:db8:1::1/64... done
client # [   10.460207] systemd[1]: Finished Address configuration of eth1.
client # [   10.526017] mousedev: PS/2 mouse device common for all mice
server: (finished: waiting for unit nginx.service, in 11.35 seconds)
client: waiting for the VM to finish booting
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 0.00 seconds)
client: (finished: waiting for the VM to finish booting, in 0.00 seconds)
client # [   10.663343] systemd-logind[455]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   11.136753] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   11.479179] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   11.483227] dhcpcd[604]: eth0: soliciting a DHCP lease
server # [   11.485567] systemd[1]: Starting Virtual Console Setup...
server # [   11.488935] dhcpcd[604]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [   11.500331] dhcpcd[604]: eth0: probing address 10.0.2.15/24
server # [   11.517940] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   11.522092] systemd[1]: Stopped Virtual Console Setup.
server # [   11.529991] systemd[1]: Starting Virtual Console Setup...
server # [   11.583932] systemd-logind[469]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
client # [   11.727021] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [   11.729646] systemd[1]: Stopped Virtual Console Setup.
client # [   11.733972] systemd[1]: Stopping Virtual Console Setup...
client # [   11.737252] systemd[1]: Starting Virtual Console Setup...
server # [   11.693242] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   11.697613] systemd[1]: Finished Virtual Console Setup.
client # [   11.782068] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client # [   11.793183] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [   11.798402] systemd[1]: Stopped Virtual Console Setup.
client # [   11.806281] systemd[1]: Starting Virtual Console Setup...
client # [   11.838963] systemd-logind[455]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
client # [   11.921830] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [   11.926451] systemd[1]: Finished Virtual Console Setup.
client # [   12.169628] dhcpcd[578]: eth0: soliciting a DHCP lease
client # [   12.172736] dhcpcd[578]: eth0: offered 10.0.2.15 from 10.0.2.2
client # [   12.180230] dhcpcd[578]: eth0: probing address 10.0.2.15/24
client # [   12.403849] dhcpcd[578]: eth0: soliciting an IPv6 router
client # [   12.406024] dhcpcd[578]: eth0: Router Advertisement from fe80::2
client # [   12.407493] dhcpcd[578]: eth0: adding address fec0::5054:ff:fe12:3456/64
client # [   12.409128] dhcpcd[578]: eth0: adding route to fec0::/64
client # [   12.410368] dhcpcd[578]: eth0: adding default route via fe80::2
server # [   12.435611] dhcpcd[604]: eth0: soliciting an IPv6 router
server # [   12.437592] dhcpcd[604]: eth0: Router Advertisement from fe80::2
server # [   12.438944] dhcpcd[604]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [   12.440839] dhcpcd[604]: eth0: adding route to fec0::/64
server # [   12.442018] dhcpcd[604]: eth0: adding default route via fe80::2
server # [   16.665362] dhcpcd[604]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   16.665545] dhcpcd[604]: eth0: adding route to 10.0.2.0/24
server # [   16.665655] dhcpcd[604]: eth0: adding default route via 10.0.2.2
server # [   16.765789] systemd[1]: Started DHCP Client.
server # [   16.767949] systemd[1]: Reached target Multi-User System.
server # [   16.769363] systemd[1]: Startup finished in 1.102s (kernel) + 4.241s (initrd) + 11.424s (userspace) = 16.769s.
client # [   17.037191] dhcpcd[578]: eth0: leased 10.0.2.15 for 86400 seconds
client # [   17.037399] dhcpcd[578]: eth0: adding route to 10.0.2.0/24
client # [   17.037469] dhcpcd[578]: eth0: adding default route via 10.0.2.2
client # [   17.149648] systemd[1]: Started DHCP Client.
client # [   17.151799] systemd[1]: Reached target Multi-User System.
client # [   17.155693] systemd[1]: Reached target Network is Online.
client # [   17.156992] systemd[1]: Startup finished in 1.113s (kernel) + 3.515s (initrd) + 12.524s (userspace) = 17.153s.
client: waiting for unit network-online.target
client: (finished: waiting for unit network-online.target, in 0.04 seconds)
client: must succeed: machinectl pull-raw --verify=signature http://server/testimage.raw
client # The 'machinectl pull-raw' command has been replaced by 'importctl -m pull-raw'. Redirecting invocation.
client # [   17.222432] systemd[1]: Starting Disk Image Download Service...
client # [   17.256123] systemd[1]: Started Disk Image Download Service.
client # Enqueued transfer job 1. Press C-c to continue download in background.
client # Pulling 'http://server/testimage.raw', saving as 'testimage'.
client # [   17.265845] systemd-importd[765]: (transfer1) Pulling 'http://server/testimage.raw', saving as 'testimage'.
client # [   17.267397] systemd-importd[765]: (transfer1) Operating on image directory '/var/lib/machines'.
client # Operating on image directory '/var/lib/machines'.
server # [   17.533696] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *1 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.raw.sha256.asc" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256.asc HTTP/1.1", host: "server"
client # Downloading 5M for http://server/testimage.raw.
client # [   17.592913] systemd-importd[765]: (transfer1) Downloading 5M for http://server/testimage.raw.
server # [   17.543550] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *3 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.raw.sha256" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256 HTTP/1.1", host: "server"
client # Got 1% of http://server/testimage.raw.
client # [   17.598793] systemd-importd[765]: (transfer1) Got 1% of http://server/testimage.raw.
server # [   17.551058] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *1 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.raw.sha256.gpg" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256.gpg HTTP/1.1", host: "server"
client # HTTP request to http://server/testimage.nspawn failed with code 404.
client # [   17.612070] systemd-importd[765]: (transfer1) HTTP request to http://server/testimage.nspawn failed with code 404.
server # [   17.561320] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *4 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.nspawn" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.nspawn HTTP/1.1", host: "server"
client # [   17.614621] systemd-importd[765]: (transfer1) Settings file could not be retrieved, proceeding without.
client # Settings file could not be retrieved, proceeding without.
server # [   17.568688] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *5 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.roothash" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.roothash HTTP/1.1", host: "server"
client # Downloading 119B for http://server/SHA256SUMS.gpg.
client # Acquired 119B for http://server/SHA256SUMS.gpg.
client # Download of http://server/SHA256SUMS.gpg complete.
client # HTTP request to http://server/testimage.roothash failed with code 404.
server # [   17.576250] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *6 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.roothash.p7s" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.roothash.p7s HTTP/1.1", host: "server"
client # [   17.632352] systemd-importd[765]: (transfer1) Downloading 119B for http://server/SHA256SUMS.gpg.
client # [   17.634411] systemd-importd[765]: (transfer1) Acquired 119B for http://server/SHA256SUMS.gpg.
server # [   17.585168] nginx[697]: 2026/09/28 03:11:25 [error] 697#697: *7 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.verity" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.verity HTTP/1.1", host: "server"
client # Root hash file could not be retrieved, proceeding without.
client # HTTP request to http://server/testimage.roothash.p7s failed with code 404.
client # [   17.652629] systemd-importd[765]: (transfer1) Download of http://server/SHA256SUMS.gpg complete.
client # [   17.654706] systemd-importd[765]: (transfer1) HTTP request to http://server/testimage.roothash failed with code 404.
client # Root hash signature file could not be retrieved, proceeding without.
client # Downloading 164B for http://server/SHA256SUMS.
client # [   17.668745] systemd-importd[765]: (transfer1) Root hash file could not be retrieved, proceeding without.
client # [   17.670744] systemd-importd[765]: (transfer1) HTTP request to http://server/testimage.roothash.p7s failed with code 404.
client # Acquired 164B for http://server/SHA256SUMS.
client # Download of http://server/SHA256SUMS complete.
client # HTTP request to http://server/testimage.verity failed with code 404.
client # Verity integrity file could not be retrieved, proceeding without.
client # [   17.688644] systemd-importd[765]: (transfer1) Root hash signature file could not be retrieved, proceeding without.
client # [   17.690567] systemd-importd[765]: (transfer1) Downloading 164B for http://server/SHA256SUMS.
client # [   17.700449] systemd-importd[765]: (transfer1) Acquired 164B for http://server/SHA256SUMS.
client # [   17.701914] systemd-importd[765]: (transfer1) Download of http://server/SHA256SUMS complete.
client # [   17.703364] systemd-importd[765]: (transfer1) HTTP request to http://server/testimage.verity failed with code 404.
client # [   17.712455] systemd-importd[765]: (transfer1) Verity integrity file could not be retrieved, proceeding without.
client # Acquired 5M for http://server/testimage.raw.
client # Download of http://server/testimage.raw complete.
client # [   17.872445] systemd-importd[765]: (transfer1) Acquired 5M for http://server/testimage.raw.
client # [   17.874568] systemd-importd[765]: (transfer1) Download of http://server/testimage.raw complete.
client # SHA256 checksum of http://server/testimage.raw is valid.
client # [   17.878242] systemd-importd[765]: (transfer1) SHA256 checksum of http://server/testimage.raw is valid.
client # gpg: Signature made Fri 11 Sep 2026 07:22:25 PM UTC
client # [   17.907425] systemd-importd[765]: (transfer1) gpg: Signature made Fri 11 Sep 2026 07:22:25 PM UTC
client # gpg:                using EDDSA key 9F9156EB88A12F336F23ABB7A08C365E823F094C
client # [   17.912504] systemd-importd[765]: (transfer1) gpg:                using EDDSA key 9F9156EB88A12F336F23ABB7A08C365E823F094C
client # [   17.918562] systemd-importd[765]: (transfer1) gpg: Good signature from "Bob Foobar <bob@foo.bar>" [unknown]
client # gpg: Good signature from "Bob Foobar <bob@foo.bar>" [unknown]
client # gpg: WARNING: Using untrusted key!
client # [   17.924366] systemd-importd[765]: (transfer1) gpg: WARNING: Using untrusted key!
client # Signature verification succeeded.
client # [   17.927114] systemd-importd[765]: (transfer1) Signature verification succeeded.
client # Created new local image 'testimage'.
client # [   18.255310] systemd-importd[765]: (transfer1) Created new local image 'testimage'.
client # Operation completed successfully.
client # Exiting.
client # [   18.261787] systemd-importd[765]: (transfer1) Operation completed successfully.
client # [   18.263485] systemd-importd[765]: (transfer1) Exiting.
client: (finished: must succeed: machinectl pull-raw --verify=signature http://server/testimage.raw, in 1.08 seconds)
client: must succeed: cmp /var/lib/machines/testimage.raw /nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.raw
client: (finished: must succeed: cmp /var/lib/machines/testimage.raw /nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage.raw, in 0.04 seconds)
client: must succeed: machinectl pull-tar --verify=signature http://server/testimage2.tar.xz
client # The 'machinectl pull-tar' command has been replaced by 'importctl -m pull-tar'. Redirecting invocation.
client # Enqueued transfer job 2. Press C-c to continue download in background.
client # Pulling 'http://server/testimage2.tar.xz', saving as 'testimage2'.
client # [   18.353333] systemd-importd[765]: (transfer2) Pulling 'http://server/testimage2.tar.xz', saving as 'testimage2'.
client # Operating on image directory '/var/lib/machines'.
client # [   18.356591] systemd-importd[765]: (transfer2) Operating on image directory '/var/lib/machines'.
server # [   18.583196] nginx[697]: 2026/09/28 03:11:26 [error] 697#697: *8 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage2.tar.xz.sha256" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256 HTTP/1.1", host: "server"
server # [   18.590393] nginx[697]: 2026/09/28 03:11:26 [error] 697#697: *9 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage2.tar.xz.sha256.asc" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256.asc HTTP/1.1", host: "server"
client # [   18.645412] systemd-importd[765]: (transfer2) HTTP request to http://server/testimage2.nspawn failed with code 404.
server # [   18.597084] nginx[697]: 2026/09/28 03:11:26 [error] 697#697: *10 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage2.nspawn" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.nspawn HTTP/1.1", host: "server"
client # HTTP request to http://server/testimage2.nspawn failed with code 404.
client # Settings file could not be retrieved, proceeding without.
client # [   18.653195] systemd-importd[765]: (transfer2) Settings file could not be retrieved, proceeding without.
server # [   18.603575] nginx[697]: 2026/09/28 03:11:26 [error] 697#697: *9 open() "/nix/store/2869il2kj5s63a9asfdy5adhdsbyq40p-localhost/testimage2.tar.xz.sha256.gpg" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256.gpg HTTP/1.1", host: "server"
client # [   18.655429] systemd-importd[765]: (transfer2) Downloading 164B for http://server/SHA256SUMS.
client # Downloading 164B for http://server/SHA256SUMS.
client # Acquired 164B for http://server/SHA256SUMS.
client # Download of http://server/SHA256SUMS complete.
client # Downloading 57.6K for http://server/testimage2.tar.xz.
client # [   18.662893] systemd-importd[765]: (transfer2) Acquired 164B for http://server/SHA256SUMS.
client # [   18.664871] systemd-importd[765]: (transfer2) Download of http://server/SHA256SUMS complete.
client # [   18.666721] systemd-importd[765]: (transfer2) Downloading 57.6K for http://server/testimage2.tar.xz.
client # Acquired 350K for http://server/testimage2.tar.xz.
client # [   18.709974] systemd-importd[765]: (transfer2) Acquired 350K for http://server/testimage2.tar.xz.
client # Download of http://server/testimage2.tar.xz complete.
client # [   18.716106] systemd-importd[765]: (transfer2) Download of http://server/testimage2.tar.xz complete.
client # Downloading 119B for http://server/SHA256SUMS.gpg.
client # [   18.962963] systemd-importd[765]: (transfer2) Downloading 119B for http://server/SHA256SUMS.gpg.
client # Acquired 119B for http://server/SHA256SUMS.gpg.
client # Download of http://server/SHA256SUMS.gpg complete.
client # [   18.969142] systemd-importd[765]: (transfer2) Acquired 119B for http://server/SHA256SUMS.gpg.
client # [   18.971108] systemd-importd[765]: (transfer2) Download of http://server/SHA256SUMS.gpg complete.
client # SHA256 checksum of http://server/testimage2.tar.xz is valid.
client # [   18.974645] systemd-importd[765]: (transfer2) SHA256 checksum of http://server/testimage2.tar.xz is valid.
client # gpg: Signature made Fri 11 Sep 2026 07:22:25 PM UTC
client # [   18.986045] systemd-importd[765]: (transfer2) gpg: Signature made Fri 11 Sep 2026 07:22:25 PM UTC
client # gpg:                using EDDSA key 9F9156EB88A12F336F23ABB7A08C365E823F094C
client # [   18.993705] systemd-importd[765]: (transfer2) gpg:                using EDDSA key 9F9156EB88A12F336F23ABB7A08C365E823F094C
client # gpg: Good signature from "Bob Foobar <bob@foo.bar>" [unknown]
client # [   18.998747] systemd-importd[765]: (transfer2) gpg: Good signature from "Bob Foobar <bob@foo.bar>" [unknown]
client # gpg: WARNING: Using untrusted key!
client # [   19.002075] systemd-importd[765]: (transfer2) gpg: WARNING: Using untrusted key!
client # Signature verification succeeded.
client # [   19.004867] systemd-importd[765]: (transfer2) Signature verification succeeded.
client # Created new local image 'testimage2'.
client # [   19.050914] systemd-importd[765]: (transfer2) Created new local image 'testimage2'.
client # Operation completed successfully.
client # Exiting.
client # [   19.055465] systemd-importd[765]: (transfer2) Operation completed successfully.
client # [   19.058636] systemd-importd[765]: (transfer2) Exiting.
client: (finished: must succeed: machinectl pull-tar --verify=signature http://server/testimage2.tar.xz, in 0.75 seconds)
client: must succeed: cmp /var/lib/machines/testimage2//nix/store/kwhxkl8yn5y8wqiq11jsybagw3fbc4iv-hello-2.12.3/bin/hello /nix/store/kwhxkl8yn5y8wqiq11jsybagw3fbc4iv-hello-2.12.3/bin/hello
client: (finished: must succeed: cmp /var/lib/machines/testimage2//nix/store/kwhxkl8yn5y8wqiq11jsybagw3fbc4iv-hello-2.12.3/bin/hello /nix/store/kwhxkl8yn5y8wqiq11jsybagw3fbc4iv-hello-2.12.3/bin/hello, in 0.02 seconds)
(finished: run the VM test script, in 20.44 seconds)
test script finished in 22.25s
cleanup
kill QemuMachine (pid 47)
client # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)
client # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
kill QemuMachine (pid 48)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)
server # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-09-28T03:11:28Z INFO  virtiofsd] Client disconnected, shutting down
(finished: cleanup, in 0.33 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