Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script additionally exposed symbols: machine, nft, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.2PY1OHloAg', fmt=raw size=25769803776 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/6291456 done machine # Creating filesystem with 6291456 4k blocks and 1572864 inodes machine # Filesystem UUID: 2ddc63e2-4e64-4a33-b2c8-a1d8cde6e333 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208, machine # 4096000 machine # machine # Allocating group tables: 0/192 done machine # Writing inode tables: 0/192 done machine # Creating journal (32768 blocks): done machine: QEMU running (pid 45) machine # Writing superblocks and filesystem accounting information: 0/192 done machine # machine # Virtualisation disk image created. nft: starting vm machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) nft # Disk image does not exist, creating the virtualisation disk image... nft # Formatting '/build/vm-state-nft/tmp.dNZ1vJWRRZ', fmt=raw size=1073741824 nft # mke2fs 1.47.4 (6-Mar-2025) nft # Discarding device blocks: 0/262144 done nft # Creating filesystem with 262144 4k blocks and 65536 inodes nft # Filesystem UUID: c2a1b4d1-7598-4477-be56-69de528279e6 nft # Superblock backups stored on blocks: nft # 32768, 98304, 163840, 229376 nft: QEMU running (pid 71) nft # nft # Allocating group tables: 0/8 done nft # Writing inode tables: 0/8 done nft # Creating journal (8192 blocks): done nft # Writing superblocks and filesystem accounting information: 0/8 done nft # nft # Virtualisation disk image created. machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine # machine # machine # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BEFD1920+BEF31920 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:03.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM BEFD1920 BEF31920 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:09.0)... machine # machine # machine # Booting from ROM... nft # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) nft # nft # nft # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA00 nft # Press Ctrl-B to configure iPXE (PCI 00:03.0)... nft # nft # nft # nft # nft # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB00 nft # Press Ctrl-B to configure iPXE (PCI 00:09.0)... nft # nft # nft # Booting from ROM... nft # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Thu Jul 30 11:05:57 UTC 2026 nft # [ 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/51l4wdy1ai1zgyndx7j1vl827a2rggad-nixos-system-nft-test/init regInfo=/nix/store/k482xshjxgm51imrh7ykfzn3hd1g9zk0-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.000000] BIOS-provided physical RAM map: machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Thu Jul 30 11:05:57 UTC 2026 nft # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable nft # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable 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/rq7w421mh4fzzj33qpzj08vzrbds0rs0-nixos-system-machine-test/init regInfo=/nix/store/mydfxnjkvf1lmclvqhmkfwhn2s3wgy9v-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved machine # [ 0.000000] BIOS-provided physical RAM map: nft # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable nft # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved nft # [ 0.000000] NX (Execute Disable) protection: active nft # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdafff] usable nft # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] BIOS-e820: [mem 0x00000000bffdb000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved nft # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 nft # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved nft # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable nft # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x400000000 nft # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved nft # [ 0.000001] kvm-clock: using sched offset of 457899695 cycles machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. nft # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns nft # [ 0.000005] tsc: Detected 4192.076 MHz processor machine # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 nft # [ 0.000642] last_pfn = 0x7ffdb max_arch_pfn = 0x400000000 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM nft # [ 0.000676] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000000] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 nft # [ 0.000678] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 nft # [ 0.002499] found SMP MP-table at [mem 0x000f5470-0x000f547f] machine # [ 0.000000] kvm-clock: using sched offset of 416124690 cycles nft # [ 0.002513] Using GB pages for direct mapping nft # [ 0.002633] RAMDISK: [mem 0x7e32d000-0x7ffcffff] machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns nft # [ 0.002638] ACPI: Early table checksum verification disabled machine # [ 0.000005] tsc: Detected 4192.076 MHz processor nft # [ 0.002642] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) machine # [ 0.000637] last_pfn = 0x240000 max_arch_pfn = 0x400000000 nft # [ 0.002645] ACPI: RSDT 0x000000007FFE2427 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000667] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs nft # [ 0.002649] ACPI: FACP 0x000000007FFE22D3 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000670] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT nft # [ 0.002654] ACPI: DSDT 0x000000007FFE0040 002293 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000710] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 nft # [ 0.002656] ACPI: FACS 0x000000007FFE0000 000040 machine # [ 0.002595] found SMP MP-table at [mem 0x000f5470-0x000f547f] machine # [ 0.002610] Using GB pages for direct mapping nft # [ 0.002657] ACPI: APIC 0x000000007FFE2347 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002742] RAMDISK: [mem 0xbe32d000-0xbffcffff] nft # [ 0.002658] ACPI: HPET 0x000000007FFE23C7 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002750] ACPI: Early table checksum verification disabled machine # [ 0.002754] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) nft # [ 0.002659] ACPI: WAET 0x000000007FFE23FF 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002758] ACPI: RSDT 0x00000000BFFE24E3 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.002661] ACPI: Reserving FACP table memory at [mem 0x7ffe22d3-0x7ffe2346] nft # [ 0.002662] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe22d2] machine # [ 0.002763] ACPI: FACP 0x00000000BFFE237F 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.002662] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] machine # [ 0.002770] ACPI: DSDT 0x00000000BFFE0040 00233F (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.002662] ACPI: Reserving APIC table memory at [mem 0x7ffe2347-0x7ffe23c6] machine # [ 0.002773] ACPI: FACS 0x00000000BFFE0000 000040 nft # [ 0.002663] ACPI: Reserving HPET table memory at [mem 0x7ffe23c7-0x7ffe23fe] machine # [ 0.002774] ACPI: APIC 0x00000000BFFE23F3 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.002663] ACPI: Reserving WAET table memory at [mem 0x7ffe23ff-0x7ffe2426] nft # [ 0.003060] No NUMA configuration found machine # [ 0.002777] ACPI: HPET 0x00000000BFFE2483 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003062] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] machine # [ 0.002779] ACPI: WAET 0x00000000BFFE24BB 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003064] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] nft # [ 0.003139] Zone ranges: machine # [ 0.002781] ACPI: Reserving FACP table memory at [mem 0xbffe237f-0xbffe23f2] nft # [ 0.003139] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.002782] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe237e] nft # [ 0.003140] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] nft # [ 0.003141] Normal empty machine # [ 0.002788] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] nft # [ 0.003142] Device empty nft # [ 0.003142] Movable zone start for each node machine # [ 0.002789] ACPI: Reserving APIC table memory at [mem 0xbffe23f3-0xbffe2482] nft # [ 0.003143] Early memory node ranges machine # [ 0.002789] ACPI: Reserving HPET table memory at [mem 0xbffe2483-0xbffe24ba] nft # [ 0.003143] node 0: [mem 0x0000000000001000-0x000000000009efff] nft # [ 0.003144] node 0: [mem 0x0000000000100000-0x000000007ffdafff] machine # [ 0.002790] ACPI: Reserving WAET table memory at [mem 0xbffe24bb-0xbffe24e2] machine # [ 0.003214] No NUMA configuration found nft # [ 0.003145] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] machine # [ 0.003216] Faking a node at [mem 0x0000000000000000-0x000000023fffffff] nft # [ 0.003160] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.003219] NODE_DATA(0) allocated [mem 0x23fffa780-0x23ffffcff] nft # [ 0.003378] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.003320] Zone ranges: nft # [ 0.033651] On node 0, zone DMA32: 37 pages in unavailable ranges nft # [ 0.034520] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.003320] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.003322] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] nft # [ 0.034536] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.003323] Normal [mem 0x0000000100000000-0x000000023fffffff] nft # [ 0.034564] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.003325] Device empty nft # [ 0.034567] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) nft # [ 0.034569] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.003325] Movable zone start for each node machine # [ 0.003326] Early memory node ranges machine # [ 0.003327] node 0: [mem 0x0000000000001000-0x000000000009efff] nft # [ 0.034570] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.003328] node 0: [mem 0x0000000000100000-0x00000000bffdafff] nft # [ 0.034571] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.003329] node 0: [mem 0x0000000100000000-0x000000023fffffff] nft # [ 0.034572] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.003330] Initmem setup node 0 [mem 0x0000000000001000-0x000000023fffffff] nft # [ 0.034575] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.003351] On node 0, zone DMA: 1 pages in unavailable ranges nft # [ 0.034576] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.003736] On node 0, zone DMA: 97 pages in unavailable ranges nft # [ 0.034581] TSC deadline timer available machine # [ 0.120376] On node 0, zone Normal: 37 pages in unavailable ranges nft # [ 0.034586] CPU topo: Max. logical packages: 1 machine # [ 0.121155] ACPI: PM-Timer IO Port: 0x608 nft # [ 0.034587] CPU topo: Max. logical dies: 1 nft # [ 0.034587] CPU topo: Max. dies per package: 1 machine # [ 0.121171] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) nft # [ 0.034591] CPU topo: Max. threads per core: 1 machine # [ 0.121195] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 nft # [ 0.034592] CPU topo: Num. cores per package: 2 nft # [ 0.034593] CPU topo: Num. threads per package: 2 machine # [ 0.121198] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) nft # [ 0.034593] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs machine # [ 0.121199] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) nft # [ 0.034615] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.121200] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) nft # [ 0.034632] kvm-guest: KVM setup pv remote TLB flush nft # [ 0.034636] kvm-guest: setup PV sched yield machine # [ 0.121201] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.121201] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) nft # [ 0.034654] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.121204] ACPI: Using ACPI (MADT) for SMP configuration information nft # [ 0.034655] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.121205] ACPI: HPET id: 0x8086a201 base: 0xfed00000 nft # [ 0.034657] [mem 0x80000000-0xfeffbfff] available for PCI devices machine # [ 0.121211] TSC deadline timer available nft # [ 0.034658] Booting paravirtualized kernel on KVM machine # [ 0.121215] CPU topo: Max. logical packages: 1 machine # [ 0.121216] CPU topo: Max. logical dies: 1 nft # [ 0.034662] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.121217] CPU topo: Max. dies per package: 1 nft # [ 0.039602] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 machine # [ 0.121219] CPU topo: Max. threads per core: 1 machine # [ 0.121220] CPU topo: Num. cores per package: 4 nft # [ 0.041869] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 machine # [ 0.121220] CPU topo: Num. threads per package: 4 nft # [ 0.041924] kvm-guest: PV spinlocks enabled machine # [ 0.121220] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs nft # [ 0.041927] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) machine # [ 0.121241] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.121257] kvm-guest: KVM setup pv remote TLB flush machine # [ 0.121260] kvm-guest: setup PV sched yield machine # [ 0.121276] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] nft # [ 0.041930] 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/51l4wdy1ai1zgyndx7j1vl827a2rggad-nixos-system-nft-test/init regInfo=/nix/store/k482xshjxgm51imrh7ykfzn3hd1g9zk0-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.121277] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.121278] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] nft # [ 0.042049] Unknown kernel command line parameters "regInfo=/nix/store/k482xshjxgm51imrh7ykfzn3hd1g9zk0-closure-info/registration", will be passed to user space. machine # [ 0.121279] [mem 0xc0000000-0xfeffbfff] available for PCI devices nft # [ 0.042255] random: crng init done machine # [ 0.121281] Booting paravirtualized kernel on KVM nft # [ 0.042256] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.121284] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns nft # [ 0.044388] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) machine # [ 0.124831] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 nft # [ 0.045655] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) nft # [ 0.045725] Fallback order for Node 0: 0 machine # [ 0.126531] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288 machine # [ 0.126571] kvm-guest: PV spinlocks enabled nft # [ 0.045729] Built 1 zonelists, mobility grouping on. Total pages: 524153 nft # [ 0.045731] Policy zone: DMA32 machine # [ 0.126573] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) nft # [ 0.047838] mem auto-init: stack:all(zero), heap alloc:on, heap free:off nft # [ 0.052515] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 nft # [ 0.056155] allocated 4194304 bytes of page_ext nft # [ 0.066337] ftrace: allocating 48695 entries in 192 pages nft # [ 0.066339] ftrace: allocated 192 pages with 2 groups nft # [ 0.067202] Dynamic Preempt: lazy machine # [ 0.126575] 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/rq7w421mh4fzzj33qpzj08vzrbds0rs0-nixos-system-machine-test/init regInfo=/nix/store/mydfxnjkvf1lmclvqhmkfwhn2s3wgy9v-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.067385] rcu: Preemptible hierarchical RCU implementation. nft # [ 0.067387] rcu: RCU event tracing is enabled. machine # [ 0.126649] Unknown kernel command line parameters "regInfo=/nix/store/mydfxnjkvf1lmclvqhmkfwhn2s3wgy9v-closure-info/registration", will be passed to user space. nft # [ 0.067388] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. machine # [ 0.126844] random: crng init done nft # [ 0.067390] Trampoline variant of Tasks RCU enabled. machine # [ 0.126845] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes nft # [ 0.067390] Rude variant of Tasks RCU enabled. nft # [ 0.067391] Tracing variant of Tasks RCU enabled. machine # [ 0.133515] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) nft # [ 0.067391] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.136894] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) machine # [ 0.136954] software IO TLB: area num 4. nft # [ 0.067392] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 machine # [ 0.199416] Fallback order for Node 0: 0 machine # [ 0.199426] Built 1 zonelists, mobility grouping on. Total pages: 2097017 nft # [ 0.067411] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.199428] Policy zone: Normal machine # [ 0.201426] mem auto-init: stack:all(zero), heap alloc:on, heap free:off nft # [ 0.067413] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.214147] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 nft # [ 0.067414] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.230197] allocated 16777216 bytes of page_ext machine # [ 0.240975] ftrace: allocating 48695 entries in 192 pages nft # [ 0.072208] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 machine # [ 0.240977] ftrace: allocated 192 pages with 2 groups nft # [ 0.072562] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.241842] Dynamic Preempt: lazy machine # [ 0.242009] rcu: Preemptible hierarchical RCU implementation. nft # [ 0.072568] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.242010] rcu: RCU event tracing is enabled. machine # [ 0.242011] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. nft # [ 0.072748] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.242013] Trampoline variant of Tasks RCU enabled. nft # [ 0.079039] Console: colour VGA+ 80x25 machine # [ 0.242013] Rude variant of Tasks RCU enabled. nft # [ 0.079043] printk: legacy console [tty0] enabled machine # [ 0.242014] Tracing variant of Tasks RCU enabled. nft # [ 0.118043] printk: legacy console [ttyS0] enabled nft # [ 0.269566] ACPI: Core revision 20250807 machine # [ 0.242014] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.242015] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 nft # [ 0.270722] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.242040] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. nft # [ 0.272848] APIC: Switch to symmetric I/O mode setup nft # [ 0.274149] x2apic enabled machine # [ 0.242042] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. nft # [ 0.275051] APIC: Switched APIC routing to: physical x2apic machine # [ 0.242044] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. nft # [ 0.276308] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() machine # [ 0.246588] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16 machine # [ 0.246861] rcu: srcu_init: Setting srcu_struct sizes based on contention. nft # [ 0.277938] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() nft # [ 0.280191] kvm-guest: setup PV IPIs machine # [ 0.246866] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.247040] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) nft # [ 0.282107] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.253427] Console: colour VGA+ 80x25 machine # [ 0.253431] printk: legacy console [tty0] enabled nft # [ 0.283437] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns machine # [ 0.291481] printk: legacy console [ttyS0] enabled machine # [ 0.452844] ACPI: Core revision 20250807 nft # [ 0.285766] Calibrating delay loop (skipped) preset value.. 8384.15 BogoMIPS (lpj=4192076) nft # [ 0.287859] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.454169] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns nft # [ 0.289903] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.456462] APIC: Switch to symmetric I/O mode setup machine # [ 0.457867] x2apic enabled nft # [ 0.290765] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.458810] APIC: Switched APIC routing to: physical x2apic nft # [ 0.291770] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.460099] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() nft # [ 0.292765] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.461929] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() machine # [ 0.464234] kvm-guest: setup PV IPIs machine # [ 0.466355] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 nft # [ 0.293765] Spectre V2 : Mitigation: Enhanced / Automatic IBRS nft # [ 0.295765] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.467943] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns nft # [ 0.296765] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization nft # [ 0.298773] Spectre V2 : Enabling IBPB for BPF machine # [ 0.470555] Calibrating delay loop (skipped) preset value.. 8384.15 BogoMIPS (lpj=4192076) nft # [ 0.299766] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.471679] x86/cpu: User Mode Instruction Prevention (UMIP) activated nft # [ 0.301765] active return thunk: srso_alias_return_thunk nft # [ 0.302795] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' nft # [ 0.304764] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' nft # [ 0.305765] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.472697] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 nft # [ 0.307764] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.474553] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 nft # [ 0.308765] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' nft # [ 0.309765] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.475558] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto nft # [ 0.311764] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.477553] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl nft # [ 0.312767] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' machine # [ 0.478554] Spectre V2 : Mitigation: Enhanced / Automatic IBRS nft # [ 0.313765] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' machine # [ 0.479554] Speculative Return Stack Overflow: Mitigation: Safe RET nft # [ 0.315766] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.481553] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization nft # [ 0.317765] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 nft # [ 0.318765] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.482562] Spectre V2 : Enabling IBPB for BPF nft # [ 0.320766] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.483555] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier nft # [ 0.321766] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.485555] active return thunk: srso_alias_return_thunk nft # [ 0.323766] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 machine # [ 0.487582] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' nft # [ 0.324771] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 machine # [ 0.488553] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.489553] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' nft # [ 0.325767] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. machine # [ 0.491552] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.492553] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.493553] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.495552] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.496552] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' machine # [ 0.497553] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' machine # [ 0.499553] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.500553] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.501553] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.503553] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.504553] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.506553] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 machine # [ 0.507553] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 machine # [ 0.509553] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. nft # [ 0.353977] Freeing SMP alternatives memory: 44K nft # [ 0.354768] pid_max: default: 32768 minimum: 301 nft # [ 0.355845] LSM: initializing lsm=capability,landlock,yama,bpf,ima nft # [ 0.357845] landlock: Up and running. nft # [ 0.358765] Yama: becoming mindful. nft # [ 0.360008] LSM support for eBPF active nft # [ 0.360889] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) nft # [ 0.361806] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) nft # [ 0.364321] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) nft # [ 0.365212] Performance Events: Fam17h+ core perfctr, AMD PMU driver. nft # [ 0.365773] ... version: 2 nft # [ 0.366735] ... bit width: 48 nft # [ 0.367540] ... generic counters: 6 nft # [ 0.368523] ... generic bitmap: 000000000000003f nft # [ 0.368766] ... fixed-purpose counters: 0 nft # [ 0.369749] ... fixed-purpose bitmap: 0000000000000000 nft # [ 0.370754] ... value mask: 0000ffffffffffff machine # [ 0.538862] Freeing SMP alternatives memory: 44K nft # [ 0.371730] ... max period: 00007fffffffffff machine # [ 0.539556] pid_max: default: 32768 minimum: 301 nft # [ 0.372730] ... global_ctrl mask: 000000000000003f nft # [ 0.373854] signal: max sigframe size: 3376 machine # [ 0.540629] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.541661] landlock: Up and running. nft # [ 0.374842] rcu: Hierarchical SRCU implementation. machine # [ 0.542553] Yama: becoming mindful. nft # [ 0.375771] rcu: Max phase no-delay instances is 400. machine # [ 0.543746] LSM support for eBPF active nft # [ 0.376967] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level machine # [ 0.544736] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.546621] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) nft # [ 0.381129] smp: Bringing up secondary CPUs ... machine # [ 0.549376] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) nft # [ 0.382030] smpboot: x86: Booting SMP configuration: nft # [ 0.382775] .... node #0, CPUs: #1 machine # [ 0.550080] Performance Events: Fam17h+ core perfctr, AMD PMU driver. nft # [ 0.382893] smp: Brought up 1 node, 2 CPUs machine # [ 0.550558] ... version: 2 machine # [ 0.551554] ... bit width: 48 nft # [ 0.384771] smpboot: Total of 2 processors activated (16768.30 BogoMIPS) machine # [ 0.552569] ... generic counters: 6 machine # [ 0.553555] ... generic bitmap: 000000000000003f nft # [ 0.385986] Memory: 1970632K/2096612K available (17198K kernel code, 2726K rwdata, 13572K rodata, 3644K init, 2992K bss, 116152K reserved, 0K cma-reserved) machine # [ 0.554554] ... fixed-purpose counters: 0 machine # [ 0.555554] ... fixed-purpose bitmap: 0000000000000000 nft # [ 0.386941] devtmpfs: initialized nft # [ 0.388005] x86/mm: Memory block size: 128MB machine # [ 0.556555] ... value mask: 0000ffffffffffff machine # [ 0.557555] ... max period: 00007fffffffffff machine # [ 0.558555] ... global_ctrl mask: 000000000000003f nft # [ 0.389790] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) machine # [ 0.559656] signal: max sigframe size: 3376 nft # [ 0.390813] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). machine # [ 0.560619] rcu: Hierarchical SRCU implementation. machine # [ 0.561558] rcu: Max phase no-delay instances is 400. nft # [ 0.391848] pinctrl core: initialized pinctrl subsystem nft # [ 0.393074] PM: RTC time: 08:06:25, date: 2026-08-03 machine # [ 0.562710] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level nft # [ 0.395949] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.567000] smp: Bringing up secondary CPUs ... nft # [ 0.397228] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.567896] smpboot: x86: Booting SMP configuration: nft # [ 0.397789] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations nft # [ 0.399001] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.568557] .... node #0, CPUs: #1 #2 #3 nft # [ 0.399777] audit: initializing netlink subsys (disabled) machine # [ 0.570599] smp: Brought up 1 node, 4 CPUs machine # [ 0.572555] smpboot: Total of 4 processors activated (33536.60 BogoMIPS) nft # [ 0.400825] audit: type=2000 audit(1785744386.340:1): state=initialized audit_enabled=0 res=1 nft # [ 0.400998] thermal_sys: Registered thermal governor 'fair_share' nft # [ 0.401773] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.573753] Memory: 8073700K/8388068K available (17198K kernel code, 2726K rwdata, 13572K rodata, 3644K init, 2992K bss, 290784K reserved, 0K cma-reserved) nft # [ 0.402769] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.574783] devtmpfs: initialized machine # [ 0.575772] x86/mm: Memory block size: 128MB nft # [ 0.403768] thermal_sys: Registered thermal governor 'user_space' nft # [ 0.404767] thermal_sys: Registered thermal governor 'power_allocator' nft # [ 0.405781] cpuidle: using governor menu machine # [ 0.578735] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) nft # [ 0.408426] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 nft # [ 0.410008] PCI: Using configuration type 1 for base access machine # [ 0.579634] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). nft # [ 0.410766] PCI: Using configuration type 1 for extended access machine # [ 0.580636] pinctrl core: initialized pinctrl subsystem machine # [ 0.581829] PM: RTC time: 08:06:26, date: 2026-08-03 nft # [ 0.411994] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.584964] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.586545] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.587613] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.589412] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations nft # [ 0.421783] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.590564] audit: initializing netlink subsys (disabled) nft # [ 0.422767] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page nft # [ 0.423767] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.591640] audit: type=2000 audit(1785744386.355:1): state=initialized audit_enabled=0 res=1 nft # [ 0.425563] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.591765] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.592558] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.593555] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.594555] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.595555] thermal_sys: Registered thermal governor 'power_allocator' nft # [ 0.432163] ACPI: Added _OSI(Module Device) machine # [ 0.596583] cpuidle: using governor menu nft # [ 0.432769] ACPI: Added _OSI(Processor Device) nft # [ 0.434769] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.599564] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.600841] PCI: Using configuration type 1 for base access machine # [ 0.601554] PCI: Using configuration type 1 for extended access nft # [ 0.437856] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.602716] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. nft # [ 0.440992] ACPI: Interpreter enabled nft # [ 0.441805] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.603914] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages nft # [ 0.442768] ACPI: Using IOAPIC for interrupt routing machine # [ 0.604556] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.605556] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.606554] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page nft # [ 0.444861] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug nft # [ 0.447768] PCI: Using E820 reservations for host bridge windows machine # [ 0.608885] ACPI: Added _OSI(Module Device) nft # [ 0.449986] ACPI: Enabled 2 GPEs in block 00 to 0F machine # [ 0.609555] ACPI: Added _OSI(Processor Device) machine # [ 0.610555] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.613192] ACPI: 1 ACPI AML tables successfully acquired and loaded nft # [ 0.454573] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) nft # [ 0.456775] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] nft # [ 0.458161] acpiphp: Slot [3] registered machine # [ 0.615791] ACPI: Interpreter enabled machine # [ 0.617257] ACPI: PM: (supports S0 S3 S4 S5) nft # [ 0.459795] acpiphp: Slot [4] registered nft # [ 0.460811] acpiphp: Slot [5] registered machine # [ 0.618427] ACPI: Using IOAPIC for interrupt routing nft # [ 0.462827] acpiphp: Slot [6] registered nft # [ 0.463804] acpiphp: Slot [7] registered machine # [ 0.619574] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug nft # [ 0.464805] acpiphp: Slot [8] registered machine # [ 0.620555] PCI: Using E820 reservations for host bridge windows nft # [ 0.465803] acpiphp: Slot [9] registered machine # [ 0.621722] ACPI: Enabled 2 GPEs in block 00 to 0F nft # [ 0.466819] acpiphp: Slot [10] registered nft # [ 0.467819] acpiphp: Slot [11] registered nft # [ 0.468814] acpiphp: Slot [12] registered nft # [ 0.469857] acpiphp: Slot [13] registered nft # [ 0.471808] acpiphp: Slot [14] registered nft # [ 0.472799] acpiphp: Slot [15] registered machine # [ 0.627397] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) nft # [ 0.473796] acpiphp: Slot [16] registered nft # [ 0.474738] acpiphp: Slot [17] registered nft # [ 0.475510] acpiphp: Slot [18] registered machine # [ 0.628562] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] nft # [ 0.475804] acpiphp: Slot [19] registered machine # [ 0.629944] acpiphp: Slot [3] registered nft # [ 0.477821] acpiphp: Slot [20] registered machine # [ 0.630601] acpiphp: Slot [4] registered nft # [ 0.478825] acpiphp: Slot [21] registered machine # [ 0.631589] acpiphp: Slot [5] registered nft # [ 0.479788] acpiphp: Slot [22] registered machine # [ 0.632588] acpiphp: Slot [6] registered nft # [ 0.480748] acpiphp: Slot [23] registered machine # [ 0.633588] acpiphp: Slot [7] registered nft # [ 0.481557] acpiphp: Slot [24] registered machine # [ 0.634599] acpiphp: Slot [8] registered nft # [ 0.482598] acpiphp: Slot [25] registered machine # [ 0.635588] acpiphp: Slot [9] registered nft # [ 0.483582] acpiphp: Slot [26] registered nft # [ 0.484611] acpiphp: Slot [27] registered machine # [ 0.636589] acpiphp: Slot [10] registered nft # [ 0.485530] acpiphp: Slot [28] registered machine # [ 0.637592] acpiphp: Slot [11] registered nft # [ 0.486800] acpiphp: Slot [29] registered machine # [ 0.638600] acpiphp: Slot [12] registered nft # [ 0.487758] acpiphp: Slot [30] registered machine # [ 0.639587] acpiphp: Slot [13] registered nft # [ 0.488518] acpiphp: Slot [31] registered machine # [ 0.640586] acpiphp: Slot [14] registered nft # [ 0.489791] PCI host bridge to bus 0000:00 machine # [ 0.641586] acpiphp: Slot [15] registered nft # [ 0.490766] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.642596] acpiphp: Slot [16] registered machine # [ 0.643586] acpiphp: Slot [17] registered nft # [ 0.491770] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.644587] acpiphp: Slot [18] registered nft # [ 0.493769] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.645611] acpiphp: Slot [19] registered machine # [ 0.646587] acpiphp: Slot [20] registered nft # [ 0.494769] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] machine # [ 0.647586] acpiphp: Slot [21] registered nft # [ 0.496768] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] machine # [ 0.648587] acpiphp: Slot [22] registered machine # [ 0.649596] acpiphp: Slot [23] registered nft # [ 0.498769] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.650587] acpiphp: Slot [24] registered machine # [ 0.651630] acpiphp: Slot [25] registered nft # [ 0.500174] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.652615] acpiphp: Slot [26] registered machine # [ 0.653646] acpiphp: Slot [27] registered nft # [ 0.502613] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.654593] acpiphp: Slot [28] registered machine # [ 0.655577] acpiphp: Slot [29] registered machine # [ 0.656516] acpiphp: Slot [30] registered nft # [ 0.505557] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint machine # [ 0.657305] acpiphp: Slot [31] registered machine # [ 0.657593] PCI host bridge to bus 0000:00 nft # [ 0.508818] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] machine # [ 0.658518] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] nft # [ 0.509818] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk machine # [ 0.659556] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] nft # [ 0.510768] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk machine # [ 0.660556] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] nft # [ 0.512768] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk machine # [ 0.661555] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] nft # [ 0.513767] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk machine # [ 0.662556] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] nft # [ 0.515061] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.663557] pci_bus 0000:00: root bus resource [bus 00-ff] nft # [ 0.518840] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] machine # [ 0.664906] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint nft # [ 0.520849] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint machine # [ 0.666316] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint nft # [ 0.523332] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI machine # [ 0.668412] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint nft # [ 0.524780] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB machine # [ 0.670623] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] nft # [ 0.526173] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.671617] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk machine # [ 0.672556] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk machine # [ 0.673556] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk nft # [ 0.532830] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.674556] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk nft # [ 0.533794] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.675914] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint nft # [ 0.535820] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.677612] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] nft # [ 0.537025] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.679545] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint nft # [ 0.540648] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.681052] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI nft # [ 0.543749] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.681566] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB nft # [ 0.545723] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.682933] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint nft # [ 0.546821] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.685616] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] nft # [ 0.548787] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.686582] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.687598] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] nft # [ 0.561668] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.565779] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] nft # [ 0.566778] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] nft # [ 0.567808] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] nft # [ 0.571486] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.688758] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] nft # [ 0.575782] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.691603] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint nft # [ 0.577780] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] nft # [ 0.578807] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.694566] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.695567] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] nft # [ 0.581659] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.696603] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] machine # [ 0.697565] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] nft # [ 0.585767] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] nft # [ 0.587792] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.700274] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.588824] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.702579] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.703566] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] nft # [ 0.592422] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.704603] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] nft # [ 0.594778] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] nft # [ 0.596783] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.707293] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint nft # [ 0.597812] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.709565] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.710566] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] nft # [ 0.601667] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.711597] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] nft # [ 0.605757] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] nft # [ 0.606780] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.714394] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint nft # [ 0.608811] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.717347] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] nft # [ 0.611457] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.718569] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] nft # [ 0.614778] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] machine # [ 0.719600] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] nft # [ 0.615778] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] nft # [ 0.616808] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.722363] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint nft # [ 0.618779] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.725422] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] nft # [ 0.621399] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.726569] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] nft # [ 0.624788] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.727604] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] nft # [ 0.625807] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] nft # [ 0.629369] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.730458] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint nft # [ 0.631794] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] machine # [ 0.733356] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] nft # [ 0.633779] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.734569] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] nft # [ 0.634809] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.735598] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] nft # [ 0.637620] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.738145] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint nft # [ 0.640786] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] nft # [ 0.641778] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.739567] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] machine # [ 0.740567] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] nft # [ 0.643809] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.741596] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] machine # [ 0.742566] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.745644] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint nft # [ 0.650809] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 nft # [ 0.651943] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.747583] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] nft # [ 0.653920] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.748598] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] nft # [ 0.654922] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 nft # [ 0.656863] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 machine # [ 0.751201] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint nft # [ 0.659796] iommu: Default domain type: Translated nft # [ 0.660768] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.753187] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] nft # [ 0.661979] ACPI: bus type USB registered machine # [ 0.753566] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] nft # [ 0.662835] usbcore: registered new interface driver usbfs machine # [ 0.754595] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] nft # [ 0.664786] usbcore: registered new interface driver hub nft # [ 0.665791] usbcore: registered new device driver usb nft # [ 0.667874] NetLabel: Initializing machine # [ 0.757189] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.668720] NetLabel: domain hash size = 128 nft # [ 0.669560] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO nft # [ 0.670816] NetLabel: unlabeled traffic allowed by default machine # [ 0.759554] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] nft # [ 0.672780] PCI: Using ACPI for IRQ routing machine # [ 0.760571] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] nft # [ 0.674162] pci 0000:00:02.0: vgaarb: setting as boot VGA device machine # [ 0.761602] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] nft # [ 0.674762] pci 0000:00:02.0: vgaarb: bridge control possible nft # [ 0.674762] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none nft # [ 0.677770] vgaarb: loaded nft # [ 0.678658] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 nft # [ 0.680639] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.769570] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 nft # [ 0.684861] clocksource: Switched to clocksource kvm-clock machine # [ 0.770727] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 nft # [ 0.686582] VFS: Disk quotas dquot_6.6.0 machine # [ 0.771722] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.772710] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 nft # [ 0.687556] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) nft # [ 0.689448] pnp: PnP ACPI init machine # [ 0.773672] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 nft # [ 0.690856] pnp: PnP ACPI: found 6 devices machine # [ 0.775844] iommu: Default domain type: Translated machine # [ 0.776556] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.777717] ACPI: bus type USB registered machine # [ 0.778622] usbcore: registered new interface driver usbfs machine # [ 0.779579] usbcore: registered new interface driver hub machine # [ 0.780570] usbcore: registered new device driver usb nft # [ 0.698937] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.782227] NetLabel: Initializing nft # [ 0.700916] clocksource: Switched to clocksource acpi_pm machine # [ 0.783170] NetLabel: domain hash size = 128 machine # [ 0.783555] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO nft # [ 0.702259] NET: Registered PF_INET protocol family machine # [ 0.784598] NetLabel: unlabeled traffic allowed by default nft # [ 0.703764] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) machine # [ 0.785567] PCI: Using ACPI for IRQ routing machine # [ 0.786951] pci 0000:00:02.0: vgaarb: setting as boot VGA device machine # [ 0.787550] pci 0000:00:02.0: vgaarb: bridge control possible machine # [ 0.787550] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.787559] vgaarb: loaded machine # [ 0.788435] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.789402] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.794706] clocksource: Switched to clocksource kvm-clock machine # [ 0.796713] VFS: Disk quotas dquot_6.6.0 nft # [ 0.719487] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) machine # [ 0.797823] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) nft # [ 0.721678] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.799887] pnp: PnP ACPI init nft # [ 0.723495] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.801362] pnp: PnP ACPI: found 6 devices nft # [ 0.725838] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) nft # [ 0.727749] TCP: Hash tables configured (established 16384 bind 16384) nft # [ 0.729482] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) nft # [ 0.731439] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) nft # [ 0.733130] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) machine # [ 0.810208] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns nft # [ 0.735043] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.812403] clocksource: Switched to clocksource acpi_pm nft # [ 0.736498] NET: Registered PF_XDP protocol family machine # [ 0.813975] NET: Registered PF_INET protocol family nft # [ 0.737695] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] nft # [ 0.739044] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.816482] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) nft # [ 0.740441] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] nft # [ 0.741968] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] nft # [ 0.743503] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] nft # [ 0.745117] pci 0000:00:01.0: PIIX3: Enabling Passive Release nft # [ 0.746490] pci 0000:00:00.0: Limiting direct PCI/PCI transfers nft # [ 0.749057] ACPI: \_SB_.LNKD: Enabled at IRQ 11 nft # [ 0.751652] PCI: CLS 0 bytes, default 64 nft # [ 0.752818] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns nft # [ 0.752919] Trying to unpack rootfs image as initramfs... machine # [ 0.831413] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) machine # [ 0.833463] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.835372] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.839025] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) machine # [ 0.840974] TCP: Hash tables configured (established 65536 bind 65536) machine # [ 0.842931] MPTCP token hash table entries: 8192 (order: 6, 196608 bytes, linear) machine # [ 0.845006] UDP hash table entries: 4096 (order: 6, 262144 bytes, linear) nft # [ 0.769729] Initialise system trusted keyrings machine # [ 0.846850] UDP-Lite hash table entries: 4096 (order: 6, 262144 bytes, linear) nft # [ 0.771357] workingset: timestamp_bits=40 max_order=19 bucket_order=0 machine # [ 0.848722] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.850092] NET: Registered PF_XDP protocol family machine # [ 0.851281] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.852720] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.854180] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.855760] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] machine # [ 0.857304] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] machine # [ 0.859117] pci 0000:00:01.0: PIIX3: Enabling Passive Release machine # [ 0.860529] pci 0000:00:00.0: Limiting direct PCI/PCI transfers nft # [ 0.785120] Key type asymmetric registered nft # [ 0.786305] Asymmetric key parser 'x509' registered machine # [ 0.863356] ACPI: \_SB_.LNKD: Enabled at IRQ 11 nft # [ 0.787678] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.866222] PCI: CLS 0 bytes, default 64 nft # [ 0.790301] io scheduler mq-deadline registered nft # [ 0.791489] io scheduler kyber registered machine # [ 0.867312] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) machine # [ 0.867479] Trying to unpack rootfs image as initramfs... machine # [ 0.867590] software IO TLB: mapped [mem 0x00000000ba32d000-0x00000000be32d000] (64MB) nft # [ 0.794575] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled nft # [ 0.796406] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.872348] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns nft # [ 0.799437] Linux agpgart interface v0.103 nft # [ 0.800570] ACPI: bus type drm_connector registered nft # [ 0.806430] usbcore: registered new interface driver usbserial_generic nft # [ 0.808136] usbserial: USB Serial support registered for generic nft # [ 0.809754] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. nft # [ 0.809754] Please enable it if your BIOS has the CPPC option. nft # [ 0.813154] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.891986] Initialise system trusted keyrings nft # [ 0.815328] drop_monitor: Initializing network drop monitor service nft # [ 0.817060] NET: Registered PF_INET6 protocol family machine # [ 0.893298] workingset: timestamp_bits=40 max_order=21 bucket_order=0 nft # [ 0.819295] Segment Routing with IPv6 nft # [ 0.820342] In-situ OAM (IOAM) with IPv6 nft # [ 0.823547] IPI shorthand broadcast: enabled machine # [ 0.903735] Key type asymmetric registered nft # [ 0.827619] sched_clock: Marking stable (622024773, 205195528)->(864743277, -37522976) machine # [ 0.904814] Asymmetric key parser 'x509' registered nft # [ 0.829771] registered taskstats version 1 machine # [ 0.906142] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) nft # [ 0.831003] Loading compiled-in X.509 certificates machine # [ 0.908379] io scheduler mq-deadline registered machine # [ 0.909551] io scheduler kyber registered machine # [ 0.914723] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled nft # [ 0.839648] Demotion targets for Node 0: null nft # [ 0.841352] Key type .fscrypt registered machine # [ 0.916967] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A nft # [ 0.842386] Key type fscrypt-provisioning registered nft # [ 0.843769] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.920472] Linux agpgart interface v0.103 nft # [ 0.845108] ima: Allocated hash algorithm: sha1 machine # [ 0.921682] ACPI: bus type drm_connector registered nft # [ 0.846317] ima: No architecture policies found nft # [ 0.847734] PM: Magic number: 6:149:118 machine # [ 0.924525] usbcore: registered new interface driver usbserial_generic machine # [ 0.926201] usbserial: USB Serial support registered for generic nft # [ 0.850019] RAS: Correctable Errors collector initialized. machine # [ 0.927743] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.927743] Please enable it if your BIOS has the CPPC option. nft # [ 0.855255] clk: Disabling unused clocks machine # [ 0.930909] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled nft # [ 0.856323] PM: genpd: Disabling unused power domains machine # [ 0.933136] drop_monitor: Initializing network drop monitor service machine # [ 0.934947] NET: Registered PF_INET6 protocol family machine # [ 0.938544] Segment Routing with IPv6 machine # [ 0.939786] In-situ OAM (IOAM) with IPv6 machine # [ 0.943966] IPI shorthand broadcast: enabled machine # [ 0.948730] sched_clock: Marking stable (734026342, 214684576)->(1076709215, -127998297) machine # [ 0.951351] registered taskstats version 1 machine # [ 0.952854] Loading compiled-in X.509 certificates machine # [ 0.962549] Demotion targets for Node 0: null machine # [ 0.963968] Key type .fscrypt registered machine # [ 0.965075] Key type fscrypt-provisioning registered machine # [ 0.966665] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.968138] ima: Allocated hash algorithm: sha1 machine # [ 0.969394] ima: No architecture policies found machine # [ 0.971062] PM: Magic number: 6:149:118 machine # [ 0.973451] RAS: Correctable Errors collector initialized. machine # [ 0.979268] clk: Disabling unused clocks machine # [ 0.980340] PM: genpd: Disabling unused power domains nft # [ 1.028344] Freeing initrd memory: 29324K nft # [ 1.031931] Freeing unused decrypted memory: 2028K nft # [ 1.034808] Freeing unused kernel image (initmem) memory: 3644K nft # [ 1.036283] Write protecting the kernel read-only data: 32768k nft # [ 1.038498] Freeing unused kernel image (text/rodata gap) memory: 1232K nft # [ 1.040396] Freeing unused kernel image (rodata/data gap) memory: 764K machine # [ 1.137723] Freeing initrd memory: 29324K machine # [ 1.141292] Freeing unused decrypted memory: 2028K machine # [ 1.144162] Freeing unused kernel image (initmem) memory: 3644K machine # [ 1.145640] Write protecting the kernel read-only data: 32768k machine # [ 1.147929] Freeing unused kernel image (text/rodata gap) memory: 1232K machine # [ 1.149911] Freeing unused kernel image (rodata/data gap) memory: 764K nft # [ 1.076587] x86/mm: Checked W+X mappings: passed, no W+X pages found. nft # [ 1.078038] Run /init as init process nft # [ 1.088224] systemd[1]: Inserted module 'autofs4' nft # [ 1.108701] fuse: init (API version 7.45) machine # [ 1.186911] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 1.188396] Run /init as init process nft # [ 1.116927] ACPI: \_SB_.LNKC: Enabled at IRQ 10 nft # [ 1.123885] ACPI: \_SB_.LNKA: Enabled at IRQ 10 machine # [ 1.201033] systemd[1]: Inserted module 'autofs4' nft # [ 1.127311] ACPI: \_SB_.LNKB: Enabled at IRQ 11 machine # [ 1.224043] fuse: init (API version 7.45) machine # [ 1.234109] ACPI: \_SB_.LNKC: Enabled at IRQ 10 nft # [ 1.163294] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.241519] ACPI: \_SB_.LNKA: Enabled at IRQ 10 machine # [ 1.245031] ACPI: \_SB_.LNKB: Enabled at IRQ 11 machine # [ 1.281638] systemd[1]: Successfully made /usr/ read-only. nft # [ 1.499758] systemd[1]: systemd 261.1 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) nft # [ 1.506259] systemd[1]: Detected virtualization kvm. nft # [ 1.507423] systemd[1]: Detected architecture x86-64. nft # [ 1.508569] systemd[1]: Running in initrd. nft # [ 1.509813] systemd[1]: Initializing machine ID from random generator. nft # [ 1.511338] systemd[1]: Hostname set to . machine # [ 1.627021] systemd[1]: systemd 261.1 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) machine # [ 1.633594] systemd[1]: Detected virtualization kvm. machine # [ 1.634815] systemd[1]: Detected architecture x86-64. machine # [ 1.635987] systemd[1]: Running in initrd. machine # [ 1.637301] systemd[1]: Initializing machine ID from random generator. machine # [ 1.638855] systemd[1]: Hostname set to . nft # [ 1.604384] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 1.638291] systemd[1]: Queued start job for default target Initrd Default Target. nft # [ 1.645942] systemd[1]: Created slice Slice /system/modprobe. nft # [ 1.647784] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. nft # [ 1.649915] systemd[1]: Expecting device /dev/disk/by-label/nixos... nft # [ 1.651671] systemd[1]: Reached target Path Units. nft # [ 1.653023] systemd[1]: Reached target Slice Units. nft # [ 1.654322] systemd[1]: Reached target Swaps. nft # [ 1.655484] systemd[1]: Reached target Timer Units. nft # [ 1.666764] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.743574] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 1.668621] systemd[1]: Listening on Journal Socket (/dev/log). nft # [ 1.670379] systemd[1]: Listening on Journal Sockets. nft # [ 1.671911] systemd[1]: Listening on udev Control Socket. nft # [ 1.673480] systemd[1]: Listening on udev Kernel Socket. nft # [ 1.674953] systemd[1]: Reached target Socket Units. nft # [ 1.677482] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 1.681305] systemd[1]: Starting Load Kernel Module 9pnet_virtio... nft # [ 1.685289] systemd[1]: Starting Load Kernel Module configfs... nft # [ 1.692938] systemd[1]: Starting Journal Service... nft # [ 1.696414] systemd[1]: Starting Load Kernel Modules... machine # [ 1.774047] systemd[1]: Queued start job for default target Initrd Default Target. nft # [ 1.699307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.782394] systemd[1]: Created slice Slice /system/modprobe. nft # [ 1.707405] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.784025] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.785934] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.787456] systemd[1]: Reached target Path Units. machine # [ 1.788620] systemd[1]: Reached target Slice Units. machine # [ 1.789999] systemd[1]: Reached target Swaps. machine # [ 1.791143] systemd[1]: Reached target Timer Units. machine # [ 1.792652] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.794518] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.796177] systemd[1]: Listening on Journal Sockets. nft # [ 1.720331] netfs: FS-Cache loaded machine # [ 1.797793] systemd[1]: Listening on udev Control Socket. machine # [ 1.799362] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.800816] systemd[1]: Reached target Socket Units. machine # [ 1.803309] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 1.729856] 9pnet: Installing 9P2000 support nft # [ 1.731632] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 1.733984] systemd-journald[76]: Collecting audit messages is disabled. machine # [ 1.811136] systemd[1]: Starting Load Kernel Module 9pnet_virtio... nft # [ 1.736422] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.813813] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.817321] systemd[1]: Starting Journal Service... nft # [ 1.742736] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.819669] systemd[1]: Starting Load Kernel Modules... machine # [ 1.821191] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 1.746778] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.824441] systemd[1]: Starting Coldplug All udev Devices... nft # [ 1.748753] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.829346] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.830529] systemd-journald[92]: Collecting audit messages is disabled. nft # [ 1.755734] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.832287] systemd[1]: modprobe@configfs.service: Deactivated successfully. nft # [ 1.757773] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev nft # [ 1.759896] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.838553] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.843822] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config nft # [ 1.769314] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... nft # [ 1.775991] systemd[1]: Finished Load Kernel Modules. machine # [ 1.854783] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.857549] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.858235] netfs: FS-Cache loaded nft # [ 1.784296] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.863765] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev nft # [ 1.792343] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.871454] systemd[1]: Finished Load Kernel Modules. machine # [ 1.873831] 9pnet: Installing 9P2000 support nft # [ 1.799299] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.875804] systemd[1]: Starting Apply Kernel Variables... nft # [ 1.604302] systemd-modules-load[77]: Using 2 probe threads machine # [ 1.885627] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. nft # [ 1.606135] systemd-modules-load[77]: Inserted module 'virtio_balloon' machine # [ 1.888301] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. nft # [ 1.812899] systemd[1]: Started Journal Service. machine # [ 1.890587] systemd[1]: Finished Load Kernel Module 9pnet_virtio. nft # [ 1.610110] systemd-modules-load[77]: Inserted module 'virtio_gpu' machine # [ 1.892903] systemd[1]: Finished Apply Kernel Variables. nft # [ 1.611652] systemd-modules-load[77]: Inserted module 'dm_mod' machine # [ 1.679661] s[ 1.894526] systemd[1]: Started Journal Service. machine # ystemd-modules-load[93]: Using 4 probe threads nft # [ 1.615094] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.682413] systemd-modules-load[93]: Inserted module 'virtio_balloon' machine # [ 1.683801] systemd-modules-load[93]: Inserted module 'virtio_gpu' nft # [ 1.617911] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.685161] systemd-modules-load[93]: Inserted module 'dm_mod' machine # [ 1.686405] systemd[1]: Starting Create Static Device Nodes in /dev... nft # [ 1.622940] systemd[1]: Reached target Preparation for Local File Systems. nft # [ 1.625134] systemd[1]: Reached target Local File Systems. machine # [ 1.695295] systemd[1]: Finished Create Static Device Nodes in /dev. nft # [ 1.627156] systemd[1]: Starting Create System Files and Directories... machine # [ 1.696604] systemd[1]: Reached target Preparation for Local File Systems. nft # [ 1.630183] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.697841] systemd[1]: Reached target Local File Systems. machine # [ 1.698849] systemd[1]: Starting Create System Files and Directories... machine # [ 1.700125] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.714795] systemd[1]: Finished Create System Files and Directories. nft # [ 1.648954] systemd[1]: Finished Create System Files and Directories. nft # [ 1.653882] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.723542] systemd-udevd[112]: Using default interface naming scheme 'v261'. nft # [ 1.657314] systemd-udevd[93]: Using default interface naming scheme 'v261'. nft # [ 1.669048] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.736289] systemd[1]: Started Rule-based Manager for Device Events and Files. nft # [ 1.670636] systemd[1]: Reached target System Initialization. nft # [ 1.671888] systemd[1]: Reached target Basic System. machine # [ 1.760072] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.761221] systemd[1]: Reached target System Initialization. machine # [ 1.762274] systemd[1]: Reached target Basic System. machine # [ 2.072228] uhci_hcd 0000:00:01.2: UHCI Host Controller machine # [ 2.076649] SCSI subsystem initialized machine # [ 2.077119] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 machine # [ 2.080557] uhci_hcd 0000:00:01.2: detected 2 ports machine # [ 2.082198] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.082296] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 machine # [ 2.085184] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.086756] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.088237] usb usb1: Product: UHCI Host Controller machine # [ 2.089268] usb usb1: Manufacturer: Linux 6.18.41 uhci_hcd machine # [ 2.090432] usb usb1: SerialNumber: 0000:00:01.2 nft # [ 2.015394] uhci_hcd 0000:00:01.2: UHCI Host Controller nft # [ 2.021078] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 nft # [ 2.022410] uhci_hcd 0000:00:01.2: detected 2 ports nft # [ 2.023651] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 machine # [ 2.103864] hub 1-0:1.0: USB hub found nft # [ 2.027793] SCSI subsystem initialized machine # [ 2.105246] hub 1-0:1.0: 2 ports detected machine # [ 2.106323] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.107226] serio: i8042 AUX port at 0x60,0x64 irq 12 nft # [ 2.032548] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.117863] scsi host0: ata_piix nft # [ 2.041755] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.118907] scsi host1: ata_piix machine # [ 2.119659] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 machine # [ 2.121380] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 nft # [ 2.045747] usb usb1: Product: UHCI Host Controller nft # [ 2.046626] usb usb1: Manufacturer: Linux 6.18.41 uhci_hcd nft # [ 2.048085] usb usb1: SerialNumber: 0000:00:01.2 nft # [ 2.053437] hub 1-0:1.0: USB hub found machine # [ 2.129764] virtio_blk virtio5: 4/0/0 default/read/poll queues nft # [ 2.056236] hub 1-0:1.0: 2 ports detected nft # [ 2.061099] virtio_blk virtio5: 2/0/0 default/read/poll queues nft # [ 2.065396] scsi host0: ata_piix nft # [ 2.065507] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) nft # [ 2.069729] scsi host1: ata_piix nft # [ 2.073527] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 nft # [ 2.077684] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 nft # [ 2.078499] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 nft # [ 2.082858] serio: i8042 KBD port at 0x60,0x64 irq 1 nft # [ 2.084055] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.950311] (udev-worker)[130]: eth1: Config file /et[ 2.165581] virtio_blk virtio5: [vda] 50331648 512-byte logical blocks (25.8 GB/24.0 GiB) machine # c/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.954931] (udev-worker)[130]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.957076] systemd[1]: Starting Virtual Console Setup... machine # [ 1.959506] (udev-worker)[140]: Network interface NamePolicy= disabled on kernel command line. nft # [ 1.894702] (udev-worker)[109]: Network interface NamePolicy= disabled on kernel command line. nft # [ 1.901326] systemd[1]: Starting Virtual Console Setup... nft # [ 1.905247] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. nft # [ 1.909247] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.981968] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.984086] systemd[1]: Finished Virtual Console Setup. nft # [ 1.923044] systemd[1]: Found device /dev/disk/by-label/nixos. nft # [ 1.924526] systemd[1]: Reached target Initrd Root Device. nft # [ 1.930094] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... nft # [ 1.932869] systemd-vconsole-setup[119]: Configuration of first virtual console was skipped, ignoring remaining ones. nft # [ 1.936506] systemd[1]: Finished Virtual Console Setup. nft # [ 1.947076] systemd-fsck[126]: nixos: clean, 12/65536 files, 13019/262144 blocks nft # [ 1.951312] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.276946] ata2: found unknown device (class 0) machine # [ 2.278586] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.280997] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.306065] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 nft # [ 2.238532] ata2: found unknown device (class 0) machine # [ 2.101635] systemd[1]: Found device /dev/disk/by-label/nixos. nft # [ 2.240274] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.102966] systemd[1]: Reached target Initrd Root Device. machine # [ 2.104710] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... nft # [ 2.242901] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.333761] usb 1-1: new full-speed USB device number 2 using uhci_hcd nft # [ 2.266832] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.131483] systemd-fsck[159]: nixos: clean, 12/1572864 files, 142772/6291456 blocks machine # [ 2.347943] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.135045] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. nft # [ 2.278264] usb 1-1: new full-speed USB device number 2 using uhci_hcd nft # [ 2.284990] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray nft # [ 2.309673] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.393174] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.500753] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.502362] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.503883] usb 1-1: Product: QEMU USB Tablet machine # [ 2.504829] usb 1-1: Manufacturer: QEMU machine # [ 2.505638] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 nft # [ 2.445783] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 nft # [ 2.447310] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 nft # [ 2.448651] usb 1-1: Product: QEMU USB Tablet machine # [ 2.525025] hid: raw HID events driver (C) Jiri Kosina nft # [ 2.449601] usb 1-1: Manufacturer: QEMU nft # [ 2.450408] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 machine # [ 2.533197] usbcore: registered new interface driver usbhid machine # [ 2.534201] usbhid: USB HID core driver machine # [ 2.539430] 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 machine # [ 2.541689] 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 nft # [ 2.466836] hid: raw HID events driver (C) Jiri Kosina nft # [ 2.474285] usbcore: registered new interface driver usbhid nft # [ 2.475414] usbhid: USB HID core driver nft # [ 2.479990] 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 nft # [ 2.482605] 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 nft # [ 2.517405] systemd[1]: Mounting /sysroot... machine # [ 2.615448] systemd[1]: Mounting /sysroot... nft # [ 2.809902] EXT4-fs (vda): mounted filesystem c2a1b4d1-7598-4477-be56-69de528279e6 r/w with ordered data mode. Quota mode: none. nft # [ 2.608067] systemd[1]: Mounted /sysroot. nft # [ 2.608966] systemd[1]: Reached target Initrd Root File System. nft # [ 2.610436] systemd[1]: Mounting /sysroot/nix/.ro-store... nft # [ 2.612072] systemd[1]: Mounting /sysroot/nix/.rw-store... nft # [ 2.614224] systemd[1]: Mounting /sysroot/run... nft # [ 2.617139] systemd[1]: Mounting /sysroot/tmp/shared... nft # [ 2.625231] systemd[1]: Mounting /sysroot/tmp/xchg... nft # [ 2.634171] systemd[1]: Starting Mountpoints Configured in the Real Root... nft # [ 2.849049] 9p: Installing v9fs 9p2000 file system support nft # [ 2.651121] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.931787] EXT4-fs (vda): mounted filesystem 2ddc63e2-4e64-4a33-b2c8-a1d8cde6e333 r/w with ordered data mode. Quota mode: none. nft # [ 2.652800] systemd[1]: Mounted /sysroot/run. machine # [ 2.720680] systemd[1]: Mounted /sysroot. nft # [ 2.654861] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.721873] systemd[1]: Reached target Initrd Root File System. nft # [ 2.656171] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.724716] systemd[1]: Mounting /sysroot/nix/.ro-store... nft # [ 2.658297] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.726620] systemd[1]: Mounting /sysroot/nix/.rw-store... nft # [ 2.660867] systemd-sysroot-fstab-check[146]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.729034] systemd[1]: Mounting /sysroot/run... nft # [ 2.665595] systemd[1]: Starting rw-sysroot-nix-store.service... nft # [ 2.667202] systemd[1]: Reload requested from client PID 146 ('systemd-sysroot') (unit initrd-parse-etc.service)... nft # [ 2.669186] systemd[1]: Reloading... machine # [ 2.742144] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.745281] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.746342] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.963489] 9p: Installing v9fs 9p2000 file system support machine # [ 2.749932] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.753193] systemd[1]: Mounted /sysroot/run. machine # [ 2.754600] systemd-sysroot-fstab-check[181]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.756463] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.757622] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.758992] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.761483] systemd[1]: Reload requested from client PID 181 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.763580] systemd[1]: Reloading... nft # [ 2.724844] systemd[1]: Reloading finished in 57 ms. machine # [ 2.809228] systemd[1]: Reloading finished in 47 ms. nft # [ 2.747861] systemd-sysroot-fstab-check[146]: Requesting initrd-fs.target/start/replace... nft # [ 2.750489] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. nft # [ 2.752339] systemd[1]: Finished rw-sysroot-nix-store.service. nft # [ 2.755075] systemd-sysroot-fstab-check[146]: Requesting swap.target/start/replace... nft # [ 2.758285] systemd[1]: initrd-parse-etc.service: Deactivated successfully. nft # [ 2.759903] systemd[1]: Finished Mountpoints Configured in the Real Root. nft # [ 2.761249] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.828621] systemd-sysroot-fstab-check[181]: Requesting initrd-fs.target/start/replace... nft # [ 2.764888] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.832260] systemd-sysroot-fstab-check[181]: Requesting swap.target/start/replace... machine # [ 2.833903] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.835194] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.836447] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.837668] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. nft # [ 2.784848] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. nft # [ 2.786683] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 2.855846] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.857712] systemd[1]: Finished rw-sysroot-nix-store.service. nft # [ 3.517172] systemd[1]: Mounting /sysroot/nix/store... nft # [ 3.538215] systemd[1]: Mounted /sysroot/nix/store. nft # [ 3.539615] systemd[1]: Reached target Initrd File Systems. nft # [ 3.540887] systemd[1]: Starting Find NixOS closure... nft # [ 3.544379] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.615747] systemd[1]: Mounting /sysroot/nix/store... nft # [ 3.554423] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. nft # [ 3.556237] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. nft # [ 3.560215] systemd[1]: Finished Find NixOS closure. nft # [ 3.561357] systemd[1]: Reached target Initrd Default Target. nft # [ 3.562633] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... nft # [ 3.571406] systemd[1]: Stopped target Initrd Default Target. nft # [ 3.572722] systemd[1]: Stopped target Basic System. nft # [ 3.573891] systemd[1]: Stopped target Initrd Root Device. nft # [ 3.575129] systemd[1]: Stopped target Path Units. nft # [ 3.576305] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. nft # [ 3.577912] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. nft # [ 3.579574] systemd[1]: Stopped target Slice Units. nft # [ 3.580756] systemd[1]: Stopped target Socket Units. machine # [ 3.648043] systemd[1]: Mounted /sysroot/nix/store. nft # [ 3.582057] systemd[1]: Stopped target System Initialization. machine # [ 3.649234] systemd[1]: Reached target Initrd File Systems. nft # [ 3.583346] systemd[1]: Stopped target Swaps. machine # [ 3.650430] systemd[1]: Starting Find NixOS closure... machine # [ 3.651507] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... nft # [ 3.584578] systemd[1]: Stopped target Timer Units. nft # [ 3.587351] systemd[1]: dbus.socket: Deactivated successfully. nft # [ 3.588698] systemd[1]: Closed D-Bus System Message Bus Socket. nft # [ 3.590883] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. nft # [ 3.593148] systemd[1]: Stopped Find NixOS closure. nft # [ 3.594681] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio nft # [ 3.597585] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.666715] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. nft # [ 3.599872] systemd[1]: systemd-sysctl.service: Deactivated successfully. nft # [ 3.601941] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.668653] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. nft # [ 3.603918] systemd[1]: systemd-modules-load.service: Deactivated successfully. nft # [ 3.605396] systemd[1]: Stopped Load Kernel Modules. nft # [ 3.606586] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.674423] systemd[1]: Finished Find NixOS closure. nft # [ 3.608429] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.675739] systemd[1]: Reached target Initrd Default Target. nft # [ 3.609948] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.676983] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... nft # [ 3.611366] systemd[1]: Stopped Create System Files and Directories. nft # [ 3.612492] systemd[1]: Stopped target Local File Systems. nft # [ 3.613492] systemd[1]: Stopped target Preparation for Local File Systems. nft # [ 3.614790] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. nft # [ 3.616086] systemd[1]: Stopped Coldplug All udev Devices. nft # [ 3.617174] systemd[1]: Stopping Rule-based Manager for Device Events and Files... nft # [ 3.618493] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. nft # [ 3.619846] systemd[1]: Stopped Virtual Console Setup. nft # [ 3.620885] systemd[1]: initrd-cleanup.service: Deactivated successfully. nft # [ 3.622105] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. nft # [ 3.623282] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. nft # [ 3.624551] systemd[1]: Finished rw-sysroot-nix-store.service. nft # [ 3.625580] systemd[1]: systemd-udevd.service: Deactivated successfully. nft # [ 3.628667] systemd[1]: Stopped Rule-based Manager for Device Events and Files. nft # [ 3.630192] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. nft # [ 3.631695] systemd[1]: Closed udev Control Socket. nft # [ 3.632804] systemd[1]: Starting Cleanup udev Database... machine # [ 3.699762] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.700903] systemd[1]: Stopped target Basic System. machine # [ 3.701967] systemd[1]: Stopped target Initrd Root Device. nft # [ 3.633986] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. nft # [ 3.635577] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.703580] systemd[1]: Stopped target Path Units. nft # [ 3.636850] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.704573] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. nft # [ 3.638396] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.706179] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. nft # [ 3.639942] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.707697] systemd[1]: Stopped target Slice Units. nft # [ 3.641425] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.708748] systemd[1]: Stopped target Socket Units. machine # [ 3.709880] systemd[1]: Stopped target System Initialization. nft # [ 3.642864] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.711229] systemd[1]: Stopped target Swaps. nft # [ 3.644460] systemd[1]: Finished Cleanup udev Database. nft # [ 3.645516] systemd[1]: Reached target Switch Root. machine # [ 3.712407] systemd[1]: Stopped target Timer Units. nft # [ 3.646521] systemd[1]: Starting NixOS Activation... machine # [ 3.713510] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.714737] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.715981] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.717470] systemd[1]: Stopped Find NixOS closure. machine # [ 3.718474] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.720498] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.722288] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.723715] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.725913] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.727277] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.728281] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.729771] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.731371] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.733002] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.734455] systemd[1]: Stopped target Local File Systems. machine # [ 3.735632] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.737039] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.738440] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.739584] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.741067] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.742572] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.743847] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.745529] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.746849] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.748457] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.749670] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.750990] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.752441] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 3.753886] systemd[1]: Closed udev Control Socket. machine # [ 3.755107] systemd[1]: Starting Cleanup udev Database... machine # [ 3.756286] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.757791] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.759174] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.760761] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.762828] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.765546] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.767157] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.769098] systemd[1]: Finished Cleanup udev Database. machine # [ 3.770243] systemd[1]: Reached target Switch Root. machine # [ 3.772072] systemd[1]: Starting NixOS Activation... nft # [ 3.812105] initrd-nixos-activation-start[193]: booting system configuration /nix/store/51l4wdy1ai1zgyndx7j1vl827a2rggad-nixos-system-nft-test machine # [ 3.909460] initrd-nixos-activation-start[225]: booting system configuration /nix/store/rq7w421mh4fzzj33qpzj08vzrbds0rs0-nixos-system-machine-test nft # [ 3.866690] initrd-nixos-activation-start[193]: running activation script... machine # [ 3.965805] initrd-nixos-activation-start[225]: running activation script... nft # [ 4.224202] initrd-nixos-activation-start[216]: setting up /etc... machine # [ 4.348817] initrd-nixos-activation-start[248]: setting up /etc... nft # [ 4.440772] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. nft # [ 4.442419] systemd[1]: Finished NixOS Activation. nft # [ 4.443528] systemd[1]: Starting Switch Root... nft # [ 4.459267] systemd[1]: Switching root. machine # [ 4.559553] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.561244] systemd[1]: Finished NixOS Activation. machine # [ 4.562354] systemd[1]: Starting Switch Root... nft # [ 4.712472] systemd-journald[76]: Received SIGTERM from PID 1 (systemd). machine # [ 4.583237] systemd[1]: Switching root. machine # [ 4.849606] systemd-journald[92]: Received SIGTERM from PID 1 (systemd). nft # [ 4.862182] NET: Registered PF_VSOCK protocol family machine # [ 4.982143] NET: Registered PF_VSOCK protocol family nft # [ 5.253751] systemd[1]: systemd 261.1 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) nft # [ 5.258846] systemd[1]: Detected virtualization kvm. nft # [ 5.259824] systemd[1]: Detected architecture x86-64. nft # [ 5.260890] systemd[1]: Detected first boot. nft # [ 5.264637] systemd[1]: Initializing machine ID from random generator. machine # [ 5.372281] systemd[1]: systemd 261.1 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) machine # [ 5.377586] systemd[1]: Detected virtualization kvm. machine # [ 5.378613] systemd[1]: Detected architecture x86-64. machine # [ 5.379611] systemd[1]: Detected first boot. machine # [ 5.382973] systemd[1]: Initializing machine ID from random generator. nft # [ 5.396660] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.523911] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 5.503996] systemd[1]: Applying preset policy. machine # [ 5.609074] systemd[1]: Applying preset policy. nft # [ 5.875410] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.991393] systemd[1]: Populated /etc with preset unit settings. nft # [ 6.190717] systemd[1]: microvm@hermes-alice.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. machine # [ 6.329220] systemd[1]: microvm@hermes-bob.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. machine # [ 6.335791] systemd[1]: microvm@hermes-alice.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. nft # [ 6.349047] systemd[1]: initrd-switch-root.service: Deactivated successfully. nft # [ 6.351044] systemd[1]: Stopped initrd-switch-root.service. nft # [ 6.353918] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. nft # [ 6.356824] systemd[1]: Created slice Slice /system/getty. nft # [ 6.358678] systemd[1]: Created slice User and Session Slice. nft # [ 6.360042] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. nft # [ 6.361774] systemd[1]: Started Forward Password Requests to Wall Directory Watch. nft # [ 6.363310] systemd[1]: Expecting device /dev/hvc0... nft # [ 6.364348] systemd[1]: Expecting device /dev/ttyS0... nft # [ 6.365441] systemd[1]: Reached target Local Encrypted Volumes. nft # [ 6.366649] systemd[1]: Stopped target initrd-fs.target. nft # [ 6.367711] systemd[1]: Stopped target initrd-root-fs.target. nft # [ 6.368822] systemd[1]: Stopped target initrd-switch-root.target. nft # [ 6.370008] systemd[1]: Reached target Virtual Machines and Containers. nft # [ 6.371263] systemd[1]: Reached target Remote File Systems. nft # [ 6.372318] systemd[1]: Reached target Slice Units. nft # [ 6.373285] systemd[1]: Reached target Swaps. nft # [ 6.376082] systemd[1]: Listening on Query the User Interactively for a Password. nft # [ 6.380517] systemd[1]: Listening on Process Core Dump Socket. nft # [ 6.383325] systemd[1]: Listening on Credential Encryption/Decryption. nft # [ 6.386091] systemd[1]: Listening on Factory Reset Management. nft # [ 6.387383] systemd[1]: Listening on Hostname Service Socket. nft # [ 6.391449] systemd[1]: Starting Journal Log Access Socket... nft # [ 6.393384] systemd[1]: Listening on Journal Audit Socket. nft # [ 6.396425] systemd[1]: Listening on Console Output Muting Service Socket. nft # [ 6.398072] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. nft # [ 6.400061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os nft # [ 6.402054] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.483148] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.485040] systemd[1]: Stopped initrd-switch-root.service. nft # [ 6.409472] systemd[1]: Listening on Disk Repartitioning Service Socket. nft # [ 6.410911] systemd[1]: Listening on udev Control Socket. nft # [ 6.412203] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.488033] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.490589] systemd[1]: Created slice Slice /system/getty. nft # [ 6.415981] systemd[1]: Mounting Huge Pages File System... machine # [ 6.492318] systemd[1]: Created slice Slice /system/microvm. machine # [ 6.494174] systemd[1]: Created slice Slice /system/microvm-macvtap-interfaces. nft # [ 6.418642] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.496496] systemd[1]: Created slice Slice /system/microvm-pci-devices. nft # [ 6.421756] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.498534] systemd[1]: Created slice Slice /system/microvm-set-booted. machine # [ 6.500556] systemd[1]: Created slice Slice /system/microvm-tap-interfaces. nft # [ 6.424553] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.502681] systemd[1]: Created slice Slice /system/microvm-virtiofsd. machine # [ 6.504498] systemd[1]: Created slice User and Session Slice. machine # [ 6.505696] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.507295] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.508647] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.509598] systemd[1]: Expecting device /dev/ttyS0... machine # [ 6.510583] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.511687] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.512651] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.513692] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.515056] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.516426] systemd[1]: Reached target Remote File Systems. machine # [ 6.517843] systemd[1]: Reached target Slice Units. machine # [ 6.518986] systemd[1]: Reached target Swaps. nft # [ 6.442483] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 6.443843] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 6.522841] systemd[1]: Listening on Query the User Interactively for a Password. nft # [ 6.450761] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.527257] systemd[1]: Listening on Process Core Dump Socket. nft # [ 6.452358] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.530335] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.533476] systemd[1]: Listening on Factory Reset Management. nft # [ 6.456312] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.534909] systemd[1]: Listening on Hostname Service Socket. nft # [ 6.459850] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.538938] systemd[1]: Starting Journal Log Access Socket... nft # [ 6.464085] systemd[1]: Mounting FUSE Control File System... machine # [ 6.541078] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.544381] systemd[1]: Listening on Console Output Muting Service Socket. nft # [ 6.465846] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.546020] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.547829] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.549621] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.558225] systemd[1]: Listening on Disk Repartitioning Service Socket. nft # [ 6.482340] systemd[1]: Starting Journal Service... machine # [ 6.559656] systemd[1]: Listening on udev Control Socket. machine # [ 6.560838] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.564368] systemd[1]: Mounting Huge Pages File System... machine # [ 6.567523] systemd[1]: Mounting POSIX Message Queue File System... nft # [ 6.493064] systemd[1]: Starting Load Kernel Modules... nft # [ 6.499175] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... nft # [ 6.502461] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.571214] systemd[1]: Mounting Kernel Debug File System... nft # [ 6.506353] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 6.512215] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.589390] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.593319] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.594950] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 6.599024] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.601886] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.606342] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.608975] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse nft # [ 6.537598] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.615708] systemd[1]: Mounting FUSE Control File System... machine # [ 6.617749] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 nft # [ 6.546347] systemd-journald[286]: Collecting audit messages is enabled. nft # [ 6.546381] systemd[1]: Mounted Huge Pages File System. machine # [ 6.628963] systemd[1]: Starting Journal Service... nft # [ 6.557331] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.633891] systemd[1]: Starting Load Kernel Modules... nft # [ 6.558896] systemd[1]: Mounted Kernel Debug File System. nft # [ 6.560088] EXT4-fs (vda): re-mounted c2a1b4d1-7598-4477-be56-69de528279e6. nft # [ 6.561618] loop: module loaded nft # [ 6.562063] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.640765] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.645058] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.647292] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.651842] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.656509] systemd[1]: Listening on Journal Log Access Socket. nft # [ 6.366620] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.659862] systemd[1]: Mounted Huge Pages File System. nft # [ 6.571492] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 6.379599] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.662255] systemd[1]: Mounted POSIX Message Queue File System. nft # [ 6.382547] systemd-modules-load[287]: Using 2 probe threads machine # [ 6.664956] systemd[1]: Mounted Kernel Debug File System. nft # [ 6.590542] systemd[1]: Started Journal Service. machine # [ 6.666877] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.668696] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 6.388697] systemd-modules-load[287]: Inserted module 'loop' nft # [ 6.391616] systemd-modules-load[287]: Inserted module 'tap' machine # [ 6.671529] systemd[1]: modprobe@configfs.service: Deactivated successfully. nft # [ 6.394668] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 6.675189] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.678166] systemd[1]: Mounted FUSE Control File System. nft # [ 6.400355] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.683179] systemd[1]: Mounting Kernel Configuration File System... nft # [ 6.405105] systemd[1]: Mounted FUSE Control File System. machine # [ 6.684795] systemd-journald[318]: Collecting audit messages is enabled. machine # [ 6.688644] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... nft # [ 6.408488] systemd[1]: Finished Remount Root and Kernel File Systems. nft # [ 6.615459] tun: Universal TUN/TAP device driver, 1.6 nft # [ 6.412144] systemd-modules-load[287]: Inserted module 'vhost_vsock' machine # [ 6.695139] loop: module loaded nft # [ 6.415544] systemd-oomd[289]: No swap; memory pressure usage will be degraded machine # [ 6.697986] EXT4-fs (vda): re-mounted 2ddc63e2-4e64-4a33-b2c8-a1d8cde6e333. nft # [ 6.418465] systemd[1]: Listening on Disk Image Download Service Socket. nft # [ 6.420558] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.706769] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.706802] tun: Universal TUN/TAP device driver, 1.6 machine # [ 6.709673] systemd[1]: Listening on Disk Image Download Service Socket. nft # [ 6.429298] systemd-modules-load[287]: Inserted module 'vhost_net' machine # [ 6.711043] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.497687] systemd[1]: Queued start job for default target Multi-User System. nft # [ 6.432367] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.715372] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.502392] systemd[1]: systemd-journald.serv[ 6.717462] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # ice: Deactivated successfully. nft # [ 6.436326] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.719928] systemd[1]: Started Journal Service. machine # [ 6.506131] systemd-modules-load[319]: Using 4 probe threads nft # [ 6.439206] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.509629] systemd-modules-load[319]: Inserted module 'tap' nft # [ 6.444827] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.513495] systemd-modules-load[319]: Inserted module 'loop' nft # [ 6.447162] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.516136] systemd-modules-load[319]: Inserted module 'vhost_vsock' machine # [ 6.518278] systemd-modules-load[319]: Inserted module 'vhost_net' nft # [ 6.455241] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.520967] systemd-oomd[321]: No swap; memory pressure usage will be degraded nft # [ 6.458070] systemd[1]: Finished Load Kernel Modules. machine # [ 6.525682] systemd[1]: Starting Flush Journal to Persistent Storage... nft # [ 6.460292] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.528203] systemd[1]: Finished Load Kernel Modules. machine # [ 6.531214] systemd[1]: Starting Firewall... machine # [ 6.532904] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.535201] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.537188] systemd[1]: Mounted Kernel Configuration File System. nft # [ 6.473387] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.542860] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.759578] systemd-journald[318]: Received client request to flush runtime journal. nft # [ 6.481711] systemd[1]: Finished Load/Save OS Random Seed. nft # [ 6.483727] systemd[1]: Reached target First Boot Complete. nft # [ 6.702039] systemd-journald[286]: Received client request to flush runtime journal. machine # [ 6.598172] systemd[1]: Reached target First Boot Complete. machine # [ 6.600120] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.602229] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.603981] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.605530] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.611865] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.613188] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.615643] systemd[1]: Starting Rule-based Manager for Device Events and Files... nft # [ 6.566530] systemd[1]: Finished Apply Kernel Variables. nft # [ 6.569120] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. nft # [ 6.571541] systemd[1]: Starting Create Static Device Nodes in /dev... nft # [ 6.573341] systemd[1]: Finished Flush Journal to Persistent Storage. nft # [ 6.575402] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.644721] systemd[1]: Finished Coldplug All udev Devices. nft # [ 6.603487] systemd[1]: Finished Create Static Device Nodes in /dev. nft # [ 6.606421] systemd[1]: Reached target Preparation for Local File Systems. nft # [ 6.608531] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.678632] systemd-udevd[356]: Using default interface naming scheme 'v261'. nft # [ 6.669751] systemd-udevd[318]: Using default interface naming scheme 'v261'. machine # [ 6.753310] systemd[1]: Started Rule-based Manager for Device Events and Files. nft # [ 6.737063] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.839636] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.864585] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.871664] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.895367] (udev-worker)[392]: Network interface NamePolicy= disabled on kernel command line. machine # [ 6.898365] (udev-worker)[398]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 6.901487] (udev-worker)[398]: Network interface NamePolicy= disabled on kernel command line. nft # [ 6.839805] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.927910] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.930702] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.932894] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.936562] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore nft # [ 6.872052] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.939333] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.941995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.160195] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 nft # [ 6.882125] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 7.173078] rtc_cmos 00:05: RTC can wake from S4 machine # [ 7.175595] ACPI: button: Power Button [PWRF] machine # [ 7.182427] rtc_cmos 00:05: registered as rtc0 nft # [ 6.900923] (udev-worker)[334]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 7.183868] rtc_cmos 00:05: setting system clock to 2026-08-03T08:06:32 UTC (1785744392) nft # [ 6.904294] (udev-worker)[334]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.184283] systemd-journald[318]: Time jumped backwards, rotating. nft # [ 6.906476] (udev-worker)[327]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.186771] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.194615] parport_pc 00:03: reported by Plug and Play ACPI machine # [ 7.196361] mousedev: PS/2 mouse device common for all mice machine # [ 7.200453] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 7.204713] Floppy drive(s): fd0 is 2.88M AMI BIOS machine # [ 7.220692] FDC 0 is a S82078B nft # [ 6.941946] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 7.225119] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console nft # [ 6.944040] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore nft # [ 6.946234] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 nft # [ 6.949201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore nft # [ 6.951516] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 6.953301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.228468] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 machine # [ 7.240168] Console: switching to colour dummy device 80x25 machine # [ 7.242940] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 7.242942] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.248864] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 machine # [ 7.249189] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic machine # [ 7.250241] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 7.251583] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 machine # [ 7.259233] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 nft # [ 7.216054] mousedev: PS/2 mouse device common for all mice machine # [ 7.310341] Console: switching to colour frame buffer device 160x50 machine # [ 7.312311] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device nft # [ 7.238156] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 7.315566] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 nft # [ 7.251981] parport_pc 00:03: reported by Plug and Play ACPI nft # [ 7.253762] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] nft # [ 7.255221] rtc_cmos 00:05: RTC can wake from S4 nft # [ 7.259210] rtc_cmos 00:05: registered as rtc0 nft # [ 7.260534] rtc_cmos 00:05: setting system clock to 2026-08-03T08:06:32 UTC (1785744392) nft # [ 7.262375] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs nft # [ 7.264137] ACPI: button: Power Button [PWRF] nft # [ 7.267608] systemd-journald[286]: Time jumped backwards, rotating. nft # [ 7.269710] Floppy drive(s): fd0 is 2.88M AMI BIOS nft # [ 7.287574] FDC 0 is a S82078B machine # [ 7.150487] systemd[1]: Starting Virtual Console Setup... machine # [ 7.176427] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.178267] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.397660] ppdev: user-space parallel port driver nft # [ 7.321778] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 nft # [ 7.323397] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD nft # [ 7.327216] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 machine # [ 7.192034] systemd[1]: Starting Virtual Console Setup... nft # [ 7.337730] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console nft # [ 7.340805] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 7.225783] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.229137] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.232092] systemd[1]: Starting Virtual Console Setup... nft # [ 7.171257] systemd[1]: Mounting /run/wrappers... machine # [ 7.471168] kvm_amd: TSC scaling supported machine # [ 7.472291] kvm_amd: Nested Virtualization enabled machine # [ 7.473465] kvm_amd: Nested Paging enabled machine # [ 7.474449] kvm_amd: LBR virtualization supported machine # [ 7.475446] kvm_amd: Virtual GIF supported machine # [ 7.476121] kvm_amd: Virtual NMI enabled nft # [ 7.200972] systemd[1]: Mounted /run/wrappers. nft # [ 7.202426] systemd[1]: Reached target Local File Systems. machine # [ 7.272330] systemd[1]: Mounting /run/wrappers... nft # [ 7.206105] systemd[1]: Listening on Boot Loader Control Service Socket. nft # [ 7.208845] systemd[1]: Starting register-nix-paths.service... machine # [ 7.297843] systemd[1]: Mounted /run/wrappers. machine # [ 7.299427] systemd[1]: Reached target Local File Systems. machine # [ 7.301646] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.305244] systemd[1]: Starting register-nix-paths.service... nft # [ 7.383089] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 nft # [ 7.444836] Console: switching to colour dummy device 80x25 machine # [ 7.309098] systemd[1]: Starting Create SUID/SGID Wrappers... nft # [ 7.448753] [drm] Found bochs VGA, ID 0xb0c5. nft # [ 7.448755] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.310733] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.320236] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.323438] systemd[1]: Starting Create System Files and Directories... nft # [ 7.472315] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic nft # [ 7.473375] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 nft # [ 7.271503] systemd[1]: Starting Create SUID/SGID Wrappers... nft # [ 7.273344] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. nft # [ 7.276963] systemd[1]: Starting Save Transient machine-id to Disk... nft # [ 7.278579] systemd[1]: Starting Create System Files and Directories... machine # [ 7.352494] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. nft # [ 7.495617] ppdev: user-space parallel port driver machine # [ 7.355967] systemd[1]: Finished Save Transient machine-id to Disk. nft # [ 7.295420] systemd[1]: Starting Virtual Console Setup... machine # [ 7.362946] systemd-tmpfiles[475]: /etc/tmpfiles.d/10-microvm.conf:1: Duplicate line for path "/home/alice/hermes", ignoring. machine # [ 7.367835] systemd-tmpfiles[[ 7.582768] EDAC MC: Ver: 3.0.0 machine # 475]: /etc/tmpfiles.d/10-microvm.conf:2: Duplicate line for path "/home/bob/hermes", ignoring. machine # [ 7.373720] systemd-tmpfiles[475]: /etc/tmpfiles.d/10-microvm.conf:3: Duplicate line for path "/var/lib/hermes-microvm/alice/guest", ignoring. nft # [ 7.313186] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.379248] systemd-tmpfiles[475]: /etc/tmpfiles.d/10-microvm.conf:4: Duplicate line for path "/var/lib/hermes-microvm/alice/state-vault/state", ignoring. machine # [ 7.384305] systemd-tmpfiles[475]: /etc/tmpfiles.d/10-microvm.conf:5: Duplicate line for path "/var/lib/hermes-microvm/bob/guest", ignoring. machine # [ 7.387396] systemd-tmpfiles[475]: /etc/tmpfiles.d/10-microvm.conf:6: Duplicate line for path "/var/lib/hermes-microvm/bob/state-vault/state", ignoring. nft # [ 7.322627] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.393875] systemd[1]: Finished Create System Files and Directories. machine # [ 7.398938] systemd[1]: Starting Rebuild Journal Catalog... nft # [ 7.328310] systemd-tmpfiles[353]: /etc/tmpfiles.d/10-microvm.conf:1: Duplicate line for path "/home/alice/hermes", ignoring. machine # [ 7.403160] systemd[1]: Starting Record System Boot/Shutdown in UTMP... nft # [ 7.338482] systemd-tmpfiles[353]: /etc/tmpfiles.d/10-microvm.conf:2: Duplicate line for path "/var/lib/hermes-microvm/alice/guest", ignoring. nft # [ 7.341589] systemd-tmpfiles[353]: /etc/tmpfiles.d/10-microvm.conf:3: Duplicate line for path "/var/lib/hermes-microvm/alice/state-vault/state", ignoring. nft # [ 7.363310] systemd[1]: Finished Create System Files and Directories. nft # [ 7.367835] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.437319] systemd[1]: Finished Record System Boot/Shutdown in UTMP. nft # [ 7.373268] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.462965] systemd[1]: Finished Rebuild Journal Catalog. nft # [ 7.605741] kvm_amd: TSC scaling supported nft # [ 7.606870] kvm_amd: Nested Virtualization enabled machine # [ 7.468212] systemd[1]: Starting Update is Completed... nft # [ 7.608197] kvm_amd: Nested Paging enabled nft # [ 7.609351] kvm_amd: LBR virtualization supported nft # [ 7.610003] kvm_amd: Virtual GIF supported nft # [ 7.611028] kvm_amd: Virtual NMI enabled machine # [ 7.486077] systemd[1]: Finished Firewall. machine # [ 7.494955] systemd[1]: Finished Update is Completed. nft # [ 7.430138] systemd[1]: Finished Record System Boot/Shutdown in UTMP. nft # [ 7.673043] Console: switching to colour frame buffer device 160x50 nft # [ 7.675578] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device nft # [ 7.463478] systemd[1]: Finished Rebuild Journal Catalog. nft # [ 7.472927] systemd[1]: Starting Update is Completed... nft # [ 7.474377] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. nft # [ 7.477579] systemd[1]: Stopped Virtual Console Setup. nft # [ 7.482895] systemd[1]: Starting Virtual Console Setup... nft # [ 7.503125] systemd[1]: Finished Update is Completed. nft # [ 7.733985] EDAC MC: Ver: 3.0.0 machine # [ 7.603568] systemd-vconsole-setup[457]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 7.606422] systemd[1]: Finished Virtual Console Setup. machine # [ 7.663901] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.665886] systemd[1]: Finished Create SUID/SGID Wrappers. nft # [ 7.735110] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. nft # [ 7.737191] systemd[1]: Finished Create SUID/SGID Wrappers. nft # [ 7.828494] systemd-vconsole-setup[385]: Configuration of first virtual console was skipped, ignoring remaining ones. nft # [ 7.832531] systemd[1]: Finished Virtual Console Setup. machine # [ 7.988282] systemd[1]: Finished register-nix-paths.service. machine # [ 7.989512] systemd[1]: Reached target System Initialization. machine # [ 7.990708] systemd[1]: Started hermes-microvm-timezone.path. machine # [ 7.992135] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.993563] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.994792] systemd[1]: Reached target Path Units. machine # [ 7.995740] systemd[1]: Reached target Timer Units. machine # [ 7.996681] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.003905] systemd[1]: Listening on dashboard forward socket for hermes-alice. machine # [ 8.008855] systemd[1]: Listening on dashboard forward socket for hermes-bob. machine # [ 8.011407] systemd[1]: Listening on spaces bridge socket for hermes-alice. machine # [ 8.012849] systemd[1]: Listening on Nix Daemon Socket. machine # [ 8.014271] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.016383] systemd[1]: Reached target Socket Units. machine # [ 8.017678] systemd[1]: Reached target Basic System. machine # [ 8.018710] systemd[1]: Started backdoor.service. machine # [ 8.019652] systemd[1]: Started Enable Kernel Same-Page Merging. machine # [ 8.027259] systemd[1]: Starting Owner-match loopback firewall for hermes microvms... machine # [ 8.031237] systemd[1]: Starting Install MicroVM 'hermes-alice'... machine # [ 8.032683] systemd[1]: Starting Install MicroVM 'hermes-bob'... machine # [ 8.035781] systemd[1]: Starting Import lastlog data into lastlog2 database... nft # [ 7.971463] systemd[1]: Finished register-nix-paths.service. nft # [ 7.972932] systemd[1]: Reached target System Initialization. nft # [ 7.974161] systemd[1]: Started hermes-microvm-timezone.path. machine # [ 8.039691] systemd[1]: Starting Name Service Cache Daemon (nsncd)... nft # [ 7.975868] systemd[1]: Started Discard unused filesystem blocks once a week. nft # [ 7.977228] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.044276] systemd[1]: Starting Post-Boot Actions... nft # [ 7.978498] systemd[1]: Reached target Path Units. nft # [ 7.979531] systemd[1]: Reached target Timer Units. nft # [ 7.980522] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.046332] systemd[1]: Started Reset console on configuration changes. machine # [ 8.050368] systemd[1]: Starting resolvconf update... machine # [ 8.054301] systemd[1]: enable-ksm.service: Deactivated successfully. nft # [ 7.995939] systemd[1]: Listening on dashboard forward socket for hermes-alice. nft # [ 7.998252] systemd[1]: Listening on spaces bridge socket for hermes-alice. nft # [ 7.999771] systemd[1]: Listening on Nix Daemon Socket. nft # [ 8.001238] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.068714] systemd[1]: Starting D-Bus System Message Bus... nft # [ 8.003497] systemd[1]: Reached target Socket Units. nft # [ 8.004803] systemd[1]: Reached target Basic System. nft # [ 8.005905] systemd[1]: Started backdoor.service. nft # [ 8.007302] systemd[1]: Started Enable Kernel Same-Page Merging. nft # [ 8.009889] systemd[1]: Starting Install MicroVM 'hermes-alice'... machine # connecting to host... nft # [ 8.016765] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.084242] systemd[1]: Finished Post-Boot Actions. nft # [ 8.018892] systemd[1]: Starting nftables firewall... nft # [ 8.024657] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.091554] systemd[1]: install-microvm-hermes-alice.service: Deactivated successfully. machine # [ 8.094139] systemd[1]: Finished Install MicroVM 'hermes-alice'. machine # [ 8.098065] systemd[1]: Setup MicroVM 'hermes-alice' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/pci-setup nft # [ 8.036464] systemd[1]: Starting Post-Boot Actions... machine # [ 8.104454] systemd[1]: Starting Save MicroVM 'hermes-alice' booted configuration... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 8.107674] systemd[1]: install-microvm-hermes-bob.service: Deactivated successfully. machine # [ 8.110712] systemd[1]: Finished Install MicroVM 'hermes-bob'. nft # [ 8.050541] systemd[1]: Started Reset console on configuration changes. machine # [ 8.113080] systemd[1]: Finished Import lastlog data into lastlog2 database. machine: connected to guest root shell machine # [ 8.116843] nsncd[585]: Aug 03 08:06:33.641 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine: (connecting took 8.76 seconds) nft # [ 8.055803] systemd[1]: Starting resolvconf update... nft # connecting to host... machine # [ 8.122416] systemd[1]: Setup MicroVM 'hermes-bob' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/pci-setup machine: (finished: waiting for the VM to finish booting, in 8.77 seconds) machine # [ 8.127035] systemd[1]: Starting Save MicroVM 'hermes-bob' booted configuration... machine # [ 8.128462] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.129702] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.130971] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.132433] systemd[1]: Starting User Login Management... nft # [ 8.067286] systemd[1]: enable-ksm.service: Deactivated successfully. nft # [ 8.082546] systemd[1]: install-microvm-hermes-alice.service: Deactivated successfully. nft # [ 8.085070] systemd[1]: Finished Install MicroVM 'hermes-alice'. nft # [ 8.105440] nsncd[441]: Aug 03 08:06:33.548 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" nft # [ 8.107671] systemd[1]: Started Name Service Cache Daemon (nsncd). nft # [ 8.110920] systemd[1]: Finished Post-Boot Actions. machine # [ 8.179456] dbus-broker-launch[595]: Looking up NSS user entry for 'systemd-timesync'... nft # [ 8.115916] systemd[1]: Reached target microvms.target. nft # [ 8.117225] systemd[1]: Reached target Host and Network Name Lookups. nft # [ 8.119278] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.186684] systemd-logind[629]: New seat seat0. nft # [ 8.122446] systemd[1]: Starting D-Bus System Message Bus... nft # [ 8.131202] systemd[1]: Starting User Login Management... nft # [ 8.136175] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.229644] dbus-broker-launch[595]: NSS returned no entry for 'systemd-timesync' machine # [ 8.235391] dbus-broker-launch[595]: Invalid user-name in /nix/store/hprw2lc217j3v33rqn98dnh9ljayqyj7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.241666] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.244224] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.247389] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.249821] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.252475] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.255388] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.257585] systemd-logind[629]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.261425] systemd-logind[629]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.265527] systemd-logind[629]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 8.270163] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.273087] systemd[1]: Starting Name Service Cache Daemon (nsncd)... nft # [ 8.206837] dbus-broker-launch[476]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.276447] systemd[1]: Started D-Bus System Message Bus. nft # [ 8.212225] systemd-logind[477]: New seat seat0. machine # [ 8.284522] dbus-broker-launch[595]: Ready nft # [ 8.218932] systemd-logind[477]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.291520] nsncd[699]: Aug 03 08:06:33.821 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" nft # [ 8.220846] systemd-logind[477]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.295158] systemd[1]: Finished Save MicroVM 'hermes-alice' booted configuration. machine # [ 8.299976] systemd[1]: Started Name Service Cache Daemon (nsncd). nft # [ 8.228756] systemd[1]: Stopped target Host and Network Name Lookups. nft # [ 8.236580] systemd[1]: Stopping Host and Network Name Lookups... nft # [ 8.238449] systemd[1]: Stopped target User and Group Name Lookups. nft # [ 8.240903] systemd[1]: Stopping User and Group Name Lookups... nft # [ 8.248811] dbus-broker-launch[476]: NSS returned no entry for 'systemd-timesync' nft # [ 8.249771] dbus-broker-launch[476]: Invalid user-name in /nix/store/60axf0wb9cl42hbp9wg641i9mzaf7x2n-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" nft # [ 8.251132] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... nft # [ 8.252217] systemd-logind[477]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) nft # [ 8.252747] systemd[1]: nscd.service: Deactivated successfully. nft # [ 8.252960] systemd[1]: Stopped Name Service Cache Daemon (nsncd). nft # [ 8.253180] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.345082] systemd[1]: Finished Save MicroVM 'hermes-bob' booted configuration. machine # [ 8.346853] systemd[1]: Started User Login Management. machine # [ 8.356968] systemd[1]: Created slice Slice /user/1000. machine # [ 8.358542] systemd[1]: Reached target Host and Network Name Lookups. nft # [ 8.292561] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.360322] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.361871] systemd[1]: Starting linger-users.service... machine # [ 8.362760] systemd[1]: Setup MicroVM 'hermes-alice' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/macvtap-up machine # [ 8.363772] systemd[1]: Setup MicroVM 'hermes-bob' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/macvtap-up machine # [ 8.368425] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-alice'... nft # [ 8.303890] nsncd[527]: Aug 03 08:06:33.747 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.373645] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 8.375744] systemd[1]: Starting User Runtime Directory /run/user/1000... nft # [ 8.314174] dbus-broker-launch[476]: Ready nft # [ 8.315750] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.395966] systemd[1]: Finished resolvconf update. machine # [ 8.397942] systemd[1]: Reached target Preparation for Network. nft # [ 8.336080] systemd[1]: Finished resolvconf update. machine # [ 8.402362] systemd[1]: Starting DHCP Client... nft # [ 8.336608] systemd[1]: Started User Login Management. machine # [ 8.405487] systemd[1]: Starting Address configuration of eth1... machine # [ 8.407821] systemd[1]: Starting Extra networking commands.... nft # [ 8.345167] systemd[1]: Created slice Slice /user/1000. nft # [ 8.347094] systemd[1]: Reached target Host and Network Name Lookups. nft # [ 8.347722] systemd[1]: Reached target User and Group Name Lookups. nft # [ 8.351856] systemd[1]: Starting DHCP Client... nft # [ 8.354147] systemd[1]: Starting linger-users.service... machine # [ 8.423846] systemd[1]: Finished User Runtime Directory /run/user/1000. nft # [ 8.360180] systemd[1]: Starting User Runtime Directory /run/user/1000... machine # [ 8.434227] systemd[1]: Starting User Manager for UID 1000... machine # [ 8.436646] systemd[1]: Finished Owner-match loopback firewall for hermes microvms. machine # [ 8.445670] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.449485] systemd[1]: Finished linger-users.service. nft # [ 8.398819] systemd[1]: Finished User Runtime Directory /run/user/1000. nft # [ 8.403320] systemd[1]: Starting User Manager for UID 1000... nft # [ 8.416822] systemd[1]: linger-users.service: Deactivated successfully. nft # [ 8.418938] systemd[1]: Finished linger-users.service. nft # [ 8.420430] systemd[1]: Finished nftables firewall. machine # [ 8.487705] (systemd)[759]: pam_unix(systemd-user:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 8.423588] systemd[1]: Reached target Preparation for Network. machine # [ 8.491322] network-addresses-eth1-start[747]: adding address 192.168.1.1/24... done nft # [ 8.426343] systemd[1]: Starting Owner-match loopback firewall for hermes microvms... nft # [ 8.430789] systemd[1]: Starting Address configuration of eth1... machine # [ 8.502588] network-addresses-eth1-start[747]: adding address 2001:db8:1::1/64... done nft # [ 8.436450] systemd[1]: Starting Extra networking commands.... machine # [ 8.507868] systemd-logind[629]: New session '1' of user 'alice' with class 'manager' and type 'unspecified'. machine # [ 8.519706] systemd[1]: Finished Address configuration of eth1. nft # [ 8.462212] (systemd)[570]: pam_unix(systemd-user:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 8.537192] dhcpcd[775]: dhcpcd-10.3.2 starting machine # [ 8.542430] systemd[759]: Failed to adjust io pressure threshold, ignoring: Device or resource busy nft # [ 8.486677] systemd-logind[477]: New session '1' of user 'alice' with class 'manager' and type 'unspecified'. machine # [ 8.560232] systemd[1]: Finished Extra networking commands.. machine # [ 8.561837] dhcpcd[831]: dev: loaded udev machine # [ 8.562780] systemd[1]: Reached target Network. machine # [ 8.563980] systemd[1]: Setup MicroVM 'hermes-alice' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/tap-up machine # [ 8.565234] systemd[1]: Setup MicroVM 'hermes-bob' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/tap-up machine # [ 8.565982] systemd[1]: Starting Permit User Sessions... machine # [ 8.785461] 8021q: 802.1Q VLAN Support v1.8 machine # [ 8.786245] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.577813] systemd[1]: Finished Permit User Sessions. machine # [ 8.582363] systemd[1]: Started Getty on tty1. machine # [ 8.583538] systemd[1]: Reached target Login Prompts. machine # [ 8.592829] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. nft # [ 8.527908] network-addresses-eth1-start[575]: adding address 192.168.1.2/24... done nft # [ 8.532190] systemd[570]: Failed to adjust io pressure threshold, ignoring: Device or resource busy nft # [ 8.572493] systemd[1]: Finished Address configuration of eth1. nft # [ 8.573956] network-addresses-eth1-start[575]: adding address 2001:db8:1::2/64... done nft # [ 8.578494] dhcpcd[577]: dhcpcd-10.3.2 starting nft # [ 8.581873] dhcpcd[612]: dev: loaded udev nft # [ 8.796675] 8021q: 802.1Q VLAN Support v1.8 nft # [ 8.797226] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.888544] cfg80211: Loading compiled-in X.509 certificates for regulatory database nft # [ 8.617742] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.910156] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 8.912075] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 8.915497] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 8.917337] cfg80211: failed to load regulatory.db nft # [ 8.634541] systemd[1]: Finished Extra networking commands.. nft # [ 8.638409] systemd[1]: Reached target Network. nft # [ 8.640445] systemd[1]: Starting Permit User Sessions... machine # [ 8.959868] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 8.745482] systemd[759]: Queued start job for default target Main User Target. machine # [ 8.748163] dhcpcd[831]: eth0: waiting for carrier machine # [ 8.749693] dhcpcd[831]: eth0: carrier acquired machine # [ 8.752213] systemd[759]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.756344] systemd[759]: Created slice User Application Slice. machine # [ 8.758548] systemd[759]: Started Daily Cleanup of User's Temporary Directories. nft # [ 8.899010] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 8.761327] systemd[759]: Reached target Paths. machine # [ 8.763122] systemd[759]: Reached target Timers. machine # [ 8.764801] dhcpcd[831]: DUID 00:01:00:01:32:03:08:8a:52:54:00:12:34:56 nft # [ 8.697957] systemd[1]: Finished Permit User Sessions. nft # [ 8.700752] systemd[1]: Started Getty on tty1. machine # [ 8.766512] systemd[759]: Starting D-Bus User Message Bus Socket... machine # [ 8.769125] dhcpcd[831]: eth0: IAID 00:12:34:56 nft # [ 8.703798] systemd[1]: Reached target Login Prompts. machine # [ 8.771470] systemd[759]: Starting Create User Files and Directories... machine # [ 8.774587] dhcpcd[831]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.787153] systemd[759]: Finished Create User Files and Directories. nft # [ 8.929091] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' nft # [ 8.930774] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' nft # [ 8.934302] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 nft # [ 8.936452] cfg80211: failed to load regulatory.db machine # [ 8.823403] systemd[759]: Listening on D-Bus User Message Bus Socket. machine # [ 8.824750] systemd[759]: Reached target Sockets. machine # [ 8.826142] systemd[759]: Reached target Basic System. machine # [ 8.828360] systemd[759]: Starting Run user-specific NixOS activation... machine # [ 8.829678] systemd[1]: Started User Manager for UID 1000. nft # [ 8.764505] systemd[1]: Finished Owner-match loopback firewall for hermes microvms. nft # [ 8.774546] systemd[570]: Queued start job for default target Main User Target. nft # [ 8.984855] 8021q: adding VLAN 0 to HW filter on device eth0 nft # [ 8.781349] dhcpcd[612]: eth0: waiting for carrier nft # [ 8.782054] systemd[570]: Failed to adjust io pressure threshold, ignoring: Device or resource busy nft # [ 8.784532] dhcpcd[612]: eth0: carrier acquired nft # [ 8.787409] systemd[570]: Created slice User Application Slice. nft # [ 8.788838] systemd[570]: Started Daily Cleanup of User's Temporary Directories. nft # [ 8.790674] systemd[570]: Reached target Paths. nft # [ 8.792375] systemd[570]: Reached target Timers. nft # [ 8.794476] systemd[570]: Starting D-Bus User Message Bus Socket... nft # [ 8.796231] systemd[570]: Starting Create User Files and Directories... machine # [ 8.863970] systemd[759]: Finished Run user-specific NixOS activation. nft # [ 8.797643] dhcpcd[612]: DUID 00:01:00:01:32:03:08:8a:52:54:00:12:34:56 nft # [ 8.798948] dhcpcd[612]: eth0: IAID 00:12:34:56 machine # [ 8.865067] systemd[759]: Reached target Main User Target. machine # [ 8.866082] systemd[759]: Startup finished in 334ms. nft # [ 8.800087] dhcpcd[612]: eth0: adding address fe80::5054:ff:fe12:3456 nft # [ 8.821165] systemd[570]: Finished Create User Files and Directories. nft # [ 8.860528] systemd[570]: Listening on D-Bus User Message Bus Socket. nft # [ 8.862037] systemd[570]: Reached target Sockets. nft # [ 8.863135] systemd[570]: Reached target Basic System. nft # [ 8.865304] systemd[1]: Started User Manager for UID 1000. nft # [ 8.867185] systemd[570]: Starting Run user-specific NixOS activation... nft # [ 8.904502] systemd[570]: Finished Run user-specific NixOS activation. nft # [ 8.905945] systemd[570]: Reached target Main User Target. nft # [ 8.907243] systemd[570]: Startup finished in 389ms. machine # [ 9.193208] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:34,722 INFO Set uid to user 0 succeeded machine # [ 9.194543] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:34,722 INFO Set uid to user 0 succeeded machine # [ 9.200856] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:34,731 INFO supervisord started with pid 768 machine # [ 9.201716] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:34,731 INFO supervisord started with pid 771 machine # [ 9.220972] dhcpcd[831]: eth0: soliciting a DHCP lease machine # [ 9.450416] NET: Registered PF_PACKET protocol family machine # [ 9.242626] dhcpcd[831]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.250253] dhcpcd[831]: eth0: probing address 10.0.2.15/24 machine # [ 10.209708] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:35,739 INFO spawned: 'notify' with pid 872 machine # [ 10.211273] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:35,739 INFO spawned: 'notify' with pid 871 machine # [ 10.213255] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:35,742 INFO spawned: 'virtiofsd-hermes-exchange' with pid 873 machine # [ 10.214365] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:35,743 INFO spawned: 'virtiofsd-hermes-exchange' with pid 874 machine # [ 10.218088] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:35,745 INFO spawned: 'virtiofsd-hermes-state' with pid 875 machine # [ 10.219432] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:35,748 INFO spawned: 'virtiofsd-hermes-state' with pid 876 machine # [ 10.223881] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:35,754 INFO spawned: 'virtiofsd-host-config' with pid 877 machine # [ 10.228799] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:35,754 INFO spawned: 'virtiofsd-host-config' with pid 878 machine # [ 10.229872] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:35,757 INFO spawned: 'virtiofsd-ro-store' with pid 879 machine # [ 10.237369] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:35,767 INFO spawned: 'virtiofsd-ro-store' with pid 882 machine # [ 10.346937] supervisord[768]: virtiofsd-hermes-exchange [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.347851] supervisord[768]: virtiofsd-hermes-state [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.348762] supervisord[771]: virtiofsd-ro-store [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.349849] supervisord[771]: virtiofsd-hermes-exchange [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.351471] supervisord[771]: virtiofsd-hermes-state [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.353354] supervisord[771]: virtiofsd-host-config [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.354131] supervisord[768]: virtiofsd-host-config [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 10.354714] supervisord[768]: virtiofsd-ro-store [2026-08-03T08:06:35Z INFO virtiofsd] Waiting for vhost-user socket connection... nft # [ 10.486450] dhcpcd[612]: eth0: soliciting a DHCP lease nft # [ 10.703883] NET: Registered PF_PACKET protocol family nft # [ 10.514107] dhcpcd[612]: eth0: offered 10.0.2.15 from 10.0.2.2 nft # [ 10.516270] dhcpcd[612]: eth0: probing address 10.0.2.15/24 machine # [ 10.833401] dhcpcd[831]: eth0: soliciting an IPv6 router machine # [ 10.834374] dhcpcd[831]: eth0: Router Advertisement from fe80::2 machine # [ 10.835430] dhcpcd[831]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 10.836281] dhcpcd[831]: eth0: adding route to fec0::/64 machine # [ 10.837033] dhcpcd[831]: eth0: adding default route via fe80::2 machine # [ 11.378939] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:36,909 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) nft # [ 11.314468] dhcpcd[612]: eth0: soliciting an IPv6 router nft # [ 11.315835] dhcpcd[612]: eth0: Router Advertisement from fe80::2 machine # [ 11.380236] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:36,909 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) nft # [ 11.317243] dhcpcd[612]: eth0: adding address fec0::5054:ff:fe12:3456/64 nft # [ 11.318793] dhcpcd[612]: eth0: adding route to fec0::/64 machine # [ 11.380864] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) nft # [ 11.320110] dhcpcd[612]: eth0: adding default route via fe80::2 machine # [ 11.381554] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.382732] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.383632] microvm-virtiofsd@hermes-alice[771]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.384863] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.385677] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.386736] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.387725] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:36,909 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 11.407434] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-alice'. machine # [ 11.410883] systemd[1]: Starting MicroVM 'hermes-alice'... machine # [ 11.415892] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 11.420813] systemd[1]: Starting MicroVM 'hermes-bob'... machine # [ 11.554650] microvm@hermes-bob[1010]: cp: cannot create regular file '/var/lib/hermes-microvm/alice/guest/tz/.localtime.tmp': File exists machine # [ 11.559269] systemd[1]: microvm@hermes-bob.service: Control process exited, code=exited, status=1/FAILURE machine # [ 11.623511] systemd[1]: microvm@hermes-bob.service: Failed with result 'exit-code'. machine # [ 11.625972] systemd[1]: Failed to start MicroVM 'hermes-bob'. machine # [ 14.465586] dhcpcd[831]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 14.466901] dhcpcd[831]: eth0: adding route to 10.0.2.0/24 machine # [ 14.468554] dhcpcd[831]: eth0: adding default route via 10.0.2.2 machine # [ 14.548671] systemd[1]: Started DHCP Client. nft # [ 16.242500] dhcpcd[612]: eth0: leased 10.0.2.15 for 86400 seconds nft # [ 16.245671] dhcpcd[612]: eth0: adding route to 10.0.2.0/24 nft # [ 16.247088] dhcpcd[612]: eth0: adding default route via 10.0.2.2 nft # [ 16.317365] systemd[1]: Started DHCP Client. nft # [ 16.318320] systemd[1]: Reached target Multi-User System. nft # [ 16.319833] systemd[1]: Startup finished in 876ms (kernel) + 3.708s (initrd) + 11.735s (userspace) = 16.319s. machine # [ 16.707556] systemd[1]: microvm@hermes-bob.service: Scheduled restart job, restart counter is at 1. machine # [ 16.709470] systemd[1]: Stopped MicroVM 'hermes-bob'. machine # [ 16.710697] systemd[1]: Setup MicroVM 'hermes-bob' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/pci-setup machine # [ 16.714549] systemd[1]: Stopping VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 17.427216] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,957 WARN received SIGTERM indicating exit request machine # [ 17.429385] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,957 INFO waiting for notify, virtiofsd-hermes-exchange, virtiofsd-hermes-state, virtiofsd-host-config, virtiofsd-ro-store to die machine # [ 17.432766] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,960 WARN stopped: virtiofsd-ro-store (exit status 1) machine # [ 17.434870] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,961 WARN stopped: virtiofsd-host-config (exit status 1) machine # [ 17.437433] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,962 WARN stopped: virtiofsd-hermes-state (exit status 1) machine # [ 17.439769] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:42,963 WARN stopped: virtiofsd-hermes-exchange (exit status 1) machine # [ 18.437930] microvm-virtiofsd@hermes-bob[768]: 2026-08-03 08:06:43,968 WARN stopped: notify (terminated by SIGTERM) machine # [ 18.461046] systemd[1]: microvm-virtiofsd@hermes-bob.service: Deactivated successfully. machine # [ 18.462605] systemd[1]: Stopped VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 18.464967] systemd[1]: Stopping Save MicroVM 'hermes-bob' booted configuration... machine # [ 18.496615] systemd[1]: microvm-set-booted@hermes-bob.service: Deactivated successfully. machine # [ 18.497673] systemd[1]: Stopped Save MicroVM 'hermes-bob' booted configuration. machine # [ 18.499557] systemd[1]: Starting Save MicroVM 'hermes-bob' booted configuration... machine # [ 18.586347] systemd[1]: Finished Save MicroVM 'hermes-bob' booted configuration. machine # [ 18.588274] systemd[1]: Setup MicroVM 'hermes-bob' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/macvtap-up machine # [ 18.591246] systemd[1]: Setup MicroVM 'hermes-bob' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/tap-up machine # [ 18.593549] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 18.906856] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:44,437 INFO Set uid to user 0 succeeded machine # [ 18.910670] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:44,441 INFO supervisord started with pid 1165 machine # [ 19.918803] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:45,447 INFO spawned: 'notify' with pid 1185 machine # [ 19.923655] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:45,453 INFO spawned: 'virtiofsd-hermes-exchange' with pid 1186 machine # [ 19.927087] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:45,457 INFO spawned: 'virtiofsd-hermes-state' with pid 1187 machine # [ 19.929632] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:45,460 INFO spawned: 'virtiofsd-host-config' with pid 1188 machine # [ 19.933073] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:45,463 INFO spawned: 'virtiofsd-ro-store' with pid 1190 machine # [ 19.987283] supervisord[1165]: virtiofsd-host-config [2026-08-03T08:06:45Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 19.991835] supervisord[1165]: virtiofsd-ro-store [2026-08-03T08:06:45Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 20.003239] supervisord[1165]: virtiofsd-hermes-state [2026-08-03T08:06:45Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 20.006429] supervisord[1165]: virtiofsd-hermes-exchange [2026-08-03T08:06:45Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 21.065493] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:46,594 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 21.070058] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:46,594 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 21.073363] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:46,594 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 21.076295] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:46,595 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 21.079514] microvm-virtiofsd@hermes-bob[1165]: 2026-08-03 08:06:46,595 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 21.091265] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 21.100845] systemd[1]: Starting MicroVM 'hermes-bob'... machine # [ 21.669132] systemd[1]: Started MicroVM 'hermes-bob'. machine # [ 23.045286] supervisord[1165]: virtiofsd-hermes-exchange [2026-08-03T08:06:48Z INFO virtiofsd] Client connected, servicing requests machine # [ 23.047230] supervisord[1165]: virtiofsd-hermes-state [2026-08-03T08:06:48Z INFO virtiofsd] Client connected, servicing requests machine # [ 23.048080] supervisord[1165]: virtiofsd-host-config [2026-08-03T08:06:48Z INFO virtiofsd] Client connected, servicing requests machine # [ 23.048673] supervisord[1165]: virtiofsd-ro-store [2026-08-03T08:06:48Z INFO virtiofsd] Client connected, servicing requests machine # [ 23.055060] microvm@hermes-bob[1265]: microvm@hermes-bob: warning: Number of SMP cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 23.088893] microvm@hermes-bob[1265]: microvm@hermes-bob: warning: Number of hotpluggable cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 23.461451] microvm@hermes-bob[1265]: SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # [ 24.411851] microvm@hermes-bob[1265]: Booting from ROM... machine # [ 24.415910] microvm@hermes-bob[1265]: PPrroobbiinngg EEDDDD ((eedddd==ooffff ttoo ddiissaabbllee))...... ook machine # [ 24.718552] microvm@hermes-bob[1265]: No EFI environment detected. machine # [ 24.721565] microvm@hermes-bob[1265]: early console in extract_kernel machine # [ 24.724230] microvm@hermes-bob[1265]: input_data: 0x0000000003ac72cc machine # [ 24.725773] microvm@hermes-bob[1265]: input_len: 0x0000000000cb9a3c machine # [ 24.727393] microvm@hermes-bob[1265]: output: 0x0000000001000000 machine # [ 24.728777] microvm@hermes-bob[1265]: output_len: 0x0000000003728d94 machine # [ 24.731339] microvm@hermes-bob[1265]: kernel_total_size: 0x0000000002e30000 machine # [ 24.733123] microvm@hermes-bob[1265]: needed_size: 0x0000000003800000 machine # [ 24.735459] microvm@hermes-bob[1265]: trampoline_32bit: 0x0000000000000000 machine # [ 24.737936] microvm@hermes-bob[1265]: Physical KASLR using RDRAND RDTSC... machine # [ 24.740436] microvm@hermes-bob[1265]: Virtual KASLR using RDRAND RDTSC... machine # [ 24.743316] microvm@hermes-bob[1265]: machine # [ 24.743924] microvm@hermes-bob[1265]: Decompressing Linux... No EFI environment detected. machine # [ 25.543426] microvm@hermes-bob[1265]: Parsing ELF... Performing relocations... done. machine # [ 25.546800] microvm@hermes-bob[1265]: Booting the kernel (entry_offset: 0x000000000278c520). machine # [ 25.566987] microvm@hermes-bob[1265]: [ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Thu Jul 30 11:05:57 UTC 2026 machine # [ 25.585177] microvm@hermes-bob[1265]: [ 0.000000] Command line: earlyprintk=ttyS0 console=ttyS0 reboot=t panic=-1 8250.nr_uarts=1 8250.nr_uarts=1 root=fstab loglevel=4 lsm=landlock,yama,bpf init=/nix/store/fj8maw0xwpfsrr7xlf49crymmyxnzr9y-nixos-system-hermes-bob-26.11pre-git/init regInfo=/nix/store/vbsb8qcavgsnn0cwhfrbnzfb2i8b4syp-closure-info/registration machine # [ 25.590953] microvm@hermes-bob[1265]: [ 0.000000] BIOS-provided physical RAM map: machine # [ 25.592508] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 25.595579] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 25.599702] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 25.603613] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bfffdfff] usable machine # [ 25.607873] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x00000000bfffe000-0x00000000bfffffff] reserved machine # [ 25.612292] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 25.617226] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 25.625480] microvm@hermes-bob[1265]: [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable machine # [ 25.631233] microvm@hermes-bob[1265]: [ 0.000000] printk: legacy bootconsole [earlyser0] enabled machine # [ 25.637791] microvm@hermes-bob[1265]: Memory KASLR using RDRAND RDTSC... machine # [ 28.554448] microvm@hermes-bob[1265]: Poking KASLR using RDRAND RDTSC... machine # [ 28.939708] microvm@hermes-bob[1265]: [ 3.147747] PCI: Fatal: No config space access function found machine # [ 32.849367] microvm@hermes-bob[1265]: +q6E616D65Booting initrd of NixOS 26.11 (Zokor) (Initrd). machine # [ 33.416737] microvm@hermes-bob[1265]: [ OK ] Created slice Slice /system/modprobe. machine # [ 33.421674] microvm@hermes-bob[1265]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 33.425042] microvm@hermes-bob[1265]: [ OK ] Reached target Initrd Root Device. machine # [ 33.428193] microvm@hermes-bob[1265]: [ OK ] Reached target Path Units. machine # [ 33.431412] microvm@hermes-bob[1265]: [ OK ] Reached target Slice Units. machine # [ 33.434445] microvm@hermes-bob[1265]: [ OK ] Reached target Swaps. machine # [ 33.437795] microvm@hermes-bob[1265]: [ OK ] Reached target Timer Units. machine # [ 33.442512] microvm@hermes-bob[1265]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 33.447497] microvm@hermes-bob[1265]: [ OK ] Listening on Journal Socket (/dev/log). machine # [ 33.450449] microvm@hermes-bob[1265]: [ OK ] Listening on Journal Sockets. machine # [ 33.453753] microvm@hermes-bob[1265]: [ OK ] Listening on udev Control Socket. machine # [ 33.458251] microvm@hermes-bob[1265]: [ OK ] Listening on udev Kernel Socket. machine # [ 33.460171] microvm@hermes-bob[1265]: [ OK ] Reached target Socket Units. machine # [ 33.467639] microvm@hermes-bob[1265]: Starting Create List of Static Device Nodes... machine # [ 33.496962] microvm@hermes-bob[1265]: Starting Load Kernel Module configfs... machine # [ 33.517801] microvm@hermes-bob[1265]: Starting Journal Service... machine # [ 33.536385] microvm@hermes-bob[1265]: Starting Load Kernel Modules... machine # [ 33.559564] microvm@hermes-bob[1265]: Starting Coldplug All udev Devices... machine # [ 33.567949] microvm@hermes-bob[1265]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 33.592088] microvm@hermes-bob[1265]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 33.603085] microvm@hermes-bob[1265]: [ OK ] Finished Load Kernel Module configfs. machine # [ 33.731422] microvm@hermes-bob[1265]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 33.797736] microvm@hermes-bob[1265]: Starting Create Static Device Nodes in /dev... machine # [ 33.865118] microvm@hermes-bob[1265]: [ OK ] Finished Coldplug All udev Devices. machine # [ 33.876727] microvm@hermes-bob[1265]: [ OK ] Started Journal Service. machine # [ 33.979718] microvm@hermes-bob[1265]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 34.026956] microvm@hermes-bob[1265]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 34.045388] microvm@hermes-bob[1265]: [ OK ] Reached target Local File Systems. machine # [ 34.071648] microvm@hermes-bob[1265]: Starting Create System Files and Directories... machine # [ 34.197054] microvm@hermes-bob[1265]: Starting Rule-based Manager for Device Events and Files... machine # [ 34.226862] microvm@hermes-bob[1265]: [ OK ] Finished Create System Files and Directories. machine # [ 34.597228] microvm@hermes-bob[1265]: Mounting /sysroot... machine # [ 34.648618] microvm@hermes-bob[1265]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 34.759911] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot. machine # [ 34.793400] microvm@hermes-bob[1265]: [ OK ] Reached target Initrd Root File System. machine # [ 34.811676] microvm@hermes-bob[1265]: Mounting /sysroot/run... machine # [ 34.825225] microvm@hermes-bob[1265]: Starting Mountpoints Configured in the Real Root... machine # [ 34.907655] microvm@hermes-bob[1265]: Starting rw-sysroot-nix-store.service... machine # [ 34.922595] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot/run. machine # [ 35.406654] microvm@hermes-bob[1265]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 35.428246] microvm@hermes-bob[1265]: Starting rw-sysroot-nix-store.service... machine # [ 35.456680] microvm@hermes-bob[1265]: Starting Virtual Console Setup... machine # [ 35.478755] microvm@hermes-bob[1265]: [ OK ] Finished Mountpoints Configured in the Real Root. machine # [ 35.530530] microvm@hermes-bob[1265]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 35.579534] microvm@hermes-bob[1265]: [ OK ] Finished Virtual Console Setup. machine # [ 36.006765] microvm@hermes-bob[1265]: [ OK ] Finished Load Kernel Modules. machine # [ 36.027126] microvm@hermes-bob[1265]: Mounting /sysroot/nix/.ro-store... machine # [ 36.032401] microvm@hermes-bob[1265]: Mounting /sysroot/run/hermes-host... machine # [ 36.042095] microvm@hermes-bob[1265]: Mounting /sysroot/var/lib/hermes... machine # [ 36.072597] microvm@hermes-bob[1265]: Starting Apply Kernel Variables... machine # [ 36.091870] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot/nix/.ro-store. machine # [ 36.101617] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot/var/lib/hermes. machine # [ 36.125989] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot/run/hermes-host. machine # [ 36.145045] microvm@hermes-bob[1265]: [ OK ] Finished Apply Kernel Variables. machine # [ 36.157931] microvm@hermes-bob[1265]: [ OK ] Reached target System Initialization. machine # [ 36.165234] microvm@hermes-bob[1265]: [ OK ] Reached target Basic System. machine # [ 36.571870] microvm@hermes-bob[1265]: Mounting /sysroot/nix/store... machine # [ 36.617914] microvm@hermes-bob[1265]: [ OK ] Mounted /sysroot/nix/store. machine # [ 36.624265] microvm@hermes-bob[1265]: [ OK ] Reached target Initrd File Systems. machine # [ 36.628805] microvm@hermes-bob[1265]: Starting Find NixOS closure... machine # [ 36.636743] microvm@hermes-bob[1265]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 36.675179] microvm@hermes-bob[1265]: [ OK ] Finished Create Volatile Files and Directories in the Real Root. machine # [ 36.703492] microvm@hermes-bob[1265]: [ OK ] Finished Find NixOS closure. machine # [ 36.708412] microvm@hermes-bob[1265]: [ OK ] Reached target Initrd Default Target. machine # [ 36.718433] microvm@hermes-bob[1265]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 36.853504] microvm@hermes-bob[1265]: [ OK ] Stopped target Initrd Default Target. machine # [ 36.856201] microvm@hermes-bob[1265]: [ OK ] Stopped target Basic System. machine # [ 36.858787] microvm@hermes-bob[1265]: [ OK ] Stopped target Initrd Root Device. machine # [ 36.861360] microvm@hermes-bob[1265]: [ OK ] Stopped target Path Units. machine # [ 36.863712] microvm@hermes-bob[1265]: [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 36.866412] microvm@hermes-bob[1265]: [ OK ] Stopped target Slice Units. machine # [ 36.869729] microvm@hermes-bob[1265]: [ OK ] Stopped target Socket Units. machine # [ 36.871665] microvm@hermes-bob[1265]: [ OK ] Stopped target System Initialization. machine # [ 36.875329] microvm@hermes-bob[1265]: [ OK ] Stopped target Swaps. machine # [ 36.879797] microvm@hermes-bob[1265]: [ OK ] Stopped target Timer Units. machine # [ 36.885276] microvm@hermes-bob[1265]: [ OK ] Closed D-Bus System Message Bus Socket. machine # [ 36.891214] microvm@hermes-bob[1265]: [ OK ] Stopped Find NixOS closure. machine # [ 36.895840] microvm@hermes-bob[1265]: Starting rw-sysroot-nix-store.service... machine # [ 36.899541] microvm@hermes-bob[1265]: [ OK ] Stopped Apply Kernel Variables. machine # [ 36.904802] microvm@hermes-bob[1265]: [ OK ] Stopped Load Kernel Modules. machine # [ 36.912516] microvm@hermes-bob[1265]: [ OK ] Stopped Create Volatile Files and Directories in the Real Root. machine # [ 36.918840] microvm@hermes-bob[1265]: [ OK ] Stopped Create System Files and Directories. machine # [ 36.927541] microvm@hermes-bob[1265]: [ OK ] Stopped target Local File Systems. machine # [ 36.936712] microvm@hermes-bob[1265]: [ OK ] Stopped target Preparation for Local File Systems. machine # [ 36.941495] microvm@hermes-bob[1265]: [ OK ] Stopped Coldplug All udev Devices. machine # [ 36.948931] microvm@hermes-bob[1265]: Stopping Rule-based Manager for Device Events and Files... machine # [ 36.954082] microvm@hermes-bob[1265]: [ OK ] Stopped Virtual Console Setup. machine # [ 36.965530] microvm@hermes-bob[1265]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 36.980461] microvm@hermes-bob[1265]: [ OK ] Finished Cleaning Up and Shutting Down Daemons. machine # [ 36.995307] microvm@hermes-bob[1265]: [ OK ] Stopped Rule-based Manager for Device Events and Files. machine # [ 37.000921] microvm@hermes-bob[1265]: [ OK ] Closed udev Control Socket. machine # [ 37.015785] microvm@hermes-bob[1265]: Starting Cleanup udev Database... machine # [ 37.019146] microvm@hermes-bob[1265]: [ OK ] Stopped Create Static Device Nodes in /dev. machine # [ 37.025665] microvm@hermes-bob[1265]: [ OK ] Stopped Create Static Device Nodes in /dev gracefully. machine # [ 37.032748] microvm@hermes-bob[1265]: [ OK ] Stopped Create List of Static Device Nodes. machine # [ 37.061649] microvm@hermes-bob[1265]: [ OK ] Finished Cleanup udev Database. machine # [ 37.065890] microvm@hermes-bob[1265]: [ OK ] Reached target Switch Root. machine # [ 37.071652] microvm@hermes-bob[1265]: Starting NixOS Activation... machine # [ 39.235193] microvm@hermes-bob[1265]: [* ] A start job is running for NixOS Activation (2s / no limit) machine # [ 39.818226] microvm@hermes-bob[1265]: [** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 40.401656] microvm@hermes-bob[1265]: [*** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 40.986263] microvm@hermes-bob[1265]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # [ 41.568103] microvm@hermes-bob[1265]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # [ 42.067663] microvm@hermes-bob[1265]: [ ***] A start job is running for NixOS Activation (5s / no limit) machine # [ 42.650693] microvm@hermes-bob[1265]: [ **] A start job is running for NixOS Activation (5s / no limit) machine # [ 43.233763] microvm@hermes-bob[1265]: [ *] A start job is running for NixOS Activation (6s / no limit) machine # [ 43.818252] microvm@hermes-bob[1265]: [ **] A start job is running for NixOS Activation (7s / no limit) machine # [ 44.401069] microvm@hermes-bob[1265]: [ ***] A start job is running for NixOS Activation (7s / no limit) machine # [ 44.985405] microvm@hermes-bob[1265]: [ *** ] A start job is running for NixOS Activation (8s / no limit) machine # [ 45.569207] microvm@hermes-bob[1265]: [ *** ] A start job is running for NixOS Activation (8s / no limit) machine # [ 46.152268] microvm@hermes-bob[1265]: [*** ] A start job is running for NixOS Activation (9s / no limit) machine # [ 46.206151] microvm@hermes-bob[1265]: [ OK ] Finished NixOS Activation. machine # [ 46.210635] microvm@hermes-bob[1265]: Starting Switch Root... machine # [ 47.722114] microvm@hermes-bob[1265]: +q6E616D65 machine # [ 47.728905] microvm@hermes-bob[1265]: Welcome to NixOS 26.11 (Zokor)! machine # [ 47.731150] microvm@hermes-bob[1265]: machine # [ 49.622559] microvm@hermes-bob[1265]: [ OK ] Stopped initrd-switch-root.service. machine # [ 49.628162] microvm@hermes-bob[1265]: [ OK ] Created slice Slice /system/getty. machine # [ 49.632219] microvm@hermes-bob[1265]: [ OK ] Created slice Slice /system/serial-getty. machine # [ 49.636279] microvm@hermes-bob[1265]: [ OK ] Created slice User and Session Slice. machine # [ 49.640261] microvm@hermes-bob[1265]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 49.644133] microvm@hermes-bob[1265]: [ OK ] Started Forward Password Requests to Wall Directory Watch. machine # [ 49.646352] microvm@hermes-bob[1265]: Expecting device /dev/ttyS0... machine # [ 49.649318] microvm@hermes-bob[1265]: [ OK ] Reached target Local Encrypted Volumes. machine # [ 49.652189] microvm@hermes-bob[1265]: [ OK ] Stopped target initrd-fs.target. machine # [ 49.654967] microvm@hermes-bob[1265]: [ OK ] Stopped target initrd-root-fs.target. machine # [ 49.658268] microvm@hermes-bob[1265]: [ OK ] Stopped target initrd-switch-root.target. machine # [ 49.661723] microvm@hermes-bob[1265]: [ OK ] Reached target Virtual Machines and Containers. machine # [ 49.664305] microvm@hermes-bob[1265]: [ OK ] Reached target Path Units. machine # [ 49.667209] microvm@hermes-bob[1265]: [ OK ] Reached target Remote File Systems. machine # [ 49.669827] microvm@hermes-bob[1265]: [ OK ] Reached target Slice Units. machine # [ 49.672281] microvm@hermes-bob[1265]: [ OK ] Reached target Swaps. machine # [ 49.679977] microvm@hermes-bob[1265]: [ OK ] Listening on Query the User Interactively for a Password. machine # [ 49.686657] microvm@hermes-bob[1265]: [ OK ] Listening on Process Core Dump Socket. machine # [ 49.692894] microvm@hermes-bob[1265]: [ OK ] Listening on Credential Encryption/Decryption. machine # [ 49.698339] microvm@hermes-bob[1265]: [ OK ] Listening on Factory Reset Management. machine # [ 49.701627] microvm@hermes-bob[1265]: [ OK ] Listening on Hostname Service Socket. machine # [ 49.709635] microvm@hermes-bob[1265]: Starting Journal Log Access Socket... machine # [ 49.712719] microvm@hermes-bob[1265]: [ OK ] Listening on Journal Audit Socket. machine # [ 49.718674] microvm@hermes-bob[1265]: [ OK ] Listening on Console Output Muting Service Socket. machine # [ 49.722231] microvm@hermes-bob[1265]: [ OK ] Listening on Network Management Resolve Hook Socket. machine # [ 49.725888] microvm@hermes-bob[1265]: [ OK ] Listening on Network Management Metrics Varlink Socket. machine # [ 49.729331] microvm@hermes-bob[1265]: [ OK ] Listening on Network Management Varlink Socket. machine # [ 49.732656] microvm@hermes-bob[1265]: [ OK ] Listening on Network Management Netlink Socket. machine # [ 49.736688] microvm@hermes-bob[1265]: [ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 49.752764] microvm@hermes-bob[1265]: [ OK ] Listening on Disk Repartitioning Service Socket. machine # [ 49.756512] microvm@hermes-bob[1265]: [ OK ] Listening on Resolve Monitor Varlink Socket. machine # [ 49.760295] microvm@hermes-bob[1265]: [ OK ] Listening on Resolve Service Varlink Socket. machine # [ 49.763587] microvm@hermes-bob[1265]: [ OK ] Listening on udev Control Socket. machine # [ 49.766912] microvm@hermes-bob[1265]: [ OK ] Listening on udev Varlink Socket. machine # [ 49.773934] microvm@hermes-bob[1265]: Mounting Huge Pages File System... machine # [ 49.783810] microvm@hermes-bob[1265]: Mounting POSIX Message Queue File System... machine # [ 49.833075] microvm@hermes-bob[1265]: Mounting Kernel Debug File System... machine # [ 49.872959] microvm@hermes-bob[1265]: Mounting Kernel Trace File System... machine # [ 49.920958] microvm@hermes-bob[1265]: Starting Create List of Static Device Nodes... machine # [ 49.956787] microvm@hermes-bob[1265]: Starting Load Kernel Module configfs... machine # [ 50.000918] microvm@hermes-bob[1265]: Mounting FUSE Control File System... machine # [ 50.042035] microvm@hermes-bob[1265]: Starting Journal Service... machine # [ 50.106207] microvm@hermes-bob[1265]: Starting Load Kernel Modules... machine # [ 50.136637] microvm@hermes-bob[1265]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 50.196476] microvm@hermes-bob[1265]: Starting Remount Root and Kernel File Systems... machine # [ 50.258361] microvm@hermes-bob[1265]: Starting Coldplug All udev Devices... machine # [ 50.296247] microvm@hermes-bob[1265]: [ OK ] Listening on Journal Log Access Socket. machine # [ 50.305321] microvm@hermes-bob[1265]: [ OK ] Mounted Huge Pages File System. machine # [ 50.315880] microvm@hermes-bob[1265]: [ OK ] Started Journal Service. machine # [ 50.327671] microvm@hermes-bob[1265]: [ OK ] Mounted POSIX Message Queue File System. machine # [ 50.338377] microvm@hermes-bob[1265]: [ OK ] Mounted Kernel Debug File System. machine # [ 50.342420] microvm@hermes-bob[1265]: [ OK ] Mounted Kernel Trace File System. machine # [ 50.348101] microvm@hermes-bob[1265]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 50.355542] microvm@hermes-bob[1265]: [ OK ] Finished Load Kernel Module configfs. machine # [ 50.362201] microvm@hermes-bob[1265]: [ OK ] Mounted FUSE Control File System. machine # [ 50.410868] microvm@hermes-bob[1265]: Mounting Kernel Configuration File System... machine # [ 50.443890] microvm@hermes-bob[1265]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 50.492240] microvm@hermes-bob[1265]: [ OK ] Finished Load Kernel Modules. machine # [ 50.509298] microvm@hermes-bob[1265]: [ OK ] Finished Remount Root and Kernel File Systems. machine # [ 50.521465] microvm@hermes-bob[1265]: [ OK ] Listening on Disk Image Download Service Socket. machine # [ 50.543086] microvm@hermes-bob[1265]: Starting Flush Journal to Persistent Storage... machine # [ 50.617138] microvm@hermes-bob[1265]: Starting Load/Save OS Random Seed... machine # [ 50.652132] microvm@hermes-bob[1265]: Starting Apply Kernel Variables... machine # [ 50.871351] microvm@hermes-bob[1265]: Starting Network Time Synchronization... machine # [ 50.888640] microvm@hermes-bob[1265]: [ OK ] Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 50.910483] microvm@hermes-bob[1265]: [ OK ] Mounted Kernel Configuration File System. machine # [ 50.996166] microvm@hermes-bob[1265]: [ OK ] Finished Load/Save OS Random Seed. machine # [ 51.006198] microvm@hermes-bob[1265]: [ OK ] Finished Coldplug All udev Devices. machine # [ 51.018483] microvm@hermes-bob[1265]: [ OK ] Finished Flush Journal to Persistent Storage. machine # [ 51.114915] microvm@hermes-bob[1265]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 51.126497] microvm@hermes-bob[1265]: Starting Create Static Device Nodes in /dev... machine # [ 51.161627] microvm@hermes-bob[1265]: [ OK ] Finished Apply Kernel Variables. machine # [ 51.167627] microvm@hermes-bob[1265]: [ OK ] Started Network Time Synchronization. machine # [ 51.174400] microvm@hermes-bob[1265]: [ OK ] Reached target System Time Set. machine # [ 51.185806] microvm@hermes-bob[1265]: Starting Network Name Resolution... machine # [ 51.322215] microvm@hermes-bob[1265]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 51.339362] microvm@hermes-bob[1265]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 51.351560] microvm@hermes-bob[1265]: Starting Rule-based Manager for Device Events and Files... machine # [ 51.534860] microvm@hermes-bob[1265]: [ OK ] Started Network Name Resolution. machine # [ 51.700601] microvm@hermes-bob[1265]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 51.708316] microvm@hermes-bob[1265]: Starting Network Management... machine # [ 52.017406] microvm@hermes-bob[1265]: Mounting /home/bob/hermes... machine # [ 52.061636] microvm@hermes-bob[1265]: Mounting /run/wrappers... machine # [ 52.195768] microvm@hermes-bob[1265]: Starting Virtual Console Setup... machine # [ 52.508647] microvm@hermes-bob[1265]: [ OK ] Mounted /home/bob/hermes. machine # [ 52.585493] microvm@hermes-bob[1265]: [ OK ] Mounted /run/wrappers. machine # [ 52.607298] microvm@hermes-bob[1265]: [ OK ] Reached target Local File Systems. machine # [ 52.618035] microvm@hermes-bob[1265]: [ OK ] Listening on Boot Loader Control Service Socket. machine # [ 52.657510] microvm@hermes-bob[1265]: Starting Create SUID/SGID Wrappers... machine # [ 52.769813] microvm@hermes-bob[1265]: Starting Create System Files and Directories... machine # [ 53.137709] microvm@hermes-bob[1265]: [ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 53.221838] microvm@hermes-bob[1265]: [ OK ] Finished Create System Files and Directories. machine # [ 53.242365] microvm@hermes-bob[1265]: Starting Rebuild Journal Catalog... machine # [ 53.305062] microvm@hermes-bob[1265]: Starting Record System Boot/Shutdown in UTMP... machine # [ 53.591736] microvm@hermes-bob[1265]: [ OK ] Finished Record System Boot/Shutdown in UTMP. machine # [ 53.652318] microvm@hermes-bob[1265]: [ OK ] Finished Rebuild Journal Catalog. machine # [ 53.676313] microvm@hermes-bob[1265]: Starting Update is Completed... machine # [ 54.069944] microvm@hermes-bob[1265]: [ OK ] Finished Update is Completed. machine # [ 54.145185] microvm@hermes-bob[1265]: [ OK ] Finished Virtual Console Setup. machine # [ 54.457613] microvm@hermes-bob[1265]: [ OK ] Started Network Management. machine # [ 54.461645] microvm@hermes-bob[1265]: [ OK ] Reached target Network. machine # [ 54.464878] microvm@hermes-bob[1265]: [ OK ] Reached target Network is Online. machine # [ 54.484176] microvm@hermes-bob[1265]: Starting Enable Persistent Storage in systemd-networkd... machine # [ 54.727069] microvm@hermes-bob[1265]: [ OK ] Finished Enable Persistent Storage in systemd-networkd. machine # [ 55.262937] microvm@hermes-bob[1265]: [ OK ] Finished Create SUID/SGID Wrappers. machine # [ 55.268430] microvm@hermes-bob[1265]: [ OK ] Reached target System Initialization. machine # [ 55.275654] microvm@hermes-bob[1265]: [ OK ] Started Discard unused filesystem blocks once a week. machine # [ 55.278203] microvm@hermes-bob[1265]: [ OK ] Started logrotate.timer. machine # [ 55.281458] microvm@hermes-bob[1265]: [ OK ] Started Daily Cleanup of Temporary Directories. machine # [ 55.286068] microvm@hermes-bob[1265]: [ OK ] Reached target Timer Units. machine # [ 55.291560] microvm@hermes-bob[1265]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 55.295808] microvm@hermes-bob[1265]: [ OK ] Listening on Nix Daemon Socket. machine # [ 55.308889] microvm@hermes-bob[1265]: [ OK ] Listening on OpenSSH Server Socket…temd-ssh-generator, AF_UNIX Local). machine # [ 55.322603] microvm@hermes-bob[1265]: [ OK ] Listening on SSH Socket. machine # [ 55.327564] microvm@hermes-bob[1265]: [ OK ] Listening on Virtual Machine and C…tainer Registration Service Socket. machine # [ 55.330446] microvm@hermes-bob[1265]: [ OK ] Reached target Socket Units. machine # [ 55.333373] microvm@hermes-bob[1265]: [ OK ] Reached target Basic System. machine # [ 55.340166] microvm@hermes-bob[1265]: Starting Hermes python venv (pip-writable)... machine # [ 55.348395] microvm@hermes-bob[1265]: Starting Import lastlog data into lastlog2 database... machine # [ 55.382147] microvm@hermes-bob[1265]: Starting Logrotate configuration check... machine # [ 55.399604] microvm@hermes-bob[1265]: Starting Name Service Cache Daemon (nsncd)... machine # [ 55.525068] microvm@hermes-bob[1265]: Starting Post-Boot Actions... machine # [ 55.549783] microvm@hermes-bob[1265]: [ OK ] Started Reset console on configuration changes. machine # [ 55.606261] microvm@hermes-bob[1265]: Starting D-Bus System Message Bus... machine # [ 55.704857] microvm@hermes-bob[1265]: [ OK ] Finished Logrotate configuration check. machine # [ 55.765669] microvm@hermes-bob[1265]: [ OK ] Finished Post-Boot Actions. machine # [ 55.804391] microvm@hermes-bob[1265]: [ OK ] Started Name Service Cache Daemon (nsncd). machine # [ 55.811964] microvm@hermes-bob[1265]: [ OK ] Reached target Host and Network Name Lookups. machine # [ 55.818516] microvm@hermes-bob[1265]: [ OK ] Reached target User and Group Name Lookups. machine # [ 55.839649] microvm@hermes-bob[1265]: Starting User Login Management... machine # [ 55.884090] microvm@hermes-bob[1265]: Starting Permit User Sessions... machine # [ 55.949106] microvm@hermes-bob[1265]: [ OK ] Finished Import lastlog data into lastlog2 database. machine # [ 56.074903] microvm@hermes-bob[1265]: [ OK ] Finished Permit User Sessions. machine # [ 56.093247] microvm@hermes-bob[1265]: [ OK ] Started Getty on tty1. machine # [ 56.133589] microvm@hermes-bob[1265]: [ OK ] Started Serial Getty on ttyS0. machine # [ 56.138174] microvm@hermes-bob[1265]: [ OK ] Reached target Login Prompts. machine # [ 56.173840] microvm@hermes-bob[1265]: [ OK ] Started User Login Management. machine # [ 56.180624] microvm@hermes-bob[1265]: [ OK ] Started D-Bus System Message Bus. machine # [ 56.211678] microvm@hermes-bob[1265]: Starting linger-users.service... machine # [ 56.340380] microvm@hermes-bob[1265]: [ OK ] Finished linger-users.service. machine # [ 63.233745] microvm@hermes-bob[1265]: +q6E616D65 machine # [ 63.234937] microvm@hermes-bob[1265]: machine # [ 63.242754] microvm@hermes-bob[1265]: <<< Welcome to NixOS 26.11pre-git (x86_64) - ttyS0 >>> machine # [ 63.244546] microvm@hermes-bob[1265]: machine # [ 63.247903] microvm@hermes-bob[1265]: Run 'nixos-help' for the NixOS manual. machine # [ 63.249284] microvm@hermes-bob[1265]: machine # [ 73.234915] systemd[1]: Started MicroVM 'hermes-alice'. machine # [ 73.237205] systemd[1]: Reached target microvms.target. machine # [ 73.238461] systemd[1]: Reached target Multi-User System. machine # [ 73.240883] systemd[1]: Startup finished in 977ms (kernel) + 3.738s (initrd) + 1min 8.523s (userspace) = 1min 13.239s. machine # [ 73.288704] supervisord[771]: virtiofsd-ro-store [2026-08-03T08:07:38Z INFO virtiofsd] Client connected, servicing requests machine # [ 73.289737] supervisord[771]: virtiofsd-hermes-exchange [2026-08-03T08:07:38Z INFO virtiofsd] Client connected, servicing requests machine # [ 73.290497] microvm@hermes-alice[1756]: microvm@hermes-alice: warning: Number of SMP cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 73.291495] microvm@hermes-alice[1756]: microvm@hermes-alice: warning: Number of hotpluggable cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 73.292937] supervisord[771]: virtiofsd-hermes-state [2026-08-03T08:07:38Z INFO virtiofsd] Client connected, servicing requests machine # [ 73.293777] supervisord[771]: virtiofsd-host-config [2026-08-03T08:07:38Z INFO virtiofsd] Client connected, servicing requests machine # [ 73.391587] microvm@hermes-alice[1756]: SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # [ 73.805140] microvm@hermes-alice[1756]: Booting from ROM... machine # [ 73.809306] microvm@hermes-alice[1756]: PPrroobbiinngg EEDDDD ((eedddd==ooffff ttoo ddiissaabbllee))...... ook machine # [ 74.085321] microvm@hermes-alice[1756]: No EFI environment detected. machine # [ 74.098348] microvm@hermes-alice[1756]: early console in extract_kernel machine # [ 74.105862] microvm@hermes-alice[1756]: input_data: 0x0000000003ac72cc machine # [ 74.113509] microvm@hermes-alice[1756]: input_len: 0x0000000000cb9a3c machine # [ 74.119171] microvm@hermes-alice[1756]: output: 0x0000000001000000 machine # [ 74.122742] microvm@hermes-alice[1756]: output_len: 0x0000000003728d94 machine # [ 74.127265] microvm@hermes-alice[1756]: kernel_total_size: 0x0000000002e30000 machine # [ 74.130963] microvm@hermes-alice[1756]: needed_size: 0x0000000003800000 machine # [ 74.134313] microvm@hermes-alice[1756]: trampoline_32bit: 0x0000000000000000 machine # [ 74.140990] microvm@hermes-alice[1756]: Physical KASLR using RDRAND RDTSC... machine # [ 74.144991] microvm@hermes-alice[1756]: Virtual KASLR using RDRAND RDTSC... machine # [ 74.146465] microvm@hermes-alice[1756]: machine # [ 74.150988] microvm@hermes-alice[1756]: Decompressing Linux... No EFI environment detected. machine: (finished: waiting for unit multi-user.target, in 74.81 seconds) subtest: dashboard gate on the iptables backend machine: must succeed: systemctl is-active firewall.service machine: (finished: must succeed: systemctl is-active firewall.service, in 0.03 seconds) machine: waiting for unit hermes-firewall.service machine: (finished: waiting for unit hermes-firewall.service, in 0.06 seconds) machine: must succeed: systemctl is-active hermes-dashboard-fwd-alice.socket machine: (finished: must succeed: systemctl is-active hermes-dashboard-fwd-alice.socket, in 0.02 seconds) machine: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' machine # [ 74.323341] runuser[1790]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 74.346472] runuser[1790]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901', in 0.06 seconds) machine: must fail: runuser -u bob -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' machine # [ 74.356516] systemd[1]: Created slice Slice /system/hermes-dashboard-fwd-alice. machine # [ 74.360861] systemd[1]: Started dashboard vsock forward for hermes-alice (127.0.0.1:47666). machine # [ 74.383574] runuser[1795]: pam_unix(runuser:session): session opened for user bob(uid=1001) by (uid=0) machine # bash: connect: Connection refused machine # bash: line 1: /dev/tcp/127.0.0.1/22901: Connection refused machine # [ 74.398655] runuser[1795]: pam_unix(runuser:session): session closed for user bob machine: (finished: must fail: runuser -u bob -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901', in 0.06 seconds) machine: must succeed: systemd-run --unit=marker-probe -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat' machine # [ 74.430479] systemd[1]: Started [systemd-run] /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat. machine # Running as unit: marker-probe.service; invocation ID: 2085949f36f74557842cd313dad7fc77 machine: (finished: must succeed: systemd-run --unit=marker-probe -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat', in 0.03 seconds) machine: waiting for TCP port 9999 on localhost machine # Connection to localhost (127.0.0.1) 9999 port [tcp/distinct] succeeded! machine: (finished: waiting for TCP port 9999 on localhost, in 0.07 seconds) machine: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' machine # [ 74.527849] runuser[1812]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 74.540396] runuser[1812]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999', in 0.04 seconds) machine: must fail: runuser -u alice -g users -G microvm-hermes-alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' machine # [ 74.569612] runuser[1818]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 74.929424] microvm@hermes-alice[1756]: Parsing ELF... Performing relocations... done. machine # [ 74.931637] microvm@hermes-alice[1756]: Booting the kernel (entry_offset: 0x000000000278c520). machine # [ 74.951952] microvm@hermes-alice[1756]: [ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Thu Jul 30 11:05:57 UTC 2026 machine # [ 74.968738] microvm@hermes-alice[1756]: [ 0.000000] Command line: earlyprintk=ttyS0 console=ttyS0 reboot=t panic=-1 8250.nr_uarts=1 8250.nr_uarts=1 root=fstab loglevel=4 lsm=landlock,yama,bpf init=/nix/store/4y7pfzmn6prjaf5lg2w2a9pfsxnjjv5i-nixos-system-hermes-alice-26.11pre-git/init regInfo=/nix/store/jz45idcfkv21y86s4vvc63hk8hypigfk-closure-info/registration machine # [ 74.971194] microvm@hermes-alice[1756]: [ 0.000000] BIOS-provided physical RAM map: machine # [ 74.975287] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 74.979241] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 74.983509] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 74.987460] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bfffdfff] usable machine # [ 74.991598] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x00000000bfffe000-0x00000000bfffffff] reserved machine # [ 74.995852] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 75.000271] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 75.003999] microvm@hermes-alice[1756]: [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable machine # [ 75.007649] microvm@hermes-alice[1756]: [ 0.000000] printk: legacy bootconsole [earlyser0] enabled machine # [ 75.013388] microvm@hermes-alice[1756]: Memory KASLR using RDRAND RDTSC... machine # bash: connect: Connection refused machine # bash: line 1: /dev/tcp/127.0.0.1/9999: Connection refused machine # [ 75.684470] runuser[1818]: pam_unix(runuser:session): session closed for user alice machine: (finished: must fail: runuser -u alice -g users -G microvm-hermes-alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999', in 1.15 seconds) (finished: subtest: dashboard gate on the iptables backend, in 1.51 seconds) subtest: dashboard gate on the nftables backend nft: waiting for unit multi-user.target nft: waiting for the VM to finish booting nft: Guest shell says: b'Spawning backdoor root shell...\n' nft: connected to guest root shell nft: (connecting took 0.00 seconds) nft: (finished: waiting for the VM to finish booting, in 0.00 seconds) nft: (finished: waiting for unit multi-user.target, in 0.07 seconds) nft: must fail: systemctl cat firewall.service nft # No files found for firewall.service. nft: (finished: must fail: systemctl cat firewall.service, in 0.02 seconds) nft: waiting for unit hermes-firewall.service nft: (finished: waiting for unit hermes-firewall.service, in 0.03 seconds) nft: must succeed: systemctl is-active hermes-dashboard-fwd-alice.socket nft: (finished: must succeed: systemctl is-active hermes-dashboard-fwd-alice.socket, in 0.01 seconds) nft: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' nft # [ 75.781907] runuser[771]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 75.794127] runuser[771]: pam_unix(runuser:session): session closed for user alice nft: (finished: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901', in 0.04 seconds) nft: must fail: runuser -u bob -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' nft # [ 75.802643] systemd[1]: Created slice Slice /system/hermes-dashboard-fwd-alice. nft # [ 75.806693] systemd[1]: Started dashboard vsock forward for hermes-alice (127.0.0.1:36498). nft # [ 75.825867] runuser[776]: pam_unix(runuser:session): session opened for user bob(uid=1001) by (uid=0) nft # bash: connect: Connection refused nft # bash: line 1: /dev/tcp/127.0.0.1/22901: Connection refused nft # [ 75.842724] runuser[776]: pam_unix(runuser:session): session closed for user bob nft: (finished: must fail: runuser -u bob -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901', in 0.05 seconds) nft: must succeed: systemd-run --unit=marker-probe -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat' nft # [ 75.857462] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:36498.service: Main process exited, code=exited, status=1/FAILURE nft # [ 75.859335] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:36498.service: Failed with result 'exit-code'. nft # Running as unit: marker-probe.service; invocation ID: 752aa87a369f4f21b01469c784801e7e nft # [ 75.872213] systemd[1]: Started [systemd-run] /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat. nft: (finished: must succeed: systemd-run --unit=marker-probe -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat TCP-LISTEN:9999,bind=127.0.0.1,fork,reuseaddr EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat', in 0.03 seconds) nft: waiting for TCP port 9999 on localhost nft # Connection to localhost (127.0.0.1) 9999 port [tcp/distinct] succeeded! nft: (finished: waiting for TCP port 9999 on localhost, in 0.05 seconds) nft: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' nft # [ 75.942861] runuser[794]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 75.954148] runuser[794]: pam_unix(runuser:session): session closed for user alice nft: (finished: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999', in 0.03 seconds) nft: must fail: runuser -u alice -g users -G microvm-hermes-alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' nft # [ 75.976655] runuser[800]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 76.443947] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:47666.service: Main process exited, code=exited, status=1/FAILURE machine # [ 76.447752] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:47666.service: Failed with result 'exit-code'. nft # bash: connect: Connection refused nft # bash: line 1: /dev/tcp/127.0.0.1/9999: Connection refused nft # [ 77.101608] runuser[800]: pam_unix(runuser:session): session closed for user alice nft: (finished: must fail: runuser -u alice -g users -G microvm-hermes-alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999', in 1.15 seconds) (finished: subtest: dashboard gate on the nftables backend, in 1.48 seconds) machine: waiting for unit microvm@hermes-alice.service machine: (finished: waiting for unit microvm@hermes-alice.service, in 0.13 seconds) machine: waiting for unit microvm@hermes-bob.service machine: (finished: waiting for unit microvm@hermes-bob.service, in 0.12 seconds) machine: waiting for success: runuser -u alice -- hermes --version machine # [ 77.459968] runuser[1837]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 77.656360] microvm@hermes-alice[1756]: Poking KASLR using RDRAND RDTSC... machine # [ 77.969276] microvm@hermes-alice[1756]: [ 2.879211] PCI: Fatal: No config space access function found machine # Failed to connect to vsock:735577804:22: Connection timed out machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 79.651073] runuser[1837]: pam_unix(runuser:session): session closed for user alice machine # [ 80.684945] runuser[1847]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 81.255352] microvm@hermes-alice[1756]: +q6E616D65Booting initrd of NixOS 26.11 (Zokor) (Initrd). machine # [ 81.549765] microvm@hermes-alice[1756]: [ OK ] Created slice Slice /system/modprobe. machine # [ 81.557230] microvm@hermes-alice[1756]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 81.562915] microvm@hermes-alice[1756]: [ OK ] Reached target Initrd Root Device. machine # [ 81.566368] microvm@hermes-alice[1756]: [ OK ] Reached target Path Units. machine # [ 81.569510] microvm@hermes-alice[1756]: [ OK ] Reached target Slice Units. machine # [ 81.572465] microvm@hermes-alice[1756]: [ OK ] Reached target Swaps. machine # [ 81.575575] microvm@hermes-alice[1756]: [ OK ] Reached target Timer Units. machine # [ 81.582402] microvm@hermes-alice[1756]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 81.586277] microvm@hermes-alice[1756]: [ OK ] Listening on Journal Socket (/dev/log). machine # [ 81.589779] microvm@hermes-alice[1756]: [ OK ] Listening on Journal Sockets. machine # [ 81.593035] microvm@hermes-alice[1756]: [ OK ] Listening on udev Control Socket. machine # [ 81.596801] microvm@hermes-alice[1756]: [ OK ] Listening on udev Kernel Socket. machine # [ 81.601184] microvm@hermes-alice[1756]: [ OK ] Reached target Socket Units. machine # [ 81.617575] microvm@hermes-alice[1756]: Starting Create List of Static Device Nodes... machine # [ 81.631171] microvm@hermes-alice[1756]: Starting Load Kernel Module configfs... machine # [ 81.709088] microvm@hermes-alice[1756]: Starting Journal Service... machine # [ 81.716914] microvm@hermes-alice[1756]: Starting Load Kernel Modules... machine # [ 81.728453] microvm@hermes-alice[1756]: Starting Coldplug All udev Devices... machine # [ 81.736379] microvm@hermes-alice[1756]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 81.752666] microvm@hermes-alice[1756]: [ OK ] Finished Load Kernel Module configfs. machine # [ 81.766905] microvm@hermes-alice[1756]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 81.881574] microvm@hermes-alice[1756]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 81.895444] microvm@hermes-alice[1756]: Starting Create Static Device Nodes in /dev... machine # [ 81.976435] microvm@hermes-alice[1756]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 81.993398] microvm@hermes-alice[1756]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 82.001172] microvm@hermes-alice[1756]: [ OK ] Reached target Local File Systems. machine # [ 82.018724] microvm@hermes-alice[1756]: Starting Rule-based Manager for Device Events and Files... machine # [ 82.022883] microvm@hermes-alice[1756]: [ OK ] Started Journal Service. machine # [ 82.139465] microvm@hermes-alice[1756]: [ OK ] Finished Coldplug All udev Devices. machine # [ 82.153343] microvm@hermes-alice[1756]: Starting Create System Files and Directories... machine # [ 82.188769] microvm@hermes-alice[1756]: [ OK ] Finished Create System Files and Directories. machine # [ 82.283420] microvm@hermes-alice[1756]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 82.520593] microvm@hermes-alice[1756]: [ OK ] Finished Load Kernel Modules. machine # [ 82.539562] microvm@hermes-alice[1756]: Starting Apply Kernel Variables... machine # [ 82.598942] microvm@hermes-alice[1756]: [ OK ] Finished Apply Kernel Variables. machine # [ 82.609186] microvm@hermes-alice[1756]: [ OK ] Reached target System Initialization. machine # [ 82.613190] microvm@hermes-alice[1756]: [ OK ] Reached target Basic System. machine # [ 82.620131] microvm@hermes-alice[1756]: Starting Virtual Console Setup... machine # [ 82.665567] microvm@hermes-alice[1756]: [ OK ] Finished Virtual Console Setup. machine # [ 82.734695] microvm@hermes-alice[1756]: Mounting /sysroot... machine # [ 82.772452] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot. machine # Failed to connect to vsock:735577804:22: Connection timed out machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 82.780789] runuser[1847]: pam_unix(runuser:session): session closed for user alice machine # [ 82.783921] microvm@hermes-alice[1756]: [ OK ] Reached target Initrd Root File System. machine # [ 82.792634] microvm@hermes-alice[1756]: Mounting /sysroot/nix/.ro-store... machine # [ 82.808225] microvm@hermes-alice[1756]: Mounting /sysroot/run... machine # [ 82.817442] microvm@hermes-alice[1756]: Mounting /sysroot/var/lib/hermes... machine # [ 82.832227] microvm@hermes-alice[1756]: Starting Mountpoints Configured in the Real Root... machine # [ 82.844042] microvm@hermes-alice[1756]: Starting rw-sysroot-nix-store.service... machine # [ 82.857135] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot/nix/.ro-store. machine # [ 82.861679] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot/run. machine # [ 82.866670] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot/var/lib/hermes. machine # [ 82.873168] microvm@hermes-alice[1756]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 82.977785] microvm@hermes-alice[1756]: Mounting /sysroot/run/hermes-host... machine # [ 82.995071] microvm@hermes-alice[1756]: Starting rw-sysroot-nix-store.service... machine # [ 83.006936] microvm@hermes-alice[1756]: [ OK ] Finished Mountpoints Configured in the Real Root. machine # [ 83.012399] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot/run/hermes-host. machine # [ 83.020646] microvm@hermes-alice[1756]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 83.735883] microvm@hermes-alice[1756]: Mounting /sysroot/nix/store... machine # [ 83.771181] microvm@hermes-alice[1756]: [ OK ] Mounted /sysroot/nix/store. machine # [ 83.776565] microvm@hermes-alice[1756]: [ OK ] Reached target Initrd File Systems. machine # [ 83.782721] microvm@hermes-alice[1756]: Starting Find NixOS closure... machine # [ 83.800955] microvm@hermes-alice[1756]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 83.816408] microvm@hermes-alice[1756]: [ OK ] Finished Create Volatile Files and Directories in the Real Root. machine # [ 83.823691] microvm@hermes-alice[1756]: [ OK ] Finished Find NixOS closure. machine # [ 83.827919] runuser[1857]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 83.832871] microvm@hermes-alice[1756]: [ OK ] Reached target Initrd Default Target. machine # [ 83.842345] microvm@hermes-alice[1756]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 83.877819] microvm@hermes-alice[1756]: [ OK ] Stopped target Initrd Default Target. machine # [ 83.882628] microvm@hermes-alice[1756]: [ OK ] Stopped target Basic System. machine # [ 83.890390] microvm@hermes-alice[1756]: [ OK ] Stopped target Initrd Root Device. machine # [ 83.893812] microvm@hermes-alice[1756]: [ OK ] Stopped target Path Units. machine # [ 83.899359] microvm@hermes-alice[1756]: [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 83.903579] microvm@hermes-alice[1756]: [ OK ] Stopped target Slice Units. machine # [ 83.907244] microvm@hermes-alice[1756]: [ OK ] Stopped target Socket Units. machine # [ 83.911760] microvm@hermes-alice[1756]: [ OK ] Stopped target System Initialization. machine # [ 83.915630] microvm@hermes-alice[1756]: [ OK ] Stopped target Swaps. machine # [ 83.919165] microvm@hermes-alice[1756]: [ OK ] Stopped target Timer Units. machine # [ 83.923361] microvm@hermes-alice[1756]: [ OK ] Closed D-Bus System Message Bus Socket. machine # [ 83.926955] microvm@hermes-alice[1756]: [ OK ] Stopped Find NixOS closure. machine # [ 83.934948] microvm@hermes-alice[1756]: Starting rw-sysroot-nix-store.service... machine # [ 83.940663] microvm@hermes-alice[1756]: [ OK ] Stopped Apply Kernel Variables. machine # [ 83.944435] microvm@hermes-alice[1756]: [ OK ] Stopped Load Kernel Modules. machine # [ 83.954306] microvm@hermes-alice[1756]: [ OK ] Stopped Create Volatile Files and Directories in the Real Root. machine # [ 83.963539] microvm@hermes-alice[1756]: [ OK ] Stopped Create System Files and Directories. machine # [ 83.969383] microvm@hermes-alice[1756]: [ OK ] Stopped target Local File Systems. machine # [ 83.977650] microvm@hermes-alice[1756]: [ OK ] Stopped target Preparation for Local File Systems. machine # [ 83.982622] microvm@hermes-alice[1756]: [ OK ] Stopped Coldplug All udev Devices. machine # [ 83.989688] microvm@hermes-alice[1756]: Stopping Rule-based Manager for Device Events and Files... machine # [ 83.995882] microvm@hermes-alice[1756]: [ OK ] Stopped Virtual Console Setup. machine # [ 84.008576] microvm@hermes-alice[1756]: [ OK ] Finished rw-sysroot-nix-store.service. machine # [ 84.018957] microvm@hermes-alice[1756]: [ OK ] Finished Cleaning Up and Shutting Down Daemons. machine # [ 84.026952] microvm@hermes-alice[1756]: [ OK ] Stopped Rule-based Manager for Device Events and Files. machine # [ 84.036567] microvm@hermes-alice[1756]: [ OK ] Closed udev Control Socket. machine # [ 84.044098] microvm@hermes-alice[1756]: Starting Cleanup udev Database... machine # [ 84.050398] microvm@hermes-alice[1756]: [ OK ] Stopped Create Static Device Nodes in /dev. machine # [ 84.057314] microvm@hermes-alice[1756]: [ OK ] Stopped Create Static Device Nodes in /dev gracefully. machine # [ 84.062329] microvm@hermes-alice[1756]: [ OK ] Stopped Create List of Static Device Nodes. machine # [ 84.085791] microvm@hermes-alice[1756]: [ OK ] Finished Cleanup udev Database. machine # [ 84.090789] microvm@hermes-alice[1756]: [ OK ] Reached target Switch Root. machine # [ 84.095077] microvm@hermes-alice[1756]: Starting NixOS Activation... machine # Failed to connect to vsock:735577804:22: Connection timed out machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 85.915768] runuser[1857]: pam_unix(runuser:session): session closed for user alice machine # [ 86.352152] microvm@hermes-alice[1756]: [* ] A start job is running for NixOS Activation (2s / no limit) machine # [ 86.935769] microvm@hermes-alice[1756]: [** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 86.953770] runuser[1867]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 87.517724] microvm@hermes-alice[1756]: [*** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 88.101288] microvm@hermes-alice[1756]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # [ 88.689772] microvm@hermes-alice[1756]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # Failed to connect to vsock:735577804:22: Connection timed out machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 89.051977] runuser[1867]: pam_unix(runuser:session): session closed for user alice machine # [ 89.224094] microvm@hermes-alice[1756]: [ ***] A start job is running for NixOS Activation (5s / no limit) machine # [ 89.227297] microvm@hermes-alice[1756]: [ OK ] Finished NixOS Activation. machine # [ 89.232501] microvm@hermes-alice[1756]: Starting Switch Root... machine # [ 90.078900] runuser[1877]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 90.116703] runuser[1877]: pam_unix(runuser:session): session closed for user alice machine # [ 90.600879] microvm@hermes-alice[1756]: +q6E616D65 machine # [ 90.605825] microvm@hermes-alice[1756]: Welcome to NixOS 26.11 (Zokor)! machine # [ 90.607739] microvm@hermes-alice[1756]: machine # [ 91.148768] runuser[1887]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 91.190468] runuser[1887]: pam_unix(runuser:session): session closed for user alice machine # [ 91.907278] microvm@hermes-alice[1756]: [ OK ] Stopped initrd-switch-root.service. machine # [ 91.911682] microvm@hermes-alice[1756]: [ OK ] Created slice Slice /system/getty. machine # [ 91.915542] microvm@hermes-alice[1756]: [ OK ] Created slice Slice /system/serial-getty. machine # [ 91.920369] microvm@hermes-alice[1756]: [ OK ] Created slice User and Session Slice. machine # [ 91.924536] microvm@hermes-alice[1756]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 91.928481] microvm@hermes-alice[1756]: [ OK ] Started Forward Password Requests to Wall Directory Watch. machine # [ 91.930631] microvm@hermes-alice[1756]: Expecting device /dev/ttyS0... machine # [ 91.937230] microvm@hermes-alice[1756]: [ OK ] Reached target Local Encrypted Volumes. machine # [ 91.941158] microvm@hermes-alice[1756]: [ OK ] Stopped target initrd-fs.target. machine # [ 91.945257] microvm@hermes-alice[1756]: [ OK ] Stopped target initrd-root-fs.target. machine # [ 91.948622] microvm@hermes-alice[1756]: [ OK ] Stopped target initrd-switch-root.target. machine # [ 91.952156] microvm@hermes-alice[1756]: [ OK ] Reached target Virtual Machines and Containers. machine # [ 91.954712] microvm@hermes-alice[1756]: [ OK ] Reached target Path Units. machine # [ 91.957501] microvm@hermes-alice[1756]: [ OK ] Reached target Remote File Systems. machine # [ 91.959927] microvm@hermes-alice[1756]: [ OK ] Reached target Slice Units. machine # [ 91.962266] microvm@hermes-alice[1756]: [ OK ] Reached target Swaps. machine # [ 91.971248] microvm@hermes-alice[1756]: [ OK ] Listening on Query the User Interactively for a Password. machine # [ 91.977837] microvm@hermes-alice[1756]: [ OK ] Listening on Process Core Dump Socket. machine # [ 91.985771] microvm@hermes-alice[1756]: [ OK ] Listening on Credential Encryption/Decryption. machine # [ 91.992514] microvm@hermes-alice[1756]: [ OK ] Listening on Factory Reset Management. machine # [ 91.995104] microvm@hermes-alice[1756]: [ OK ] Listening on Hostname Service Socket. machine # [ 92.004450] microvm@hermes-alice[1756]: Starting Journal Log Access Socket... machine # [ 92.008650] microvm@hermes-alice[1756]: [ OK ] Listening on Journal Audit Socket. machine # [ 92.016227] microvm@hermes-alice[1756]: [ OK ] Listening on Console Output Muting Service Socket. machine # [ 92.020764] microvm@hermes-alice[1756]: [ OK ] Listening on Network Management Resolve Hook Socket. machine # [ 92.024491] microvm@hermes-alice[1756]: [ OK ] Listening on Network Management Metrics Varlink Socket. machine # [ 92.027722] microvm@hermes-alice[1756]: [ OK ] Listening on Network Management Varlink Socket. machine # [ 92.031000] microvm@hermes-alice[1756]: [ OK ] Listening on Network Management Netlink Socket. machine # [ 92.034928] microvm@hermes-alice[1756]: [ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 92.052809] microvm@hermes-alice[1756]: [ OK ] Listening on Disk Repartitioning Service Socket. machine # [ 92.057172] microvm@hermes-alice[1756]: [ OK ] Listening on Resolve Monitor Varlink Socket. machine # [ 92.060192] microvm@hermes-alice[1756]: [ OK ] Listening on Resolve Service Varlink Socket. machine # [ 92.062643] microvm@hermes-alice[1756]: [ OK ] Listening on udev Control Socket. machine # [ 92.065463] microvm@hermes-alice[1756]: [ OK ] Listening on udev Varlink Socket. machine # [ 92.072410] microvm@hermes-alice[1756]: Mounting Huge Pages File System... machine # [ 92.083157] microvm@hermes-alice[1756]: Mounting POSIX Message Queue File System... machine # [ 92.123062] microvm@hermes-alice[1756]: Mounting Kernel Debug File System... machine # [ 92.166688] microvm@hermes-alice[1756]: Mounting Kernel Trace File System... machine # [ 92.210773] microvm@hermes-alice[1756]: Starting Create List of Static Device Nodes... machine # [ 92.228704] runuser[1897]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 92.262785] microvm@hermes-alice[1756]: Starting Load Kernel Module configfs... machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 92.281367] runuser[1897]: pam_unix(runuser:session): session closed for user alice machine # [ 92.317559] microvm@hermes-alice[1756]: Mounting FUSE Control File System... machine # [ 92.346146] microvm@hermes-alice[1756]: Starting Journal Service... machine # [ 92.424907] microvm@hermes-alice[1756]: Starting Load Kernel Modules... machine # [ 92.456995] microvm@hermes-alice[1756]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 92.520897] microvm@hermes-alice[1756]: Starting Remount Root and Kernel File Systems... machine # [ 92.575302] microvm@hermes-alice[1756]: Starting Coldplug All udev Devices... machine # [ 92.649618] microvm@hermes-alice[1756]: [ OK ] Listening on Journal Log Access Socket. machine # [ 92.655675] microvm@hermes-alice[1756]: [ OK ] Mounted Huge Pages File System. machine # [ 92.671267] microvm@hermes-alice[1756]: [ OK ] Mounted POSIX Message Queue File System. machine # [ 92.674789] microvm@hermes-alice[1756]: [ OK ] Mounted Kernel Debug File System. machine # [ 92.680704] microvm@hermes-alice[1756]: [ OK ] Mounted Kernel Trace File System. machine # [ 92.684825] microvm@hermes-alice[1756]: [ OK ] Started Journal Service. machine # [ 92.692093] microvm@hermes-alice[1756]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 92.696316] microvm@hermes-alice[1756]: [ OK ] Finished Load Kernel Module configfs. machine # [ 92.703059] microvm@hermes-alice[1756]: [ OK ] Mounted FUSE Control File System. machine # [ 92.727713] microvm@hermes-alice[1756]: Mounting Kernel Configuration File System... machine # [ 92.819249] microvm@hermes-alice[1756]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 92.888755] microvm@hermes-alice[1756]: [ OK ] Finished Load Kernel Modules. machine # [ 92.910660] microvm@hermes-alice[1756]: [ OK ] Finished Remount Root and Kernel File Systems. machine # [ 92.918131] microvm@hermes-alice[1756]: [ OK ] Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 92.933593] microvm@hermes-alice[1756]: [ OK ] Listening on Disk Image Download Service Socket. machine # [ 92.949750] microvm@hermes-alice[1756]: Starting Flush Journal to Persistent Storage... machine # [ 92.998772] microvm@hermes-alice[1756]: Starting Load/Save OS Random Seed... machine # [ 93.024384] microvm@hermes-alice[1756]: Starting Apply Kernel Variables... machine # [ 93.102974] microvm@hermes-alice[1756]: Starting Network Time Synchronization... machine # [ 93.163986] microvm@hermes-alice[1756]: [ OK ] Finished Coldplug All udev Devices. machine # [ 93.171905] microvm@hermes-alice[1756]: [ OK ] Mounted Kernel Configuration File System. machine # [ 93.243432] microvm@hermes-alice[1756]: [ OK ] Finished Load/Save OS Random Seed. machine # [ 93.266436] microvm@hermes-alice[1756]: [ OK ] Finished Flush Journal to Persistent Storage. machine # [ 93.275123] microvm@hermes-alice[1756]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 93.288274] microvm@hermes-alice[1756]: Starting Create Static Device Nodes in /dev... machine # [ 93.312895] runuser[1907]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 93.359224] runuser[1907]: pam_unix(runuser:session): session closed for user alice machine # [ 93.366615] microvm@hermes-alice[1756]: [ OK ] Finished Apply Kernel Variables. machine # [ 93.382522] microvm@hermes-alice[1756]: Starting Network Name Resolution... machine # [ 93.428857] microvm@hermes-alice[1756]: [ OK ] Started Network Time Synchronization. machine # [ 93.439635] microvm@hermes-alice[1756]: [ OK ] Reached target System Time Set. machine # [ 93.534376] microvm@hermes-alice[1756]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 93.539042] microvm@hermes-alice[1756]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 93.549334] microvm@hermes-alice[1756]: Starting Rule-based Manager for Device Events and Files... machine # [ 93.665736] microvm@hermes-alice[1756]: [ OK ] Started Network Name Resolution. machine # [ 93.877080] microvm@hermes-alice[1756]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 93.885458] microvm@hermes-alice[1756]: Starting Network Management... machine # [ 93.964659] microvm@hermes-alice[1756]: Mounting /home/alice/hermes... machine # [ 94.006922] microvm@hermes-alice[1756]: Mounting /run/wrappers... machine # [ 94.284931] microvm@hermes-alice[1756]: Starting Virtual Console Setup... machine # [ 94.399561] runuser[1917]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 94.433963] microvm@hermes-alice[1756]: [ OK ] Mounted /home/alice/hermes. machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 94.463564] runuser[1917]: pam_unix(runuser:session): session closed for user alice machine # [ 94.466123] microvm@hermes-alice[1756]: [ OK ] Mounted /run/wrappers. machine # [ 94.474581] microvm@hermes-alice[1756]: [ OK ] Reached target Local File Systems. machine # [ 94.489223] microvm@hermes-alice[1756]: [ OK ] Listening on Boot Loader Control Service Socket. machine # [ 94.514377] microvm@hermes-alice[1756]: Starting Create SUID/SGID Wrappers... machine # [ 94.562601] microvm@hermes-alice[1756]: Starting Create System Files and Directories... machine # [ 94.901452] microvm@hermes-alice[1756]: [ OK ] Finished Create System Files and Directories. machine # [ 94.911812] microvm@hermes-alice[1756]: Starting Rebuild Journal Catalog... machine # [ 94.968480] microvm@hermes-alice[1756]: Starting Record System Boot/Shutdown in UTMP... machine # [ 95.223386] microvm@hermes-alice[1756]: [ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 95.393709] microvm@hermes-alice[1756]: [ OK ] Finished Record System Boot/Shutdown in UTMP. machine # [ 95.446839] microvm@hermes-alice[1756]: [ OK ] Finished Rebuild Journal Catalog. machine # [ 95.468217] microvm@hermes-alice[1756]: Starting Update is Completed... machine # [ 95.509361] runuser[1927]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 95.561696] runuser[1927]: pam_unix(runuser:session): session closed for user alice machine # [ 95.730316] microvm@hermes-alice[1756]: [ OK ] Finished Update is Completed. machine # [ 95.965579] microvm@hermes-alice[1756]: [ OK ] Finished Virtual Console Setup. machine # [ 96.408648] microvm@hermes-alice[1756]: [ OK ] Started Network Management. machine # [ 96.414332] microvm@hermes-alice[1756]: [ OK ] Reached target Network. machine # [ 96.419691] microvm@hermes-alice[1756]: [ OK ] Reached target Network is Online. machine # [ 96.435990] microvm@hermes-alice[1756]: Starting Enable Persistent Storage in systemd-networkd... machine # [ 96.594478] runuser[1937]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 96.627651] microvm@hermes-alice[1756]: [ OK ] Finished Enable Persistent Storage in systemd-networkd. machine # Failed to connect to vsock:735577804:22: Connection reset by peer machine # mm_receive_fd: recvmsg: expected received 1 got 0 machine # proxy dialer did not pass back a connection machine # [ 96.637352] runuser[1937]: pam_unix(runuser:session): session closed for user alice machine # [ 96.817877] microvm@hermes-alice[1756]: [ OK ] Finished Create SUID/SGID Wrappers. machine # [ 96.822994] microvm@hermes-alice[1756]: [ OK ] Reached target System Initialization. machine # [ 96.830137] microvm@hermes-alice[1756]: [ OK ] Started Discard unused filesystem blocks once a week. machine # [ 96.833262] microvm@hermes-alice[1756]: [ OK ] Started logrotate.timer. machine # [ 96.836879] microvm@hermes-alice[1756]: [ OK ] Started Daily Cleanup of Temporary Directories. machine # [ 96.840254] microvm@hermes-alice[1756]: [ OK ] Reached target Timer Units. machine # [ 96.845540] microvm@hermes-alice[1756]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 96.849142] microvm@hermes-alice[1756]: [ OK ] Listening on Nix Daemon Socket. machine # [ 96.856739] microvm@hermes-alice[1756]: [ OK ] Listening on OpenSSH Server Socket…temd-ssh-generator, AF_UNIX Local). machine # [ 96.870842] microvm@hermes-alice[1756]: [ OK ] Listening on SSH Socket. machine # [ 96.875406] microvm@hermes-alice[1756]: [ OK ] Listening on Virtual Machine and C…tainer Registration Service Socket. machine # [ 96.878211] microvm@hermes-alice[1756]: [ OK ] Reached target Socket Units. machine # [ 96.880648] microvm@hermes-alice[1756]: [ OK ] Reached target Basic System. machine # [ 96.886295] microvm@hermes-alice[1756]: Starting Hermes python venv (pip-writable)... machine # [ 96.911452] microvm@hermes-alice[1756]: Starting Import lastlog data into lastlog2 database... machine # [ 96.947575] microvm@hermes-alice[1756]: Starting Logrotate configuration check... machine # [ 96.990618] microvm@hermes-alice[1756]: Starting Name Service Cache Daemon (nsncd)... machine # [ 97.032681] microvm@hermes-alice[1756]: Starting Post-Boot Actions... machine # [ 97.080274] microvm@hermes-alice[1756]: [ OK ] Started Reset console on configuration changes. machine # [ 97.182524] microvm@hermes-alice[1756]: Starting D-Bus System Message Bus... machine # [ 97.228308] microvm@hermes-alice[1756]: [ OK ] Finished Logrotate configuration check. machine # [ 97.268593] microvm@hermes-alice[1756]: [ OK ] Finished Post-Boot Actions. machine # [ 97.284275] microvm@hermes-alice[1756]: [ OK ] Started Name Service Cache Daemon (nsncd). machine # [ 97.292529] microvm@hermes-alice[1756]: [ OK ] Reached target Host and Network Name Lookups. machine # [ 97.296436] microvm@hermes-alice[1756]: [ OK ] Reached target User and Group Name Lookups. machine # [ 97.317324] microvm@hermes-alice[1756]: Starting User Login Management... machine # [ 97.370416] microvm@hermes-alice[1756]: Starting Permit User Sessions... machine # [ 97.395537] microvm@hermes-alice[1756]: [ OK ] Finished Import lastlog data into lastlog2 database. machine # [ 97.507959] microvm@hermes-alice[1756]: [ OK ] Finished Permit User Sessions. machine # [ 97.519476] microvm@hermes-alice[1756]: [ OK ] Started Getty on tty1. machine # [ 97.560135] microvm@hermes-alice[1756]: [ OK ] Started Serial Getty on ttyS0. machine # [ 97.570310] microvm@hermes-alice[1756]: [ OK ] Reached target Login Prompts. machine # [ 97.575445] microvm@hermes-alice[1756]: [ OK ] Started User Login Management. machine # [ 97.585579] microvm@hermes-alice[1756]: Starting linger-users.service... machine # [ 97.616243] microvm@hermes-alice[1756]: [ OK ] Started D-Bus System Message Bus. machine # [ 97.669083] runuser[1947]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 97.721099] microvm@hermes-alice[1756]: [ OK ] Created slice Slice /system/sshd. machine # [ 97.738401] microvm@hermes-alice[1756]: [ OK ] Started SSH per-connection Daemon (vsock:2:1256062079). machine # [ 97.783449] microvm@hermes-alice[1756]: [ OK ] Finished linger-users.service. machine # [ 98.244744] microvm@hermes-alice[1756]: [ OK ] Created slice Slice /user/1000. machine # [ 98.252788] microvm@hermes-alice[1756]: Starting User Runtime Directory /run/user/1000... machine # [ 98.396294] microvm@hermes-alice[1756]: [ OK ] Finished User Runtime Directory /run/user/1000. machine # [ 98.409598] microvm@hermes-alice[1756]: Starting User Manager for UID 1000... machine # [ 99.610704] microvm@hermes-alice[1756]: [ OK ] Started User Manager for UID 1000. machine # [ 99.669536] microvm@hermes-alice[1756]: [ OK ] Started Session 1 of User alice. machine # [ 104.739530] microvm@hermes-alice[1756]: +q6E616D65 machine # [ 104.740551] microvm@hermes-alice[1756]: machine # [ 104.748723] microvm@hermes-alice[1756]: <<< Welcome to NixOS 26.11pre-git (x86_64) - ttyS0 >>> machine # [ 104.749556] microvm@hermes-alice[1756]: machine # [ 104.752700] microvm@hermes-alice[1756]: Run 'nixos-help' for the NixOS manual. machine # [ 104.753782] microvm@hermes-alice[1756]: machine # [ 113.470768] runuser[1947]: pam_unix(runuser:session): session closed for user alice machine: (finished: waiting for success: runuser -u alice -- hermes --version, in 36.06 seconds) machine: must succeed: systemctl is-active hermes-spaces-bridge-alice.socket machine: (finished: must succeed: systemctl is-active hermes-spaces-bridge-alice.socket, in 0.02 seconds) machine: must succeed: systemctl show -p Listen hermes-spaces-bridge-alice.socket machine: (finished: must succeed: systemctl show -p Listen hermes-spaces-bridge-alice.socket, in 0.03 seconds) machine: waiting for success: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'systemctl is-active --quiet hermes-python-venv.service' machine # [ 113.547717] runuser[1963]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 114.160330] runuser[1963]: pam_unix(runuser:session): session closed for user alice machine: (finished: waiting for success: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'systemctl is-active --quiet hermes-python-venv.service', in 0.64 seconds) subtest: guest python contract machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'command -v python3'"'"'' machine # [ 114.186897] runuser[1966]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 114.791361] runuser[1966]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'command -v python3'"'"'', in 0.63 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'command -v pip'"'"'' machine # [ 114.821044] runuser[1971]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 115.418608] runuser[1971]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'command -v pip'"'"'', in 0.62 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'pip install --no-index --no-deps --quiet --dry-run pip'"'"'' machine # [ 115.445809] runuser[1976]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 118.907585] runuser[1976]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'pip install --no-index --no-deps --quiet --dry-run pip'"'"'', in 3.49 seconds) (finished: subtest: guest python contract, in 4.75 seconds) subtest: brain: credentials only, never a model pin machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- '! test -e /var/lib/hermes/.hermes/.model-seeded' machine # [ 118.930121] runuser[1981]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 119.490757] runuser[1981]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- '! test -e /var/lib/hermes/.hermes/.model-seeded', in 0.58 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'grep -q OPENROUTER_API_KEY /var/lib/hermes/.hermes/.env'"'"'' machine # [ 119.517312] runuser[1986]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 120.151493] runuser[1986]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'grep -q OPENROUTER_API_KEY /var/lib/hermes/.hermes/.env'"'"'', in 0.66 seconds) (finished: subtest: brain: credentials only, never a model pin, in 1.24 seconds) subtest: virtiofs uid translation: guest 1000 <-> runtime host uid machine: must succeed: id -u alice machine: (finished: must succeed: id -u alice, in 0.03 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'id -u'"'"'' machine # [ 120.201828] runuser[1994]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 121.049173] runuser[1994]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'id -u'"'"'', in 0.87 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'touch ~/xfer-marker'"'"'' machine # [ 121.105362] runuser[1999]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 121.863654] runuser[1999]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'touch ~/xfer-marker'"'"'', in 0.81 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'stat -c %u ~/xfer-marker'"'"'' machine # [ 121.887865] runuser[2004]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 122.702193] runuser[2004]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'stat -c %u ~/xfer-marker'"'"'', in 0.84 seconds) machine: must succeed: stat -c %u /home/alice/hermes/xfer-marker machine: (finished: must succeed: stat -c %u /home/alice/hermes/xfer-marker, in 0.02 seconds) (finished: subtest: virtiofs uid translation: guest 1000 <-> runtime host uid, in 2.57 seconds) subtest: spaces bridge: own VM passes the peer-CID gate machine: must succeed: id -u alice machine: (finished: must succeed: id -u alice, in 0.02 seconds) machine: must succeed: systemd-run --uid=alice --unit=fake-gw -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat UNIX-LISTEN:/run/user/1000/spaces-integration-gateway.sock,fork EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat' machine # [ 122.758868] systemd[1]: Started [systemd-run] /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat UNIX-LISTEN:/run/user/1000/spaces-integration-gateway.sock,fork EXEC:/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat. machine # Running as unit: fake-gw.service; invocation ID: dc22d92f57884fd9a5d8639cf4cd9e09 machine: (finished: must succeed: systemd-run --uid=alice --unit=fake-gw -- /nix/store/y9nx079bq7f3aff4fxp9995mckf3ql7m-socat-1.8.1.3/bin/socat UNIX-LISTEN:/run/user/1000/spaces-integration-gateway.sock,fork EXEC:'/nix/store/di26b1kkbammy0sj70nq5qzvfrh78wxl-coreutils-9.11/bin/cat', in 0.03 seconds) machine: waiting for success: test -S /run/user/1000/spaces-integration-gateway.sock machine # [ 123.084267] systemd[1]: Created slice Slice /system/hermes-spaces-bridge-alice. machine # [ 123.087330] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:2481322212). machine # [ 123.128573] systemd[1]: hermes-spaces-bridge-alice@0-4097-2:735578825-735577804:2481322212.service: Deactivated successfully. machine: (finished: waiting for success: test -S /run/user/1000/spaces-integration-gateway.sock, in 1.03 seconds) machine: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'printf ping | socat -T 10 STDIO VSOCK-CONNECT:2:735578825'"'"'' machine # [ 123.813561] runuser[2034]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 124.263918] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:2481322213). machine # [ 124.287418] systemd[1]: hermes-spaces-bridge-alice@1-8193-2:735578825-735577804:2481322213.service: Deactivated successfully. machine # [ 124.297473] runuser[2034]: pam_unix(runuser:session): session closed for user alice machine: (finished: must succeed: runuser -u alice -- ssh -q -i /var/lib/hermes-microvm/alice/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/alice/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-alice -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/735577804 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none alice@hermes-alice -- 'bash -lc '"'"'printf ping | socat -T 10 STDIO VSOCK-CONNECT:2:735578825'"'"'', in 0.50 seconds) (finished: subtest: spaces bridge: own VM passes the peer-CID gate, in 1.58 seconds) subtest: spaces bridge: sibling VM is rejected at accept machine: must succeed: runuser -u bob -- ssh -q -i /var/lib/hermes-microvm/bob/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/bob/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-bob -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/2176202715 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none bob@hermes-bob -- 'bash -lc '"'"'printf ping | socat -T 10 STDIO VSOCK-CONNECT:2:735578825 2>&1 || true'"'"'' machine # [ 124.321896] runuser[2045]: pam_unix(runuser:session): session opened for user bob(uid=1001) by (uid=0) machine # [ 124.560899] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:2481322214). machine # [ 124.594381] systemd[1]: hermes-spaces-bridge-alice@2-8194-2:735578825-735577804:2481322214.service: Deactivated successfully. machine # [ 126.290539] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:2176202715:2505448270). machine # [ 126.311581] hermes-vsock-spaces-bridge[2056]: rejecting connection: peer cid 2176202715, expected 735577804 machine # [ 126.313333] systemd[1]: hermes-spaces-bridge-alice@3-4098-2:735578825-2176202715:2505448270.service: Main process exited, code=exited, status=1/FAILURE machine # [ 126.315705] systemd[1]: hermes-spaces-bridge-alice@3-4098-2:735578825-2176202715:2505448270.service: Failed with result 'exit-code'. machine # [ 126.327037] runuser[2045]: pam_unix(runuser:session): session closed for user bob machine: (finished: must succeed: runuser -u bob -- ssh -q -i /var/lib/hermes-microvm/bob/ssh/client_ed25519 -o UserKnownHostsFile=/var/lib/hermes-microvm/bob/ssh/known_hosts -o StrictHostKeyChecking=yes -o HostKeyAlias=hermes-bob -o ProxyCommand='/nix/store/hbg7ib0c60pn7hi8sx7w5yvs8yfahwgw-systemd-261.1/lib/systemd/systemd-ssh-proxy vsock/2176202715 22' -o ProxyUseFdpass=yes -o ControlMaster=no -o ControlPath=none bob@hermes-bob -- 'bash -lc '"'"'printf ping | socat -T 10 STDIO VSOCK-CONNECT:2:735578825 2>&1 || true'"'"'', in 2.03 seconds) machine: waiting for success: journalctl -u 'hermes-spaces-bridge-alice@*' | grep -q 'rejecting connection: peer cid 2176202715' machine: (finished: waiting for success: journalctl -u 'hermes-spaces-bridge-alice@*' | grep -q 'rejecting connection: peer cid 2176202715', in 0.02 seconds) (finished: subtest: spaces bridge: sibling VM is rejected at accept, in 2.05 seconds) (finished: run the VM test script, in 127.26 seconds) test script finished in 127.32s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/gxzhl7aaiid7zp3y47jqqiq7zg5mqpwp-python3-3.14.6/bin/python3.14) kill QemuMachine (pid 71) nft # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/gxzhl7aaiid7zp3y47jqqiq7zg5mqpwp-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.58 seconds)