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.ZdMiAs3gOx', 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: 2fb05b1c-a187-46d8-a39d-9780723e2a0f 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 # Writing superblocks and filesystem accounting information: 0/192 done machine # machine: QEMU running (pid 45) machine # Virtualisation disk image created. nft: starting vm machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) nft: QEMU running (pid 70) nft # Disk image does not exist, creating the virtualisation disk image... nft # Formatting '/build/vm-state-nft/tmp.bOGWs8kOEN', 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: ab290139-ccf4-4bcf-9e3b-5fb28ef1f06c nft # Superblock backups stored on blocks: nft # 32768, 98304, 163840, 229376 nft # nft # Allocating group tables: 0/8 done nft # Writing inode tables: 0/8 done machine: waiting for unit multi-user.target nft # Creating journal (8192 blocks): done machine: waiting for the VM to finish booting nft # Writing superblocks and filesystem accounting information: 0/8 done nft # nft # Virtualisation disk image created. 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 # nft # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok 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)... ok[ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Aug 3 09:22:13 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/kv7ji9frx41fyl605r0nh66g7i5yhbp6-nixos-system-nft-test/init regInfo=/nix/store/4a1ici4rv5d66h6lsq1dwcxcmv1xmx20-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.000000] BIOS-provided physical RAM map: 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 nft # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved nft # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved nft # [ 0.000000] NX (Execute Disable) protection: active nft # [ 0.000000] APIC: Static calls initialized nft # [ 0.000000] SMBIOS 2.8 present. 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 nft # [ 0.000000] Hypervisor detected: KVM nft # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x400000000 nft # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 nft # [ 0.000000] kvm-clock: using sched offset of 452631307 cycles nft # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns nft # [ 0.000007] tsc: Detected 4192.076 MHz processor nft # [ 0.000815] last_pfn = 0x7ffdb max_arch_pfn = 0x400000000 nft # [ 0.000852] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs nft # [ 0.000856] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT nft # [ 0.003105] found SMP MP-table at [mem 0x000f5470-0x000f547f] nft # [ 0.003123] Using GB pages for direct mapping nft # [ 0.003236] RAMDISK: [mem 0x7e350000-0x7ffcffff] nft # [ 0.003243] ACPI: Early table checksum verification disabled nft # [ 0.003247] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) nft # [ 0.003251] ACPI: RSDT 0x000000007FFE2427 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003255] ACPI: FACP 0x000000007FFE22D3 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003263] ACPI: DSDT 0x000000007FFE0040 002293 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003265] ACPI: FACS 0x000000007FFE0000 000040 nft # [ 0.003266] ACPI: APIC 0x000000007FFE2347 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003267] ACPI: HPET 0x000000007FFE23C7 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003269] ACPI: WAET 0x000000007FFE23FF 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.003270] ACPI: Reserving FACP table memory at [mem 0x7ffe22d3-0x7ffe2346] nft # [ 0.003273] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe22d2] nft # [ 0.003273] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] nft # [ 0.003273] ACPI: Reserving APIC table memory at [mem 0x7ffe2347-0x7ffe23c6] nft # [ 0.003274] ACPI: Reserving HPET table memory at [mem 0x7ffe23c7-0x7ffe23fe] nft # [ 0.003274] ACPI: Reserving WAET table memory at [mem 0x7ffe23ff-0x7ffe2426] nft # [ 0.003724] No NUMA configuration found nft # [ 0.003725] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] nft # [ 0.003728] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] nft # [ 0.003811] Zone ranges: nft # [ 0.003811] DMA [mem 0x0000000000001000-0x0000000000ffffff] nft # [ 0.003812] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] nft # [ 0.003814] Normal empty nft # [ 0.003816] Device empty nft # [ 0.003816] Movable zone start for each node nft # [ 0.003817] Early memory node ranges nft # [ 0.003817] node 0: [mem 0x0000000000001000-0x000000000009efff] nft # [ 0.003818] node 0: [mem 0x0000000000100000-0x000000007ffdafff] nft # [ 0.003819] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] nft # [ 0.003838] On node 0, zone DMA: 1 pages in unavailable ranges nft # [ 0.004086] On node 0, zone DMA: 97 pages in unavailable ranges nft # [ 0.037694] On node 0, zone DMA32: 37 pages in unavailable ranges nft # [ 0.038620] ACPI: PM-Timer IO Port: 0x608 nft # [ 0.038633] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) nft # [ 0.038661] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 nft # [ 0.038663] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) nft # [ 0.038666] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) nft # [ 0.038667] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) nft # [ 0.038668] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) nft # [ 0.038668] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) nft # [ 0.038672] ACPI: Using ACPI (MADT) for SMP configuration information nft # [ 0.038673] ACPI: HPET id: 0x8086a201 base: 0xfed00000 nft # [ 0.038676] TSC deadline timer available nft # [ 0.038681] CPU topo: Max. logical packages: 1 nft # [ 0.038681] CPU topo: Max. logical dies: 1 nft # [ 0.038682] CPU topo: Max. dies per package: 1 nft # [ 0.038688] CPU topo: Max. threads per core: 1 nft # [ 0.038689] CPU topo: Num. cores per package: 2 nft # [ 0.038689] CPU topo: Num. threads per package: 2 nft # [ 0.038689] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs nft # [ 0.038703] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() nft # [ 0.038717] kvm-guest: KVM setup pv remote TLB flush nft # [ 0.038720] kvm-guest: setup PV sched yield nft # [ 0.038736] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] nft # [ 0.038739] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] nft # [ 0.038740] [mem 0x80000000-0xfeffbfff] available for PCI devices nft # [ 0.038741] Booting paravirtualized kernel on KVM nft # [ 0.038743] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns nft # [ 0.043460] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 nft # [ 0.045785] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 nft # [ 0.045829] kvm-guest: PV spinlocks enabled machine # [ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Aug 3 09:22:13 UTC 2026 nft # [ 0.045832] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) 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/k4vfb6g0z0k62k0nwn4jx0gmcvxrvm5a-nixos-system-machine-test/init regInfo=/nix/store/gm1jsp0hrgdwnaxqyrj7b29h21csz9k5-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.045834] 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/kv7ji9frx41fyl605r0nh66g7i5yhbp6-nixos-system-nft-test/init regInfo=/nix/store/4a1ici4rv5d66h6lsq1dwcxcmv1xmx20-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable nft # [ 0.045927] Unknown kernel command line parameters "regInfo=/nix/store/4a1ici4rv5d66h6lsq1dwcxcmv1xmx20-closure-info/registration", will be passed to user space. machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved nft # [ 0.046143] random: crng init done machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved nft # [ 0.046144] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdafff] usable nft # [ 0.048362] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) machine # [ 0.000000] BIOS-e820: [mem 0x00000000bffdb000-0x00000000bfffffff] reserved nft # [ 0.049426] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved nft # [ 0.049473] Fallback order for Node 0: 0 machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved nft # [ 0.049476] Built 1 zonelists, mobility grouping on. Total pages: 524153 machine # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable nft # [ 0.049476] Policy zone: DMA32 machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved nft # [ 0.051635] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] NX (Execute Disable) protection: active nft # [ 0.056497] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. nft # [ 0.060675] allocated 4194304 bytes of page_ext nft # [ 0.071478] ftrace: allocating 48722 entries in 192 pages 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.071480] ftrace: allocated 192 pages with 2 groups machine # [ 0.000000] DMI: Memory slots populated: 1/1 nft # [ 0.072306] Dynamic Preempt: lazy machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 nft # [ 0.072473] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 nft # [ 0.072474] rcu: RCU event tracing is enabled. machine # [ 0.000000] kvm-clock: using sched offset of 470307391 cycles nft # [ 0.072474] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns nft # [ 0.072476] Trampoline variant of Tasks RCU enabled. machine # [ 0.000004] tsc: Detected 4192.076 MHz processor nft # [ 0.072476] Rude variant of Tasks RCU enabled. machine # [ 0.000823] last_pfn = 0x240000 max_arch_pfn = 0x400000000 nft # [ 0.072476] Tracing variant of Tasks RCU enabled. machine # [ 0.000867] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs nft # [ 0.072477] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.000870] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT nft # [ 0.072477] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 machine # [ 0.000925] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 machine # [ 0.003194] found SMP MP-table at [mem 0x000f5470-0x000f547f] nft # [ 0.072493] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.003211] Using GB pages for direct mapping machine # [ 0.003324] RAMDISK: [mem 0xbe34f000-0xbffcffff] nft # [ 0.072494] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.003330] ACPI: Early table checksum verification disabled machine # [ 0.003333] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) nft # [ 0.072495] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. machine # [ 0.003338] ACPI: RSDT 0x00000000BFFE24E3 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.076838] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 machine # [ 0.003342] ACPI: FACP 0x00000000BFFE237F 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.077142] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.003349] ACPI: DSDT 0x00000000BFFE0040 00233F (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.077147] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.003351] ACPI: FACS 0x00000000BFFE0000 000040 machine # [ 0.003354] ACPI: APIC 0x00000000BFFE23F3 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.077346] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) nft # [ 0.084860] Console: colour VGA+ 80x25 machine # [ 0.003356] ACPI: HPET 0x00000000BFFE2483 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.084868] printk: legacy console [tty0] enabled machine # [ 0.003357] ACPI: WAET 0x00000000BFFE24BB 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) nft # [ 0.125499] printk: legacy console [ttyS0] enabled machine # [ 0.003360] ACPI: Reserving FACP table memory at [mem 0xbffe237f-0xbffe23f2] nft # [ 0.296762] ACPI: Core revision 20250807 machine # [ 0.003361] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe237e] machine # [ 0.003362] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] nft # [ 0.298364] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.003363] ACPI: Reserving APIC table memory at [mem 0xbffe23f3-0xbffe2482] nft # [ 0.301392] APIC: Switch to symmetric I/O mode setup machine # [ 0.003363] ACPI: Reserving HPET table memory at [mem 0xbffe2483-0xbffe24ba] nft # [ 0.303328] x2apic enabled machine # [ 0.003364] ACPI: Reserving WAET table memory at [mem 0xbffe24bb-0xbffe24e2] machine # [ 0.003827] No NUMA configuration found nft # [ 0.304781] APIC: Switched APIC routing to: physical x2apic machine # [ 0.003829] Faking a node at [mem 0x0000000000000000-0x000000023fffffff] machine # [ 0.003831] NODE_DATA(0) allocated [mem 0x23fffa780-0x23ffffcff] nft # [ 0.306678] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() machine # [ 0.003931] Zone ranges: machine # [ 0.003931] DMA [mem 0x0000000000001000-0x0000000000ffffff] nft # [ 0.308939] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() machine # [ 0.003933] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] nft # [ 0.311601] kvm-guest: setup PV IPIs machine # [ 0.003934] Normal [mem 0x0000000100000000-0x000000023fffffff] machine # [ 0.003935] Device empty machine # [ 0.003935] Movable zone start for each node machine # [ 0.003938] Early memory node ranges nft # [ 0.314050] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.003938] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.003939] node 0: [mem 0x0000000000100000-0x00000000bffdafff] nft # [ 0.315745] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns machine # [ 0.003940] node 0: [mem 0x0000000100000000-0x000000023fffffff] machine # [ 0.003941] Initmem setup node 0 [mem 0x0000000000001000-0x000000023fffffff] nft # [ 0.318532] Calibrating delay loop (skipped) preset value.. 8384.15 BogoMIPS (lpj=4192076) machine # [ 0.003958] On node 0, zone DMA: 1 pages in unavailable ranges nft # [ 0.319655] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.004206] On node 0, zone DMA: 97 pages in unavailable ranges nft # [ 0.320673] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.150628] On node 0, zone Normal: 37 pages in unavailable ranges machine # [ 0.151643] ACPI: PM-Timer IO Port: 0x608 nft # [ 0.321529] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.151660] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.151694] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 nft # [ 0.323535] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.151698] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.151699] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) nft # [ 0.324538] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.151702] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.151703] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.151704] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.151707] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.151710] ACPI: HPET id: 0x8086a201 base: 0xfed00000 nft # [ 0.325533] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.151718] TSC deadline timer available machine # [ 0.151724] CPU topo: Max. logical packages: 1 nft # [ 0.327531] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.151725] CPU topo: Max. logical dies: 1 machine # [ 0.151727] CPU topo: Max. dies per package: 1 nft # [ 0.329529] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.151731] CPU topo: Max. threads per core: 1 nft # [ 0.330544] Spectre V2 : Enabling IBPB for BPF machine # [ 0.151731] CPU topo: Num. cores per package: 4 machine # [ 0.151732] CPU topo: Num. threads per package: 4 nft # [ 0.332532] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.151732] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs nft # [ 0.333530] active return thunk: srso_alias_return_thunk machine # [ 0.151758] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.151781] kvm-guest: KVM setup pv remote TLB flush nft # [ 0.334563] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.151785] kvm-guest: setup PV sched yield machine # [ 0.151806] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] nft # [ 0.336529] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.151807] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] nft # [ 0.338528] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.151808] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] nft # [ 0.339529] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.151812] [mem 0xc0000000-0xfeffbfff] available for PCI devices nft # [ 0.340528] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.151814] Booting paravirtualized kernel on KVM nft # [ 0.342530] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.151817] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.156955] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 nft # [ 0.343530] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.159696] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288 nft # [ 0.344530] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' machine # [ 0.159760] kvm-guest: PV spinlocks enabled machine # [ 0.159764] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) nft # [ 0.345528] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' nft # [ 0.346529] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 nft # [ 0.347530] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 nft # [ 0.348529] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.159769] 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/k4vfb6g0z0k62k0nwn4jx0gmcvxrvm5a-nixos-system-machine-test/init regInfo=/nix/store/gm1jsp0hrgdwnaxqyrj7b29h21csz9k5-closure-info/registration console=ttyS0,115200n8 console=tty0 nft # [ 0.350528] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 nft # [ 0.351528] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.159890] Unknown kernel command line parameters "regInfo=/nix/store/gm1jsp0hrgdwnaxqyrj7b29h21csz9k5-closure-info/registration", will be passed to user space. machine # [ 0.160106] random: crng init done nft # [ 0.353530] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 machine # [ 0.160107] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes nft # [ 0.354528] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 machine # [ 0.170555] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) nft # [ 0.355530] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. machine # [ 0.175439] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) machine # [ 0.175511] software IO TLB: area num 4. machine # [ 0.249613] Fallback order for Node 0: 0 machine # [ 0.249620] Built 1 zonelists, mobility grouping on. Total pages: 2097017 machine # [ 0.249622] Policy zone: Normal machine # [ 0.251975] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.266307] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 machine # [ 0.283858] allocated 16777216 bytes of page_ext machine # [ 0.294558] ftrace: allocating 48722 entries in 192 pages machine # [ 0.294562] ftrace: allocated 192 pages with 2 groups machine # [ 0.295388] Dynamic Preempt: lazy machine # [ 0.295551] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.295552] rcu: RCU event tracing is enabled. machine # [ 0.295552] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. machine # [ 0.295554] Trampoline variant of Tasks RCU enabled. machine # [ 0.295554] Rude variant of Tasks RCU enabled. machine # [ 0.295554] Tracing variant of Tasks RCU enabled. machine # [ 0.295555] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.295556] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 machine # [ 0.295573] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.295574] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.295575] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.299938] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16 nft # [ 0.385208] Freeing SMP alternatives memory: 44K machine # [ 0.300273] rcu: srcu_init: Setting srcu_struct sizes based on contention. nft # [ 0.385533] pid_max: default: 32768 minimum: 301 machine # [ 0.300280] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns nft # [ 0.387635] LSM: initializing lsm=capability,landlock,yama,bpf,ima nft # [ 0.388644] landlock: Up and running. machine # [ 0.300476] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.306964] Console: colour VGA+ 80x25 nft # [ 0.390224] Yama: becoming mindful. machine # [ 0.306968] printk: legacy console [tty0] enabled nft # [ 0.391444] LSM support for eBPF active machine # [ 0.351435] printk: legacy console [ttyS0] enabled machine # [ 0.524805] ACPI: Core revision 20250807 nft # [ 0.392622] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) nft # [ 0.393573] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) machine # [ 0.526197] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.529029] APIC: Switch to symmetric I/O mode setup machine # [ 0.530746] x2apic enabled nft # [ 0.396968] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) machine # [ 0.531869] APIC: Switched APIC routing to: physical x2apic nft # [ 0.398181] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.533347] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() nft # [ 0.399542] ... version: 2 nft # [ 0.400534] ... bit width: 48 machine # [ 0.535538] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() nft # [ 0.401530] ... generic counters: 6 machine # [ 0.537927] kvm-guest: setup PV IPIs nft # [ 0.402534] ... generic bitmap: 000000000000003f nft # [ 0.403530] ... fixed-purpose counters: 0 machine # [ 0.540077] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 nft # [ 0.404530] ... fixed-purpose bitmap: 0000000000000000 nft # [ 0.405530] ... value mask: 0000ffffffffffff machine # [ 0.541610] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns nft # [ 0.406531] ... max period: 00007fffffffffff machine # [ 0.544279] Calibrating delay loop (skipped) preset value.. 8384.15 BogoMIPS (lpj=4192076) nft # [ 0.407530] ... global_ctrl mask: 000000000000003f machine # [ 0.545398] x86/cpu: User Mode Instruction Prevention (UMIP) activated nft # [ 0.408640] signal: max sigframe size: 3376 nft # [ 0.409641] rcu: Hierarchical SRCU implementation. nft # [ 0.410535] rcu: Max phase no-delay instances is 400. nft # [ 0.411765] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level machine # [ 0.546408] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.548279] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 nft # [ 0.416982] smp: Bringing up secondary CPUs ... machine # [ 0.550285] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto nft # [ 0.417918] smpboot: x86: Booting SMP configuration: nft # [ 0.418542] .... node #0, CPUs: #1 machine # [ 0.552280] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl nft # [ 0.418666] smp: Brought up 1 node, 2 CPUs machine # [ 0.554279] Spectre V2 : Mitigation: Enhanced / Automatic IBRS nft # [ 0.420537] smpboot: Total of 2 processors activated (16768.30 BogoMIPS) machine # [ 0.555279] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.556277] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization nft # [ 0.421810] Memory: 1970760K/2096612K available (17210K kernel code, 2726K rwdata, 13576K rodata, 3640K init, 2992K bss, 116012K reserved, 0K cma-reserved) machine # [ 0.557290] Spectre V2 : Enabling IBPB for BPF nft # [ 0.422870] devtmpfs: initialized nft # [ 0.423739] x86/mm: Memory block size: 128MB machine # [ 0.558281] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.559279] active return thunk: srso_alias_return_thunk nft # [ 0.425854] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) machine # [ 0.560311] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.562277] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' nft # [ 0.427579] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). machine # [ 0.563279] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' nft # [ 0.428636] pinctrl core: initialized pinctrl subsystem machine # [ 0.564279] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' nft # [ 0.429966] PM: RTC time: 10:48:21, date: 2026-08-06 machine # [ 0.566278] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.568277] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' nft # [ 0.433485] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.569277] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.570278] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' nft # [ 0.435129] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.572277] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' nft # [ 0.435586] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.573278] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 nft # [ 0.436842] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.574278] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 nft # [ 0.437555] audit: initializing netlink subsys (disabled) machine # [ 0.575278] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 nft # [ 0.438626] audit: type=2000 audit(1786013301.838:1): state=initialized audit_enabled=0 res=1 machine # [ 0.576278] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 nft # [ 0.438827] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.578277] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 nft # [ 0.439539] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.579277] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 machine # [ 0.581278] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 nft # [ 0.440532] thermal_sys: Registered thermal governor 'step_wise' nft # [ 0.441534] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.582277] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. nft # [ 0.442533] thermal_sys: Registered thermal governor 'power_allocator' nft # [ 0.443567] cpuidle: using governor menu nft # [ 0.446789] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 nft # [ 0.447857] PCI: Using configuration type 1 for base access nft # [ 0.448531] PCI: Using configuration type 1 for extended access nft # [ 0.449833] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. nft # [ 0.457572] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages nft # [ 0.458533] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page nft # [ 0.459544] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages nft # [ 0.462534] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.613781] Freeing SMP alternatives memory: 44K machine # [ 0.614282] pid_max: default: 32768 minimum: 301 machine # [ 0.616361] LSM: initializing lsm=capability,landlock,yama,bpf,ima nft # [ 0.467876] ACPI: Added _OSI(Module Device) nft # [ 0.468538] ACPI: Added _OSI(Processor Device) machine # [ 0.617433] landlock: Up and running. machine # [ 0.619277] Yama: becoming mindful. nft # [ 0.469534] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.620586] LSM support for eBPF active machine # [ 0.621523] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) nft # [ 0.472901] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.624349] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) nft # [ 0.476884] ACPI: Interpreter enabled machine # [ 0.626840] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) nft # [ 0.478420] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.627991] Performance Events: Fam17h+ core perfctr, AMD PMU driver. nft # [ 0.479532] ACPI: Using IOAPIC for interrupt routing machine # [ 0.629299] ... version: 2 machine # [ 0.630281] ... bit width: 48 nft # [ 0.480570] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.631286] ... generic counters: 6 nft # [ 0.481531] PCI: Using E820 reservations for host bridge windows machine # [ 0.632285] ... generic bitmap: 000000000000003f nft # [ 0.482746] ACPI: Enabled 2 GPEs in block 00 to 0F machine # [ 0.633281] ... fixed-purpose counters: 0 machine # [ 0.634283] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.635281] ... value mask: 0000ffffffffffff machine # [ 0.636281] ... max period: 00007fffffffffff machine # [ 0.637280] ... global_ctrl mask: 000000000000003f nft # [ 0.487974] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) nft # [ 0.488541] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.638439] signal: max sigframe size: 3376 machine # [ 0.639407] rcu: Hierarchical SRCU implementation. nft # [ 0.489936] acpiphp: Slot [3] registered machine # [ 0.640286] rcu: Max phase no-delay instances is 400. nft # [ 0.490579] acpiphp: Slot [4] registered nft # [ 0.491566] acpiphp: Slot [5] registered machine # [ 0.641490] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level nft # [ 0.492565] acpiphp: Slot [6] registered nft # [ 0.493577] acpiphp: Slot [7] registered nft # [ 0.494563] acpiphp: Slot [8] registered nft # [ 0.495564] acpiphp: Slot [9] registered nft # [ 0.496569] acpiphp: Slot [10] registered machine # [ 0.646199] smp: Bringing up secondary CPUs ... nft # [ 0.497581] acpiphp: Slot [11] registered nft # [ 0.498568] acpiphp: Slot [12] registered machine # [ 0.647671] smpboot: x86: Booting SMP configuration: nft # [ 0.499564] acpiphp: Slot [13] registered nft # [ 0.500564] acpiphp: Slot [14] registered nft # [ 0.501702] acpiphp: Slot [15] registered machine # [ 0.648284] .... node #0, CPUs: #1 #2 #3 nft # [ 0.502600] acpiphp: Slot [16] registered machine # [ 0.650341] smp: Brought up 1 node, 4 CPUs nft # [ 0.503583] acpiphp: Slot [17] registered machine # [ 0.652282] smpboot: Total of 4 processors activated (33536.60 BogoMIPS) nft # [ 0.504586] acpiphp: Slot [18] registered nft # [ 0.505584] acpiphp: Slot [19] registered nft # [ 0.506572] acpiphp: Slot [20] registered nft # [ 0.507584] acpiphp: Slot [21] registered machine # [ 0.653822] Memory: 8073800K/8388068K available (17210K kernel code, 2726K rwdata, 13576K rodata, 3640K init, 2992K bss, 290652K reserved, 0K cma-reserved) nft # [ 0.508586] acpiphp: Slot [22] registered nft # [ 0.509572] acpiphp: Slot [23] registered machine # [ 0.656283] devtmpfs: initialized nft # [ 0.510589] acpiphp: Slot [24] registered machine # [ 0.657648] x86/mm: Memory block size: 128MB nft # [ 0.511581] acpiphp: Slot [25] registered nft # [ 0.512585] acpiphp: Slot [26] registered nft # [ 0.513566] acpiphp: Slot [27] registered nft # [ 0.514576] acpiphp: Slot [28] registered machine # [ 0.661333] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) nft # [ 0.515577] acpiphp: Slot [29] registered machine # [ 0.662388] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). nft # [ 0.516600] acpiphp: Slot [30] registered nft # [ 0.517574] acpiphp: Slot [31] registered machine # [ 0.663432] pinctrl core: initialized pinctrl subsystem nft # [ 0.518560] PCI host bridge to bus 0000:00 nft # [ 0.519547] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.664742] PM: RTC time: 10:48:22, date: 2026-08-06 nft # [ 0.520538] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] nft # [ 0.521536] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.669059] NET: Registered PF_NETLINK/PF_ROUTE protocol family nft # [ 0.522532] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] nft # [ 0.523534] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] machine # [ 0.671693] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations nft # [ 0.524534] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.672356] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations nft # [ 0.525967] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.674441] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.675304] audit: initializing netlink subsys (disabled) nft # [ 0.527519] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.676412] audit: type=2000 audit(1786013301.963:1): state=initialized audit_enabled=0 res=1 nft # [ 0.529524] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint machine # [ 0.676628] thermal_sys: Registered thermal governor 'fair_share' nft # [ 0.531601] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] machine # [ 0.677284] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.678286] thermal_sys: Registered thermal governor 'step_wise' nft # [ 0.532597] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk machine # [ 0.679280] thermal_sys: Registered thermal governor 'user_space' nft # [ 0.533535] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk machine # [ 0.680280] thermal_sys: Registered thermal governor 'power_allocator' nft # [ 0.534532] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk machine # [ 0.681326] cpuidle: using governor menu nft # [ 0.535533] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk machine # [ 0.685155] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 nft # [ 0.536920] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.686692] PCI: Using configuration type 1 for base access nft # [ 0.538587] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] machine # [ 0.687282] PCI: Using configuration type 1 for extended access machine # [ 0.688472] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. nft # [ 0.540894] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint nft # [ 0.542031] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI machine # [ 0.689677] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages nft # [ 0.542546] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB machine # [ 0.691279] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.692281] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages nft # [ 0.543960] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.693282] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.696387] ACPI: Added _OSI(Module Device) machine # [ 0.697280] ACPI: Added _OSI(Processor Device) nft # [ 0.546730] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.698282] ACPI: Added _OSI(Processor Aggregator Device) nft # [ 0.547583] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] nft # [ 0.548590] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.701779] ACPI: 1 ACPI AML tables successfully acquired and loaded nft # [ 0.549794] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.705300] ACPI: Interpreter enabled nft # [ 0.551668] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.706304] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.707281] ACPI: Using IOAPIC for interrupt routing nft # [ 0.554559] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.708315] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.709282] PCI: Using E820 reservations for host bridge windows nft # [ 0.555546] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.710488] ACPI: Enabled 2 GPEs in block 00 to 0F nft # [ 0.556589] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.717124] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.718288] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.719730] acpiphp: Slot [3] registered nft # [ 0.557548] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.720334] acpiphp: Slot [4] registered machine # [ 0.721320] acpiphp: Slot [5] registered machine # [ 0.722321] acpiphp: Slot [6] registered machine # [ 0.723319] acpiphp: Slot [7] registered nft # [ 0.562121] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.724336] acpiphp: Slot [8] registered machine # [ 0.725319] acpiphp: Slot [9] registered machine # [ 0.726320] acpiphp: Slot [10] registered machine # [ 0.727325] acpiphp: Slot [11] registered machine # [ 0.728332] acpiphp: Slot [12] registered nft # [ 0.565556] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] nft # [ 0.566546] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.729324] acpiphp: Slot [13] registered nft # [ 0.567583] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.730322] acpiphp: Slot [14] registered machine # [ 0.731340] acpiphp: Slot [15] registered machine # [ 0.732370] acpiphp: Slot [16] registered machine # [ 0.733315] acpiphp: Slot [17] registered nft # [ 0.570618] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.734338] acpiphp: Slot [18] registered machine # [ 0.735339] acpiphp: Slot [19] registered machine # [ 0.736316] acpiphp: Slot [20] registered nft # [ 0.573547] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.737328] acpiphp: Slot [21] registered nft # [ 0.574547] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.738319] acpiphp: Slot [22] registered machine # [ 0.739330] acpiphp: Slot [23] registered nft # [ 0.575582] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.740315] acpiphp: Slot [24] registered machine # [ 0.741308] acpiphp: Slot [25] registered machine # [ 0.742318] acpiphp: Slot [26] registered machine # [ 0.743330] acpiphp: Slot [27] registered nft # [ 0.578747] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.744322] acpiphp: Slot [28] registered machine # [ 0.745311] acpiphp: Slot [29] registered machine # [ 0.746319] acpiphp: Slot [30] registered nft # [ 0.581487] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.747338] acpiphp: Slot [31] registered machine # [ 0.748335] PCI host bridge to bus 0000:00 nft # [ 0.582548] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.749297] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] nft # [ 0.583586] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.750285] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.751284] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] nft # [ 0.587281] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.752281] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.753283] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] nft # [ 0.590313] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] machine # [ 0.754281] pci_bus 0000:00: root bus resource [bus 00-ff] nft # [ 0.591548] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] nft # [ 0.592584] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.755678] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.757251] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint nft # [ 0.595781] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.759353] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint nft # [ 0.598547] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.761342] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] nft # [ 0.599546] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.762357] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk nft # [ 0.600582] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.763283] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk machine # [ 0.764283] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk nft # [ 0.603860] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.765281] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk machine # [ 0.766624] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint nft # [ 0.606379] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] nft # [ 0.607545] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.768345] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] nft # [ 0.608585] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] nft # [ 0.609545] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.770665] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint machine # [ 0.771893] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI nft # [ 0.612957] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.773297] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB machine # [ 0.774678] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint nft # [ 0.615558] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] nft # [ 0.616590] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] nft # [ 0.619678] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.777368] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.778311] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.779328] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] nft # [ 0.622546] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] nft # [ 0.623547] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] nft # [ 0.624583] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] nft # [ 0.627505] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.630387] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] machine # [ 0.780479] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] nft # [ 0.631544] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] nft # [ 0.632580] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.783541] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.786294] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.787314] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] nft # [ 0.640549] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 nft # [ 0.641731] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.788339] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] nft # [ 0.642759] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.789299] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] nft # [ 0.643713] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 nft # [ 0.644644] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 machine # [ 0.792810] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.646872] iommu: Default domain type: Translated nft # [ 0.647535] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.796297] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] nft # [ 0.650114] ACPI: bus type USB registered machine # [ 0.797306] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] nft # [ 0.651707] usbcore: registered new interface driver usbfs machine # [ 0.798338] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] nft # [ 0.653651] usbcore: registered new interface driver hub nft # [ 0.655584] usbcore: registered new device driver usb nft # [ 0.658863] NetLabel: Initializing machine # [ 0.801470] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint nft # [ 0.659533] NetLabel: domain hash size = 128 nft # [ 0.660530] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.804294] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] nft # [ 0.661652] NetLabel: unlabeled traffic allowed by default machine # [ 0.805296] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] nft # [ 0.662547] PCI: Using ACPI for IRQ routing machine # [ 0.806337] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] nft # [ 0.664138] pci 0000:00:02.0: vgaarb: setting as boot VGA device nft # [ 0.664526] pci 0000:00:02.0: vgaarb: bridge control possible nft # [ 0.664526] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.809596] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint nft # [ 0.664533] vgaarb: loaded nft # [ 0.665725] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.812297] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] nft # [ 0.666535] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.813296] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.814331] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] machine # [ 0.817391] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.820242] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] machine # [ 0.821293] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] nft # [ 0.678721] clocksource: Switched to clocksource kvm-clock machine # [ 0.822327] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] nft # [ 0.680531] VFS: Disk quotas dquot_6.6.0 nft # [ 0.681507] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) nft # [ 0.683441] pnp: PnP ACPI init machine # [ 0.825370] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint nft # [ 0.685323] pnp: PnP ACPI: found 6 devices machine # [ 0.828283] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.829300] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.830338] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] nft # [ 0.694751] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns nft # [ 0.697176] clocksource: Switched to clocksource acpi_pm machine # [ 0.833822] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint nft # [ 0.698907] NET: Registered PF_INET protocol family machine # [ 0.837305] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] nft # [ 0.700811] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) machine # [ 0.838297] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.839347] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] machine # [ 0.840298] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.843898] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.847307] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] nft # [ 0.719268] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) machine # [ 0.848334] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] nft # [ 0.721520] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) nft # [ 0.723591] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.851704] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint nft # [ 0.725729] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) nft # [ 0.727700] TCP: Hash tables configured (established 16384 bind 16384) machine # [ 0.854295] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] nft # [ 0.729620] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) machine # [ 0.855295] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] nft # [ 0.731813] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) machine # [ 0.856342] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] nft # [ 0.733770] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) nft # [ 0.736005] NET: Registered PF_UNIX/PF_LOCAL protocol family nft # [ 0.737698] NET: Registered PF_XDP protocol family machine # [ 0.860001] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint nft # [ 0.739098] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] nft # [ 0.740913] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.863302] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] nft # [ 0.742514] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.864293] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] nft # [ 0.744316] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] machine # [ 0.865327] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] nft # [ 0.746162] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] nft # [ 0.748133] pci 0000:00:01.0: PIIX3: Enabling Passive Release nft # [ 0.749775] pci 0000:00:00.0: Limiting direct PCI/PCI transfers nft # [ 0.753130] ACPI: \_SB_.LNKD: Enabled at IRQ 11 machine # [ 0.873215] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 nft # [ 0.757050] PCI: CLS 0 bytes, default 64 machine # [ 0.874542] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.875521] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 nft # [ 0.758469] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns machine # [ 0.876522] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 nft # [ 0.758509] Trying to unpack rootfs image as initramfs... machine # [ 0.877408] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 machine # [ 0.880304] iommu: Default domain type: Translated machine # [ 0.881281] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.884554] ACPI: bus type USB registered machine # [ 0.886317] usbcore: registered new interface driver usbfs machine # [ 0.887306] usbcore: registered new interface driver hub machine # [ 0.888301] usbcore: registered new device driver usb nft # [ 0.779647] Initialise system trusted keyrings machine # [ 0.891343] NetLabel: Initializing machine # [ 0.892281] NetLabel: domain hash size = 128 nft # [ 0.781116] workingset: timestamp_bits=40 max_order=19 bucket_order=0 machine # [ 0.893279] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.894337] NetLabel: unlabeled traffic allowed by default machine # [ 0.895298] PCI: Using ACPI for IRQ routing machine # [ 0.896876] pci 0000:00:02.0: vgaarb: setting as boot VGA device machine # [ 0.897274] pci 0000:00:02.0: vgaarb: bridge control possible machine # [ 0.897274] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.897289] vgaarb: loaded nft # [ 0.794587] Key type asymmetric registered nft # [ 0.795830] Asymmetric key parser 'x509' registered machine # [ 0.898590] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 nft # [ 0.797356] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.899279] hpet0: 3 comparators, 64-bit 100.000000 MHz counter nft # [ 0.799477] io scheduler mq-deadline registered nft # [ 0.800719] io scheduler kyber registered nft # [ 0.803845] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.906177] clocksource: Switched to clocksource kvm-clock nft # [ 0.806095] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A nft # [ 0.809452] Linux agpgart interface v0.103 machine # [ 0.909574] VFS: Disk quotas dquot_6.6.0 nft # [ 0.810888] ACPI: bus type drm_connector registered machine # [ 0.910802] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.913124] pnp: PnP ACPI init nft # [ 0.813920] usbcore: registered new interface driver usbserial_generic machine # [ 0.915140] pnp: PnP ACPI: found 6 devices nft # [ 0.815784] usbserial: USB Serial support registered for generic nft # [ 0.817502] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. nft # [ 0.817502] Please enable it if your BIOS has the CPPC option. nft # [ 0.821240] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled nft # [ 0.823574] drop_monitor: Initializing network drop monitor service nft # [ 0.825489] NET: Registered PF_INET6 protocol family machine # [ 0.924592] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.927107] clocksource: Switched to clocksource acpi_pm nft # [ 0.828606] Segment Routing with IPv6 machine # [ 0.928735] NET: Registered PF_INET protocol family nft # [ 0.829888] In-situ OAM (IOAM) with IPv6 nft # [ 0.832753] IPI shorthand broadcast: enabled machine # [ 0.931752] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) nft # [ 0.837975] sched_clock: Marking stable (605028461, 232379415)->(1001270145, -163862269) nft # [ 0.840476] registered taskstats version 1 nft # [ 0.841947] Loading compiled-in X.509 certificates machine # [ 0.951461] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) nft # [ 0.853455] Demotion targets for Node 0: null machine # [ 0.953683] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) nft # [ 0.855495] Key type .fscrypt registered nft # [ 0.856587] Key type fscrypt-provisioning registered machine # [ 0.956047] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) nft # [ 0.858213] ima: No TPM chip found, activating TPM-bypass! nft # [ 0.859708] ima: Allocated hash algorithm: sha1 nft # [ 0.860941] ima: No architecture policies found machine # [ 0.960556] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) nft # [ 0.863437] PM: Magic number: 6:310:830 machine # [ 0.962559] TCP: Hash tables configured (established 65536 bind 65536) machine # [ 0.964370] MPTCP token hash table entries: 8192 (order: 6, 196608 bytes, linear) nft # [ 0.865674] RAS: Correctable Errors collector initialized. machine # [ 0.966683] UDP hash table entries: 4096 (order: 6, 262144 bytes, linear) machine # [ 0.968826] UDP-Lite hash table entries: 4096 (order: 6, 262144 bytes, linear) machine # [ 0.970961] NET: Registered PF_UNIX/PF_LOCAL protocol family nft # [ 0.871652] clk: Disabling unused clocks machine # [ 0.972666] NET: Registered PF_XDP protocol family nft # [ 0.873367] PM: genpd: Disabling unused power domains machine # [ 0.974075] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.975713] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.977418] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.979228] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] machine # [ 0.981049] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] machine # [ 0.983136] pci 0000:00:01.0: PIIX3: Enabling Passive Release machine # [ 0.984712] pci 0000:00:00.0: Limiting direct PCI/PCI transfers machine # [ 0.988135] ACPI: \_SB_.LNKD: Enabled at IRQ 11 machine # [ 0.991507] PCI: CLS 0 bytes, default 64 machine # [ 0.992746] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) machine # [ 0.993086] Trying to unpack rootfs image as initramfs... machine # [ 0.995967] software IO TLB: mapped [mem 0x00000000ba34f000-0x00000000be34f000] (64MB) machine # [ 0.998291] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2409b60, max_idle_ns: 440795393887 ns machine # [ 1.023740] Initialise system trusted keyrings machine # [ 1.025372] workingset: timestamp_bits=40 max_order=21 bucket_order=0 machine # [ 1.038529] Key type asymmetric registered machine # [ 1.039750] Asymmetric key parser 'x509' registered machine # [ 1.041230] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 1.043634] io scheduler mq-deadline registered machine # [ 1.044936] io scheduler kyber registered machine # [ 1.051147] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 1.053497] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 1.057600] Linux agpgart interface v0.103 machine # [ 1.058944] ACPI: bus type drm_connector registered machine # [ 1.062946] usbcore: registered new interface driver usbserial_generic machine # [ 1.064774] usbserial: USB Serial support registered for generic machine # [ 1.066430] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 1.066430] Please enable it if your BIOS has the CPPC option. machine # [ 1.070057] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 1.072249] drop_monitor: Initializing network drop monitor service machine # [ 1.074160] NET: Registered PF_INET6 protocol family machine # [ 1.076743] Segment Routing with IPv6 machine # [ 1.077934] In-situ OAM (IOAM) with IPv6 machine # [ 1.080649] IPI shorthand broadcast: enabled machine # [ 1.086219] sched_clock: Marking stable (854022097, 231996703)->(1263013705, -176994905) machine # [ 1.090953] registered taskstats version 1 machine # [ 1.092674] Loading compiled-in X.509 certificates machine # [ 1.104357] Demotion targets for Node 0: null machine # [ 1.106100] Key type .fscrypt registered machine # [ 1.107329] Key type fscrypt-provisioning registered machine # [ 1.109118] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.110741] ima: Allocated hash algorithm: sha1 machine # [ 1.112289] ima: No architecture policies found machine # [ 1.114118] PM: Magic number: 6:310:830 machine # [ 1.116819] RAS: Correctable Errors collector initialized. machine # [ 1.123859] clk: Disabling unused clocks machine # [ 1.125171] PM: genpd: Disabling unused power domains nft # [ 1.050003] Freeing initrd memory: 29184K nft # [ 1.054911] Freeing unused decrypted memory: 2028K nft # [ 1.058495] Freeing unused kernel image (initmem) memory: 3640K nft # [ 1.060228] Write protecting the kernel read-only data: 32768k nft # [ 1.063043] Freeing unused kernel image (text/rodata gap) memory: 1220K nft # [ 1.065175] Freeing unused kernel image (rodata/data gap) memory: 760K nft # [ 1.110260] x86/mm: Checked W+X mappings: passed, no W+X pages found. nft # [ 1.112070] Run /init as init process nft # [ 1.126867] systemd[1]: Inserted module 'autofs4' nft # [ 1.154924] fuse: init (API version 7.45) nft # [ 1.164327] ACPI: \_SB_.LNKC: Enabled at IRQ 10 nft # [ 1.172914] ACPI: \_SB_.LNKA: Enabled at IRQ 10 nft # [ 1.177614] ACPI: \_SB_.LNKB: Enabled at IRQ 11 machine # [ 1.308465] Freeing initrd memory: 29188K machine # [ 1.312799] Freeing unused decrypted memory: 2028K machine # [ 1.316645] Freeing unused kernel image (initmem) memory: 3640K machine # [ 1.318391] Write protecting the kernel read-only data: 32768k nft # [ 1.219110] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.321511] Freeing unused kernel image (text/rodata gap) memory: 1220K machine # [ 1.324178] Freeing unused kernel image (rodata/data gap) memory: 760K machine # [ 1.371601] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 1.373373] Run /init as init process machine # [ 1.387393] systemd[1]: Inserted module 'autofs4' machine # [ 1.415694] fuse: init (API version 7.45) machine # [ 1.427650] ACPI: \_SB_.LNKC: Enabled at IRQ 10 machine # [ 1.435962] ACPI: \_SB_.LNKA: Enabled at IRQ 10 machine # [ 1.439911] ACPI: \_SB_.LNKB: Enabled at IRQ 11 machine # [ 1.481480] systemd[1]: Successfully made /usr/ read-only. nft # [ 1.556290] 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.564646] systemd[1]: Detected virtualization kvm. nft # [ 1.566169] systemd[1]: Detected architecture x86-64. nft # [ 1.567730] systemd[1]: Running in initrd. nft # [ 1.569508] systemd[1]: Initializing machine ID from random generator. nft # [ 1.571603] systemd[1]: Hostname set to . nft # [ 1.698451] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 1.734518] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.830898] 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.838768] systemd[1]: Detected virtualization kvm. machine # [ 1.840152] systemd[1]: Detected architecture x86-64. machine # [ 1.841529] systemd[1]: Running in initrd. machine # [ 1.842985] systemd[1]: Initializing machine ID from random generator. nft # [ 1.743679] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.844809] systemd[1]: Hostname set to . nft # [ 1.745623] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. nft # [ 1.748015] systemd[1]: Expecting device /dev/disk/by-label/nixos... nft # [ 1.749984] systemd[1]: Reached target Path Units. nft # [ 1.751521] systemd[1]: Reached target Slice Units. nft # [ 1.753064] systemd[1]: Reached target Swaps. nft # [ 1.754499] systemd[1]: Reached target Timer Units. nft # [ 1.768791] systemd[1]: Listening on D-Bus System Message Bus Socket. nft # [ 1.770954] systemd[1]: Listening on Journal Socket (/dev/log). nft # [ 1.772988] systemd[1]: Listening on Journal Sockets. nft # [ 1.774809] systemd[1]: Listening on udev Control Socket. nft # [ 1.776597] systemd[1]: Listening on udev Kernel Socket. nft # [ 1.778262] systemd[1]: Reached target Socket Units. nft # [ 1.781502] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 1.785294] systemd[1]: Starting Load Kernel Module 9pnet_virtio... nft # [ 1.796518] systemd[1]: Starting Load Kernel Module configfs... nft # [ 1.807537] systemd[1]: Starting Journal Service... nft # [ 1.830558] systemd[1]: Starting Load Kernel Modules... nft # [ 1.834560] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 1.835897] netfs: FS-Cache loaded nft # [ 1.847092] systemd[1]: Starting Coldplug All udev Devices... nft # [ 1.856018] 9pnet: Installing 9P2000 support nft # [ 1.858322] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 1.862133] systemd-journald[75]: Collecting audit messages is disabled. nft # [ 1.865064] systemd[1]: modprobe@configfs.service: Deactivated successfully. nft # [ 1.872257] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.974143] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 1.880132] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. nft # [ 1.885146] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. nft # [ 1.885272] systemd[1]: Finished Load Kernel Module 9pnet_virtio. nft # [ 1.888621] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev nft # [ 1.896074] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config nft # [ 1.905532] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 2.011206] systemd[1]: Queued start job for default target Initrd Default Target. nft # [ 1.916551] systemd[1]: Finished Load Kernel Modules. nft # [ 1.923698] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.025413] systemd[1]: Created slice Slice /system/modprobe. machine # [ 2.027346] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 2.029569] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 2.031382] systemd[1]: Reached target Path Units. machine # [ 2.032808] systemd[1]: Reached target Slice Units. machine # [ 2.034300] systemd[1]: Reached target Swaps. machine # [ 2.035656] systemd[1]: Reached target Timer Units. machine # [ 2.037381] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 2.039371] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 2.041295] systemd[1]: Listening on Journal Sockets. machine # [ 2.042790] systemd[1]: Listening on udev Control Socket. nft # [ 1.942563] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 2.044408] systemd[1]: Listening on udev Kernel Socket. machine # [ 2.045921] systemd[1]: Reached target Socket Units. machine # [ 2.048879] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 1.952218] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 2.052347] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 2.058390] systemd[1]: Starting Load Kernel Module configfs... machine # [ 2.062716] systemd[1]: Starting Journal Service... nft # [ 1.964679] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.066076] systemd[1]: Starting Load Kernel Modules... nft # [ 1.730837] systemd-modules-load[77]: Using 2 probe threads nft # [ 1.969362] systemd[1]: Started Journal Service. nft # [ 1.738430] systemd-modules-load[77]: Inserted module 'virtio_balloon' machine # [ 2.069216] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 1.740356] systemd-modules-load[77]: Inserted module 'dm_mod' nft # [ 1.742407] systemd-modules-load[77]: Inserted module 'virtio_gpu' machine # [ 2.076215] systemd[1]: Starting Coldplug All udev Devices... nft # [ 1.756198] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 2.088193] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 1.759449] systemd[1]: Reached target Preparation for Local File Systems. nft # [ 1.761517] systemd[1]: Reached target Local File Systems. nft # [ 1.765104] systemd[1]: Starting Create System Files and Directories... machine # [ 2.093974] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 2.095538] netfs: FS-Cache loaded nft # [ 1.769325] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 2.100357] systemd-journald[92]: Collecting audit messages is disabled. machine # [ 2.106160] 9pnet: Installing 9P2000 support machine # [ 2.107085] systemd[1]: Finished Load Kernel Module configfs. machine # [ 2.109778] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 2.114942] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 2.123745] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. nft # [ 1.794168] systemd[1]: Finished Create System Files and Directories. machine # [ 2.127974] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 2.128521] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 2.133325] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 2.136391] systemd[1]: Finished Load Kernel Modules. machine # [ 2.139727] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.142499] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. nft # [ 1.812401] systemd-udevd[92]: Using default interface naming scheme 'v261'. nft # [ 1.828905] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.162181] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.932824] systemd-modules-load[93]: Using 4 probe threads machine # [ 1.934680] systemd-modules-load[93]: Inserted module 'virtio_balloon' machine # [ 2.168240] systemd[1]: Started Journal Service. nft # [ 1.835932] systemd[1]: Started Rule-based Manager for Device Events and Files. nft # [ 1.837732] systemd[1]: Reached target System Initialization. machine # [ 1.938557] systemd-modules-load[93]: Inserted module 'virtio_gpu' nft # [ 1.839157] systemd[1]: Reached target Basic System. machine # [ 1.940387] systemd-modules-load[93]: Inserted module 'dm_mod' machine # [ 1.942112] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.943786] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.945722] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.947620] systemd[1]: Reached target Local File Systems. machine # [ 1.949263] systemd[1]: Starting Create System Files and Directories... machine # [ 1.950890] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.961797] systemd[1]: Finished Create System Files and Directories. machine # [ 1.970807] systemd-udevd[110]: Using default interface naming scheme 'v261'. machine # [ 1.984913] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.998789] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.000175] systemd[1]: Reached target System Initialization. machine # [ 2.001564] systemd[1]: Reached target Basic System. machine # [ 2.375819] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.378782] serio: i8042 KBD port at 0x60,0x64 irq 1 nft # [ 2.278849] uhci_hcd 0000:00:01.2: UHCI Host Controller machine # [ 2.379755] serio: i8042 AUX port at 0x60,0x64 irq 12 nft # [ 2.279993] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 machine # [ 2.383821] SCSI subsystem initialized nft # [ 2.293540] uhci_hcd 0000:00:01.2: detected 2 ports nft # [ 2.297154] SCSI subsystem initialized nft # [ 2.298093] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 nft # [ 2.301777] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 nft # [ 2.304649] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 nft # [ 2.306441] usb usb1: Product: UHCI Host Controller nft # [ 2.307897] usb usb1: Manufacturer: Linux 6.18.42 uhci_hcd nft # [ 2.309145] usb usb1: SerialNumber: 0000:00:01.2 machine # [ 2.414500] virtio_blk virtio5: 4/0/0 default/read/poll queues nft # [ 2.320140] hub 1-0:1.0: USB hub found machine # [ 2.420301] uhci_hcd 0000:00:01.2: UHCI Host Controller nft # [ 2.322913] hub 1-0:1.0: 2 ports detected machine # [ 2.424259] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 nft # [ 2.325128] virtio_blk virtio5: 2/0/0 default/read/poll queues machine # [ 2.425736] uhci_hcd 0000:00:01.2: detected 2 ports machine # [ 2.426934] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 machine # [ 2.428644] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.430422] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.431887] usb usb1: Product: UHCI Host Controller machine # [ 2.432923] usb usb1: Manufacturer: Linux 6.18.42 uhci_hcd machine # [ 2.434105] usb usb1: SerialNumber: 0000:00:01.2 nft # [ 2.334894] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.435987] hub 1-0:1.0: USB hub found machine # [ 2.436966] hub 1-0:1.0: 2 ports detected nft # [ 2.339084] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.442451] virtio_blk virtio5: [vda] 50331648 512-byte logical blocks (25.8 GB/24.0 GiB) machine # [ 2.455105] scsi host0: ata_piix nft # [ 2.355641] serio: i8042 KBD port at 0x60,0x64 irq 1 nft # [ 2.356833] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.459097] scsi host1: ata_piix machine # [ 2.464789] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 machine # [ 2.466533] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 nft # [ 2.141359] systemd[1]: Starting Virtual Console Setup... machine # [ 2.248493] systemd[1]: Starting Virtual Console Setup... nft # [ 2.153635] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.254049] (udev-worker)[137]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.257359] (udev-worker)[141]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.260790] (udev-worker)[141]: Network interface NamePolicy= disabled on kernel command line. nft # [ 2.163149] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. nft # [ 2.168085] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. nft # [ 2.404718] scsi host0: ata_piix machine # [ 2.275742] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.278428] systemd[1]: Finished Virtual Console Setup. nft # [ 2.178286] systemd-vconsole-setup[114]: Configuration of first virtual console was skipped, ignoring remaining ones. nft # [ 2.182245] systemd[1]: Finished Virtual Console Setup. machine # [ 2.284690] systemd[1]: Found device /dev/disk/by-label/nixos. nft # [ 2.417345] scsi host1: ata_piix machine # [ 2.286360] systemd[1]: Reached target Initrd Root Device. machine # [ 2.288193] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... nft # [ 2.423988] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 nft # [ 2.427179] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 nft # [ 2.430903] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 nft # [ 2.200556] systemd[1]: Found device /dev/disk/by-label/nixos. nft # [ 2.201965] systemd[1]: Reached target Initrd Root Device. nft # [ 2.205532] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.323630] systemd-fsck[158]: nixos: clean, 12/1572864 files, 142772/6291456 blocks nft # [ 2.230783] systemd-fsck[128]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.337977] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. nft # [ 2.239529] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.628504] ata2: found unknown device (class 0) machine # [ 2.630534] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.633527] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 nft # [ 2.551688] usb 1-1: new full-speed USB device number 2 using uhci_hcd machine # [ 2.653410] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.671128] usb 1-1: new full-speed USB device number 2 using uhci_hcd machine # [ 2.685921] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray nft # [ 2.589718] ata2: found unknown device (class 0) nft # [ 2.591936] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 nft # [ 2.594935] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.715500] cdrom: Uniform CD-ROM driver Revision: 3.20 nft # [ 2.638322] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray nft # [ 2.663906] cdrom: Uniform CD-ROM driver Revision: 3.20 nft # [ 2.721828] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 nft # [ 2.723646] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 nft # [ 2.725278] usb 1-1: Product: QEMU USB Tablet nft # [ 2.726325] usb 1-1: Manufacturer: QEMU nft # [ 2.727284] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 machine # [ 2.838821] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.840768] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.842510] usb 1-1: Product: QEMU USB Tablet machine # [ 2.843628] usb 1-1: Manufacturer: QEMU machine # [ 2.844968] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 nft # [ 2.746771] hid: raw HID events driver (C) Jiri Kosina nft # [ 2.756750] usbcore: registered new interface driver usbhid nft # [ 2.759885] usbhid: USB HID core driver machine # [ 2.864960] hid: raw HID events driver (C) Jiri Kosina nft # [ 2.767305] 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.769861] 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 machine # [ 2.874814] usbcore: registered new interface driver usbhid machine # [ 2.876396] usbhid: USB HID core driver machine # [ 2.882442] 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.884850] 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.623386] systemd[1]: Mounting /sysroot... machine # [ 2.849539] systemd[1]: Mounting /sysroot... nft # [ 2.990846] EXT4-fs (vda): mounted filesystem ab290139-ccf4-4bcf-9e3b-5fb28ef1f06c r/w with ordered data mode. Quota mode: none. nft # [ 2.763279] systemd[1]: Mounted /sysroot. nft # [ 2.764475] systemd[1]: Reached target Initrd Root File System. nft # [ 2.766228] systemd[1]: Mounting /sysroot/nix/.ro-store... nft # [ 2.769109] systemd[1]: Mounting /sysroot/nix/.rw-store... nft # [ 2.780786] systemd[1]: Mounting /sysroot/run... nft # [ 2.785190] systemd[1]: Mounting /sysroot/tmp/shared... nft # [ 2.788618] systemd[1]: Mounting /sysroot/tmp/xchg... nft # [ 2.801101] systemd[1]: Starting Mountpoints Configured in the Real Root... nft # [ 2.802769] systemd[1]: Mounted /sysroot/nix/.rw-store. nft # [ 3.042172] 9p: Installing v9fs 9p2000 file system support nft # [ 2.810964] systemd-sysroot-fstab-check[148]: /sysroot should be mounted in the initrd, will request daemon-reload. nft # [ 2.822934] systemd[1]: Mounted /sysroot/nix/.ro-store. nft # [ 2.825654] systemd[1]: Reload requested from client PID 148 ('systemd-sysroot') (unit initrd-parse-etc.service)... nft # [ 2.829222] systemd[1]: Reloading... machine # [ 3.203751] EXT4-fs (vda): mounted filesystem 2fb05b1c-a187-46d8-a39d-9780723e2a0f r/w with ordered data mode. Quota mode: none. machine # [ 2.976667] systemd[1]: Mounted /sysroot. machine # [ 2.977904] systemd[1]: Reached target Initrd Root File System. machine # [ 2.980067] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.981504] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.983667] systemd[1]: Mounting /sysroot/run... machine # [ 2.992151] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.995114] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.996809] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.001874] systemd[1]: Mounted /sysroot/nix/[ 3.234087] 9p: Installing v9fs 9p2000 file system support machine # .rw-store. machine # [ 3.004357] systemd[1]: Mounted /sysroot/run. machine # [ 3.007237] systemd[1]: Mounted /sysroot/nix/.ro-store. nft # [ 2.911214] systemd[1]: Reloading finished in 82 ms. machine # [ 3.011247] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.014655] systemd-sysroot-fstab-check[180]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.018422] systemd[1]: Reload requested from client PID 180 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.021142] systemd[1]: Reloading... nft # [ 2.929196] systemd-sysroot-fstab-check[148]: Requesting initrd-fs.target/start/replace... nft # [ 2.932550] systemd[1]: Mounted /sysroot/run. nft # [ 2.933841] systemd[1]: Mounted /sysroot/tmp/shared. nft # [ 2.935265] systemd[1]: Mounted /sysroot/tmp/xchg. nft # [ 2.940148] systemd-sysroot-fstab-check[148]: Requesting swap.target/start/replace... nft # [ 2.945685] systemd[1]: Starting rw-sysroot-nix-store.service... nft # [ 2.947406] systemd[1]: initrd-parse-etc.service: Deactivated successfully. nft # [ 2.949309] systemd[1]: Finished Mountpoints Configured in the Real Root. nft # [ 2.951133] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. nft # [ 2.957371] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. nft # [ 2.959377] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.084222] systemd[1]: Reloading finished in 67 ms. machine # [ 3.106663] systemd-sysroot-fstab-check[180]: Requesting initrd-fs.target/start/replace... machine # [ 3.108879] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.109992] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.111148] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.112717] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.114092] systemd-sysroot-fstab-check[180]: Requesting swap.target/start/replace... machine # [ 3.116609] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.117936] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.119420] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.120892] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.134278] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.135849] systemd[1]: Finished rw-sysroot-nix-store.service. nft # [ 3.623746] systemd[1]: Mounting /sysroot/nix/store... nft # [ 3.651686] systemd[1]: Mounted /sysroot/nix/store. nft # [ 3.652921] systemd[1]: Reached target Initrd File Systems. nft # [ 3.654264] systemd[1]: Starting Find NixOS closure... nft # [ 3.655546] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... nft # [ 3.679495] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. nft # [ 3.682451] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. nft # [ 3.688349] systemd[1]: Finished Find NixOS closure. nft # [ 3.689917] systemd[1]: Reached target Initrd Default Target. nft # [ 3.691487] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... nft # [ 3.705637] systemd[1]: Stopped target Initrd Default Target. nft # [ 3.707098] systemd[1]: Stopped target Basic System. nft # [ 3.708290] systemd[1]: Stopped target Initrd Root Device. nft # [ 3.709554] systemd[1]: Stopped target Path Units. nft # [ 3.710712] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. nft # [ 3.712815] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. nft # [ 3.714586] systemd[1]: Stopped target Slice Units. nft # [ 3.715775] systemd[1]: Stopped target Socket Units. nft # [ 3.716922] systemd[1]: Stopped target System Initialization. nft # [ 3.718230] systemd[1]: Stopped target Swaps. nft # [ 3.719290] systemd[1]: Stopped target Timer Units. nft # [ 3.720462] systemd[1]: dbus.socket: Deactivated successfully. nft # [ 3.721890] systemd[1]: Closed D-Bus System Message Bus Socket. nft # [ 3.723282] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. nft # [ 3.725208] systemd[1]: Stopped Find NixOS closure. nft # [ 3.726495] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio nft # [ 3.732096] systemd[1]: Starting rw-sysroot-nix-store.service... nft # [ 3.733380] systemd[1]: systemd-sysctl.service: Deactivated successfully. nft # [ 3.735281] systemd[1]: Stopped Apply Kernel Variables. nft # [ 3.737231] systemd[1]: systemd-modules-load.service: Deactivated successfully. nft # [ 3.739130] systemd[1]: Stopped Load Kernel Modules. nft # [ 3.740256] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. nft # [ 3.742115] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. nft # [ 3.747074] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.849649] systemd[1]: Mounting /sysroot/nix/store... nft # [ 3.751399] systemd[1]: Stopped Create System Files and Directories. nft # [ 3.754960] systemd[1]: Stopped target Local File Systems. nft # [ 3.758718] systemd[1]: Stopped target Preparation for Local File Systems. nft # [ 3.760295] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. nft # [ 3.762297] systemd[1]: Stopped Coldplug All udev Devices. nft # [ 3.765522] systemd[1]: Stopping Rule-based Manager for Device Events and Files... nft # [ 3.767434] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. nft # [ 3.769248] systemd[1]: Stopped Virtual Console Setup. nft # [ 3.771292] systemd[1]: initrd-cleanup.service: Deactivated successfully. nft # [ 3.773159] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. nft # [ 3.774760] systemd[1]: systemd-udevd.service: Deactivated successfully. nft # [ 3.776401] systemd[1]: Stopped Rule-based Manager for Device Events and Files. nft # [ 3.778202] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. nft # [ 3.779916] systemd[1]: Finished rw-sysroot-nix-store.service. nft # [ 3.781431] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. nft # [ 3.783200] systemd[1]: Closed udev Control Socket. nft # [ 3.785155] systemd[1]: Starting Cleanup udev Database... nft # [ 3.787451] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. nft # [ 3.790174] systemd[1]: Stopped Create Static Device Nodes in /dev. nft # [ 3.791729] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.892301] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.893607] systemd[1]: Reached target Initrd File Systems. nft # [ 3.793944] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.894854] systemd[1]: Starting Find NixOS closure... nft # [ 3.795806] systemd[1]: kmod-static-nodes.service: Deactivated successfully. nft # [ 3.797531] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.896276] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... nft # [ 3.804871] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. nft # [ 3.806643] systemd[1]: Finished Cleanup udev Database. nft # [ 3.807943] systemd[1]: Reached target Switch Root. nft # [ 3.809203] systemd[1]: Starting NixOS Activation... machine # [ 3.916668] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.918456] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.929967] systemd[1]: Finished Find NixOS closure. machine # [ 3.931274] systemd[1]: Reached target Initrd Default Target. machine # [ 3.932816] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.957693] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.959162] systemd[1]: Stopped target Basic System. machine # [ 3.960400] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.961715] systemd[1]: Stopped target Path Units. machine # [ 3.962906] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.964618] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.966988] systemd[1]: Stopped target Slice Units. machine # [ 3.969824] systemd[1]: Stopped target Socket Units. machine # [ 3.971622] systemd[1]: Stopped target System Initialization. machine # [ 3.972979] systemd[1]: Stopped target Swaps. machine # [ 3.974189] systemd[1]: Stopped target Timer Units. machine # [ 3.975409] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.977183] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.978494] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.980141] systemd[1]: Stopped Find NixOS closure. machine # [ 3.981218] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.983270] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.984486] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.985850] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.986893] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.988375] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.989409] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.990950] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.992424] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.993919] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.995231] systemd[1]: Stopped target Local File Systems. machine # [ 3.996353] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.997747] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.999249] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.000444] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.002042] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.003655] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.004881] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.006491] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.007919] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.009465] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.010724] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.012258] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.013781] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 4.015371] systemd[1]: Closed udev Control Socket. machine # [ 4.017167] systemd[1]: Starting Cleanup udev Database... machine # [ 4.018401] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.020202] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.021869] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.023626] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.025213] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.026746] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.034187] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.035717] systemd[1]: Finished Cleanup udev Database. machine # [ 4.036871] systemd[1]: Reached target Switch Root. machine # [ 4.038344] systemd[1]: Starting NixOS Activation... nft # [ 4.327994] hrtimer: interrupt took 3601017 ns nft # [ 4.134694] initrd-nixos-activation-start[196]: booting system configuration /nix/store/kv7ji9frx41fyl605r0nh66g7i5yhbp6-nixos-system-nft-test machine # [ 4.530619] initrd-nixos-activation-start[228]: booting system configuration /nix/store/k4vfb6g0z0k62k0nwn4jx0gmcvxrvm5a-nixos-system-machine-test nft # [ 4.608265] initrd-nixos-activation-start[196]: running activation script... machine # [ 4.776078] initrd-nixos-activation-start[228]: running activation script... nft # [ 5.333324] initrd-nixos-activation-start[219]: setting up /etc... machine # [ 5.467980] initrd-nixos-activation-start[251]: setting up /etc... nft # [ 5.599614] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. nft # [ 5.601512] systemd[1]: Finished NixOS Activation. nft # [ 5.602625] systemd[1]: Starting Switch Root... nft # [ 5.621242] systemd[1]: Switching root. machine # [ 5.761072] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.762854] systemd[1]: Finished NixOS Activation. machine # [ 5.764182] systemd[1]: Starting Switch Root... nft # [ 5.901580] systemd-journald[75]: Received SIGTERM from PID 1 (systemd). machine # [ 5.792497] systemd[1]: Switching root. machine # [ 6.085159] systemd-journald[92]: Received SIGTERM from PID 1 (systemd). nft # [ 6.123827] NET: Registered PF_VSOCK protocol family machine # [ 6.248456] NET: Registered PF_VSOCK protocol family nft # [ 6.517200] 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 # [ 6.522943] systemd[1]: Detected virtualization kvm. nft # [ 6.524013] systemd[1]: Detected architecture x86-64. nft # [ 6.525117] systemd[1]: Detected first boot. nft # [ 6.528247] systemd[1]: Initializing machine ID from random generator. machine # [ 6.655424] 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 # [ 6.661563] systemd[1]: Detected virtualization kvm. machine # [ 6.662700] systemd[1]: Detected architecture x86-64. machine # [ 6.663960] systemd[1]: Detected first boot. machine # [ 6.669190] systemd[1]: Initializing machine ID from random generator. nft # [ 6.714236] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.834008] systemd[1]: bpf-restrict-fs: LSM BPF program attached nft # [ 6.828703] systemd[1]: Applying preset policy. machine # [ 6.937988] systemd[1]: Applying preset policy. nft # [ 8.031802] systemd[1]: Populated /etc with preset unit settings. machine # [ 8.272393] systemd[1]: Populated /etc with preset unit settings. machine # [ 8.935060] hrtimer: interrupt took 3821156 ns nft # [ 9.424083] systemd[1]: microvm@hermes-alice.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. nft # [ 9.722630] systemd[1]: initrd-switch-root.service: Deactivated successfully. nft # [ 9.724758] systemd[1]: Stopped initrd-switch-root.service. nft # [ 9.727824] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. nft # [ 9.730694] systemd[1]: Created slice Slice /system/getty. nft # [ 9.732535] systemd[1]: Created slice User and Session Slice. nft # [ 9.733794] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. nft # [ 9.735616] systemd[1]: Started Forward Password Requests to Wall Directory Watch. nft # [ 9.737123] systemd[1]: Expecting device /dev/hvc0... nft # [ 9.738547] systemd[1]: Expecting device /dev/ttyS0... nft # [ 9.739722] systemd[1]: Reached target Local Encrypted Volumes. nft # [ 9.741119] systemd[1]: Stopped target initrd-fs.target. nft # [ 9.742232] systemd[1]: Stopped target initrd-root-fs.target. nft # [ 9.743782] systemd[1]: Stopped target initrd-switch-root.target. nft # [ 9.745203] systemd[1]: Reached target Virtual Machines and Containers. nft # [ 9.746746] systemd[1]: Reached target Remote File Systems. nft # [ 9.748045] systemd[1]: Reached target Slice Units. nft # [ 9.749259] systemd[1]: Reached target Swaps. nft # [ 9.758806] systemd[1]: Listening on Query the User Interactively for a Password. nft # [ 9.767495] systemd[1]: Listening on Process Core Dump Socket. nft # [ 9.771698] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 9.875917] systemd[1]: microvm@hermes-bob.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. nft # [ 9.778682] systemd[1]: Listening on Factory Reset Management. nft # [ 9.780176] systemd[1]: Listening on Hostname Service Socket. nft # [ 9.785856] systemd[1]: Starting Journal Log Access Socket... machine # [ 9.885514] systemd[1]: microvm@hermes-alice.service: Service uses a combination of Type=simple, ExecStartPost=, and credentials. This could lead to race conditions. Continuing. nft # [ 9.788380] systemd[1]: Listening on Journal Audit Socket. nft # [ 9.792479] systemd[1]: Listening on Console Output Muting Service Socket. nft # [ 9.794241] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. nft # [ 9.796397] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os nft # [ 9.798420] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki nft # [ 9.811060] systemd[1]: Listening on Disk Repartitioning Service Socket. nft # [ 9.812813] systemd[1]: Listening on udev Control Socket. nft # [ 9.814694] systemd[1]: Listening on udev Varlink Socket. nft # [ 9.823052] systemd[1]: Mounting Huge Pages File System... nft # [ 9.827199] systemd[1]: Mounting POSIX Message Queue File System... nft # [ 9.833117] systemd[1]: Mounting Kernel Debug File System... nft # [ 9.837545] systemd[1]: Mounting Kernel Trace File System... nft # [ 9.846370] systemd[1]: Starting Create List of Static Device Nodes... nft # [ 9.848849] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio nft # [ 9.855472] systemd[1]: Starting Load Kernel Module configfs... nft # [ 9.856686] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm nft # [ 9.862487] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore nft # [ 9.865782] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse nft # [ 9.871515] systemd[1]: Mounting FUSE Control File System... nft # [ 9.872702] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 nft # [ 9.879929] systemd[1]: Starting Journal Service... nft # [ 9.889123] systemd[1]: Starting Load Kernel Modules... nft # [ 9.909608] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... nft # [ 9.919892] systemd[1]: Starting Remount Root and Kernel File Systems... nft # [ 9.924148] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 9.931017] systemd[1]: Starting Coldplug All udev Devices... nft # [ 9.934164] systemd[1]: Listening on Journal Log Access Socket. nft # [ 9.974057] systemd[1]: Finished Create List of Static Device Nodes. nft # [ 9.979191] systemd-journald[289]: Collecting audit messages is enabled. nft # [ 9.981903] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... nft # [ 9.989892] systemd[1]: modprobe@configfs.service: Deactivated successfully. nft # [ 9.998552] EXT4-fs (vda): re-mounted ab290139-ccf4-4bcf-9e3b-5fb28ef1f06c. nft # [ 9.780468] systemd[1]: Queued start job for default target Multi-User System. nft # [ 9.782475] systemd[1]: systemd-journald.service: Deactivated successfully. nft # [ 9.785724] systemd-modules-load[290]: Using 2 probe threads nft # [ 10.019816] systemd[1]: Finished Load Kernel Module configfs. nft # [ 10.026422] systemd[1]: Started Journal Service. nft # [ 9.803498] systemd[1]: Mounted Kernel Trace File System. nft # [ 9.806817] systemd[1]: Finished Remount Root and Kernel File Systems. nft # [ 9.810386] systemd[1]: Mounted Kernel Debug File System. nft # [ 10.044880] loop: module loaded nft # [ 9.813404] systemd[1]: Mounted Huge Pages File System. nft # [ 9.816726] systemd-modules-load[290]: Inserted module 'tap' nft # [ 9.820523] systemd[1]: Mounted POSIX Message Queue File System. nft # [ 9.822235] systemd[1]: Mounted FUSE Control File System. nft # [ 9.826232] systemd[1]: Listening on Disk Image Download Service Socket. nft # [ 9.827681] systemd[1]: Mounting Kernel Configuration File System... nft # [ 9.830349] systemd[1]: Starting Flush Journal to Persistent Storage... nft # [ 9.837385] systemd-modules-load[290]: Inserted module 'loop' nft # [ 9.840481] systemd-oomd[292]: No swap; memory pressure usage will be degraded nft # [ 9.847652] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore nft # [ 9.850529] s[ 10.082787] tun: Universal TUN/TAP device driver, 1.6 nft # ystemd[1]: Starting Load/Save OS Random Seed... nft # [ 9.860346] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 9.862479] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. nft # [ 9.863915] systemd-modules-load[290]: Inserted module 'vhost_vsock' nft # [ 9.865885] systemd-modules-load[290]: Inserted module 'vhost_net' nft # [ 9.875122] systemd[1]: Finished Load Kernel Modules. nft # [ 9.878193] systemd[1]: Starting Apply Kernel Variables... nft # [ 10.119355] systemd-journald[289]: Received client request to flush runtime journal. nft # [ 10.215218] systemd[1]: Mounted Kernel Configuration File System. nft # [ 10.219079] systemd[1]: Finished Coldplug All udev Devices. nft # [ 10.221997] systemd[1]: Finished Load/Save OS Random Seed. nft # [ 10.223261] systemd[1]: Reached target First Boot Complete. nft # [ 10.227125] systemd[1]: Finished Flush Journal to Persistent Storage. nft # [ 10.296224] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. nft # [ 10.322061] systemd[1]: Starting Create Static Device Nodes in /dev... nft # [ 10.333184] systemd[1]: Finished Apply Kernel Variables. machine # [ 10.706455] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 10.714339] systemd[1]: Stopped initrd-switch-root.service. machine # [ 10.720014] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 10.724383] systemd[1]: Created slice Slice /system/getty. machine # [ 10.727353] systemd[1]: Created slice Slice /system/microvm. machine # [ 10.729639] systemd[1]: Created slice Slice /system/microvm-macvtap-interfaces. machine # [ 10.732141] systemd[1]: Created slice Slice /system/microvm-pci-devices. machine # [ 10.734762] systemd[1]: Created slice Slice /system/microvm-set-booted. machine # [ 10.737319] systemd[1]: Created slice Slice /system/microvm-tap-interfaces. machine # [ 10.739558] systemd[1]: Created slice Slice /system/microvm-virtiofsd. machine # [ 10.741793] systemd[1]: Created slice User and Session Slice. machine # [ 10.743219] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 10.745466] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 10.747291] systemd[1]: Expecting device /dev/hvc0... machine # [ 10.748546] systemd[1]: Expecting device /dev/ttyS0... machine # [ 10.749624] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 10.750849] systemd[1]: Stopped target initrd-fs.target. machine # [ 10.752413] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 10.753663] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 10.755126] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 10.756596] systemd[1]: Reached target Remote File Systems. machine # [ 10.758660] systemd[1]: Reached target Slice Units. machine # [ 10.760032] systemd[1]: Reached target Swaps. machine # [ 10.819632] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 10.897493] systemd[1]: Listening on Process Core Dump Socket. machine # [ 10.912481] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 10.954925] systemd[1]: Listening on Factory Reset Management. machine # [ 10.958838] systemd[1]: Listening on Hostname Service Socket. machine # [ 10.986019] systemd[1]: Starting Journal Log Access Socket... machine # [ 10.991503] systemd[1]: Listening on Journal Audit Socket. machine # [ 11.020473] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 11.023084] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 11.028098] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 11.033160] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 11.101526] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 11.103171] systemd[1]: Listening on udev Control Socket. machine # [ 11.107768] systemd[1]: Listening on udev Varlink Socket. machine # [ 11.120417] systemd[1]: Mounting Huge Pages File System... machine # [ 11.128244] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 11.148765] systemd[1]: Mounting Kernel Debug File System... machine # [ 11.156152] systemd[1]: Mounting Kernel Trace File System... nft # [ 10.824547] systemd[1]: Finished Create Static Device Nodes in /dev. nft # [ 10.828809] systemd[1]: Reached target Preparation for Local File Systems. nft # [ 10.832881] systemd[1]: Mounting /run/wrappers... nft # [ 10.841530] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 11.178728] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 11.180595] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 11.198985] systemd[1]: Starting Load Kernel Module configfs... machine # [ 11.204173] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 11.206765] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 11.208879] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 11.225037] systemd[1]: Mounting FUSE Control File System... machine # [ 11.226767] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 11.242124] systemd[1]: Starting Journal Service... machine # [ 11.246749] systemd[1]: Starting Load Kernel Modules... machine # [ 11.258681] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 11.286668] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 11.288568] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 11.298288] systemd[1]: Starting Coldplug All udev Devices... machine # [ 11.300827] systemd[1]: Listening on Journal Log Access Socket. nft # [ 10.999290] systemd[1]: Mounted /run/wrappers. nft # [ 11.003175] systemd[1]: Reached target Local File Systems. nft # [ 11.023220] systemd[1]: Listening on Boot Loader Control Service Socket. nft # [ 11.026990] systemd[1]: Starting register-nix-paths.service... nft # [ 11.034045] systemd[1]: Starting Create SUID/SGID Wrappers... nft # [ 11.036498] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. nft # [ 11.058707] systemd[1]: Starting Save Transient machine-id to Disk... nft # [ 11.073679] systemd[1]: Starting Create System Files and Directories... machine # [ 11.465334] systemd[1]: Mounted Huge Pages File System. machine # [ 11.467316] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 11.469631] systemd[1]: Mounted Kernel Debug File System. machine # [ 11.474523] systemd[1]: Mounted Kernel Trace File System. nft # [ 11.144081] systemd-udevd[323]: Using default interface naming scheme 'v261'. machine # [ 11.477714] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 11.479259] systemd[1]: Mounted FUSE Control File System. machine # [ 11.480690] EXT4-fs (vda): re-mounted 2fb05b1c-a187-46d8-a39d-9780723e2a0f. machine # [ 11.494243] systemd-journald[321]: Collecting audit messages is enabled. machine # [ 11.511380] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 11.514913] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 11.517413] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 11.519879] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 11.305549] systemd[1]: Queued start job for default target Multi-User System. machine # [ 11.540723] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 11.313119] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 11.543794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 11.212097] systemd-tmpfiles[328]: /etc/tmpfiles.d/10-microvm.conf:1: Duplicate line for path "/home/alice/hermes", ignoring. machine # [ 11.549633] systemd[1]: Started Journal Service. machine # [ 11.318295] systemd-modules-load[322]: Using 4 probe threads nft # [ 11.218559] systemd-tmpfiles[328]: /etc/tmpfiles.d/10-microvm.conf:2: Duplicate line for path "/var/lib/hermes-microvm/alice/guest", ignoring. machine # [ 11.320897] systemd-oomd[323]: No swap; memory pressure usage will be degraded nft # [ 11.221516] systemd-tmpfiles[328]: /etc/tmpfiles.d/10-microvm.conf:3: Duplicate line for path "/var/lib/hermes-microvm/alice/state-vault/state", ignoring. machine # [ 11.327348] systemd[1]: Starting Flush Journal to Persistent Storage... nft # [ 11.232341] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 11.332620] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 11.335782] systemd[1]: Finished Load Kernel Module configfs. nft # [ 11.237183] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 11.341604] systemd-modules-load[322]: Inserted module 'tap' machine # [ 11.578038] loop: module loaded machine # [ 11.348108] systemd-modules-load[322]: Inserted module 'loop' machine # [ 11.351326] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 11.594223] tun: Universal TUN/TAP device driver, 1.6 machine # [ 11.366248] systemd-modules-load[322]: Inserted module 'vhost_vsock' machine # [ 11.370496] systemd-modules-load[322]: Inserted module 'vhost_net' machine # [ 11.377255] systemd[1]: Finished Load Kernel Modules. nft # [ 11.278352] systemd[1]: Finished Create System Files and Directories. nft # [ 11.283501] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 11.382267] systemd[1]: Starting Firewall... nft # [ 11.287157] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 11.390488] systemd[1]: Starting Apply Kernel Variables... machine # [ 11.640549] systemd-journald[321]: Received client request to flush runtime journal. nft # [ 11.360244] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 11.480447] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 11.482273] systemd[1]: Reached target First Boot Complete. machine # [ 11.483757] systemd[1]: Finished Coldplug All udev Devices. machine # [ 11.487406] systemd[1]: Mounting Kernel Configuration File System... machine # [ 11.492796] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 11.521726] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 11.526232] systemd[1]: Starting Create Static Device Nodes in /dev... nft # [ 11.425205] systemd[1]: Finished Rebuild Journal Catalog. nft # [ 11.429343] systemd[1]: Starting Update is Completed... machine # [ 11.554960] systemd[1]: Finished Apply Kernel Variables. nft # [ 11.459720] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 11.569479] systemd[1]: Mounted Kernel Configuration File System. nft # [ 11.503771] systemd[1]: Finished Update is Completed. machine # [ 11.648188] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 11.650989] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 11.654558] systemd[1]: Starting Rule-based Manager for Device Events and Files... nft # [ 11.595624] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse nft # [ 11.632342] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. nft # [ 11.634123] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 11.772001] systemd-udevd[360]: Using default interface naming scheme 'v261'. nft # [ 11.716941] (udev-worker)[368]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. nft # [ 11.720294] (udev-worker)[368]: Network interface NamePolicy= disabled on kernel command line. nft # [ 11.723192] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line. nft # [ 12.029075] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 nft # [ 12.038618] ACPI: button: Power Button [PWRF] nft # [ 11.812212] systemd[1]: Condition check resulted in Virtio network device being skipped. nft # [ 11.814382] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore nft # [ 11.816547] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. nft # [ 11.819326] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 nft # [ 11.822716] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore nft # [ 11.825367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 11.827347] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os nft # [ 12.061912] mousedev: PS/2 mouse device common for all mice nft # [ 12.068875] rtc_cmos 00:05: RTC can wake from S4 nft # [ 12.071896] Floppy drive(s): fd0 is 2.88M AMI BIOS nft # [ 12.087627] FDC 0 is a S82078B nft # [ 12.088990] parport_pc 00:03: reported by Plug and Play ACPI nft # [ 12.090867] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] nft # [ 12.094786] rtc_cmos 00:05: registered as rtc0 nft # [ 12.099171] rtc_cmos 00:05: setting system clock to 2026-08-06T10:48:33 UTC (1786013313) nft # [ 12.104748] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs nft # [ 12.145215] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console nft # [ 12.151690] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 nft # [ 12.173969] Console: switching to colour dummy device 80x25 nft # [ 12.176006] [drm] Found bochs VGA, ID 0xb0c5. nft # [ 12.176008] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. nft # [ 12.178370] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic nft # [ 12.180557] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 nft # [ 12.208818] Console: switching to colour frame buffer device 160x50 nft # [ 12.210959] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device nft # [ 12.223377] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 nft # [ 12.227684] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD nft # [ 12.248970] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 12.125942] systemd[1]: Started Rule-based Manager for Device Events and Files. nft # [ 12.033867] systemd[1]: Starting Virtual Console Setup... nft # [ 12.288694] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 nft # [ 12.299174] ppdev: user-space parallel port driver nft # [ 12.133584] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.236360] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse nft # [ 12.136494] systemd[1]: Stopped Virtual Console Setup. nft # [ 12.144292] systemd[1]: Starting Virtual Console Setup... nft # [ 12.160487] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. nft # [ 12.163073] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.253907] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 12.318745] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. nft # [ 12.238484] systemd[1]: Starting Virtual Console Setup... machine # [ 12.429527] (udev-worker)[390]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 12.437630] (udev-worker)[402]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.440984] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.489500] systemd[1]: Mounting /run/wrappers... machine # [ 12.723010] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 nft # [ 12.627108] kvm_amd: TSC scaling supported nft # [ 12.628184] kvm_amd: Nested Virtualization enabled nft # [ 12.629235] kvm_amd: Nested Paging enabled nft # [ 12.630138] kvm_amd: LBR virtualization supported nft # [ 12.631138] kvm_amd: Virtual GIF supported machine # [ 12.729176] ACPI: button: Power Button [PWRF] nft # [ 12.632018] kvm_amd: Virtual NMI enabled machine # [ 12.757772] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 machine # [ 12.762657] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console machine # [ 12.762929] Floppy drive(s): fd0 is 2.88M AMI BIOS machine # [ 12.767635] rtc_cmos 00:05: RTC can wake from S4 machine # [ 12.778255] rtc_cmos 00:05: registered as rtc0 machine # [ 12.778381] rtc_cmos 00:05: setting system clock to 2026-08-06T10:48:34 UTC (1786013314) machine # [ 12.778506] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 12.794369] FDC 0 is a S82078B machine # [ 12.798245] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 12.806119] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 12.806229] Console: switching to colour dummy device 80x25 machine # [ 12.817646] mousedev: PS/2 mouse device common for all mice machine # [ 12.818584] parport_pc 00:03: reported by Plug and Play ACPI machine # [ 12.818730] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 12.829318] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 12.829713] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 machine # [ 12.830046] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 12.839885] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 12.863271] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic machine # [ 12.867389] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 machine # [ 12.880590] Console: switching to colour frame buffer device 160x50 machine # [ 12.886343] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 12.661331] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.676993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 12.679540] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 12.729263] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 12.751469] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.755404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.775934] systemd[1]: Mounted /run/wrappers. machine # [ 12.797081] s[ 13.029629] ppdev: user-space parallel port driver machine # ystemd[1]: Reached target Local File Systems. machine # [ 12.828115] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 12.837230] systemd[1]: Starting register-nix-paths.service... machine # [ 12.851625] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 12.853247] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 12.864614] systemd[1]: Starting Save Transient machine-id to Disk... nft # [ 12.793533] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. nft # [ 12.795703] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 12.893708] systemd[1]: Starting Create System Files and Directories... machine # [ 12.903974] systemd[1]: Starting Virtual Console Setup... nft # [ 13.045988] EDAC MC: Ver: 3.0.0 machine # [ 12.988871] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.004187] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.065487] systemd[1]: Starting Virtual Console Setup... machine # [ 13.101414] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 13.116641] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:1: Duplicate line for path "/home/alice/hermes", ignoring. machine # [ 13.124133] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:2: Duplicate line for path "/home/bob/hermes", ignoring. machine # [ 13.127569] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:3: Duplicate line for path "/var/lib/hermes-microvm/alice/guest", ignoring. machine # [ 13.131854] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:4: Duplicate line for path "/var/lib/hermes-microvm/alice/state-vault/state", ignoring. machine # [ 13.135971] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:5: Duplicate line for path "/var/lib/hermes-microvm/bob/guest", ignoring. machine # [ 13.141555] systemd-tmpfiles[429]: /etc/tmpfiles.d/10-microvm.conf:6: Duplicate line for path "/var/lib/hermes-microvm/bob/state-vault/state", ignoring. machine # [ 13.458060] kvm_amd: TSC scaling supported machine # [ 13.458852] kvm_amd: Nested Virtualization enabled machine # [ 13.459805] kvm_amd: Nested Paging enabled machine # [ 13.460560] kvm_amd: LBR virtualization supported machine # [ 13.461579] kvm_amd: Virtual GIF supported machine # [ 13.462476] kvm_amd: Virtual NMI enabled machine # [ 13.235196] systemd[1]: Finished Create System Files and Directories. machine # [ 13.244937] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 13.251228] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 13.320911] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 13.607553] EDAC MC: Ver: 3.0.0 machine # [ 13.401862] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 13.406340] systemd[1]: Starting Update is Completed... machine # [ 13.470449] systemd[1]: Finished Update is Completed. machine # [ 13.476637] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. nft # [ 13.589604] systemd[1]: Finished register-nix-paths.service. nft # [ 13.742728] systemd-vconsole-setup[419]: Configuration of first virtual console was skipped, ignoring remaining ones. nft # [ 13.746617] systemd[1]: Finished Virtual Console Setup. nft # [ 13.749322] systemd[1]: Reached target System Initialization. nft # [ 13.750780] systemd[1]: Started hermes-microvm-timezone.path. nft # [ 13.752292] systemd[1]: Started Discard unused filesystem blocks once a week. nft # [ 13.754083] systemd[1]: Started Daily Cleanup of Temporary Directories. nft # [ 13.755623] systemd[1]: Reached target Path Units. machine # [ 13.855226] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. nft # [ 13.756708] systemd[1]: Reached target Timer Units. machine # [ 13.857180] systemd[1]: Finished Create SUID/SGID Wrappers. nft # [ 13.757852] systemd[1]: Listening on D-Bus System Message Bus Socket. nft # [ 13.760609] systemd[1]: Listening on dashboard forward socket for hermes-alice. nft # [ 13.763235] systemd[1]: Listening on spaces bridge socket for hermes-alice. nft # [ 13.764756] systemd[1]: Listening on Nix Daemon Socket. nft # [ 13.766146] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. nft # [ 13.768084] systemd[1]: Reached target Socket Units. nft # [ 13.769446] systemd[1]: Reached target Basic System. nft # [ 13.770579] systemd[1]: Started backdoor.service. nft # [ 13.772207] systemd[1]: Started Enable Kernel Same-Page Merging. nft # [ 13.775083] systemd[1]: Starting Install MicroVM 'hermes-alice'... nft # [ 13.778224] systemd[1]: Starting Import lastlog data into lastlog2 database... nft # [ 13.783438] systemd[1]: Starting nftables firewall... nft # [ 13.790256] systemd[1]: Starting Name Service Cache Daemon (nsncd)... nft # [ 13.795858] systemd[1]: Starting Post-Boot Actions... nft # [ 13.801478] systemd[1]: Started Reset console on configuration changes. nft # [ 13.806367] systemd[1]: Starting resolvconf update... nft # [ 13.819779] systemd[1]: Starting D-Bus System Message Bus... nft # [ 13.847649] systemd[1]: enable-ksm.service: Deactivated successfully. machine # [ 13.952841] systemd-vconsole-setup[435]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.957360] systemd[1]: Finished Virtual Console Setup. nft # [ 13.860180] systemd[1]: Finished Post-Boot Actions. nft # connecting to host... nft # [ 13.892357] systemd[1]: install-microvm-hermes-alice.service: Deactivated successfully. nft # [ 13.895110] systemd[1]: Finished Install MicroVM 'hermes-alice'. nft # [ 13.896567] systemd[1]: Reached target microvms.target. nft # [ 13.898939] systemd[1]: Finished Import lastlog data into lastlog2 database. nft # [ 13.908433] nsncd[443]: Aug 06 10:48:35.540 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" nft # [ 13.912695] systemd[1]: Started Name Service Cache Daemon (nsncd). nft # [ 13.914900] systemd[1]: Reached target Host and Network Name Lookups. nft # [ 13.917100] systemd[1]: Reached target User and Group Name Lookups. nft # [ 13.918977] systemd[1]: Starting User Login Management... nft # [ 13.972853] dbus-broker-launch[449]: Looking up NSS user entry for 'systemd-timesync'... nft # [ 13.988698] systemd-logind[480]: New seat seat0. nft # [ 13.993488] dbus-broker-launch[449]: NSS returned no entry for 'systemd-timesync' nft # [ 13.995763] dbus-broker-launch[449]: Invalid user-name in /nix/store/a67cmbrix5hyg8i1ss38ns8i3q1w1ccd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" nft # [ 14.001057] systemd[1]: Stopped target Host and Network Name Lookups. nft # [ 14.002665] systemd[1]: Stopping Host and Network Name Lookups... nft # [ 14.004742] systemd[1]: Stopped target User and Group Name Lookups. nft # [ 14.006780] systemd[1]: Stopping User and Group Name Lookups... nft # [ 14.008536] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... nft # [ 14.010100] systemd-logind[480]: Watching system buttons on /dev/input/event2 (Power Button) nft # [ 14.012455] systemd-logind[480]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) nft # [ 14.014546] systemd-logind[480]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) nft # [ 14.017625] systemd[1]: nscd.service: Deactivated successfully. nft # [ 14.019922] systemd[1]: Stopped Name Service Cache Daemon (nsncd). nft # [ 14.022268] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 14.142036] systemd[1]: Finished Firewall. nft # [ 14.086798] systemd[1]: Started D-Bus System Message Bus. nft # [ 14.189563] dbus-broker-launch[449]: Ready nft # [ 14.220353] nsncd[525]: Aug 06 10:48:35.847 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" nft # [ 14.234942] systemd[1]: Started Name Service Cache Daemon (nsncd). nft # [ 14.244269] systemd[1]: Started User Login Management. nft # [ 14.250589] systemd[1]: Created slice Slice /user/1000. nft # [ 14.251847] systemd[1]: Reached target Host and Network Name Lookups. nft # [ 14.254194] systemd[1]: Reached target User and Group Name Lookups. nft # [ 14.266774] systemd[1]: Starting linger-users.service... nft # [ 14.272426] systemd[1]: Starting User Runtime Directory /run/user/1000... nft # [ 14.416241] systemd[1]: Finished resolvconf update. nft # [ 14.427647] systemd[1]: Starting DHCP Client... nft # [ 14.454191] systemd[1]: Finished User Runtime Directory /run/user/1000. nft # [ 14.464352] systemd[1]: Starting User Manager for UID 1000... nft # [ 14.542871] systemd[1]: linger-users.service: Deactivated successfully. nft # [ 14.549849] systemd[1]: Finished linger-users.service. nft # [ 14.740372] (systemd)[560]: pam_unix(systemd-user:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 14.817259] dhcpcd[573]: dhcpcd-10.3.2 starting nft # [ 14.825877] systemd-logind[480]: New session '1' of user 'alice' with class 'manager' and type 'unspecified'. nft # [ 14.837270] dhcpcd[581]: dev: loaded udev machine # [ 14.956725] systemd[1]: Finished register-nix-paths.service. machine # [ 14.958048] systemd[1]: Reached target System Initialization. machine # [ 14.959285] systemd[1]: Started hermes-microvm-timezone.path. machine # [ 14.961535] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 14.962898] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 14.964146] systemd[1]: Reached target Path Units. machine # [ 14.965087] systemd[1]: Reached target Timer Units. machine # [ 14.966039] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 14.977592] systemd[1]: Listening on dashboard forward socket for hermes-alice. nft # [ 15.113006] 8021q: 802.1Q VLAN Support v1.8 nft # [ 14.881930] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 14.983204] systemd[1]: Listening on dashboard forward socket for hermes-bob. machine # [ 14.987488] systemd[1]: Listening on spaces bridge socket for hermes-alice. machine # [ 14.988880] systemd[1]: Listening on Nix Daemon Socket. machine # [ 14.990514] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 14.992288] systemd[1]: Reached target Socket Units. machine # [ 14.993411] systemd[1]: Reached target Basic System. machine # [ 14.994669] systemd[1]: Started backdoor.service. machine # [ 14.996988] systemd[1]: Started Enable Kernel Same-Page Merging. machine # [ 15.000183] systemd[1]: Starting Owner-match loopback firewall for hermes microvms... machine # [ 15.002242] systemd[1]: Starting Install MicroVM 'hermes-alice'... machine # [ 15.005918] systemd[1]: Starting Install MicroVM 'hermes-bob'... machine # [ 15.011083] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 15.014146] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 15.017714] systemd[1]: Starting Post-Boot Actions... nft # [ 14.919417] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 15.020312] systemd[1]: Started Reset console on configuration changes. machine # [ 15.024166] systemd[1]: Starting resolvconf update... nft # [ 14.934088] systemd[1]: Finished nftables firewall. machine # [ 15.034096] systemd[1]: Starting D-Bus System Message Bus... nft # [ 14.935325] systemd[1]: Reached target Preparation for Network. nft # [ 14.937206] systemd[1]: Starting Owner-match loopback firewall for hermes microvms... nft # [ 14.939224] systemd[1]: Starting Address configuration of eth1... nft # [ 14.941531] systemd[1]: Starting Extra networking commands.... machine # [ 15.046082] systemd[1]: enable-ksm.service: Deactivated successfully. machine # [ 15.055901] systemd[1]: Finished Post-Boot Actions. machine # connecting to host... machine # [ 15.071422] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 15.074362] systemd[1]: install-microvm-hermes-alice.service: Deactivated successfully. machine # [ 15.077784] nsncd[586]: Aug 06 10:48:37.024 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 15.084233] systemd[1]: Finished Install MicroVM 'hermes-alice'. machine # [ 15.086200] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 15.087886] systemd[1]: Reached target User and Group Name Lookups. nft # [ 15.220369] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 15.090461] systemd[1]: Setup MicroVM 'hermes-alice' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/pci-setup machine # [ 15.096810] systemd[1]: Starting Save MicroVM 'hermes-alice' booted configuration... machine # [ 15.099678] systemd[1]: Starting User Login Management... machine # [ 15.102274] systemd[1]: install-microvm-hermes-bob.service: Deactivated successfully. nft # [ 15.245858] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 15.105038] systemd[1]: Finished Install MicroVM 'hermes-bob'. machine # [ 15.106989] systemd[1]: Finished Import lastlog data into lastlog2 database. machine: connected to guest root shell nft # [ 15.247915] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' nft # [ 15.250819] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine: (connecting took 15.87 seconds) nft # [ 15.252298] cfg80211: failed to load regulatory.db machine: (finished: waiting for the VM to finish booting, in 15.87 seconds) machine # [ 15.109468] systemd[1]: Setup MicroVM 'hermes-bob' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/pci-setup machine # [ 15.113749] systemd[1]: Starting Save MicroVM 'hermes-bob' booted configuration... machine # [ 15.146413] dbus-broker-launch[591]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 15.148390] dbus-broker-launch[591]: NSS returned no entry for 'systemd-timesync' machine # [ 15.150161] dbus-broker-launch[591]: Invalid user-name in /nix/store/p3il7gm2ch24473mw04c4ql1zmg1lj0v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" nft # [ 15.292053] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 15.170836] systemd-logind[626]: New seat seat0. machine # [ 15.175340] systemd[1]: Started D-Bus System Message Bus. nft # [ 15.084540] network-addresses-eth1-start[595]: adding address 192.168.1.2/24... done machine # [ 15.194041] dbus-broker-launch[591]: Ready nft # [ 15.099863] dhcpcd[620]: /nix/store/sik59w5vizfgwjqm2ri2gwnw9c3a78rg-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (600) - Operation not permitted nft # [ 15.103414] dhcpcd[620]: .resolvconf-wrapped: clearing stale lock pid 600 nft # [ 15.106359] network-addresses-eth1-start[595]: adding address 2001:db8:1::2/64... done nft # [ 15.126557] systemd[1]: Finished Address configuration of eth1. nft # [ 15.366923] 8021q: adding VLAN 0 to HW filter on device eth0 nft # [ 15.135792] dhcpcd[581]: eth0: waiting for carrier nft # [ 15.137211] dhcpcd[581]: eth0: carrier acquired nft # [ 15.138805] systemd[1]: Finished Extra networking commands.. nft # [ 15.142281] systemd[1]: Reached target Network. nft # [ 15.147292] systemd[1]: Starting Permit User Sessions... nft # [ 15.148609] systemd[560]: Queued start job for default target Main User Target. nft # [ 15.150465] dhcpcd[581]: DUID 00:01:00:01:32:07:23:04:52:54:00:12:34:56 nft # [ 15.151704] dhcpcd[581]: eth0: IAID 00:12:34:56 nft # [ 15.153037] dhcpcd[581]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 15.254091] systemd-logind[626]: Watching system buttons on /dev/input/event2 (Power Button) nft # [ 15.155541] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 15.255520] systemd-logind[626]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) nft # [ 15.159348] systemd[560]: Created slice User Application Slice. machine # [ 15.257462] systemd-logind[626]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) nft # [ 15.161303] systemd[560]: Started Daily Cleanup of User's Temporary Directories. nft # [ 15.162956] systemd[560]: Reached target Paths. nft # [ 15.164690] systemd[560]: Reached target Timers. nft # [ 15.166891] systemd[560]: Starting D-Bus User Message Bus Socket... nft # [ 15.169186] systemd[560]: Starting Create User Files and Directories... nft # [ 15.180271] systemd[1]: Finished Permit User Sessions. machine # [ 15.284197] systemd[1]: Started User Login Management. nft # [ 15.189084] systemd[1]: Started Getty on tty1. nft # [ 15.190336] systemd[1]: Reached target Login Prompts. machine # [ 15.293249] systemd[1]: Created slice Slice /user/1000. machine # [ 15.294330] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 15.295461] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 15.297125] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 15.298160] systemd[1]: Stopping User and Group Name Lookups... machine # [ 15.298678] systemd[1]: Starting linger-users.service... nft # [ 15.199887] systemd[560]: Finished Create User Files and Directories. machine # [ 15.299885] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 15.300892] systemd[1]: Starting User Runtime Directory /run/user/1000... machine # [ 15.318186] systemd[1]: nscd.service: Deactivated successfully. machine # [ 15.319318] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 15.323332] systemd[1]: Finished resolvconf update. machine # [ 15.324503] systemd[1]: Finished Save MicroVM 'hermes-alice' booted configuration. machine # [ 15.325331] systemd[1]: Finished Save MicroVM 'hermes-bob' booted configuration. nft # [ 15.229073] systemd[560]: Listening on D-Bus User Message Bus Socket. machine # [ 15.329496] systemd[1]: Reached target Preparation for Network. nft # [ 15.230426] systemd[560]: Reached target Sockets. machine # [ 15.332287] systemd[1]: Starting DHCP Client... nft # [ 15.231448] systemd[560]: Reached target Basic System. nft # [ 15.234377] systemd[1]: Started User Manager for UID 1000. machine # [ 15.333550] systemd[1]: Setup MicroVM 'hermes-alice' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/macvtap-up nft # [ 15.236135] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 15.334993] systemd[1]: Setup MicroVM 'hermes-bob' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/macvtap-up machine # [ 15.336642] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-alice'... machine # [ 15.338958] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 15.342492] systemd[1]: Starting Address configuration of eth1... nft # [ 15.256838] systemd[1]: Finished Owner-match loopback firewall for hermes microvms. machine # [ 15.358313] systemd[1]: Starting Extra networking commands.... machine # [ 15.361351] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 15.362968] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 15.366395] systemd[1]: Finished linger-users.service. nft # [ 15.268061] systemd[560]: Finished Run user-specific NixOS activation. nft # [ 15.269440] systemd[560]: Reached target Main User Target. nft # [ 15.270541] systemd[560]: Startup finished in 409ms. machine # [ 15.384689] systemd[1]: Finished User Runtime Directory /run/user/1000. machine # [ 15.390354] systemd[1]: Starting User Manager for UID 1000... machine # [ 15.391651] systemd[1]: Finished Owner-match loopback firewall for hermes microvms. machine # [ 15.395221] nsncd[754]: Aug 06 10:48:37.348 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 15.399463] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 15.401658] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 15.403864] systemd[1]: Reached target User and Group Name Lookups. machine # [ 15.422146] network-addresses-eth1-start[747]: adding address 192.168.1.1/24... done machine # [ 15.426882] (systemd)[760]: pam_unix(systemd-user:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 15.433622] network-addresses-eth1-start[747]: adding address 2001:db8:1::1/64... done machine # [ 15.444066] systemd-logind[626]: New session '1' of user 'alice' with class 'manager' and type 'unspecified'. machine # [ 15.448663] systemd[1]: Finished Address configuration of eth1. machine # [ 15.469062] dhcpcd[767]: dhcpcd-10.3.2 starting machine # [ 15.471722] systemd[760]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 15.723851] 8021q: 802.1Q VLAN Support v1.8 machine # [ 15.724689] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 15.527178] dhcpcd[847]: dev: loaded udev machine # [ 15.529090] systemd[1]: Finished Extra networking commands.. machine # [ 15.530906] systemd[1]: Reached target Network. machine # [ 15.532234] systemd[1]: Setup MicroVM 'hermes-alice' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-alice/current/bin/tap-up machine # [ 15.535408] systemd[1]: Setup MicroVM 'hermes-bob' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/tap-up machine # [ 15.538663] systemd[1]: Starting Permit User Sessions... machine # [ 15.539913] systemd[1]: Finished Permit User Sessions. machine # [ 15.541332] systemd[1]: Started Getty on tty1. machine # [ 15.542488] systemd[1]: Reached target Login Prompts. machine # [ 15.543839] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. nft # [ 15.495902] dhcpcd[581]: eth0: soliciting a DHCP lease machine # [ 15.831702] cfg80211: Loading compiled-in X.509 certificates for regulatory database nft # [ 15.740576] NET: Registered PF_PACKET protocol family nft # [ 15.518578] dhcpcd[581]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 15.852351] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 15.853368] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' nft # [ 15.523309] dhcpcd[581]: eth0: probing address 10.0.2.15/24 machine # [ 15.855910] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 15.857120] cfg80211: failed to load regulatory.db machine # [ 15.655195] systemd[760]: Queued start job for default target Main User Target. machine # [ 15.662902] systemd[760]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 15.897650] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 15.667426] dhcpcd[847]: eth0: waiting for carrier machine # [ 15.668966] dhcpcd[847]: eth0: carrier acquired machine # [ 15.671956] systemd[760]: Created slice User Application Slice. machine # [ 15.673516] systemd[760]: Started Daily Cleanup of User's Temporary Directories. machine # [ 15.675120] dhcpcd[847]: DUID 00:01:00:01:32:07:23:05:52:54:00:12:34:56 machine # [ 15.675932] dhcpcd[847]: eth0: IAID 00:12:34:56 machine # [ 15.677063] dhcpcd[847]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 15.680232] systemd[760]: Reached target Paths. machine # [ 15.681278] systemd[760]: Reached target Timers. machine # [ 15.684259] systemd[760]: Starting D-Bus User Message Bus Socket... machine # [ 15.688184] systemd[760]: Starting Create User Files and Directories... machine # [ 15.709596] systemd[760]: Finished Create User Files and Directories. machine # [ 15.740847] systemd[760]: Listening on D-Bus User Message Bus Socket. machine # [ 15.741910] systemd[760]: Reached target Sockets. machine # [ 15.743193] systemd[760]: Reached target Basic System. machine # [ 15.744219] systemd[1]: Started User Manager for UID 1000. machine # [ 15.745276] systemd[760]: Starting Run user-specific NixOS activation... machine # [ 15.776073] systemd[760]: Finished Run user-specific NixOS activation. machine # [ 15.776934] systemd[760]: Reached target Main User Target. machine # [ 15.777915] systemd[760]: Startup finished in 315ms. machine # [ 16.096283] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:38,048 INFO Set uid to user 0 succeeded machine # [ 16.097742] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:38,048 INFO Set uid to user 0 succeeded machine # [ 16.103682] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:38,057 INFO supervisord started with pid 812 machine # [ 16.104840] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:38,057 INFO supervisord started with pid 809 machine # [ 16.815763] dhcpcd[847]: eth0: soliciting an IPv6 router machine # [ 16.816708] dhcpcd[847]: eth0: Router Advertisement from fe80::2 machine # [ 16.817800] dhcpcd[847]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 16.818922] dhcpcd[847]: eth0: adding route to fec0::/64 machine # [ 16.819705] dhcpcd[847]: eth0: adding default route via fe80::2 machine # [ 17.113060] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:39,065 INFO spawned: 'notify' with pid 887 machine # [ 17.114651] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:39,065 INFO spawned: 'notify' with pid 886 machine # [ 17.121571] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:39,073 INFO spawned: 'virtiofsd-hermes-exchange' with pid 889 machine # [ 17.122699] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:39,074 INFO spawned: 'virtiofsd-hermes-exchange' with pid 888 machine # [ 17.128469] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:39,080 INFO spawned: 'virtiofsd-hermes-state' with pid 891 machine # [ 17.130850] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:39,081 INFO spawned: 'virtiofsd-hermes-state' with pid 890 machine # [ 17.133061] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:39,086 INFO spawned: 'virtiofsd-host-config' with pid 892 machine # [ 17.135505] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:39,086 INFO spawned: 'virtiofsd-host-config' with pid 893 machine # [ 17.141034] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:39,090 INFO spawned: 'virtiofsd-ro-store' with pid 894 machine # [ 17.145251] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:39,093 INFO spawned: 'virtiofsd-ro-store' with pid 895 machine # [ 17.202662] supervisord[812]: virtiofsd-hermes-exchange [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.205446] supervisord[809]: virtiofsd-hermes-exchange [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.208477] supervisord[809]: virtiofsd-host-config [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.211041] supervisord[809]: virtiofsd-hermes-state [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.213113] supervisord[812]: virtiofsd-hermes-state [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.215252] supervisord[812]: virtiofsd-host-config [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.216072] supervisord[812]: virtiofsd-ro-store [2026-08-06T10:48:39Z WARN virtiofsd::passthrough] Filesystem mounted on "/" (mount ID: 591): Filesystem does not support file handles, falling back to O_PATH FDs machine # [ 17.216672] supervisord[812]: virtiofsd-ro-store [2026-08-06T10:48:39Z WARN virtiofsd::passthrough] Failed to generate a file handle for the root node, disabling file handles altogether machine # [ 17.217323] supervisord[812]: virtiofsd-ro-store [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.217915] supervisord[809]: virtiofsd-ro-store [2026-08-06T10:48:39Z WARN virtiofsd::passthrough] Filesystem mounted on "/" (mount ID: 112): Filesystem does not support file handles, falling back to O_PATH FDs machine # [ 17.218784] supervisord[809]: virtiofsd-ro-store [2026-08-06T10:48:39Z WARN virtiofsd::passthrough] Failed to generate a file handle for the root node, disabling file handles altogether machine # [ 17.219601] supervisord[809]: virtiofsd-ro-store [2026-08-06T10:48:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 17.237583] dhcpcd[847]: eth0: soliciting a DHCP lease machine # [ 17.482595] NET: Registered PF_PACKET protocol family machine # [ 17.257537] dhcpcd[847]: eth0: offered 10.0.2.15 from 10.0.2.2 nft # [ 17.165222] dhcpcd[581]: eth0: soliciting an IPv6 router machine # [ 17.265284] dhcpcd[847]: eth0: probing address 10.0.2.15/24 nft # [ 17.166170] dhcpcd[581]: eth0: Router Advertisement from fe80::2 nft # [ 17.167001] dhcpcd[581]: eth0: adding address fec0::5054:ff:fe12:3456/64 nft # [ 17.167959] dhcpcd[581]: eth0: adding route to fec0::/64 nft # [ 17.169237] dhcpcd[581]: eth0: adding default route via fe80::2 machine # [ 18.212109] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:40,165 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.213733] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:40,165 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.214816] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.215948] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.217067] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.217863] microvm-virtiofsd@hermes-alice[809]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.218776] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.219702] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.220530] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.221337] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:40,165 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 18.222175] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-alice'. machine # [ 18.223457] systemd[1]: Starting MicroVM 'hermes-alice'... machine # [ 18.244884] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 18.248661] systemd[1]: Starting MicroVM 'hermes-bob'... machine # [ 18.375877] microvm@hermes-bob[1026]: mv: cannot stat '/var/lib/hermes-microvm/alice/guest/tz/.localtime.tmp': No such file or directory machine # [ 18.378698] systemd[1]: microvm@hermes-bob.service: Control process exited, code=exited, status=1/FAILURE machine # [ 18.411694] systemd[1]: microvm@hermes-bob.service: Failed with result 'exit-code'. machine # [ 18.412951] systemd[1]: Failed to start MicroVM 'hermes-bob'. nft # [ 20.111126] dhcpcd[581]: eth0: leased 10.0.2.15 for 86400 seconds nft # [ 20.113310] dhcpcd[581]: eth0: adding route to 10.0.2.0/24 nft # [ 20.114944] dhcpcd[581]: eth0: adding default route via 10.0.2.2 nft # [ 20.218272] systemd[1]: Started DHCP Client. nft # [ 20.219741] systemd[1]: Reached target Multi-User System. nft # [ 20.221705] systemd[1]: Startup finished in 884ms (kernel) + 4.944s (initrd) + 14.392s (userspace) = 20.221s. machine # [ 22.410279] dhcpcd[847]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 22.411486] dhcpcd[847]: eth0: adding route to 10.0.2.0/24 machine # [ 22.411949] dhcpcd[847]: eth0: adding default route via 10.0.2.2 machine # [ 22.496668] systemd[1]: Started DHCP Client. machine # [ 23.663237] systemd[1]: microvm@hermes-bob.service: Scheduled restart job, restart counter is at 1. machine # [ 23.664541] systemd[1]: Stopped MicroVM 'hermes-bob'. machine # [ 23.665511] systemd[1]: Setup MicroVM 'hermes-bob' devices for passthrough skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/pci-setup machine # [ 23.666786] systemd[1]: Stopping VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 24.255691] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,208 WARN received SIGTERM indicating exit request machine # [ 24.256325] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,209 INFO waiting for notify, virtiofsd-hermes-exchange, virtiofsd-hermes-state, virtiofsd-host-config, virtiofsd-ro-store to die machine # [ 24.262698] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,216 WARN stopped: virtiofsd-ro-store (exit status 1) machine # [ 24.265809] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,219 WARN stopped: virtiofsd-host-config (exit status 1) machine # [ 24.268321] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,220 WARN stopped: virtiofsd-hermes-state (exit status 1) machine # [ 24.270464] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:46,221 WARN stopped: virtiofsd-hermes-exchange (exit status 1) machine # [ 25.275181] microvm-virtiofsd@hermes-bob[812]: 2026-08-06 10:48:47,228 WARN stopped: notify (terminated by SIGTERM) machine # [ 25.308614] systemd[1]: microvm-virtiofsd@hermes-bob.service: Deactivated successfully. machine # [ 25.310420] systemd[1]: Stopped VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 25.313949] systemd[1]: Stopping Save MicroVM 'hermes-bob' booted configuration... machine # [ 25.356523] systemd[1]: microvm-set-booted@hermes-bob.service: Deactivated successfully. machine # [ 25.357941] systemd[1]: Stopped Save MicroVM 'hermes-bob' booted configuration. machine # [ 25.360953] systemd[1]: Starting Save MicroVM 'hermes-bob' booted configuration... machine # [ 25.476633] systemd[1]: Finished Save MicroVM 'hermes-bob' booted configuration. machine # [ 25.478050] systemd[1]: Setup MicroVM 'hermes-bob' MACVTAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/macvtap-up machine # [ 25.479175] systemd[1]: Setup MicroVM 'hermes-bob' TAP interfaces skipped, unmet condition check ConditionPathExists=/var/lib/microvms/hermes-bob/current/bin/tap-up machine # [ 25.481763] systemd[1]: Starting VirtioFS daemons for MicroVM 'hermes-bob'... machine # [ 26.034715] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:47,987 INFO Set uid to user 0 succeeded machine # [ 26.039134] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:47,992 INFO supervisord started with pid 1184 machine # [ 27.046640] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:48,999 INFO spawned: 'notify' with pid 1204 machine # [ 27.048712] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:49,002 INFO spawned: 'virtiofsd-hermes-exchange' with pid 1205 machine # [ 27.052773] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:49,006 INFO spawned: 'virtiofsd-hermes-state' with pid 1206 machine # [ 27.056655] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:49,010 INFO spawned: 'virtiofsd-host-config' with pid 1207 machine # [ 27.058910] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:49,011 INFO spawned: 'virtiofsd-ro-store' with pid 1208 machine # [ 27.156330] supervisord[1184]: virtiofsd-host-config [2026-08-06T10:48:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 27.160110] supervisord[1184]: virtiofsd-ro-store [2026-08-06T10:48:49Z WARN virtiofsd::passthrough] Filesystem mounted on "/" (mount ID: 308): Filesystem does not support file handles, falling back to O_PATH FDs machine # [ 27.161443] supervisord[1184]: virtiofsd-ro-store [2026-08-06T10:48:49Z WARN virtiofsd::passthrough] Failed to generate a file handle for the root node, disabling file handles altogether machine # [ 27.167659] supervisord[1184]: virtiofsd-ro-store [2026-08-06T10:48:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 27.171555] supervisord[1184]: virtiofsd-hermes-exchange [2026-08-06T10:48:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 27.172877] supervisord[1184]: virtiofsd-hermes-state [2026-08-06T10:48:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [ 28.242289] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:50,190 INFO success: notify entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 28.242891] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:50,190 INFO success: virtiofsd-hermes-exchange entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 28.243158] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:50,190 INFO success: virtiofsd-hermes-state entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 28.243321] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:50,190 INFO success: virtiofsd-host-config entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 28.243485] microvm-virtiofsd@hermes-bob[1184]: 2026-08-06 10:48:50,190 INFO success: virtiofsd-ro-store entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) machine # [ 28.292894] systemd[1]: Started VirtioFS daemons for MicroVM 'hermes-bob'. machine # [ 28.306620] systemd[1]: Starting MicroVM 'hermes-bob'... machine # [ 29.048296] systemd[1]: Started MicroVM 'hermes-bob'. machine # [ 33.429180] supervisord[1184]: virtiofsd-hermes-exchange [2026-08-06T10:48:55Z INFO virtiofsd] Client connected, servicing requests machine # [ 33.431590] supervisord[1184]: virtiofsd-hermes-state [2026-08-06T10:48:55Z INFO virtiofsd] Client connected, servicing requests machine # [ 33.431942] supervisord[1184]: virtiofsd-host-config [2026-08-06T10:48:55Z INFO virtiofsd] Client connected, servicing requests machine # [ 33.447527] supervisord[1184]: virtiofsd-ro-store [2026-08-06T10:48:55Z INFO virtiofsd] Client connected, servicing requests machine # [ 33.454269] microvm@hermes-bob[1283]: microvm@hermes-bob: warning: Number of SMP cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 33.528924] microvm@hermes-bob[1283]: microvm@hermes-bob: warning: Number of hotpluggable cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 35.313609] microvm@hermes-bob[1283]: SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # [ 41.912638] microvm@hermes-bob[1283]: Booting from ROM... machine # [ 41.916508] microvm@hermes-bob[1283]: PPrroobbiinngg EEDDDD ((eedddd==ooffff ttoo ddiissaabbllee))...... ook machine # [ 42.199601] microvm@hermes-bob[1283]: No EFI environment detected. machine # [ 42.202502] microvm@hermes-bob[1283]: early console in extract_kernel machine # [ 42.204440] microvm@hermes-bob[1283]: input_data: 0x0000000003ac42cc machine # [ 42.206242] microvm@hermes-bob[1283]: input_len: 0x0000000000cbc298 machine # [ 42.207805] microvm@hermes-bob[1283]: output: 0x0000000001000000 machine # [ 42.209733] microvm@hermes-bob[1283]: output_len: 0x0000000003728ef8 machine # [ 42.212214] microvm@hermes-bob[1283]: kernel_total_size: 0x0000000002e30000 machine # [ 42.214238] microvm@hermes-bob[1283]: needed_size: 0x0000000003800000 machine # [ 42.216154] microvm@hermes-bob[1283]: trampoline_32bit: 0x0000000000000000 machine # [ 42.218470] microvm@hermes-bob[1283]: Physical KASLR using RDRAND RDTSC... machine # [ 42.220795] microvm@hermes-bob[1283]: Virtual KASLR using RDRAND RDTSC... machine # [ 42.221742] microvm@hermes-bob[1283]: machine # [ 42.223456] microvm@hermes-bob[1283]: Decompressing Linux... No EFI environment detected. machine # [ 42.935834] microvm@hermes-bob[1283]: Parsing ELF... Performing relocations... done. machine # [ 42.938065] microvm@hermes-bob[1283]: Booting the kernel (entry_offset: 0x000000000278d520). machine # [ 42.954792] microvm@hermes-bob[1283]: [ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Aug 3 09:22:13 UTC 2026 machine # [ 42.970071] microvm@hermes-bob[1283]: [ 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/54xw57bq8yp2jrzbgg95g3qr0wsz5x7f-nixos-system-hermes-bob-26.11pre-git/init regInfo=/nix/store/nh1m3rrm9jp752w69idy955xz2n2impm-closure-info/registration machine # [ 42.972225] microvm@hermes-bob[1283]: [ 0.000000] BIOS-provided physical RAM map: machine # [ 42.975771] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 42.979495] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 42.983317] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 42.987066] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bfffdfff] usable machine # [ 42.990767] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x00000000bfffe000-0x00000000bfffffff] reserved machine # [ 42.994764] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 42.998645] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 43.002311] microvm@hermes-bob[1283]: [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable machine # [ 43.005251] microvm@hermes-bob[1283]: [ 0.000000] printk: legacy bootconsole [earlyser0] enabled machine # [ 43.011583] microvm@hermes-bob[1283]: Memory KASLR using RDRAND RDTSC... machine # [ 45.704898] microvm@hermes-bob[1283]: Poking KASLR using RDRAND RDTSC... machine # [ 46.002770] microvm@hermes-bob[1283]: [ 2.909341] PCI: Fatal: No config space access function found machine # [ 52.313198] microvm@hermes-bob[1283]: +q6E616D65Booting initrd of NixOS 26.11 (Zokor) (Initrd). machine # [ 52.632676] microvm@hermes-bob[1283]: [ OK ] Created slice Slice /system/modprobe. machine # [ 52.643575] microvm@hermes-bob[1283]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 52.650149] microvm@hermes-bob[1283]: [ OK ] Reached target Initrd Root Device. machine # [ 52.655884] microvm@hermes-bob[1283]: [ OK ] Reached target Path Units. machine # [ 52.661590] microvm@hermes-bob[1283]: [ OK ] Reached target Slice Units. machine # [ 52.666454] microvm@hermes-bob[1283]: [ OK ] Reached target Swaps. machine # [ 52.671454] microvm@hermes-bob[1283]: [ OK ] Reached target Timer Units. machine # [ 52.677255] microvm@hermes-bob[1283]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 52.683643] microvm@hermes-bob[1283]: [ OK ] Listening on Journal Socket (/dev/log). machine # [ 52.689524] microvm@hermes-bob[1283]: [ OK ] Listening on Journal Sockets. machine # [ 52.695075] microvm@hermes-bob[1283]: [ OK ] Listening on udev Control Socket. machine # [ 52.700493] microvm@hermes-bob[1283]: [ OK ] Listening on udev Kernel Socket. machine # [ 52.705622] microvm@hermes-bob[1283]: [ OK ] Reached target Socket Units. machine # [ 52.713659] microvm@hermes-bob[1283]: Starting Create List of Static Device Nodes... machine # [ 52.720469] microvm@hermes-bob[1283]: Starting Load Kernel Module configfs... machine # [ 52.740120] microvm@hermes-bob[1283]: Starting Journal Service... machine # [ 52.753353] microvm@hermes-bob[1283]: Starting Load Kernel Modules... machine # [ 52.769292] microvm@hermes-bob[1283]: Starting Coldplug All udev Devices... machine # [ 52.787085] microvm@hermes-bob[1283]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 52.800754] microvm@hermes-bob[1283]: [ OK ] Finished Load Kernel Module configfs. machine # [ 52.820493] microvm@hermes-bob[1283]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 52.909684] microvm@hermes-bob[1283]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 52.934154] microvm@hermes-bob[1283]: Starting Create Static Device Nodes in /dev... machine # [ 53.033665] microvm@hermes-bob[1283]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 53.044626] microvm@hermes-bob[1283]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 53.051882] microvm@hermes-bob[1283]: [ OK ] Reached target Local File Systems. machine # [ 53.068275] microvm@hermes-bob[1283]: Starting Rule-based Manager for Device Events and Files... machine # [ 53.106253] microvm@hermes-bob[1283]: [ OK ] Started Journal Service. machine # [ 53.128652] microvm@hermes-bob[1283]: Starting Create System Files and Directories... machine # [ 53.163230] microvm@hermes-bob[1283]: [ OK ] Finished Coldplug All udev Devices. machine # [ 53.212154] microvm@hermes-bob[1283]: [ OK ] Finished Create System Files and Directories. machine # [ 53.316512] microvm@hermes-bob[1283]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 53.738962] microvm@hermes-bob[1283]: Starting Virtual Console Setup... machine # [ 53.792988] microvm@hermes-bob[1283]: Mounting /sysroot... machine # [ 53.837175] microvm@hermes-bob[1283]: [ OK ] Finished Virtual Console Setup. machine # [ 53.862989] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot. machine # [ 53.869193] microvm@hermes-bob[1283]: [ OK ] Reached target Initrd Root File System. machine # [ 53.876221] microvm@hermes-bob[1283]: Starting Mountpoints Configured in the Real Root... machine # [ 54.129813] microvm@hermes-bob[1283]: Starting Load Kernel Module configfs... machine # [ 54.139577] microvm@hermes-bob[1283]: [ OK ] Finished Mountpoints Configured in the Real Root. machine # [ 54.173847] microvm@hermes-bob[1283]: [ OK ] Finished Load Kernel Modules. machine # [ 54.182399] microvm@hermes-bob[1283]: Starting Apply Kernel Variables... machine # [ 54.200250] microvm@hermes-bob[1283]: [ OK ] Finished Load Kernel Module configfs. machine # [ 54.209762] microvm@hermes-bob[1283]: [ OK ] Finished Apply Kernel Variables. machine # [ 54.775294] microvm@hermes-bob[1283]: [ OK ] Reached target System Initialization. machine # [ 54.778097] microvm@hermes-bob[1283]: [ OK ] Reached target Basic System. machine # [ 54.783554] microvm@hermes-bob[1283]: Mounting /sysroot/nix/.ro-store... machine # [ 54.788132] microvm@hermes-bob[1283]: Mounting /sysroot/nix/store... machine # [ 54.803143] microvm@hermes-bob[1283]: Mounting /sysroot/run... machine # [ 54.810527] microvm@hermes-bob[1283]: Mounting /sysroot/var/lib/hermes... machine # [ 54.816615] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot/nix/.ro-store. machine # [ 54.822072] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot/nix/store. machine # [ 54.836641] microvm@hermes-bob[1283]: Starting nix-store-binds.service... machine # [ 54.843815] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot/run. machine # [ 54.854650] microvm@hermes-bob[1283]: Mounting /sysroot/run/hermes-host... machine # [ 54.864302] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot/var/lib/hermes. machine # [ 54.872866] microvm@hermes-bob[1283]: [ OK ] Mounted /sysroot/run/hermes-host. machine # [ 56.402377] microvm@hermes-bob[1283]: [ OK ] Finished nix-store-binds.service. machine # [ 56.408747] microvm@hermes-bob[1283]: [ OK ] Reached target Initrd File Systems. machine # [ 56.416108] microvm@hermes-bob[1283]: Starting Find NixOS closure... machine # [ 56.423182] microvm@hermes-bob[1283]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 56.460734] microvm@hermes-bob[1283]: [ OK ] Finished Create Volatile Files and Directories in the Real Root. machine # [ 56.490543] microvm@hermes-bob[1283]: [ OK ] Finished Find NixOS closure. machine # [ 56.498823] microvm@hermes-bob[1283]: [ OK ] Reached target Initrd Default Target. machine # [ 56.507390] microvm@hermes-bob[1283]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 56.551170] microvm@hermes-bob[1283]: [ OK ] Stopped target Initrd Default Target. machine # [ 56.557264] microvm@hermes-bob[1283]: [ OK ] Stopped target Basic System. machine # [ 56.563461] microvm@hermes-bob[1283]: [ OK ] Stopped target Initrd Root Device. machine # [ 56.569238] microvm@hermes-bob[1283]: [ OK ] Stopped target Path Units. machine # [ 56.574644] microvm@hermes-bob[1283]: [ OK ] Stopped target Slice Units. machine # [ 56.578532] microvm@hermes-bob[1283]: [ OK ] Stopped target Socket Units. machine # [ 56.582504] microvm@hermes-bob[1283]: [ OK ] Stopped target Timer Units. machine # [ 56.587406] microvm@hermes-bob[1283]: [ OK ] Closed D-Bus System Message Bus Socket. machine # [ 56.591800] microvm@hermes-bob[1283]: [ OK ] Stopped Find NixOS closure. machine # [ 56.614202] microvm@hermes-bob[1283]: Starting Load Kernel Module configfs... machine # [ 56.621769] microvm@hermes-bob[1283]: [ OK ] Stopped Create Volatile Files and Directories in the Real Root. machine # [ 56.626718] microvm@hermes-bob[1283]: [ OK ] Stopped Create System Files and Directories. machine # [ 56.631091] microvm@hermes-bob[1283]: [ OK ] Stopped Coldplug All udev Devices. machine # [ 56.636675] microvm@hermes-bob[1283]: Stopping Rule-based Manager for Device Events and Files... machine # [ 56.646984] microvm@hermes-bob[1283]: [ OK ] Stopped Virtual Console Setup. machine # [ 56.662118] microvm@hermes-bob[1283]: [ OK ] Finished Load Kernel Module configfs. machine # [ 56.679983] microvm@hermes-bob[1283]: [ OK ] Finished Cleaning Up and Shutting Down Daemons. machine # [ 56.706221] microvm@hermes-bob[1283]: [ OK ] Stopped Rule-based Manager for Device Events and Files. machine # [ 56.713113] microvm@hermes-bob[1283]: Starting Cleanup udev Database... machine # [ 56.717807] microvm@hermes-bob[1283]: [ OK ] Stopped Create Static Device Nodes in /dev. machine # [ 56.722857] microvm@hermes-bob[1283]: [ OK ] Stopped Create Static Device Nodes in /dev gracefully. machine # [ 56.749210] microvm@hermes-bob[1283]: [ OK ] Finished Cleanup udev Database. machine # [ 56.755111] microvm@hermes-bob[1283]: [ OK ] Reached target Switch Root. machine # [ 56.763135] microvm@hermes-bob[1283]: Starting NixOS Activation... machine # [ 59.028791] microvm@hermes-bob[1283]: [* ] A start job is running for NixOS Activation (2s / no limit) machine # [ 59.402383] microvm@hermes-bob[1283]: [** ] A start job is running for NixOS Activation (2s / no limit) machine # [ 59.986471] microvm@hermes-bob[1283]: [*** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 60.570778] microvm@hermes-bob[1283]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # [ 61.153127] microvm@hermes-bob[1283]: [ *** ] A start job is running for NixOS Activation (4s / no limit) machine # [ 61.737704] microvm@hermes-bob[1283]: [ ***] A start job is running for NixOS Activation (5s / no limit) machine # [ 62.319373] microvm@hermes-bob[1283]: [ **] A start job is running for NixOS Activation (5s / no limit) machine # [ 62.962157] microvm@hermes-bob[1283]: [ *] A start job is running for NixOS Activation (6s / no limit) machine # [ 63.098858] microvm@hermes-bob[1283]: [ OK ] Finished NixOS Activation. machine # [ 63.106588] microvm@hermes-bob[1283]: Starting Switch Root... machine # [ 64.948240] microvm@hermes-bob[1283]: +q6E616D65 machine # [ 64.952352] microvm@hermes-bob[1283]: Welcome to NixOS 26.11 (Zokor)! machine # [ 64.954924] microvm@hermes-bob[1283]: machine # [ 68.719724] microvm@hermes-bob[1283]: [ OK ] Stopped initrd-switch-root.service. machine # [ 68.731593] microvm@hermes-bob[1283]: [ OK ] Created slice Slice /system/getty. machine # [ 68.737579] microvm@hermes-bob[1283]: [ OK ] Created slice Slice /system/serial-getty. machine # [ 68.742394] microvm@hermes-bob[1283]: [ OK ] Created slice User and Session Slice. machine # [ 68.747173] microvm@hermes-bob[1283]: [ OK ] Started Forward Password Requests to Wall Directory Watch. machine # [ 68.751922] microvm@hermes-bob[1283]: [ OK ] Started Daily Cleanup of Temporary Directories. machine # [ 68.755095] microvm@hermes-bob[1283]: Expecting device /dev/ttyS0... machine # [ 68.759238] microvm@hermes-bob[1283]: [ OK ] Reached target Local Encrypted Volumes. machine # [ 68.762789] microvm@hermes-bob[1283]: [ OK ] Stopped target initrd-fs.target. machine # [ 68.766781] microvm@hermes-bob[1283]: [ OK ] Stopped target initrd-root-fs.target. machine # [ 68.771099] microvm@hermes-bob[1283]: [ OK ] Stopped target initrd-switch-root.target. machine # [ 68.775582] microvm@hermes-bob[1283]: [ OK ] Reached target Virtual Machines and Containers. machine # [ 68.779205] microvm@hermes-bob[1283]: [ OK ] Reached target Path Units. machine # [ 68.783259] microvm@hermes-bob[1283]: [ OK ] Reached target Remote File Systems. machine # [ 68.786680] microvm@hermes-bob[1283]: [ OK ] Reached target Slice Units. machine # [ 68.791814] microvm@hermes-bob[1283]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 68.809631] microvm@hermes-bob[1283]: [ OK ] Listening on OpenSSH Server Socket…temd-ssh-generator, AF_UNIX Local). machine # [ 68.832192] microvm@hermes-bob[1283]: [ OK ] Listening on SSH Socket. machine # [ 68.848941] microvm@hermes-bob[1283]: [ OK ] Listening on Query the User Interactively for a Password. machine # [ 68.866167] microvm@hermes-bob[1283]: [ OK ] Listening on Boot Loader Control Service Socket. machine # [ 68.888280] microvm@hermes-bob[1283]: [ OK ] Listening on Process Core Dump Socket. machine # [ 68.905270] microvm@hermes-bob[1283]: [ OK ] Listening on Credential Encryption/Decryption. machine # [ 68.919762] microvm@hermes-bob[1283]: [ OK ] Listening on Factory Reset Management. machine # [ 68.924256] microvm@hermes-bob[1283]: [ OK ] Listening on Hostname Service Socket. machine # [ 68.942951] microvm@hermes-bob[1283]: Starting Journal Log Access Socket... machine # [ 68.949278] microvm@hermes-bob[1283]: [ OK ] Listening on Journal Audit Socket. machine # [ 68.956676] microvm@hermes-bob[1283]: [ OK ] Listening on Virtual Machine and C…tainer Registration Service Socket. machine # [ 68.971182] microvm@hermes-bob[1283]: [ OK ] Listening on Console Output Muting Service Socket. machine # [ 68.977907] microvm@hermes-bob[1283]: [ OK ] Listening on Network Management Resolve Hook Socket. machine # [ 68.985322] microvm@hermes-bob[1283]: [ OK ] Listening on Network Management Metrics Varlink Socket. machine # [ 68.991193] microvm@hermes-bob[1283]: [ OK ] Listening on Network Management Varlink Socket. machine # [ 68.997981] microvm@hermes-bob[1283]: [ OK ] Listening on Network Management Netlink Socket. machine # [ 69.004211] microvm@hermes-bob[1283]: [ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 69.053361] microvm@hermes-bob[1283]: [ OK ] Listening on Disk Repartitioning Service Socket. machine # [ 69.058272] microvm@hermes-bob[1283]: [ OK ] Listening on Resolve Monitor Varlink Socket. machine # [ 69.063164] microvm@hermes-bob[1283]: [ OK ] Listening on Resolve Service Varlink Socket. machine # [ 69.067403] microvm@hermes-bob[1283]: [ OK ] Listening on udev Varlink Socket. machine # [ 69.078393] microvm@hermes-bob[1283]: Mounting Huge Pages File System... machine # [ 69.116055] microvm@hermes-bob[1283]: Mounting POSIX Message Queue File System... machine # [ 69.142425] microvm@hermes-bob[1283]: Mounting /home/bob/hermes... machine # [ 69.193296] microvm@hermes-bob[1283]: Mounting /run/wrappers... machine # [ 69.227454] microvm@hermes-bob[1283]: Mounting Kernel Debug File System... machine # [ 69.313554] microvm@hermes-bob[1283]: Mounting Kernel Trace File System... machine # [ 69.353607] microvm@hermes-bob[1283]: Starting Load Kernel Module configfs... machine # [ 69.477390] microvm@hermes-bob[1283]: Mounting FUSE Control File System... machine # [ 69.487810] microvm@hermes-bob[1283]: [ OK ] Stopped nix-store-binds.service. machine # [ 69.600201] microvm@hermes-bob[1283]: Starting Journal Service... machine # [ 69.741418] microvm@hermes-bob[1283]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 69.789114] microvm@hermes-bob[1283]: Starting Remount Root and Kernel File Systems... machine # [ 69.882708] microvm@hermes-bob[1283]: Starting Network Name Resolution... machine # [ 69.938266] microvm@hermes-bob[1283]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 70.033226] microvm@hermes-bob[1283]: Starting Coldplug All udev Devices... machine # [ 70.241971] microvm@hermes-bob[1283]: [ OK ] Listening on Journal Log Access Socket. machine # [ 70.251471] microvm@hermes-bob[1283]: [ OK ] Mounted Huge Pages File System. machine # [ 70.259812] microvm@hermes-bob[1283]: [ OK ] Mounted POSIX Message Queue File System. machine # [ 70.268498] microvm@hermes-bob[1283]: [ OK ] Mounted /home/bob/hermes. machine # [ 70.273054] microvm@hermes-bob[1283]: [ OK ] Mounted /run/wrappers. machine # [ 70.277157] microvm@hermes-bob[1283]: [ OK ] Mounted Kernel Debug File System. machine # [ 70.280330] microvm@hermes-bob[1283]: [ OK ] Mounted Kernel Trace File System. machine # [ 70.309893] microvm@hermes-bob[1283]: Starting Create SUID/SGID Wrappers... machine # [ 70.426783] microvm@hermes-bob[1283]: [ OK ] Finished Load Kernel Module configfs. machine # [ 70.504808] microvm@hermes-bob[1283]: [ OK ] Mounted FUSE Control File System. machine # [ 70.536622] microvm@hermes-bob[1283]: Mounting Kernel Configuration File System... machine # [ 70.716601] microvm@hermes-bob[1283]: [ OK ] Started Journal Service. machine # [ 70.920474] microvm@hermes-bob[1283]: [ OK ] Finished Remount Root and Kernel File Systems. machine # [ 70.960783] microvm@hermes-bob[1283]: [ OK ] Listening on Disk Image Download Service Socket. machine # [ 70.971651] microvm@hermes-bob[1283]: [ OK ] Reached target Socket Units. machine # [ 70.983351] microvm@hermes-bob[1283]: [ OK ] Reached target Basic System. machine # [ 71.018686] microvm@hermes-bob[1283]: Starting Hermes python venv (pip-writable)... machine # [ 71.103528] microvm@hermes-bob[1283]: Starting Logrotate configuration check... machine # [ 71.159067] microvm@hermes-bob[1283]: Starting Post-Boot Actions... machine # [ 71.304108] microvm@hermes-bob[1283]: [ OK ] Started Reset console on configuration changes. machine # [ 71.358828] microvm@hermes-bob[1283]: Starting Flush Journal to Persistent Storage... machine # [ 71.498666] microvm@hermes-bob[1283]: Starting Load/Save OS Random Seed... machine # [ 71.620868] microvm@hermes-bob[1283]: Starting Network Time Synchronization... machine # [ 71.764361] microvm@hermes-bob[1283]: [ OK ] Finished Coldplug All udev Devices. machine # [ 71.777102] microvm@hermes-bob[1283]: [ OK ] Mounted Kernel Configuration File System. machine # [ 71.903773] microvm@hermes-bob[1283]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 72.010092] microvm@hermes-bob[1283]: Starting Create Static Device Nodes in /dev... machine # [ 72.282834] microvm@hermes-bob[1283]: [ OK ] Finished Logrotate configuration check. machine # [ 72.442936] microvm@hermes-bob[1283]: [ OK ] Finished Post-Boot Actions. machine # [ 72.589275] microvm@hermes-bob[1283]: [ OK ] Finished Flush Journal to Persistent Storage. machine # [ 72.604818] microvm@hermes-bob[1283]: [ OK ] Finished Load/Save OS Random Seed. machine # [ 72.710744] microvm@hermes-bob[1283]: Starting Save Transient machine-id to Disk... machine # [ 72.788234] microvm@hermes-bob[1283]: Starting Create System Files and Directories... machine # [ 73.575097] microvm@hermes-bob[1283]: [ OK ] Finished Save Transient machine-id to Disk. machine # [ 73.590394] microvm@hermes-bob[1283]: [ OK ] Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 73.748111] microvm@hermes-bob[1283]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 73.789939] microvm@hermes-bob[1283]: Starting Rule-based Manager for Device Events and Files... machine # [ 74.031455] microvm@hermes-bob[1283]: [ OK ] Started Network Name Resolution. machine # [ 74.049422] microvm@hermes-bob[1283]: [ OK ] Finished Create System Files and Directories. machine # [ 74.087663] microvm@hermes-bob[1283]: Starting D-Bus System Message Bus... machine # [ 74.171395] microvm@hermes-bob[1283]: Starting Import lastlog data into lastlog2 database... machine # [ 74.209986] microvm@hermes-bob[1283]: Starting Name Service Cache Daemon (nsncd)... machine # [ 74.232833] microvm@hermes-bob[1283]: Starting Rebuild Journal Catalog... machine # [ 74.401928] microvm@hermes-bob[1283]: Starting Record System Boot/Shutdown in UTMP... machine # [ 75.121858] microvm@hermes-bob[1283]: [ OK ] Started Network Time Synchronization. machine # [ 75.296959] microvm@hermes-bob[1283]: [ OK ] Reached target System Time Set. machine # [ 75.344169] microvm@hermes-bob[1283]: [ OK ] Started Discard unused filesystem blocks once a week. machine # [ 75.353857] microvm@hermes-bob[1283]: [ OK ] Started logrotate.timer. machine # [ 75.362777] microvm@hermes-bob[1283]: [ OK ] Reached target Timer Units. machine # [ 75.540183] microvm@hermes-bob[1283]: [ OK ] Finished Record System Boot/Shutdown in UTMP. machine # [ 75.613111] microvm@hermes-bob[1283]: [ OK ] Started Name Service Cache Daemon (nsncd). machine # [ 75.628276] microvm@hermes-bob[1283]: [ OK ] Reached target Host and Network Name Lookups. machine # [ 75.639728] microvm@hermes-bob[1283]: [ OK ] Reached target User and Group Name Lookups. machine # [ 75.665509] microvm@hermes-bob[1283]: Starting User Login Management... machine # [ 75.845608] microvm@hermes-bob[1283]: [ OK ] Started D-Bus System Message Bus. machine # [ 75.986780] microvm@hermes-bob[1283]: [ OK ] Finished Import lastlog data into lastlog2 database. machine # [ 77.081849] microvm@hermes-bob[1283]: [ OK ] Started User Login Management. machine # [ 77.091678] microvm@hermes-bob[1283]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 77.127223] microvm@hermes-bob[1283]: Starting linger-users.service... machine # [ 77.181285] microvm@hermes-bob[1283]: Starting Network Management... machine # [ 77.717130] microvm@hermes-bob[1283]: Starting Virtual Console Setup... machine # [ 77.878204] microvm@hermes-bob[1283]: [ OK ] Finished linger-users.service. machine # [ 78.319554] microvm@hermes-bob[1283]: [ OK ] Finished Create SUID/SGID Wrappers. machine # [ 79.157315] microvm@hermes-bob[1283]: [ OK ] Finished Rebuild Journal Catalog. machine # [ 79.174265] microvm@hermes-bob[1283]: Starting Update is Completed... machine # [ 79.585817] microvm@hermes-bob[1283]: [ OK ] Finished Update is Completed. machine # [ 79.626279] microvm@hermes-bob[1283]: [ OK ] Finished Virtual Console Setup. machine # [ 79.985282] microvm@hermes-bob[1283]: [ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 80.048199] systemd[1]: Started MicroVM 'hermes-alice'. machine # [ 80.051144] systemd[1]: Reached target microvms.target. machine # [ 80.053340] systemd[1]: Reached target Multi-User System. machine # [ 80.056174] systemd[1]: Startup finished in 1.145s (kernel) + 4.807s (initrd) + 1min 14.096s (userspace) = 1min 20.049s. machine # [ 80.157481] microvm@hermes-alice[1763]: microvm@hermes-alice: warning: Number of SMP cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 80.163490] microvm@hermes-alice[1763]: microvm@hermes-alice: warning: Number of hotpluggable cpus requested (8) exceeds the recommended cpus supported by KVM (4) machine # [ 80.175502] supervisord[809]: virtiofsd-hermes-exchange [2026-08-06T10:49:42Z INFO virtiofsd] Client connected, servicing requests machine # [ 80.178120] supervisord[809]: virtiofsd-hermes-state [2026-08-06T10:49:42Z INFO virtiofsd] Client connected, servicing requests machine # [ 80.182343] supervisord[809]: virtiofsd-host-config [2026-08-06T10:49:42Z INFO virtiofsd] Client connected, servicing requests machine # [ 80.186660] supervisord[809]: virtiofsd-ro-store [2026-08-06T10:49:42Z INFO virtiofsd] Client connected, servicing requests machine # [ 80.299259] microvm@hermes-alice[1763]: SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # [ 80.708861] microvm@hermes-bob[1283]: [ OK ] Started Network Management. machine # [ 80.715747] microvm@hermes-bob[1283]: [ OK ] Reached target Network. machine # [ 80.722992] microvm@hermes-bob[1283]: [ OK ] Reached target Network is Online. machine # [ 80.736526] microvm@hermes-bob[1283]: Starting Enable Persistent Storage in systemd-networkd... machine # [ 80.799704] microvm@hermes-bob[1283]: Starting Permit User Sessions... machine: (finished: waiting for unit multi-user.target, in 81.67 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.05 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.03 seconds) machine: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' machine # [ 81.072122] runuser[1797]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 81.091498] runuser[1797]: 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 # [ 81.103606] systemd[1]: Created slice Slice /system/hermes-dashboard-fwd-alice. machine # [ 81.106041] systemd[1]: Started dashboard vsock forward for hermes-alice (127.0.0.1:55590). machine # [ 81.131592] runuser[1802]: 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 # [ 81.150929] runuser[1802]: 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 # [ 81.186566] 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: 92026c51116f43ec807b7e4377e77387 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.04 seconds) machine: waiting for TCP port 9999 on localhost machine # [ 81.266858] microvm@hermes-bob[1283]: [ OK ] Finished Permit User Sessions. machine # Connection to localhost (127.0.0.1) 9999 port [tcp/distinct] succeeded! machine # [ 81.277354] microvm@hermes-bob[1283]: [ OK ] Finished Enable Persistent Storage in systemd-networkd. machine: (finished: waiting for TCP port 9999 on localhost, in 0.09 seconds) machine: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' machine # [ 81.297245] microvm@hermes-bob[1283]: [ OK ] Started Getty on tty1. machine # [ 81.317732] microvm@hermes-bob[1283]: [ OK ] Started Serial Getty on ttyS0. machine # [ 81.324032] microvm@hermes-bob[1283]: [ OK ] Reached target Login Prompts. machine # [ 81.329149] runuser[1819]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 81.345831] runuser[1819]: 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.07 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 # [ 81.383782] runuser[1825]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 82.240985] microvm@hermes-alice[1763]: Booting from ROM... machine # [ 82.245601] microvm@hermes-alice[1763]: PPrroobbiinngg EEDDDD ((eedddd==ooffff ttoo ddiissaabbllee))...... ook machine # bash: connect: Connection refused machine # bash: line 1: /dev/tcp/127.0.0.1/9999: Connection refused machine # [ 82.447681] runuser[1825]: 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.10 seconds) (finished: subtest: dashboard gate on the iptables backend, in 1.53 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.09 seconds) nft: must fail: systemctl cat firewall.service machine # [ 82.540441] microvm@hermes-alice[1763]: No EFI environment detected. machine # [ 82.544767] microvm@hermes-alice[1763]: early console in extract_kernel machine # [ 82.547987] microvm@hermes-alice[1763]: input_data: 0x0000000003ac42cc machine # [ 82.551221] microvm@hermes-alice[1763]: input_len: 0x0000000000cbc298 nft # No files found for firewall.service. machine # [ 82.554128] microvm@hermes-alice[1763]: output: 0x0000000001000000 nft: (finished: must fail: systemctl cat firewall.service, in 0.02 seconds) nft: waiting for unit hermes-firewall.service machine # [ 82.557177] microvm@hermes-alice[1763]: output_len: 0x0000000003728ef8 machine # [ 82.560748] microvm@hermes-alice[1763]: kernel_total_size: 0x0000000002e30000 machine # [ 82.564062] microvm@hermes-alice[1763]: needed_size: 0x0000000003800000 machine # [ 82.567427] microvm@hermes-alice[1763]: trampoline_32bit: 0x0000000000000000 machine # [ 82.570949] microvm@hermes-alice[1763]: Physical KASLR using RDRAND RDTSC... machine # [ 82.574651] microvm@hermes-alice[1763]: Virtual KASLR using RDRAND RDTSC... machine # [ 82.575733] microvm@hermes-alice[1763]: machine # [ 82.577899] microvm@hermes-alice[1763]: Decompressing Linux... No EFI environment detected. nft: (finished: waiting for unit hermes-firewall.service, in 0.04 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.02 seconds) nft: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/22901' nft # [ 82.540216] runuser[780]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 82.553603] runuser[780]: 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 # [ 82.564317] systemd[1]: Created slice Slice /system/hermes-dashboard-fwd-alice. nft # [ 82.567895] systemd[1]: Started dashboard vsock forward for hermes-alice (127.0.0.1:49212). nft # [ 82.587907] runuser[785]: 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 # [ 82.605181] runuser[785]: 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 # [ 82.620151] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:49212.service: Main process exited, code=exited, status=1/FAILURE nft # [ 82.622565] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:49212.service: Failed with result 'exit-code'. nft # [ 82.637341] 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 # Running as unit: marker-probe.service; invocation ID: 72b1d5800c7540d5a5989e6469ff854a 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.04 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.06 seconds) nft: must succeed: runuser -u alice -- bash -c 'exec 3<>/dev/tcp/127.0.0.1/9999' nft # [ 82.728580] runuser[803]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) nft # [ 82.741698] runuser[803]: 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.04 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 # [ 82.767842] runuser[809]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 83.216544] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:55590.service: Main process exited, code=exited, status=1/FAILURE machine # [ 83.220771] systemd[1]: hermes-dashboard-fwd-alice@0-1-127.0.0.1:22901-127.0.0.1:55590.service: Failed with result 'exit-code'. machine # [ 83.368930] microvm@hermes-alice[1763]: Parsing ELF... Performing relocations... done. machine # [ 83.371644] microvm@hermes-alice[1763]: Booting the kernel (entry_offset: 0x000000000278d520). machine # [ 83.391151] microvm@hermes-alice[1763]: [ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Aug 3 09:22:13 UTC 2026 machine # [ 83.409085] microvm@hermes-alice[1763]: [ 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/i3iaxpknlkw44f0mwd8c1ha89wkq9ilw-nixos-system-hermes-alice-26.11pre-git/init regInfo=/nix/store/2g7hwgpi1vxa1cv28xs1fppmqv72wb45-closure-info/registration machine # [ 83.411730] microvm@hermes-alice[1763]: [ 0.000000] BIOS-provided physical RAM map: machine # [ 83.416104] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 83.420534] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 83.424900] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 83.429156] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bfffdfff] usable machine # [ 83.433379] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x00000000bfffe000-0x00000000bfffffff] reserved machine # [ 83.437367] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 83.441340] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 83.445357] microvm@hermes-alice[1763]: [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable machine # [ 83.449383] microvm@hermes-alice[1763]: [ 0.000000] printk: legacy bootconsole [earlyser0] enabled machine # [ 83.456621] microvm@hermes-alice[1763]: Memory KASLR using RDRAND RDTSC... nft # bash: connect: Connection refused nft # bash: line 1: /dev/tcp/127.0.0.1/9999: Connection refused nft # [ 83.824631] runuser[809]: 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.08 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.15 seconds) machine: waiting for unit microvm@hermes-bob.service machine: (finished: waiting for unit microvm@hermes-bob.service, in 0.16 seconds) machine: waiting for success: runuser -u alice -- hermes --version machine # [ 84.275486] runuser[1844]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 86.200381] microvm@hermes-alice[1763]: Poking KASLR using RDRAND RDTSC... 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 # [ 86.485339] runuser[1844]: pam_unix(runuser:session): session closed for user alice machine # [ 86.528485] microvm@hermes-alice[1763]: [ 2.996444] PCI: Fatal: No config space access function found machine # [ 87.549898] runuser[1854]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 88.733209] microvm@hermes-bob[1283]: +q6E616D65 machine # [ 88.734518] microvm@hermes-bob[1283]: machine # [ 88.743576] microvm@hermes-bob[1283]: <<< Welcome to NixOS 26.11pre-git (x86_64) - ttyS0 >>> machine # [ 88.744762] microvm@hermes-bob[1283]: machine # [ 88.747499] microvm@hermes-bob[1283]: Run 'nixos-help' for the NixOS manual. machine # [ 88.748800] microvm@hermes-bob[1283]: 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.683255] runuser[1854]: pam_unix(runuser:session): session closed for user alice machine # [ 90.881052] runuser[1864]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) 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 # [ 93.095615] runuser[1864]: pam_unix(runuser:session): session closed for user alice machine # [ 93.609665] microvm@hermes-alice[1763]: +q6E616D65Booting initrd of NixOS 26.11 (Zokor) (Initrd). machine # [ 94.130235] microvm@hermes-alice[1763]: [ OK ] Created slice Slice /system/modprobe. machine # [ 94.140576] microvm@hermes-alice[1763]: [ OK ] Started Dispatch Password Requests to Console Directory Watch. machine # [ 94.147939] microvm@hermes-alice[1763]: [ OK ] Reached target Initrd Root Device. machine # [ 94.153581] microvm@hermes-alice[1763]: [ OK ] Reached target Path Units. machine # [ 94.159156] microvm@hermes-alice[1763]: [ OK ] Reached target Slice Units. machine # [ 94.164326] microvm@hermes-alice[1763]: [ OK ] Reached target Swaps. machine # [ 94.168447] microvm@hermes-alice[1763]: [ OK ] Reached target Timer Units. machine # [ 94.174787] microvm@hermes-alice[1763]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 94.180513] microvm@hermes-alice[1763]: [ OK ] Listening on Journal Socket (/dev/log). machine # [ 94.185138] microvm@hermes-alice[1763]: [ OK ] Listening on Journal Sockets. machine # [ 94.194198] microvm@hermes-alice[1763]: [ OK ] Listening on udev Control Socket. machine # [ 94.200222] microvm@hermes-alice[1763]: [ OK ] Listening on udev Kernel Socket. machine # [ 94.204485] microvm@hermes-alice[1763]: [ OK ] Reached target Socket Units. machine # [ 94.215626] microvm@hermes-alice[1763]: Starting Create List of Static Device Nodes... machine # [ 94.230061] microvm@hermes-alice[1763]: Starting Load Kernel Module configfs... machine # [ 94.266816] microvm@hermes-alice[1763]: Starting Journal Service... machine # [ 94.289531] microvm@hermes-alice[1763]: Starting Load Kernel Modules... machine # [ 94.305238] runuser[1874]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 94.309898] microvm@hermes-alice[1763]: Starting Coldplug All udev Devices... machine # [ 94.340048] microvm@hermes-alice[1763]: [ OK ] Finished Create List of Static Device Nodes. machine # [ 94.352925] microvm@hermes-alice[1763]: [ OK ] Finished Load Kernel Module configfs. machine # [ 94.374115] microvm@hermes-alice[1763]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 94.504254] microvm@hermes-alice[1763]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 94.522876] microvm@hermes-alice[1763]: Starting Create Static Device Nodes in /dev... machine # [ 94.580691] microvm@hermes-alice[1763]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 94.596874] microvm@hermes-alice[1763]: [ OK ] Reached target Preparation for Local File Systems. machine # [ 94.611347] microvm@hermes-alice[1763]: [ OK ] Reached target Local File Systems. machine # [ 94.636522] microvm@hermes-alice[1763]: Starting Rule-based Manager for Device Events and Files... machine # [ 94.737326] microvm@hermes-alice[1763]: [ OK ] Finished Coldplug All udev Devices. machine # [ 94.752325] microvm@hermes-alice[1763]: [ OK ] Started Journal Service. machine # [ 94.772128] microvm@hermes-alice[1763]: Starting Create System Files and Directories... machine # [ 94.828167] microvm@hermes-alice[1763]: [ OK ] Finished Create System Files and Directories. machine # [ 94.841440] microvm@hermes-alice[1763]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 95.220621] microvm@hermes-alice[1763]: Starting Virtual Console Setup... machine # [ 95.356301] microvm@hermes-alice[1763]: Mounting /sysroot... machine # [ 95.402727] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot. machine # [ 95.427995] microvm@hermes-alice[1763]: [ OK ] Reached target Initrd Root File System. machine # [ 95.471926] microvm@hermes-alice[1763]: Mounting /sysroot/nix/store... machine # [ 95.485836] microvm@hermes-alice[1763]: Mounting /sysroot/run... machine # [ 95.505923] microvm@hermes-alice[1763]: Starting Mountpoints Configured in the Real Root... machine # [ 95.536838] microvm@hermes-alice[1763]: [ OK ] Finished Virtual Console Setup. machine # [ 95.543270] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot/run. machine # [ 96.156424] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot/nix/store. machine # [ 96.171992] microvm@hermes-alice[1763]: Starting Load Kernel Module configfs... machine # [ 96.276132] microvm@hermes-alice[1763]: [ OK ] Finished Mountpoints Configured in the Real Root. machine # [ 96.291047] microvm@hermes-alice[1763]: [ OK ] Finished Load Kernel Module configfs. 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 # [ 96.534911] runuser[1874]: pam_unix(runuser:session): session closed for user alice machine # [ 96.673099] microvm@hermes-alice[1763]: [ OK ] Finished Load Kernel Modules. machine # [ 96.679167] microvm@hermes-alice[1763]: Mounting /sysroot/nix/.ro-store... machine # [ 96.694576] microvm@hermes-alice[1763]: Mounting /sysroot/run/hermes-host... machine # [ 96.706848] microvm@hermes-alice[1763]: Mounting /sysroot/var/lib/hermes... machine # [ 96.716274] microvm@hermes-alice[1763]: Starting Apply Kernel Variables... machine # [ 96.726422] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot/nix/.ro-store. machine # [ 96.736611] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot/run/hermes-host. machine # [ 96.757462] microvm@hermes-alice[1763]: [ OK ] Finished Apply Kernel Variables. machine # [ 96.767957] microvm@hermes-alice[1763]: [ OK ] Mounted /sysroot/var/lib/hermes. machine # [ 96.777608] microvm@hermes-alice[1763]: [ OK ] Reached target System Initialization. machine # [ 96.783991] microvm@hermes-alice[1763]: [ OK ] Reached target Basic System. machine # [ 96.791954] microvm@hermes-alice[1763]: Starting nix-store-binds.service... machine # [ 97.605299] runuser[1884]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 98.107536] microvm@hermes-alice[1763]: [ OK ] Finished nix-store-binds.service. machine # [ 98.124887] microvm@hermes-alice[1763]: [ OK ] Reached target Initrd File Systems. machine # [ 98.156966] microvm@hermes-alice[1763]: Starting Find NixOS closure... machine # [ 98.174401] microvm@hermes-alice[1763]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 98.244986] microvm@hermes-alice[1763]: [ OK ] Finished Create Volatile Files and Directories in the Real Root. machine # [ 98.324412] microvm@hermes-alice[1763]: [ OK ] Finished Find NixOS closure. machine # [ 98.333429] microvm@hermes-alice[1763]: [ OK ] Reached target Initrd Default Target. machine # [ 98.353124] microvm@hermes-alice[1763]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 98.416507] microvm@hermes-alice[1763]: [ OK ] Stopped target Initrd Default Target. machine # [ 98.421633] microvm@hermes-alice[1763]: [ OK ] Stopped target Basic System. machine # [ 98.432366] microvm@hermes-alice[1763]: [ OK ] Stopped target Initrd Root Device. machine # [ 98.434755] microvm@hermes-alice[1763]: [ OK ] Stopped target Path Units. machine # [ 98.444676] microvm@hermes-alice[1763]: [ OK ] Stopped target Slice Units. machine # [ 98.464306] microvm@hermes-alice[1763]: [ OK ] Stopped target Socket Units. machine # [ 98.464740] microvm@hermes-alice[1763]: [ OK ] Stopped target Timer Units. machine # [ 98.476659] microvm@hermes-alice[1763]: [ OK ] Closed D-Bus System Message Bus Socket. machine # [ 98.480841] microvm@hermes-alice[1763]: [ OK ] Stopped Find NixOS closure. machine # [ 98.491867] microvm@hermes-alice[1763]: Starting Load Kernel Module configfs... machine # [ 98.513035] microvm@hermes-alice[1763]: [ OK ] Stopped Create Volatile Files and Directories in the Real Root. machine # [ 98.521473] microvm@hermes-alice[1763]: [ OK ] Stopped Create System Files and Directories. machine # [ 98.526577] microvm@hermes-alice[1763]: [ OK ] Stopped Coldplug All udev Devices. machine # [ 98.550182] microvm@hermes-alice[1763]: Stopping Rule-based Manager for Device Events and Files... machine # [ 98.583239] microvm@hermes-alice[1763]: [ OK ] Stopped Virtual Console Setup. machine # [ 98.596962] microvm@hermes-alice[1763]: [ OK ] Finished Load Kernel Module configfs. machine # [ 98.622353] microvm@hermes-alice[1763]: [ OK ] Finished Cleaning Up and Shutting Down Daemons. machine # [ 98.645233] microvm@hermes-alice[1763]: [ OK ] Stopped Rule-based Manager for Device Events and Files. machine # [ 98.665292] microvm@hermes-alice[1763]: Starting Cleanup udev Database... machine # [ 98.672155] microvm@hermes-alice[1763]: [ OK ] Stopped Create Static Device Nodes in /dev. machine # [ 98.678335] microvm@hermes-alice[1763]: [ OK ] Stopped Create Static Device Nodes in /dev gracefully. machine # [ 98.695266] microvm@hermes-alice[1763]: [ OK ] Finished Cleanup udev Database. machine # [ 98.700604] microvm@hermes-alice[1763]: [ OK ] Reached target Switch Root. machine # [ 98.706595] microvm@hermes-alice[1763]: 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 # [ 99.734896] runuser[1884]: pam_unix(runuser:session): session closed for user alice machine # [ 100.792393] runuser[1894]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 100.962297] microvm@hermes-alice[1763]: [* ] A start job is running for NixOS Activation (2s / no limit) machine # [ 101.342505] microvm@hermes-alice[1763]: [** ] A start job is running for NixOS Activation (2s / no limit) machine # [ 101.773969] microvm@hermes-alice[1763]: [*** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 102.133677] microvm@hermes-alice[1763]: [ *** ] A start job is running for NixOS Activation (3s / no limit) machine # [ 102.717309] microvm@hermes-alice[1763]: [ *** ] 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 # [ 102.933574] runuser[1894]: pam_unix(runuser:session): session closed for user alice machine # [ 103.300902] microvm@hermes-alice[1763]: [ ***] A start job is running for NixOS Activation (4s / no limit) machine # [ 103.884739] microvm@hermes-alice[1763]: [ **] A start job is running for NixOS Activation (5s / no limit) machine # [ 103.983650] runuser[1904]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 104.466324] microvm@hermes-alice[1763]: [ *] A start job is running for NixOS Activation (6s / no limit) machine # [ 105.049270] microvm@hermes-alice[1763]: [ **] A start job is running for NixOS Activation (6s / no limit) machine # [ 105.641098] microvm@hermes-alice[1763]: [ ***] A start job is running for NixOS Activation (7s / 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 # [ 106.066161] runuser[1904]: pam_unix(runuser:session): session closed for user alice machine # [ 106.225440] microvm@hermes-alice[1763]: [ *** ] A start job is running for NixOS Activation (7s / no limit) machine # [ 106.806942] microvm@hermes-alice[1763]: [ *** ] A start job is running for NixOS Activation (8s / no limit) machine # [ 107.106204] runuser[1914]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 107.221064] microvm@hermes-alice[1763]: [*** ] A start job is running for NixOS Activation (8s / no limit) machine # [ 107.226385] microvm@hermes-alice[1763]: [ OK ] Finished NixOS Activation. machine # [ 107.233720] microvm@hermes-alice[1763]: Starting Switch Root... 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 # [ 108.920285] runuser[1914]: pam_unix(runuser:session): session closed for user alice machine # [ 109.970592] runuser[1924]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 110.017478] microvm@hermes-alice[1763]: +q6E616D65 machine # [ 110.022320] microvm@hermes-alice[1763]: Welcome to NixOS 26.11 (Zokor)! machine # [ 110.025122] microvm@hermes-alice[1763]: 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 # [ 110.046434] runuser[1924]: pam_unix(runuser:session): session closed for user alice machine # [ 111.095644] runuser[1934]: 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 # [ 111.165741] runuser[1934]: pam_unix(runuser:session): session closed for user alice machine # [ 112.215157] runuser[1944]: 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 # [ 112.283739] runuser[1944]: pam_unix(runuser:session): session closed for user alice machine # [ 113.408518] runuser[1954]: 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 # [ 113.630611] runuser[1954]: pam_unix(runuser:session): session closed for user alice machine # [ 114.675960] runuser[1964]: 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 # [ 114.753720] runuser[1964]: pam_unix(runuser:session): session closed for user alice machine # [ 115.796563] runuser[1974]: 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 # [ 115.868673] runuser[1974]: pam_unix(runuser:session): session closed for user alice machine # [ 116.653672] microvm@hermes-alice[1763]: [ OK ] Stopped initrd-switch-root.service. machine # [ 116.672107] microvm@hermes-alice[1763]: [ OK ] Created slice Slice /system/getty. machine # [ 116.681111] microvm@hermes-alice[1763]: [ OK ] Created slice Slice /system/serial-getty. machine # [ 116.693101] microvm@hermes-alice[1763]: [ OK ] Created slice User and Session Slice. machine # [ 116.700332] microvm@hermes-alice[1763]: [ OK ] Started Forward Password Requests to Wall Directory Watch. machine # [ 116.710105] microvm@hermes-alice[1763]: [ OK ] Started Daily Cleanup of Temporary Directories. machine # [ 116.713593] microvm@hermes-alice[1763]: Expecting device /dev/ttyS0... machine # [ 116.722276] microvm@hermes-alice[1763]: [ OK ] Reached target Local Encrypted Volumes. machine # [ 116.726770] microvm@hermes-alice[1763]: [ OK ] Stopped target initrd-fs.target. machine # [ 116.736191] microvm@hermes-alice[1763]: [ OK ] Stopped target initrd-root-fs.target. machine # [ 116.742971] microvm@hermes-alice[1763]: [ OK ] Stopped target initrd-switch-root.target. machine # [ 116.750732] microvm@hermes-alice[1763]: [ OK ] Reached target Virtual Machines and Containers. machine # [ 116.756652] microvm@hermes-alice[1763]: [ OK ] Reached target Path Units. machine # [ 116.763556] microvm@hermes-alice[1763]: [ OK ] Reached target Remote File Systems. machine # [ 116.770287] microvm@hermes-alice[1763]: [ OK ] Reached target Slice Units. machine # [ 116.777666] microvm@hermes-alice[1763]: [ OK ] Listening on D-Bus System Message Bus Socket. machine # [ 116.804068] microvm@hermes-alice[1763]: [ OK ] Listening on OpenSSH Server Socket…temd-ssh-generator, AF_UNIX Local). machine # [ 116.830828] microvm@hermes-alice[1763]: [ OK ] Listening on SSH Socket. machine # [ 116.850969] microvm@hermes-alice[1763]: [ OK ] Listening on Query the User Interactively for a Password. machine # [ 116.867952] microvm@hermes-alice[1763]: [ OK ] Listening on Boot Loader Control Service Socket. machine # [ 116.905820] microvm@hermes-alice[1763]: [ OK ] Listening on Process Core Dump Socket. machine # [ 116.926375] microvm@hermes-alice[1763]: [ OK ] Listening on Credential Encryption/Decryption. machine # [ 116.930664] runuser[1984]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 116.947520] microvm@hermes-alice[1763]: [ OK ] Listening on Factory Reset Management. machine # [ 116.955758] microvm@hermes-alice[1763]: [ OK ] Listening on Hostname Service Socket. machine # [ 116.982600] microvm@hermes-alice[1763]: Starting Journal Log Access Socket... machine # [ 116.989360] microvm@hermes-alice[1763]: [ OK ] Listening on Journal Audit Socket. machine # [ 116.997398] microvm@hermes-alice[1763]: [ OK ] Listening on Virtual Machine and C…tainer Registration Service Socket. machine # [ 117.033527] microvm@hermes-alice[1763]: [ OK ] Listening on Console Output Muting Service Socket. machine # [ 117.040532] microvm@hermes-alice[1763]: [ OK ] Listening on Network Management Resolve Hook Socket. machine # [ 117.046565] microvm@hermes-alice[1763]: [ OK ] Listening on Network Management Metrics Varlink Socket. machine # [ 117.053569] microvm@hermes-alice[1763]: [ OK ] Listening on Network Management Varlink Socket. machine # [ 117.062548] microvm@hermes-alice[1763]: [ OK ] Listening on Network Management Netlink Socket. machine # [ 117.067323] microvm@hermes-alice[1763]: [ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 117.150239] microvm@hermes-alice[1763]: [ OK ] Listening on Disk Repartitioning Service Socket. machine # [ 117.156518] microvm@hermes-alice[1763]: [ OK ] Listening on Resolve Monitor Varlink Socket. machine # [ 117.163919] microvm@hermes-alice[1763]: [ OK ] Listening on Resolve Service Varlink Socket. machine # [ 117.170607] microvm@hermes-alice[1763]: [ OK ] Listening on udev Varlink Socket. machine # [ 117.180586] microvm@hermes-alice[1763]: Mounting Huge Pages File System... machine # [ 117.200798] microvm@hermes-alice[1763]: Mounting POSIX Message Queue File System... machine # [ 117.316450] microvm@hermes-alice[1763]: Mounting /home/alice/hermes... machine # [ 117.426958] microvm@hermes-alice[1763]: Mounting /run/wrappers... machine # [ 117.548359] microvm@hermes-alice[1763]: Mounting Kernel Debug File System... machine # [ 117.575977] microvm@hermes-alice[1763]: Mounting Kernel Trace File System... machine # [ 117.719643] microvm@hermes-alice[1763]: Starting Load Kernel Module configfs... machine # [ 117.814559] microvm@hermes-alice[1763]: Mounting FUSE Control File System... machine # [ 117.907800] microvm@hermes-alice[1763]: [ OK ] Stopped nix-store-binds.service. machine # [ 118.001784] microvm@hermes-alice[1763]: Starting Journal Service... machine # [ 118.175197] microvm@hermes-alice[1763]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 118.231672] microvm@hermes-alice[1763]: Starting Remount Root and Kernel File Systems... machine # [ 118.378453] microvm@hermes-alice[1763]: Starting Network Name Resolution... machine # [ 118.657192] microvm@hermes-alice[1763]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 118.759945] microvm@hermes-alice[1763]: Starting Coldplug All udev Devices... machine # [ 118.911360] microvm@hermes-alice[1763]: [ OK ] Listening on Journal Log Access Socket. machine # [ 118.925780] microvm@hermes-alice[1763]: [ OK ] Mounted Huge Pages File System. machine # [ 118.936841] microvm@hermes-alice[1763]: [ OK ] Mounted POSIX Message Queue File System. machine # [ 118.943377] microvm@hermes-alice[1763]: [ OK ] Mounted /home/alice/hermes. machine # [ 118.954699] microvm@hermes-alice[1763]: [ OK ] Mounted /run/wrappers. machine # [ 118.967295] microvm@hermes-alice[1763]: [ OK ] Mounted Kernel Debug File System. machine # [ 118.984292] microvm@hermes-alice[1763]: [ OK ] Mounted Kernel Trace File System. machine # [ 119.019929] microvm@hermes-alice[1763]: [ OK ] Finished Load Kernel Module configfs. machine # [ 119.104857] microvm@hermes-alice[1763]: [ OK ] Mounted FUSE Control File System. machine # [ 119.116851] microvm@hermes-alice[1763]: [ OK ] Created slice Slice /system/sshd. machine # [ 119.142451] microvm@hermes-alice[1763]: Mounting Kernel Configuration File System... machine # [ 119.299791] microvm@hermes-alice[1763]: Starting Create SUID/SGID Wrappers... machine # [ 119.830226] microvm@hermes-alice[1763]: [ OK ] Started Journal Service. machine # [ 119.886951] microvm@hermes-alice[1763]: [ OK ] Finished Remount Root and Kernel File Systems. machine # [ 119.935804] microvm@hermes-alice[1763]: [ OK ] Listening on Disk Image Download Service Socket. machine # [ 119.944914] microvm@hermes-alice[1763]: [ OK ] Reached target Socket Units. machine # [ 119.953945] microvm@hermes-alice[1763]: [ OK ] Reached target Basic System. machine # [ 119.988829] microvm@hermes-alice[1763]: Starting Hermes python venv (pip-writable)... machine # [ 120.024337] microvm@hermes-alice[1763]: Starting Logrotate configuration check... machine # [ 120.176809] microvm@hermes-alice[1763]: Starting Post-Boot Actions... machine # [ 120.322238] microvm@hermes-alice[1763]: [ OK ] Started Reset console on configuration changes. machine # [ 120.411841] microvm@hermes-alice[1763]: Starting Flush Journal to Persistent Storage... machine # [ 120.465449] microvm@hermes-alice[1763]: Starting Load/Save OS Random Seed... machine # [ 120.640241] microvm@hermes-alice[1763]: Starting Network Time Synchronization... machine # [ 120.810067] microvm@hermes-alice[1763]: [ OK ] Finished Coldplug All udev Devices. machine # [ 120.841586] microvm@hermes-alice[1763]: [ OK ] Mounted Kernel Configuration File System. machine # [ 121.224288] microvm@hermes-alice[1763]: [ OK ] Finished Create Static Device Nodes in /dev gracefully. machine # [ 121.341121] microvm@hermes-alice[1763]: Starting Create Static Device Nodes in /dev... machine # [ 121.353181] microvm@hermes-alice[1763]: [ OK ] Finished Logrotate configuration check. machine # [ 121.750191] microvm@hermes-alice[1763]: [ OK ] Finished Load/Save OS Random Seed. machine # [ 121.797140] microvm@hermes-alice[1763]: [ OK ] Finished Post-Boot Actions. machine # [ 121.883507] microvm@hermes-alice[1763]: Starting Save Transient machine-id to Disk... machine # [ 121.905848] microvm@hermes-alice[1763]: [ OK ] Finished Flush Journal to Persistent Storage. machine # [ 122.097863] microvm@hermes-alice[1763]: Starting Create System Files and Directories... machine # [ 123.047657] microvm@hermes-alice[1763]: [ OK ] Finished Save Transient machine-id to Disk. machine # [ 123.500872] microvm@hermes-alice[1763]: [ OK ] Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 123.773242] microvm@hermes-alice[1763]: [ OK ] Finished Create Static Device Nodes in /dev. machine # [ 123.857910] microvm@hermes-alice[1763]: Starting Rule-based Manager for Device Events and Files... machine # [ 124.127088] microvm@hermes-alice[1763]: [ OK ] Finished Create System Files and Directories. machine # [ 124.174111] microvm@hermes-alice[1763]: [ OK ] Started Network Name Resolution. machine # [ 124.194227] microvm@hermes-alice[1763]: Starting D-Bus System Message Bus... machine # [ 124.295724] microvm@hermes-alice[1763]: Starting Import lastlog data into lastlog2 database... machine # [ 124.350644] microvm@hermes-alice[1763]: Starting Name Service Cache Daemon (nsncd)... machine # [ 124.456109] microvm@hermes-alice[1763]: Starting Rebuild Journal Catalog... machine # [ 124.508816] microvm@hermes-alice[1763]: Starting Record System Boot/Shutdown in UTMP... machine # [ 125.822320] microvm@hermes-alice[1763]: [ OK ] Finished Record System Boot/Shutdown in UTMP. machine # [ 126.079573] microvm@hermes-alice[1763]: [ OK ] Started Network Time Synchronization. machine # [ 126.089869] microvm@hermes-alice[1763]: [ OK ] Reached target System Time Set. machine # [ 126.105549] microvm@hermes-alice[1763]: [ OK ] Started Discard unused filesystem blocks once a week. machine # [ 126.111533] microvm@hermes-alice[1763]: [ OK ] Started logrotate.timer. machine # [ 126.118679] microvm@hermes-alice[1763]: [ OK ] Reached target Timer Units. machine # [ 126.127114] microvm@hermes-alice[1763]: [ OK ] Started Name Service Cache Daemon (nsncd). machine # [ 126.143719] microvm@hermes-alice[1763]: [ OK ] Reached target Host and Network Name Lookups. machine # [ 126.156185] microvm@hermes-alice[1763]: [ OK ] Reached target User and Group Name Lookups. machine # [ 126.202947] microvm@hermes-alice[1763]: Starting User Login Management... machine # [ 126.433863] microvm@hermes-alice[1763]: [ OK ] Finished Import lastlog data into lastlog2 database. machine # [ 126.649122] microvm@hermes-alice[1763]: [ OK ] Started D-Bus System Message Bus. machine # [ 128.605246] microvm@hermes-alice[1763]: [ OK ] Started Rule-based Manager for Device Events and Files. machine # [ 128.671168] microvm@hermes-alice[1763]: Starting Network Management... machine # [ 128.750959] microvm@hermes-alice[1763]: [ OK ] Started User Login Management. machine # [ 128.847696] microvm@hermes-alice[1763]: Starting linger-users.service... machine # [ 129.970399] microvm@hermes-alice[1763]: [ OK ] Finished linger-users.service. machine # [ 130.299942] microvm@hermes-alice[1763]: [ OK ] Finished Create SUID/SGID Wrappers. machine # [ 131.712214] microvm@hermes-alice[1763]: Starting Virtual Console Setup... machine # [ 132.129609] microvm@hermes-alice[1763]: [ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 132.178536] microvm@hermes-alice[1763]: [ OK ] Finished Rebuild Journal Catalog. machine # [ 132.223252] microvm@hermes-alice[1763]: Starting Update is Completed... machine # [ 133.039507] microvm@hermes-alice[1763]: [ OK ] Finished Update is Completed. machine # [ 135.103773] microvm@hermes-alice[1763]: [* ] (1 of 3) A start job is running for…nv (pip-writable) (18s / no limit) machine # [ 135.114400] microvm@hermes-alice[1763]: [ OK ] Finished Virtual Console Setup. machine # [ 135.267869] microvm@hermes-alice[1763]: [ OK ] Started Network Management. machine # [ 135.279883] microvm@hermes-alice[1763]: [ OK ] Reached target Network. machine # [ 135.293714] microvm@hermes-alice[1763]: [ OK ] Reached target Network is Online. machine # [ 135.319783] microvm@hermes-alice[1763]: [ OK ] Started SSH per-connection Daemon (vsock:2:1445999278). machine # [ 135.487372] microvm@hermes-alice[1763]: Starting Enable Persistent Storage in systemd-networkd... machine # [ 135.530523] microvm@hermes-alice[1763]: Starting Permit User Sessions... machine # [ 136.353779] microvm@hermes-alice[1763]: [ OK ] Finished Enable Persistent Storage in systemd-networkd. machine # [ 136.368856] microvm@hermes-alice[1763]: [ OK ] Finished Permit User Sessions. machine # [ 136.396222] microvm@hermes-alice[1763]: [ OK ] Started Getty on tty1. machine # [ 136.571283] microvm@hermes-alice[1763]: [ OK ] Started Serial Getty on ttyS0. machine # [ 136.584851] microvm@hermes-alice[1763]: [ OK ] Reached target Login Prompts. machine # [ 137.407216] microvm@hermes-alice[1763]: [ OK ] Created slice Slice /user/1000. machine # [ 137.435565] microvm@hermes-alice[1763]: Starting User Runtime Directory /run/user/1000... machine # [ 138.205787] microvm@hermes-alice[1763]: [ OK ] Finished User Runtime Directory /run/user/1000. machine # [ 138.241429] microvm@hermes-alice[1763]: Starting User Manager for UID 1000... machine # [ 144.036099] microvm@hermes-alice[1763]: +q6E616D65 machine # [ 144.039240] microvm@hermes-alice[1763]: machine # [ 144.042336] microvm@hermes-alice[1763]: <<< Welcome to NixOS 26.11pre-git (x86_64) - ttyS0 >>> machine # [ 144.043508] microvm@hermes-alice[1763]: machine # [ 144.044925] microvm@hermes-alice[1763]: Run 'nixos-help' for the NixOS manual. machine # [ 144.047322] microvm@hermes-alice[1763]: machine # [ 172.937221] runuser[1984]: pam_unix(runuser:session): session closed for user alice machine: (finished: waiting for success: runuser -u alice -- hermes --version, in 88.72 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.03 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.04 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 # [ 173.063157] runuser[2000]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 174.933648] runuser[2000]: 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 1.92 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 # [ 174.990303] runuser[2003]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 177.899804] runuser[2003]: 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 2.96 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 # [ 177.963340] runuser[2008]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 180.101099] runuser[2008]: 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 2.25 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 # [ 180.576386] runuser[2013]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 187.073914] runuser[2013]: 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 6.93 seconds) (finished: subtest: guest python contract, in 12.13 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 # [ 187.110910] runuser[2018]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 188.312694] runuser[2018]: 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 1.24 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 # [ 188.356488] runuser[2023]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 189.923613] runuser[2023]: 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 1.61 seconds) (finished: subtest: brain: credentials only, never a model pin, in 2.85 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 # [ 189.987511] runuser[2031]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 190.164907] systemd[1]: Created slice Slice /system/hermes-spaces-bridge-alice. machine # [ 190.167726] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:1393721435). machine # [ 190.200802] hermes-vsock-spaces-bridge[2036]: connect /run/user/1000/spaces-integration-gateway.sock: No such file or directory (os error 2) machine # [ 190.203515] systemd[1]: hermes-spaces-bridge-alice@0-4097-2:735578825-735577804:1393721435.service: Main process exited, code=exited, status=1/FAILURE machine # [ 190.207429] systemd[1]: hermes-spaces-bridge-alice@0-4097-2:735578825-735577804:1393721435.service: Failed with result 'exit-code'. machine # [ 191.175550] runuser[2031]: 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 1.22 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 # [ 191.218285] runuser[2039]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 192.550440] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:1393721436). machine # [ 192.584802] hermes-vsock-spaces-bridge[2044]: connect /run/user/1000/spaces-integration-gateway.sock: No such file or directory (os error 2) machine # [ 192.588280] systemd[1]: hermes-spaces-bridge-alice@1-8193-2:735578825-735577804:1393721436.service: Main process exited, code=exited, status=1/FAILURE machine # [ 192.592663] systemd[1]: hermes-spaces-bridge-alice@1-8193-2:735578825-735577804:1393721436.service: Failed with result 'exit-code'. machine # [ 192.728137] runuser[2039]: 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 1.56 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 # [ 192.773740] runuser[2047]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 194.130226] runuser[2047]: 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 1.40 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.03 seconds) (finished: subtest: virtiofs uid translation: guest 1000 <-> runtime host uid, in 4.23 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.03 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 # [ 194.218668] 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: a18361b98a404198b0e6e9de75d2c3ea 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: (finished: waiting for success: test -S /run/user/1000/spaces-integration-gateway.sock, in 1.05 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 # [ 195.304332] runuser[2071]: pam_unix(runuser:session): session opened for user alice(uid=1000) by (uid=0) machine # [ 195.873449] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:1393721437). machine # [ 195.941910] systemd[1]: hermes-spaces-bridge-alice@2-4098-2:735578825-735577804:1393721437.service: Deactivated successfully. machine # [ 196.741164] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:1393721438). machine # [ 196.775895] systemd[1]: hermes-spaces-bridge-alice@3-8194-2:735578825-735577804:1393721438.service: Deactivated successfully. machine # [ 196.797487] runuser[2071]: 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 1.53 seconds) (finished: subtest: spaces bridge: own VM passes the peer-CID gate, in 2.64 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 # [ 196.832746] runuser[2088]: pam_unix(runuser:session): session opened for user bob(uid=1001) by (uid=0) machine # [ 200.968447] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:735577804:1393721439). machine # [ 201.019521] systemd[1]: hermes-spaces-bridge-alice@4-8195-2:735578825-735577804:1393721439.service: Deactivated successfully. machine # [ 212.249045] systemd[1]: Started spaces gateway bridge for hermes-alice (vsock:2176202715:2534307017). machine # [ 212.291543] hermes-vsock-spaces-bridge[2099]: rejecting connection: peer cid 2176202715, expected 735577804 machine # [ 212.294218] systemd[1]: hermes-spaces-bridge-alice@5-8196-2:735578825-2176202715:2534307017.service: Main process exited, code=exited, status=1/FAILURE machine # [ 212.297475] systemd[1]: hermes-spaces-bridge-alice@5-8196-2:735578825-2176202715:2534307017.service: Failed with result 'exit-code'. machine # [ 212.316939] runuser[2088]: 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 15.52 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.05 seconds) (finished: subtest: spaces bridge: sibling VM is rejected at accept, in 15.57 seconds) (finished: run the VM test script, in 213.42 seconds) test script finished in 213.50s 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 70) 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.84 seconds)