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: second, test, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs second: starting vm test: starting vm test # Disk image does not exist, creating the virtualisation disk image... test: QEMU running (pid 15) second # Disk image does not exist, creating the virtualisation disk image... second: QEMU running (pid 14) second # Formatting '/build/vm-state-second/tmp.PWrMhtlNSn', fmt=raw size=1073741824 test # Formatting '/build/vm-state-test/tmp.V82eNnQNV0', fmt=raw size=1073741824 second # mke2fs 1.47.4 (6-Mar-2025) test # mke2fs 1.47.4 (6-Mar-2025) (finished: start all VMs, in 0.10 seconds) test # Discarding device blocks: 0/262144 done test # Creating filesystem with 262144 4k blocks and 65536 inodes second # Discarding device blocks: 0/262144 done test: waiting for unit NetworkManager.service test # Filesystem UUID: 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f test: waiting for the VM to finish booting test # Superblock backups stored on blocks: test # 32768, 98304, 163840, 229376 second # Creating filesystem with 262144 4k blocks and 65536 inodes test # second # Filesystem UUID: f50fd241-d8d6-4d19-bf09-b4298b3a2ef8 test # Allocating group tables: 0/8 done second # Superblock backups stored on blocks: test # Writing inode tables: 0/8 done second # 32768, 98304, 163840, 229376 test # Creating journal (8192 blocks): done second # test # Writing superblocks and filesystem accounting information: 0/8 done second # Allocating group tables: 0/8 done test # second # Writing inode tables: 0/8 done test # Virtualisation disk image created. second # Creating journal (8192 blocks): done second # Writing superblocks and filesystem accounting information: 0/8 done second # second # Virtualisation disk image created. test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) test # test # second # second # test # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00 second # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00 test # Press Ctrl-B to configure iPXE (PCI 00:03.0)... test # test # second # Press Ctrl-B to configure iPXE (PCI 00:03.0)... second # second # second # second # test # test # test # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00 second # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00 test # Press Ctrl-B to configure iPXE (PCI 00:09.0)... test # test # second # Press Ctrl-B to configure iPXE (PCI 00:09.0)... second # second # second # Booting from ROM... test # Booting from ROM... test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 2026 second # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 2026 test # [ 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/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test/init regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-closure-info/registration console=ttyS0,115200n8 console=tty0 second # [ 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/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test/init regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration console=ttyS0,115200n8 console=tty0 test # [ 0.000000] BIOS-provided physical RAM map: second # [ 0.000000] BIOS-provided physical RAM map: second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable second # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved second # [ 0.000000] NX (Execute Disable) protection: active test # [ 0.000000] NX (Execute Disable) protection: active second # [ 0.000000] APIC: Static calls initialized test # [ 0.000000] APIC: Static calls initialized second # [ 0.000000] SMBIOS 2.8 present. test # [ 0.000000] SMBIOS 2.8 present. second # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 test # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 second # [ 0.000000] DMI: Memory slots populated: 1/1 test # [ 0.000000] DMI: Memory slots populated: 1/1 second # [ 0.000000] Hypervisor detected: KVM test # [ 0.000000] Hypervisor detected: KVM second # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 test # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 second # [ 0.000000] kvm-clock: using sched offset of 369937072 cycles test # [ 0.000000] kvm-clock: using sched offset of 370548639 cycles test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns second # [ 0.000006] tsc: Detected 4192.120 MHz processor test # [ 0.000005] tsc: Detected 4192.120 MHz processor second # [ 0.000605] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 test # [ 0.000601] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 second # [ 0.000633] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs test # [ 0.000629] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs second # [ 0.000635] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT test # [ 0.000632] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT second # [ 0.002293] found SMP MP-table at [mem 0x000f5470-0x000f547f] test # [ 0.002304] found SMP MP-table at [mem 0x000f5470-0x000f547f] second # [ 0.002306] Using GB pages for direct mapping test # [ 0.002318] Using GB pages for direct mapping second # [ 0.002368] RAMDISK: [mem 0x3e4d9000-0x3ffcffff] test # [ 0.002390] RAMDISK: [mem 0x3e4dc000-0x3ffcffff] second # [ 0.002372] ACPI: Early table checksum verification disabled test # [ 0.002395] ACPI: Early table checksum verification disabled second # [ 0.002376] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) test # [ 0.002398] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) second # [ 0.002379] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002401] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002383] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002405] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002388] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002411] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002390] ACPI: FACS 0x000000003FFE0000 000040 test # [ 0.002413] ACPI: FACS 0x000000003FFE0000 000040 second # [ 0.002392] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002414] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002393] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002415] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002394] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.002416] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.002395] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300] test # [ 0.002417] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300] second # [ 0.002396] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c] test # [ 0.002418] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c] second # [ 0.002396] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] test # [ 0.002419] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] second # [ 0.002397] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378] test # [ 0.002419] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378] second # [ 0.002397] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0] test # [ 0.002419] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0] second # [ 0.002398] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8] test # [ 0.002420] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8] second # [ 0.002757] No NUMA configuration found test # [ 0.002782] No NUMA configuration found second # [ 0.002758] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff] test # [ 0.002783] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff] second # [ 0.002760] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff] test # [ 0.002786] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff] second # [ 0.002834] Zone ranges: test # [ 0.002859] Zone ranges: second # [ 0.002835] DMA [mem 0x0000000000001000-0x0000000000ffffff] test # [ 0.002859] DMA [mem 0x0000000000001000-0x0000000000ffffff] test # [ 0.002861] DMA32 [mem 0x0000000001000000-0x000000003ffdafff] second # [ 0.002836] DMA32 [mem 0x0000000001000000-0x000000003ffdafff] test # [ 0.002861] Normal empty second # [ 0.002837] Normal empty second # [ 0.002838] Device empty test # [ 0.002862] Device empty test # [ 0.002863] Movable zone start for each node second # [ 0.002838] Movable zone start for each node test # [ 0.002863] Early memory node ranges second # [ 0.002839] Early memory node ranges test # [ 0.002863] node 0: [mem 0x0000000000001000-0x000000000009efff] second # [ 0.002839] node 0: [mem 0x0000000000001000-0x000000000009efff] test # [ 0.002864] node 0: [mem 0x0000000000100000-0x000000003ffdafff] second # [ 0.002840] node 0: [mem 0x0000000000100000-0x000000003ffdafff] test # [ 0.002865] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff] second # [ 0.002841] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff] test # [ 0.002881] On node 0, zone DMA: 1 pages in unavailable ranges second # [ 0.002858] On node 0, zone DMA: 1 pages in unavailable ranges test # [ 0.003084] On node 0, zone DMA: 97 pages in unavailable ranges second # [ 0.003058] On node 0, zone DMA: 97 pages in unavailable ranges test # [ 0.016806] On node 0, zone DMA32: 37 pages in unavailable ranges second # [ 0.016745] On node 0, zone DMA32: 37 pages in unavailable ranges test # [ 0.017550] ACPI: PM-Timer IO Port: 0x608 second # [ 0.017476] ACPI: PM-Timer IO Port: 0x608 test # [ 0.017564] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) second # [ 0.017490] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) test # [ 0.017591] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 second # [ 0.017513] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 test # [ 0.017593] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) second # [ 0.017516] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) test # [ 0.017595] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) second # [ 0.017518] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) test # [ 0.017596] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) second # [ 0.017518] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) test # [ 0.017597] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) second # [ 0.017519] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) test # [ 0.017597] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) second # [ 0.017520] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) second # [ 0.017522] ACPI: Using ACPI (MADT) for SMP configuration information test # [ 0.017599] ACPI: Using ACPI (MADT) for SMP configuration information second # [ 0.017522] ACPI: HPET id: 0x8086a201 base: 0xfed00000 test # [ 0.017600] ACPI: HPET id: 0x8086a201 base: 0xfed00000 second # [ 0.017526] TSC deadline timer available test # [ 0.017605] TSC deadline timer available second # [ 0.017529] CPU topo: Max. logical packages: 1 test # [ 0.017609] CPU topo: Max. logical packages: 1 second # [ 0.017530] CPU topo: Max. logical dies: 1 test # [ 0.017609] CPU topo: Max. logical dies: 1 second # [ 0.017530] CPU topo: Max. dies per package: 1 test # [ 0.017610] CPU topo: Max. dies per package: 1 second # [ 0.017533] CPU topo: Max. threads per core: 1 test # [ 0.017613] CPU topo: Max. threads per core: 1 second # [ 0.017534] CPU topo: Num. cores per package: 1 test # [ 0.017614] CPU topo: Num. cores per package: 1 second # [ 0.017534] CPU topo: Num. threads per package: 1 test # [ 0.017614] CPU topo: Num. threads per package: 1 second # [ 0.017534] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs test # [ 0.017614] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs second # [ 0.017552] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() test # [ 0.017631] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() second # [ 0.017589] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] test # [ 0.017668] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] second # [ 0.017591] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] test # [ 0.017669] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] second # [ 0.017592] [mem 0x40000000-0xfeffbfff] available for PCI devices test # [ 0.017671] [mem 0x40000000-0xfeffbfff] available for PCI devices test # [ 0.017672] Booting paravirtualized kernel on KVM second # [ 0.017593] Booting paravirtualized kernel on KVM test # [ 0.017675] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns second # [ 0.017596] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns test # [ 0.021016] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 second # [ 0.020924] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 test # [ 0.022697] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 second # [ 0.022603] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 test # [ 0.022733] kvm-guest: PV spinlocks disabled, single CPU second # [ 0.022643] kvm-guest: PV spinlocks disabled, single CPU test # [ 0.022734] 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/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test/init regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-closure-info/registration console=ttyS0,115200n8 console=tty0 second # [ 0.022645] 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/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test/init regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration console=ttyS0,115200n8 console=tty0 test # [ 0.022809] Unknown kernel command line parameters "regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-closure-info/registration", will be passed to user space. second # [ 0.022720] Unknown kernel command line parameters "regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration", will be passed to user space. test # [ 0.023175] random: crng init done second # [ 0.023080] random: crng init done test # [ 0.023175] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes second # [ 0.023081] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes test # [ 0.023194] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) second # [ 0.023099] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.023603] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) second # [ 0.023509] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.023631] Fallback order for Node 0: 0 second # [ 0.023539] Fallback order for Node 0: 0 test # [ 0.023633] Built 1 zonelists, mobility grouping on. Total pages: 262009 second # [ 0.023541] Built 1 zonelists, mobility grouping on. Total pages: 262009 test # [ 0.023634] Policy zone: DMA32 second # [ 0.023542] Policy zone: DMA32 test # [ 0.025515] mem auto-init: stack:all(zero), heap alloc:on, heap free:off second # [ 0.025444] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.028198] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.028144] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 test # [ 0.030206] allocated 2097152 bytes of page_ext second # [ 0.030149] allocated 2097152 bytes of page_ext test # [ 0.039704] ftrace: allocating 48650 entries in 192 pages second # [ 0.039656] ftrace: allocating 48650 entries in 192 pages test # [ 0.039706] ftrace: allocated 192 pages with 2 groups second # [ 0.039659] ftrace: allocated 192 pages with 2 groups test # [ 0.040462] Dynamic Preempt: lazy second # [ 0.040411] Dynamic Preempt: lazy test # [ 0.040581] rcu: Preemptible hierarchical RCU implementation. second # [ 0.040549] rcu: Preemptible hierarchical RCU implementation. test # [ 0.040582] rcu: RCU event tracing is enabled. second # [ 0.040550] rcu: RCU event tracing is enabled. test # [ 0.040582] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. second # [ 0.040550] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.040583] Trampoline variant of Tasks RCU enabled. second # [ 0.040551] Trampoline variant of Tasks RCU enabled. test # [ 0.040584] Rude variant of Tasks RCU enabled. second # [ 0.040551] Rude variant of Tasks RCU enabled. test # [ 0.040584] Tracing variant of Tasks RCU enabled. second # [ 0.040551] Tracing variant of Tasks RCU enabled. test # [ 0.040585] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. second # [ 0.040552] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. test # [ 0.040586] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 second # [ 0.040553] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.040600] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.040580] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.040601] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.040582] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.040603] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.040583] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.044015] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 second # [ 0.044118] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 test # [ 0.044273] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.044367] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.044282] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns second # [ 0.044373] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns test # [ 0.044457] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.044544] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.049928] Console: colour VGA+ 80x25 second # [ 0.049986] Console: colour VGA+ 80x25 test # [ 0.049931] printk: legacy console [tty0] enabled second # [ 0.049990] printk: legacy console [tty0] enabled test # [ 0.080274] printk: legacy console [ttyS0] enabled second # [ 0.080312] printk: legacy console [ttyS0] enabled test # [ 0.212895] ACPI: Core revision 20250807 second # [ 0.213256] ACPI: Core revision 20250807 test # [ 0.214010] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns second # [ 0.214330] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns test # [ 0.215990] APIC: Switch to symmetric I/O mode setup second # [ 0.216281] APIC: Switch to symmetric I/O mode setup test # [ 0.217205] x2apic enabled second # [ 0.217500] x2apic enabled test # [ 0.218049] APIC: Switched APIC routing to: physical x2apic second # [ 0.218364] APIC: Switched APIC routing to: physical x2apic test # [ 0.220054] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 second # [ 0.220371] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 test # [ 0.221327] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.221642] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns test # [ 0.223448] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120) second # [ 0.223745] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120) test # [ 0.224538] x86/cpu: User Mode Instruction Prevention (UMIP) activated second # [ 0.224841] x86/cpu: User Mode Instruction Prevention (UMIP) activated test # [ 0.225583] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 second # [ 0.225881] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 test # [ 0.226447] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 second # [ 0.227743] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 test # [ 0.228450] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto second # [ 0.228748] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto test # [ 0.229446] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl second # [ 0.230743] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl test # [ 0.230446] Spectre V2 : Mitigation: Enhanced / Automatic IBRS second # [ 0.232744] Spectre V2 : Mitigation: Enhanced / Automatic IBRS test # [ 0.231446] Speculative Return Stack Overflow: Mitigation: Safe RET second # [ 0.233744] Speculative Return Stack Overflow: Mitigation: Safe RET test # [ 0.232446] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization second # [ 0.235748] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization test # [ 0.234453] Spectre V2 : Enabling IBPB for BPF second # [ 0.236753] Spectre V2 : Enabling IBPB for BPF test # [ 0.235447] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier test # [ 0.236447] active return thunk: srso_alias_return_thunk second # [ 0.237711] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier second # [ 0.238745] active return thunk: srso_alias_return_thunk test # [ 0.237469] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' second # [ 0.240766] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' test # [ 0.239447] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' second # [ 0.242744] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' test # [ 0.241446] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' second # [ 0.243743] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' test # [ 0.242446] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' test # [ 0.243446] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' second # [ 0.244746] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' second # [ 0.245745] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' test # [ 0.245447] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' second # [ 0.247744] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' test # [ 0.246447] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' test # [ 0.247447] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 second # [ 0.248743] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' test # [ 0.248447] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 second # [ 0.249744] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 test # [ 0.249446] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 second # [ 0.250743] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 test # [ 0.251446] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 second # [ 0.252743] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 test # [ 0.252446] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 second # [ 0.253743] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 test # [ 0.253446] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. second # [ 0.254744] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 second # [ 0.256743] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. test # [ 0.281758] Freeing SMP alternatives memory: 44K test # [ 0.282450] pid_max: default: 32768 minimum: 301 second # [ 0.284887] Freeing SMP alternatives memory: 44K test # [ 0.283529] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.284557] landlock: Up and running. second # [ 0.285747] pid_max: default: 32768 minimum: 301 test # [ 0.286063] Yama: becoming mindful. second # [ 0.286825] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.286673] LSM support for eBPF active second # [ 0.287829] landlock: Up and running. second # [ 0.289386] Yama: becoming mindful. test # [ 0.288196] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.290624] LSM support for eBPF active test # [ 0.289465] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.291555] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.292763] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.292298] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) test # [ 0.292879] Performance Events: Fam17h+ core perfctr, AMD PMU driver. test # [ 0.293450] ... version: 2 second # [ 0.294969] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) test # [ 0.294378] ... bit width: 48 test # [ 0.295172] ... generic counters: 6 second # [ 0.296257] Performance Events: Fam17h+ core perfctr, AMD PMU driver. test # [ 0.295493] ... generic bitmap: 000000000000003f second # [ 0.296757] ... version: 2 test # [ 0.296448] ... fixed-purpose counters: 0 second # [ 0.297745] ... bit width: 48 test # [ 0.297406] ... fixed-purpose bitmap: 0000000000000000 second # [ 0.298745] ... generic counters: 6 test # [ 0.298375] ... value mask: 0000ffffffffffff second # [ 0.299745] ... generic bitmap: 000000000000003f test # [ 0.299368] ... max period: 00007fffffffffff second # [ 0.300752] ... fixed-purpose counters: 0 test # [ 0.300377] ... global_ctrl mask: 000000000000003f second # [ 0.301735] ... fixed-purpose bitmap: 0000000000000000 test # [ 0.301494] signal: max sigframe size: 3376 second # [ 0.302668] ... value mask: 0000ffffffffffff test # [ 0.302490] rcu: Hierarchical SRCU implementation. second # [ 0.303675] ... max period: 00007fffffffffff test # [ 0.303452] rcu: Max phase no-delay instances is 400. second # [ 0.304667] ... global_ctrl mask: 000000000000003f second # [ 0.305752] signal: max sigframe size: 3376 second # [ 0.306750] rcu: Hierarchical SRCU implementation. second # [ 0.307747] rcu: Max phase no-delay instances is 400. test # [ 0.307845] smp: Bringing up secondary CPUs ... test # [ 0.308471] smp: Brought up 1 node, 1 CPU test # [ 0.309367] smpboot: Total of 1 processors activated (8384.24 BogoMIPS) second # [ 0.312005] smp: Bringing up secondary CPUs ... second # [ 0.312766] smp: Brought up 1 node, 1 CPU test # [ 0.310655] Memory: 944512K/1048036K available (17135K kernel code, 2721K rwdata, 13540K rodata, 3644K init, 3000K bss, 96104K reserved, 0K cma-reserved) second # [ 0.313726] smpboot: Total of 1 processors activated (8384.24 BogoMIPS) test # [ 0.311743] devtmpfs: initialized test # [ 0.312655] x86/mm: Memory block size: 128MB second # [ 0.314899] Memory: 944516K/1048036K available (17135K kernel code, 2721K rwdata, 13540K rodata, 3644K init, 3000K bss, 96116K reserved, 0K cma-reserved) second # [ 0.315974] devtmpfs: initialized test # [ 0.314255] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.316934] x86/mm: Memory block size: 128MB test # [ 0.315489] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.316544] pinctrl core: initialized pinctrl subsystem second # [ 0.318518] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.317707] PM: RTC time: 00:04:56, date: 2026-09-09 second # [ 0.319776] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). second # [ 0.320869] pinctrl core: initialized pinctrl subsystem second # [ 0.322080] PM: RTC time: 00:04:56, date: 2026-09-09 test # [ 0.320787] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.321742] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.322469] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.325121] NET: Registered PF_NETLINK/PF_ROUTE protocol family second # [ 0.326058] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.323584] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations test # [ 0.324470] audit: initializing netlink subsys (disabled) second # [ 0.326768] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations test # [ 0.325770] thermal_sys: Registered thermal governor 'fair_share' second # [ 0.327864] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations test # [ 0.325772] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.328761] audit: initializing netlink subsys (disabled) test # [ 0.326454] audit: type=2000 audit(1788912297.071:1): state=initialized audit_enabled=0 res=1 second # [ 0.330019] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.328451] thermal_sys: Registered thermal governor 'step_wise' second # [ 0.330021] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.330745] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.328453] thermal_sys: Registered thermal governor 'user_space' second # [ 0.331749] audit: type=2000 audit(1788912297.076:1): state=initialized audit_enabled=0 res=1 test # [ 0.329449] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.330492] cpuidle: using governor menu second # [ 0.333749] thermal_sys: Registered thermal governor 'user_space' second # [ 0.333751] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.333403] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 second # [ 0.334769] cpuidle: using governor menu test # [ 0.334696] PCI: Using configuration type 1 for base access second # [ 0.337514] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 test # [ 0.335448] PCI: Using configuration type 1 for extended access second # [ 0.338998] PCI: Using configuration type 1 for base access test # [ 0.336637] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. second # [ 0.339745] PCI: Using configuration type 1 for extended access second # [ 0.340935] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. test # [ 0.343479] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.345960] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages test # [ 0.344448] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.346745] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.349448] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages second # [ 0.351745] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.350449] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.352745] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.357301] ACPI: Added _OSI(Module Device) test # [ 0.358154] ACPI: Added _OSI(Processor Device) test # [ 0.358448] ACPI: Added _OSI(Processor Aggregator Device) second # [ 0.362381] ACPI: Added _OSI(Module Device) second # [ 0.362758] ACPI: Added _OSI(Processor Device) second # [ 0.363746] ACPI: Added _OSI(Processor Aggregator Device) test # [ 0.364817] ACPI: 1 ACPI AML tables successfully acquired and loaded second # [ 0.368132] ACPI: 1 ACPI AML tables successfully acquired and loaded test # [ 0.368659] ACPI: Interpreter enabled test # [ 0.369463] ACPI: PM: (supports S0 S3 S4 S5) test # [ 0.370370] ACPI: Using IOAPIC for interrupt routing second # [ 0.373932] ACPI: Interpreter enabled second # [ 0.374759] ACPI: PM: (supports S0 S3 S4 S5) second # [ 0.375673] ACPI: Using IOAPIC for interrupt routing test # [ 0.373470] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug test # [ 0.374449] PCI: Using E820 reservations for host bridge windows second # [ 0.378154] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug test # [ 0.375737] ACPI: Enabled 2 GPEs in block 00 to 0F second # [ 0.378745] PCI: Using E820 reservations for host bridge windows second # [ 0.379905] ACPI: Enabled 2 GPEs in block 00 to 0F test # [ 0.379943] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) second # [ 0.384072] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) test # [ 0.380456] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] test # [ 0.381747] acpiphp: Slot [3] registered second # [ 0.384750] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] test # [ 0.382487] acpiphp: Slot [4] registered second # [ 0.386045] acpiphp: Slot [3] registered test # [ 0.383417] acpiphp: Slot [5] registered second # [ 0.386780] acpiphp: Slot [4] registered test # [ 0.384170] acpiphp: Slot [6] registered second # [ 0.387645] acpiphp: Slot [5] registered test # [ 0.384480] acpiphp: Slot [7] registered second # [ 0.388472] acpiphp: Slot [6] registered test # [ 0.385457] acpiphp: Slot [8] registered second # [ 0.388770] acpiphp: Slot [7] registered test # [ 0.386411] acpiphp: Slot [9] registered second # [ 0.389659] acpiphp: Slot [8] registered test # [ 0.387176] acpiphp: Slot [10] registered second # [ 0.390429] acpiphp: Slot [9] registered second # [ 0.390769] acpiphp: Slot [10] registered test # [ 0.387478] acpiphp: Slot [11] registered second # [ 0.391660] acpiphp: Slot [11] registered test # [ 0.388474] acpiphp: Slot [12] registered second # [ 0.392432] acpiphp: Slot [12] registered test # [ 0.389441] acpiphp: Slot [13] registered second # [ 0.392770] acpiphp: Slot [13] registered test # [ 0.390201] acpiphp: Slot [14] registered second # [ 0.393664] acpiphp: Slot [14] registered test # [ 0.390488] acpiphp: Slot [15] registered second # [ 0.394426] acpiphp: Slot [15] registered test # [ 0.391487] acpiphp: Slot [16] registered second # [ 0.394779] acpiphp: Slot [16] registered test # [ 0.392464] acpiphp: Slot [17] registered second # [ 0.395722] acpiphp: Slot [17] registered test # [ 0.393413] acpiphp: Slot [18] registered second # [ 0.396456] acpiphp: Slot [18] registered test # [ 0.394156] acpiphp: Slot [19] registered second # [ 0.396782] acpiphp: Slot [19] registered test # [ 0.394475] acpiphp: Slot [20] registered second # [ 0.397674] acpiphp: Slot [20] registered test # [ 0.395373] acpiphp: Slot [21] registered second # [ 0.398425] acpiphp: Slot [21] registered test # [ 0.396149] acpiphp: Slot [22] registered second # [ 0.398768] acpiphp: Slot [22] registered test # [ 0.396482] acpiphp: Slot [23] registered second # [ 0.399668] acpiphp: Slot [23] registered test # [ 0.397381] acpiphp: Slot [24] registered second # [ 0.400428] acpiphp: Slot [24] registered test # [ 0.398147] acpiphp: Slot [25] registered second # [ 0.400769] acpiphp: Slot [25] registered test # [ 0.398472] acpiphp: Slot [26] registered second # [ 0.401647] acpiphp: Slot [26] registered test # [ 0.399362] acpiphp: Slot [27] registered second # [ 0.402453] acpiphp: Slot [27] registered test # [ 0.400132] acpiphp: Slot [28] registered test # [ 0.400472] acpiphp: Slot [29] registered second # [ 0.402795] acpiphp: Slot [28] registered test # [ 0.401390] acpiphp: Slot [30] registered second # [ 0.404477] acpiphp: Slot [29] registered test # [ 0.402157] acpiphp: Slot [31] registered second # [ 0.404805] acpiphp: Slot [30] registered test # [ 0.402473] PCI host bridge to bus 0000:00 second # [ 0.405711] acpiphp: Slot [31] registered second # [ 0.406425] PCI host bridge to bus 0000:00 test # [ 0.403379] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] second # [ 0.406751] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] test # [ 0.404480] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] second # [ 0.407746] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] test # [ 0.405448] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] second # [ 0.408745] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] test # [ 0.406448] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] second # [ 0.409747] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] test # [ 0.407448] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] second # [ 0.410747] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] test # [ 0.408449] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.411749] pci_bus 0000:00: root bus resource [bus 00-ff] test # [ 0.409741] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint second # [ 0.413046] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint test # [ 0.411194] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint second # [ 0.414470] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint test # [ 0.413150] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint second # [ 0.416444] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint test # [ 0.415498] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] second # [ 0.418794] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] test # [ 0.416499] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk second # [ 0.419794] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk test # [ 0.417449] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk second # [ 0.420745] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk test # [ 0.418449] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk second # [ 0.421746] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk test # [ 0.419448] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk second # [ 0.422746] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk test # [ 0.420791] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint second # [ 0.424062] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint test # [ 0.422499] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] second # [ 0.425799] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] test # [ 0.424420] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint second # [ 0.427711] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint test # [ 0.425926] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI second # [ 0.429256] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI test # [ 0.426459] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB second # [ 0.429758] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB test # [ 0.427766] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint second # [ 0.431093] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint test # [ 0.430444] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] test # [ 0.431470] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] second # [ 0.433767] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] test # [ 0.432487] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] second # [ 0.434766] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] test # [ 0.433627] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] second # [ 0.435792] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] second # [ 0.436930] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] test # [ 0.435292] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.438597] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.438165] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] test # [ 0.438459] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] second # [ 0.441756] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] test # [ 0.439488] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] second # [ 0.442756] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] test # [ 0.440458] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] second # [ 0.443791] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] second # [ 0.444756] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] test # [ 0.443141] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.445973] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] second # [ 0.447403] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.446459] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] test # [ 0.447488] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] second # [ 0.449515] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] second # [ 0.449756] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] second # [ 0.450785] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] test # [ 0.449983] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.453340] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.451459] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] test # [ 0.452459] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] test # [ 0.453488] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] second # [ 0.455756] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] second # [ 0.456756] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] second # [ 0.457784] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] test # [ 0.455980] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.457459] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] second # [ 0.460250] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.458459] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] test # [ 0.459491] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] second # [ 0.461756] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] second # [ 0.462756] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] test # [ 0.461958] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.463785] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] test # [ 0.463459] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] second # [ 0.466239] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.467756] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] test # [ 0.464460] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] test # [ 0.466480] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] second # [ 0.468755] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] test # [ 0.468988] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.470780] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] second # [ 0.473400] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.471462] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] test # [ 0.472459] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] test # [ 0.473488] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] second # [ 0.475758] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] second # [ 0.476757] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] second # [ 0.477785] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] test # [ 0.476103] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.480486] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.478266] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] test # [ 0.479401] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] test # [ 0.480467] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] second # [ 0.483755] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] second # [ 0.484757] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] test # [ 0.481460] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] second # [ 0.485789] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] second # [ 0.486757] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] test # [ 0.484036] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.489293] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.485923] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] test # [ 0.486491] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] second # [ 0.491100] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] second # [ 0.491792] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] test # [ 0.488978] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.494261] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint test # [ 0.490459] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] test # [ 0.491460] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] second # [ 0.496397] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] test # [ 0.492491] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] second # [ 0.496758] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] second # [ 0.497911] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] test # [ 0.495035] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.496459] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] second # [ 0.500351] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.497459] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] second # [ 0.501756] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] test # [ 0.498495] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] second # [ 0.502763] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] second # [ 0.503784] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] test # [ 0.504866] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 test # [ 0.505606] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 test # [ 0.506662] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 second # [ 0.510448] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 second # [ 0.510928] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 test # [ 0.507804] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 second # [ 0.511892] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 test # [ 0.508535] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 second # [ 0.512877] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 test # [ 0.510308] iommu: Default domain type: Translated second # [ 0.513838] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 test # [ 0.511302] iommu: DMA domain TLB invalidation policy: lazy mode test # [ 0.512702] ACPI: bus type USB registered second # [ 0.515625] iommu: Default domain type: Translated test # [ 0.513501] usbcore: registered new interface driver usbfs second # [ 0.516538] iommu: DMA domain TLB invalidation policy: lazy mode test # [ 0.514478] usbcore: registered new interface driver hub second # [ 0.517970] ACPI: bus type USB registered test # [ 0.515460] usbcore: registered new device driver usb second # [ 0.518796] usbcore: registered new interface driver usbfs test # [ 0.517210] NetLabel: Initializing second # [ 0.519770] usbcore: registered new interface driver hub test # [ 0.517452] NetLabel: domain hash size = 128 second # [ 0.520757] usbcore: registered new device driver usb test # [ 0.518391] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO second # [ 0.522480] NetLabel: Initializing test # [ 0.519447] NetLabel: unlabeled traffic allowed by default second # [ 0.522753] NetLabel: domain hash size = 128 test # [ 0.520458] PCI: Using ACPI for IRQ routing second # [ 0.523690] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO test # [ 0.521878] pci 0000:00:02.0: vgaarb: setting as boot VGA device second # [ 0.524728] NetLabel: unlabeled traffic allowed by default second # [ 0.525717] PCI: Using ACPI for IRQ routing test # [ 0.522444] pci 0000:00:02.0: vgaarb: bridge control possible second # [ 0.526968] pci 0000:00:02.0: vgaarb: setting as boot VGA device test # [ 0.522444] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none test # [ 0.522450] vgaarb: loaded second # [ 0.527741] pci 0000:00:02.0: vgaarb: bridge control possible test # [ 0.523287] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 second # [ 0.527741] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none test # [ 0.524257] hpet0: 3 comparators, 64-bit 100.000000 MHz counter second # [ 0.527748] vgaarb: loaded second # [ 0.528580] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 second # [ 0.529543] hpet0: 3 comparators, 64-bit 100.000000 MHz counter test # [ 0.527549] clocksource: Switched to clocksource kvm-clock test # [ 0.530685] VFS: Disk quotas dquot_6.6.0 second # [ 0.533824] clocksource: Switched to clocksource kvm-clock test # [ 0.531587] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.533243] pnp: PnP ACPI init test # [ 0.534474] pnp: PnP ACPI: found 6 devices second # [ 0.537154] VFS: Disk quotas dquot_6.6.0 second # [ 0.538059] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.539666] pnp: PnP ACPI init second # [ 0.540909] pnp: PnP ACPI: found 6 devices test # [ 0.541730] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns test # [ 0.543522] clocksource: Switched to clocksource acpi_pm test # [ 0.544725] NET: Registered PF_INET protocol family second # [ 0.548161] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns test # [ 0.545962] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) second # [ 0.549983] clocksource: Switched to clocksource acpi_pm second # [ 0.551177] NET: Registered PF_INET protocol family second # [ 0.552466] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.560001] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.561978] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.563676] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.566710] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.565353] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.568608] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.566928] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.570255] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.568389] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) second # [ 0.571939] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) test # [ 0.569998] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.573490] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.571468] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.574907] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.572988] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.574286] NET: Registered PF_XDP protocol family second # [ 0.576506] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.575379] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] second # [ 0.577917] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.576685] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] second # [ 0.579506] NET: Registered PF_UNIX/PF_LOCAL protocol family second # [ 0.580732] NET: Registered PF_XDP protocol family test # [ 0.578012] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] second # [ 0.581856] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] test # [ 0.579519] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] second # [ 0.583282] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] test # [ 0.580977] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] second # [ 0.584654] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] test # [ 0.582571] pci 0000:00:01.0: PIIX3: Enabling Passive Release test # [ 0.583844] pci 0000:00:00.0: Limiting direct PCI/PCI transfers second # [ 0.586354] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] test # [ 0.586298] ACPI: \_SB_.LNKD: Enabled at IRQ 11 second # [ 0.588324] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] second # [ 0.589959] pci 0000:00:01.0: PIIX3: Enabling Passive Release test # [ 0.588747] PCI: CLS 0 bytes, default 64 second # [ 0.591235] pci 0000:00:00.0: Limiting direct PCI/PCI transfers test # [ 0.589827] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.593736] ACPI: \_SB_.LNKD: Enabled at IRQ 11 test # [ 0.592001] Trying to unpack rootfs image as initramfs... second # [ 0.596435] PCI: CLS 0 bytes, default 64 second # [ 0.597542] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.599938] Trying to unpack rootfs image as initramfs... test # [ 0.627920] Initialise system trusted keyrings test # [ 0.631254] workingset: timestamp_bits=40 max_order=18 bucket_order=0 second # [ 0.638942] Initialise system trusted keyrings second # [ 0.640127] workingset: timestamp_bits=40 max_order=18 bucket_order=0 test # [ 0.646561] Key type asymmetric registered test # [ 0.651215] Asymmetric key parser 'x509' registered test # [ 0.652393] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) second # [ 0.659538] Key type asymmetric registered test # [ 0.657344] io scheduler mq-deadline registered second # [ 0.660526] Asymmetric key parser 'x509' registered test # [ 0.658374] io scheduler kyber registered second # [ 0.663464] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) test # [ 0.661716] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled second # [ 0.668445] io scheduler mq-deadline registered test # [ 0.665380] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A second # [ 0.669465] io scheduler kyber registered second # [ 0.673010] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.671109] Linux agpgart interface v0.103 test # [ 0.674236] ACPI: bus type drm_connector registered second # [ 0.677693] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A second # [ 0.680140] Linux agpgart interface v0.103 test # [ 0.677328] usbcore: registered new interface driver usbserial_generic second # [ 0.681113] ACPI: bus type drm_connector registered test # [ 0.678692] usbserial: USB Serial support registered for generic test # [ 0.682205] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. second # [ 0.685797] usbcore: registered new interface driver usbserial_generic test # [ 0.682205] Please enable it if your BIOS has the CPPC option. second # [ 0.687216] usbserial: USB Serial support registered for generic test # [ 0.685070] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled second # [ 0.690405] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. second # [ 0.690405] Please enable it if your BIOS has the CPPC option. test # [ 0.690330] drop_monitor: Initializing network drop monitor service second # [ 0.693273] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled test # [ 0.691817] NET: Registered PF_INET6 protocol family second # [ 0.697557] drop_monitor: Initializing network drop monitor service test # [ 0.695623] Segment Routing with IPv6 second # [ 0.699020] NET: Registered PF_INET6 protocol family test # [ 0.699221] In-situ OAM (IOAM) with IPv6 test # [ 0.700511] IPI shorthand broadcast: enabled second # [ 0.703844] Segment Routing with IPv6 second # [ 0.706424] In-situ OAM (IOAM) with IPv6 second # [ 0.707653] IPI shorthand broadcast: enabled test # [ 0.705989] sched_clock: Marking stable (531022281, 174162924)->(803871656, -98686451) second # [ 0.713236] sched_clock: Marking stable (538022647, 174368890)->(808454174, -96062637) test # [ 0.712561] registered taskstats version 1 test # [ 0.713663] Loading compiled-in X.509 certificates second # [ 0.719801] registered taskstats version 1 second # [ 0.720899] Loading compiled-in X.509 certificates test # [ 0.728550] Demotion targets for Node 0: null test # [ 0.732260] Key type .fscrypt registered test # [ 0.733094] Key type fscrypt-provisioning registered second # [ 0.736713] Demotion targets for Node 0: null test # [ 0.734284] ima: No TPM chip found, activating TPM-bypass! test # [ 0.735423] ima: Allocated hash algorithm: sha1 second # [ 0.740453] Key type .fscrypt registered second # [ 0.741292] Key type fscrypt-provisioning registered second # [ 0.742485] ima: No TPM chip found, activating TPM-bypass! test # [ 0.740222] ima: No architecture policies found second # [ 0.743632] ima: Allocated hash algorithm: sha1 test # [ 0.741344] PM: Magic number: 10:204:51 test # [ 0.742886] RAS: Correctable Errors collector initialized. second # [ 0.746439] ima: No architecture policies found second # [ 0.749403] PM: Magic number: 10:204:51 second # [ 0.751150] RAS: Correctable Errors collector initialized. test # [ 0.751920] clk: Disabling unused clocks test # [ 0.752802] PM: genpd: Disabling unused power domains second # [ 0.759164] clk: Disabling unused clocks second # [ 0.761416] PM: genpd: Disabling unused power domains test # [ 0.867868] Freeing initrd memory: 27600K test # [ 0.870872] Freeing unused decrypted memory: 2028K test # [ 0.873557] Freeing unused kernel image (initmem) memory: 3644K test # [ 0.874892] Write protecting the kernel read-only data: 32768k test # [ 0.876949] Freeing unused kernel image (text/rodata gap) memory: 1296K test # [ 0.878764] Freeing unused kernel image (rodata/data gap) memory: 796K second # [ 0.883878] Freeing initrd memory: 27612K second # [ 0.887300] Freeing unused decrypted memory: 2028K second # [ 0.889996] Freeing unused kernel image (initmem) memory: 3644K second # [ 0.891348] Write protecting the kernel read-only data: 32768k second # [ 0.893440] Freeing unused kernel image (text/rodata gap) memory: 1296K second # [ 0.895226] Freeing unused kernel image (rodata/data gap) memory: 796K test # [ 0.912224] x86/mm: Checked W+X mappings: passed, no W+X pages found. test # [ 0.913610] Run /init as init process test # [ 0.922407] systemd[1]: Inserted module 'autofs4' second # [ 0.928778] x86/mm: Checked W+X mappings: passed, no W+X pages found. second # [ 0.930186] Run /init as init process test # [ 0.934819] fuse: init (API version 7.45) second # [ 0.939198] systemd[1]: Inserted module 'autofs4' test # [ 0.940333] ACPI: \_SB_.LNKC: Enabled at IRQ 10 test # [ 0.946505] ACPI: \_SB_.LNKA: Enabled at IRQ 10 second # [ 0.951842] fuse: init (API version 7.45) test # [ 0.949651] ACPI: \_SB_.LNKB: Enabled at IRQ 11 second # [ 0.957312] ACPI: \_SB_.LNKC: Enabled at IRQ 10 second # [ 0.963434] ACPI: \_SB_.LNKA: Enabled at IRQ 10 second # [ 0.966557] ACPI: \_SB_.LNKB: Enabled at IRQ 11 test # [ 0.979085] systemd[1]: Successfully made /usr/ read-only. second # [ 0.994956] systemd[1]: Successfully made /usr/ read-only. test # [ 1.315922] systemd[1]: systemd 260.2 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) test # [ 1.322106] systemd[1]: Detected virtualization kvm. test # [ 1.323225] systemd[1]: Detected architecture x86-64. test # [ 1.324334] systemd[1]: Running in initrd. test # [ 1.325545] systemd[1]: Initializing machine ID from random generator. test # [ 1.327006] systemd[1]: Hostname set to . second # [ 1.331240] systemd[1]: systemd 260.2 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) second # [ 1.337301] systemd[1]: Detected virtualization kvm. second # [ 1.338444] systemd[1]: Detected architecture x86-64. second # [ 1.339572] systemd[1]: Running in initrd. second # [ 1.340814] systemd[1]: Initializing machine ID from random generator. second # [ 1.342261] systemd[1]: Hostname set to . test # [ 1.364466] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.368348] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.369754] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.371436] systemd[1]: Expecting device /dev/disk/by-label/nixos... test # [ 1.372800] systemd[1]: Reached target Path Units. test # [ 1.373884] systemd[1]: Reached target Slice Units. test # [ 1.375010] systemd[1]: Reached target Swaps. test # [ 1.376020] systemd[1]: Reached target Timer Units. second # [ 1.379282] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.377244] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.378705] systemd[1]: Listening on Journal Socket (/dev/log). test # [ 1.380129] systemd[1]: Listening on Journal Sockets. second # [ 1.383566] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.381360] systemd[1]: Listening on udev Control Socket. test # [ 1.382602] systemd[1]: Listening on udev Kernel Socket. second # [ 1.384959] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.383787] systemd[1]: Reached target Socket Units. second # [ 1.386643] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.387992] systemd[1]: Reached target Path Units. test # [ 1.385663] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.389070] systemd[1]: Reached target Slice Units. second # [ 1.390162] systemd[1]: Reached target Swaps. second # [ 1.391160] systemd[1]: Reached target Timer Units. second # [ 1.392346] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.389976] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.393846] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.395296] systemd[1]: Listening on Journal Sockets. second # [ 1.396582] systemd[1]: Listening on udev Control Socket. second # [ 1.397876] systemd[1]: Listening on udev Kernel Socket. second # [ 1.399088] systemd[1]: Reached target Socket Units. test # [ 1.396755] systemd[1]: Starting Load Kernel Module configfs... second # [ 1.401119] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.405105] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.412014] systemd[1]: Starting Load Kernel Module configfs... test # [ 1.409048] systemd[1]: Starting Journal Service... test # [ 1.419658] systemd[1]: Starting Load Kernel Modules... second # [ 1.425463] systemd[1]: Starting Journal Service... test # [ 1.426736] netfs: FS-Cache loaded test # [ 1.428332] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki second # [ 1.437562] systemd[1]: Starting Load Kernel Modules... test # [ 1.437781] 9pnet: Installing 9P2000 support second # [ 1.440931] netfs: FS-Cache loaded test # [ 1.441553] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.443506] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki second # [ 1.453002] 9pnet: Installing 9P2000 support second # [ 1.456598] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.458797] systemd-journald[67]: Collecting audit messages is disabled. test # [ 1.460910] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.475034] systemd-journald[67]: Collecting audit messages is disabled. second # [ 1.478501] systemd[1]: Finished Create List of Static Device Nodes. test # [ 1.469236] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.482521] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. second # [ 1.482997] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.493343] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev second # [ 1.501604] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.510255] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 1.512536] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.515680] systemd[1]: modprobe@configfs.service: Deactivated successfully. second # [ 1.524989] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.523277] systemd[1]: Finished Load Kernel Module configfs. test # [ 1.530346] systemd[1]: Finished Load Kernel Modules. second # [ 1.533845] systemd[1]: modprobe@configfs.service: Deactivated successfully. test # [ 1.534838] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config second # [ 1.539453] systemd[1]: Finished Load Kernel Module configfs. second # [ 1.547530] systemd[1]: Finished Load Kernel Modules. test # [ 1.545279] systemd[1]: Starting Apply Kernel Variables... second # [ 1.551004] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config test # [ 1.555869] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 1.562466] systemd[1]: Starting Apply Kernel Variables... second # [ 1.572450] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.582620] systemd[1]: Finished Apply Kernel Variables. test # [ 1.594860] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.601462] systemd[1]: Finished Apply Kernel Variables. test # [ 1.600632] systemd[1]: Started Journal Service. test # [ 1.425751] systemd-modules-load[68]: Inserted module 'dm_mod' test # [ 1.429316] systemd-modules-load[68]: Inserted module 'virtio_balloon' second # [ 1.607485] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.431352] systemd-modules-load[68]: Inserted module 'virtio_gpu' test # [ 1.436762] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.616584] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.445678] systemd-modules-load[68]: Inserted module 'dm_mod' second # [ 1.448233] systemd-modules-load[68]: Inserted module 'virtio_balloon' second # [ 1.449579] systemd-modules-load[68]: Inserted module 'virtio_gpu' second # [ 1.628574] systemd[1]: Started Journal Service. test # [ 1.460205] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.461926] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.464712] systemd[1]: Reached target Local File Systems. test # [ 1.466136] systemd[1]: Starting Create System Files and Directories... second # [ 1.472244] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.474336] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.475638] systemd[1]: Reached target Local File Systems. test # [ 1.473246] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 1.480081] systemd[1]: Starting Create System Files and Directories... second # [ 1.486081] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.493953] systemd[1]: Finished Create System Files and Directories. second # [ 1.507228] systemd[1]: Finished Create System Files and Directories. test # [ 1.512347] systemd-udevd[82]: Using default interface naming scheme 'v260'. second # [ 1.524296] systemd-udevd[83]: Using default interface naming scheme 'v260'. test # [ 1.535873] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.541140] systemd[1]: Finished Coldplug All udev Devices. test # [ 1.542265] systemd[1]: Reached target System Initialization. test # [ 1.544192] systemd[1]: Reached target Basic System. second # [ 1.549106] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 1.561167] systemd[1]: Finished Coldplug All udev Devices. second # [ 1.563735] systemd[1]: Reached target System Initialization. second # [ 1.564833] systemd[1]: Reached target Basic System. test # [ 1.915702] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 second # [ 1.931936] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 test # [ 1.933694] serio: i8042 KBD port at 0x60,0x64 irq 1 test # [ 1.934557] serio: i8042 AUX port at 0x60,0x64 irq 12 test # [ 1.947575] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 1.957195] serio: i8042 KBD port at 0x60,0x64 irq 1 second # [ 1.965846] uhci_hcd 0000:00:01.2: UHCI Host Controller second # [ 1.967211] serio: i8042 AUX port at 0x60,0x64 irq 12 test # [ 1.975812] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 1.979927] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 test # [ 1.983692] uhci_hcd 0000:00:01.2: UHCI Host Controller second # [ 1.986687] uhci_hcd 0000:00:01.2: detected 2 ports second # [ 1.988137] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 1.994038] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 test # [ 1.995840] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 second # [ 1.999919] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) test # [ 1.999072] uhci_hcd 0000:00:01.2: detected 2 ports second # [ 2.001797] SCSI subsystem initialized test # [ 2.003089] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 second # [ 2.007209] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 test # [ 2.007536] SCSI subsystem initialized test # [ 2.011534] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 test # [ 2.012996] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 second # [ 2.018985] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 second # [ 2.020248] usb usb1: Product: UHCI Host Controller second # [ 2.034016] usb usb1: Manufacturer: Linux 6.18.49 uhci_hcd test # [ 2.036322] usb usb1: Product: UHCI Host Controller test # [ 2.037125] usb usb1: Manufacturer: Linux 6.18.49 uhci_hcd second # [ 2.039972] usb usb1: SerialNumber: 0000:00:01.2 second # [ 2.045918] hub 1-0:1.0: USB hub found test # [ 2.043641] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 test # [ 1.873858] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. test # [ 1.877910] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.055527] hub 1-0:1.0: 2 ports detected test # [ 2.055206] usb usb1: SerialNumber: 0000:00:01.2 test # [ 1.885720] systemd[1]: Starting Virtual Console Setup... second # [ 1.894968] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.072638] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 test # [ 2.073238] hub 1-0:1.0: USB hub found test # [ 2.078350] hub 1-0:1.0: 2 ports detected second # [ 1.909888] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. second # [ 1.913072] systemd[1]: Starting Virtual Console Setup... test # [ 1.916548] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 1.919566] systemd[1]: Finished Virtual Console Setup. test # [ 1.928142] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 1.929341] systemd[1]: Reached target Initrd Root Device. test # [ 1.933083] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 1.955130] systemd[1]: Found device /dev/disk/by-label/nixos. second # [ 1.956392] systemd[1]: Reached target Initrd Root Device. second # [ 1.957877] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 1.961087] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 1.960704] systemd-fsck[106]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 1.967700] systemd[1]: Finished Virtual Console Setup. test # [ 1.970583] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.148145] scsi host0: ata_piix test # [ 2.146355] scsi host0: ata_piix test # [ 2.148691] scsi host1: ata_piix test # [ 2.150412] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 second # [ 2.153811] scsi host1: ata_piix test # [ 2.152521] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 second # [ 2.156560] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 second # [ 2.159943] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 second # [ 1.992288] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 1.997731] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.283417] usb 1-1: new full-speed USB device number 2 using uhci_hcd test # [ 2.307578] ata2: found unknown device (class 0) test # [ 2.308949] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 test # [ 2.312076] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 second # [ 2.315863] ata2: found unknown device (class 0) second # [ 2.317221] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 test # [ 2.315202] usb 1-1: new full-speed USB device number 2 using uhci_hcd second # [ 2.319448] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 test # [ 2.336737] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray second # [ 2.343939] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray test # [ 2.345493] cdrom: Uniform CD-ROM driver Revision: 3.20 second # [ 2.352700] cdrom: Uniform CD-ROM driver Revision: 3.20 second # [ 2.449966] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 second # [ 2.451316] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 second # [ 2.452859] usb 1-1: Product: QEMU USB Tablet second # [ 2.453727] usb 1-1: Manufacturer: QEMU second # [ 2.454538] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 test # [ 2.282734] systemd[1]: Mounting /sysroot... second # [ 2.467265] hid: raw HID events driver (C) Jiri Kosina second # [ 2.298726] systemd[1]: Mounting /sysroot... second # [ 2.476185] usbcore: registered new interface driver usbhid second # [ 2.478607] usbhid: USB HID core driver test # [ 2.482074] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 test # [ 2.483433] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 second # [ 2.485679] 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 test # [ 2.487182] usb 1-1: Product: QEMU USB Tablet test # [ 2.487898] usb 1-1: Manufacturer: QEMU second # [ 2.489613] 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 test # [ 2.490180] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 test # [ 2.516391] hid: raw HID events driver (C) Jiri Kosina test # [ 2.526492] usbcore: registered new interface driver usbhid test # [ 2.529581] EXT4-fs (vda): mounted filesystem 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f r/w with ordered data mode. Quota mode: none. test # [ 2.531814] usbhid: USB HID core driver test # [ 2.363218] systemd[1]: Mounted /sysroot. test # [ 2.539078] 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 test # [ 2.367764] systemd[1]: Reached target Initrd Root File System. second # [ 2.545233] EXT4-fs (vda): mounted filesystem f50fd241-d8d6-4d19-bf09-b4298b3a2ef8 r/w with ordered data mode. Quota mode: none. test # [ 2.370075] systemd[1]: Starting Mountpoints Configured in the Real Root... second # [ 2.374642] systemd[1]: Mounted /sysroot. test # [ 2.546453] 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 second # [ 2.376265] systemd[1]: Reached target Initrd Root File System. second # [ 2.378228] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.382650] systemd-sysroot-fstab-check[126]: /sysroot should be mounted in the initrd, will request daemon-reload. second # [ 2.388357] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.385965] systemd[1]: Reload requested from client PID 126 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.388309] systemd[1]: Reloading... second # [ 2.391161] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)... second # [ 2.393048] systemd[1]: Reloading... second # [ 2.447169] systemd[1]: Reloading finished in 53 ms. test # [ 2.449763] systemd[1]: Reloading finished in 60 ms. second # [ 2.452582] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace... second # [ 2.455880] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio second # [ 2.457745] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace... test # [ 2.456073] systemd-sysroot-fstab-check[126]: Requesting initrd-fs.target/start/replace... second # [ 2.460561] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.459098] systemd-sysroot-fstab-check[126]: Requesting swap.target/start/replace... second # [ 2.461809] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.464115] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.463117] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.464473] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 2.465810] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.468346] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio test # [ 3.283664] systemd[1]: Mounting /sysroot/nix/.ro-store... test # [ 3.287143] systemd[1]: Mounting /sysroot/nix/.rw-store... test # [ 3.289135] systemd[1]: Mounting /sysroot/run... test # [ 3.294618] systemd[1]: Mounting /sysroot/tmp/shared... test # [ 3.296529] systemd[1]: Mounting /sysroot/tmp/xchg... second # [ 3.299615] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.302663] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.307722] systemd[1]: Mounting /sysroot/run... second # [ 3.311082] systemd[1]: Mounting /sysroot/tmp/shared... test # [ 3.313847] systemd[1]: Mounted /sysroot/nix/.rw-store. second # [ 3.316426] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 3.496229] 9p: Installing v9fs 9p2000 file system support test # [ 3.325181] systemd[1]: Mounted /sysroot/run. second # [ 3.505667] 9p: Installing v9fs 9p2000 file system support second # [ 3.333677] systemd[1]: Mounted /sysroot/run. test # [ 3.333606] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.334935] systemd[1]: Mounted /sysroot/tmp/shared. test # [ 3.336168] systemd[1]: Mounted /sysroot/tmp/xchg. second # [ 3.339621] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.340199] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.342730] systemd[1]: Mounted /sysroot/nix/.rw-store. second # [ 3.344266] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.347918] systemd[1]: Mounted /sysroot/tmp/xchg. second # [ 3.350773] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.349673] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.351573] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.353775] systemd[1]: Mounting /sysroot/nix/store... second # [ 3.359914] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.361725] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.363963] systemd[1]: Mounting /sysroot/nix/store... test # [ 3.370579] systemd[1]: Mounted /sysroot/nix/store. test # [ 3.371902] systemd[1]: Reached target Initrd File Systems. test # [ 3.373634] systemd[1]: Starting Find NixOS closure... test # [ 3.377130] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 3.380275] systemd[1]: Mounted /sysroot/nix/store. second # [ 3.381655] systemd[1]: Reached target Initrd File Systems. second # [ 3.383877] systemd[1]: Starting Find NixOS closure... second # [ 3.387129] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 3.393438] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 3.399889] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. test # [ 3.398434] systemd[1]: Finished Find NixOS closure. test # [ 3.399900] systemd[1]: Reached target Initrd Default Target. test # [ 3.402099] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... second # [ 3.405781] systemd[1]: Finished Find NixOS closure. second # [ 3.407917] systemd[1]: Reached target Initrd Default Target. second # [ 3.409217] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 3.413746] systemd[1]: Stopped target Initrd Default Target. test # [ 3.415081] systemd[1]: Stopped target Basic System. test # [ 3.416171] systemd[1]: Stopped target Initrd Root Device. test # [ 3.417342] systemd[1]: Stopped target Path Units. second # [ 3.419954] systemd[1]: Stopped target Initrd Default Target. second # [ 3.421557] systemd[1]: Stopped target Basic System. test # [ 3.419142] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. second # [ 3.422726] systemd[1]: Stopped target Initrd Root Device. test # [ 3.420431] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 3.424031] systemd[1]: Stopped target Path Units. test # [ 3.421850] systemd[1]: Stopped target Slice Units. test # [ 3.422784] systemd[1]: Stopped target Socket Units. test # [ 3.423915] systemd[1]: Stopped target System Initialization. second # [ 3.426143] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 3.425163] systemd[1]: Stopped target Swaps. second # [ 3.427410] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 3.428704] systemd[1]: Stopped target Slice Units. test # [ 3.426432] systemd[1]: Stopped target Timer Units. second # [ 3.429759] systemd[1]: Stopped target Socket Units. test # [ 3.427807] systemd[1]: dbus.socket: Deactivated successfully. second # [ 3.430693] systemd[1]: Stopped target System Initialization. second # [ 3.431716] systemd[1]: Stopped target Swaps. test # [ 3.429196] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 3.432896] systemd[1]: Stopped target Timer Units. test # [ 3.430639] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. second # [ 3.434173] systemd[1]: dbus.socket: Deactivated successfully. test # [ 3.431930] systemd[1]: Stopped Find NixOS closure. second # [ 3.435360] systemd[1]: Closed D-Bus System Message Bus Socket. test # [ 3.432951] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio second # [ 3.436755] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 3.435159] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.438161] systemd[1]: Stopped Find NixOS closure. test # [ 3.437147] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 3.438441] systemd[1]: Stopped Apply Kernel Variables. second # [ 3.440140] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio test # [ 3.439407] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 3.441971] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.440626] systemd[1]: Stopped Load Kernel Modules. second # [ 3.443276] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 3.441562] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 3.444864] systemd[1]: Stopped Apply Kernel Variables. test # [ 3.443203] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 3.446152] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 3.447653] systemd[1]: Stopped Load Kernel Modules. test # [ 3.445152] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 3.446399] systemd[1]: Stopped Create System Files and Directories. second # [ 3.449177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 3.447491] systemd[1]: Stopped target Local File Systems. second # [ 3.450580] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. test # [ 3.449155] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.452126] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 3.450317] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. test # [ 3.451711] systemd[1]: Stopped Coldplug All udev Devices. second # [ 3.454131] systemd[1]: Stopped Create System Files and Directories. second # [ 3.455216] systemd[1]: Stopped target Local File Systems. test # [ 3.453432] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 3.456203] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.457363] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 3.458757] systemd[1]: Stopped Coldplug All udev Devices. test # [ 3.456501] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.457759] systemd[1]: Stopped Virtual Console Setup. second # [ 3.460341] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 3.462521] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.463917] systemd[1]: Stopped Virtual Console Setup. test # [ 3.465563] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 3.470120] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 3.474168] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 3.472633] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.474366] systemd[1]: Stopped Rule-based Manager for Device Events and Files. second # [ 3.478122] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 3.476156] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.479504] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.477849] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.482049] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 3.479718] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. second # [ 3.483305] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.481958] systemd[1]: Closed udev Control Socket. second # [ 3.484699] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.483085] systemd[1]: Starting Cleanup udev Database... test # [ 3.484122] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. second # [ 3.487261] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 3.486124] systemd[1]: Stopped Create Static Device Nodes in /dev. second # [ 3.489156] systemd[1]: Closed udev Control Socket. test # [ 3.487311] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 3.490255] systemd[1]: Starting Cleanup udev Database... second # [ 3.491287] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 3.489160] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 3.490384] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 3.493075] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 3.491665] systemd[1]: Stopped Create List of Static Device Nodes. second # [ 3.494180] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 3.496161] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. second # [ 3.497409] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 3.498597] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 3.503358] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 3.505379] systemd[1]: Finished Cleanup udev Database. test # [ 3.507201] systemd[1]: Reached target Switch Root. second # [ 3.509771] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 3.508389] systemd[1]: Starting NixOS Activation... second # [ 3.512184] systemd[1]: Finished Cleanup udev Database. second # [ 3.513413] systemd[1]: Reached target Switch Root. second # [ 3.515356] systemd[1]: Starting NixOS Activation... test # [ 3.591488] initrd-nixos-activation-start[178]: booting system configuration /nix/store/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test second # [ 3.594237] initrd-nixos-activation-start[177]: booting system configuration /nix/store/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test test # [ 3.622504] initrd-nixos-activation-start[178]: running activation script... second # [ 3.624939] initrd-nixos-activation-start[177]: running activation script... second # [ 3.824271] initrd-nixos-activation-start[200]: setting up /etc... test # [ 3.824654] initrd-nixos-activation-start[201]: setting up /etc... test # [ 3.939076] initrd-nixos-activation-start[201]: setting up age secrets... second # [ 3.941796] initrd-nixos-activation-start[200]: setting up age secrets... second # [ 4.049608] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 4.051517] systemd[1]: Finished NixOS Activation. second # [ 4.053594] systemd[1]: Starting Switch Root... second # [ 4.064112] systemd[1]: Switching root. test # [ 4.072800] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 4.075179] systemd[1]: Finished NixOS Activation. test # [ 4.076696] systemd[1]: Starting Switch Root... second # [ 4.253821] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). test # [ 4.087424] systemd[1]: Switching root. test # [ 4.274468] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). second # [ 4.330627] NET: Registered PF_VSOCK protocol family test # [ 4.348802] NET: Registered PF_VSOCK protocol family second # [ 4.690569] systemd[1]: systemd 260.2 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) second # [ 4.694879] systemd[1]: Detected virtualization kvm. second # [ 4.695723] systemd[1]: Detected architecture x86-64. second # [ 4.696604] systemd[1]: Detected first boot. second # [ 4.698982] systemd[1]: Initializing machine ID from random generator. test # [ 4.707665] systemd[1]: systemd 260.2 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) test # [ 4.712002] systemd[1]: Detected virtualization kvm. test # [ 4.712837] systemd[1]: Detected architecture x86-64. test # [ 4.713725] systemd[1]: Detected first boot. test # [ 4.716172] systemd[1]: Initializing machine ID from random generator. second # [ 4.883648] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 4.899606] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 4.952829] systemd[1]: Applying preset policy. test # [ 4.964628] systemd[1]: Applying preset policy. second # [ 5.214947] systemd[1]: Populated /etc with preset unit settings. test # [ 5.224521] systemd[1]: Populated /etc with preset unit settings. second # [ 5.453986] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 5.455623] systemd[1]: Stopped initrd-switch-root.service. second # [ 5.458155] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 5.460260] systemd[1]: Created slice Slice /system/getty. second # [ 5.461691] systemd[1]: Created slice User and Session Slice. test # [ 5.459330] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 5.462750] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 5.460914] systemd[1]: Stopped initrd-switch-root.service. second # [ 5.464096] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 5.465381] systemd[1]: Expecting device /dev/hvc0... second # [ 5.466195] systemd[1]: Expecting device /dev/ttyS0... test # [ 5.463487] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 5.467100] systemd[1]: Reached target Local Encrypted Volumes. second # [ 5.468073] systemd[1]: Stopped target initrd-fs.target. test # [ 5.465642] systemd[1]: Created slice Slice /system/getty. second # [ 5.468968] systemd[1]: Stopped target initrd-root-fs.target. test # [ 5.467031] systemd[1]: Created slice User and Session Slice. second # [ 5.469915] systemd[1]: Stopped target initrd-switch-root.target. second # [ 5.470930] systemd[1]: Reached target Virtual Machines and Containers. test # [ 5.468171] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 5.472009] systemd[1]: Reached target Path Units. test # [ 5.469551] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 5.472866] systemd[1]: Reached target Remote File Systems. test # [ 5.470797] systemd[1]: Expecting device /dev/hvc0... second # [ 5.473806] systemd[1]: Reached target Slice Units. test # [ 5.471668] systemd[1]: Expecting device /dev/ttyS0... second # [ 5.474672] systemd[1]: Reached target Swaps. test # [ 5.472570] systemd[1]: Reached target Local Encrypted Volumes. test # [ 5.473554] systemd[1]: Stopped target initrd-fs.target. test # [ 5.474455] systemd[1]: Stopped target initrd-root-fs.target. second # [ 5.477045] systemd[1]: Listening on Process Core Dump Socket. test # [ 5.475409] systemd[1]: Stopped target initrd-switch-root.target. test # [ 5.476433] systemd[1]: Reached target Virtual Machines and Containers. second # [ 5.479095] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 5.477518] systemd[1]: Reached target Path Units. test # [ 5.478381] systemd[1]: Reached target Remote File Systems. test # [ 5.479334] systemd[1]: Reached target Slice Units. second # [ 5.481962] systemd[1]: Starting Journal Log Access Socket... test # [ 5.480201] systemd[1]: Reached target Swaps. second # [ 5.483432] systemd[1]: Listening on Journal Audit Socket. second # [ 5.484672] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 5.482441] systemd[1]: Listening on Process Core Dump Socket. second # [ 5.486473] systemd[1]: Listening on Network Management Netlink Socket. test # [ 5.484422] systemd[1]: Listening on Credential Encryption/Decryption. second # [ 5.487682] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 5.488909] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki test # [ 5.487419] systemd[1]: Starting Journal Log Access Socket... second # [ 5.490521] systemd[1]: Listening on udev Control Socket. test # [ 5.488707] systemd[1]: Listening on Journal Audit Socket. test # [ 5.489809] systemd[1]: Listening on Network Management Metrics Varlink Socket. second # [ 5.493022] systemd[1]: Mounting Huge Pages File System... test # [ 5.491773] systemd[1]: Listening on Network Management Netlink Socket. test # [ 5.493001] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 5.495899] systemd[1]: Mounting POSIX Message Queue File System... test # [ 5.494255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki test # [ 5.495864] systemd[1]: Listening on udev Control Socket. test # [ 5.498278] systemd[1]: Mounting Huge Pages File System... second # [ 5.502233] systemd[1]: Mounting Kernel Debug File System... test # [ 5.501517] systemd[1]: Mounting POSIX Message Queue File System... second # [ 5.507890] systemd[1]: Mounting Kernel Trace File System... test # [ 5.507470] systemd[1]: Mounting Kernel Debug File System... second # [ 5.511653] systemd[1]: Starting Create List of Static Device Nodes... test # [ 5.513213] systemd[1]: Mounting Kernel Trace File System... second # [ 5.516573] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio test # [ 5.519828] systemd[1]: Starting Create List of Static Device Nodes... second # [ 5.525283] systemd[1]: Starting Load Kernel Module configfs... test # [ 5.523811] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio second # [ 5.528107] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 5.539762] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore test # [ 5.538975] systemd[1]: Starting Load Kernel Module configfs... test # [ 5.540275] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 5.545017] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 5.546105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 5.552720] systemd[1]: Mounting FUSE Control File System... second # [ 5.553890] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 5.552730] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 5.559336] systemd[1]: Mounting FUSE Control File System... second # [ 5.563781] systemd[1]: Starting Journal Service... test # [ 5.560417] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 second # [ 5.570113] systemd[1]: Starting Load Kernel Modules... test # [ 5.572424] systemd[1]: Starting Journal Service... second # [ 5.578872] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... test # [ 5.580123] systemd[1]: Starting Load Kernel Modules... test # [ 5.590450] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 5.597380] systemd[1]: Starting Remount Root and Kernel File Systems... second # [ 5.601735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki test # [ 5.599743] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 5.606460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki second # [ 5.613456] systemd-journald[299]: Collecting audit messages is enabled. second # [ 5.615962] loop: module loaded second # [ 5.620744] systemd[1]: Starting Coldplug All udev Devices... test # [ 5.619255] systemd[1]: Starting Coldplug All udev Devices... test # [ 5.621293] systemd-journald[320]: Collecting audit messages is enabled. test # [ 5.638826] systemd[1]: Listening on Journal Log Access Socket. second # [ 5.642522] systemd[1]: Listening on Journal Log Access Socket. test # [ 5.641067] loop: module loaded second # [ 5.648561] systemd[1]: Started Journal Service. second # [ 5.476086] systemd[1]: Queued start job for default target Multi-User System. second # [ 5.477855] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 5.652502] systemd[1]: Mounted Huge Pages File System. second # [ 5.481545] systemd-modules-load[300]: Module 'ctr' is built in second # [ 5.657294] EXT4-fs (vda): re-mounted f50fd241-d8d6-4d19-bf09-b4298b3a2ef8. test # [ 5.655696] systemd[1]: Mounted POSIX Message Queue File System. second # [ 5.485494] systemd-modules-load[300]: Inserted module 'loop' test # [ 5.657260] EXT4-fs (vda): re-mounted 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f. second # [ 5.489299] systemd[1]: Mounted Huge Pages File System. test # [ 5.486506] systemd[1]: Queued start job for default target Multi-User System. second # [ 5.491519] systemd[1]: Mounted POSIX Message Queue File System. test # [ 5.489407] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 5.666549] systemd[1]: Started Journal Service. second # [ 5.494876] systemd[1]: Mounted Kernel Debug File System. test # [ 5.493720] systemd-modules-load[321]: Module 'ctr' is built in test # [ 5.496508] systemd-modules-load[321]: Inserted module 'loop' second # [ 5.499263] systemd[1]: Mounted Kernel Trace File System. second # [ 5.500511] systemd[1]: Finished Create List of Static Device Nodes. second # [ 5.503067] systemd[1]: modprobe@configfs.service: Deactivated successfully. second # [ 5.505730] systemd[1]: Finished Load Kernel Module configfs. test # [ 5.504113] systemd[1]: Mounted Kernel Debug File System. second # [ 5.508383] systemd[1]: Mounted FUSE Control File System. test # [ 5.505758] systemd[1]: Mounted Kernel Trace File System. second # [ 5.510218] systemd[1]: Finished Load Kernel Modules. test # [ 5.508267] systemd[1]: Finished Create List of Static Device Nodes. test # [ 5.511185] systemd[1]: modprobe@configfs.service: Deactivated successfully. second # [ 5.513726] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 5.512746] systemd[1]: Finished Load Kernel Module configfs. test # [ 5.516505] systemd[1]: Mounted FUSE Control File System. test # [ 5.518601] systemd[1]: Finished Load Kernel Modules. second # [ 5.524695] systemd-oomd[301]: No swap; memory pressure usage will be degraded test # [ 5.522913] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 5.535075] systemd[1]: Mounting Kernel Configuration File System... second # [ 5.537073] systemd[1]: Starting Firewall... test # [ 5.543081] systemd[1]: Mounting Kernel Configuration File System... test # [ 5.546398] systemd-oomd[323]: No swap; memory pressure usage will be degraded second # [ 5.549869] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 5.551262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 5.550078] systemd[1]: Starting Firewall... test # [ 5.555791] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 5.563652] systemd[1]: Starting Load/Save OS Random Seed... test # [ 5.561193] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 5.567350] systemd[1]: Starting Load/Save OS Random Seed... second # [ 5.573303] systemd[1]: Starting Apply Kernel Variables... test # [ 5.581888] systemd[1]: Starting Apply Kernel Variables... second # [ 5.585770] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 5.587101] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki second # [ 5.588585] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 5.595608] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 5.596947] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki test # [ 5.600071] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. second # [ 5.806665] systemd-journald[299]: Received client request to flush runtime journal. test # [ 5.820373] systemd-journald[320]: Received client request to flush runtime journal. second # [ 5.810234] systemd[1]: Mounted Kernel Configuration File System. second # [ 5.814889] systemd[1]: Finished Load/Save OS Random Seed. test # [ 5.812639] systemd[1]: Mounted Kernel Configuration File System. second # [ 5.819400] systemd[1]: Reached target First Boot Complete. test # [ 5.817996] systemd[1]: Finished Load/Save OS Random Seed. second # [ 5.822736] systemd[1]: Finished Apply Kernel Variables. test # [ 5.822305] systemd[1]: Reached target First Boot Complete. test # [ 5.823468] systemd[1]: Finished Apply Kernel Variables. second # [ 5.826195] systemd[1]: Starting Network Name Resolution... second # [ 5.827252] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 5.826144] systemd[1]: Starting Network Name Resolution... second # [ 5.828537] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 5.830976] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 5.828643] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 5.831179] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 5.833191] systemd[1]: Finished Flush Journal to Persistent Storage. second # [ 5.836186] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 5.837331] systemd[1]: Reached target Preparation for Local File Systems. test # [ 5.835814] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 5.843209] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 5.841084] systemd[1]: Reached target Preparation for Local File Systems. test # [ 5.845587] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 5.865606] systemd-resolved[329]: Positive Trust Anchors: second # [ 5.868662] systemd-resolved[329]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d second # [ 5.871313] systemd-resolved[329]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 5.873662] systemd-resolved[329]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test test # [ 5.891183] systemd-resolved[351]: Positive Trust Anchors: test # [ 5.892973] systemd-resolved[351]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 5.897323] systemd-resolved[351]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 test # [ 5.898974] systemd-resolved[351]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test test # [ 5.930896] systemd-udevd[366]: Using default interface naming scheme 'v260'. second # [ 5.934754] systemd-udevd[348]: Using default interface naming scheme 'v260'. test # [ 5.936392] systemd[1]: Finished Coldplug All udev Devices. second # [ 5.958776] systemd[1]: Finished Coldplug All udev Devices. second # [ 5.976503] systemd-resolved[329]: Using system hostname 'second'. second # [ 5.984107] systemd[1]: Started Network Name Resolution. test # [ 5.982262] systemd-resolved[351]: Using system hostname 'test'. test # [ 5.992582] systemd[1]: Started Network Name Resolution. second # [ 6.035095] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 6.036099] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 6.198743] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 6.201682] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse second # [ 6.284074] systemd[1]: Mounting /run/wrappers... test # [ 6.290096] systemd[1]: Mounting /run/wrappers... second # [ 6.294422] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 6.301129] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 6.319170] systemd[1]: Mounted /run/wrappers. second # [ 6.320893] systemd[1]: Reached target Local File Systems. second # [ 6.325704] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 6.325243] systemd[1]: Mounted /run/wrappers. second # [ 6.328411] systemd[1]: Starting register-nix-paths.service... test # [ 6.326202] systemd[1]: Reached target Local File Systems. test # [ 6.330310] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 6.334607] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 6.335665] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 6.335137] systemd[1]: Starting register-nix-paths.service... test # [ 6.338728] systemd[1]: Starting Create SUID/SGID Wrappers... test # [ 6.340757] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 6.344762] systemd[1]: Starting Save Transient machine-id to Disk... test # [ 6.349812] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 6.360505] systemd[1]: Starting Create System Files and Directories... second # [ 6.371842] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. test # [ 6.370267] systemd[1]: Starting Create System Files and Directories... second # [ 6.386788] systemd[1]: Finished Firewall. test # [ 6.387102] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. second # [ 6.400292] systemd[1]: Reached target Preparation for Network. second # [ 6.407298] systemd[1]: Starting Network Management... test # [ 6.410432] systemd[1]: Finished Firewall. second # [ 6.414146] (udev-worker)[401]: Network interface NamePolicy= disabled on kernel command line. second # [ 6.418381] (udev-worker)[399]: Network interface NamePolicy= disabled on kernel command line. test # [ 6.417188] systemd[1]: Reached target Preparation for Network. test # [ 6.425045] systemd[1]: Starting Network Management... second # [ 6.439255] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 6.436223] (udev-worker)[417]: Network interface NamePolicy= disabled on kernel command line. second # [ 6.447386] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 6.445570] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 6.453224] (udev-worker)[414]: Network interface NamePolicy= disabled on kernel command line. test # [ 6.458840] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 6.508831] systemd[1]: Finished Create System Files and Directories. test # [ 6.511323] systemd[1]: Finished Create System Files and Directories. second # [ 6.519855] systemd[1]: Starting Rebuild Journal Catalog... test # [ 6.517958] systemd[1]: Starting Rebuild Journal Catalog... second # [ 6.528111] systemd[1]: Starting Record System Boot/Shutdown in UTMP... test # [ 6.527272] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 6.613403] systemd[1]: Finished Record System Boot/Shutdown in UTMP. test # [ 6.615326] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 6.651470] systemd[1]: Finished Rebuild Journal Catalog. test # [ 6.655514] systemd[1]: Finished Rebuild Journal Catalog. second # [ 6.661681] systemd[1]: Starting Update is Completed... test # [ 6.663147] systemd[1]: Starting Update is Completed... second # [ 6.715416] systemd[1]: Finished Update is Completed. test # [ 6.722251] systemd[1]: Finished Update is Completed. second # [ 6.942766] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 6.941653] cfg80211: Loading compiled-in X.509 certificates for regulatory database second # [ 6.963440] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 6.963541] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 6.964593] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 6.967262] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 6.836303] systemd-networkd[453]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. test # [ 6.834375] systemd-networkd[476]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 6.841104] systemd-networkd[453]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. test # [ 6.839731] systemd-networkd[476]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. test # [ 6.844234] systemd-networkd[476]: lo: Link UP second # [ 6.846674] systemd-networkd[453]: lo: Link UP second # [ 6.847738] systemd-networkd[453]: lo: Gained carrier test # [ 6.846138] systemd-networkd[476]: lo: Gained carrier test # [ 6.859405] systemd[1]: Started Network Management. second # [ 6.862339] systemd[1]: Started Network Management. test # [ 6.866919] systemd-networkd[476]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 6.869891] systemd-networkd[476]: eth1: Configuring with /etc/systemd/network/40-eth1.network. second # [ 6.871776] systemd-networkd[453]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 6.874287] systemd-networkd[453]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 6.872448] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # [ 6.877678] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 6.878203] systemd-networkd[476]: eth1: Link UP test # [ 6.879124] systemd-networkd[476]: eth1: Gained carrier second # [ 6.881887] systemd-networkd[453]: eth1: Link UP second # [ 6.886658] systemd-networkd[453]: eth1: Gained carrier test # [ 6.883341] systemd-networkd[476]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 6.888182] systemd-networkd[453]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 7.074645] NET: Registered PF_PACKET protocol family second # [ 7.080508] NET: Registered PF_PACKET protocol family test # [ 6.943971] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. second # [ 6.949865] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 6.952982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. second # [ 6.957690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 6.956296] systemd[1]: Finished Create SUID/SGID Wrappers. second # [ 6.962147] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 7.042371] systemd[1]: Finished register-nix-paths.service. test # [ 7.043576] systemd[1]: Reached target System Initialization. second # [ 7.048111] systemd[1]: Finished register-nix-paths.service. test # [ 7.045626] systemd[1]: Started Discard unused filesystem blocks once a week. second # [ 7.049315] systemd[1]: Reached target System Initialization. test # [ 7.048825] systemd[1]: Started Daily Cleanup of Temporary Directories. second # [ 7.051751] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 7.050087] systemd[1]: Reached target Timer Units. second # [ 7.053199] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 7.051387] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 7.055307] systemd[1]: Reached target Timer Units. test # [ 7.053453] systemd[1]: Listening on Nix Daemon Socket. second # [ 7.057169] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 7.229473] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 second # [ 7.058298] systemd[1]: Listening on Nix Daemon Socket. test # [ 7.058232] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 7.059669] systemd[1]: Listening on Hostname Service Socket. second # [ 7.063291] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 7.061247] systemd[1]: Reached target Socket Units. second # [ 7.064464] systemd[1]: Listening on Hostname Service Socket. second # [ 7.065498] systemd[1]: Reached target Socket Units. second # [ 7.240709] mousedev: PS/2 mouse device common for all mice test # [ 7.065231] systemd[1]: Starting D-Bus System Message Bus... second # [ 7.068838] systemd[1]: Starting D-Bus System Message Bus... second # [ 7.246285] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 test # [ 7.248164] mousedev: PS/2 mouse device common for all mice test # [ 7.267725] ACPI: button: Power Button [PWRF] second # [ 7.278282] ACPI: button: Power Button [PWRF] test # [ 7.279983] rtc_cmos 00:05: RTC can wake from S4 second # [ 7.290906] rtc_cmos 00:05: RTC can wake from S4 test # [ 7.292427] rtc_cmos 00:05: registered as rtc0 test # [ 7.297461] Floppy drive(s): fd0 is 2.88M AMI BIOS test # [ 7.298809] parport_pc 00:03: reported by Plug and Play ACPI test # [ 7.300518] rtc_cmos 00:05: setting system clock to 2026-09-09T00:05:03 UTC (1788912303) second # [ 7.304115] Floppy drive(s): fd0 is 2.88M AMI BIOS test # [ 7.302437] systemd-journald[320]: Time jumped backwards, rotating. second # [ 7.134384] dbus-broker-launch[546]: Looking up NSS user entry for 'systemd-timesync'... second # [ 7.140394] dbus-broker-launch[546]: NSS returned no entry for 'systemd-timesync' second # [ 7.141753] dbus-broker-launch[546]: Invalid user-name in /nix/store/pkmj4sdxqs18al74pm419w7mvxqvs09i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 7.319712] rtc_cmos 00:05: registered as rtc0 test # [ 7.317676] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] second # [ 7.322212] parport_pc 00:03: reported by Plug and Play ACPI test # [ 7.151332] systemd-resolved[351]: Clock change detected. Flushing caches. second # [ 7.329215] rtc_cmos 00:05: setting system clock to 2026-09-09T00:05:03 UTC (1788912303) second # [ 7.331203] systemd-journald[299]: Time jumped backwards, rotating. test # [ 7.329493] FDC 0 is a S82078B second # [ 7.333221] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] test # [ 7.156880] dbus-broker-launch[566]: Looking up NSS user entry for 'systemd-timesync'... test # [ 7.334645] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs test # [ 7.160367] dbus-broker-launch[566]: NSS returned no entry for 'systemd-timesync' test # [ 7.164346] dbus-broker-launch[566]: Invalid user-name in /nix/store/pkmj4sdxqs18al74pm419w7mvxqvs09i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 7.170182] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' second # [ 7.352532] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs test # [ 7.176398] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 7.355933] FDC 0 is a S82078B second # [ 7.183782] systemd-resolved[329]: Clock change detected. Flushing caches. test # [ 7.182160] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/kv22l88laj89v51jwjsnf1vbg7qp3igk-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' second # [ 7.186662] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 7.186925] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zalak21wkk24c0rlmaaqhvwmywz8f6bq-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' test # [ 7.190664] systemd[1]: Started D-Bus System Message Bus. second # [ 7.194623] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 7.202740] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/kv22l88laj89v51jwjsnf1vbg7qp3igk-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 7.205583] dbus-broker-launch[566]: Ready second # [ 7.208165] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zalak21wkk24c0rlmaaqhvwmywz8f6bq-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 7.212260] systemd[1]: Started D-Bus System Message Bus. test # [ 7.215087] systemd[1]: Reached target Basic System. second # [ 7.219306] dbus-broker-launch[546]: Ready test # [ 7.218216] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 7.222839] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 7.227069] systemd[1]: Reached target Basic System. second # [ 7.232046] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 7.230077] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 7.235232] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 7.242792] systemd[1]: Starting Network Manager... test # [ 7.242211] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 7.250972] systemd[1]: Started backdoor.service. test # [ 7.254470] systemd[1]: Starting Network Manager... second # [ 7.272309] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 7.271482] systemd[1]: Started backdoor.service. second # [ 7.449566] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console second # [ 7.290714] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 7.302464] llkkvzg5p3xcxck0byqirpqsh987x8q2-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 7.309599] systemd[1]: Starting Post-Boot Actions... test # [ 7.309294] yci3hny1h84jin598kc3z3w5rndsylf0-wifi-secrets[571]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 7.312880] llkkvzg5p3xcxck0byqirpqsh987x8q2-wifi-secrets[550]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 7.312099] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 7.494781] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console second # [ 7.502627] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 second # [ 7.342257] systemd[1]: Started Reset console on configuration changes. second # connecting to host... second # [ 7.555779] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 second # [ 7.386474] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 7.398445] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 7.536163] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 test # [ 7.536221] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD test # [ 7.578561] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 test # [ 7.649659] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 second # [ 7.625423] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD second # [ 7.688042] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 second # [ 7.688353] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 test # [ 7.649938] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 test # [ 7.685176] Console: switching to colour dummy device 80x25 second # [ 7.720146] Console: switching to colour dummy device 80x25 second # [ 7.770068] [drm] Found bochs VGA, ID 0xb0c5. second # [ 7.770070] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. second # [ 7.427256] systemd[1]: Finished Post-Boot Actions. second # [ 7.601345] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 7.605876] nsncd[556]: Sep 09 00:05:03.779 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 7.609635] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 7.328407] systemd[1]: Starting Name Service Cache Daemon (nsncd)... second # [ 7.613708] systemd[1]: Reached target Host and Network Name Lookups. test # [ 7.612856] systemd[1]: Starting Post-Boot Actions... second # [ 7.616625] systemd[1]: Reached target User and Group Name Lookups. test # [ 7.615192] qhkvsid2d53bk2b82gkhz48ypn2k3ymy-wifi-secrets[572]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 7.618526] systemd[1]: Starting User Login Management... second # [ 7.620793] systemd[1]: Starting Hostname Service... test # [ 7.618504] systemd[1]: Started Reset console on configuration changes. second # [ 7.625299] systemd[1]: Started Hostname Service. test # [ 7.623297] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 7.626690] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. test # [ 7.628976] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 7.631492] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test # [ 7.635918] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 7.641283] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. test # [ 7.645727] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. second # [ 7.825112] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic second # [ 7.825976] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 test # [ 7.651517] systemd[1]: Started Network Manager Script Dispatcher Service. second # [ 7.655397] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 7.654758] systemd[1]: Starting Hostname Service... test # [ 7.834263] [drm] Found bochs VGA, ID 0xb0c5. second # [ 7.663093] systemd-networkd[453]: eth0: Link UP test # [ 7.834821] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. second # [ 7.664367] systemd-networkd[453]: eth0: Gained carrier test # [ 7.662227] systemd[1]: Started Hostname Service. test # [ 7.663264] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. test # [ 7.666576] systemd-networkd[476]: eth0: Link UP test # [ 7.670393] systemd-networkd[476]: eth0: Gained carrier test # [ 7.689692] systemd[1]: Finished Post-Boot Actions. second # [ 7.699705] systemd[1]: Started Network Manager. second # [ 7.700658] systemd[1]: Reached target Network. test # connecting to host... second # [ 7.709360] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 7.707544] systemd[1]: Started Network Manager. second # [ 7.714323] systemd[1]: Starting Permit User Sessions... test # [ 7.723505] nsncd[583]: Sep 09 00:05:04.094 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test # [ 7.730131] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 7.734225] systemd-logind[589]: New seat seat0. test: Guest shell says: b'Spawning backdoor root shell...\n' test: connected to guest root shell test: (connecting took 8.39 seconds) test: (finished: waiting for the VM to finish booting, in 8.39 seconds) second # [ 7.743966] systemd[1]: Started User Login Management. test # [ 7.732941] systemd[1]: Reached target Network. test # [ 7.735522] systemd[1]: Reached target Host and Network Name Lookups. test # [ 7.737618] systemd[1]: Reached target User and Group Name Lookups. test # [ 7.921784] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic test # [ 7.922601] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 test # [ 7.750214] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 7.762884] systemd[1]: Starting linger-users.service... test # [ 7.780100] systemd[1]: Starting User Login Management... second # [ 7.784275] systemd[1]: Starting Virtual Console Setup... test # [ 7.796538] systemd[1]: Starting Permit User Sessions... second # [ 7.810164] systemd[1]: Finished Permit User Sessions. second # [ 7.812914] systemd-logind[589]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) test # [ 7.814107] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 7.890244] systemd[1]: Finished Permit User Sessions. test: (finished: waiting for unit NetworkManager.service, in 8.58 seconds) test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection test # [ 8.121765] ppdev: user-space parallel port driver test # [ 7.957654] systemd-logind[633]: Watching system buttons on /dev/input/event2 (Power Button) test # [ 7.961607] systemd-logind[633]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) second # [ 8.103716] ppdev: user-space parallel port driver second # [ 8.127785] Console: switching to colour frame buffer device 160x50 test # [ 7.968079] systemd-logind[633]: New seat seat0. test # [ 7.977100] systemd-resolved[351]: eth0: Bus client set default route setting: yes second # [ 8.155369] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device test # [ 7.980586] systemd-resolved[351]: eth0: Bus client set DNS server list to: 10.0.2.3 second # [ 7.872986] systemd-logind[589]: Watching system buttons on /dev/input/event2 (Power Button) second # [ 7.985261] systemd[1]: linger-users.service: Deactivated successfully. second # [ 7.986503] systemd[1]: Finished linger-users.service. test # [ 7.983890] NetworkManager[573]: [1788912304.3564] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 7.988776] systemd-resolved[329]: eth0: Bus client set default route setting: yes second # [ 7.990709] systemd-resolved[329]: eth0: Bus client set DNS server list to: 10.0.2.3 second # [ 7.992840] systemd-logind[589]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) test # [ 7.988710] NetworkManager[573]: [1788912304.3609] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 7.994841] systemd[1]: Started Getty on tty1. second # [ 7.996684] systemd[1]: Reached target Login Prompts. second # [ 7.999455] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. second # [ 8.000788] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.06 seconds) cleanup kill QemuMachine (pid 14) second # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/h3l4z7p6wny3phbckwwhy1i2g52pdnj4-python3-3.13.15/bin/python3.13) test # [ 8.017431] systemd[1]: Started User Login Management. test # [ 8.255476] Console: switching to colour frame buffer device 160x50 test # [ 8.271092] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device kill QemuMachine (pid 15) test # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/h3l4z7p6wny3phbckwwhy1i2g52pdnj4-python3-3.13.15/bin/python3.13) (finished: cleanup, in 0.20 seconds) Traceback (most recent call last): File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in sys.exit(main()) ~~~~^^ File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/__init__.py", line 183, in main driver.run_tests() ~~~~~~~~~~~~~~~~^^ File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 434, in run_tests self.test_script() ~~~~~~~~~~~~~~~~^^ File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 392, in test_script exec(self.tests, symbols, None) ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "", line 4, in AssertionError: Expected mock password in connection file: [connection] autoconnect=true id= type=wifi [wifi] mode=infrastructure ssid= [wifi-security] key-mgmt=wpa-psk psk=