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
subtest: Creating keys and certificates
(finished: subtest: Creating keys and certificates, in 0.04 seconds)
subtest: Copying keys and certificates
(finished: subtest: Copying keys and certificates, in 0.02 seconds)
server: waiting for unit nginx.service
server: waiting for the VM to finish booting
server: starting vm
server # Disk image does not exist, creating the virtualisation disk image...
server: QEMU running (pid 57)
server # Formatting '/build/vm-state-server/tmp.jrxRPlxZJv', fmt=raw size=1073741824
server # mke2fs 1.47.4 (6-Mar-2025)
server # Discarding device blocks:      0/262144             done
server # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Filesystem UUID: 3e040681-039a-458c-b9ae-0df799226089
server # Superblock backups stored on blocks:
server # 	32768, 98304, 163840, 229376
server # 
server # Allocating group tables: 0/8   done
server # Writing inode tables: 0/8   done
server # Creating journal (8192 blocks): done
server # Writing superblocks and filesystem accounting information: 0/8   done
server # 
server # Virtualisation disk image created.
server # Starting virtiofs daemons...
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
server # [2026-10-01T03:46:13Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Waiting for vhost-user socket connection...
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Client connected, servicing requests
server # [2026-10-01T03:46:13Z INFO  virtiofsd] Client connected, servicing requests
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
server # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026
server # [    0.000000] KASLR enabled
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]
server # [    0.000000] Zone ranges:
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   empty
server # [    0.000000]   Device   empty
server # [    0.000000] Movable zone start for each node
server # [    0.000000] Early memory node ranges
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x000000007cc00000
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.3 detected in firmware.
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.1
server # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
server # [    0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] CPU features: detected: Spectre-BHB
server # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38
server # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23
server # [    0.000000] alternatives: applying boot alternatives
server # [    0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/18syabcxvzl7mmqgxqadd1ahhxscwfn4-nixos-system-server-test/init regInfo=/nix/.ro-store/3d8s0ribv9v2dbs5dl2pdqvd2pjx2lv5-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/3d8s0ribv9v2dbs5dl2pdqvd2pjx2lv5-closure-info/registration", will be passed to user space.
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
server # [    0.000000] software IO TLB: area num 1.
server # [    0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)
server # [    0.000000] Fallback order for Node 0: 0
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
server # [    0.000000] Policy zone: DMA
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
server # [    0.000000] allocated 2097152 bytes of page_ext
server # [    0.000000] ftrace: allocating 75026 entries in 294 pages
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
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.
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
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
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.000034] arm-pv: using stolen time PV
server # [    0.000422] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.000658] Console: colour dummy device 80x25
server # [    0.000667] printk: legacy console [tty0] enabled
server # [    0.000857] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.000864] pid_max: default: 32768 minimum: 301
server # [    0.000942] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.001093] landlock: Up and running.
server # [    0.001096] Yama: becoming mindful.
server # [    0.001556] LSM support for eBPF active
server # [    0.001686] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.001707] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.003773] rcu: Hierarchical SRCU implementation.
server # [    0.003780] rcu: 	Max phase no-delay instances is 1000.
server # [    0.005146] fsl-mc MSI: its@8080000 domain created
server # [    0.005274] EFI services will not be available.
server # [    0.005363] smp: Bringing up secondary CPUs ...
server # [    0.005373] smp: Brought up 1 node, 1 CPU
server # [    0.005376] SMP: Total of 1 processors activated.
server # [    0.005379] CPU: All CPU(s) started at EL1
server # [    0.005389] CPU features: detected: Branch Target Identification
server # [    0.005398] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.005401] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.005405] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.005409] CPU features: detected: Common not Private translations
server # [    0.005412] CPU features: detected: CRC32 instructions
server # [    0.005415] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.005418] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.005421] CPU features: detected: Data independent timing control (DIT)
server # [    0.005424] CPU features: detected: E0PD
server # [    0.005427] CPU features: detected: Enhanced Counter Virtualization
server # [    0.005430] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.005434] CPU features: detected: Enhanced Virtualization Traps
server # [    0.005437] CPU features: detected: Fine Grained Traps
server # [    0.005440] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
server # [    0.005445] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.005448] CPU features: detected: LSE atomic instructions
server # [    0.005451] CPU features: detected: Privileged Access Never
server # [    0.005454] CPU features: detected: PMUv3
server # [    0.005456] CPU features: detected: RAS Extension Support
server # [    0.005459] CPU features: detected: RASv1p1 Extension Support
server # [    0.005462] CPU features: detected: Random Number Generator
server # [    0.005464] CPU features: detected: Speculation barrier (SB)
server # [    0.005467] CPU features: detected: Stage-2 Force Write-Back
server # [    0.005470] CPU features: detected: TLB range maintenance instructions
server # [    0.005475] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.005515] alternatives: applying system-wide alternatives
server # [    0.008721] CPU features: detected: BBM Level 2 without TLB conflict abort
server # [    0.008965] Memory: 893624K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 113604K reserved, 32768K cma-reserved)
server # [    0.009358] devtmpfs: initialized
server # [    0.011139] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.011168] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.011376] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.011380] 0 pages in range for non-PLT usage
server # [    0.011381] 508208 pages in range for PLT usage
server # [    0.011518] pinctrl core: initialized pinctrl subsystem
server # [    0.012378] DMI not present or invalid.
server # [    0.015843] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.018169] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
server # [    0.018331] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.018490] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.018517] audit: initializing netlink subsys (disabled)
server # [    0.019138] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.019140] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.019143] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.019146] thermal_sys: Registered thermal governor 'user_space'
server # [    0.019149] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.019177] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
server # [    0.019186] cpuidle: using governor ladder
server # [    0.019192] cpuidle: using governor menu
server # [    0.019398] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
server # [    0.019413] ASID allocator initialised with 65536 entries
server # [    0.020663] Serial: AMBA PL011 UART driver
server # [    0.026530] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.026684] printk: console [ttyAMA0] enabled
server # [    0.155616] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.155628] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.155631] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.155634] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.155637] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.155640] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.155643] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.155645] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.157114] fbcon: Taking over console
server # [    0.157125] ACPI: Interpreter disabled.
server # [    0.167043] iommu: Default domain type: Translated
server # [    0.167050] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.167578] SCSI subsystem initialized
server # [    0.169701] usbcore: registered new interface driver usbfs
server # [    0.169732] usbcore: registered new interface driver hub
server # [    0.169748] usbcore: registered new device driver usb
server # [    0.170056] pps_core: LinuxPPS API ver. 1 registered
server # [    0.170060] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.170068] PTP clock support registered
server # [    0.170114] EDAC MC: Ver: 3.0.0
server # [    0.171698] scmi_core: SCMI protocol bus registered
server # [    0.177633] FPGA manager framework
server # [    0.179939] vgaarb: loaded
server # [    0.181087] clocksource: Switched to clocksource arch_sys_counter
server # [    0.189016] VFS: Disk quotas dquot_6.6.0
server # [    0.189048] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.190821] netfs: FS-Cache loaded
server # [    0.190955] pnp: PnP ACPI: disabled
server # [    0.197676] NET: Registered PF_INET protocol family
server # [    0.197842] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    0.229673] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.229721] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.229747] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.229793] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    0.229866] TCP: Hash tables configured (established 8192 bind 8192)
server # [    0.229958] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
server # [    0.230026] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.230072] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    0.230165] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.230183] NET: Registered PF_XDP protocol family
server # [    0.230200] PCI: CLS 0 bytes, default 64
server # [    0.230466] Trying to unpack rootfs image as initramfs...
server # [    0.243772] kvm [1]: HYP mode not available
server # [    0.398854] Initialise system trusted keyrings
server # [    0.399001] workingset: timestamp_bits=42 max_order=18 bucket_order=0
server # [    0.399368] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.399418] 9p: Installing v9fs 9p2000 file system support
server # [    0.422615] Key type asymmetric registered
server # [    0.422632] Asymmetric key parser 'x509' registered
server # [    0.422711] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    0.427423] io scheduler mq-deadline registered
server # [    0.427435] io scheduler kyber registered
server # [    0.440223] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    0.440816] ledtrig-cpu: registered to indicate activity on CPUs
server # [    0.442770] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    0.442786] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    0.442796] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    0.442802] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    0.442823] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    0.442845] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    0.442937] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    0.442944] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    0.442948] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    0.442951] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    0.442954] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    0.443007] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    0.443446] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.443662] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    0.443675] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.443701] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.443713] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.444189] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.444375] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    0.444387] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.444413] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.444876] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    0.445061] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
server # [    0.445073] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.473225] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.473773] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    0.473967] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    0.473979] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.474005] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.474016] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    0.474480] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    0.474673] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.474698] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.475161] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    0.475351] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.475377] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.475830] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    0.476015] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    0.476271] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.476463] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.476488] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.476959] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.501319] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.501355] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.501889] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
server # [    0.502092] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.502118] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.502612] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    0.502933] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    0.502945] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.502971] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.503450] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    0.503754] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    0.503766] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    0.503792] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    0.504431] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    0.504437] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    0.504441] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    0.504487] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    0.504531] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    0.504575] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    0.504620] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    0.504664] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    0.504710] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    0.504754] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    0.504797] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    0.504840] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    0.504913] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    0.504956] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    0.504973] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    0.504990] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    0.505007] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    0.505025] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    0.505042] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    0.505060] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
server # [    0.505079] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    0.505131] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    0.505154] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
server # [    0.505171] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    0.505189] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    0.505206] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    0.505223] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    0.505240] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
server # [    0.505257] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
server # [    0.505274] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    0.505291] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    0.505314] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    0.505319] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    0.505323] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    0.506183] pci 0000:00:07.0: enabling device (0000 -> 0002)
server # [    0.570584] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    0.572806] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    0.583077] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    0.593400] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    0.595964] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
server # [    0.606490] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
server # [    0.608467] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    0.611892] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    0.621801] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    0.623864] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    0.628023] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    0.641565] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    0.643355] msm_serial: driver initialized
server # [    0.643539] SuperH (H)SCI(F) driver initialized
server # [    0.643598] STM32 USART driver initialized
server # [    0.680427] loop: module loaded
server # [    0.680639] virtio_blk virtio2: 1/0/0 default/read/poll queues
server # [    0.682750] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    0.689876] megasas: 07.734.00.00-rc1
server # [    0.690674] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    0.692995] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.693020] Intel/Sharp Extended Query Table at 0x0031
server # [    0.706624] Using buffer write method
server # [    0.706681] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    0.708631] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    0.708653] Intel/Sharp Extended Query Table at 0x0031
server # [    0.713831] Using buffer write method
server # [    0.713879] Concatenating MTD devices:
server # [    0.713882] (0): "0.flash"
server # [    0.713884] (1): "0.flash"
server # [    0.713886] into device "0.flash"
server # [    1.043240] Freeing initrd memory: 26424K
server # [    1.049952] tun: Universal TUN/TAP device driver, 1.6
server # [    1.054104] thunder_xcv, ver 1.0
server # [    1.054138] thunder_bgx, ver 1.0
server # [    1.054157] nicpf, ver 1.0
server # [    1.054753] e1000: Intel(R) PRO/1000 Network Driver
server # [    1.054758] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    1.054780] e1000e: Intel(R) PRO/1000 Network Driver
server # [    1.054787] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    1.054817] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    1.054821] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    1.054839] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    1.054843] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    1.054973] sky2: driver version 1.30
server # [    1.056797] usbcore: registered new interface driver usb-storage
server # [    1.056885] usbcore: registered new interface driver usbserial_generic
server # [    1.056897] usbserial: USB Serial support registered for generic
server # [    1.067793] ehci-pci 0000:00:07.0: EHCI Host Controller
server # [    1.067815] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
server # [    1.068074] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
server # [    1.068648] hv_vmbus: registering driver hyperv_keyboard
server # [    1.072804] rtc-pl031 9010000.pl031: registered as rtc0
server # [    1.072833] rtc-pl031 9010000.pl031: setting system clock to 2026-10-01T03:46:15 UTC (1790826375)
server # [    1.074995] i2c_dev: i2c /dev entries driver
server # [    1.077137] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
server # [    1.078784] hub 1-0:1.0: USB hub found
server # [    1.078821] hub 1-0:1.0: 6 ports detected
server # [    1.080606] sdhci: Secure Digital Host Controller Interface driver
server # [    1.080612] sdhci: Copyright(c) Pierre Ossman
server # [    1.080917] Synopsys Designware Multimedia Card Interface Driver
server # [    1.084493] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    1.086900] hid: raw HID events driver (C) Jiri Kosina
server # [    1.087148] usbcore: registered new interface driver usbhid
server # [    1.087152] usbhid: USB HID core driver
server # [    1.088469] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
server # [    1.093303] drop_monitor: Initializing network drop monitor service
server # [    1.093516] NET: Registered PF_INET6 protocol family
server # [    1.094096] Segment Routing with IPv6
server # [    1.094108] In-situ OAM (IOAM) with IPv6
server # [    1.094134] NET: Registered PF_PACKET protocol family
server # [    1.094190] 9pnet: Installing 9P2000 support
server # [    1.094229] Key type dns_resolver registered
server # [    1.105177] registered taskstats version 1
server # [    1.105320] Loading compiled-in X.509 certificates
server # [    1.114109] Demotion targets for Node 0: null
server # [    1.114242] Key type .fscrypt registered
server # [    1.114246] Key type fscrypt-provisioning registered
server # [    1.114356] ima: No TPM chip found, activating TPM-bypass!
server # [    1.114373] ima: Allocated hash algorithm: sha1
server # [    1.114392] ima: No architecture policies found
server # [    1.115134] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    1.139754] clk: Disabling unused clocks
server # [    1.139774] PM: genpd: Disabling unused power domains
server # [    1.144126] Freeing unused kernel memory: 4736K
server # [    1.144338] Run /init as init process
server # [    1.159788] systemd[1]: Successfully made /usr/ read-only.
server # [    1.160245] systemd[1]: systemd 263-889bc48 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.160258] systemd[1]: Detected virtualization qemu.
server # [    1.160300] systemd[1]: Detected architecture arm64.
server # [    1.160306] systemd[1]: Running in initrd.
server # [    1.160593] systemd[1]: Initializing machine ID from random generator.
server # [    1.160690] systemd[1]: Hostname set to <server>.
server # [    1.270472] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    1.325167] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    1.332400] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    1.339212] systemd[1]: Created slice Slice /system/modprobe.
server # [    1.339416] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    1.339444] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    1.339579] systemd[1]: Reached target Path Units.
server # [    1.339593] systemd[1]: Reached target Slice Units.
server # [    1.339608] systemd[1]: Reached target Swaps.
server # [    1.339622] systemd[1]: Reached target Timer Units.
server # [    1.339770] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    1.339898] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    1.340019] systemd[1]: Listening on Journal Sockets.
server # [    1.340095] systemd[1]: Listening on udev Kernel Socket.
server # [    1.340109] systemd[1]: Reached target Socket Units.
server # [    1.350672] systemd[1]: Starting Create List of Static Device Nodes...
server # [    1.350749] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    1.360480] systemd[1]: Mounting Kernel Configuration File System...
server # [    1.377360] systemd[1]: Starting Journal Service...
server # [    1.382102] systemd[1]: Starting Load Kernel Modules...
server # [    1.382233] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    1.417346] systemd[1]: Starting Coldplug All udev Devices...
server # [    1.433447] systemd[1]: Finished Create List of Static Device Nodes.
server # [    1.440679] systemd-journald[71]: Collecting audit messages is disabled.
server # [    1.451061] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    1.454922] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    1.465563] systemd[1]: Mounted Kernel Configuration File System.
server # [    1.465794] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    1.492601] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
server # [    1.492887] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    1.492891] [drm] features: -context_init
server # [    1.498672] 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.518010] [drm] number of scanouts: 1
server # [    1.518032] [drm] number of cap sets: 0
server # [    1.518640] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
server # [    1.518657] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
server # [    1.529947] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    1.539385] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    1.553523] Console: switching to colour frame buffer device 160x50
server # [    1.569598] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    1.589814] systemd[1]: Finished Load Kernel Modules.
server # [    1.593505] 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.597958] systemd[1]: Starting Apply Kernel Variables...
server # [    1.618515] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    1.618933] systemd[1]: Reached target Preparation for Local File Systems.
server # [    1.619942] systemd[1]: Reached target Local File Systems.
server # [    1.637705] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    1.638010] systemd-modules-load[72]: Inserted module 'dm_mod'
server # [    1.656754] systemd[1]: Started Journal Service.
server # [    1.648340] systemd-modules-load[72]: Module 'virtio_balloon' is built in
server # [    1.649631] systemd-modules-load[72]: Module 'virtio_console' is built in
server # [    1.650938] systemd-modules-load[72]: Inserted module 'virtio_gpu'
server # [    1.651993] systemd-modules-load[72]: Module 'virtio_rng' is built in
server # [    1.664581] systemd[1]: Starting Create System Files and Directories...
server # [    1.668506] systemd[1]: Finished Apply Kernel Variables.
server # [    1.717302] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    1.739340] systemd[1]: Finished Create System Files and Directories.
server # [    1.750150] systemd-udevd[80]: Using default interface naming scheme 'v261'.
server # [    1.788579] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    1.888090] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
server # [    1.888420] 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.908147] systemd[1]: Starting Virtual Console Setup...
server # [    2.003573] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    2.013772] systemd[1]: Finished Virtual Console Setup.
server # [    2.753850] systemd[1]: Finished Coldplug All udev Devices.
server # [    2.754960] systemd[1]: Reached target System Initialization.
server # [    2.760332] systemd[1]: Reached target Basic System.
server # [    2.908478] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [    2.947572] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.
server # [    3.034169] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [    3.037345] systemd[1]: Reached target Initrd Root Device.
server # [    3.041751] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [    3.105638] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [    3.182687] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [    3.188975] systemd[1]: Mounting /sysroot...
server # [    3.335408] EXT4-fs (vda): mounted filesystem 3e040681-039a-458c-b9ae-0df799226089 r/w with ordered data mode. Quota mode: none.
server # [    3.323877] systemd[1]: Mounted /sysroot.
server # [    3.327406] systemd[1]: Reached target Initrd Root File System.
server # [    3.333992] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [    3.368253] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [    3.373318] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [    3.377390] systemd[1]: Reloading...
server # [    3.601546] systemd[1]: Reloading finished in 225 ms.
server # [    3.632935] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...
server # [    3.638893] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...
server # [    3.651907] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [    3.656901] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [    3.680697] systemd[1]: Mounting /sysroot/run...
server # [    3.696275] systemd[1]: Mounting /sysroot/tmp/shared...
server # [    3.732939] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [    3.748910] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [    3.763090] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [    3.768402] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [    3.832611] fuse: init (API version 7.45)
server # [    3.841840] virtiofs virtio6: discovered new tag: nix-store
server # [    3.842704] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
server # [    3.836401] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [    3.858877] virtiofs virtio7: discovered new tag: shared
server # [    3.859763] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
server # [    3.847756] systemd[1]: Mounted /sysroot/run.
server # [    3.868066] virtiofs virtio8: discovered new tag: xchg
server # [    3.868941] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
server # [    3.884851] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    3.890587] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [    3.898829] systemd[1]: Mounted /sysroot/tmp/shared.
server # [    3.904702] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [    3.929512] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    3.932330] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    3.935723] systemd[1]: Mounting /sysroot/nix/store...
server # [    3.995575] systemd[1]: Mounted /sysroot/nix/store.
server # [    3.998271] systemd[1]: Reached target Initrd File Systems.
server # [    3.999346] systemd[1]: Starting Find NixOS closure...
server # [    4.010842] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [    4.065886] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [    4.076638] systemd[1]: Finished Find NixOS closure.
server # [    4.078084] systemd[1]: Reached target Initrd Default Target.
server # [    4.083299] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [    4.124101] systemd[1]: Stopped target Initrd Default Target.
server # [    4.128381] systemd[1]: Stopped target Basic System.
server # [    4.129679] systemd[1]: Stopped target Initrd Root Device.
server # [    4.133731] systemd[1]: Stopped target Path Units.
server # [    4.136634] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [    4.141322] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [    4.145725] systemd[1]: Stopped target Slice Units.
server # [    4.149062] systemd[1]: Stopped target Socket Units.
server # [    4.151587] systemd[1]: Stopped target System Initialization.
server # [    4.155625] systemd[1]: Stopped target Swaps.
server # [    4.161424] systemd[1]: Stopped target Timer Units.
server # [    4.162283] systemd[1]: dbus.socket: Deactivated successfully.
server # [    4.163236] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [    4.167343] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [    4.173912] systemd[1]: Stopped Find NixOS closure.
server # [    4.174947] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [    4.175863] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [    4.183175] systemd[1]: Stopped Apply Kernel Variables.
server # [    4.187434] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [    4.191632] systemd[1]: Stopped Load Kernel Modules.
server # [    4.199049] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [    4.202616] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [    4.208738] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [    4.213215] systemd[1]: Stopped Create System Files and Directories.
server # [    4.220411] systemd[1]: Stopped target Local File Systems.
server # [    4.222181] systemd[1]: Stopped target Preparation for Local File Systems.
server # [    4.225046] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [    4.228265] systemd[1]: Stopped Coldplug All udev Devices.
server # [    4.229243] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [    4.231925] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [    4.236704] systemd[1]: Stopped Virtual Console Setup.
server # [    4.237541] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [    4.238673] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [    4.239649] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [    4.243417] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [    4.252155] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [    4.255607] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [    4.257024] systemd[1]: systemd-udevd.service: Consumed 1.234s CPU time over 2.630s wall clock time, 18.3M memory peak.
server # [    4.264469] systemd[1]: Starting Cleanup udev Database...
server # [    4.265470] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [    4.266669] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [    4.267617] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [    4.270250] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [    4.271625] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [    4.272844] systemd[1]: Stopped Create List of Static Device Nodes.
server # [    4.309604] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [    4.312670] systemd[1]: Finished Cleanup udev Database.
server # [    4.315623] systemd[1]: Reached target Switch Root.
server # [    4.317642] systemd[1]: Starting NixOS Activation...
server # [    4.413430] initrd-nixos-activation-start[169]: booting system configuration /nix/store/18syabcxvzl7mmqgxqadd1ahhxscwfn4-nixos-system-server-test
server # [    4.454956] initrd-nixos-activation-start[169]: running activation script...
server # [    4.712732] initrd-nixos-activation-start[192]: setting up /etc...
server # [    4.843633] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [    4.847159] systemd[1]: Finished NixOS Activation.
server # [    4.848730] systemd[1]: Starting Switch Root...
server # [    4.873934] systemd[1]: Switching root.
server # [    5.054975] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).
server # [    5.221331] systemd[1]: systemd 263-889bc48 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.222261] systemd[1]: Detected virtualization qemu.
server # [    5.222850] systemd[1]: Detected architecture arm64.
server # [    5.223368] systemd[1]: Detected first boot.
server # [    5.248782] systemd[1]: Received regular credentials: ca.cert.pem, server.cert.pem, server.key.pem
server # [    5.252318] systemd[1]: Acquired 3 regular credentials, 0 untrusted credentials.
server # [    5.256573] systemd[1]: Initializing machine ID from random generator.
server # [    5.533517] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [    5.756249] systemd[1]: Applying preset policy.
server # [    5.991834] systemd[1]: Populated /etc with preset unit settings.
server # [    6.216027] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [    6.216919] systemd[1]: Stopped initrd-switch-root.service.
server # [    6.222974] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [    6.227090] systemd[1]: Created slice Slice /system/getty.
server # [    6.228680] systemd[1]: Created slice User and Session Slice.
server # [    6.231676] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    6.232230] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [    6.232987] systemd[1]: Expecting device /dev/hvc0...
server # [    6.237118] systemd[1]: Expecting device /dev/ttyAMA0...
server # [    6.237609] systemd[1]: Reached target Local Encrypted Volumes.
server # [    6.238457] systemd[1]: Stopped target initrd-fs.target.
server # [    6.239164] systemd[1]: Stopped target initrd-root-fs.target.
server # [    6.239896] systemd[1]: Stopped target initrd-switch-root.target.
server # [    6.240587] systemd[1]: Reached target Virtual Machines and Containers.
server # [    6.246556] systemd[1]: Reached target Path Units.
server # [    6.247033] systemd[1]: Reached target Remote File Systems.
server # [    6.248014] systemd[1]: Reached target Slice Units.
server # [    6.248727] systemd[1]: Reached target Swaps.
server # [    6.254045] systemd[1]: Listening on Query the User Interactively for a Password.
server # [    6.256225] systemd[1]: Listening on Process Core Dump Socket.
server # [    6.259882] systemd[1]: Listening on Credential Encryption/Decryption.
server # [    6.262294] systemd[1]: Listening on Factory Reset Management.
server # [    6.262825] systemd[1]: Listening on Hostname Service Socket.
server # [    6.267975] systemd[1]: Starting Journal Log Access Socket...
server # [    6.270731] systemd[1]: Listening on Journal Audit Socket.
server # [    6.272973] systemd[1]: Listening on Console Output Muting Service Socket.
server # [    6.275620] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [    6.278339] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
server # [    6.279592] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [    6.285926] systemd[1]: Listening on Disk Repartitioning Service Socket.
server # [    6.286582] systemd[1]: Listening on udev Varlink Socket.
server # [    6.291376] systemd[1]: Mounting Huge Pages File System...
server # [    6.296676] systemd[1]: Mounting POSIX Message Queue File System...
server # [    6.313036] systemd[1]: Mounting Kernel Debug File System...
server # [    6.328759] systemd[1]: Mounting Kernel Trace File System...
server # [    6.343945] systemd[1]: Starting Create List of Static Device Nodes...
server # [    6.346648] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    6.365446] systemd[1]: Mounting Kernel Configuration File System...
server # [    6.366003] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [    6.376496] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [    6.377086] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
server # [    6.405708] systemd[1]: Mounting FUSE Control File System...
server # [    6.406192] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [    6.444279] systemd[1]: Starting Journal Service...
server # [    6.465961] systemd[1]: Starting Load Kernel Modules...
server # [    6.486651] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [    6.508745] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [    6.512009] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    6.557538] systemd[1]: Starting Coldplug All udev Devices...
server # [    6.560836] systemd[1]: Listening on Journal Log Access Socket.
server # [    6.571660] systemd-journald[264]: Collecting audit messages is enabled.
server # [    6.578622] systemd[1]: Mounted Huge Pages File System.
server # [    6.579206] systemd[1]: Mounted POSIX Message Queue File System.
server # [    6.579672] systemd[1]: Mounted Kernel Debug File System.
server # [    6.580103] systemd[1]: Mounted Kernel Trace File System.
server # [    6.567475] systemd[1]: Queued start job for default target Multi-User System.
server # [    6.592129] systemd[1]: Finished Create List of Static Device Nodes.
server # [    6.592975] systemd[1]: Started Journal Service.
server # [    6.580797] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [    6.611125] systemd-modules-load[265]: Module 'atkbd' is built in
server # [    6.616580] systemd-modules-load[265]: Module 'loop' is built in
server # [    6.639726] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    6.645437] systemd-modules-load[265]: Inserted module 'tls'
server # [    6.658142] systemd[1]: Mounted FUSE Control File System.
server # [    6.664962] systemd-oomd[266]: No swap; memory pressure usage will be degraded
server # [    6.673500] systemd[1]: Finished Load Kernel Modules.
server # [    6.693154] EXT4-fs (vda): re-mounted 3e040681-039a-458c-b9ae-0df799226089.
server # [    6.685976] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [    6.688154] systemd[1]: Mounted Kernel Configuration File System.
server # [    6.700187] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [    6.712060] systemd[1]: Listening on Disk Image Download Service Socket.
server # [    6.718058] systemd[1]: Starting Firewall...
server # [    6.727014] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [    6.732467] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [    6.742211] systemd[1]: Starting Load/Save OS Random Seed...
server # [    6.771256] systemd[1]: Starting Apply Kernel Variables...
server # [    6.776422] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
server # [    6.872266] systemd[1]: Finished Load/Save OS Random Seed.
server # [    6.873279] systemd[1]: Reached target First Boot Complete.
server # [    6.894571] systemd-journald[264]: Received client request to flush runtime journal.
server # [    6.962060] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    6.963610] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    6.977216] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [    7.005727] systemd[1]: Finished Apply Kernel Variables.
server # [    7.122444] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    7.123555] systemd[1]: Reached target Preparation for Local File Systems.
server # [    7.128892] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    7.210571] systemd[1]: Mounting /run/wrappers...
server # [    7.273954] systemd[1]: Mounted /run/wrappers.
server # [    7.274903] systemd[1]: Reached target Local File Systems.
server # [    7.287479] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [    7.298963] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [    7.300259] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [    7.312152] systemd[1]: Starting Save Transient machine-id to Disk...
server # [    7.320104] systemd[1]: Starting Create System Files and Directories...
server # [    7.536120] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [    7.545367] systemd[1]: Finished Save Transient machine-id to Disk.
server # [    7.619794] systemd[1]: Finished Create System Files and Directories.
server # [    7.634076] systemd[1]: Starting Rebuild Journal Catalog...
server # [    7.644314] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [    7.665090] systemd-udevd[300]: Using default interface naming scheme 'v261'.
server # [    7.828171] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [    7.852353] systemd[1]: Finished Rebuild Journal Catalog.
server # [    7.865841] systemd[1]: Starting Update is Completed...
server # [    7.873483] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    8.029620] systemd[1]: Finished Update is Completed.
server # [    8.536704] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [    8.539161] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [    8.847157] systemd[1]: Finished Coldplug All udev Devices.
server # [    8.850411] systemd[1]: Reached target System Initialization.
server # [    8.851374] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [    8.857557] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [    8.858749] systemd[1]: Reached target Timer Units.
server # [    8.859510] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    8.867046] systemd[1]: Listening on Journal Remote Sink Socket.
server # [    8.869038] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
server # [    8.870534] systemd[1]: Reached target Socket Units.
server # [    8.871312] systemd[1]: Reached target Basic System.
server # [    8.880949] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [    8.882087] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [    8.890955] systemd[1]: Starting Post-Boot Actions...
server # [    8.914364] systemd[1]: Started Reset console on configuration changes.
server # [    8.945830] systemd[1]: Starting resolvconf update...
server # [    9.026640] systemd[1]: Starting D-Bus System Message Bus...
server # [    9.068118] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [    9.091874] nsncd[434]: Oct 01 03:46:23.528 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [    9.114674] systemd[1]: Reached target Host and Network Name Lookups.
server # [    9.115769] systemd[1]: Reached target User and Group Name Lookups.
server # [    9.145555] systemd[1]: Starting User Login Management...
server # [    9.199471] systemd[1]: Finished Post-Boot Actions.
server # [    9.278135] dbus-broker-launch[442]: Looking up NSS user entry for 'systemd-timesync'...
server # [    9.292652] dbus-broker-launch[442]: NSS returned no entry for 'systemd-timesync'
server # [    9.294000] dbus-broker-launch[442]: Invalid user-name in /nix/store/psdd1lhqpa1966292a8fpkvafsrnjqcn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [    9.315106] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [    9.340231] systemd[1]: Started D-Bus System Message Bus.
server # [    9.396453] dbus-broker-launch[442]: Ready
server # [    9.468789] systemd-logind[456]: New seat seat0.
server # [    9.477013] systemd[1]: Started User Login Management.
server # [    9.488248] systemd[1]: Starting linger-users.service...
server # [    9.548499] systemd[1]: Stopped target Host and Network Name Lookups.
server # [    9.549668] systemd[1]: Stopping Host and Network Name Lookups...
server # [    9.550636] systemd[1]: Stopped target User and Group Name Lookups.
server # [    9.551583] systemd[1]: Stopping User and Group Name Lookups...
server # [    9.570257] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [    9.571421] systemd[1]: nscd.service: Deactivated successfully.
server # [    9.580402] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [    9.611746] systemd[1]: linger-users.service: Deactivated successfully.
server # [    9.619765] systemd[1]: Finished linger-users.service.
server # [    9.640004] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [    9.736609] systemd[1]: Finished resolvconf update.
server # [    9.748806] nsncd[534]: Oct 01 03:46:24.184 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [    9.759297] systemd[1]: Starting DHCP Client...
server # [    9.765636] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [    9.766726] systemd[1]: Reached target Host and Network Name Lookups.
server # [    9.767679] systemd[1]: Reached target User and Group Name Lookups.
server # [    9.971137] systemd[1]: Finished Firewall.
server # [    9.975723] systemd[1]: Reached target Preparation for Network.
server # [    9.980252] systemd[1]: Starting Extra networking commands....
server # [    9.994160] dhcpcd[568]: dhcpcd-10.3.2 starting
server # [   10.005484] dhcpcd[580]: dev: loaded udev
server # [   10.006365] dhcpcd[580]: no valid interfaces found
server # [   10.007324] dhcpcd[580]: no valid interfaces found
server # [   10.107435] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
server # [   10.369060] systemd[1]: Finished Extra networking commands..
server # [   10.375155] systemd[1]: Reached target Network.
server # [   10.382270] systemd[1]: Starting Nginx Web Server...
server # [   10.389080] systemd[1]: Starting Permit User Sessions...
server # [   10.479914] systemd[1]: Finished Permit User Sessions.
server # [   10.493115] systemd[1]: Started Getty on tty1.
server # [   10.495253] systemd[1]: Reached target Login Prompts.
server # [   10.673787] nginx-pre-start[635]: nginx: the configuration file /nix/store/1r3yba5p84ky5hngrh4kz50x9nlg7v5r-nginx.conf syntax is ok
server # [   10.675633] nginx-pre-start[635]: nginx: configuration file /nix/store/1r3yba5p84ky5hngrh4kz50x9nlg7v5r-nginx.conf test is successful
server # [   10.689894] systemd[1]: Starting Virtual Console Setup...
server # [   10.750667] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   10.756608] systemd[1]: Stopped Virtual Console Setup.
server # [   10.769624] systemd[1]: Starting Virtual Console Setup...
server # [   10.837991] systemd[1]: Started Nginx Web Server.
server # [   10.953026] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   11.115054] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [   11.136630] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [   11.144222] systemd[1]: Started backdoor.service.
server # connecting to host...
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 11.63 seconds)
server: (finished: waiting for the VM to finish booting, in 11.99 seconds)
server # [   11.335766] 8021q: 802.1Q VLAN Support v1.8
server: (finished: waiting for unit nginx.service, in 12.15 seconds)
client: waiting for unit systemd-journal-upload.service
client: waiting for the VM to finish booting
client: starting vm
server # [   11.456227] (udev-worker)[650]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   11.495247] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [   11.483878] (udev-worker)[650]: Network interface NamePolicy= disabled on kernel command line.
server # [   11.548615] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [   11.551116] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [   11.556119] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [   11.556496] cfg80211: failed to load regulatory.db
server # [   11.696682] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [   11.703866] systemd[1]: Starting Address configuration of eth1...
server # [   11.753459] systemd-vconsole-setup[646]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   11.768496] systemd[1]: Finished Virtual Console Setup.
server # [   11.775521] systemd-logind[456]: Watching system buttons on /dev/input/event0 (gpio-keys)
client # Disk image does not exist, creating the virtualisation disk image...
client: QEMU running (pid 97)
client # Formatting '/build/vm-state-client/tmp.fiIrqvA8Gq', fmt=raw size=1073741824
client # mke2fs 1.47.4 (6-Mar-2025)
client # Discarding device blocks:      0/262144             done
client # Creating filesystem with 262144 4k blocks and 65536 inodes
client # Filesystem UUID: 5d1920ab-16da-4d25-ab46-ce6c1dc2636e
client # Superblock backups stored on blocks:
client # 	32768, 98304, 163840, 229376
client # 
client # Allocating group tables: 0/8   done
server # [   11.843126] 8021q: adding VLAN 0 to HW filter on device eth1
client # Writing inode tables: 0/8   done
client # Creating journal (8192 blocks): done
client # Writing superblocks and filesystem accounting information: 0/8   done
client # 
client # Virtualisation disk image created.
client # Starting virtiofs daemons...
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)
client # [2026-10-01T03:46:25Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Waiting for vhost-user socket connection...
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Client connected, servicing requests
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Client connected, servicing requests
client # [2026-10-01T03:46:25Z INFO  virtiofsd] Client connected, servicing requests
server # [   11.853522] 8021q: adding VLAN 0 to HW filter on device eth0
server # [   11.841306] dhcpcd[580]: eth0: waiting for carrier
server # [   11.842747] dhcpcd[580]: eth0: carrier acquired
server # [   11.857982] network-addresses-eth1-start[679]: adding address 192.168.1.2/24... done
server # [   11.863393] dhcpcd[580]: DUID 00:01:00:01:32:50:94:12:52:54:00:12:34:56
server # [   11.865677] dhcpcd[580]: eth0: IAID 00:12:34:56
server # [   11.866462] dhcpcd[580]: eth0: adding address fe80::5054:ff:fe12:3456
server # [   11.888253] network-addresses-eth1-start[679]: adding address 2001:db8:1::2/64... done
server # [   11.914137] systemd[1]: Finished Address configuration of eth1.
server # [   11.998726] mousedev: PS/2 mouse device common for all mice
server # [   12.049543] systemd-logind[456]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
client # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]
client # [    0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.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 0x7fded700-0x7fdf0e7f]
client # [    0.000000] Zone ranges:
client # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000]   DMA32    empty
client # [    0.000000]   Normal   empty
client # [    0.000000]   Device   empty
client # [    0.000000] Movable zone start for each node
client # [    0.000000] Early memory node ranges
client # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
client # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
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/dpkqx3hyffyyrsh9r6phbv8vrsfw5kzp-nixos-system-client-test/init regInfo=/nix/.ro-store/bgy4d0hpr8lyxjrpclclpzk72mwqwy8x-closure-info/registration console=ttyAMA0,115200n8 console=tty0
client # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/bgy4d0hpr8lyxjrpclclpzk72mwqwy8x-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 75026 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.
client # [    0.000000] 	Tracing variant of Tasks RCU enabled.
client # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
client # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
client # [    0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
client # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
client # [    0.000000] GICv3: 256 SPIs implemented
client # [    0.000000] GICv3: 0 Extended SPIs implemented
client # [    0.000000] Root IRQ handler: gic_handle_irq
client # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI
client # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
client # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
client # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)
client # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)
client # [    0.000000] GICv3: using LPI property table @0x0000000044d10000
client # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000
client # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
client # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
client # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
client # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
client # [    0.000036] arm-pv: using stolen time PV
client # [    0.000503] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
client # [    0.000691] Console: colour dummy device 80x25
client # [    0.000700] printk: legacy console [tty0] enabled
client # [    0.000900] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
client # [    0.000908] pid_max: default: 32768 minimum: 301
client # [    0.000994] LSM: initializing lsm=capability,landlock,yama,bpf,ima
client # [    0.001182] landlock: Up and running.
client # [    0.001185] Yama: becoming mindful.
client # [    0.001911] LSM support for eBPF active
client # [    0.002079] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.002102] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
client # [    0.004265] rcu: Hierarchical SRCU implementation.
client # [    0.004273] rcu: 	Max phase no-delay instances is 1000.
client # [    0.005595] fsl-mc MSI: its@8080000 domain created
client # [    0.005724] EFI services will not be available.
client # [    0.005820] smp: Bringing up secondary CPUs ...
client # [    0.005830] smp: Brought up 1 node, 1 CPU
client # [    0.005834] SMP: Total of 1 processors activated.
client # [    0.005837] CPU: All CPU(s) started at EL1
client # [    0.005849] CPU features: detected: Branch Target Identification
client # [    0.005857] CPU features: detected: ARMv8.4 Translation Table Level
client # [    0.005861] CPU features: detected: Instruction cache invalidation not required for I/D coherence
client # [    0.005864] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
client # [    0.005868] CPU features: detected: Common not Private translations
client # [    0.005872] CPU features: detected: CRC32 instructions
client # [    0.005874] CPU features: detected: Data cache clean to Point of Deep Persistence
client # [    0.005878] CPU features: detected: Data cache clean to Point of Persistence
client # [    0.005881] CPU features: detected: Data independent timing control (DIT)
client # [    0.005884] CPU features: detected: E0PD
client # [    0.005886] CPU features: detected: Enhanced Counter Virtualization
client # [    0.005889] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
client # [    0.005893] CPU features: detected: Enhanced Virtualization Traps
client # [    0.005896] CPU features: detected: Fine Grained Traps
client # [    0.005900] CPU features: detected: Generic authentication (architected QARMA5 algorithm)
client # [    0.005906] CPU features: detected: RCpc load-acquire (LDAPR)
client # [    0.005909] CPU features: detected: LSE atomic instructions
client # [    0.005911] CPU features: detected: Privileged Access Never
client # [    0.005914] CPU features: detected: PMUv3
client # [    0.005917] CPU features: detected: RAS Extension Support
client # [    0.005920] CPU features: detected: RASv1p1 Extension Support
client # [    0.005923] CPU features: detected: Random Number Generator
client # [    0.005925] CPU features: detected: Speculation barrier (SB)
client # [    0.005928] CPU features: detected: Stage-2 Force Write-Back
client # [    0.005931] CPU features: detected: TLB range maintenance instructions
client # [    0.005936] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
client # [    0.005975] alternatives: applying system-wide alternatives
client # [    0.009180] CPU features: detected: BBM Level 2 without TLB conflict abort
client # [    0.009468] Memory: 893408K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 113608K reserved, 32768K cma-reserved)
client # [    0.009891] devtmpfs: initialized
client # [    0.011772] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.011799] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
client # [    0.012002] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
client # [    0.012006] 0 pages in range for non-PLT usage
client # [    0.012007] 508208 pages in range for PLT usage
client # [    0.012126] pinctrl core: initialized pinctrl subsystem
client # [    0.012959] DMI not present or invalid.
client # [    0.016269] NET: Registered PF_NETLINK/PF_ROUTE protocol family
client # [    0.018725] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
client # [    0.018881] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
client # [    0.019045] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
client # [    0.019073] audit: initializing netlink subsys (disabled)
client # [    0.019694] thermal_sys: Registered thermal governor 'fair_share'
client # [    0.019696] thermal_sys: Registered thermal governor 'bang_bang'
client # [    0.019699] thermal_sys: Registered thermal governor 'step_wise'
client # [    0.019702] thermal_sys: Registered thermal governor 'user_space'
client # [    0.019705] thermal_sys: Registered thermal governor 'power_allocator'
client # [    0.019733] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1
client # [    0.019741] cpuidle: using governor ladder
client # [    0.019747] cpuidle: using governor menu
client # [    0.019961] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.
client # [    0.019979] ASID allocator initialised with 65536 entries
client # [    0.021317] Serial: AMBA PL011 UART driver
client # [    0.027212] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
client # [    0.027367] printk: console [ttyAMA0] enabled
client # [    0.159526] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
client # [    0.159538] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
client # [    0.159542] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
client # [    0.159544] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
client # [    0.159547] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
client # [    0.159550] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
client # [    0.159553] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
client # [    0.159555] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
client # [    0.160861] fbcon: Taking over console
client # [    0.160872] ACPI: Interpreter disabled.
client # [    0.171080] iommu: Default domain type: Translated
client # [    0.171089] iommu: DMA domain TLB invalidation policy: strict mode
client # [    0.171759] SCSI subsystem initialized
client # [    0.175791] usbcore: registered new interface driver usbfs
client # [    0.175825] usbcore: registered new interface driver hub
client # [    0.175843] usbcore: registered new device driver usb
client # [    0.176195] pps_core: LinuxPPS API ver. 1 registered
client # [    0.176199] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
client # [    0.176208] PTP clock support registered
client # [    0.176253] EDAC MC: Ver: 3.0.0
client # [    0.181490] scmi_core: SCMI protocol bus registered
client # [    0.181924] FPGA manager framework
client # [    0.185535] vgaarb: loaded
client # [    0.185887] clocksource: Switched to clocksource arch_sys_counter
client # [    0.193180] VFS: Disk quotas dquot_6.6.0
client # [    0.193216] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
client # [    0.197575] netfs: FS-Cache loaded
client # [    0.197732] pnp: PnP ACPI: disabled
client # [    0.202462] NET: Registered PF_INET protocol family
client # [    0.202632] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
client # [    0.235852] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
client # [    0.235901] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
client # [    0.235929] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
client # [    0.235982] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
client # [    0.236056] TCP: Hash tables configured (established 8192 bind 8192)
client # [    0.236151] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
client # [    0.236183] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.236205] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
client # [    0.236291] NET: Registered PF_UNIX/PF_LOCAL protocol family
client # [    0.236309] NET: Registered PF_XDP protocol family
client # [    0.236326] PCI: CLS 0 bytes, default 64
client # [    0.236642] Trying to unpack rootfs image as initramfs...
client # [    0.253914] kvm [1]: HYP mode not available
client # [    0.442606] Initialise system trusted keyrings
client # [    0.442749] workingset: timestamp_bits=42 max_order=18 bucket_order=0
client # [    0.443155] squashfs: version 4.0 (2009/01/31) Phillip Lougher
client # [    0.443209] 9p: Installing v9fs 9p2000 file system support
client # [    0.471662] Key type asymmetric registered
client # [    0.471679] Asymmetric key parser 'x509' registered
client # [    0.471763] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
client # [    0.471891] io scheduler mq-deadline registered
client # [    0.471896] io scheduler kyber registered
client # [    0.484415] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
client # [    0.484992] ledtrig-cpu: registered to indicate activity on CPUs
client # [    0.485504] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
client # [    0.485520] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
client # [    0.485551] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
client # [    0.485557] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
client # [    0.485576] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
client # [    0.485597] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
client # [    0.485682] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
client # [    0.485689] pci_bus 0000:00: root bus resource [bus 00-ff]
client # [    0.485693] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
client # [    0.485696] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
client # [    0.485699] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
client # [    0.485771] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [   12.862017] dhcpcd[580]: eth0: soliciting a DHCP lease
client # [    0.506380] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.506588] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
client # [    0.506602] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.506627] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.506640] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.507123] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.507308] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
client # [    0.507320] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [   12.868700] dhcpcd[580]: eth0: offered 10.0.2.15 from 10.0.2.2
client # [    0.507345] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.507817] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
client # [    0.508005] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
client # [    0.508016] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.508042] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.508521] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
client # [    0.508709] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
client # [    0.508720] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [   12.876315] dhcpcd[580]: eth0: probing address 10.0.2.15/24
client # [    0.508747] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.508759] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]
client # [    0.509242] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
client # [    0.509539] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.509565] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.528045] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
client # [    0.528239] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.528265] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.528673] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
client # [    0.528859] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]
client # [    0.529115] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.529305] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.529401] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.545973] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.546244] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.546272] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.546854] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint
client # [    0.547044] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.547071] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.547549] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
client # [    0.547861] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
client # [    0.547874] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.547900] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.548386] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
client # [    0.548578] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
client # [    0.548590] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
client # [    0.548615] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
client # [    0.549243] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
client # [    0.549249] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
client # [    0.549253] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
client # [    0.549312] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
client # [    0.549489] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
client # [    0.549536] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
client # [    0.549581] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
client # [    0.549626] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
client # [    0.549672] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
client # [    0.549717] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
client # [    0.549761] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
client # [    0.549804] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
client # [    0.549882] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
client # [    0.549960] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
client # [    0.549979] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
client # [    0.549996] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
client # [    0.550014] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
client # [    0.550031] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
client # [    0.550049] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
client # [    0.550066] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned
client # [    0.550086] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
client # [    0.550104] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
client # [    0.550129] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned
client # [    0.550148] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
client # [    0.550166] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
client # [    0.550183] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
client # [    0.550201] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned
client # [    0.550218] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
client # [    0.550235] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
client # [    0.550253] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned
client # [    0.550270] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned
client # [    0.550293] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
client # [    0.550299] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
client # [    0.550302] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
client # [    0.551195] pci 0000:00:07.0: enabling device (0000 -> 0002)
client # [    0.617580] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
client # [    0.627559] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
client # [    0.638260] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
client # [    0.640449] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
client # [    0.644373] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)
client # [    0.654195] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
client # [    0.656131] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
client # [    0.659769] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
client # [    0.670161] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)
client # [    0.672262] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
client # [    0.676422] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
client # [    0.691359] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client # [    0.693510] msm_serial: driver initialized
client # [    0.693648] SuperH (H)SCI(F) driver initialized
client # [    0.693707] STM32 USART driver initialized
client # [    0.734657] loop: module loaded
client # [    0.734881] virtio_blk virtio2: 1/0/0 default/read/poll queues
client # [    0.735739] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
client # [    0.740853] megasas: 07.734.00.00-rc1
client # [    0.742388] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
client # [    0.754674] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.754706] Intel/Sharp Extended Query Table at 0x0031
client # [    0.756467] Using buffer write method
client # [    0.756517] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
client # [    0.762752] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
client # [    0.762822] Intel/Sharp Extended Query Table at 0x0031
client # [    0.764230] Using buffer write method
client # [    0.764250] Concatenating MTD devices:
client # [    0.764253] (0): "0.flash"
client # [    0.764255] (1): "0.flash"
client # [    0.764257] into device "0.flash"
server # [   13.237834] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   13.243423] systemd[1]: Stopped Virtual Console Setup.
server # [   13.244708] systemd[1]: Stopping Virtual Console Setup...
server # [   13.248855] systemd[1]: Starting Virtual Console Setup...
server # [   13.274612] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [   13.285008] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   13.291999] systemd[1]: Stopped Virtual Console Setup.
server # [   13.297616] systemd[1]: Starting Virtual Console Setup...
server # [   13.347551] systemd-logind[456]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
client # [    1.066480] Freeing initrd memory: 26428K
client # [    1.072386] tun: Universal TUN/TAP device driver, 1.6
server # [   13.429261] systemd-vconsole-setup[704]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [    1.077150] thunder_xcv, ver 1.0
client # [    1.077181] thunder_bgx, ver 1.0
client # [    1.077200] nicpf, ver 1.0
server # [   13.433041] systemd[1]: Finished Virtual Console Setup.
client # [    1.079230] e1000: Intel(R) PRO/1000 Network Driver
client # [    1.079236] e1000: Copyright (c) 1999-2006 Intel Corporation.
client # [    1.079272] e1000e: Intel(R) PRO/1000 Network Driver
client # [    1.079281] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
client # [    1.079306] igb: Intel(R) Gigabit Ethernet Network Driver
client # [    1.079309] igb: Copyright (c) 2007-2014 Intel Corporation.
client # [    1.079353] igbvf: Intel(R) Gigabit Virtual Function Network Driver
client # [    1.079358] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
client # [    1.079509] sky2: driver version 1.30
client # [    1.081205] usbcore: registered new interface driver usb-storage
client # [    1.081292] usbcore: registered new interface driver usbserial_generic
client # [    1.081303] usbserial: USB Serial support registered for generic
client # [    1.082576] ehci-pci 0000:00:07.0: EHCI Host Controller
client # [    1.082596] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1
client # [    1.082920] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000
client # [    1.094039] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00
client # [    1.094472] hub 1-0:1.0: USB hub found
client # [    1.094489] hub 1-0:1.0: 6 ports detected
client # [    1.095080] hv_vmbus: registering driver hyperv_keyboard
client # [    1.096041] rtc-pl031 9010000.pl031: registered as rtc0
client # [    1.096065] rtc-pl031 9010000.pl031: setting system clock to 2026-10-01T03:46:27 UTC (1790826387)
client # [    1.096391] i2c_dev: i2c /dev entries driver
client # [    1.104948] sdhci: Secure Digital Host Controller Interface driver
client # [    1.104955] sdhci: Copyright(c) Pierre Ossman
client # [    1.105248] Synopsys Designware Multimedia Card Interface Driver
client # [    1.105670] sdhci-pltfm: SDHCI platform and OF driver helper
client # [    1.110352] hid: raw HID events driver (C) Jiri Kosina
client # [    1.110604] usbcore: registered new interface driver usbhid
client # [    1.110608] usbhid: USB HID core driver
client # [    1.111836] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available
client # [    1.113528] drop_monitor: Initializing network drop monitor service
client # [    1.113709] NET: Registered PF_INET6 protocol family
client # [    1.119204] Segment Routing with IPv6
client # [    1.119218] In-situ OAM (IOAM) with IPv6
client # [    1.119260] NET: Registered PF_PACKET protocol family
client # [    1.119314] 9pnet: Installing 9P2000 support
client # [    1.119358] Key type dns_resolver registered
client # [    1.128510] registered taskstats version 1
client # [    1.128654] Loading compiled-in X.509 certificates
client # [    1.137737] Demotion targets for Node 0: null
client # [    1.138542] Key type .fscrypt registered
client # [    1.138547] Key type fscrypt-provisioning registered
client # [    1.138662] ima: No TPM chip found, activating TPM-bypass!
client # [    1.138680] ima: Allocated hash algorithm: sha1
client # [    1.138702] ima: No architecture policies found
client # [    1.139429] input: gpio-keys as /devices/platform/gpio-keys/input/input0
client # [    1.164642] clk: Disabling unused clocks
client # [    1.164661] PM: genpd: Disabling unused power domains
client # [    1.169023] Freeing unused kernel memory: 4736K
client # [    1.169251] Run /init as init process
client # [    1.184404] systemd[1]: Successfully made /usr/ read-only.
client # [    1.184862] systemd[1]: systemd 263-889bc48 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.184876] systemd[1]: Detected virtualization qemu.
client # [    1.184916] systemd[1]: Detected architecture arm64.
client # [    1.184921] systemd[1]: Running in initrd.
client # [    1.185204] systemd[1]: Initializing machine ID from random generator.
client # [    1.185299] systemd[1]: Hostname set to <client>.
client # [    1.296424] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    1.341997] usb 1-1: new high-speed USB device number 2 using ehci-pci
client # [    1.356322] systemd[1]: Queued start job for default target Initrd Default Target.
client # [    1.363984] systemd[1]: Created slice Slice /system/modprobe.
client # [    1.364170] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    1.364196] systemd[1]: Expecting device /dev/disk/by-label/nixos...
client # [    1.364220] systemd[1]: Reached target Path Units.
client # [    1.364232] systemd[1]: Reached target Slice Units.
client # [    1.364245] systemd[1]: Reached target Swaps.
client # [    1.364258] systemd[1]: Reached target Timer Units.
client # [    1.364384] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    1.364506] systemd[1]: Listening on Journal Socket (/dev/log).
client # [    1.364656] systemd[1]: Listening on Journal Sockets.
client # [    1.364729] systemd[1]: Listening on udev Kernel Socket.
client # [    1.364743] systemd[1]: Reached target Socket Units.
client # [    1.375216] systemd[1]: Starting Create List of Static Device Nodes...
client # [    1.375286] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    1.382099] systemd[1]: Mounting Kernel Configuration File System...
client # [    1.392426] systemd[1]: Starting Journal Service...
client # [    1.426392] systemd[1]: Starting Load Kernel Modules...
client # [    1.426567] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    1.446183] systemd[1]: Starting Coldplug All udev Devices...
client # [    1.455633] systemd-journald[71]: Collecting audit messages is disabled.
client # [    1.462431] systemd[1]: Finished Create List of Static Device Nodes.
client # [    1.495939] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    1.496652] systemd[1]: Mounted Kernel Configuration File System.
client # [    1.514490] 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.545171] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
client # [    1.562137] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
client # [    1.573146] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0
client # [    1.573525] [drm] features: -virgl +edid -resource_blob -host_visible
client # [    1.573529] [drm] features: -context_init
client # [    1.584904] [drm] number of scanouts: 1
client # [    1.584928] [drm] number of cap sets: 0
client # [    1.598921] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    1.600924] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic
client # [    1.600940] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0
client # [    1.606566] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    1.620458] 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.634426] Console: switching to colour frame buffer device 160x50
client # [    1.652519] systemd[1]: Started Journal Service.
client # [    1.653436] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device
client # [    1.639667] systemd-modules-load[73]: Inserted module 'dm_mod'
client # [    1.649087] systemd-modules-load[73]: Module 'virtio_balloon' is built in
client # [    1.650723] systemd-modules-load[73]: Module 'virtio_console' is built in
client # [    1.651883] systemd-modules-load[73]: Inserted module 'virtio_gpu'
client # [    1.668589] systemd-modules-load[73]: Module 'virtio_rng' is built in
client # [    1.669738] systemd[1]: Finished Load Kernel Modules.
client # [    1.670633] systemd[1]: Starting Apply Kernel Variables...
client # [    1.677161] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    1.680802] systemd[1]: Reached target Preparation for Local File Systems.
server # [   14.054025] dhcpcd[580]: eth0: soliciting an IPv6 router
server # [   14.056224] dhcpcd[580]: eth0: Router Advertisement from fe80::2
client # [    1.685883] systemd[1]: Reached target Local File Systems.
server # [   14.057628] dhcpcd[580]: eth0: adding address fec0::5054:ff:fe12:3456/64
client # [    1.687589] systemd[1]: Starting Create System Files and Directories...
server # [   14.059222] dhcpcd[580]: eth0: adding route to fec0::/64
server # [   14.060676] dhcpcd[580]: eth0: adding default route via fe80::2
client # [    1.723601] systemd[1]: Starting Rule-based Manager for Device Events and Files...[    1.737966] usb 1-2: new high-speed USB device number 3 using ehci-pci
client # 
client # [    1.726912] systemd[1]: Finished Apply Kernel Variables.
client # [    1.764910] systemd[1]: Finished Create System Files and Directories.
client # [    1.794396] systemd-udevd[86]: Using default interface naming scheme 'v261'.
client # [    1.823695] systemd[1]: Started Rule-based Manager for Device Events and Files.
client # [    1.900011] 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.900325] 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.932125] systemd[1]: Starting Virtual Console Setup...
client # [    2.009399] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [    2.013550] systemd[1]: Finished Virtual Console Setup.
client # [    2.718169] systemd[1]: Finished Coldplug All udev Devices.
client # [    2.720326] systemd[1]: Reached target System Initialization.
client # [    2.721331] systemd[1]: Reached target Basic System.
client # [    2.892465] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [    2.923117] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.
client # [    2.988597] systemd[1]: Found device /dev/disk/by-label/nixos.
client # [    2.991964] systemd[1]: Reached target Initrd Root Device.
client # [    2.996215] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
client # [    3.057297] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks
client # [    3.064346] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
client # [    3.073752] systemd[1]: Mounting /sysroot...
client # [    3.111618] systemd[1]: Mounted /sysroot.[    3.126017] EXT4-fs (vda): mounted filesystem 5d1920ab-16da-4d25-ab46-ce6c1dc2636e r/w with ordered data mode. Quota mode: none.
client # 
client # [    3.117758] systemd[1]: Reached target Initrd Root File System.
client # [    3.128165] systemd[1]: Starting Mountpoints Configured in the Real Root...
client # [    3.158090] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.
client # [    3.163412] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...
client # [    3.169817] systemd[1]: Reloading...
client # [    3.387719] systemd[1]: Reloading finished in 220 ms.
client # [    3.421479] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...
client # [    3.426601] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...
client # [    3.435476] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
client # [    3.439704] systemd[1]: Finished Mountpoints Configured in the Real Root.
client # [    3.444197] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
client # [    3.448350] systemd[1]: Mounting /sysroot/nix/.ro-store...
client # [    3.457090] systemd[1]: Mounting /sysroot/nix/.rw-store...
client # [    3.477979] systemd[1]: Mounting /sysroot/run...
client # [    3.506086] systemd[1]: Mounting /sysroot/tmp/shared...
client # [    3.526426] systemd[1]: Mounting /sysroot/tmp/xchg...
client # [    3.572741] systemd[1]: Mounted /sysroot/nix/.rw-store.
client # [    3.616330] fuse: init (API version 7.45)
client # [    3.625485] virtiofs virtio6: discovered new tag: nix-store
client # [    3.635721] virtiofs virtio6: virtio_fs_setup_dax: No cache capability
client # [    3.629651] systemd[1]: Mounted /sysroot/run.
client # [    3.651678] virtiofs virtio7: discovered new tag: shared
client # [    3.652520] virtiofs virtio7: virtio_fs_setup_dax: No cache capability
client # [    3.659870] virtiofs virtio8: discovered new tag: xchg
client # [    3.660698] virtiofs virtio8: virtio_fs_setup_dax: No cache capability
client # [    3.655613] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    3.665517] systemd[1]: Mounted /sysroot/nix/.ro-store.
client # [    3.674648] systemd[1]: Mounted /sysroot/tmp/shared.
client # [    3.683468] systemd[1]: Mounted /sysroot/tmp/xchg.
client # [    3.698106] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    3.701341] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    4.439679] systemd[1]: Mounting /sysroot/nix/store...
client # [    4.450237] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/fng2bb9zpmbrj4khaym6439can623sc3-systemd-263-889bc48/lib/udev/mtd_probe": No such file or directory
client # [    4.457986] (udev-worker)[95]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory
client # [    4.502925] systemd[1]: Mounted /sysroot/nix/store.
client # [    4.505499] systemd[1]: Reached target Initrd File Systems.
client # [    4.508217] systemd[1]: Starting Find NixOS closure...
client # [    4.514945] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
client # [    4.557189] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
client # [    4.561278] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
client # [    4.574652] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.577212] systemd[1]: Stopped Virtual Console Setup.
client # [    4.583199] systemd[1]: Stopping Virtual Console Setup...
client # [    4.586741] systemd[1]: Starting Virtual Console Setup...
client # [    4.593507] systemd[1]: Finished Find NixOS closure.
client # [    4.599225] systemd[1]: Reached target Initrd Default Target.
client # [    4.603251] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
client # [    4.608398] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.610000] systemd[1]: Stopped Virtual Console Setup.
client # [    4.620370] systemd[1]: Starting Virtual Console Setup...
client # [    4.654241] systemd[1]: Stopped target Initrd Default Target.
client # [    4.663973] systemd[1]: Stopped target Basic System.
client # [    4.665328] systemd[1]: Stopped target Initrd Root Device.
client # [    4.666197] systemd[1]: Stopped target Path Units.
client # [    4.666938] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
client # [    4.673121] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
client # [    4.674323] systemd[1]: Stopped target Slice Units.
client # [    4.675084] systemd[1]: Stopped target Socket Units.
client # [    4.675880] systemd[1]: Stopped target System Initialization.
client # [    4.689127] systemd[1]: Stopped target Swaps.
client # [    4.689962] systemd[1]: Stopped target Timer Units.
client # [    4.690722] systemd[1]: dbus.socket: Deactivated successfully.
client # [    4.691728] systemd[1]: Closed D-Bus System Message Bus Socket.
client # [    4.699600] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
client # [    4.702477] systemd[1]: Stopped Find NixOS closure.
client # [    4.705860] systemd[1]: Starting rw-sysroot-nix-store.service...
client # [    4.708480] systemd[1]: systemd-sysctl.service: Deactivated successfully.
client # [    4.710353] systemd[1]: Stopped Apply Kernel Variables.
client # [    4.713865] systemd[1]: systemd-modules-load.service: Deactivated successfully.
client # [    4.715070] systemd[1]: Stopped Load Kernel Modules.
client # [    4.715873] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
client # [    4.724356] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
client # [    4.727136] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
client # [    4.734805] systemd[1]: Stopped Create System Files and Directories.
client # [    4.735933] systemd[1]: Stopped target Local File Systems.
client # [    4.738988] systemd[1]: Stopped target Preparation for Local File Systems.
client # [    4.744313] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
client # [    4.745585] systemd[1]: Stopped Coldplug All udev Devices.
client # [    4.746452] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
client # [    4.747580] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [    4.750068] systemd[1]: Stopped Virtual Console Setup.
client # [    4.751756] systemd[1]: systemd-udevd.service: Deactivated successfully.
client # [    4.753771] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
client # [    4.754883] systemd[1]: systemd-udevd.service: Consumed 1.698s CPU time over 2.990s wall clock time, 25.9M memory peak.
client # [    4.756579] systemd[1]: initrd-cleanup.service: Deactivated successfully.
client # [    4.757597] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
client # [    4.758568] systemd[1]: Starting Cleanup udev Database...
client # [    4.759393] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
client # [    4.765760] systemd[1]: Stopped Create Static Device Nodes in /dev.
client # [    4.766982] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
client # [    4.772583] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
client # [    4.773957] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
client # [    4.776188] systemd[1]: Stopped Create List of Static Device Nodes.
client # [    4.780224] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
client # [    4.781359] systemd[1]: Finished rw-sysroot-nix-store.service.
client # [    4.813790] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
client # [    4.815758] systemd[1]: Finished Cleanup udev Database.
client # [    4.819179] systemd[1]: Reached target Switch Root.
client # [    4.824432] systemd[1]: Starting NixOS Activation...
client # [    4.906577] initrd-nixos-activation-start[176]: booting system configuration /nix/store/dpkqx3hyffyyrsh9r6phbv8vrsfw5kzp-nixos-system-client-test
client # [    4.942376] initrd-nixos-activation-start[176]: running activation script...
client # [    5.172995] initrd-nixos-activation-start[199]: setting up /etc...
client # [    5.295638] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
client # [    5.299016] systemd[1]: Finished NixOS Activation.
client # [    5.300202] systemd[1]: Starting Switch Root...
client # [    5.325539] systemd[1]: Switching root.
client # [    5.515657] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).
server # [   17.902913] dhcpcd[580]: eth0: leased 10.0.2.15 for 86400 seconds
server # [   17.904849] dhcpcd[580]: eth0: adding route to 10.0.2.0/24
server # [   17.906102] dhcpcd[580]: eth0: adding default route via 10.0.2.2
server # [   18.015885] systemd[1]: Started DHCP Client.
server # [   18.018497] systemd[1]: Reached target Multi-User System.
server # [   18.019885] systemd[1]: Startup finished in 1.132s (kernel) + 3.983s (initrd) + 12.904s (userspace) = 18.019s.
client # [    5.676917] systemd[1]: systemd 263-889bc48 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
client # [    5.685065] systemd[1]: Detected virtualization qemu.
client # [    5.685138] systemd[1]: Detected architecture arm64.
client # [    5.685245] systemd[1]: Detected first boot.
client # [    5.702643] systemd[1]: Received regular credentials: ca.cert.pem, client.cert.pem, client.key.pem
client # [    5.702792] systemd[1]: Acquired 3 regular credentials, 0 untrusted credentials.
client # [    5.704995] systemd[1]: Initializing machine ID from random generator.
client # [    5.843243] systemd[1]: bpf-restrict-fs: LSM BPF program attached
client # [    6.168133] systemd[1]: Applying preset policy.
client # [    6.415452] systemd[1]: Populated /etc with preset unit settings.
client # [    6.608119] systemd[1]: initrd-switch-root.service: Deactivated successfully.
client # [    6.608980] systemd[1]: Stopped initrd-switch-root.service.
client # [    6.614592] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
client # [    6.616263] systemd[1]: Created slice Slice /system/getty.
client # [    6.617430] systemd[1]: Created slice User and Session Slice.
client # [    6.617852] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client # [    6.623299] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
client # [    6.623782] systemd[1]: Expecting device /dev/hvc0...
client # [    6.624578] systemd[1]: Expecting device /dev/ttyAMA0...
client # [    6.625232] systemd[1]: Reached target Local Encrypted Volumes.
client # [    6.625856] systemd[1]: Stopped target initrd-fs.target.
client # [    6.630720] systemd[1]: Stopped target initrd-root-fs.target.
client # [    6.631140] systemd[1]: Stopped target initrd-switch-root.target.
client # [    6.631878] systemd[1]: Reached target Virtual Machines and Containers.
client # [    6.632533] systemd[1]: Reached target Path Units.
client # [    6.633111] systemd[1]: Reached target Remote File Systems.
client # [    6.633727] systemd[1]: Reached target Slice Units.
client # [    6.638776] systemd[1]: Reached target Swaps.
client # [    6.640753] systemd[1]: Listening on Query the User Interactively for a Password.
client # [    6.644423] systemd[1]: Listening on Process Core Dump Socket.
client # [    6.645831] systemd[1]: Listening on Credential Encryption/Decryption.
client # [    6.648737] systemd[1]: Listening on Factory Reset Management.
client # [    6.649238] systemd[1]: Listening on Hostname Service Socket.
client # [    6.654757] systemd[1]: Starting Journal Log Access Socket...
client # [    6.656131] systemd[1]: Listening on Journal Audit Socket.
client # [    6.659575] systemd[1]: Listening on Console Output Muting Service Socket.
client # [    6.660267] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
client # [    6.660613] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.660896] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
client # [    6.670617] systemd[1]: Listening on Disk Repartitioning Service Socket.
client # [    6.671327] systemd[1]: Listening on udev Varlink Socket.
client # [    6.675886] systemd[1]: Mounting Huge Pages File System...
client # [    6.682222] systemd[1]: Mounting POSIX Message Queue File System...
client # [    6.699885] systemd[1]: Mounting Kernel Debug File System...
client # [    6.709053] systemd[1]: Mounting Kernel Trace File System...
client # [    6.730555] systemd[1]: Starting Create List of Static Device Nodes...
client # [    6.731154] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    6.746088] systemd[1]: Mounting Kernel Configuration File System...
client # [    6.751118] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
client # [    6.761663] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
client # [    6.764750] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [    6.787031] systemd[1]: Mounting FUSE Control File System...
client # [    6.787537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
client # [    6.822626] systemd[1]: Starting Journal Service...
client # [    6.839178] systemd[1]: Starting Load Kernel Modules...
client # [    6.868469] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
client # [    6.893294] systemd[1]: Starting Remount Root and Kernel File Systems...
client # [    6.893712] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    6.922450] systemd-journald[270]: Collecting audit messages is enabled.
client # [    6.939615] systemd[1]: Starting Coldplug All udev Devices...
client # [    6.921399] systemd[1]: Queued start job for default target Multi-User System.
client # [    6.927377] systemd[1]: systemd-journald.service: Deactivated successfully.
client # [    6.932880] systemd-modules-load[271]: Module 'atkbd' is built in
client # [    6.934006] systemd-modules-load[271]: Module 'loop' is built in
client # [    6.956166] systemd[1]: Started Journal Service.
client # [    6.948305] systemd[1]: Listening on Journal Log Access Socket.
client # [    6.949380] systemd[1]: Mounted Huge Pages File System.
client # [    6.950169] systemd[1]: Mounted POSIX Message Queue File System.
client # [    6.951060] systemd[1]: Mounted Kernel Debug File System.
client # [    6.951903] systemd[1]: Mounted Kernel Trace File System.
client # [    6.959569] systemd[1]: Finished Create List of Static Device Nodes.
client # [    6.968425] systemd[1]: Finished Load Kernel Modules.
client # [    6.977392] systemd[1]: Mounted Kernel Configuration File System.
client # [    6.999015] systemd[1]: Starting Firewall...
client # [    7.006189] systemd[1]: Starting Apply Kernel Variables...
client # [    7.022469] systemd-oomd[273]: No swap; memory pressure usage will be degraded
client # [    7.037560] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
client # [    7.061870] EXT4-fs (vda): re-mounted 5d1920ab-16da-4d25-ab46-ce6c1dc2636e.
client # [    7.047453] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
client # [    7.081480] systemd[1]: Finished Remount Root and Kernel File Systems.
client # [    7.084200] systemd[1]: Listening on Disk Image Download Service Socket.
client # [    7.103242] systemd[1]: Starting Flush Journal to Persistent Storage...
client # [    7.109232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
client # [    7.122413] systemd[1]: Starting Load/Save OS Random Seed...
client # [    7.123457] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
client # [    7.132184] systemd[1]: Mounted FUSE Control File System.
client # [    7.234980] systemd-journald[270]: Received client request to flush runtime journal.
client # [    7.300554] systemd[1]: Finished Apply Kernel Variables.
client # [    7.301581] systemd[1]: Finished Load/Save OS Random Seed.
client # [    7.302419] systemd[1]: Reached target First Boot Complete.
client # [    7.303263] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
client # [    7.313718] systemd[1]: Starting Create Static Device Nodes in /dev...
client # [    7.324143] systemd[1]: Finished Flush Journal to Persistent Storage.
client # [    7.458284] systemd[1]: Finished Create Static Device Nodes in /dev.
client # [    7.459459] systemd[1]: Reached target Preparation for Local File Systems.
client # [    7.464494] systemd[1]: Starting Rule-based Manager for Device Events and Files...
client # [    7.598059] systemd[1]: Mounting /run/wrappers...
client # [    7.625889] systemd-udevd[309]: Using default interface naming scheme 'v261'.
client # [    7.667313] systemd[1]: Mounted /run/wrappers.
client # [    7.668818] systemd[1]: Reached target Local File Systems.
client # [    7.675043] systemd[1]: Listening on Boot Loader Control Service Socket.
client # [    7.683061] systemd[1]: Starting Create SUID/SGID Wrappers...
client # [    7.684264] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
client # [    7.689727] systemd[1]: Starting Save Transient machine-id to Disk...
client # [    7.693962] systemd[1]: Starting Create System Files and Directories...
client # [    7.837454] systemd[1]: Started Rule-based Manager for Device Events and Files.
client # [    7.849627] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
client # [    7.858699] systemd[1]: Finished Save Transient machine-id to Disk.
client # [    7.976837] systemd[1]: Finished Create System Files and Directories.
client # [    7.996170] systemd[1]: Starting Rebuild Journal Catalog...
client # [    8.008636] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
client # [    8.176532] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
client # [    8.198919] systemd[1]: Finished Rebuild Journal Catalog.
client # [    8.214176] systemd[1]: Starting Update is Completed...
client # [    8.304628] systemd[1]: Finished Update is Completed.
client # [    8.894393] systemd[1]: Finished Coldplug All udev Devices.
client # [    8.927295] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
client # [    8.930789] systemd[1]: Finished Create SUID/SGID Wrappers.
client # [    8.937296] systemd[1]: Reached target System Initialization.
client # [    8.938335] systemd[1]: Started Discard unused filesystem blocks once a week.
client # [    8.939528] systemd[1]: Started Daily Cleanup of Temporary Directories.
client # [    8.947716] systemd[1]: Reached target Timer Units.
client # [    8.950863] systemd[1]: Listening on D-Bus System Message Bus Socket.
client # [    8.951926] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
client # [    8.963050] systemd[1]: Reached target Socket Units.
client # [    8.963985] systemd[1]: Reached target Basic System.
client # [    8.971213] systemd[1]: Starting Import lastlog data into lastlog2 database...
client # [    8.977245] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [    8.978277] systemd[1]: Starting Post-Boot Actions...
client # [    8.985634] systemd[1]: Started Reset console on configuration changes.
client # [    9.031597] systemd[1]: Starting resolvconf update...
client # [    9.112368] systemd[1]: Starting D-Bus System Message Bus...
client # [    9.113819] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
client # [    9.127495] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
client # [    9.154476] systemd[1]: Finished Post-Boot Actions.
client # [    9.204145] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    9.228273] systemd[1]: Reached target Host and Network Name Lookups.
client # [    9.229405] systemd[1]: Reached target User and Group Name Lookups.
client # [    9.241605] nsncd[441]: Oct 01 03:46:35.625 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    9.259541] systemd[1]: Starting User Login Management...
client # [    9.339632] systemd[1]: Finished Import lastlog data into lastlog2 database.
client # [    9.436840] dbus-broker-launch[448]: Looking up NSS user entry for 'systemd-timesync'...
client # [    9.446655] dbus-broker-launch[448]: NSS returned no entry for 'systemd-timesync'
client # [    9.447906] dbus-broker-launch[448]: Invalid user-name in /nix/store/n5ajpvi0apkn1j8sdflkn28hvc5w06bj-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
client # [    9.495712] systemd[1]: Started D-Bus System Message Bus.
client # [    9.538457] systemd-logind[469]: New seat seat0.
client # [    9.545493] systemd[1]: Started User Login Management.
client # [    9.553795] systemd[1]: Starting linger-users.service...
client # [    9.557751] dbus-broker-launch[448]: Ready
client # [    9.567198] systemd[1]: Stopped target Host and Network Name Lookups.
client # [    9.572106] systemd[1]: Stopping Host and Network Name Lookups...
client # [    9.573135] systemd[1]: Stopped target User and Group Name Lookups.
client # [    9.574078] systemd[1]: Stopping User and Group Name Lookups...
client # [    9.574980] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
client # [    9.586449] systemd[1]: nscd.service: Deactivated successfully.
client # [    9.590424] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
client # [    9.654094] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
client # [    9.690885] systemd[1]: linger-users.service: Deactivated successfully.
client # [    9.696701] systemd[1]: Finished linger-users.service.
client # [    9.733822] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
client # [    9.773426] systemd[1]: Started Name Service Cache Daemon (nsncd).
client # [    9.781449] nsncd[534]: Oct 01 03:46:36.197 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
client # [    9.783755] systemd[1]: Reached target Host and Network Name Lookups.
client # [    9.797849] systemd[1]: Reached target User and Group Name Lookups.
client # [    9.798893] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
client # [    9.809942] systemd[1]: Started backdoor.service.
client # [    9.820162] systemd[1]: Finished resolvconf update.
client # [    9.839854] systemd[1]: Starting DHCP Client...
client # connecting to host...
client # [    9.984784] systemd[1]: Finished Firewall.
client # [    9.985545] systemd[1]: Reached target Preparation for Network.
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 10.55 seconds)
client: (finished: waiting for the VM to finish booting, in 10.95 seconds)
client # [   10.013801] systemd[1]: Starting Extra networking commands....
client # [   10.100571] (udev-worker)[336]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
client # [   10.137062] (udev-worker)[336]: Network interface NamePolicy= disabled on kernel command line.
client # [   10.209215] dhcpcd[583]: dhcpcd-10.3.2 starting
client # [   10.222142] dhcpcd[603]: dev: loaded udev
client # [   10.299021] 8021q: 802.1Q VLAN Support v1.8
client # [   10.452039] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client # [   10.472787] systemd[1]: Finished Extra networking commands..
client # [   10.476253] systemd[1]: Reached target Network.
client # [   10.500067] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client # [   10.500552] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
client # [   10.504792] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
client # [   10.505106] cfg80211: failed to load regulatory.db
client # [   10.492210] systemd[1]: Starting Permit User Sessions...
client # [   10.543393] systemd[1]: Condition check resulted in Virtio network device being skipped.
client # [   10.557843] systemd[1]: Starting Address configuration of eth1...
client # [   10.577517] systemd[1]: Finished Permit User Sessions.
client # [   10.587306] systemd[1]: Started Getty on tty1.
client # [   10.592503] systemd[1]: Reached target Login Prompts.
client # [   10.633819] 8021q: adding VLAN 0 to HW filter on device eth0
client # [   10.618620] dhcpcd[603]: eth0: waiting for carrier
client # [   10.625016] dhcpcd[603]: eth0: carrier acquired
client # [   10.637221] dhcpcd[603]: DUID 00:01:00:01:32:50:94:1d:52:54:00:12:34:56
client # [   10.638289] dhcpcd[603]: eth0: IAID 00:12:34:56
client # [   10.639117] dhcpcd[603]: eth0: adding address fe80::5054:ff:fe12:3456
client # [   10.648755] dhcpcd[603]: eth0: IAID 00:12:34:56
client # [   10.654014] systemd-logind[469]: Watching system buttons on /dev/input/event0 (gpio-keys)
client # [   10.698863] 8021q: adding VLAN 0 to HW filter on device eth1
client # [   10.696554] network-addresses-eth1-start[659]: adding address 192.168.1.1/24... done
client # [   10.707163] network-addresses-eth1-start[659]: adding address 2001:db8:1::1/64... done
client # [   10.728254] systemd[1]: Finished Address configuration of eth1.
client # [   10.898958] mousedev: PS/2 mouse device common for all mice
client # [   10.945099] systemd-logind[469]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
client # [   10.981627] dhcpcd[603]: eth0: soliciting a DHCP lease
client # [   10.988689] dhcpcd[603]: eth0: offered 10.0.2.15 from 10.0.2.2
client # [   10.996340] dhcpcd[603]: eth0: probing address 10.0.2.15/24
client # [   11.680721] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3
client # [   11.997231] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client # [   12.013616] systemd[1]: Starting Virtual Console Setup...
client # [   12.042483] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
client # [   12.043784] systemd[1]: Stopped Virtual Console Setup.
client # [   12.049378] systemd[1]: Starting Virtual Console Setup...
client # [   12.099179] systemd-logind[469]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
client # [   12.200527] systemd-vconsole-setup[701]: Configuration of first virtual console was skipped, ignoring remaining ones.
client # [   12.205472] systemd[1]: Finished Virtual Console Setup.
client # [   12.980228] dhcpcd[603]: eth0: soliciting an IPv6 router
client # [   12.982048] dhcpcd[603]: eth0: Router Advertisement from fe80::2
client # [   12.983512] dhcpcd[603]: eth0: adding address fec0::5054:ff:fe12:3456/64
client # [   12.985213] dhcpcd[603]: eth0: adding route to fec0::/64
client # [   12.986384] dhcpcd[603]: eth0: adding default route via fe80::2
client # [   15.369272] dhcpcd[603]: eth0: leased 10.0.2.15 for 86400 seconds
client # [   15.370898] dhcpcd[603]: eth0: adding route to 10.0.2.0/24
client # [   15.372587] dhcpcd[603]: eth0: adding default route via 10.0.2.2
client # [   15.485842] systemd[1]: Started DHCP Client.
client # [   15.488992] systemd[1]: Reached target Network is Online.
client # [   15.495146] systemd[1]: Starting Journal Remote Upload Service...
client # [   15.554885] systemd[1]: Started Journal Remote Upload Service.
client # [   15.560197] systemd[1]: Reached target Multi-User System.
client # [   15.564676] systemd[1]: Startup finished in 1.156s (kernel) + 4.417s (initrd) + 9.988s (userspace) = 15.561s.
server # [   28.029483] systemd[1]: Started Journal Remote Sink Service.
client: (finished: waiting for unit systemd-journal-upload.service, in 16.63 seconds)
client: must succeed: systemd-cat --identifier=nixos-test <<< 'Hello from NixOS test infrastructure'
client # [   15.712280] nixos-test[804]: Hello from NixOS test infrastructure
client: (finished: must succeed: systemd-cat --identifier=nixos-test <<< 'Hello from NixOS test infrastructure', in 0.03 seconds)
server: waiting for success: journalctl --file /var/log/journal/remote/remote-*.journal --identifier=nixos-test | grep -F 'Hello from NixOS test infrastructure'
server # Failed to open files: No such file or directory
server: (finished: waiting for success: journalctl --file /var/log/journal/remote/remote-*.journal --identifier=nixos-test | grep -F 'Hello from NixOS test infrastructure', in 1.11 seconds)
(finished: run the VM test script, in 29.98 seconds)
test script finished in 30.06s
cleanup
kill QemuMachine (pid 97)
client # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)
client # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
client # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
kill QemuMachine (pid 57)
server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)
server # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
server # [2026-10-01T03:46:43Z INFO  virtiofsd] Client disconnected, shutting down
(finished: cleanup, in 0.26 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