Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.01 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: vm, 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 start all VMs vm: starting vm vm # /build /build/vm-state-vm vm # /build/vm-state-vm vm: QEMU running (pid 46) (finished: start all VMs, in 0.11 seconds) vm: waiting for unit default.target vm: waiting for the VM to finish booting vm # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) vm # vm # vm # iPXE (http://ipxe.org) 00:04.0 CA00 PCI2.10 PnP PMM+3EFD1BE0+3EF31BE0 CA00 vm # Press Ctrl-B to configure iPXE (PCI 00:04.0)... vm # vm # vm # Booting from Hard Disk... vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. vm # [ 0.000000] Linux version 5.15.0-191-generic (buildd@lcy02-amd64-042) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04.3) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #201-Ubuntu SMP Fri Aug 7 18:39:04 UTC 2026 (Ubuntu 5.15.0-191.201-generic 5.15.209) vm # [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-5.15.0-191-generic root=LABEL=cloudimg-rootfs ro console=tty1 console=ttyS0 vm # [ 0.000000] KERNEL supported cpus: vm # [ 0.000000] Intel GenuineIntel vm # [ 0.000000] AMD AuthenticAMD vm # [ 0.000000] Hygon HygonGenuine vm # [ 0.000000] Centaur CentaurHauls vm # [ 0.000000] zhaoxin Shanghai vm # [ 0.000000] x86/split lock detection: #DB: warning on user-space bus_locks vm # [ 0.000000] BIOS-provided physical RAM map: vm # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable vm # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved vm # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved vm # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdffff] usable vm # [ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] reserved vm # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved vm # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved vm # [ 0.000000] NX (Execute Disable) protection: active vm # [ 0.000000] SMBIOS 2.8 present. vm # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 vm # [ 0.000000] Hypervisor detected: KVM vm # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 vm # [ 0.000000] kvm-clock: cpu 0, msr 31a01001, primary cpu clock vm # [ 0.000003] kvm-clock: using sched offset of 296939380055 cycles vm # [ 0.000007] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm # [ 0.000012] tsc: Detected 2100.000 MHz processor vm # [ 0.001360] last_pfn = 0x3ffe0 max_arch_pfn = 0x10000000000 vm # [ 0.001427] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm # [ 0.006436] found SMP MP-table at [mem 0x000f5490-0x000f549f] vm # [ 0.006481] Using GB pages for direct mapping vm # [ 0.006667] RAMDISK: [mem 0x33f7d000-0x35fb5fff] vm # [ 0.006695] ACPI: Early table checksum verification disabled vm # [ 0.006702] ACPI: RSDP 0x00000000000F52B0 000014 (v00 BOCHS ) vm # [ 0.006711] ACPI: RSDT 0x000000003FFE23A8 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006719] ACPI: FACP 0x000000003FFE2254 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006760] ACPI: DSDT 0x000000003FFE0040 002214 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006765] ACPI: FACS 0x000000003FFE0000 000040 vm # [ 0.006769] ACPI: APIC 0x000000003FFE22C8 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006774] ACPI: HPET 0x000000003FFE2348 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006779] ACPI: WAET 0x000000003FFE2380 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm # [ 0.006783] ACPI: Reserving FACP table memory at [mem 0x3ffe2254-0x3ffe22c7] vm # [ 0.006785] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2253] vm # [ 0.006787] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] vm # [ 0.006788] ACPI: Reserving APIC table memory at [mem 0x3ffe22c8-0x3ffe2347] vm # [ 0.006790] ACPI: Reserving HPET table memory at [mem 0x3ffe2348-0x3ffe237f] vm # [ 0.006791] ACPI: Reserving WAET table memory at [mem 0x3ffe2380-0x3ffe23a7] vm # [ 0.007717] No NUMA configuration found vm # [ 0.007719] Faking a node at [mem 0x0000000000000000-0x000000003ffdffff] vm # [ 0.007733] NODE_DATA(0) allocated [mem 0x3ffb6000-0x3ffdffff] vm # [ 0.009771] Zone ranges: vm # [ 0.009775] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm # [ 0.009779] DMA32 [mem 0x0000000001000000-0x000000003ffdffff] vm # [ 0.009782] Normal empty vm # [ 0.009785] Device empty vm # [ 0.009787] Movable zone start for each node vm # [ 0.009790] Early memory node ranges vm # [ 0.009791] node 0: [mem 0x0000000000001000-0x000000000009efff] vm # [ 0.009794] node 0: [mem 0x0000000000100000-0x000000003ffdffff] vm # [ 0.009798] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdffff] vm # [ 0.009836] On node 0, zone DMA: 1 pages in unavailable ranges vm # [ 0.010279] On node 0, zone DMA: 97 pages in unavailable ranges vm # [ 0.038628] On node 0, zone DMA32: 32 pages in unavailable ranges vm # [ 0.039365] ACPI: PM-Timer IO Port: 0x608 vm # [ 0.039389] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm # [ 0.039440] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm # [ 0.039445] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm # [ 0.039448] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm # [ 0.039450] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm # [ 0.039452] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm # [ 0.039454] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm # [ 0.039459] ACPI: Using ACPI (MADT) for SMP configuration information vm # [ 0.039462] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm # [ 0.039470] TSC deadline timer available vm # [ 0.039473] smpboot: Allowing 2 CPUs, 0 hotplug CPUs vm # [ 0.039506] kvm-guest: KVM setup pv remote TLB flush vm # [ 0.039513] kvm-guest: setup PV sched yield vm # [ 0.039525] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm # [ 0.039529] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm # [ 0.039532] [mem 0x40000000-0xfeffbfff] available for PCI devices vm # [ 0.039535] Booting paravirtualized kernel on KVM vm # [ 0.039539] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns vm # [ 0.039551] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 vm # [ 0.043689] percpu: Embedded 62 pages/cpu s217088 r8192 d28672 u1048576 vm # [ 0.043764] kvm-guest: setup async PF for cpu 0 vm # [ 0.043773] kvm-guest: stealtime: cpu 0, msr 3ec34080 vm # [ 0.043780] kvm-guest: PV spinlocks enabled vm # [ 0.043785] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm # [ 0.043800] Built 1 zonelists, mobility grouping on. Total pages: 257760 vm # [ 0.043803] Policy zone: DMA32 vm # [ 0.043806] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-5.15.0-191-generic root=LABEL=cloudimg-rootfs ro console=tty1 console=ttyS0 vm # [ 0.045811] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) vm # [ 0.046644] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) vm # [ 0.046738] mem auto-init: stack:off, heap alloc:on, heap free:off vm # [ 0.050084] Memory: 937152K/1048056K available (16393K kernel code, 4402K rwdata, 11004K rodata, 3292K init, 18768K bss, 110700K reserved, 0K cma-reserved) vm # [ 0.050539] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm # [ 0.050590] ftrace: allocating 50910 entries in 199 pages vm # [ 0.087536] ftrace: allocated 199 pages with 5 groups vm # [ 0.087734] rcu: Hierarchical RCU implementation. vm # [ 0.087737] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=2. vm # [ 0.087740] Rude variant of Tasks RCU enabled. vm # [ 0.087741] Tracing variant of Tasks RCU enabled. vm # [ 0.087742] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm # [ 0.087744] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm # [ 0.093813] NR_IRQS: 524544, nr_irqs: 440, preallocated irqs: 16 vm # [ 0.094105] random: crng init done vm # [ 0.107874] Console: colour VGA+ 80x25 vm # [ 0.143710] printk: console [tty1] enabled vm # [ 0.237811] printk: console [ttyS0] enabled vm # [ 0.238681] ACPI: Core revision 20210730 vm # [ 0.239755] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm # [ 0.241583] APIC: Switch to symmetric I/O mode setup vm # [ 0.242734] x2apic enabled vm # [ 0.243627] Switched APIC routing to physical x2apic. vm # [ 0.244598] kvm-guest: setup PV IPIs vm # [ 0.246479] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm # [ 0.247593] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1e4530a99b6, max_idle_ns: 440795257976 ns vm # [ 0.249494] Calibrating delay loop (skipped) preset value.. 4200.00 BogoMIPS (lpj=8400000) vm # [ 0.253644] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm # [ 0.254973] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 vm # [ 0.257491] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 vm # [ 0.258710] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm # [ 0.260436] Spectre V2 : Mitigation: Enhanced / Automatic IBRS vm # [ 0.261491] Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT vm # [ 0.262902] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm # [ 0.264417] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp vm # [ 0.265603] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm # [ 0.267056] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm # [ 0.268239] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm # [ 0.269493] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' vm # [ 0.270682] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' vm # [ 0.271902] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' vm # [ 0.273492] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' vm # [ 0.274940] x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' vm # [ 0.276150] x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' vm # [ 0.277390] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm # [ 0.277492] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 vm # [ 0.278656] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 vm # [ 0.279784] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 vm # [ 0.281491] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 vm # [ 0.282570] x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 vm # [ 0.283715] x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 vm # [ 0.285491] x86/fpu: Enabled xstate features 0x602e7, context size is 10752 bytes, using 'compacted' format. vm # [ 0.311849] Freeing SMP alternatives memory: 44K vm # [ 0.312829] pid_max: default: 32768 minimum: 301 vm # [ 0.313529] LSM: Security Framework initializing vm # [ 0.314429] landlock: Up and running. vm # [ 0.315346] Yama: becoming mindful. vm # [ 0.316106] AppArmor: AppArmor initialized vm # [ 0.316951] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm # [ 0.317496] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm # [ 0.319674] smpboot: CPU0: Intel(R) Xeon(R) Gold 5412U (family: 0x6, model: 0x8f, stepping: 0x8) vm # [ 0.321489] Performance Events: PEBS fmt0-, Sapphire Rapids events, full-width counters, Intel PMU driver. vm # [ 0.321489] ... version: 2 vm # [ 0.321495] ... bit width: 48 vm # [ 0.322543] ... generic registers: 8 vm # [ 0.323337] ... value mask: 0000ffffffffffff vm # [ 0.324457] ... max period: 00007fffffffffff vm # [ 0.325498] ... fixed-purpose events: 3 vm # [ 0.326349] ... event mask: 00000007000000ff vm # [ 0.327643] signal: max sigframe size: 11952 vm # [ 0.329599] rcu: Hierarchical SRCU implementation. vm # [ 0.331693] smp: Bringing up secondary CPUs ... vm # [ 0.333044] x86: Booting SMP configuration: vm # [ 0.333499] .... node #0, CPUs: #1 vm # [ 0.155398] kvm-clock: cpu 1, msr 31a01041, secondary cpu clock vm # [ 0.335177] kvm-guest: setup async PF for cpu 1 vm # [ 0.336558] kvm-guest: stealtime: cpu 1, msr 3ed34080 vm # [ 0.337550] smp: Brought up 1 node, 2 CPUs vm # [ 0.338392] smpboot: Max logical packages: 1 vm # [ 0.339086] smpboot: Total of 2 processors activated (8400.00 BogoMIPS) vm # [ 0.341890] devtmpfs: initialized vm # [ 0.342107] x86/mm: Memory block size: 128MB vm # [ 0.342944] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm # [ 0.342990] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm # [ 0.345575] pinctrl core: initialized pinctrl subsystem vm # [ 0.346607] PM: RTC time: 00:06:01, date: 2026-10-13 vm # [ 0.347580] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm # [ 0.348740] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations vm # [ 0.349515] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm # [ 0.350781] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm # [ 0.351985] audit: initializing netlink subsys (disabled) vm # [ 0.352866] audit: type=2000 audit(1791849961.258:1): state=initialized audit_enabled=0 res=1 vm # [ 0.352866] thermal_sys: Registered thermal governor 'fair_share' vm # [ 0.353497] thermal_sys: Registered thermal governor 'bang_bang' vm # [ 0.354550] thermal_sys: Registered thermal governor 'step_wise' vm # [ 0.355548] thermal_sys: Registered thermal governor 'user_space' vm # [ 0.356604] thermal_sys: Registered thermal governor 'power_allocator' vm # [ 0.357526] cpuidle: using governor ladder vm # [ 0.359159] cpuidle: using governor menu vm # [ 0.360176] ACPI: bus type PCI registered vm # [ 0.360861] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm # [ 0.361643] PCI: Using configuration type 1 for base access vm # [ 0.363747] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm # [ 0.365531] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages vm # [ 0.366481] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages vm # [ 0.369587] ACPI: Added _OSI(Module Device) vm # [ 0.370327] ACPI: Added _OSI(Processor Device) vm # [ 0.371105] ACPI: Added _OSI(Processor Aggregator Device) vm # [ 0.371970] ACPI: Added _OSI(Linux-Dell-Video) vm # [ 0.372894] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) vm # [ 0.373506] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) vm # [ 0.375399] ACPI: 1 ACPI AML tables successfully acquired and loaded vm # [ 0.377262] ACPI: Interpreter enabled vm # [ 0.377525] ACPI: PM: (supports S0 S3 S4 S5) vm # [ 0.378231] ACPI: Using IOAPIC for interrupt routing vm # [ 0.379090] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm # [ 0.380564] PCI: Using E820 reservations for host bridge windows vm # [ 0.381627] ACPI: Enabled 2 GPEs in block 00 to 0F vm # [ 0.384527] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm # [ 0.385500] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI EDR HPX-Type3] vm # [ 0.386854] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. vm # [ 0.388991] acpiphp: Slot [3] registered vm # [ 0.389515] acpiphp: Slot [4] registered vm # [ 0.390195] acpiphp: Slot [5] registered vm # [ 0.390977] acpiphp: Slot [6] registered vm # [ 0.391740] acpiphp: Slot [7] registered vm # [ 0.392482] acpiphp: Slot [8] registered vm # [ 0.393205] acpiphp: Slot [9] registered vm # [ 0.393508] acpiphp: Slot [10] registered vm # [ 0.394238] acpiphp: Slot [11] registered vm # [ 0.394922] acpiphp: Slot [12] registered vm # [ 0.395714] acpiphp: Slot [13] registered vm # [ 0.396438] acpiphp: Slot [14] registered vm # [ 0.397200] acpiphp: Slot [15] registered vm # [ 0.397509] acpiphp: Slot [16] registered vm # [ 0.398261] acpiphp: Slot [17] registered vm # [ 0.399071] acpiphp: Slot [18] registered vm # [ 0.399822] acpiphp: Slot [19] registered vm # [ 0.400635] acpiphp: Slot [20] registered vm # [ 0.401379] acpiphp: Slot [21] registered vm # [ 0.401510] acpiphp: Slot [22] registered vm # [ 0.402384] acpiphp: Slot [23] registered vm # [ 0.403157] acpiphp: Slot [24] registered vm # [ 0.403906] acpiphp: Slot [25] registered vm # [ 0.404685] acpiphp: Slot [26] registered vm # [ 0.405437] acpiphp: Slot [27] registered vm # [ 0.405512] acpiphp: Slot [28] registered vm # [ 0.406241] acpiphp: Slot [29] registered vm # [ 0.406939] acpiphp: Slot [30] registered vm # [ 0.407653] acpiphp: Slot [31] registered vm # [ 0.408427] PCI host bridge to bus 0000:00 vm # [ 0.409180] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm # [ 0.409496] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm # [ 0.410529] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm # [ 0.411772] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] vm # [ 0.413058] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] vm # [ 0.413492] pci_bus 0000:00: root bus resource [bus 00-ff] vm # [ 0.414475] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 vm # [ 0.416348] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 vm # [ 0.417790] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 vm # [ 0.421414] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] vm # [ 0.421530] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] vm # [ 0.422645] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] vm # [ 0.423650] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] vm # [ 0.424766] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] vm # [ 0.425781] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 vm # [ 0.427086] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm # [ 0.428273] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm # [ 0.430154] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 vm # [ 0.434984] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] vm # [ 0.436152] pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] vm # [ 0.437175] pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] vm # [ 0.437574] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm # [ 0.440006] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 vm # [ 0.443144] pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f] vm # [ 0.444053] pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] vm # [ 0.445087] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] vm # [ 0.447342] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 vm # [ 0.451395] pci 0000:00:04.0: reg 0x10: [io 0xc0a0-0xc0bf] vm # [ 0.452976] pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] vm # [ 0.453520] pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] vm # [ 0.454689] pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] vm # [ 0.457451] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 vm # [ 0.459786] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc03f] vm # [ 0.460673] pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] vm # [ 0.461521] pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] vm # [ 0.464216] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 vm # [ 0.466613] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0df] vm # [ 0.468163] pci 0000:00:06.0: reg 0x14: [mem 0xfebd4000-0xfebd4fff] vm # [ 0.469480] pci 0000:00:06.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref] vm # [ 0.471677] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 vm # [ 0.475121] pci 0000:00:07.0: reg 0x10: [io 0xc0e0-0xc0ff] vm # [ 0.476404] pci 0000:00:07.0: reg 0x14: [mem 0xfebd5000-0xfebd5fff] vm # [ 0.477535] pci 0000:00:07.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref] vm # [ 0.480623] pci 0000:00:08.0: [1af4:1003] type 00 class 0x078000 vm # [ 0.485508] pci 0000:00:08.0: reg 0x10: [io 0xc040-0xc07f] vm # [ 0.486737] pci 0000:00:08.0: reg 0x14: [mem 0xfebd6000-0xfebd6fff] vm # [ 0.488053] pci 0000:00:08.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref] vm # [ 0.491325] pci 0000:00:09.0: [1af4:1005] type 00 class 0x00ff00 vm # [ 0.495303] pci 0000:00:09.0: reg 0x10: [io 0xc100-0xc11f] vm # [ 0.496337] pci 0000:00:09.0: reg 0x14: [mem 0xfebd7000-0xfebd7fff] vm # [ 0.497374] pci 0000:00:09.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref] vm # [ 0.506377] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm # [ 0.507708] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm # [ 0.509228] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm # [ 0.509623] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm # [ 0.510964] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm # [ 0.512584] iommu: Default domain type: Translated vm # [ 0.513527] iommu: DMA domain TLB invalidation policy: lazy mode vm # [ 0.515112] SCSI subsystem initialized vm # [ 0.516018] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm # [ 0.516018] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm # [ 0.517501] pci 0000:00:02.0: vgaarb: bridge control possible vm # [ 0.518382] vgaarb: loaded vm # [ 0.518918] ACPI: bus type USB registered vm # [ 0.519566] usbcore: registered new interface driver usbfs vm # [ 0.520724] usbcore: registered new interface driver hub vm # [ 0.521509] usbcore: registered new device driver usb vm # [ 0.522402] pps_core: LinuxPPS API ver. 1 registered vm # [ 0.523268] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm # [ 0.524658] PTP clock support registered vm # [ 0.525401] EDAC MC: Ver: 3.0.0 vm # [ 0.525700] NetLabel: Initializing vm # [ 0.526533] NetLabel: domain hash size = 128 vm # [ 0.526533] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm # [ 0.526574] NetLabel: unlabeled traffic allowed by default vm # [ 0.529529] PCI: Using ACPI for IRQ routing vm # [ 0.530695] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm # [ 0.530695] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm # [ 0.536666] clocksource: Switched to clocksource kvm-clock vm # [ 0.543218] VFS: Disk quotas dquot_6.6.0 vm # [ 0.543953] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm # [ 0.545133] AppArmor: AppArmor Filesystem Enabled vm # [ 0.545883] pnp: PnP ACPI init vm # [ 0.546511] ACPI: IRQ 4 override to edge, high vm # [ 0.547426] pnp: PnP ACPI: found 6 devices vm # [ 0.553884] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm # [ 0.555237] NET: Registered PF_INET protocol family vm # [ 0.556041] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) vm # [ 0.557596] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) vm # [ 0.558889] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm # [ 0.560169] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) vm # [ 0.561449] TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) vm # [ 0.562564] TCP: Hash tables configured (established 8192 bind 8192) vm # [ 0.563540] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) vm # [ 0.564717] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) vm # [ 0.565679] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) vm # [ 0.566720] NET: Registered PF_UNIX/PF_LOCAL protocol family vm # [ 0.567630] NET: Registered PF_XDP protocol family vm # [ 0.568408] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm # [ 0.569314] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm # [ 0.570378] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm # [ 0.571512] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] vm # [ 0.572498] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] vm # [ 0.573586] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm # [ 0.574471] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm # [ 0.575556] pci 0000:00:01.0: Activating ISA DMA hang workarounds vm # [ 0.576661] PCI: CLS 0 bytes, default 64 vm # [ 0.577381] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e4530a99b6, max_idle_ns: 440795257976 ns vm # [ 0.577437] Trying to unpack rootfs image as initramfs... vm # [ 0.584192] Initialise system trusted keyrings vm # [ 0.584931] Key type blacklist registered vm # [ 0.585703] workingset: timestamp_bits=36 max_order=18 bucket_order=0 vm # [ 0.587523] zbud: loaded vm # [ 0.588137] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm # [ 0.589123] fuse: init (API version 7.34) vm # [ 0.589890] integrity: Platform Keyring initialized vm # [ 0.598920] Key type asymmetric registered vm # [ 0.599842] Asymmetric key parser 'x509' registered vm # [ 0.600614] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) vm # [ 0.601804] io scheduler mq-deadline registered vm # [ 0.602777] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 vm # [ 0.603909] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 vm # [ 0.605052] ACPI: button: Power Button [PWRF] vm # [ 0.606651] ACPI: \_SB_.LNKC: Enabled at IRQ 11 vm # [ 0.609408] ACPI: \_SB_.LNKD: Enabled at IRQ 10 vm # [ 0.612010] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm # [ 0.614773] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm # [ 0.622418] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled vm # [ 0.647543] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm # [ 0.657343] Linux agpgart interface v0.103 vm # [ 0.661599] loop: module loaded vm # [ 0.663463] scsi host0: ata_piix vm # [ 0.664290] scsi host1: ata_piix vm # [ 0.664855] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 vm # [ 0.665859] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 vm # [ 0.667013] tun: Universal TUN/TAP device driver, 1.6 vm # [ 0.667925] PPP generic driver version 2.4.2 vm # [ 0.668645] VFIO - User Level meta-driver version: 0.3 vm # [ 0.669506] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver vm # [ 0.670467] ehci-pci: EHCI PCI platform driver vm # [ 0.671170] ehci-platform: EHCI generic platform driver vm # [ 0.672028] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver vm # [ 0.673291] ohci-pci: OHCI PCI platform driver vm # [ 0.674001] ohci-platform: OHCI generic platform driver vm # [ 0.674802] uhci_hcd: USB Universal Host Controller Interface driver vm # [ 0.675844] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm # [ 0.677686] serio: i8042 KBD port at 0x60,0x64 irq 1 vm # [ 0.678460] serio: i8042 AUX port at 0x60,0x64 irq 12 vm # [ 0.679392] mousedev: PS/2 mouse device common for all mice vm # [ 0.680841] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 vm # [ 0.682253] rtc_cmos 00:05: RTC can wake from S4 vm # [ 0.683559] rtc_cmos 00:05: registered as rtc0 vm # [ 0.684315] rtc_cmos 00:05: setting system clock to 2026-10-13T00:06:01 UTC (1791849961) vm # [ 0.685592] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm # [ 0.686767] i2c_dev: i2c /dev entries driver vm # [ 0.687543] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm # [ 0.689320] device-mapper: uevent: version 1.0.3 vm # [ 0.690092] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com vm # [ 0.691363] intel_pstate: CPU model not supported vm # [ 0.732132] hpet: Lost 2 RTC interrupts vm # [ 0.732842] ledtrig-cpu: registered to indicate activity on CPUs vm # [ 0.733905] drop_monitor: Initializing network drop monitor service vm # [ 0.735185] NET: Registered PF_INET6 protocol family vm # [ 0.840080] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 vm # [ 0.840981] ata1.00: 4612096 sectors, multi 16: LBA48 vm # [ 1.000212] scsi 0:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 vm # [ 1.001020] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm # [ 1.001761] scsi 0:0:0:0: Attached scsi generic sg0 type 0 vm # [ 1.003701] sd 0:0:0:0: [sda] 4612096 512-byte logical blocks: (2.36 GB/2.20 GiB) vm # [ 1.005196] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm # [ 1.007609] sd 0:0:0:0: [sda] Write Protect is off vm # [ 1.008381] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA vm # [ 1.019813] sda: sda1 sda14 sda15 vm # [ 1.020571] sd 0:0:0:0: [sda] Attached SCSI disk vm # [ 1.036128] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm # [ 1.223859] cdrom: Uniform CD-ROM driver Revision: 3.20 vm # [ 1.324079] sr 1:0:0:0: Attached scsi generic sg1 type 5 vm # [ 1.500591] Freeing initrd memory: 32996K vm # [ 1.507329] Segment Routing with IPv6 vm # [ 1.508021] In-situ OAM (IOAM) with IPv6 vm # [ 1.508693] NET: Registered PF_PACKET protocol family vm # [ 1.509547] Key type dns_resolver registered vm # [ 1.510760] IPI shorthand broadcast: enabled vm # [ 1.511745] sched_clock: Marking stable (1360309326, 151398925)->(1553927660, -42219409) vm # [ 1.513565] registered taskstats version 1 vm # [ 1.514567] Loading compiled-in X.509 certificates vm # [ 1.516635] Loaded X.509 cert 'Build time autogenerated kernel key: ed39c156d6b29ce385c94da0a139822883a90e35' vm # [ 1.518548] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' vm # [ 1.520527] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' vm # [ 1.522366] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing 2025 Kmod: 4627603d2357a2a3f81006370894c221175893e9' vm # [ 1.524404] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' vm # [ 1.525842] blacklist: Loading compiled-in revocation X.509 certificates vm # [ 1.526847] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' vm # [ 1.528287] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' vm # [ 1.529776] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' vm # [ 1.531342] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' vm # [ 1.532891] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' vm # [ 1.534410] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' vm # [ 1.535984] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' vm # [ 1.537522] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' vm # [ 1.539242] zswap: loaded using pool lzo/zbud vm # [ 1.540474] Key type .fscrypt registered vm # [ 1.541388] Key type fscrypt-provisioning registered vm # [ 1.545416] Key type encrypted registered vm # [ 1.546207] AppArmor: AppArmor sha1 policy hashing enabled vm # [ 1.547178] ima: No TPM chip found, activating TPM-bypass! vm # [ 1.548180] Loading compiled-in module X.509 certificates vm # [ 1.549552] Loaded X.509 cert 'Build time autogenerated kernel key: ed39c156d6b29ce385c94da0a139822883a90e35' vm # [ 1.551241] ima: Allocated hash algorithm: sha1 vm # [ 1.552104] ima: No architecture policies found vm # [ 1.552945] evm: Initialising EVM extended attributes: vm # [ 1.553867] evm: security.selinux vm # [ 1.554502] evm: security.SMACK64 vm # [ 1.555129] evm: security.SMACK64EXEC vm # [ 1.555862] evm: security.SMACK64TRANSMUTE vm # [ 1.556631] evm: security.SMACK64MMAP vm # [ 1.557356] evm: security.apparmor vm # [ 1.558015] evm: security.ima vm # [ 1.558592] evm: security.capability vm # [ 1.559261] evm: HMAC attrs: 0x1 vm # [ 1.560176] PM: Magic number: 14:63:102 vm # [ 1.561186] RAS: Correctable Errors collector initialized. vm # [ 1.570219] clk: Disabling unused clocks vm # [ 1.575338] Freeing unused decrypted memory: 2036K vm # [ 1.576655] Freeing unused kernel image (initmem) memory: 3292K vm # [ 1.577578] Write protecting the kernel read-only data: 30720k vm # [ 1.578913] Freeing unused kernel image (text/rodata gap) memory: 2036K vm # [ 1.580230] Freeing unused kernel image (rodata/data gap) memory: 1284K vm # [ 1.589496] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm # [ 1.590473] Run /init as init process vm # Loading, please wait... vm # Starting version 249.11-0ubuntu3.22 vm # [ 1.674165] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 vm # [ 1.675831] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 vm # [ 1.677841] Floppy drive(s): fd0 is 2.88M AMI BIOS vm # [ 1.687427] cryptd: max_cpu_qlen set to 1000 vm # [ 1.692115] AVX2 version of gcm_enc/dec engaged. vm # [ 1.693548] AES CTR mode by8 optimization enabled vm # [ 1.695810] FDC 0 is a S82078B vm # [ 1.729697] virtio_net virtio1 ens4: renamed from eth0 vm # Begin: Loading essential drivers ... [ 3.127410] raid6: avx512x4 gen() 27068 MB/s vm # [ 3.195408] raid6: avx512x4 xor() 6213 MB/s vm # [ 3.263410] raid6: avx512x2 gen() 32878 MB/s vm: Guest root shell did not produce any data yet... vm: To debug, enter the VM and run 'systemctl status backdoor.service'. cleanup kill QemuMachine (pid 46) vm # [ 3.331404] raid6: avx512x2 xor() 18860 MB/s vm # qemu-kvm: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.05 seconds) Traceback (most recent call last): File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in sys.exit(main()) ~~~~^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main driver.run_tests() ~~~~~~~~~~~~~~~~^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests self.test_script() ~~~~~~~~~~~~~~~~^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script exec(self.tests, symbols, None) ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "", line 5, in File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 405, in wait_for_unit retry(check_active, as_timedelta(timeout)) ~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 141, in retry if fn(False): ~~^^^^^^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 386, in check_active state = self.get_unit_property(unit, "ActiveState", user) File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 441, in get_unit_property status, lines = self.systemctl( ~~~~~~~~~~~~~~^ f'--no-pager show "{unit}" --property="{property}"', ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ user, ^^^^^ ) ^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl return self.execute(f"systemctl {q}") ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute return self._execute( ~~~~~~~~~~~~~^ command=command, ^^^^^^^^^^^^^^^^ ...<2 lines>... timeout=as_timedelta(timeout) if timeout is not None else None, ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ ) ^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute self.connect() ~~~~~~~~~~~~^^ File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1174, in connect raise RuntimeError("Shell did not start in time") RuntimeError: Shell did not start in time