these 13 derivations will be built: /nix/store/fsrgahai3vypawlkz8iny2ffzli8i1jb-flakelet-config.json.drv /nix/store/8bylh3ml8lpl29442sjll0pz6wh49yg4-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/g27a823mdvfg2bhzbg718v5k5jp4vd54-unit-flakelet-reconcile.service.drv /nix/store/bvjhf6v4jz81r133fnsb0f2bxy7ypy43-system-units.drv /nix/store/4r6hhvmjkjca0wmxpbyzk7h1kixx2kiq-etc.drv /nix/store/sr3i3vn49ns69c38v7q3sc68hk7j8fm8-activate.drv /nix/store/yw1ww0822yjjv5vql6wy6i65yyskx1gd-nixos-system-machine-test.drv /nix/store/ig2cnraa4ipm5xhbxyl843al56j3c50d-closure-info.drv /nix/store/wws0lqny2jy362v1n0bric0a03ffggrp-run-nixos-vm.drv /nix/store/xjhk65mg7wm7cfd7bbf5m4a4k1r3shbx-nixos-vm.drv /nix/store/s0a3wh3m6k19wzkaafhaa9i5kvg83425-driverConfiguration.json.drv /nix/store/vw3ngmqykz7rvgplbm3imqw2ib4d2wx6-nixos-test-driver-flakelet.drv /nix/store/f24d9q9kd034apbfkw8n9nj4k8blkcl7-vm-test-run-flakelet.drv building '/nix/store/fsrgahai3vypawlkz8iny2ffzli8i1jb-flakelet-config.json.drv' flakelet-config.json> structuredAttrs is enabled building '/nix/store/8bylh3ml8lpl29442sjll0pz6wh49yg4-X-Restart-Triggers-flakelet-reconcile.drv' building '/nix/store/g27a823mdvfg2bhzbg718v5k5jp4vd54-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/bvjhf6v4jz81r133fnsb0f2bxy7ypy43-system-units.drv' building '/nix/store/4r6hhvmjkjca0wmxpbyzk7h1kixx2kiq-etc.drv' building '/nix/store/sr3i3vn49ns69c38v7q3sc68hk7j8fm8-activate.drv' building '/nix/store/yw1ww0822yjjv5vql6wy6i65yyskx1gd-nixos-system-machine-test.drv' nixos-system-machine-test> structuredAttrs is enabled building '/nix/store/ig2cnraa4ipm5xhbxyl843al56j3c50d-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/wws0lqny2jy362v1n0bric0a03ffggrp-run-nixos-vm.drv' building '/nix/store/xjhk65mg7wm7cfd7bbf5m4a4k1r3shbx-nixos-vm.drv' building '/nix/store/s0a3wh3m6k19wzkaafhaa9i5kvg83425-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/vw3ngmqykz7rvgplbm3imqw2ib4d2wx6-nixos-test-driver-flakelet.drv' nixos-test-driver-flakelet> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-flakelet> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-flakelet> All checks passed! nixos-test-driver-flakelet> Linting test script (enable/disable: config.skipLint) nixos-test-driver-flakelet> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-flakelet> All checks passed! building '/nix/store/f24d9q9kd034apbfkw8n9nj4k8blkcl7-vm-test-run-flakelet.drv' vm-test-run-flakelet> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-flakelet> start all VLans vm-test-run-flakelet> (finished: start all VLans, in 0.00 seconds) vm-test-run-flakelet> Test will time out and terminate in 3600 seconds vm-test-run-flakelet> run the VM test script vm-test-run-flakelet> additionally exposed symbols: vm-test-run-flakelet> machine, vm-test-run-flakelet> vlan1, vm-test-run-flakelet> 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 vm-test-run-flakelet> machine: waiting for unit multi-user.target vm-test-run-flakelet> machine: waiting for the VM to finish booting vm-test-run-flakelet> machine: starting vm vm-test-run-flakelet> machine # Disk image does not exist, creating the virtualisation disk image... vm-test-run-flakelet> machine: QEMU running (pid 45) vm-test-run-flakelet> machine # Formatting '/build/vm-state-machine/tmp.dNkItCIJKO', fmt=raw size=1073741824 vm-test-run-flakelet> machine # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-flakelet> machine # Discarding device blocks: 0/262144 done vm-test-run-flakelet> machine # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-flakelet> machine # Filesystem UUID: 7dd68229-d3c5-45ed-8604-54372f61f684 vm-test-run-flakelet> machine # Superblock backups stored on blocks: vm-test-run-flakelet> machine # 32768, 98304, 163840, 229376 vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Allocating group tables: 0/8 done vm-test-run-flakelet> machine # Writing inode tables: 0/8 done vm-test-run-flakelet> machine # Creating journal (8192 blocks): done vm-test-run-flakelet> machine # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Virtualisation disk image created. vm-test-run-flakelet> machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BEFD1920+BEF31920 CA00 vm-test-run-flakelet> machine # Press Ctrl-B to configure iPXE (PCI 00:03.0)... vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM BEFD1920 BEF31920 CB00 vm-test-run-flakelet> machine # Press Ctrl-B to configure iPXE (PCI 00:09.0)... vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Booting from ROM... vm-test-run-flakelet> machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Jul 24 14:17:26 UTC 2026 vm-test-run-flakelet> machine # [ 0.000000] Command line: console=ttyS0 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/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test/init regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. vm-test-run-flakelet> machine # [ 0.000000] BIOS-provided physical RAM map: vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdafff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000bffdb000-0x00000000bfffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] NX (Execute Disable) protection: active vm-test-run-flakelet> machine # [ 0.000000] APIC: Static calls initialized vm-test-run-flakelet> machine # [ 0.000000] SMBIOS 2.8 present. vm-test-run-flakelet> machine # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 vm-test-run-flakelet> machine # [ 0.000000] DMI: Memory slots populated: 1/1 vm-test-run-flakelet> machine # [ 0.000000] Hypervisor detected: KVM vm-test-run-flakelet> machine # [ 0.000000] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 vm-test-run-flakelet> machine # [ 0.000001] kvm-clock: using sched offset of 908279662 cycles vm-test-run-flakelet> machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-flakelet> machine # [ 0.000006] tsc: Detected 3099.998 MHz processor vm-test-run-flakelet> machine # [ 0.000721] last_pfn = 0x140000 max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.000747] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs vm-test-run-flakelet> machine # [ 0.000749] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm-test-run-flakelet> machine # [ 0.000790] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.002906] found SMP MP-table at [mem 0x000f5470-0x000f547f] vm-test-run-flakelet> machine # [ 0.002920] Using GB pages for direct mapping vm-test-run-flakelet> machine # [ 0.003015] RAMDISK: [mem 0xbe3b0000-0xbffcffff] vm-test-run-flakelet> machine # [ 0.003022] ACPI: Early table checksum verification disabled vm-test-run-flakelet> machine # [ 0.003026] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) vm-test-run-flakelet> machine # [ 0.003029] ACPI: RSDT 0x00000000BFFE24E3 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003034] ACPI: FACP 0x00000000BFFE237F 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003040] ACPI: DSDT 0x00000000BFFE0040 00233F (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003043] ACPI: FACS 0x00000000BFFE0000 000040 vm-test-run-flakelet> machine # [ 0.003045] ACPI: APIC 0x00000000BFFE23F3 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003047] ACPI: HPET 0x00000000BFFE2483 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003048] ACPI: WAET 0x00000000BFFE24BB 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003050] ACPI: Reserving FACP table memory at [mem 0xbffe237f-0xbffe23f2] vm-test-run-flakelet> machine # [ 0.003051] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe237e] vm-test-run-flakelet> machine # [ 0.003052] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] vm-test-run-flakelet> machine # [ 0.003052] ACPI: Reserving APIC table memory at [mem 0xbffe23f3-0xbffe2482] vm-test-run-flakelet> machine # [ 0.003053] ACPI: Reserving HPET table memory at [mem 0xbffe2483-0xbffe24ba] vm-test-run-flakelet> machine # [ 0.003053] ACPI: Reserving WAET table memory at [mem 0xbffe24bb-0xbffe24e2] vm-test-run-flakelet> machine # [ 0.003434] No NUMA configuration found vm-test-run-flakelet> machine # [ 0.003435] Faking a node at [mem 0x0000000000000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.003438] NODE_DATA(0) allocated [mem 0x13fffa780-0x13ffffcff] vm-test-run-flakelet> machine # [ 0.003532] Zone ranges: vm-test-run-flakelet> machine # [ 0.003533] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm-test-run-flakelet> machine # [ 0.003534] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] vm-test-run-flakelet> machine # [ 0.003535] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.003536] Device empty vm-test-run-flakelet> machine # [ 0.003537] Movable zone start for each node vm-test-run-flakelet> machine # [ 0.003537] Early memory node ranges vm-test-run-flakelet> machine # [ 0.003538] node 0: [mem 0x0000000000001000-0x000000000009efff] vm-test-run-flakelet> machine # [ 0.003539] node 0: [mem 0x0000000000100000-0x00000000bffdafff] vm-test-run-flakelet> machine # [ 0.003540] node 0: [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.003541] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.003560] On node 0, zone DMA: 1 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.003819] On node 0, zone DMA: 97 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.072012] On node 0, zone Normal: 37 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.072853] ACPI: PM-Timer IO Port: 0x608 vm-test-run-flakelet> machine # [ 0.072871] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm-test-run-flakelet> machine # [ 0.072896] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm-test-run-flakelet> machine # [ 0.072899] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm-test-run-flakelet> machine # [ 0.072901] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm-test-run-flakelet> machine # [ 0.072902] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm-test-run-flakelet> machine # [ 0.072904] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm-test-run-flakelet> machine # [ 0.072904] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm-test-run-flakelet> machine # [ 0.072907] ACPI: Using ACPI (MADT) for SMP configuration information vm-test-run-flakelet> machine # [ 0.072909] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm-test-run-flakelet> machine # [ 0.072915] TSC deadline timer available vm-test-run-flakelet> machine # [ 0.072921] CPU topo: Max. logical packages: 1 vm-test-run-flakelet> machine # [ 0.072921] CPU topo: Max. logical dies: 1 vm-test-run-flakelet> machine # [ 0.072922] CPU topo: Max. dies per package: 1 vm-test-run-flakelet> machine # [ 0.072925] CPU topo: Max. threads per core: 1 vm-test-run-flakelet> machine # [ 0.072926] CPU topo: Num. cores per package: 4 vm-test-run-flakelet> machine # [ 0.072927] CPU topo: Num. threads per package: 4 vm-test-run-flakelet> machine # [ 0.072927] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs vm-test-run-flakelet> machine # [ 0.072957] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() vm-test-run-flakelet> machine # [ 0.072976] kvm-guest: KVM setup pv remote TLB flush vm-test-run-flakelet> machine # [ 0.072979] kvm-guest: setup PV sched yield vm-test-run-flakelet> machine # [ 0.072993] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.072995] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm-test-run-flakelet> machine # [ 0.072996] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] vm-test-run-flakelet> machine # [ 0.072999] [mem 0xc0000000-0xfeffbfff] available for PCI devices vm-test-run-flakelet> machine # [ 0.073001] Booting paravirtualized kernel on KVM vm-test-run-flakelet> machine # [ 0.073013] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns vm-test-run-flakelet> machine # [ 0.077818] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 vm-test-run-flakelet> machine # [ 0.080058] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288 vm-test-run-flakelet> machine # [ 0.080113] kvm-guest: PV spinlocks enabled vm-test-run-flakelet> machine # [ 0.080114] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm-test-run-flakelet> machine # [ 0.080117] Kernel command line: console=ttyS0 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/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test/init regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.080216] Unknown kernel command line parameters "regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration", will be passed to user space. vm-test-run-flakelet> machine # [ 0.080238] random: crng init done vm-test-run-flakelet> machine # [ 0.080239] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes vm-test-run-flakelet> machine # [ 0.085049] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-flakelet> machine # [ 0.087114] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-flakelet> machine # [ 0.087211] software IO TLB: area num 4. vm-test-run-flakelet> machine # [ 0.170277] Fallback order for Node 0: 0 vm-test-run-flakelet> machine # [ 0.170292] Built 1 zonelists, mobility grouping on. Total pages: 1048441 vm-test-run-flakelet> machine # [ 0.170296] Policy zone: Normal vm-test-run-flakelet> machine # [ 0.173011] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-flakelet> machine # [ 0.185690] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 vm-test-run-flakelet> machine # [ 0.194507] allocated 8388608 bytes of page_ext vm-test-run-flakelet> machine # [ 0.202665] ftrace: allocating 48619 entries in 192 pages vm-test-run-flakelet> machine # [ 0.202668] ftrace: allocated 192 pages with 2 groups vm-test-run-flakelet> machine # [ 0.203499] Dynamic Preempt: lazy vm-test-run-flakelet> machine # [ 0.203708] rcu: Preemptible hierarchical RCU implementation. vm-test-run-flakelet> machine # [ 0.203709] rcu: RCU event tracing is enabled. vm-test-run-flakelet> machine # [ 0.203709] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.203710] Trampoline variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.203711] Rude variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.203711] Tracing variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.203712] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. vm-test-run-flakelet> machine # [ 0.203712] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 vm-test-run-flakelet> machine # [ 0.203733] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.203735] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.203736] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.208167] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16 vm-test-run-flakelet> machine # [ 0.208461] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-flakelet> machine # [ 0.208469] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns vm-test-run-flakelet> machine # [ 0.208571] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-flakelet> machine # [ 0.214718] Console: colour VGA+ 80x25 vm-test-run-flakelet> machine # [ 0.214723] printk: legacy console [tty0] enabled vm-test-run-flakelet> machine # [ 0.253600] printk: legacy console [ttyS0] enabled vm-test-run-flakelet> machine # [ 0.411521] ACPI: Core revision 20250807 vm-test-run-flakelet> machine # [ 0.412846] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm-test-run-flakelet> machine # [ 0.415068] APIC: Switch to symmetric I/O mode setup vm-test-run-flakelet> machine # [ 0.416418] x2apic enabled vm-test-run-flakelet> machine # [ 0.417410] APIC: Switched APIC routing to: physical x2apic vm-test-run-flakelet> machine # [ 0.418712] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() vm-test-run-flakelet> machine # [ 0.420439] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() vm-test-run-flakelet> machine # [ 0.422520] kvm-guest: setup PV IPIs vm-test-run-flakelet> machine # [ 0.424401] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm-test-run-flakelet> machine # [ 0.425788] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns vm-test-run-flakelet> machine # [ 0.428126] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) vm-test-run-flakelet> machine # [ 0.430212] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm-test-run-flakelet> machine # [ 0.431280] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 vm-test-run-flakelet> machine # [ 0.432124] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 vm-test-run-flakelet> machine # [ 0.433133] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto vm-test-run-flakelet> machine # [ 0.434129] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl vm-test-run-flakelet> machine # [ 0.435127] Spectre V2 : Mitigation: Retpolines vm-test-run-flakelet> machine # [ 0.436124] RETBleed: Mitigation: untrained return thunk vm-test-run-flakelet> machine # [ 0.437124] Speculative Return Stack Overflow: Mitigation: SMT disabled vm-test-run-flakelet> machine # [ 0.439124] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm-test-run-flakelet> machine # [ 0.440129] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT vm-test-run-flakelet> machine # [ 0.441124] Spectre V2 : Enabling Speculation Barrier for firmware calls vm-test-run-flakelet> machine # [ 0.442123] active return thunk: retbleed_return_thunk vm-test-run-flakelet> machine # [ 0.444129] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm-test-run-flakelet> machine # [ 0.445139] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm-test-run-flakelet> machine # [ 0.446123] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm-test-run-flakelet> machine # [ 0.448123] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm-test-run-flakelet> machine # [ 0.449137] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm-test-run-flakelet> machine # [ 0.450124] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. vm-test-run-flakelet> machine # [ 0.470275] Freeing SMP alternatives memory: 44K vm-test-run-flakelet> machine # [ 0.471126] pid_max: default: 32768 minimum: 301 vm-test-run-flakelet> machine # [ 0.472213] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-flakelet> machine # [ 0.474129] landlock: Up and running. vm-test-run-flakelet> machine # [ 0.475066] Yama: becoming mindful. vm-test-run-flakelet> machine # [ 0.476223] LSM support for eBPF active vm-test-run-flakelet> machine # [ 0.477313] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.478220] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.480828] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) vm-test-run-flakelet> machine # [ 0.481684] Performance Events: Fam17h+ core perfctr, AMD PMU driver. vm-test-run-flakelet> machine # [ 0.482127] ... version: 0 vm-test-run-flakelet> machine # [ 0.483124] ... bit width: 48 vm-test-run-flakelet> machine # [ 0.484134] ... generic counters: 6 vm-test-run-flakelet> machine # [ 0.485124] ... generic bitmap: 000000000000003f vm-test-run-flakelet> machine # [ 0.486124] ... fixed-purpose counters: 0 vm-test-run-flakelet> machine # [ 0.487124] ... fixed-purpose bitmap: 0000000000000000 vm-test-run-flakelet> machine # [ 0.488124] ... value mask: 0000ffffffffffff vm-test-run-flakelet> machine # [ 0.489125] ... max period: 00007fffffffffff vm-test-run-flakelet> machine # [ 0.490125] ... global_ctrl mask: 000000000000003f vm-test-run-flakelet> machine # [ 0.491230] signal: max sigframe size: 1776 vm-test-run-flakelet> machine # [ 0.492276] rcu: Hierarchical SRCU implementation. vm-test-run-flakelet> machine # [ 0.493129] rcu: Max phase no-delay instances is 400. vm-test-run-flakelet> machine # [ 0.494264] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-flakelet> machine # [ 0.498461] smp: Bringing up secondary CPUs ... vm-test-run-flakelet> machine # [ 0.499473] smpboot: x86: Booting SMP configuration: vm-test-run-flakelet> machine # [ 0.500126] .... node #0, CPUs: #1 #2 #3 vm-test-run-flakelet> machine # [ 0.501191] smp: Brought up 1 node, 4 CPUs vm-test-run-flakelet> machine # [ 0.503949] smpboot: Total of 4 processors activated (24799.98 BogoMIPS) vm-test-run-flakelet> machine # [ 0.505339] Memory: 3960144K/4193764K available (17162K kernel code, 2721K rwdata, 13548K rodata, 3640K init, 3012K bss, 218576K reserved, 0K cma-reserved) vm-test-run-flakelet> machine # [ 0.506590] devtmpfs: initialized vm-test-run-flakelet> machine # [ 0.508317] x86/mm: Memory block size: 128MB vm-test-run-flakelet> machine # [ 0.512343] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.514245] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). vm-test-run-flakelet> machine # [ 0.515335] pinctrl core: initialized pinctrl subsystem vm-test-run-flakelet> machine # [ 0.516541] PM: RTC time: 08:42:23, date: 2026-08-31 vm-test-run-flakelet> machine # [ 0.520586] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-flakelet> machine # [ 0.522047] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-flakelet> machine # [ 0.523192] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-flakelet> machine # [ 0.524800] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-flakelet> machine # [ 0.526157] audit: initializing netlink subsys (disabled) vm-test-run-flakelet> machine # [ 0.527211] audit: type=2000 audit(1788165743.795:1): state=initialized audit_enabled=0 res=1 vm-test-run-flakelet> machine # [ 0.527455] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-flakelet> machine # [ 0.528135] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-flakelet> machine # [ 0.529131] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-flakelet> machine # [ 0.530126] thermal_sys: Registered thermal governor 'user_space' vm-test-run-flakelet> machine # [ 0.531127] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-flakelet> machine # [ 0.532173] cpuidle: using governor menu vm-test-run-flakelet> machine # [ 0.535382] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm-test-run-flakelet> machine # [ 0.536506] PCI: Using configuration type 1 for base access vm-test-run-flakelet> machine # [ 0.537127] PCI: Using configuration type 1 for extended access vm-test-run-flakelet> machine # [ 0.538318] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm-test-run-flakelet> machine # [ 0.540164] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.541127] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-flakelet> machine # [ 0.542128] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.543127] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-flakelet> machine # [ 0.546323] ACPI: Added _OSI(Module Device) vm-test-run-flakelet> machine # [ 0.547132] ACPI: Added _OSI(Processor Device) vm-test-run-flakelet> machine # [ 0.548135] ACPI: Added _OSI(Processor Aggregator Device) vm-test-run-flakelet> machine # [ 0.550530] ACPI: 1 ACPI AML tables successfully acquired and loaded vm-test-run-flakelet> machine # [ 0.553320] ACPI: Interpreter enabled vm-test-run-flakelet> machine # [ 0.554150] ACPI: PM: (supports S0 S3 S4 S5) vm-test-run-flakelet> machine # [ 0.555130] ACPI: Using IOAPIC for interrupt routing vm-test-run-flakelet> machine # [ 0.556222] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm-test-run-flakelet> machine # [ 0.557131] PCI: Using E820 reservations for host bridge windows vm-test-run-flakelet> machine # [ 0.558310] ACPI: Enabled 2 GPEs in block 00 to 0F vm-test-run-flakelet> machine # [ 0.563996] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm-test-run-flakelet> machine # [ 0.565131] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] vm-test-run-flakelet> machine # [ 0.566630] acpiphp: Slot [3] registered vm-test-run-flakelet> machine # [ 0.567164] acpiphp: Slot [4] registered vm-test-run-flakelet> machine # [ 0.568159] acpiphp: Slot [5] registered vm-test-run-flakelet> machine # [ 0.569203] acpiphp: Slot [6] registered vm-test-run-flakelet> machine # [ 0.570160] acpiphp: Slot [7] registered vm-test-run-flakelet> machine # [ 0.571159] acpiphp: Slot [8] registered vm-test-run-flakelet> machine # [ 0.572158] acpiphp: Slot [9] registered vm-test-run-flakelet> machine # [ 0.573200] acpiphp: Slot [10] registered vm-test-run-flakelet> machine # [ 0.574157] acpiphp: Slot [11] registered vm-test-run-flakelet> machine # [ 0.575160] acpiphp: Slot [12] registered vm-test-run-flakelet> machine # [ 0.576154] acpiphp: Slot [13] registered vm-test-run-flakelet> machine # [ 0.577176] acpiphp: Slot [14] registered vm-test-run-flakelet> machine # [ 0.578155] acpiphp: Slot [15] registered vm-test-run-flakelet> machine # [ 0.579195] acpiphp: Slot [16] registered vm-test-run-flakelet> machine # [ 0.580183] acpiphp: Slot [17] registered vm-test-run-flakelet> machine # [ 0.581163] acpiphp: Slot [18] registered vm-test-run-flakelet> machine # [ 0.582183] acpiphp: Slot [19] registered vm-test-run-flakelet> machine # [ 0.583162] acpiphp: Slot [20] registered vm-test-run-flakelet> machine # [ 0.584219] acpiphp: Slot [21] registered vm-test-run-flakelet> machine # [ 0.585171] acpiphp: Slot [22] registered vm-test-run-flakelet> machine # [ 0.586193] acpiphp: Slot [23] registered vm-test-run-flakelet> machine # [ 0.587167] acpiphp: Slot [24] registered vm-test-run-flakelet> machine # [ 0.588206] acpiphp: Slot [25] registered vm-test-run-flakelet> machine # [ 0.589154] acpiphp: Slot [26] registered vm-test-run-flakelet> machine # [ 0.590154] acpiphp: Slot [27] registered vm-test-run-flakelet> machine # [ 0.591151] acpiphp: Slot [28] registered vm-test-run-flakelet> machine # [ 0.592173] acpiphp: Slot [29] registered vm-test-run-flakelet> machine # [ 0.593150] acpiphp: Slot [30] registered vm-test-run-flakelet> machine # [ 0.594150] acpiphp: Slot [31] registered vm-test-run-flakelet> machine # [ 0.595138] PCI host bridge to bus 0000:00 vm-test-run-flakelet> machine # [ 0.596127] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm-test-run-flakelet> machine # [ 0.597126] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm-test-run-flakelet> machine # [ 0.598125] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm-test-run-flakelet> machine # [ 0.599125] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] vm-test-run-flakelet> machine # [ 0.600125] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] vm-test-run-flakelet> machine # [ 0.601126] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-flakelet> machine # [ 0.602432] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.603834] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.605834] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.608195] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] vm-test-run-flakelet> machine # [ 0.609180] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.610125] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.611125] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.612125] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.613357] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.615182] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] vm-test-run-flakelet> machine # [ 0.616891] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.618645] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm-test-run-flakelet> machine # [ 0.619139] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm-test-run-flakelet> machine # [ 0.620447] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.623191] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] vm-test-run-flakelet> machine # [ 0.624267] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] vm-test-run-flakelet> machine # [ 0.625175] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] vm-test-run-flakelet> machine # [ 0.626337] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm-test-run-flakelet> machine # [ 0.628007] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.630955] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] vm-test-run-flakelet> machine # [ 0.632139] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] vm-test-run-flakelet> machine # [ 0.633177] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.634139] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] vm-test-run-flakelet> machine # [ 0.637045] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.640137] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] vm-test-run-flakelet> machine # [ 0.642140] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] vm-test-run-flakelet> machine # [ 0.643175] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] vm-test-run-flakelet> machine # [ 0.645774] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.649138] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] vm-test-run-flakelet> machine # [ 0.650140] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] vm-test-run-flakelet> machine # [ 0.651194] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] vm-test-run-flakelet> machine # [ 0.653668] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.655910] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] vm-test-run-flakelet> machine # [ 0.657092] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] vm-test-run-flakelet> machine # [ 0.658178] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] vm-test-run-flakelet> machine # [ 0.660845] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.663147] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] vm-test-run-flakelet> machine # [ 0.664138] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] vm-test-run-flakelet> machine # [ 0.665177] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] vm-test-run-flakelet> machine # [ 0.667793] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.671138] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] vm-test-run-flakelet> machine # [ 0.672139] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] vm-test-run-flakelet> machine # [ 0.673185] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] vm-test-run-flakelet> machine # [ 0.676085] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.679158] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] vm-test-run-flakelet> machine # [ 0.680144] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] vm-test-run-flakelet> machine # [ 0.681178] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] vm-test-run-flakelet> machine # [ 0.682139] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] vm-test-run-flakelet> machine # [ 0.684968] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.688162] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] vm-test-run-flakelet> machine # [ 0.689190] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] vm-test-run-flakelet> machine # [ 0.691858] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.695155] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] vm-test-run-flakelet> machine # [ 0.696137] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] vm-test-run-flakelet> machine # [ 0.697169] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] vm-test-run-flakelet> machine # [ 0.699883] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.703159] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] vm-test-run-flakelet> machine # [ 0.704141] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] vm-test-run-flakelet> machine # [ 0.705187] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] vm-test-run-flakelet> machine # [ 0.712347] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm-test-run-flakelet> machine # [ 0.713310] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm-test-run-flakelet> machine # [ 0.714286] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm-test-run-flakelet> machine # [ 0.715274] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm-test-run-flakelet> machine # [ 0.716223] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm-test-run-flakelet> machine # [ 0.718613] iommu: Default domain type: Translated vm-test-run-flakelet> machine # [ 0.720126] iommu: DMA domain TLB invalidation policy: lazy mode vm-test-run-flakelet> machine # [ 0.721337] ACPI: bus type USB registered vm-test-run-flakelet> machine # [ 0.722198] usbcore: registered new interface driver usbfs vm-test-run-flakelet> machine # [ 0.723150] usbcore: registered new interface driver hub vm-test-run-flakelet> machine # [ 0.724167] usbcore: registered new device driver usb vm-test-run-flakelet> machine # [ 0.726341] NetLabel: Initializing vm-test-run-flakelet> machine # [ 0.727126] NetLabel: domain hash size = 128 vm-test-run-flakelet> machine # [ 0.728127] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm-test-run-flakelet> machine # [ 0.729180] NetLabel: unlabeled traffic allowed by default vm-test-run-flakelet> machine # [ 0.730141] PCI: Using ACPI for IRQ routing vm-test-run-flakelet> machine # [ 0.731704] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm-test-run-flakelet> machine # [ 0.732120] pci 0000:00:02.0: vgaarb: bridge control possible vm-test-run-flakelet> machine # [ 0.732120] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm-test-run-flakelet> machine # [ 0.732135] vgaarb: loaded vm-test-run-flakelet> machine # [ 0.733257] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm-test-run-flakelet> machine # [ 0.734125] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm-test-run-flakelet> machine # [ 0.738232] clocksource: Switched to clocksource kvm-clock vm-test-run-flakelet> machine # [ 0.740102] VFS: Disk quotas dquot_6.6.0 vm-test-run-flakelet> machine # [ 0.741108] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-flakelet> machine # [ 0.742937] pnp: PnP ACPI init vm-test-run-flakelet> machine # [ 0.744203] pnp: PnP ACPI: found 6 devices vm-test-run-flakelet> machine # [ 0.752073] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm-test-run-flakelet> machine # [ 0.754289] clocksource: Switched to clocksource acpi_pm vm-test-run-flakelet> machine # [ 0.755845] NET: Registered PF_INET protocol family vm-test-run-flakelet> machine # [ 0.757812] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-flakelet> machine # [ 0.776321] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.778893] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.781495] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.784970] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-flakelet> machine # [ 0.786854] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-flakelet> machine # [ 0.788732] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-flakelet> machine # [ 0.790646] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.792362] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.794410] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-flakelet> machine # [ 0.795854] NET: Registered PF_XDP protocol family vm-test-run-flakelet> machine # [ 0.797109] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm-test-run-flakelet> machine # [ 0.798607] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm-test-run-flakelet> machine # [ 0.800144] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm-test-run-flakelet> machine # [ 0.801781] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] vm-test-run-flakelet> machine # [ 0.803434] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] vm-test-run-flakelet> machine # [ 0.805341] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm-test-run-flakelet> machine # [ 0.806973] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm-test-run-flakelet> machine # [ 0.809417] ACPI: \_SB_.LNKD: Enabled at IRQ 11 vm-test-run-flakelet> machine # [ 0.811926] PCI: CLS 0 bytes, default 64 vm-test-run-flakelet> machine # [ 0.813031] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) vm-test-run-flakelet> machine # [ 0.813261] Trying to unpack rootfs image as initramfs... vm-test-run-flakelet> machine # [ 0.813311] software IO TLB: mapped [mem 0x00000000ba3b0000-0x00000000be3b0000] (64MB) vm-test-run-flakelet> machine # [ 0.818044] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns vm-test-run-flakelet> machine # [ 0.835817] Initialise system trusted keyrings vm-test-run-flakelet> machine # [ 0.837501] workingset: timestamp_bits=40 max_order=20 bucket_order=0 vm-test-run-flakelet> machine # [ 0.851000] Key type asymmetric registered vm-test-run-flakelet> machine # [ 0.852066] Asymmetric key parser 'x509' registered vm-test-run-flakelet> machine # [ 0.853475] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) vm-test-run-flakelet> machine # [ 0.855636] io scheduler mq-deadline registered vm-test-run-flakelet> machine # [ 0.856892] io scheduler kyber registered vm-test-run-flakelet> machine # [ 0.862371] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-flakelet> machine # [ 0.864377] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm-test-run-flakelet> machine # [ 0.867762] Linux agpgart interface v0.103 vm-test-run-flakelet> machine # [ 0.869083] ACPI: bus type drm_connector registered vm-test-run-flakelet> machine # [ 0.872357] usbcore: registered new interface driver usbserial_generic vm-test-run-flakelet> machine # [ 0.874363] usbserial: USB Serial support registered for generic vm-test-run-flakelet> machine # [ 0.876227] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled vm-test-run-flakelet> machine # [ 0.878624] drop_monitor: Initializing network drop monitor service vm-test-run-flakelet> machine # [ 0.880393] NET: Registered PF_INET6 protocol family vm-test-run-flakelet> machine # [ 0.882823] Segment Routing with IPv6 vm-test-run-flakelet> machine # [ 0.884159] In-situ OAM (IOAM) with IPv6 vm-test-run-flakelet> machine # [ 0.887190] IPI shorthand broadcast: enabled vm-test-run-flakelet> machine # [ 0.891491] sched_clock: Marking stable (681028783, 209652491)->(1038329135, -147647861) vm-test-run-flakelet> machine # [ 0.894393] registered taskstats version 1 vm-test-run-flakelet> machine # [ 0.895961] Loading compiled-in X.509 certificates vm-test-run-flakelet> machine # [ 0.905800] Demotion targets for Node 0: null vm-test-run-flakelet> machine # [ 0.907436] Key type .fscrypt registered vm-test-run-flakelet> machine # [ 0.908810] Key type fscrypt-provisioning registered vm-test-run-flakelet> machine # [ 0.910479] ima: No TPM chip found, activating TPM-bypass! vm-test-run-flakelet> machine # [ 0.912167] ima: Allocated hash algorithm: sha1 vm-test-run-flakelet> machine # [ 0.913548] ima: No architecture policies found vm-test-run-flakelet> machine # [ 0.915023] PM: Magic number: 6:873:726 vm-test-run-flakelet> machine # [ 0.917223] RAS: Correctable Errors collector initialized. vm-test-run-flakelet> machine # [ 0.922694] clk: Disabling unused clocks vm-test-run-flakelet> machine # [ 0.923914] PM: genpd: Disabling unused power domains vm-test-run-flakelet> machine # [ 1.123812] Freeing initrd memory: 28800K vm-test-run-flakelet> machine # [ 1.128130] Freeing unused decrypted memory: 2028K vm-test-run-flakelet> machine # [ 1.131223] Freeing unused kernel image (initmem) memory: 3640K vm-test-run-flakelet> machine # [ 1.132768] Write protecting the kernel read-only data: 32768k vm-test-run-flakelet> machine # [ 1.135443] Freeing unused kernel image (text/rodata gap) memory: 1268K vm-test-run-flakelet> machine # [ 1.137941] Freeing unused kernel image (rodata/data gap) memory: 788K vm-test-run-flakelet> machine # [ 1.173206] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm-test-run-flakelet> machine # [ 1.174781] Run /init as init process vm-test-run-flakelet> machine # [ 1.185140] systemd[1]: Inserted module 'autofs4' vm-test-run-flakelet> machine # [ 1.205876] fuse: init (API version 7.45) vm-test-run-flakelet> machine # [ 1.213698] ACPI: \_SB_.LNKC: Enabled at IRQ 10 vm-test-run-flakelet> machine # [ 1.220558] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm-test-run-flakelet> machine # [ 1.224033] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm-test-run-flakelet> machine # [ 1.264230] systemd[1]: Successfully made /usr/ read-only. vm-test-run-flakelet> machine # [ 1.601094] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) vm-test-run-flakelet> machine # [ 1.610343] systemd[1]: Detected virtualization kvm. vm-test-run-flakelet> machine # [ 1.612071] systemd[1]: Detected architecture x86-64. vm-test-run-flakelet> machine # [ 1.613243] systemd[1]: Running in initrd. vm-test-run-flakelet> machine # [ 1.614463] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 1.616074] systemd[1]: Hostname set to . vm-test-run-flakelet> machine # [ 1.701110] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 1.733454] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-flakelet> machine # [ 1.753706] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 1.755349] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 1.757341] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 1.758948] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 1.760210] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 1.761493] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 1.762694] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 1.764135] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 1.765858] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-flakelet> machine # [ 1.767452] systemd[1]: Listening on Journal Sockets. vm-test-run-flakelet> machine # [ 1.768874] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 1.770355] systemd[1]: Listening on udev Kernel Socket. vm-test-run-flakelet> machine # [ 1.771795] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 1.774098] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 1.776402] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 1.778780] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-flakelet> machine # [ 1.781988] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 1.784132] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 1.785677] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 1.788917] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 1.794569] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 1.798305] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.805952] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-flakelet> machine # [ 1.805997] systemd-journald[92]: Collecting audit messages is disabled. vm-test-run-flakelet> machine # [ 1.807046] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config vm-test-run-flakelet> machine # [ 1.807413] netfs: FS-Cache loaded vm-test-run-flakelet> machine # [ 1.816038] 9pnet: Installing 9P2000 support vm-test-run-flakelet> machine # [ 1.819468] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 1.824379] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-flakelet> machine # [ 1.828580] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.831717] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-flakelet> machine # [ 1.834399] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 1.837414] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 1.839934] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 1.843821] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 1.852087] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 1.855711] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 1.860382] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 1.862345] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 1.654291] s[ 1.864229] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # ystemd-modules-load[93]: Using 4 probe threads vm-test-run-flakelet> machine # [ 1.657282] s[ 1.866607] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # ystemd-modules-load[93]: Inserted module 'virtio[ 1.868576] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # _balloon' vm-test-run-flakelet> machine # [ 1.660820] systemd-modules-load[93]: Inserted module 'virtio_gpu' vm-test-run-flakelet> machine # [ 1.662462] systemd-modules-load[93]: Inserted module 'dm_mod' vm-test-run-flakelet> machine # [ 1.663791] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 1.674068] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 1.684285] systemd-udevd[105]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 1.687142] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 1.698237] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 1.699960] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 1.701268] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 2.035623] uhci_hcd 0000:00:01.2: UHCI Host Controller vm-test-run-flakelet> machine # [ 2.036819] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 vm-test-run-flakelet> machine # [ 2.038358] uhci_hcd 0000:00:01.2: detected 2 ports vm-test-run-flakelet> machine # [ 2.039590] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 vm-test-run-flakelet> machine # [ 2.041076] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 vm-test-run-flakelet> machine # [ 2.042674] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 vm-test-run-flakelet> machine # [ 2.044155] usb usb1: Product: UHCI Host Controller vm-test-run-flakelet> machine # [ 2.045161] usb usb1: Manufacturer: Linux 6.18.40 uhci_hcd vm-test-run-flakelet> machine # [ 2.046336] usb usb1: SerialNumber: 0000:00:01.2 vm-test-run-flakelet> machine # [ 2.049065] hub 1-0:1.0: USB hub found vm-test-run-flakelet> machine # [ 2.050796] hub 1-0:1.0: 2 ports detected vm-test-run-flakelet> machine # [ 2.064227] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm-test-run-flakelet> machine # [ 2.068908] serio: i8042 KBD port at 0x60,0x64 irq 1 vm-test-run-flakelet> machine # [ 2.071122] SCSI subsystem initialized vm-test-run-flakelet> machine # [ 2.071169] serio: i8042 AUX port at 0x60,0x64 irq 12 vm-test-run-flakelet> machine # [ 2.076862] virtio_blk virtio5: 4/0/0 default/read/poll queues vm-test-run-flakelet> machine # [ 2.081108] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-flakelet> machine # [ 1.898830] (udev-worker)[128]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.109723] scsi host0: ata_piix vm-test-run-flakelet> machine # [ 2.113036] scsi host1: ata_piix vm-test-run-flakelet> machine # [ 2.114249] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 vm-test-run-flakelet> machine # [ 2.116083] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 vm-test-run-flakelet> machine # [ 1.912802] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 1.917370] (udev-worker)[143]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 1.921199] (udev-worker)[143]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 1.931367] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 1.932789] systemd[1]: Reached target Initrd Root Device. vm-test-run-flakelet> machine # [ 1.934133] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 1.938738] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 1.943859] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 1.955720] systemd-fsck[158]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-flakelet> machine # [ 1.958717] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.273802] usb 1-1: new full-speed USB device number 2 using uhci_hcd vm-test-run-flakelet> machine # [ 2.274236] ata2: found unknown device (class 0) vm-test-run-flakelet> machine # [ 2.277096] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm-test-run-flakelet> machine # [ 2.280018] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm-test-run-flakelet> machine # [ 2.303339] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 vm-test-run-flakelet> machine # [ 2.328714] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm-test-run-flakelet> machine # [ 2.355271] cdrom: Uniform CD-ROM driver Revision: 3.20 vm-test-run-flakelet> machine # [ 2.440318] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 vm-test-run-flakelet> machine # [ 2.442210] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 vm-test-run-flakelet> machine # [ 2.443626] usb 1-1: Product: QEMU USB Tablet vm-test-run-flakelet> machine # [ 2.444528] usb 1-1: Manufacturer: QEMU vm-test-run-flakelet> machine # [ 2.445322] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 vm-test-run-flakelet> machine # [ 2.460468] hid: raw HID events driver (C) Jiri Kosina vm-test-run-flakelet> machine # [ 2.469163] usbcore: registered new interface driver usbhid vm-test-run-flakelet> machine # [ 2.470665] usbhid: USB HID core driver vm-test-run-flakelet> machine # [ 2.479479] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 vm-test-run-flakelet> machine # [ 2.482586] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 vm-test-run-flakelet> machine # [ 2.585349] systemd[1]: Mounting /sysroot... vm-test-run-flakelet> machine # [ 2.907707] EXT4-fs (vda): mounted filesystem 7dd68229-d3c5-45ed-8604-54372f61f684 r/w with ordered data mode. Quota mode: none. vm-test-run-flakelet> machine # [ 2.702584] systemd[1]: Mounted /sysroot. vm-test-run-flakelet> machine # [ 2.703714] systemd[1]: Reached target Initrd Root File System. vm-test-run-flakelet> machine # [ 2.705359] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-flakelet> machine # [ 2.707968] systemd[1]: Mounting /sysroot/run... vm-test-run-flakelet> machine # [ 2.709159] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-flakelet> machine # [ 2.710318] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-flakelet> machine # [ 2.726294] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-flakelet> machine # [ 2.730367] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.732185] systemd[1]: Mounted /sysroot/run. vm-test-run-flakelet> machine # [ 2.943962] 9p: Installing v9fs 9p2000 file system support vm-test-run-flakelet> machine # [ 2.738801] systemd-sysroot-fstab-check[178]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-flakelet> machine # [ 2.741301] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-flakelet> machine # [ 2.742519] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.743909] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.745080] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-flakelet> machine # [ 2.746099] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-flakelet> machine # [ 2.747069] systemd[1]: Reload requested from client PID 178 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-flakelet> machine # [ 2.749158] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 2.798925] systemd[1]: Reloading finished in 53 ms. vm-test-run-flakelet> machine # [ 2.817419] systemd-sysroot-fstab-check[178]: Requesting initrd-fs.target/start/replace... vm-test-run-flakelet> machine # [ 2.821882] systemd-sysroot-fstab-check[178]: Requesting swap.target/start/replace... vm-test-run-flakelet> machine # [ 2.823712] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.825057] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.826460] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-flakelet> machine # [ 2.827776] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-flakelet> machine # [ 2.839408] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.840974] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.585428] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-flakelet> machine # [ 3.610283] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-flakelet> machine # [ 3.611470] systemd[1]: Reached target Initrd File Systems. vm-test-run-flakelet> machine # [ 3.612728] systemd[1]: Starting Find NixOS closure... vm-test-run-flakelet> machine # [ 3.613967] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-flakelet> machine # [ 3.626281] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.628591] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.631948] systemd[1]: Finished Find NixOS closure. vm-test-run-flakelet> machine # [ 3.634729] systemd[1]: Reached target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.637130] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-flakelet> machine # [ 3.657103] systemd[1]: Stopped target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.658378] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 3.659494] systemd[1]: Stopped target Initrd Root Device. vm-test-run-flakelet> machine # [ 3.660701] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 3.661800] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.663549] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 3.665312] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 3.668160] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 3.670149] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 3.671315] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 3.672251] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 3.673296] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.674500] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 3.675717] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.677246] systemd[1]: Stopped Find NixOS closure. vm-test-run-flakelet> machine # [ 3.678326] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-flakelet> machine # [ 3.680670] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 3.682225] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.683767] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 3.684816] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.686216] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 3.687329] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.688862] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.690352] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.691779] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 3.693093] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 3.694186] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 3.695460] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.696771] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 3.697797] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 3.699193] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.700564] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.701558] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.702961] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-flakelet> machine # [ 3.704268] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.705583] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 3.707059] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.708690] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.709804] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.711156] systemd[1]: Closed udev Control Socket. vm-test-run-flakelet> machine # [ 3.712145] systemd[1]: Starting Cleanup udev Database... vm-test-run-flakelet> machine # [ 3.713240] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.714819] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 3.716066] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.717772] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 3.719264] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.720734] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 3.722074] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.723694] systemd[1]: Finished Cleanup udev Database. vm-test-run-flakelet> machine # [ 3.724966] systemd[1]: Reached target Switch Root. vm-test-run-flakelet> machine # [ 3.726166] systemd[1]: Starting NixOS Activation... vm-test-run-flakelet> machine # [ 3.879657] initrd-nixos-activation-start[223]: booting system configuration /nix/store/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test vm-test-run-flakelet> machine # [ 3.932082] initrd-nixos-activation-start[223]: running activation script... vm-test-run-flakelet> machine # [ 4.357637] initrd-nixos-activation-start[246]: setting up /etc... vm-test-run-flakelet> machine # [ 4.628508] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 4.630245] systemd[1]: Finished NixOS Activation. vm-test-run-flakelet> machine # [ 4.631403] systemd[1]: Starting Switch Root... vm-test-run-flakelet> machine # [ 4.646055] systemd[1]: Switching root. vm-test-run-flakelet> machine # [ 4.911988] systemd-journald[92]: Received SIGTERM from PID 1 (systemd). vm-test-run-flakelet> machine # [ 5.034659] NET: Registered PF_VSOCK protocol family vm-test-run-flakelet> machine # [ 5.432164] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) vm-test-run-flakelet> machine # [ 5.437644] systemd[1]: Detected virtualization kvm. vm-test-run-flakelet> machine # [ 5.438682] systemd[1]: Detected architecture x86-64. vm-test-run-flakelet> machine # [ 5.439890] systemd[1]: Detected first boot. vm-test-run-flakelet> machine # [ 5.443398] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 5.562383] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 5.658871] systemd[1]: Applying preset policy. vm-test-run-flakelet> machine # [ 6.107817] systemd[1]: Populated /etc with preset unit settings. vm-test-run-flakelet> machine # [ 6.760810] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.764551] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-flakelet> machine # [ 6.769810] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-flakelet> machine # [ 6.773050] systemd[1]: Created slice Slice /system/getty. vm-test-run-flakelet> machine # [ 6.775181] systemd[1]: Created slice User and Session Slice. vm-test-run-flakelet> machine # [ 6.776758] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 6.778521] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 6.780174] systemd[1]: Expecting device /dev/hvc0... vm-test-run-flakelet> machine # [ 6.781319] systemd[1]: Expecting device /dev/ttyS0... vm-test-run-flakelet> machine # [ 6.782816] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 6.784667] systemd[1]: Reached target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 6.786523] systemd[1]: Stopped target initrd-fs.target. vm-test-run-flakelet> machine # [ 6.787835] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-flakelet> machine # [ 6.789404] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-flakelet> machine # [ 6.790898] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 6.792532] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 6.793795] systemd[1]: Reached target Remote File Systems. vm-test-run-flakelet> machine # [ 6.795192] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 6.796444] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 6.802590] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-flakelet> machine # [ 6.808138] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-flakelet> machine # [ 6.812009] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-flakelet> machine # [ 6.816087] systemd[1]: Listening on Factory Reset Management. vm-test-run-flakelet> machine # [ 6.817502] systemd[1]: Listening on Hostname Service Socket. vm-test-run-flakelet> machine # [ 6.822452] systemd[1]: Starting Journal Log Access Socket... vm-test-run-flakelet> machine # [ 6.825154] systemd[1]: Listening on Journal Audit Socket. vm-test-run-flakelet> machine # [ 6.830435] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 6.832268] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 6.834755] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.836994] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-flakelet> machine # [ 6.847020] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 6.849041] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 6.850389] systemd[1]: Listening on udev Varlink Socket. vm-test-run-flakelet> machine # [ 6.855039] systemd[1]: Mounting Huge Pages File System... vm-test-run-flakelet> machine # [ 6.858979] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-flakelet> machine # [ 6.863257] systemd[1]: Mounting Kernel Debug File System... vm-test-run-flakelet> machine # [ 6.874590] systemd[1]: Mounting Kernel Trace File System... vm-test-run-flakelet> machine # [ 6.879447] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 6.881295] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-flakelet> machine # [ 6.889113] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-flakelet> machine # [ 6.892790] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-flakelet> machine # [ 6.897365] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 6.903131] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-flakelet> machine # [ 6.919425] systemd[1]: Mounting FUSE Control File System... vm-test-run-flakelet> machine # [ 6.921680] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-flakelet> machine # [ 6.931870] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 6.937778] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 6.948521] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 6.960179] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-flakelet> machine # [ 6.962882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.971416] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 6.977564] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-flakelet> machine # [ 6.981369] systemd[1]: Mounted Huge Pages File System. vm-test-run-flakelet> machine # [ 6.985226] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-flakelet> machine # [ 6.988079] systemd[1]: Mounted Kernel Debug File System. vm-test-run-flakelet> machine # [ 6.992183] systemd[1]: Mounted Kernel Trace File System. vm-test-run-flakelet> machine # [ 6.995432] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 6.998952] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.000327] systemd-journald[316]: Collecting audit messages is enabled. vm-test-run-flakelet> machine # [ 7.002968] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-flakelet> machine # [ 7.005564] systemd[1]: Mounted FUSE Control File System. vm-test-run-flakelet> machine # [ 7.007721] EXT4-fs (vda): re-mounted 7dd68229-d3c5-45ed-8604-54372f61f684. vm-test-run-flakelet> machine # [ 7.011462] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 7.012084] loop: module loaded vm-test-run-flakelet> machine # [ 7.018843] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 7.023743] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 7.025812] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 6.818101] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-flakelet> machine # [ 6.821808] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.824763] systemd-modules-load[317]: Using 2 probe threads vm-test-run-flakelet> machine # [ 6.827290] systemd-modules-load[317]: Inserted module 'loop' vm-test-run-flakelet> machine # [ 6.829260] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 6.831309] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 6.834279] systemd[1]: Starting Firewall... vm-test-run-flakelet> machine # [ 6.836779] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-flakelet> machine # [ 6.839509] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 6.844728] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 6.851369] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 6.853369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.856490] systemd-oomd[319]: No swap; memory pressure usage will be degraded vm-test-run-flakelet> machine # [ 6.864448] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 6.868993] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 7.086281] systemd-journald[316]: Received client request to flush runtime journal. vm-test-run-flakelet> machine # [ 6.958372] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 6.961709] systemd[1]: Reached target First Boot Complete. vm-test-run-flakelet> machine # [ 6.963855] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 6.965773] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 6.968297] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 6.970830] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 6.972568] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-flakelet> machine # [ 6.999698] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 7.001657] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 7.004619] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 7.075846] systemd-udevd[353]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 7.212268] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 7.301508] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-flakelet> machine # [ 7.320894] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-flakelet> machine # [ 7.342464] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. vm-test-run-flakelet> machine # [ 7.345937] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 7.352127] (udev-worker)[400]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 7.356917] (udev-worker)[400]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 7.394218] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-flakelet> machine # [ 7.396726] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 7.401079] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-flakelet> machine # [ 7.405842] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 7.409791] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 7.412219] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 7.634503] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 vm-test-run-flakelet> machine # [ 7.640021] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console vm-test-run-flakelet> machine # [ 7.644011] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 vm-test-run-flakelet> machine # [ 7.644100] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD vm-test-run-flakelet> machine # [ 7.645140] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 vm-test-run-flakelet> machine # [ 7.651378] Console: switching to colour dummy device 80x25 vm-test-run-flakelet> machine # [ 7.657537] [drm] Found bochs VGA, ID 0xb0c5. vm-test-run-flakelet> machine # [ 7.657540] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. vm-test-run-flakelet> machine # [ 7.659851] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 vm-test-run-flakelet> machine # [ 7.663069] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic vm-test-run-flakelet> machine # [ 7.664667] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 vm-test-run-flakelet> machine # [ 7.666988] mousedev: PS/2 mouse device common for all mice vm-test-run-flakelet> machine # [ 7.671263] ACPI: button: Power Button [PWRF] vm-test-run-flakelet> machine # [ 7.690693] rtc_cmos 00:05: RTC can wake from S4 vm-test-run-flakelet> machine # [ 7.692491] Console: switching to colour frame buffer device 160x50 vm-test-run-flakelet> machine # [ 7.695025] rtc_cmos 00:05: registered as rtc0 vm-test-run-flakelet> machine # [ 7.695581] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device vm-test-run-flakelet> machine # [ 7.697429] rtc_cmos 00:05: setting system clock to 2026-08-31T08:42:30 UTC (1788165750) vm-test-run-flakelet> machine # [ 7.705317] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 vm-test-run-flakelet> machine # [ 7.706082] Floppy drive(s): fd0 is 2.88M AMI BIOS vm-test-run-flakelet> machine # [ 7.708997] systemd-journald[316]: Time jumped backwards, rotating. vm-test-run-flakelet> machine # [ 7.716835] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm-test-run-flakelet> machine # [ 7.724498] parport_pc 00:03: reported by Plug and Play ACPI vm-test-run-flakelet> machine # [ 7.728131] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] vm-test-run-flakelet> machine # [ 7.733420] FDC 0 is a S82078B vm-test-run-flakelet> machine # [ 7.563403] systemd[1]: Mounting /run/wrappers... vm-test-run-flakelet> machine # [ 7.610259] systemd[1]: Mounted /run/wrappers. vm-test-run-flakelet> machine # [ 7.613835] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 7.618915] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-flakelet> machine # [ 7.622072] systemd[1]: Starting register-nix-paths.service... vm-test-run-flakelet> machine # [ 7.628239] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-flakelet> machine # [ 7.629853] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 7.638191] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-flakelet> machine # [ 7.641478] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 7.856624] ppdev: user-space parallel port driver vm-test-run-flakelet> machine # [ 7.668703] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 7.695555] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.700228] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 7.710694] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-flakelet> machine # [ 7.720241] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 7.747247] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 7.774104] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-flakelet> machine # [ 7.781523] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 8.065406] kvm_amd: TSC scaling supported vm-test-run-flakelet> machine # [ 8.067134] kvm_amd: Nested Virtualization enabled vm-test-run-flakelet> machine # [ 8.069683] kvm_amd: Nested Paging enabled vm-test-run-flakelet> machine # [ 8.071123] kvm_amd: LBR virtualization supported vm-test-run-flakelet> machine # [ 8.073776] kvm_amd: Virtual VMLOAD VMSAVE supported vm-test-run-flakelet> machine # [ 8.075831] kvm_amd: Virtual GIF supported vm-test-run-flakelet> machine # [ 7.868615] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 8.133462] EDAC MC: Ver: 3.0.0 vm-test-run-flakelet> machine # [ 7.924150] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-flakelet> machine # [ 7.931473] systemd[1]: Starting Update is Completed... vm-test-run-flakelet> machine # [ 7.964300] systemd[1]: Finished Update is Completed. vm-test-run-flakelet> machine # [ 8.190192] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.193077] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-flakelet> machine # [ 8.215593] systemd[1]: Finished Firewall. vm-test-run-flakelet> machine # [ 8.330551] systemd-vconsole-setup[465]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 8.333966] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 8.551698] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.775390] systemd[1]: Finished register-nix-paths.service. vm-test-run-flakelet> machine # [ 8.776995] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 8.778647] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 8.780504] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 8.782215] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 8.784983] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 8.787702] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-flakelet> machine # [ 8.790057] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 8.792452] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 8.795468] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 8.797047] systemd[1]: Started backdoor.service. vm-test-run-flakelet> machine # [ 8.799449] systemd[1]: Starting Re-link flakelet services at boot... vm-test-run-flakelet> machine # [ 8.804694] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-flakelet> machine # [ 8.807881] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 8.810793] systemd[1]: Starting Post-Boot Actions... vm-test-run-flakelet> machine # [ 8.814881] systemd[1]: Started Reset console on configuration changes. vm-test-run-flakelet> machine # [ 8.817093] systemd[1]: Starting resolvconf update... vm-test-run-flakelet> machine # [ 8.827131] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 8.862911] systemd[1]: Finished Post-Boot Actions. vm-test-run-flakelet> machine # [ 8.881231] systemd[1]: Finished Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 8.884639] systemd[1]: Starting Reconcile flakelet services with the host configuration... vm-test-run-flakelet> machine # connecting to host... vm-test-run-flakelet> machine # [ 8.917355] nsncd[571]: Aug 31 08:42:31.927 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 8.919352] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 8.920948] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-flakelet> machine # [ 8.924781] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 8.925230] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 8.930322] systemd[1]: Starting User Login Management... vm-test-run-flakelet> machine: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-flakelet> machine # [ 8.966258] systemd[1]: Finished Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine: connected to guest root shell vm-test-run-flakelet> machine: (connecting took 10.24 seconds) vm-test-run-flakelet> machine: (finished: waiting for the VM to finish booting, in 10.40 seconds) vm-test-run-flakelet> machine # [ 9.012420] dbus-broker-launch[576]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-flakelet> machine # [ 9.037208] systemd-logind[598]: New seat seat0. vm-test-run-flakelet> machine # [ 9.039616] dbus-broker-launch[576]: NSS returned no entry for 'systemd-timesync' vm-test-run-flakelet> machine # [ 9.041486] dbus-broker-launch[576]: Invalid user-name in /nix/store/s8hy0z9qrdvs2k3y9dswf360fvwa9n5v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-flakelet> machine # [ 9.042499] systemd-logind[598]: Watching system buttons on /dev/input/event2 (Power Button) vm-test-run-flakelet> machine # [ 9.043898] systemd-logind[598]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-flakelet> machine # [ 9.046493] systemd-logind[598]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) vm-test-run-flakelet> machine # [ 9.054166] systemd[1]: Started User Login Management. vm-test-run-flakelet> machine # [ 9.124918] dbus-broker-launch[576]: Ready vm-test-run-flakelet> machine # [ 9.174905] systemd[1]: Started D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 9.186404] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 9.188488] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-flakelet> machine # [ 9.192870] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 9.195374] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-flakelet> machine # [ 9.198323] systemd[1]: Starting linger-users.service... vm-test-run-flakelet> machine # [ 9.200486] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 9.204856] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 9.209071] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 9.218464] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 9.249253] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 9.250818] systemd[1]: Finished linger-users.service. vm-test-run-flakelet> machine # [ 9.296534] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 9.298625] nsncd[660]: Aug 31 08:42:32.308 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 9.300807] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 9.304864] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 9.306690] systemd[1]: Finished resolvconf update. vm-test-run-flakelet> machine # [ 9.307965] systemd[1]: Reached target Preparation for Network. vm-test-run-flakelet> machine # [ 9.314160] systemd[1]: Starting DHCP Client... vm-test-run-flakelet> machine # [ 9.319061] systemd[1]: Starting Address configuration of eth1... vm-test-run-flakelet> machine # [ 9.323275] systemd[1]: Starting Extra networking commands.... vm-test-run-flakelet> machine # [ 9.427628] network-addresses-eth1-start[683]: adding address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 9.438980] network-addresses-eth1-start[683]: adding address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 9.456444] systemd[1]: Finished Address configuration of eth1. vm-test-run-flakelet> machine # [ 9.464906] dhcpcd[690]: dhcpcd-10.3.2 starting vm-test-run-flakelet> machine # [ 9.475168] dhcpcd[743]: dev: loaded udev vm-test-run-flakelet> machine # [ 9.490661] systemd[1]: Finished Extra networking commands.. vm-test-run-flakelet> machine # [ 9.492474] systemd[1]: Reached target Network. vm-test-run-flakelet> machine # [ 9.496802] systemd[1]: Starting Permit User Sessions... vm-test-run-flakelet> machine # [ 9.501885] systemd[1]: Starting Update flakelet service static... vm-test-run-flakelet> machine # [ 9.714693] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-flakelet> machine # [ 9.715458] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-flakelet> machine # [ 9.511493] systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> machine # [ 9.553137] systemd[1]: Finished Permit User Sessions. vm-test-run-flakelet> machine # [ 9.556076] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 9.562972] systemd[1]: Started Getty on tty1. vm-test-run-flakelet> machine # [ 9.563414] systemd[1]: Reached target Login Prompts. vm-test-run-flakelet> machine # [ 9.569613] flakelet[751]: static: using prebuilt artifact /nix/store/f1dm6yd8wvxg9lz1avfaclh1x8ipjfzy-flakelet-static vm-test-run-flakelet> machine # [ 9.599066] flakelet[752]: web: resolving path:/nix/store/r870dwwpfrafvid6lzzmp8am798blqfd-flake.nix vm-test-run-flakelet> machine # [ 9.606120] flakelet[751]: static: activating generation 1 vm-test-run-flakelet> machine # [ 9.625128] systemd[1]: Reload requested from client PID 757 ('systemctl') (unit flakelet-static.service)... vm-test-run-flakelet> machine # [ 9.625444] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 9.922352] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-flakelet> machine # [ 9.969744] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-flakelet> machine # [ 9.971462] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-flakelet> machine # [ 9.976371] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-flakelet> machine # [ 9.980004] cfg80211: failed to load regulatory.db vm-test-run-flakelet> machine # [ 10.068738] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-flakelet> machine # [ 9.862477] dhcpcd[743]: eth0: waiting for carrier vm-test-run-flakelet> machine # [ 9.862824] dhcpcd[743]: eth0: carrier acquired vm-test-run-flakelet> machine # [ 9.878771] dhcpcd[743]: DUID 00:01:00:01:32:27:fa:f8:52:54:00:12:34:56 vm-test-run-flakelet> machine # [ 9.879168] dhcpcd[743]: eth0: IAID 00:12:34:56 vm-test-run-flakelet> machine # [ 9.879531] dhcpcd[743]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> machine # [ 10.124714] dhcpcd[743]: eth0: soliciting a DHCP lease vm-test-run-flakelet> machine # [ 10.357197] NET: Registered PF_PACKET protocol family vm-test-run-flakelet> machine # [ 10.158974] dhcpcd[743]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-flakelet> machine # [ 10.166378] dhcpcd[743]: eth0: probing address 10.0.2.15/24 vm-test-run-flakelet> machine # [ 10.449220] systemd[1]: Reloading finished in 817 ms. vm-test-run-flakelet> machine # [ 10.547701] systemd[1]: Started Nix Daemon. vm-test-run-flakelet> machine # [ 10.577520] systemd[1]: Reload requested from client PID 823 ('systemctl') (unit flakelet-static.service)... vm-test-run-flakelet> machine # [ 10.578261] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 11.103124] systemd[1]: Reloading finished in 523 ms. vm-test-run-flakelet> machine # [ 11.151682] nix-daemon[819]: accepted connection from pid 756, user flakelet vm-test-run-flakelet> machine # [ 11.159799] systemd[1]: Created slice Slice /system/static-echo. vm-test-run-flakelet> machine # [ 11.162239] systemd[1]: Listening on static-echo@1.socket. vm-test-run-flakelet> machine # [ 11.164330] systemd[1]: Listening on static-echo@2.socket. vm-test-run-flakelet> machine # [ 11.166363] systemd[1]: Listening on static-echo@3.socket. vm-test-run-flakelet> machine # [ 11.169875] systemd[1]: Starting prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 11.193667] systemd[1]: Started prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 11.331236] flakelet[752]: web: evaluating /nix/store/3r6v3rl82jvx862vf4yjps5jl8hj8903-flakelet-driver.nix vm-test-run-flakelet> machine # [ 11.417843] nix-daemon[819]: accepted connection from pid 886, user flakelet vm-test-run-flakelet> machine # [ 11.780570] flakelet[751]: static: updated to generation 1 vm-test-run-flakelet> machine # [ 11.783829] systemd[1]: Finished Update flakelet service static. vm-test-run-flakelet> machine # [ 12.223351] dhcpcd[743]: eth0: soliciting an IPv6 router vm-test-run-flakelet> machine # [ 12.223613] dhcpcd[743]: eth0: Router Advertisement from fe80::2 vm-test-run-flakelet> machine # [ 12.224358] dhcpcd[743]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-flakelet> machine # [ 12.224991] dhcpcd[743]: eth0: adding route to fec0::/64 vm-test-run-flakelet> machine # [ 12.226209] dhcpcd[743]: eth0: adding default route via fe80::2 vm-test-run-flakelet> machine # [ 15.038507] dhcpcd[743]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-flakelet> machine # [ 15.038772] dhcpcd[743]: eth0: adding route to 10.0.2.0/24 vm-test-run-flakelet> machine # [ 15.039549] dhcpcd[743]: eth0: adding default route via 10.0.2.2 vm-test-run-flakelet> machine # [ 15.128207] systemd[1]: Started DHCP Client. vm-test-run-flakelet> machine # [ 17.318857] flakelet[752]: web: building /nix/store/2zh6szjc4gq1miw2nzq090xpvvllzg4a-flakelet-web.drv vm-test-run-flakelet> machine # [ 18.231174] nix-daemon[819]: accepted connection from pid 1119, user flakelet vm-test-run-flakelet> machine # [ 18.251120] flakelet[752]: web: activating generation 1 vm-test-run-flakelet> machine # [ 18.258244] systemd[1]: Reload requested from client PID 1127 ('systemctl') (unit flakelet-web.service)... vm-test-run-flakelet> machine # [ 18.258829] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 18.766935] systemd[1]: Reloading finished in 504 ms. vm-test-run-flakelet> machine # [ 18.868282] systemd[1]: Reload requested from client PID 1169 ('systemctl') (unit flakelet-web.service)... vm-test-run-flakelet> machine # [ 18.868819] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 19.370968] systemd[1]: Reloading finished in 497 ms. vm-test-run-flakelet> machine # [ 19.436458] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 19.461774] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine # [ 19.595416] flakelet[752]: web: updated to generation 1 vm-test-run-flakelet> machine # [ 19.599623] systemd[1]: Finished Update flakelet service web. vm-test-run-flakelet> machine # [ 19.601331] systemd[1]: Reached target flakelet managed services. vm-test-run-flakelet> machine # [ 19.602930] systemd[1]: Reached target Multi-User System. vm-test-run-flakelet> machine # [ 19.604395] systemd[1]: Startup finished in 968ms (kernel) + 3.796s (initrd) + 14.835s (userspace) = 19.600s. vm-test-run-flakelet> machine: (finished: waiting for unit multi-user.target, in 22.00 seconds) vm-test-run-flakelet> machine: must succeed: systemctl start flakelet-web.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl start flakelet-web.service, in 0.05 seconds) vm-test-run-flakelet> Aug 31 08:42:32 machine systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> Aug 31 08:42:32 machine flakelet[752]: web: resolving path:/nix/store/r870dwwpfrafvid6lzzmp8am798blqfd-flake.nix vm-test-run-flakelet> Aug 31 08:42:34 machine flakelet[752]: web: evaluating /nix/store/3r6v3rl82jvx862vf4yjps5jl8hj8903-flakelet-driver.nix vm-test-run-flakelet> Aug 31 08:42:40 machine flakelet[752]: web: building /nix/store/2zh6szjc4gq1miw2nzq090xpvvllzg4a-flakelet-web.drv vm-test-run-flakelet> Aug 31 08:42:41 machine flakelet[752]: web: activating generation 1 vm-test-run-flakelet> Aug 31 08:42:42 machine flakelet[752]: web: updated to generation 1 vm-test-run-flakelet> Aug 31 08:42:42 machine systemd[1]: Finished Update flakelet service web. vm-test-run-flakelet> vm-test-run-flakelet> machine: must succeed: systemctl is-active web.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active web.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello vm-test-run-flakelet> machine: (finished: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json vm-test-run-flakelet> machine: (finished: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json, in 0.01 seconds) vm-test-run-flakelet> machine: must succeed: flakelet status | grep -q '^web' vm-test-run-flakelet> machine: (finished: must succeed: flakelet status | grep -q '^web', in 0.61 seconds) vm-test-run-flakelet> machine: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json vm-test-run-flakelet> machine: (finished: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: systemctl start flakelet-static.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl start flakelet-static.service, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active static.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active static.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: /nix/store/fyamkshpr5rrm5drs7m20ny1k403hqs9-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/static-echo/2.sock vm-test-run-flakelet> machine: (finished: must succeed: /nix/store/fyamkshpr5rrm5drs7m20ny1k403hqs9-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/static-echo/2.sock, in 0.03 seconds) vm-test-run-flakelet> machine: waiting for success: systemctl is-active static-echo@2.service vm-test-run-flakelet> machine # [ 21.474324] systemd[1]: Starting static-echo@2.service... vm-test-run-flakelet> machine # [ 21.504165] systemd[1]: Started static-echo@2.service. vm-test-run-flakelet> machine: (finished: waiting for success: systemctl is-active static-echo@2.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active static-echo@3.socket vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active static-echo@3.socket, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet activate cli /nix/store/baii89wdrajk9r95g2cc7hm7whr7qv2n-flakelet-cli vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/baii89wdrajk9r95g2cc7hm7whr7qv2n-flakelet-cli vm-test-run-flakelet> machine # cli: activating generation 1 vm-test-run-flakelet> machine # [ 21.575779] systemd[1]: Reload requested from client PID 1277 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 21.576351] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 22.023905] systemd[1]: Reloading finished in 446 ms. vm-test-run-flakelet> machine # [ 22.087670] systemd[1]: Reload requested from client PID 1321 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 22.088221] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 22.505119] systemd[1]: Reloading finished in 415 ms. vm-test-run-flakelet> machine # [ 22.545668] systemd[1]: Created slice Slice /system/cli-echo. vm-test-run-flakelet> machine # [ 22.546437] systemd[1]: Listening on cli-echo@1.socket. vm-test-run-flakelet> machine # [ 22.547270] systemd[1]: Listening on cli-echo@2.socket. vm-test-run-flakelet> machine # [ 22.552491] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 22.554873] systemd[1]: Listening on cli-echo@3.socket. vm-test-run-flakelet> machine # [ 22.574720] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet activate cli /nix/store/baii89wdrajk9r95g2cc7hm7whr7qv2n-flakelet-cli, in 1.52 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet status --json | grep -q 'prebuilt:cli' vm-test-run-flakelet> machine: (finished: must succeed: flakelet status --json | grep -q 'prebuilt:cli', in 0.70 seconds) vm-test-run-flakelet> machine: must fail: flakelet activate cli /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken vm-test-run-flakelet> machine # cli: activating generation 2 vm-test-run-flakelet> machine # [ 23.851223] systemd[1]: cli-echo@3.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 23.852055] systemd[1]: Closed cli-echo@3.socket. vm-test-run-flakelet> machine # [ 23.855395] systemd[1]: cli-echo@1.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 23.856092] systemd[1]: Closed cli-echo@1.socket. vm-test-run-flakelet> machine # [ 23.859883] systemd[1]: cli-echo@2.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 23.860910] systemd[1]: Closed cli-echo@2.socket. vm-test-run-flakelet> machine # [ 23.862827] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 23.864763] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 23.866109] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 23.921093] systemd[1]: Reload requested from client PID 1396 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 23.923287] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 24.396859] systemd[1]: Reloading finished in 474 ms. vm-test-run-flakelet> machine # [ 24.470717] systemd[1]: Reload requested from client PID 1438 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 24.471214] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 24.976297] systemd[1]: Reloading finished in 501 ms. vm-test-run-flakelet> machine # [ 25.019223] systemd[1]: Reload requested from client PID 1476 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 25.021826] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 25.513573] systemd[1]: Reloading finished in 492 ms. vm-test-run-flakelet> machine # [ 25.564813] systemd[1]: Reload requested from client PID 1515 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 25.567523] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 25.846474] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/6b22zh5mvlg4arsjd21lk4nz4ckqaicj-cli.service has different name vm-test-run-flakelet> machine # [ 26.056059] systemd[1]: Reloading finished in 489 ms. vm-test-run-flakelet> machine # [ 26.103972] systemd[1]: Starting cli.service... vm-test-run-flakelet> machine # [ 26.123315] (nonexistent)[1555]: cli.service: Unable to locate executable '/nonexistent': No such file or directory vm-test-run-flakelet> machine # [ 26.128668] (nonexistent)[1555]: cli.service: Failed at step EXEC spawning /nonexistent: No such file or directory vm-test-run-flakelet> machine # [ 26.131454] systemd[1]: cli.service: Main process exited, code=exited, status=203/EXEC vm-test-run-flakelet> machine # [ 26.135263] systemd[1]: cli.service: Failed with result 'exit-code'. vm-test-run-flakelet> machine # [ 26.138348] systemd[1]: Failed to start cli.service. vm-test-run-flakelet> machine # [ 26.170172] systemd[1]: Reload requested from client PID 1562 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 26.172671] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 26.635224] systemd[1]: Reloading finished in 463 ms. vm-test-run-flakelet> machine # [ 26.682193] systemd[1]: Reload requested from client PID 1601 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 26.682781] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 27.149481] systemd[1]: Reloading finished in 465 ms. vm-test-run-flakelet> machine # [ 27.191121] systemd[1]: Reload requested from client PID 1639 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 27.191621] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 27.655167] systemd[1]: Reloading finished in 459 ms. vm-test-run-flakelet> machine # [ 27.717808] systemd[1]: Reload requested from client PID 1683 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 27.718112] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 28.129406] systemd[1]: Reloading finished in 410 ms. vm-test-run-flakelet> machine # [ 28.176832] systemd[1]: Listening on cli-echo@1.socket. vm-test-run-flakelet> machine # [ 28.177397] systemd[1]: Listening on cli-echo@2.socket. vm-test-run-flakelet> machine # [ 28.182919] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 28.185982] systemd[1]: Listening on cli-echo@3.socket. vm-test-run-flakelet> machine # [ 28.205786] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must fail: flakelet activate cli /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken, in 4.45 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1 vm-test-run-flakelet> machine: (finished: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1, in 0.02 seconds) vm-test-run-flakelet> machine: must fail: flakelet activate cli /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken vm-test-run-flakelet> machine: (finished: must fail: flakelet activate cli /nix/store/brf38rgqp7716lxk06idm10ldy2wx3nq-flakelet-cli-broken, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: /nix/store/fyamkshpr5rrm5drs7m20ny1k403hqs9-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/cli-echo/1.sock vm-test-run-flakelet> machine: (finished: must succeed: /nix/store/fyamkshpr5rrm5drs7m20ny1k403hqs9-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/cli-echo/1.sock, in 0.02 seconds) vm-test-run-flakelet> machine: waiting for success: systemctl is-active cli-echo@1.service vm-test-run-flakelet> machine # [ 28.297852] systemd[1]: Starting cli-echo@1.service... vm-test-run-flakelet> machine # [ 28.321932] systemd[1]: Started cli-echo@1.service. vm-test-run-flakelet> machine: (finished: waiting for success: systemctl is-active cli-echo@1.service, in 1.06 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show -P MainPID cli-echo@1.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.13 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show -P MainPID cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.08 seconds) vm-test-run-flakelet> machine: must succeed: flakelet activate cli /nix/store/vkrg8l1lyj0rkk9qh6aa9wrlw17d71jy-flakelet-cli2 | grep -q 'generation 2' vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/vkrg8l1lyj0rkk9qh6aa9wrlw17d71jy-flakelet-cli2 vm-test-run-flakelet> machine # cli: activating generation 2 vm-test-run-flakelet> machine # [ 29.613588] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 29.615486] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 29.617189] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 29.635612] systemd[1]: Reload requested from client PID 1766 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 29.636374] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 30.132723] systemd[1]: Reloading finished in 493 ms. vm-test-run-flakelet> machine # [ 30.193319] systemd[1]: Reload requested from client PID 1809 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 30.193987] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 30.628489] systemd[1]: Reloading finished in 433 ms. vm-test-run-flakelet> machine # [ 30.672418] systemd[1]: Reload requested from client PID 1848 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 30.672675] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 31.122760] systemd[1]: Reloading finished in 446 ms. vm-test-run-flakelet> machine # [ 31.194575] systemd[1]: Reload requested from client PID 1893 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 31.195308] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 31.639650] systemd[1]: Reloading finished in 443 ms. vm-test-run-flakelet> machine # [ 31.685694] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 31.709798] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet activate cli /nix/store/vkrg8l1lyj0rkk9qh6aa9wrlw17d71jy-flakelet-cli2 | grep -q 'generation 2', in 2.65 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show -P MainPID cli-echo@1.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show -P MainPID cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet rollback cli | grep -q 'generation 1' vm-test-run-flakelet> machine # [ 32.313635] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 32.315643] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 32.316367] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 32.337311] systemd[1]: Reload requested from client PID 1958 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 32.337579] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 32.793641] systemd[1]: Reloading finished in 454 ms. vm-test-run-flakelet> machine # [ 32.842720] systemd[1]: Reload requested from client PID 2001 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 32.842990] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 33.289338] systemd[1]: Reloading finished in 444 ms. vm-test-run-flakelet> machine # [ 33.330350] systemd[1]: Reload requested from client PID 2040 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 33.330936] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 33.800076] systemd[1]: Reloading finished in 467 ms. vm-test-run-flakelet> machine # [ 33.877488] systemd[1]: Reload requested from client PID 2085 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 33.878038] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 34.361117] systemd[1]: Reloading finished in 481 ms. vm-test-run-flakelet> machine # [ 34.411591] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 34.431627] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet rollback cli | grep -q 'generation 1', in 2.18 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli-echo@3.socket vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli-echo@3.socket, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet lock cli | grep -q 'prebuilt:cli' vm-test-run-flakelet> machine: (finished: must succeed: flakelet lock cli | grep -q 'prebuilt:cli', in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet unlock cli vm-test-run-flakelet> machine: (finished: must succeed: flakelet unlock cli, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: touch /tmp/failjob vm-test-run-flakelet> machine: (finished: must succeed: touch /tmp/failjob, in 0.02 seconds) vm-test-run-flakelet> machine: must fail: systemctl start web-job.service vm-test-run-flakelet> machine # [ 34.562227] systemd[1]: Starting web-job.service... vm-test-run-flakelet> machine # [ 34.599135] systemd[1]: web-job.service: Main process exited, code=exited, status=1/FAILURE vm-test-run-flakelet> machine # [ 34.599692] systemd[1]: web-job.service: Failed with result 'exit-code'. vm-test-run-flakelet> machine # [ 34.600200] systemd[1]: Failed to start web-job.service. vm-test-run-flakelet> machine # Job for web-job.service failed because the control process exited with error code. vm-test-run-flakelet> machine # See "systemctl status web-job.service" and "journalctl -xeu web-job.service" for details. vm-test-run-flakelet> machine: (finished: must fail: systemctl start web-job.service, in 0.06 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation' vm-test-run-flakelet> machine # web: resolving path:/nix/store/r870dwwpfrafvid6lzzmp8am798blqfd-flake.nix vm-test-run-flakelet> machine # [ 34.728526] nix-daemon[819]: accepted connection from pid 2164, user flakelet vm-test-run-flakelet> machine # web: evaluating /nix/store/3r6v3rl82jvx862vf4yjps5jl8hj8903-flakelet-driver.nix vm-test-run-flakelet> machine # [ 34.878465] nix-daemon[819]: accepted connection from pid 2184, user flakelet vm-test-run-flakelet> machine # web: building /nix/store/2zh6szjc4gq1miw2nzq090xpvvllzg4a-flakelet-web.drv vm-test-run-flakelet> machine # [ 38.051300] nix-daemon[819]: accepted connection from pid 2194, user flakelet vm-test-run-flakelet> machine # web: activating generation 2 vm-test-run-flakelet> machine # [ 38.176671] systemd[1]: Stopping flakelet test service... vm-test-run-flakelet> machine # [ 38.177524] systemd[1]: web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 38.178241] systemd[1]: Stopped flakelet test service. vm-test-run-flakelet> machine # [ 38.200812] systemd[1]: Reload requested from client PID 2207 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 38.201467] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 38.682169] systemd[1]: Reloading finished in 480 ms. vm-test-run-flakelet> machine # [ 38.743802] systemd[1]: Reload requested from client PID 2250 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 38.744164] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 39.177799] systemd[1]: Reloading finished in 431 ms. vm-test-run-flakelet> machine # [ 39.223135] systemd[1]: Reload requested from client PID 2292 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 39.223781] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 39.688134] systemd[1]: Reloading finished in 461 ms. vm-test-run-flakelet> machine # [ 39.743718] systemd[1]: Reload requested from client PID 2335 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 39.744284] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 40.184437] systemd[1]: Reloading finished in 438 ms. vm-test-run-flakelet> machine # [ 40.232864] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 40.260828] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine: (finished: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation', in 5.72 seconds) vm-test-run-flakelet> machine: must succeed: flakelet reconcile vm-test-run-flakelet> machine: (finished: must succeed: flakelet reconcile, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active web.service static.service cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active web.service static.service cli.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/' vm-test-run-flakelet> machine # [ 40.495713] nix-daemon[819]: accepted connection from pid 2393, user flakelet vm-test-run-flakelet> machine # [ 40.622617] nix-daemon[819]: accepted connection from pid 2413, user flakelet vm-test-run-flakelet> machine: (finished: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/', in 3.20 seconds) vm-test-run-flakelet> machine: must succeed: test -L /tmp/roots/web vm-test-run-flakelet> machine: (finished: must succeed: test -L /tmp/roots/web, in 0.01 seconds) vm-test-run-flakelet> machine: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web vm-test-run-flakelet> machine # [ 43.698243] nix-daemon[819]: accepted connection from pid 2430, user flakelet vm-test-run-flakelet> machine # [ 43.833555] nix-daemon[819]: accepted connection from pid 2450, user flakelet vm-test-run-flakelet> machine: (finished: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web, in 3.14 seconds) vm-test-run-flakelet> machine: must fail: flakelet check nosuchservice --no-refresh vm-test-run-flakelet> machine # error: service 'nosuchservice' is not configured vm-test-run-flakelet> machine: (finished: must fail: flakelet check nosuchservice --no-refresh, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: rm /run/systemd/system/web.service vm-test-run-flakelet> machine: (finished: must succeed: rm /run/systemd/system/web.service, in 0.02 seconds) vm-test-run-flakelet> machine: must succeed: flakelet boot vm-test-run-flakelet> machine # [ 46.835419] systemd[1]: Reload requested from client PID 2468 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 46.835690] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 47.274178] systemd[1]: Reloading finished in 434 ms. vm-test-run-flakelet> machine # [ 47.356323] systemd[1]: Reload requested from client PID 2514 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 47.357095] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 47.783787] systemd[1]: Reloading finished in 425 ms. vm-test-run-flakelet> machine # [ 47.861803] systemd[1]: Reload requested from client PID 2559 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 47.862408] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 48.275739] systemd[1]: Reloading finished in 412 ms. vm-test-run-flakelet> machine # [ 48.347200] systemd[1]: Reload requested from client PID 2605 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 48.347531] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 48.789249] systemd[1]: Reloading finished in 438 ms. vm-test-run-flakelet> machine # [ 48.847907] systemd[1]: Reload requested from client PID 2650 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 48.848655] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 49.304455] systemd[1]: Reloading finished in 452 ms. vm-test-run-flakelet> machine # [ 49.354520] systemd[1]: Reload requested from client PID 2694 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 49.356960] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 49.769911] systemd[1]: Reloading finished in 414 ms. vm-test-run-flakelet> machine: (finished: must succeed: flakelet boot, in 3.01 seconds) vm-test-run-flakelet> machine: must succeed: test -L /run/systemd/system/web.service vm-test-run-flakelet> machine: (finished: must succeed: test -L /run/systemd/system/web.service, in 0.01 seconds) vm-test-run-flakelet> machine: waiting for the VM to power off vm-test-run-flakelet> machine # [ 49.835527] systemd-logind[598]: poweroff requested from client PID 2742 ('poweroff') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 49.836166] systemd-logind[598]: The system will power off now! vm-test-run-flakelet> machine # [ 49.838830] systemd-logind[598]: System is powering down. vm-test-run-flakelet> machine # [ 49.848037] systemd[1]: Removed slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 49.848346] systemd[1]: Stopped target Multi-User System. vm-test-run-flakelet> machine # [ 49.849225] systemd[1]: Stopped target flakelet managed services. vm-test-run-flakelet> machine # [ 49.849929] systemd[1]: Stopped target Login Prompts. vm-test-run-flakelet> machine # [ 49.850741] systemd[1]: Stopped target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 49.852222] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 49.855466] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 49.857409] dhcpcd[743]: received SIGTERM, stopping vm-test-run-flakelet> machine # [ 49.859107] systemd[1]: fstrim.timer: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.861281] dhcpcd[743]: eth0: removing interface vm-test-run-flakelet> machine # [ 49.862500] systemd[1]: Stopped Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 49.864305] dhcpcd[743]: eth0: deleting address fec0::5054:ff:fe12:3456/64 vm-test-run-flakelet> machine # [ 49.867723] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.872925] dhcpcd[743]: eth0: deleting route to fec0::/64 vm-test-run-flakelet> machine # [ 49.875392] systemd[1]: Stopped Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 49.878297] dhcpcd[743]: eth0: deleting default route via fe80::2 vm-test-run-flakelet> machine # [ 49.880743] systemd[1]: systemd-rfkill.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.883876] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 49.887893] systemd[1]: Mounting /run/initramfs... vm-test-run-flakelet> machine # [ 49.890889] systemd[1]: Stopping backdoor.service... vm-test-run-flakelet> machine # [ 49.892461] systemd[1]: Stopping cli-echo@1.service... vm-test-run-flakelet> machine # [ 49.894572] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 49.896432] systemd[1]: Stopping DHCP Client... vm-test-run-flakelet> machine # [ 49.898077] systemd[1]: Stopping Getty on tty1... vm-test-run-flakelet> machine # [ 49.900633] network-addresses-eth1-pre-stop[2746]: deleting address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 49.903191] systemd[1]: lastlog2-import.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.905971] systemd[1]: Stopped Import lastlog data into lastlog2 database. vm-test-run-flakelet> machine # [ 49.909249] network-addresses-eth1-pre-stop[2746]: deleting address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 49.912314] systemd[1]: Stopping Address configuration of eth1... vm-test-run-flakelet> machine # [ 49.913954] systemd[1]: Stopping Nix Daemon... vm-test-run-flakelet> machine # [ 49.915237] systemd[1]: Stopping Post-Boot Actions... vm-test-run-flakelet> machine # [ 49.917092] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.918936] systemd[1]: Stopped Reset console on configuration changes. vm-test-run-flakelet> machine # [ 49.920318] dhcpcd[743]: eth0: deleting address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> machine # [ 49.921665] systemd[1]: Stopping static-echo@2.service... vm-test-run-flakelet> machine # [ 49.922793] systemd[1]: Stopping prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 49.925109] dhcpcd[743]: eth0: deleting route to 10.0.2.0/24 vm-test-run-flakelet> machine # [ 49.927170] systemd[1]: Stopping User Login Management... vm-test-run-flakelet> machine # [ 49.928608] dhcpcd[743]: eth0: deleting default route via 10.0.2.2 vm-test-run-flakelet> machine # [ 49.930406] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.932238] systemd[1]: Stopped Save Transient machine-id to Disk. vm-test-run-flakelet> machine # [ 49.934922] systemd[1]: Stopped target First Boot Complete. vm-test-run-flakelet> machine # [ 49.937050] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 49.939636] dhcpcd[743]: dhcpcd exited vm-test-run-flakelet> machine # [ 49.940918] systemd[1]: Stopping Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 49.942606] systemd[1]: Stopping flakelet test service... vm-test-run-flakelet> machine # [ 49.944085] systemd[1]: flakelet-static.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.945868] systemd[1]: Stopped Update flakelet service static. vm-test-run-flakelet> machine # [ 49.947153] systemd[1]: flakelet-web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.948614] systemd[1]: Stopped Update flakelet service web. vm-test-run-flakelet> machine # [ 49.949843] systemd[1]: flakelet-web.service: Consumed 2.289s CPU time over 40.362s wall clock time, 131.2M memory peak, 4K written to disk. vm-test-run-flakelet> machine # [ 49.952318] systemd[1]: Stopped target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 49.953756] systemd[1]: flakelet-reconcile.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.955588] systemd[1]: Stopped Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine # [ 49.957241] systemd[1]: flakelet-boot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.958536] systemd[1]: Stopped Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 49.959759] systemd[1]: backdoor.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.960967] systemd[1]: Stopped backdoor.service. vm-test-run-flakelet> machine # [ 49.962261] systemd[1]: backdoor.service: Consumed 4.687s CPU time over 41.095s wall clock time, 123.7M memory peak, 104K written to disk. vm-test-run-flakelet> machine # [ 49.965445] systemd[1]: getty@tty1.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.966741] systemd[1]: Stopped Getty on tty1. vm-test-run-flakelet> machine # [ 49.968166] systemd[1]: systemd-oomd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.970056] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 49.971512] systemd[1]: nix-daemon.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.973343] systemd[1]: Stopped Nix Daemon. vm-test-run-flakelet> machine # [ 49.974815] systemd[1]: nix-daemon.service: Consumed 1.474s CPU time over 39.353s wall clock time, 77.9M memory peak, 6.7M written to disk. vm-test-run-flakelet> machine # [ 49.978860] systemd[1]: static.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.980730] systemd[1]: Stopped prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 49.982084] systemd[1]: static-echo@2.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.983638] systemd[1]: Stopped static-echo@2.service. vm-test-run-flakelet> machine # [ 49.984815] systemd[1]: cli-echo@1.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.986258] systemd[1]: Stopped cli-echo@1.service. vm-test-run-flakelet> machine # [ 49.987651] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.989441] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 49.991148] systemd[1]: web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.992359] systemd[1]: Stopped flakelet test service. vm-test-run-flakelet> machine # [ 49.993591] systemd[1]: Mounted /run/initramfs. vm-test-run-flakelet> machine # [ 49.994856] systemd[1]: post-boot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 49.996615] systemd[1]: Stopped Post-Boot Actions. vm-test-run-flakelet> machine # [ 49.998180] systemd[1]: systemd-random-seed.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.000735] systemd[1]: Stopped Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 50.002717] systemd[1]: network-addresses-eth1.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.004242] systemd[1]: Stopped Address configuration of eth1. vm-test-run-flakelet> machine # [ 50.005603] systemd[1]: systemd-logind.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.007119] systemd[1]: Stopped User Login Management. vm-test-run-flakelet> machine # [ 50.008389] systemd[1]: Removed slice Slice /system/getty. vm-test-run-flakelet> machine # [ 50.009659] systemd[1]: Starting Generate shutdown ramfs... vm-test-run-flakelet> machine # [ 50.011046] systemd[1]: Stopping Permit User Sessions... vm-test-run-flakelet> machine # [ 50.012406] systemd[1]: dhcpcd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.013899] systemd[1]: Stopped DHCP Client. vm-test-run-flakelet> machine # [ 50.015067] systemd[1]: dhcpcd.service: Consumed 211ms CPU time over 40.627s wall clock time, 6.1M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic. vm-test-run-flakelet> machine # [ 50.018347] make-initrd-ng[2777]: /etc/initrd-release -> /nix/store/hpvgp4swqld71f46n4q68jwxzva3vsw6-etc-os-release vm-test-run-flakelet> machine # [ 50.020529] systemd[1]: systemd-user-sessions.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.024270] make-initrd-ng[2777]: /etc/os-release -> /nix/store/hpvgp4swqld71f46n4q68jwxzva3vsw6-etc-os-release vm-test-run-flakelet> machine # [ 50.026735] make-initrd-ng[2777]: /shutdown -> /nix/store/axx9bvf0dmah41f39ds9xdkds1lsz6z9-systemd-261/lib/systemd/systemd-shutdown vm-test-run-flakelet> machine # [ 50.029376] systemd[1]: Stopped Permit User Sessions. vm-test-run-flakelet> machine # [ 50.030758] systemd[1]: Stopped target Network. vm-test-run-flakelet> machine # [ 50.031681] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 50.032867] systemd[1]: Stopped target Remote File Systems. vm-test-run-flakelet> machine # [ 50.033969] systemd[1]: network-local-commands.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.035354] systemd[1]: Stopped Extra networking commands.. vm-test-run-flakelet> machine # [ 50.036385] systemd[1]: Stopped target Preparation for Network. vm-test-run-flakelet> machine # [ 50.037672] systemd[1]: Stopping Firewall... vm-test-run-flakelet> machine # [ 50.038896] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 50.040797] systemd[1]: resolvconf.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.042866] systemd[1]: Stopped resolvconf update. vm-test-run-flakelet> machine # [ 50.044273] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.046105] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 50.047701] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 50.048977] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 50.050312] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 50.051653] systemd[1]: Removed slice User and Session Slice. vm-test-run-flakelet> machine # [ 50.053122] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 50.054497] systemd[1]: cli-echo@1.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.056069] systemd[1]: Closed cli-echo@1.socket. vm-test-run-flakelet> machine # [ 50.057251] systemd[1]: cli-echo@2.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.059002] systemd[1]: Closed cli-echo@2.socket. vm-test-run-flakelet> machine # [ 50.060109] systemd[1]: cli-echo@3.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.061554] systemd[1]: Closed cli-echo@3.socket. vm-test-run-flakelet> machine # [ 50.062720] systemd[1]: Removed slice Slice /system/cli-echo. vm-test-run-flakelet> machine # [ 50.064119] systemd[1]: nix-daemon.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.065643] systemd[1]: Closed Nix Daemon Socket. vm-test-run-flakelet> machine # [ 50.066605] systemd[1]: static-echo@1.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.068049] systemd[1]: Closed static-echo@1.socket. vm-test-run-flakelet> machine # [ 50.069095] systemd[1]: static-echo@2.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.070459] systemd[1]: Closed static-echo@2.socket. vm-test-run-flakelet> machine # [ 50.071515] systemd[1]: static-echo@3.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.072917] systemd[1]: Closed static-echo@3.socket. vm-test-run-flakelet> machine # [ 50.073992] systemd[1]: Removed slice Slice /system/static-echo. vm-test-run-flakelet> machine # [ 50.075429] systemd[1]: systemd-hostnamed.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.077102] systemd[1]: Closed Hostname Service Socket. vm-test-run-flakelet> machine # [ 50.078326] systemd[1]: systemd-importd.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.079650] systemd[1]: Closed Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 50.080947] systemd[1]: systemd-machined.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.082282] systemd[1]: Closed Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 50.084234] systemd[1]: systemd-mute-console.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.085831] systemd[1]: Closed Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 50.087153] systemd[1]: systemd-oomd.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.088399] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 50.089987] systemd[1]: systemd-repart.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.091388] systemd[1]: Closed Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 50.092733] dbus-broker[644]: Dispatched 22466 messages @ 1(±9)μs / message. vm-test-run-flakelet> machine # [ 50.094375] systemd[1]: Stopping D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 50.095891] systemd[1]: dbus-broker.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.097456] systemd[1]: Stopped D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 50.098777] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.100202] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 50.101691] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 50.103170] systemd[1]: Stopped target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 50.104608] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.106402] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 50.108323] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.110193] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 50.112168] systemd[1]: register-nix-paths.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.113747] systemd[1]: Stopped register-nix-paths.service. vm-test-run-flakelet> machine # [ 50.114974] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.116507] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 50.117835] systemd[1]: systemd-coredump.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.119429] systemd[1]: Closed Process Core Dump Socket. vm-test-run-flakelet> machine # [ 50.120801] systemd[1]: systemd-update-done.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.122637] systemd[1]: Stopped Update is Completed. vm-test-run-flakelet> machine # [ 50.123944] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.126234] systemd[1]: Stopped Rebuild Journal Catalog. vm-test-run-flakelet> machine # [ 50.127437] systemd[1]: Stopping Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 50.129152] systemd[1]: systemd-update-utmp.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.130814] systemd[1]: Stopped Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 50.132328] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.134070] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 50.135529] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 50.136768] systemd[1]: Unmounting /run/keys... vm-test-run-flakelet> machine # [ 50.137831] systemd[1]: Unmounting /run/wrappers... vm-test-run-flakelet> machine # [ 50.138947] systemd[1]: firewall.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.140294] systemd[1]: Stopped Firewall. vm-test-run-flakelet> machine # [ 50.141243] systemd[1]: run-wrappers.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.142609] systemd[1]: Unmounted /run/wrappers. vm-test-run-flakelet> machine # [ 50.143666] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 50.144650] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.146222] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 50.147361] systemd[1]: run-keys.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.148728] systemd[1]: Unmounted /run/keys. vm-test-run-flakelet> machine # [ 50.149922] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 50.151529] systemd[1]: Reached target Unmount All Filesystems. vm-test-run-flakelet> machine # [ 50.153096] systemd[1]: systemd-remount-fs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.154447] systemd[1]: Stopped Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 50.156041] systemd[1]: systemd-fsck-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.157623] systemd[1]: Stopped File System Check on Root Device. vm-test-run-flakelet> machine # [ 50.158762] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.160393] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 50.161914] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.163404] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 50.212942] make-initrd-ng[2777]: Warning: Couldn't satisfy dependency libcrypt.so.1 for "/nix/store/axx9bvf0dmah41f39ds9xdkds1lsz6z9-systemd-261/lib/systemd/libsystemd-shared-261.so" vm-test-run-flakelet> machine # [ 50.217395] make-initrd-ng[2777]: Warning: Couldn't satisfy dependency libcrypt.so.1.1 for "/nix/store/axx9bvf0dmah41f39ds9xdkds1lsz6z9-systemd-261/lib/systemd/libsystemd-shared-261.so" vm-test-run-flakelet> machine # [ 50.272042] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.273678] systemd[1]: Finished Generate shutdown ramfs. vm-test-run-flakelet> machine # [ 50.274860] systemd[1]: Reached target System Shutdown. vm-test-run-flakelet> machine # [ 50.276219] systemd[1]: Reached target Late Shutdown Services. vm-test-run-flakelet> machine # [ 50.277672] systemd[1]: systemd-poweroff.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 50.279262] systemd[1]: Finished System Power Off. vm-test-run-flakelet> machine # [ 50.280510] systemd[1]: Reached target System Power Off. vm-test-run-flakelet> machine # [ 50.281721] systemd[1]: Shutting down. vm-test-run-flakelet> machine # [ 50.551156] systemd-shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 50.555135] systemd-shutdown[1]: Sending SIGTERM to remaining processes... vm-test-run-flakelet> machine # [ 50.558493] systemd-journald[316]: Received SIGTERM from PID 1 (systemd-shutdow). vm-test-run-flakelet> machine # [ 50.581840] systemd-shutdown[1]: Sending SIGKILL to remaining processes... vm-test-run-flakelet> machine # [ 50.585708] systemd-shutdown[1]: Unmounting file systems. vm-test-run-flakelet> machine # [ 50.588485] (sd-umount)[2813]: Unmounting '/run/credentials/systemd-journald.service'. vm-test-run-flakelet> machine # [ 50.590096] (sd-remount)[2814]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'. vm-test-run-flakelet> machine # [ 50.600006] (sd-remount)[2815]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'. vm-test-run-flakelet> machine # [ 50.603117] (sd-remount)[2816]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 50.608865] (sd-umount)[2817]: Unmounting '/tmp/shared'. vm-test-run-flakelet> machine # [ 50.621259] (sd-remount)[2818]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 50.623650] (sd-umount)[2819]: Unmounting '/tmp/xchg'. vm-test-run-flakelet> machine # [ 50.625719] (sd-remount)[2820]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 50.855507] (sd-umount)[2821]: Unmounting '/nix/.ro-store'. vm-test-run-flakelet> machine # [ 50.857051] (sd-remount)[2822]: Remounting '/' read-only with options ''. vm-test-run-flakelet> machine # [ 50.879278] EXT4-fs (vda): re-mounted 7dd68229-d3c5-45ed-8604-54372f61f684 ro. vm-test-run-flakelet> machine # [ 50.881513] systemd-shutdown[1]: All filesystems unmounted. vm-test-run-flakelet> machine # [ 50.882459] systemd-shutdown[1]: Deactivating swaps. vm-test-run-flakelet> machine # [ 50.883267] systemd-shutdown[1]: All swaps deactivated. vm-test-run-flakelet> machine # [ 50.884060] systemd-shutdown[1]: Detaching loop devices. vm-test-run-flakelet> machine # [ 50.887272] systemd-shutdown[1]: All loop devices detached. vm-test-run-flakelet> machine # [ 50.888086] systemd-shutdown[1]: Stopping MD devices. vm-test-run-flakelet> machine # [ 50.888930] systemd-shutdown[1]: All MD devices stopped. vm-test-run-flakelet> machine # [ 50.889908] systemd-shutdown[1]: Detaching DM devices. vm-test-run-flakelet> machine # [ 50.891000] systemd-shutdown[1]: All DM devices detached. vm-test-run-flakelet> machine # [ 50.892171] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. vm-test-run-flakelet> machine # [ 50.894783] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error vm-test-run-flakelet> machine # [ 51.231763] systemd-shutdown[1]: Successfully changed into root pivot. vm-test-run-flakelet> machine # [ 51.232811] systemd-shutdown[1]: Entering exitrd... vm-test-run-flakelet> machine # [ 51.239817] shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 51.240849] shutdown[1]: Sending SIGTERM to remaining processes... vm-test-run-flakelet> machine # [ 51.243130] shutdown[1]: Sending SIGKILL to remaining processes... vm-test-run-flakelet> machine # [ 51.245204] shutdown[1]: Unmounting file systems. vm-test-run-flakelet> machine # [ 51.246806] (sd-umoun[2824]: Unmounting '/run/credentials'. vm-test-run-flakelet> machine # [ 51.248600] (sd-umoun[2825]: Unmounting '/oldroot/sys/kernel/config'. vm-test-run-flakelet> machine # [ 51.250430] (sd-umoun[2826]: Unmounting '/oldroot/sys/fs/fuse/connections'. vm-test-run-flakelet> machine # [ 51.252292] (sd-umoun[2827]: Unmounting '/oldroot/dev/hugepages'. vm-test-run-flakelet> machine # [ 51.254036] (sd-umoun[2828]: Unmounting '/oldroot/sys/kernel/debug'. vm-test-run-flakelet> machine # [ 51.255839] (sd-umoun[2829]: Unmounting '/oldroot/dev/mqueue'. vm-test-run-flakelet> machine # [ 51.257572] (sd-umoun[2830]: Unmounting '/oldroot/sys/kernel/tracing'. vm-test-run-flakelet> machine # [ 51.259341] (sd-umoun[2831]: Unmounting '/oldroot/sys/fs/bpf'. vm-test-run-flakelet> machine # [ 51.261026] (sd-umoun[2832]: Unmounting '/oldroot/sys/fs/pstore'. vm-test-run-flakelet> machine # [ 51.262848] (sd-umoun[2833]: Unmounting '/oldroot/sys/fs/cgroup'. vm-test-run-flakelet> machine # [ 51.264659] (sd-umoun[2834]: Unmounting '/oldroot/sys/kernel/security'. vm-test-run-flakelet> machine # [ 51.266245] (sd-umoun[2835]: Unmounting '/oldroot/nix/store'. vm-test-run-flakelet> machine # [ 51.267666] (sd-umoun[2836]: Unmounting '/oldroot/sys'. vm-test-run-flakelet> machine # [ 51.269191] (sd-umoun[2837]: Unmounting '/oldroot/proc'. vm-test-run-flakelet> machine # [ 51.270820] (sd-umoun[2838]: Unmounting '/oldroot/dev/shm'. vm-test-run-flakelet> machine # [ 51.272930] (sd-umoun[2839]: Unmounting '/oldroot/dev/pts'. vm-test-run-flakelet> machine # [ 51.275438] (sd-umoun[2840]: Unmounting '/oldroot/dev'. vm-test-run-flakelet> machine # [ 51.277424] (sd-umoun[2841]: Unmounting '/oldroot/nix/store'. vm-test-run-flakelet> machine # [ 51.302117] (sd-umoun[2842]: Unmounting '/oldroot/run'. vm-test-run-flakelet> machine # [ 51.304762] (sd-umoun[2843]: Unmounting '/oldroot'. vm-test-run-flakelet> machine # [ 51.310969] EXT4-fs (vda): unmounting filesystem 7dd68229-d3c5-45ed-8604-54372f61f684. vm-test-run-flakelet> machine # [ 51.313584] shutdown[1]: All filesystems unmounted. vm-test-run-flakelet> machine # [ 51.314760] shutdown[1]: Deactivating swaps. vm-test-run-flakelet> machine # [ 51.316107] shutdown[1]: All swaps deactivated. vm-test-run-flakelet> machine # [ 51.317694] shutdown[1]: Detaching loop devices. vm-test-run-flakelet> machine # [ 51.320275] shutdown[1]: All loop devices detached. vm-test-run-flakelet> machine # [ 51.321703] shutdown[1]: Stopping MD devices. vm-test-run-flakelet> machine # [ 51.323009] shutdown[1]: All MD devices stopped. vm-test-run-flakelet> machine # [ 51.324285] shutdown[1]: Detaching DM devices. vm-test-run-flakelet> machine # [ 51.325598] shutdown[1]: All DM devices detached. vm-test-run-flakelet> machine # [ 51.326855] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. vm-test-run-flakelet> machine # [ 51.328890] shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 51.330087] shutdown[1]: Powering off. vm-test-run-flakelet> machine # [ 51.337441] ACPI: PM: Preparing to enter system sleep state S5 vm-test-run-flakelet> machine # [ 51.338853] kvm: exiting hardware virtualization vm-test-run-flakelet> machine # [ 51.340051] reboot: Power down vm-test-run-flakelet> machine: (finished: waiting for the VM to power off, in 1.53 seconds) vm-test-run-flakelet> machine: starting vm vm-test-run-flakelet> machine: QEMU running (pid 84) vm-test-run-flakelet> machine: waiting for unit web.service vm-test-run-flakelet> machine: waiting for the VM to finish booting vm-test-run-flakelet> machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BEFD1920+BEF31920 CA00 vm-test-run-flakelet> machine # Press Ctrl-B to configure iPXE (PCI 00:03.0)... vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM BEFD1920 BEF31920 CB00 vm-test-run-flakelet> machine # Press Ctrl-B to configure iPXE (PCI 00:09.0)... vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Booting from ROM... vm-test-run-flakelet> machine # Probing EDD (edd=off to disable)... ok vm-test-run-flakelet> machine # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Jul 24 14:17:26 UTC 2026 vm-test-run-flakelet> machine # [ 0.000000] Command line: console=ttyS0 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/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test/init regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. vm-test-run-flakelet> machine # [ 0.000000] BIOS-provided physical RAM map: vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdafff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000bffdb000-0x00000000bfffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable vm-test-run-flakelet> machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved vm-test-run-flakelet> machine # [ 0.000000] NX (Execute Disable) protection: active vm-test-run-flakelet> machine # [ 0.000000] APIC: Static calls initialized vm-test-run-flakelet> machine # [ 0.000000] SMBIOS 2.8 present. vm-test-run-flakelet> machine # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 vm-test-run-flakelet> machine # [ 0.000000] DMI: Memory slots populated: 1/1 vm-test-run-flakelet> machine # [ 0.000000] Hypervisor detected: KVM vm-test-run-flakelet> machine # [ 0.000000] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 vm-test-run-flakelet> machine # [ 0.000001] kvm-clock: using sched offset of 489929318 cycles vm-test-run-flakelet> machine # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-flakelet> machine # [ 0.000006] tsc: Detected 3099.998 MHz processor vm-test-run-flakelet> machine # [ 0.000895] last_pfn = 0x140000 max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.000927] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs vm-test-run-flakelet> machine # [ 0.000930] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm-test-run-flakelet> machine # [ 0.000979] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-flakelet> machine # [ 0.003494] found SMP MP-table at [mem 0x000f5470-0x000f547f] vm-test-run-flakelet> machine # [ 0.003513] Using GB pages for direct mapping vm-test-run-flakelet> machine # [ 0.003724] RAMDISK: [mem 0xbe3b0000-0xbffcffff] vm-test-run-flakelet> machine # [ 0.003730] ACPI: Early table checksum verification disabled vm-test-run-flakelet> machine # [ 0.003734] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) vm-test-run-flakelet> machine # [ 0.003738] ACPI: RSDT 0x00000000BFFE24E3 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003743] ACPI: FACP 0x00000000BFFE237F 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003751] ACPI: DSDT 0x00000000BFFE0040 00233F (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003753] ACPI: FACS 0x00000000BFFE0000 000040 vm-test-run-flakelet> machine # [ 0.003756] ACPI: APIC 0x00000000BFFE23F3 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003758] ACPI: HPET 0x00000000BFFE2483 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003760] ACPI: WAET 0x00000000BFFE24BB 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-flakelet> machine # [ 0.003762] ACPI: Reserving FACP table memory at [mem 0xbffe237f-0xbffe23f2] vm-test-run-flakelet> machine # [ 0.003764] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe237e] vm-test-run-flakelet> machine # [ 0.003764] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] vm-test-run-flakelet> machine # [ 0.003765] ACPI: Reserving APIC table memory at [mem 0xbffe23f3-0xbffe2482] vm-test-run-flakelet> machine # [ 0.003766] ACPI: Reserving HPET table memory at [mem 0xbffe2483-0xbffe24ba] vm-test-run-flakelet> machine # [ 0.003766] ACPI: Reserving WAET table memory at [mem 0xbffe24bb-0xbffe24e2] vm-test-run-flakelet> machine # [ 0.004253] No NUMA configuration found vm-test-run-flakelet> machine # [ 0.004255] Faking a node at [mem 0x0000000000000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.004258] NODE_DATA(0) allocated [mem 0x13fff8780-0x13fffdcff] vm-test-run-flakelet> machine # [ 0.004367] Zone ranges: vm-test-run-flakelet> machine # [ 0.004368] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm-test-run-flakelet> machine # [ 0.004370] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] vm-test-run-flakelet> machine # [ 0.004372] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.004373] Device empty vm-test-run-flakelet> machine # [ 0.004374] Movable zone start for each node vm-test-run-flakelet> machine # [ 0.004374] Early memory node ranges vm-test-run-flakelet> machine # [ 0.004375] node 0: [mem 0x0000000000001000-0x000000000009efff] vm-test-run-flakelet> machine # [ 0.004376] node 0: [mem 0x0000000000100000-0x00000000bffdafff] vm-test-run-flakelet> machine # [ 0.004377] node 0: [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.004378] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.004408] On node 0, zone DMA: 1 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.004701] On node 0, zone DMA: 97 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.073610] On node 0, zone Normal: 37 pages in unavailable ranges vm-test-run-flakelet> machine # [ 0.074409] ACPI: PM-Timer IO Port: 0x608 vm-test-run-flakelet> machine # [ 0.074424] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm-test-run-flakelet> machine # [ 0.074451] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm-test-run-flakelet> machine # [ 0.074454] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm-test-run-flakelet> machine # [ 0.074455] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm-test-run-flakelet> machine # [ 0.074456] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm-test-run-flakelet> machine # [ 0.074457] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm-test-run-flakelet> machine # [ 0.074458] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm-test-run-flakelet> machine # [ 0.074461] ACPI: Using ACPI (MADT) for SMP configuration information vm-test-run-flakelet> machine # [ 0.074462] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm-test-run-flakelet> machine # [ 0.074468] TSC deadline timer available vm-test-run-flakelet> machine # [ 0.074472] CPU topo: Max. logical packages: 1 vm-test-run-flakelet> machine # [ 0.074473] CPU topo: Max. logical dies: 1 vm-test-run-flakelet> machine # [ 0.074473] CPU topo: Max. dies per package: 1 vm-test-run-flakelet> machine # [ 0.074477] CPU topo: Max. threads per core: 1 vm-test-run-flakelet> machine # [ 0.074478] CPU topo: Num. cores per package: 4 vm-test-run-flakelet> machine # [ 0.074478] CPU topo: Num. threads per package: 4 vm-test-run-flakelet> machine # [ 0.074479] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs vm-test-run-flakelet> machine # [ 0.074498] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() vm-test-run-flakelet> machine # [ 0.074513] kvm-guest: KVM setup pv remote TLB flush vm-test-run-flakelet> machine # [ 0.074516] kvm-guest: setup PV sched yield vm-test-run-flakelet> machine # [ 0.074524] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.074526] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm-test-run-flakelet> machine # [ 0.074527] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] vm-test-run-flakelet> machine # [ 0.074529] [mem 0xc0000000-0xfeffbfff] available for PCI devices vm-test-run-flakelet> machine # [ 0.074530] Booting paravirtualized kernel on KVM vm-test-run-flakelet> machine # [ 0.074534] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns vm-test-run-flakelet> machine # [ 0.078946] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 vm-test-run-flakelet> machine # [ 0.081321] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288 vm-test-run-flakelet> machine # [ 0.081377] kvm-guest: PV spinlocks enabled vm-test-run-flakelet> machine # [ 0.081379] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm-test-run-flakelet> machine # [ 0.081382] Kernel command line: console=ttyS0 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/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test/init regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.081481] Unknown kernel command line parameters "regInfo=/nix/store/zfv7v18hq28l3zyj991ynghyj4azd02c-closure-info/registration", will be passed to user space. vm-test-run-flakelet> machine # [ 0.081499] random: crng init done vm-test-run-flakelet> machine # [ 0.081500] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes vm-test-run-flakelet> machine # [ 0.085589] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-flakelet> machine # [ 0.087673] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-flakelet> machine # [ 0.087759] software IO TLB: area num 4. vm-test-run-flakelet> machine # [ 0.169799] Fallback order for Node 0: 0 vm-test-run-flakelet> machine # [ 0.169807] Built 1 zonelists, mobility grouping on. Total pages: 1048441 vm-test-run-flakelet> machine # [ 0.169809] Policy zone: Normal vm-test-run-flakelet> machine # [ 0.172273] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-flakelet> machine # [ 0.181422] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 vm-test-run-flakelet> machine # [ 0.190083] allocated 8388608 bytes of page_ext vm-test-run-flakelet> machine # [ 0.198105] ftrace: allocating 48619 entries in 192 pages vm-test-run-flakelet> machine # [ 0.198109] ftrace: allocated 192 pages with 2 groups vm-test-run-flakelet> machine # [ 0.198994] Dynamic Preempt: lazy vm-test-run-flakelet> machine # [ 0.199175] rcu: Preemptible hierarchical RCU implementation. vm-test-run-flakelet> machine # [ 0.199176] rcu: RCU event tracing is enabled. vm-test-run-flakelet> machine # [ 0.199176] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.199177] Trampoline variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.199177] Rude variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.199178] Tracing variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.199179] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. vm-test-run-flakelet> machine # [ 0.199180] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 vm-test-run-flakelet> machine # [ 0.199216] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.199217] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.199219] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.203766] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16 vm-test-run-flakelet> machine # [ 0.204070] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-flakelet> machine # [ 0.204080] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns vm-test-run-flakelet> machine # [ 0.204193] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-flakelet> machine # [ 0.210104] Console: colour VGA+ 80x25 vm-test-run-flakelet> machine # [ 0.210109] printk: legacy console [tty0] enabled vm-test-run-flakelet> machine # [ 0.248811] printk: legacy console [ttyS0] enabled vm-test-run-flakelet> machine # [ 0.403001] ACPI: Core revision 20250807 vm-test-run-flakelet> machine # [ 0.404218] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm-test-run-flakelet> machine # [ 0.406393] APIC: Switch to symmetric I/O mode setup vm-test-run-flakelet> machine # [ 0.407754] x2apic enabled vm-test-run-flakelet> machine # [ 0.408740] APIC: Switched APIC routing to: physical x2apic vm-test-run-flakelet> machine # [ 0.410027] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() vm-test-run-flakelet> machine # [ 0.411701] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() vm-test-run-flakelet> machine # [ 0.413748] kvm-guest: setup PV IPIs vm-test-run-flakelet> machine # [ 0.415639] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm-test-run-flakelet> machine # [ 0.417011] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns vm-test-run-flakelet> machine # [ 0.419308] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) vm-test-run-flakelet> machine # [ 0.421400] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm-test-run-flakelet> machine # [ 0.422444] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 vm-test-run-flakelet> machine # [ 0.424306] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 vm-test-run-flakelet> machine # [ 0.425315] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto vm-test-run-flakelet> machine # [ 0.426318] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl vm-test-run-flakelet> machine # [ 0.428314] Spectre V2 : Mitigation: Retpolines vm-test-run-flakelet> machine # [ 0.430308] RETBleed: Mitigation: untrained return thunk vm-test-run-flakelet> machine # [ 0.431312] Speculative Return Stack Overflow: Mitigation: SMT disabled vm-test-run-flakelet> machine # [ 0.432307] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm-test-run-flakelet> machine # [ 0.434306] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT vm-test-run-flakelet> machine # [ 0.436306] Spectre V2 : Enabling Speculation Barrier for firmware calls vm-test-run-flakelet> machine # [ 0.437307] active return thunk: retbleed_return_thunk vm-test-run-flakelet> machine # [ 0.438312] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm-test-run-flakelet> machine # [ 0.439326] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm-test-run-flakelet> machine # [ 0.440307] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm-test-run-flakelet> machine # [ 0.442306] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm-test-run-flakelet> machine # [ 0.443308] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm-test-run-flakelet> machine # [ 0.445307] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. vm-test-run-flakelet> machine # [ 0.467435] Freeing SMP alternatives memory: 44K vm-test-run-flakelet> machine # [ 0.468308] pid_max: default: 32768 minimum: 301 vm-test-run-flakelet> machine # [ 0.469412] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-flakelet> machine # [ 0.470384] landlock: Up and running. vm-test-run-flakelet> machine # [ 0.471960] Yama: becoming mindful. vm-test-run-flakelet> machine # [ 0.473078] LSM support for eBPF active vm-test-run-flakelet> machine # [ 0.474149] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.475387] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.478861] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) vm-test-run-flakelet> machine # [ 0.479786] Performance Events: Fam17h+ core perfctr, AMD PMU driver. vm-test-run-flakelet> machine # [ 0.480314] ... version: 0 vm-test-run-flakelet> machine # [ 0.481288] ... bit width: 48 vm-test-run-flakelet> machine # [ 0.482061] ... generic counters: 6 vm-test-run-flakelet> machine # [ 0.483166] ... generic bitmap: 000000000000003f vm-test-run-flakelet> machine # [ 0.484317] ... fixed-purpose counters: 0 vm-test-run-flakelet> machine # [ 0.485308] ... fixed-purpose bitmap: 0000000000000000 vm-test-run-flakelet> machine # [ 0.486307] ... value mask: 0000ffffffffffff vm-test-run-flakelet> machine # [ 0.487307] ... max period: 00007fffffffffff vm-test-run-flakelet> machine # [ 0.488307] ... global_ctrl mask: 000000000000003f vm-test-run-flakelet> machine # [ 0.489429] signal: max sigframe size: 1776 vm-test-run-flakelet> machine # [ 0.490498] rcu: Hierarchical SRCU implementation. vm-test-run-flakelet> machine # [ 0.491312] rcu: Max phase no-delay instances is 400. vm-test-run-flakelet> machine # [ 0.492495] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-flakelet> machine # [ 0.496617] smp: Bringing up secondary CPUs ... vm-test-run-flakelet> machine # [ 0.497638] smpboot: x86: Booting SMP configuration: vm-test-run-flakelet> machine # [ 0.498310] .... node #0, CPUs: #1 #2 #3 vm-test-run-flakelet> machine # [ 0.499353] smp: Brought up 1 node, 4 CPUs vm-test-run-flakelet> machine # [ 0.502043] smpboot: Total of 4 processors activated (24799.98 BogoMIPS) vm-test-run-flakelet> machine # [ 0.503670] Memory: 3960368K/4193764K available (17162K kernel code, 2721K rwdata, 13548K rodata, 3640K init, 3012K bss, 218584K reserved, 0K cma-reserved) vm-test-run-flakelet> machine # [ 0.504674] devtmpfs: initialized vm-test-run-flakelet> machine # [ 0.505533] x86/mm: Memory block size: 128MB vm-test-run-flakelet> machine # [ 0.507372] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.508398] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). vm-test-run-flakelet> machine # [ 0.509403] pinctrl core: initialized pinctrl subsystem vm-test-run-flakelet> machine # [ 0.510642] PM: RTC time: 08:43:16, date: 2026-08-31 vm-test-run-flakelet> machine # [ 0.514033] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-flakelet> machine # [ 0.516029] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-flakelet> machine # [ 0.517355] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-flakelet> machine # [ 0.518851] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-flakelet> machine # [ 0.519331] audit: initializing netlink subsys (disabled) vm-test-run-flakelet> machine # [ 0.520486] audit: type=2000 audit(1788165796.095:1): state=initialized audit_enabled=0 res=1 vm-test-run-flakelet> machine # [ 0.520577] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-flakelet> machine # [ 0.521310] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-flakelet> machine # [ 0.522308] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-flakelet> machine # [ 0.523308] thermal_sys: Registered thermal governor 'user_space' vm-test-run-flakelet> machine # [ 0.524307] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-flakelet> machine # [ 0.525372] cpuidle: using governor menu vm-test-run-flakelet> machine # [ 0.528325] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm-test-run-flakelet> machine # [ 0.529684] PCI: Using configuration type 1 for base access vm-test-run-flakelet> machine # [ 0.530307] PCI: Using configuration type 1 for extended access vm-test-run-flakelet> machine # [ 0.531499] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm-test-run-flakelet> machine # [ 0.532664] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.534307] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-flakelet> machine # [ 0.535308] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.536307] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-flakelet> machine # [ 0.538623] ACPI: Added _OSI(Module Device) vm-test-run-flakelet> machine # [ 0.539307] ACPI: Added _OSI(Processor Device) vm-test-run-flakelet> machine # [ 0.540308] ACPI: Added _OSI(Processor Aggregator Device) vm-test-run-flakelet> machine # [ 0.542365] ACPI: 1 ACPI AML tables successfully acquired and loaded vm-test-run-flakelet> machine # [ 0.545628] ACPI: Interpreter enabled vm-test-run-flakelet> machine # [ 0.546336] ACPI: PM: (supports S0 S3 S4 S5) vm-test-run-flakelet> machine # [ 0.547309] ACPI: Using IOAPIC for interrupt routing vm-test-run-flakelet> machine # [ 0.548376] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm-test-run-flakelet> machine # [ 0.549307] PCI: Using E820 reservations for host bridge windows vm-test-run-flakelet> machine # [ 0.550436] ACPI: Enabled 2 GPEs in block 00 to 0F vm-test-run-flakelet> machine # [ 0.554219] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm-test-run-flakelet> machine # [ 0.555314] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] vm-test-run-flakelet> machine # [ 0.556664] acpiphp: Slot [3] registered vm-test-run-flakelet> machine # [ 0.557337] acpiphp: Slot [4] registered vm-test-run-flakelet> machine # [ 0.558322] acpiphp: Slot [5] registered vm-test-run-flakelet> machine # [ 0.559312] acpiphp: Slot [6] registered vm-test-run-flakelet> machine # [ 0.560294] acpiphp: Slot [7] registered vm-test-run-flakelet> machine # [ 0.561060] acpiphp: Slot [8] registered vm-test-run-flakelet> machine # [ 0.562047] acpiphp: Slot [9] registered vm-test-run-flakelet> machine # [ 0.563092] acpiphp: Slot [10] registered vm-test-run-flakelet> machine # [ 0.564086] acpiphp: Slot [11] registered vm-test-run-flakelet> machine # [ 0.565081] acpiphp: Slot [12] registered vm-test-run-flakelet> machine # [ 0.566084] acpiphp: Slot [13] registered vm-test-run-flakelet> machine # [ 0.567100] acpiphp: Slot [14] registered vm-test-run-flakelet> machine # [ 0.568062] acpiphp: Slot [15] registered vm-test-run-flakelet> machine # [ 0.569058] acpiphp: Slot [16] registered vm-test-run-flakelet> machine # [ 0.570087] acpiphp: Slot [17] registered vm-test-run-flakelet> machine # [ 0.571059] acpiphp: Slot [18] registered vm-test-run-flakelet> machine # [ 0.572070] acpiphp: Slot [19] registered vm-test-run-flakelet> machine # [ 0.573086] acpiphp: Slot [20] registered vm-test-run-flakelet> machine # [ 0.574110] acpiphp: Slot [21] registered vm-test-run-flakelet> machine # [ 0.575091] acpiphp: Slot [22] registered vm-test-run-flakelet> machine # [ 0.576083] acpiphp: Slot [23] registered vm-test-run-flakelet> machine # [ 0.577066] acpiphp: Slot [24] registered vm-test-run-flakelet> machine # [ 0.578092] acpiphp: Slot [25] registered vm-test-run-flakelet> machine # [ 0.579062] acpiphp: Slot [26] registered vm-test-run-flakelet> machine # [ 0.580064] acpiphp: Slot [27] registered vm-test-run-flakelet> machine # [ 0.581065] acpiphp: Slot [28] registered vm-test-run-flakelet> machine # [ 0.582090] acpiphp: Slot [29] registered vm-test-run-flakelet> machine # [ 0.583079] acpiphp: Slot [30] registered vm-test-run-flakelet> machine # [ 0.584078] acpiphp: Slot [31] registered vm-test-run-flakelet> machine # [ 0.585077] PCI host bridge to bus 0000:00 vm-test-run-flakelet> machine # [ 0.586105] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm-test-run-flakelet> machine # [ 0.587309] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm-test-run-flakelet> machine # [ 0.588309] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm-test-run-flakelet> machine # [ 0.589309] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] vm-test-run-flakelet> machine # [ 0.590312] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] vm-test-run-flakelet> machine # [ 0.591311] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-flakelet> machine # [ 0.592687] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.594095] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.596108] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.598362] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] vm-test-run-flakelet> machine # [ 0.599370] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.600309] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.601309] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.602309] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk vm-test-run-flakelet> machine # [ 0.603652] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.605362] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] vm-test-run-flakelet> machine # [ 0.607148] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.608856] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm-test-run-flakelet> machine # [ 0.609323] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm-test-run-flakelet> machine # [ 0.610692] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.613392] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] vm-test-run-flakelet> machine # [ 0.614334] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] vm-test-run-flakelet> machine # [ 0.615350] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] vm-test-run-flakelet> machine # [ 0.616524] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm-test-run-flakelet> machine # [ 0.618222] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.621324] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] vm-test-run-flakelet> machine # [ 0.622320] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] vm-test-run-flakelet> machine # [ 0.623350] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.624320] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] vm-test-run-flakelet> machine # [ 0.626966] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.630156] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] vm-test-run-flakelet> machine # [ 0.631275] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] vm-test-run-flakelet> machine # [ 0.632350] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] vm-test-run-flakelet> machine # [ 0.634923] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.638328] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] vm-test-run-flakelet> machine # [ 0.639321] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] vm-test-run-flakelet> machine # [ 0.640350] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] vm-test-run-flakelet> machine # [ 0.642843] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.645325] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] vm-test-run-flakelet> machine # [ 0.646322] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] vm-test-run-flakelet> machine # [ 0.647352] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] vm-test-run-flakelet> machine # [ 0.649820] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.652323] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] vm-test-run-flakelet> machine # [ 0.653320] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] vm-test-run-flakelet> machine # [ 0.654351] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] vm-test-run-flakelet> machine # [ 0.656816] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.659325] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] vm-test-run-flakelet> machine # [ 0.660321] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] vm-test-run-flakelet> machine # [ 0.661361] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] vm-test-run-flakelet> machine # [ 0.663814] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.666321] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] vm-test-run-flakelet> machine # [ 0.667320] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] vm-test-run-flakelet> machine # [ 0.668351] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] vm-test-run-flakelet> machine # [ 0.669320] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] vm-test-run-flakelet> machine # [ 0.671831] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.673909] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] vm-test-run-flakelet> machine # [ 0.674352] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] vm-test-run-flakelet> machine # [ 0.676884] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.679128] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] vm-test-run-flakelet> machine # [ 0.680331] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] vm-test-run-flakelet> machine # [ 0.681351] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] vm-test-run-flakelet> machine # [ 0.683855] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.685916] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] vm-test-run-flakelet> machine # [ 0.686320] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] vm-test-run-flakelet> machine # [ 0.687365] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] vm-test-run-flakelet> machine # [ 0.694213] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm-test-run-flakelet> machine # [ 0.695475] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm-test-run-flakelet> machine # [ 0.696463] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm-test-run-flakelet> machine # [ 0.697457] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm-test-run-flakelet> machine # [ 0.698381] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm-test-run-flakelet> machine # [ 0.700482] iommu: Default domain type: Translated vm-test-run-flakelet> machine # [ 0.701307] iommu: DMA domain TLB invalidation policy: lazy mode vm-test-run-flakelet> machine # [ 0.702467] ACPI: bus type USB registered vm-test-run-flakelet> machine # [ 0.703362] usbcore: registered new interface driver usbfs vm-test-run-flakelet> machine # [ 0.704325] usbcore: registered new interface driver hub vm-test-run-flakelet> machine # [ 0.705335] usbcore: registered new device driver usb vm-test-run-flakelet> machine # [ 0.707015] NetLabel: Initializing vm-test-run-flakelet> machine # [ 0.707929] NetLabel: domain hash size = 128 vm-test-run-flakelet> machine # [ 0.708309] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm-test-run-flakelet> machine # [ 0.709343] NetLabel: unlabeled traffic allowed by default vm-test-run-flakelet> machine # [ 0.710319] PCI: Using ACPI for IRQ routing vm-test-run-flakelet> machine # [ 0.711779] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm-test-run-flakelet> machine # [ 0.712303] pci 0000:00:02.0: vgaarb: bridge control possible vm-test-run-flakelet> machine # [ 0.712303] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm-test-run-flakelet> machine # [ 0.712315] vgaarb: loaded vm-test-run-flakelet> machine # [ 0.713228] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm-test-run-flakelet> machine # [ 0.714192] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm-test-run-flakelet> machine # [ 0.719430] clocksource: Switched to clocksource kvm-clock vm-test-run-flakelet> machine # [ 0.721190] VFS: Disk quotas dquot_6.6.0 vm-test-run-flakelet> machine # [ 0.722189] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-flakelet> machine # [ 0.724047] pnp: PnP ACPI init vm-test-run-flakelet> machine # [ 0.725339] pnp: PnP ACPI: found 6 devices vm-test-run-flakelet> machine # [ 0.733490] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm-test-run-flakelet> machine # [ 0.735684] clocksource: Switched to clocksource acpi_pm vm-test-run-flakelet> machine # [ 0.737209] NET: Registered PF_INET protocol family vm-test-run-flakelet> machine # [ 0.739608] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-flakelet> machine # [ 0.756934] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.759078] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.761034] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.763037] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-flakelet> machine # [ 0.764966] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-flakelet> machine # [ 0.766884] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-flakelet> machine # [ 0.768887] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.770637] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.772492] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-flakelet> machine # [ 0.773904] NET: Registered PF_XDP protocol family vm-test-run-flakelet> machine # [ 0.775134] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm-test-run-flakelet> machine # [ 0.776618] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm-test-run-flakelet> machine # [ 0.778091] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm-test-run-flakelet> machine # [ 0.779731] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] vm-test-run-flakelet> machine # [ 0.781335] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] vm-test-run-flakelet> machine # [ 0.783202] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm-test-run-flakelet> machine # [ 0.784638] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm-test-run-flakelet> machine # [ 0.787214] ACPI: \_SB_.LNKD: Enabled at IRQ 11 vm-test-run-flakelet> machine # [ 0.789862] PCI: CLS 0 bytes, default 64 vm-test-run-flakelet> machine # [ 0.791014] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) vm-test-run-flakelet> machine # [ 0.791364] Trying to unpack rootfs image as initramfs... vm-test-run-flakelet> machine # [ 0.793969] software IO TLB: mapped [mem 0x00000000ba3b0000-0x00000000be3b0000] (64MB) vm-test-run-flakelet> machine # [ 0.796065] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns vm-test-run-flakelet> machine # [ 0.813300] Initialise system trusted keyrings vm-test-run-flakelet> machine # [ 0.814750] workingset: timestamp_bits=40 max_order=20 bucket_order=0 vm-test-run-flakelet> machine # [ 0.826362] Key type asymmetric registered vm-test-run-flakelet> machine # [ 0.827479] Asymmetric key parser 'x509' registered vm-test-run-flakelet> machine # [ 0.828959] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) vm-test-run-flakelet> machine # [ 0.831282] io scheduler mq-deadline registered vm-test-run-flakelet> machine # [ 0.832636] io scheduler kyber registered vm-test-run-flakelet> machine # [ 0.836104] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-flakelet> machine # [ 0.838034] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm-test-run-flakelet> machine # [ 0.841075] Linux agpgart interface v0.103 vm-test-run-flakelet> machine # [ 0.842472] ACPI: bus type drm_connector registered vm-test-run-flakelet> machine # [ 0.845325] usbcore: registered new interface driver usbserial_generic vm-test-run-flakelet> machine # [ 0.846935] usbserial: USB Serial support registered for generic vm-test-run-flakelet> machine # [ 0.848446] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled vm-test-run-flakelet> machine # [ 0.850578] drop_monitor: Initializing network drop monitor service vm-test-run-flakelet> machine # [ 0.852401] NET: Registered PF_INET6 protocol family vm-test-run-flakelet> machine # [ 0.858221] Segment Routing with IPv6 vm-test-run-flakelet> machine # [ 0.859627] In-situ OAM (IOAM) with IPv6 vm-test-run-flakelet> machine # [ 0.862862] IPI shorthand broadcast: enabled vm-test-run-flakelet> machine # [ 0.866797] sched_clock: Marking stable (661111022, 205223970)->(976470715, -110135723) vm-test-run-flakelet> machine # [ 0.869346] registered taskstats version 1 vm-test-run-flakelet> machine # [ 0.870773] Loading compiled-in X.509 certificates vm-test-run-flakelet> machine # [ 0.877696] Demotion targets for Node 0: null vm-test-run-flakelet> machine # [ 0.879176] Key type .fscrypt registered vm-test-run-flakelet> machine # [ 0.880187] Key type fscrypt-provisioning registered vm-test-run-flakelet> machine # [ 0.881609] ima: No TPM chip found, activating TPM-bypass! vm-test-run-flakelet> machine # [ 0.882972] ima: Allocated hash algorithm: sha1 vm-test-run-flakelet> machine # [ 0.884172] ima: No architecture policies found vm-test-run-flakelet> machine # [ 0.885627] PM: Magic number: 6:873:726 vm-test-run-flakelet> machine # [ 0.887647] RAS: Correctable Errors collector initialized. vm-test-run-flakelet> machine # [ 0.892810] clk: Disabling unused clocks vm-test-run-flakelet> machine # [ 0.893853] PM: genpd: Disabling unused power domains vm-test-run-flakelet> machine # [ 1.104807] Freeing initrd memory: 28800K vm-test-run-flakelet> machine # [ 1.110660] Freeing unused decrypted memory: 2028K vm-test-run-flakelet> machine # [ 1.113762] Freeing unused kernel image (initmem) memory: 3640K vm-test-run-flakelet> machine # [ 1.115356] Write protecting the kernel read-only data: 32768k vm-test-run-flakelet> machine # [ 1.117758] Freeing unused kernel image (text/rodata gap) memory: 1268K vm-test-run-flakelet> machine # [ 1.119865] Freeing unused kernel image (rodata/data gap) memory: 788K vm-test-run-flakelet> machine # [ 1.165182] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm-test-run-flakelet> machine # [ 1.167379] Run /init as init process vm-test-run-flakelet> machine # [ 1.184761] systemd[1]: Inserted module 'autofs4' vm-test-run-flakelet> machine # [ 1.215925] fuse: init (API version 7.45) vm-test-run-flakelet> machine # [ 1.226040] ACPI: \_SB_.LNKC: Enabled at IRQ 10 vm-test-run-flakelet> machine # [ 1.235514] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm-test-run-flakelet> machine # [ 1.240706] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm-test-run-flakelet> machine # [ 1.289198] systemd[1]: Successfully made /usr/ read-only. vm-test-run-flakelet> machine # [ 1.627079] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) vm-test-run-flakelet> machine # [ 1.639129] systemd[1]: Detected virtualization kvm. vm-test-run-flakelet> machine # [ 1.640938] systemd[1]: Detected architecture x86-64. vm-test-run-flakelet> machine # [ 1.642735] systemd[1]: Running in initrd. vm-test-run-flakelet> machine # [ 1.644969] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 1.646942] systemd[1]: Hostname set to . vm-test-run-flakelet> machine # [ 1.750092] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 1.789387] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-flakelet> machine # [ 1.805904] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 1.807754] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 1.810012] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 1.811804] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 1.813207] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 1.814702] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 1.816027] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 1.817643] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 1.819506] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-flakelet> machine # [ 1.821260] systemd[1]: Listening on Journal Sockets. vm-test-run-flakelet> machine # [ 1.822774] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 1.824348] systemd[1]: Listening on udev Kernel Socket. vm-test-run-flakelet> machine # [ 1.825819] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 1.828485] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 1.833342] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 1.842866] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-flakelet> machine # [ 1.846887] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 1.849561] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 1.851359] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 1.857331] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 1.863768] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 1.866532] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.869119] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-flakelet> machine # [ 1.871636] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config vm-test-run-flakelet> machine # [ 1.875613] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 1.884305] netfs: FS-Cache loaded vm-test-run-flakelet> machine # [ 1.887010] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-flakelet> machine # [ 1.890199] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-flakelet> machine # [ 1.892097] systemd-journald[92]: Collecting audit messages is disabled. vm-test-run-flakelet> machine # [ 1.894326] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 1.897424] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 1.900862] 9pnet: Installing 9P2000 support vm-test-run-flakelet> machine # [ 1.902177] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 1.906534] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 1.909810] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.912849] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 1.918401] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 1.924350] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 1.926211] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 1.928080] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 1.930698] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 1.956552] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 1.751448] systemd-modules-load[93]: Using 4 probe threads vm-test-run-flakelet> machine # [ 1.755058] systemd-modules-load[93]: Inserted module 'virtio_balloon' vm-test-run-flakelet> machine # [ 1.757074] systemd-modules-load[93]: Inserted module 'virtio_gpu' vm-test-run-flakelet> machine # [ 1.758974] systemd-modules-load[93]: Inserted module 'dm_mod' vm-test-run-flakelet> machine # [ 1.761137] systemd-udevd[105]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 1.763508] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 1.765983] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 1.769721] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 1.777200] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 1.779191] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 1.780719] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 2.115074] virtio_blk virtio5: 4/0/0 default/read/poll queues vm-test-run-flakelet> machine # [ 2.119567] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-flakelet> machine # [ 2.119951] uhci_hcd 0000:00:01.2: UHCI Host Controller vm-test-run-flakelet> machine # [ 2.122855] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 vm-test-run-flakelet> machine # [ 2.124464] uhci_hcd 0000:00:01.2: detected 2 ports vm-test-run-flakelet> machine # [ 2.125844] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 vm-test-run-flakelet> machine # [ 2.128097] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 vm-test-run-flakelet> machine # [ 2.129434] SCSI subsystem initialized vm-test-run-flakelet> machine # [ 2.130108] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 vm-test-run-flakelet> machine # [ 2.132374] usb usb1: Product: UHCI Host Controller vm-test-run-flakelet> machine # [ 2.133399] usb usb1: Manufacturer: Linux 6.18.40 uhci_hcd vm-test-run-flakelet> machine # [ 2.134474] usb usb1: SerialNumber: 0000:00:01.2 vm-test-run-flakelet> machine # [ 2.136709] hub 1-0:1.0: USB hub found vm-test-run-flakelet> machine # [ 2.138297] hub 1-0:1.0: 2 ports detected vm-test-run-flakelet> machine # [ 2.156839] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm-test-run-flakelet> machine # [ 2.162489] serio: i8042 KBD port at 0x60,0x64 irq 1 vm-test-run-flakelet> machine # [ 2.164383] serio: i8042 AUX port at 0x60,0x64 irq 12 vm-test-run-flakelet> machine # [ 2.177538] scsi host0: ata_piix vm-test-run-flakelet> machine # [ 2.178850] scsi host1: ata_piix vm-test-run-flakelet> machine # [ 2.179648] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 vm-test-run-flakelet> machine # [ 2.181033] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 vm-test-run-flakelet> machine # [ 1.983530] (udev-worker)[123]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 1.987263] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 1.995527] (udev-worker)[127]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 1.999076] (udev-worker)[127]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.003394] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.006310] systemd[1]: Reached target Initrd Root Device. vm-test-run-flakelet> machine # [ 2.007795] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 2.011920] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 2.018795] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 2.031744] systemd-fsck[157]: nixos: clean, 1636/65536 files, 19712/262144 blocks vm-test-run-flakelet> machine # [ 2.035257] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.337668] ata2: found unknown device (class 0) vm-test-run-flakelet> machine # [ 2.339289] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm-test-run-flakelet> machine # [ 2.341785] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm-test-run-flakelet> machine # [ 2.361289] usb 1-1: new full-speed USB device number 2 using uhci_hcd vm-test-run-flakelet> machine # [ 2.363279] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 vm-test-run-flakelet> machine # [ 2.395179] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm-test-run-flakelet> machine # [ 2.420841] cdrom: Uniform CD-ROM driver Revision: 3.20 vm-test-run-flakelet> machine # [ 2.530564] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 vm-test-run-flakelet> machine # [ 2.532428] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 vm-test-run-flakelet> machine # [ 2.534314] usb 1-1: Product: QEMU USB Tablet vm-test-run-flakelet> machine # [ 2.536066] usb 1-1: Manufacturer: QEMU vm-test-run-flakelet> machine # [ 2.537664] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 vm-test-run-flakelet> machine # [ 2.554156] hid: raw HID events driver (C) Jiri Kosina vm-test-run-flakelet> machine # [ 2.562575] usbcore: registered new interface driver usbhid vm-test-run-flakelet> machine # [ 2.563944] usbhid: USB HID core driver vm-test-run-flakelet> machine # [ 2.568128] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 vm-test-run-flakelet> machine # [ 2.572978] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 vm-test-run-flakelet> machine # [ 2.656241] systemd[1]: Mounting /sysroot... vm-test-run-flakelet> machine # [ 2.978491] EXT4-fs (vda): mounted filesystem 7dd68229-d3c5-45ed-8604-54372f61f684 r/w with ordered data mode. Quota mode: none. vm-test-run-flakelet> machine # [ 2.777538] systemd[1]: Mounted /sysroot. vm-test-run-flakelet> machine # [ 2.778853] systemd[1]: Reached target Initrd Root File System. vm-test-run-flakelet> machine # [ 2.781538] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-flakelet> machine # [ 2.783407] systemd[1]: Mounting /sysroot/run... vm-test-run-flakelet> machine # [ 2.789122] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-flakelet> machine # [ 2.793485] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-flakelet> machine # [ 2.794971] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-flakelet> machine # [ 3.003057] 9p: Installing v9fs 9p2000 file system support vm-test-run-flakelet> machine # [ 2.798463] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.805679] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-flakelet> machine # [ 2.806930] systemd[1]: Mounted /sysroot/run. vm-test-run-flakelet> machine # [ 2.807822] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-flakelet> machine # [ 2.809070] systemd-sysroot-fstab-check[178]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-flakelet> machine # [ 2.811853] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-flakelet> machine # [ 2.812995] systemd[1]: Reload requested from client PID 178 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-flakelet> machine # [ 2.815133] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 2.867351] systemd[1]: Reloading finished in 55 ms. vm-test-run-flakelet> machine # [ 2.884416] systemd-sysroot-fstab-check[178]: Requesting initrd-fs.target/start/replace... vm-test-run-flakelet> machine # [ 2.886084] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.887513] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.888984] systemd-sysroot-fstab-check[178]: Requesting swap.target/start/replace... vm-test-run-flakelet> machine # [ 2.890555] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.891769] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.893165] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-flakelet> machine # [ 2.894456] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-flakelet> machine # [ 2.900637] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.902284] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.656604] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-flakelet> machine # [ 3.679784] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-flakelet> machine # [ 3.681095] systemd[1]: Reached target Initrd File Systems. vm-test-run-flakelet> machine # [ 3.682412] systemd[1]: Starting Find NixOS closure... vm-test-run-flakelet> machine # [ 3.683697] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-flakelet> machine # [ 3.694501] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.696227] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.702954] systemd[1]: Finished Find NixOS closure. vm-test-run-flakelet> machine # [ 3.704196] systemd[1]: Reached target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.705523] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-flakelet> machine # [ 3.730945] systemd[1]: Stopped target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.732368] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 3.733556] systemd[1]: Stopped target Initrd Root Device. vm-test-run-flakelet> machine # [ 3.734665] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 3.735660] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.737139] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 3.738711] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 3.739806] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 3.740858] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 3.742048] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 3.743111] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 3.744162] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.746324] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 3.747630] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.749243] systemd[1]: Stopped Find NixOS closure. vm-test-run-flakelet> machine # [ 3.750351] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-flakelet> machine # [ 3.752523] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 3.753814] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.755232] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 3.756484] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.758414] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 3.759930] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.761728] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.763533] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.765100] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 3.766439] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 3.767713] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 3.769524] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.771280] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 3.772667] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 3.774659] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.776407] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.777953] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.779590] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-flakelet> machine # [ 3.781131] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.782706] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 3.784414] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.786122] systemd[1]: Closed udev Control Socket. vm-test-run-flakelet> machine # [ 3.787543] systemd[1]: Starting Cleanup udev Database... vm-test-run-flakelet> machine # [ 3.788860] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.790707] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 3.792406] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.794360] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 3.796192] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.797650] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 3.799363] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.801947] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.803845] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.805995] systemd[1]: Finished Cleanup udev Database. vm-test-run-flakelet> machine # [ 3.807236] systemd[1]: Reached target Switch Root. vm-test-run-flakelet> machine # [ 3.808352] systemd[1]: Starting NixOS Activation... vm-test-run-flakelet> machine # [ 3.931285] initrd-nixos-activation-start[226]: booting system configuration /nix/store/vacq4jffrfrlz39yz4kdwkmnv5zafnqn-nixos-system-machine-test vm-test-run-flakelet> machine # [ 3.992704] initrd-nixos-activation-start[226]: running activation script... vm-test-run-flakelet> machine # [ 4.383137] initrd-nixos-activation-start[250]: setting up /etc... vm-test-run-flakelet> machine # [ 4.654038] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 4.656096] systemd[1]: Finished NixOS Activation. vm-test-run-flakelet> machine # [ 4.657308] systemd[1]: Starting Switch Root... vm-test-run-flakelet> machine # [ 4.671238] systemd[1]: Switching root. vm-test-run-flakelet> machine # [ 4.931810] systemd-journald[92]: Received SIGTERM from PID 1 (systemd). vm-test-run-flakelet> machine # [ 5.045225] NET: Registered PF_VSOCK protocol family vm-test-run-flakelet> machine # [ 5.439305] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) vm-test-run-flakelet> machine # [ 5.445033] systemd[1]: Detected virtualization kvm. vm-test-run-flakelet> machine # [ 5.446025] systemd[1]: Detected architecture x86-64. vm-test-run-flakelet> machine # [ 5.559677] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 6.191666] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.194012] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-flakelet> machine # [ 6.197385] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-flakelet> machine # [ 6.200444] systemd[1]: Created slice Slice /system/getty. vm-test-run-flakelet> machine # [ 6.202410] systemd[1]: Created slice User and Session Slice. vm-test-run-flakelet> machine # [ 6.203928] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 6.205946] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 6.207855] systemd[1]: Expecting device /dev/hvc0... vm-test-run-flakelet> machine # [ 6.209095] systemd[1]: Expecting device /dev/ttyS0... vm-test-run-flakelet> machine # [ 6.210464] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 6.211919] systemd[1]: Reached target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 6.213543] systemd[1]: Stopped target initrd-fs.target. vm-test-run-flakelet> machine # [ 6.214861] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-flakelet> machine # [ 6.216284] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-flakelet> machine # [ 6.217790] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 6.219375] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 6.220611] systemd[1]: Reached target Remote File Systems. vm-test-run-flakelet> machine # [ 6.222018] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 6.223305] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 6.227504] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-flakelet> machine # [ 6.232141] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-flakelet> machine # [ 6.235832] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-flakelet> machine # [ 6.239628] systemd[1]: Listening on Factory Reset Management. vm-test-run-flakelet> machine # [ 6.241166] systemd[1]: Listening on Hostname Service Socket. vm-test-run-flakelet> machine # [ 6.245809] systemd[1]: Starting Journal Log Access Socket... vm-test-run-flakelet> machine # [ 6.248037] systemd[1]: Listening on Journal Audit Socket. vm-test-run-flakelet> machine # [ 6.252328] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 6.254102] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 6.256356] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.258540] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-flakelet> machine # [ 6.268453] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 6.270151] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 6.271697] systemd[1]: Listening on udev Varlink Socket. vm-test-run-flakelet> machine # [ 6.275888] systemd[1]: Mounting Huge Pages File System... vm-test-run-flakelet> machine # [ 6.279726] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-flakelet> machine # [ 6.282860] systemd[1]: Mounting Kernel Debug File System... vm-test-run-flakelet> machine # [ 6.291758] systemd[1]: Mounting Kernel Trace File System... vm-test-run-flakelet> machine # [ 6.298025] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 6.301064] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-flakelet> machine # [ 6.307996] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-flakelet> machine # [ 6.311340] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-flakelet> machine # [ 6.313755] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 6.315996] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-flakelet> machine # [ 6.326624] systemd[1]: Mounting FUSE Control File System... vm-test-run-flakelet> machine # [ 6.330294] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-flakelet> machine # [ 6.344420] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 6.348856] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 6.356667] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 6.361413] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-flakelet> machine # [ 6.363995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.369960] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 6.386216] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-flakelet> machine # [ 6.391017] systemd[1]: Mounted Huge Pages File System. vm-test-run-flakelet> machine # [ 6.391543] systemd-journald[320]: Collecting audit messages is enabled. vm-test-run-flakelet> machine # [ 6.393031] loop: module loaded vm-test-run-flakelet> machine # [ 6.393598] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-flakelet> machine # [ 6.398053] systemd[1]: Mounted Kernel Debug File System. vm-test-run-flakelet> machine # [ 6.400059] systemd[1]: Mounted Kernel Trace File System. vm-test-run-flakelet> machine # [ 6.402638] EXT4-fs (vda): re-mounted 7dd68229-d3c5-45ed-8604-54372f61f684. vm-test-run-flakelet> machine # [ 6.402981] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 6.202637] systemd[1]: Queued start job for default target Multi-User System[ 6.408663] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # . vm-test-run-flakelet> machine # [ 6.205677] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.207662] systemd-modules-load[321]: Using 2 probe threads vm-test-run-flakelet> machine # [ 6.209491] systemd-modules-load[321]: Inserted module 'loop' vm-test-run-flakelet> machine # [ 6.211278] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.213153] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-flakelet> machine # [ 6.214900] systemd[1]: Mounted FUSE Control File System. vm-test-run-flakelet> machine # [ 6.216744] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 6.218295] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 6.220591] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 6.222837] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 6.225456] systemd[1]: Starting Firewall... vm-test-run-flakelet> machine # [ 6.227188] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-flakelet> machine # [ 6.230218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 6.236633] systemd-oomd[323]: No swap; memory pressure usage will be degraded vm-test-run-flakelet> machine # [ 6.242308] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 6.244577] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 6.248746] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 6.252514] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.255553] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 6.463928] systemd-journald[320]: Received client request to flush runtime journal. vm-test-run-flakelet> machine # [ 6.313628] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 6.315525] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 6.317081] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes vm-test-run-flakelet> machine # [ 6.319538] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 6.321312] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 6.324150] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 6.326432] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-flakelet> machine # [ 6.328083] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 6.357976] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 6.359623] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 6.361964] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 6.416224] systemd-udevd[359]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 6.501198] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 6.591142] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-flakelet> machine # [ 6.610282] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-flakelet> machine # [ 6.619869] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. vm-test-run-flakelet> machine # [ 6.628401] (udev-worker)[409]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 6.642622] (udev-worker)[416]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 6.648204] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 6.679188] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-flakelet> machine # [ 6.683409] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 6.687250] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-flakelet> machine # [ 6.692375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 6.697103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.700494] systemd[1]: TPM SRK Setup skipped, unmet conditio[ 6.905915] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 vm-test-run-flakelet> machine # n check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 6.913110] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console vm-test-run-flakelet> machine # [ 6.921106] mousedev: PS/2 mouse device common for all mice vm-test-run-flakelet> machine # [ 6.924094] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 vm-test-run-flakelet> machine # [ 6.928484] Console: switching to colour dummy device 80x25 vm-test-run-flakelet> machine # [ 6.931562] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD vm-test-run-flakelet> machine # [ 6.933154] [drm] Found bochs VGA, ID 0xb0c5. vm-test-run-flakelet> machine # [ 6.934933] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. vm-test-run-flakelet> machine # [ 6.935087] ACPI: button: Power Button [PWRF] vm-test-run-flakelet> machine # [ 6.935358] rtc_cmos 00:05: RTC can wake from S4 vm-test-run-flakelet> machine # [ 6.936408] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic vm-test-run-flakelet> machine # [ 6.939332] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 vm-test-run-flakelet> machine # [ 6.940883] Floppy drive(s): fd0 is 2.88M AMI BIOS vm-test-run-flakelet> machine # [ 6.965593] parport_pc 00:03: reported by Plug and Play ACPI vm-test-run-flakelet> machine # [ 6.965707] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] vm-test-run-flakelet> machine # [ 6.966907] FDC 0 is a S82078B vm-test-run-flakelet> machine # [ 6.968608] rtc_cmos 00:05: registered as rtc0 vm-test-run-flakelet> machine # [ 6.968789] rtc_cmos 00:05: setting system clock to 2026-08-31T08:43:22 UTC (1788165802) vm-test-run-flakelet> machine # [ 6.969821] Console: switching to colour frame buffer device 160x50 vm-test-run-flakelet> machine # [ 6.972808] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm-test-run-flakelet> machine # [ 6.974156] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device vm-test-run-flakelet> machine # [ 6.975329] systemd-journald[320]: Time jumped backwards, rotating. vm-test-run-flakelet> machine # [ 7.019993] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 vm-test-run-flakelet> machine # [ 7.029236] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 vm-test-run-flakelet> machine # [ 7.040587] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 vm-test-run-flakelet> machine # [ 6.872207] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 6.903087] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.905513] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 6.952941] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 6.982144] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 6.983872] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 6.986759] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 6.994206] systemd[1]: Mounting /run/wrappers... vm-test-run-flakelet> machine # [ 7.200900] ppdev: user-space parallel port driver vm-test-run-flakelet> machine # [ 7.024333] systemd[1]: Mount[ 7.229980] kvm_amd: TSC scaling supported vm-test-run-flakelet> machine # ed /run/wrappers[ 7.230812] kvm_amd: Nested Virtualization enabled vm-test-run-flakelet> machine # .[ 7.231861] kvm_amd: Nested Paging enabled vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # [ 7.233356] kvm_amd: LBR virtualization supported vm-test-run-flakelet> machine # [ 7.028409] s[ 7.234515] kvm_amd: Virtual VMLOAD VMSAVE supported vm-test-run-flakelet> machine # ystemd[1]: Reach[ 7.235814] kvm_amd: Virtual GIF supported vm-test-run-flakelet> machine # ed target Local File Systems. vm-test-run-flakelet> machine # [ 7.034165] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-flakelet> machine # [ 7.038236] systemd[1]: Starting register-nix-paths.service... vm-test-run-flakelet> machine # [ 7.043321] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-flakelet> machine # [ 7.045968] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 7.048861] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id vm-test-run-flakelet> machine # [ 7.054676] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 7.291065] EDAC MC: Ver: 3.0.0 vm-test-run-flakelet> machine # [ 7.122991] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 7.125709] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var vm-test-run-flakelet> machine # [ 7.130548] systemd[1]: Update is Completed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 7.133633] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 7.158336] systemd[1]: Finished Firewall. vm-test-run-flakelet> machine # [ 7.161613] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 7.367109] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.369213] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-flakelet> machine # [ 7.379692] systemd-vconsole-setup[471]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 7.382175] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 7.636138] systemd[1]: Finished register-nix-paths.service. vm-test-run-flakelet> machine # [ 7.637908] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 7.639451] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 7.641784] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 7.644634] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 7.646230] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 7.648243] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-flakelet> machine # [ 7.649559] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 7.651641] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 7.652941] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 7.654183] systemd[1]: Started backdoor.service. vm-test-run-flakelet> machine # [ 7.655348] systemd[1]: Starting Re-link flakelet services at boot... vm-test-run-flakelet> machine # [ 7.657700] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db vm-test-run-flakelet> machine # [ 7.660240] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 7.666065] systemd[1]: Starting Post-Boot Actions... vm-test-run-flakelet> machine # [ 7.669175] systemd[1]: Started Reset console on configuration changes. vm-test-run-flakelet> machine # [ 7.673474] systemd[1]: Starting resolvconf update... vm-test-run-flakelet> machine # [ 7.681190] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 7.706145] systemd[1]: Finished Post-Boot Actions. vm-test-run-flakelet> machine # connecting to host... vm-test-run-flakelet> machine # [ 7.731236] nsncd[568]: Aug 31 08:43:23.464 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 7.735538] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 7.737394] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 7.739163] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 7.741424] systemd[1]: Starting User Login Management... vm-test-run-flakelet> machine # [ 7.743412] systemd[1]: Reload requested from client PID 579 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 7.747237] systemd[1]: Reloading... vm-test-run-flakelet> machine: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-flakelet> machine: connected to guest root shell vm-test-run-flakelet> machine: (connecting took 8.59 seconds) vm-test-run-flakelet> machine: (finished: waiting for the VM to finish booting, in 8.59 seconds) vm-test-run-flakelet> machine # [ 7.787416] dbus-broker-launch[573]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-flakelet> machine # [ 7.819485] systemd-logind[590]: New seat seat0. vm-test-run-flakelet> machine # [ 7.823481] systemd-logind[590]: Watching system buttons on /dev/input/event2 (Power Button) vm-test-run-flakelet> machine # [ 7.825503] systemd-logind[590]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-flakelet> machine # [ 7.826972] systemd-logind[590]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) vm-test-run-flakelet> machine # [ 8.169866] systemd[1]: Reloading finished in 429 ms. vm-test-run-flakelet> machine # [ 8.206186] systemd[1]: Started User Login Management. vm-test-run-flakelet> machine # [ 8.218266] dbus-broker-launch[573]: NSS returned no entry for 'systemd-timesync' vm-test-run-flakelet> machine # [ 8.219157] dbus-broker-launch[573]: Invalid user-name in /nix/store/s8hy0z9qrdvs2k3y9dswf360fvwa9n5v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-flakelet> machine # [ 8.227330] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 8.228566] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-flakelet> machine # [ 8.230129] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 8.232479] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-flakelet> machine # [ 8.233653] systemd[1]: Starting linger-users.service... vm-test-run-flakelet> machine # [ 8.235102] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 8.240941] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.242365] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 8.249671] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 8.253143] systemd[1]: Started D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 8.279145] dbus-broker-launch[573]: Ready vm-test-run-flakelet> machine # [ 8.279981] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.281182] systemd[1]: Finished linger-users.service. vm-test-run-flakelet> machine # [ 8.287074] nsncd[684]: Aug 31 08:43:24.022 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 8.287740] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 8.291794] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 8.292708] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 8.303448] systemd[1]: Finished resolvconf update. vm-test-run-flakelet> machine # [ 8.305835] systemd[1]: Reached target Preparation for Network. vm-test-run-flakelet> machine # [ 8.309379] systemd[1]: Starting DHCP Client... vm-test-run-flakelet> machine # [ 8.311289] systemd[1]: Starting Address configuration of eth1... vm-test-run-flakelet> machine # [ 8.315111] systemd[1]: Starting Extra networking commands.... vm-test-run-flakelet> machine # [ 8.323850] systemd[1]: Reload requested from client PID 710 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 8.324524] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 8.395930] network-addresses-eth1-start[713]: adding address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 8.408212] network-addresses-eth1-start[713]: adding address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 8.912784] systemd[1]: Reloading finished in 586 ms. vm-test-run-flakelet> machine # [ 8.948596] systemd[1]: Finished Address configuration of eth1. vm-test-run-flakelet> machine # [ 8.950103] systemd[1]: Finished Extra networking commands.. vm-test-run-flakelet> machine # [ 8.971563] systemd[1]: Created slice Slice /system/cli-echo. vm-test-run-flakelet> machine # [ 8.972584] systemd[1]: Reached target Network. vm-test-run-flakelet> machine # [ 8.973770] systemd[1]: Listening on cli-echo@1.socket. vm-test-run-flakelet> machine # [ 8.974767] systemd[1]: Listening on cli-echo@2.socket. vm-test-run-flakelet> machine # [ 8.978103] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 8.981233] systemd[1]: Starting Permit User Sessions... vm-test-run-flakelet> machine # [ 8.993437] systemd[1]: Listening on cli-echo@3.socket. vm-test-run-flakelet> machine # [ 9.002156] systemd[1]: Reload requested from client PID 809 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 9.003747] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 9.532911] systemd[1]: Reloading finished in 527 ms. vm-test-run-flakelet> machine # [ 9.570216] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 9.573357] systemd[1]: Finished Permit User Sessions. vm-test-run-flakelet> machine # [ 9.594075] systemd[1]: Started Getty on tty1. vm-test-run-flakelet> machine # [ 9.595138] systemd[1]: Reached target Login Prompts. vm-test-run-flakelet> machine # [ 9.622980] systemd[1]: Reload requested from client PID 868 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 9.623804] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 9.658816] dhcpcd[856]: dhcpcd-10.3.2 starting vm-test-run-flakelet> machine # [ 9.666845] dhcpcd[898]: dev: loaded udev vm-test-run-flakelet> machine # [ 9.667507] dhcpcd[898]: DUID 00:01:00:01:32:27:fa:f8:52:54:00:12:34:56 vm-test-run-flakelet> machine # [ 9.894202] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-flakelet> machine # [ 9.894881] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-flakelet> machine # [ 10.023534] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-flakelet> machine # [ 10.045732] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-flakelet> machine # [ 10.047187] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-flakelet> machine # [ 10.050418] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-flakelet> machine # [ 10.052704] cfg80211: failed to load regulatory.db vm-test-run-flakelet> machine # [ 10.097766] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-flakelet> machine # [ 9.894911] dhcpcd[898]: eth0: waiting for carrier vm-test-run-flakelet> machine # [ 9.895683] dhcpcd[898]: eth0: carrier acquired vm-test-run-flakelet> machine # [ 9.907841] dhcpcd[898]: eth0: IAID 00:12:34:56 vm-test-run-flakelet> machine # [ 9.908919] dhcpcd[898]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> machine # [ 10.153541] systemd[1]: Reloading finished in 526 ms. vm-test-run-flakelet> machine # [ 10.205475] systemd[1]: Created slice Slice /system/static-echo. vm-test-run-flakelet> machine # [ 10.206181] systemd[1]: Listening on static-echo@1.socket. vm-test-run-flakelet> machine # [ 10.207109] systemd[1]: Listening on static-echo@2.socket. vm-test-run-flakelet> machine # [ 10.209110] systemd[1]: Starting prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 10.212307] systemd[1]: Listening on static-echo@3.socket. vm-test-run-flakelet> machine # [ 10.222368] systemd[1]: Reload requested from client PID 926 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 10.223748] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 10.326049] dhcpcd[898]: eth0: rebinding lease of 10.0.2.15 vm-test-run-flakelet> machine # [ 10.545291] NET: Registered PF_PACKET protocol family vm-test-run-flakelet> machine # [ 10.364647] dhcpcd[898]: eth0: probing address 10.0.2.15/24 vm-test-run-flakelet> machine # [ 10.676920] systemd[1]: Reloading finished in 452 ms. vm-test-run-flakelet> machine # [ 10.714157] systemd[1]: Started prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 10.722881] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 10.730753] systemd[1]: Reload requested from client PID 976 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 10.731859] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 11.176518] systemd[1]: Reloading finished in 443 ms. vm-test-run-flakelet> machine # [ 11.216231] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 11.219124] flakelet[567]: cli: units re-linked vm-test-run-flakelet> machine # [ 11.220745] flakelet[567]: static: units re-linked vm-test-run-flakelet> machine # [ 11.222703] flakelet[567]: web: units re-linked vm-test-run-flakelet> machine # [ 11.234962] systemd[1]: Finished Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 11.240354] systemd[1]: Starting Reconcile flakelet services with the host configuration... vm-test-run-flakelet> machine # [ 11.291500] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine # [ 11.293667] systemd[1]: Finished Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine # [ 11.298917] systemd[1]: Starting Update flakelet service static... vm-test-run-flakelet> machine # [ 11.301768] systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> machine # [ 11.329885] flakelet[1026]: static: using prebuilt artifact /nix/store/f1dm6yd8wvxg9lz1avfaclh1x8ipjfzy-flakelet-static vm-test-run-flakelet> machine # [ 11.334155] flakelet[1027]: web: resolving path:/nix/store/r870dwwpfrafvid6lzzmp8am798blqfd-flake.nix vm-test-run-flakelet> machine # [ 11.338639] flakelet[1026]: static: up to date vm-test-run-flakelet> machine # [ 11.340968] systemd[1]: Finished Update flakelet service static. vm-test-run-flakelet> machine # [ 11.404105] systemd[1]: Started Nix Daemon. vm-test-run-flakelet> machine # [ 11.480959] nix-daemon[1035]: accepted connection from pid 1028, user flakelet vm-test-run-flakelet> machine # [ 11.570843] flakelet[1027]: web: evaluating /nix/store/3r6v3rl82jvx862vf4yjps5jl8hj8903-flakelet-driver.nix vm-test-run-flakelet> machine # [ 11.583687] dhcpcd[898]: eth0: soliciting an IPv6 router vm-test-run-flakelet> machine # [ 11.584264] dhcpcd[898]: eth0: Router Advertisement from fe80::2 vm-test-run-flakelet> machine # [ 11.584951] dhcpcd[898]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-flakelet> machine # [ 11.585919] dhcpcd[898]: eth0: adding route to fec0::/64 vm-test-run-flakelet> machine # [ 11.586921] dhcpcd[898]: eth0: adding default route via fe80::2 vm-test-run-flakelet> machine # [ 11.646261] nix-daemon[1035]: accepted connection from pid 1054, user flakelet vm-test-run-flakelet> machine: (finished: waiting for unit web.service, in 13.13 seconds) vm-test-run-flakelet> machine: waiting for unit cli.service vm-test-run-flakelet> machine: (finished: waiting for unit cli.service, in 0.07 seconds) vm-test-run-flakelet> (finished: run the VM test script, in 66.08 seconds) vm-test-run-flakelet> test script finished in 66.12s vm-test-run-flakelet> cleanup vm-test-run-flakelet> kill QemuMachine (pid 84) vm-test-run-flakelet> machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/rgnappqqc5vbq60gza5fflyk84sylwl6-python3-3.14.6/bin/python3.14) vm-test-run-flakelet> (finished: cleanup, in 0.20 seconds) post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet attr=checks.x86_64-linux.vm