build-x86-01: building 8d7mpwcrgvkdgha4svnxhlr1s2rdvlb7-vm-test-run-wifi.drv 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.0 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 # Formatting '/build/vm-state-test/tmp.nSHxmYAoG0', fmt=raw size=1073741824 test # mke2fs 1.47.4 (6-Mar-2025) test # Discarding device blocks: 0/262144 done test # Creating filesystem with 262144 4k blocks and 65536 inodes test # Filesystem UUID: d01fb6e5-30d5-460a-b0f0-876d1e7314a7 test # Superblock backups stored on blocks: test # 32768, 98304, 163840, 229376 test # test # Allocating group tables: 0/8 done test # Writing inode tables: 0/8 done test # Creating journal (8192 blocks): done test # Writing superblocks and filesystem accounting information: 0/8 done test # test # Virtualisation disk image created. test # Starting virtiofs daemons... test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether test: QEMU running (pid 48) test # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether test # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) test # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether test # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... test # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests test # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests test # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests second # Disk image does not exist, creating the virtualisation disk image... second: QEMU running (pid 47) second # Formatting '/build/vm-state-second/tmp.KFRw9Dmn6e', fmt=raw size=1073741824 second # mke2fs 1.47.4 (6-Mar-2025) second # Discarding device blocks: 0/262144 done second # Creating filesystem with 262144 4k blocks and 65536 inodes second # Filesystem UUID: 57bfd2a7-f3f6-450a-a090-9dc8994d558e second # Superblock backups stored on blocks: second # 32768, 98304, 163840, 229376 second # second # Allocating group tables: 0/8 done second # Writing inode tables: 0/8 done second # Creating journal (8192 blocks): done second # Writing superblocks and filesystem accounting information: 0/8 done second # second # Virtualisation disk image created. second # Starting virtiofs daemons... second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether second # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether second # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) second # [2026-09-27T20:10:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether second # [2026-09-27T20:10:34Z INFO virtiofsd] Waiting for vhost-user socket connection... second # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests second # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests second # [2026-09-27T20:10:34Z INFO virtiofsd] Client connected, servicing requests (finished: start all VMs, in 0.15 seconds) test: waiting for unit NetworkManager.service test: waiting for the VM to finish booting second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) second # second # second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 test # test # second # Press Ctrl-B to configure iPXE (PCI 00:02.0)... second # second # second # second # test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 second # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 test # Press Ctrl-B to configure iPXE (PCI 00:02.0)... test # test # test # test # second # Press Ctrl-B to configure iPXE (PCI 00:05.0)... second # second # test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 test # Press Ctrl-B to configure iPXE (PCI 00:05.0)... test # test # second # Booting from ROM... second # Probing EDD (edd=off to disable)... ok test # Booting from ROM... second # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 2026 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/w79m1hl5gbjrvxc7wqb4l1lnjgkhgz23-nixos-system-second-test/init regInfo=/nix/.ro-store/15s93bvbbl42cdf0pl8fwk639pp97aw2-closure-info/registration console=ttyS0,115200n8 console=tty0 second # [ 0.000000] BIOS-provided physical RAM map: second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved second # [ 0.000000] NX (Execute Disable) protection: active second # [ 0.000000] APIC: Static calls initialized second # [ 0.000000] SMBIOS 2.8 present. second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 second # [ 0.000000] DMI: Memory slots populated: 1/1 second # [ 0.000000] Hypervisor detected: KVM second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000 second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 second # [ 0.000000] kvm-clock: using sched offset of 423506138 cycles second # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns second # [ 0.000008] tsc: Detected 4192.120 MHz processor second # [ 0.000607] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000 second # [ 0.000638] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 2026 second # [ 0.000641] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT second # [ 0.002318] found SMP MP-table at [mem 0x000f5450-0x000f545f] second # [ 0.002331] Using GB pages for direct mapping second # [ 0.002430] RAMDISK: [mem 0x3e36d000-0x3ffcffff] second # [ 0.002434] ACPI: Early table checksum verification disabled 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/8f83hrdz2mq01n7jlxrjbsdxh73r414s-nixos-system-test-test/init regInfo=/nix/.ro-store/rq5nplragyhsmq1yyhx5l22m4gykil33-closure-info/registration console=ttyS0,115200n8 console=tty0 test # [ 0.000000] BIOS-provided physical RAM map: second # [ 0.002438] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable second # [ 0.002441] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved second # [ 0.002445] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved second # [ 0.002450] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable second # [ 0.002452] ACPI: FACS 0x000000003FFE0000 000040 test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved second # [ 0.002453] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved second # [ 0.002454] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved second # [ 0.002455] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved second # [ 0.002456] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved second # [ 0.002457] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] test # [ 0.000000] NX (Execute Disable) protection: active test # [ 0.000000] APIC: Static calls initialized second # [ 0.002458] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] test # [ 0.000000] SMBIOS 2.8 present. second # [ 0.002459] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 second # [ 0.002459] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] test # [ 0.000000] DMI: Memory slots populated: 1/1 test # [ 0.000000] Hypervisor detected: KVM second # [ 0.002459] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000 second # [ 0.002460] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 second # [ 0.002460] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] test # [ 0.000000] kvm-clock: using sched offset of 457370093 cycles second # [ 0.002817] No NUMA configuration found second # [ 0.002818] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns second # [ 0.002821] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] test # [ 0.000006] tsc: Detected 4192.120 MHz processor second # [ 0.002892] Zone ranges: test # [ 0.000603] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000 second # [ 0.002892] DMA [mem 0x0000000000001000-0x0000000000ffffff] test # [ 0.000634] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs second # [ 0.002894] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] second # [ 0.002895] Normal empty second # [ 0.002895] Device empty test # [ 0.000636] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT second # [ 0.002896] Movable zone start for each node test # [ 0.002313] found SMP MP-table at [mem 0x000f5450-0x000f545f] second # [ 0.002896] Early memory node ranges test # [ 0.002331] Using GB pages for direct mapping second # [ 0.002896] node 0: [mem 0x0000000000001000-0x000000000009efff] test # [ 0.002426] RAMDISK: [mem 0x3e36c000-0x3ffcffff] second # [ 0.002897] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] test # [ 0.002431] ACPI: Early table checksum verification disabled test # [ 0.002435] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) second # [ 0.002898] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] second # [ 0.002914] On node 0, zone DMA: 1 pages in unavailable ranges test # [ 0.002439] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.003111] On node 0, zone DMA: 97 pages in unavailable ranges test # [ 0.002444] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.016942] On node 0, zone DMA32: 40 pages in unavailable ranges second # [ 0.017779] ACPI: PM-Timer IO Port: 0x608 test # [ 0.002450] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.017794] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) test # [ 0.002452] ACPI: FACS 0x000000003FFE0000 000040 second # [ 0.017824] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 test # [ 0.002453] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.017828] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) test # [ 0.002454] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.017830] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) second # [ 0.017832] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) test # [ 0.002456] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.017834] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) test # [ 0.002457] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) second # [ 0.017836] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) test # [ 0.002458] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] second # [ 0.017841] ACPI: Using ACPI (MADT) for SMP configuration information test # [ 0.002459] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] second # [ 0.017842] ACPI: HPET id: 0x8086a201 base: 0xfed00000 second # [ 0.017848] TSC deadline timer available test # [ 0.002459] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] second # [ 0.017879] CPU topo: Max. logical packages: 1 test # [ 0.002459] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] second # [ 0.017880] CPU topo: Max. logical dies: 1 second # [ 0.017881] CPU topo: Max. dies per package: 1 test # [ 0.002460] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] second # [ 0.017911] CPU topo: Max. threads per core: 1 test # [ 0.002460] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] second # [ 0.017912] CPU topo: Num. cores per package: 1 second # [ 0.017914] CPU topo: Num. threads per package: 1 test # [ 0.002461] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] test # [ 0.002828] No NUMA configuration found second # [ 0.017915] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs test # [ 0.002829] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] second # [ 0.017939] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() test # [ 0.002831] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] second # [ 0.017986] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] test # [ 0.002900] Zone ranges: second # [ 0.017988] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] test # [ 0.002901] DMA [mem 0x0000000000001000-0x0000000000ffffff] second # [ 0.017990] [mem 0x40000000-0xafffffff] available for PCI devices test # [ 0.002902] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] test # [ 0.002903] Normal empty second # [ 0.017992] Booting paravirtualized kernel on KVM test # [ 0.002904] Device empty test # [ 0.002904] Movable zone start for each node test # [ 0.002905] Early memory node ranges second # [ 0.017998] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns test # [ 0.002905] node 0: [mem 0x0000000000001000-0x000000000009efff] second # [ 0.022169] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 test # [ 0.002906] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] second # [ 0.023990] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 second # [ 0.024025] kvm-guest: PV spinlocks disabled, single CPU test # [ 0.002907] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] test # [ 0.002924] On node 0, zone DMA: 1 pages in unavailable ranges test # [ 0.003119] On node 0, zone DMA: 97 pages in unavailable ranges test # [ 0.016269] On node 0, zone DMA32: 40 pages in unavailable ranges test # [ 0.017080] ACPI: PM-Timer IO Port: 0x608 test # [ 0.017093] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) second # [ 0.024027] 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/w79m1hl5gbjrvxc7wqb4l1lnjgkhgz23-nixos-system-second-test/init regInfo=/nix/.ro-store/15s93bvbbl42cdf0pl8fwk639pp97aw2-closure-info/registration console=ttyS0,115200n8 console=tty0 test # [ 0.017114] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 test # [ 0.017116] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) second # [ 0.024103] Unknown kernel command line parameters "regInfo=/nix/.ro-store/15s93bvbbl42cdf0pl8fwk639pp97aw2-closure-info/registration", will be passed to user space. test # [ 0.017118] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) second # [ 0.024296] random: crng init done test # [ 0.017119] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) second # [ 0.024296] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes test # [ 0.017120] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) second # [ 0.025105] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.017120] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) second # [ 0.025405] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.017122] ACPI: Using ACPI (MADT) for SMP configuration information second # [ 0.025433] Fallback order for Node 0: 0 test # [ 0.017123] ACPI: HPET id: 0x8086a201 base: 0xfed00000 second # [ 0.025435] Built 1 zonelists, mobility grouping on. Total pages: 262006 test # [ 0.017126] TSC deadline timer available second # [ 0.025436] Policy zone: DMA32 test # [ 0.017130] CPU topo: Max. logical packages: 1 second # [ 0.027068] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.017130] CPU topo: Max. logical dies: 1 test # [ 0.017131] CPU topo: Max. dies per package: 1 second # [ 0.029591] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 test # [ 0.017134] CPU topo: Max. threads per core: 1 second # [ 0.031307] allocated 2097152 bytes of page_ext test # [ 0.017134] CPU topo: Num. cores per package: 1 second # [ 0.041641] ftrace: allocating 48804 entries in 192 pages test # [ 0.017134] CPU topo: Num. threads per package: 1 second # [ 0.041642] ftrace: allocated 192 pages with 2 groups second # [ 0.042497] Dynamic Preempt: lazy test # [ 0.017135] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs second # [ 0.042640] rcu: Preemptible hierarchical RCU implementation. test # [ 0.017149] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() second # [ 0.042641] rcu: RCU event tracing is enabled. test # [ 0.017177] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] second # [ 0.042642] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. second # [ 0.042643] Trampoline variant of Tasks RCU enabled. test # [ 0.017178] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] second # [ 0.042643] Rude variant of Tasks RCU enabled. test # [ 0.017179] [mem 0x40000000-0xafffffff] available for PCI devices second # [ 0.042643] Tracing variant of Tasks RCU enabled. test # [ 0.017180] Booting paravirtualized kernel on KVM second # [ 0.042644] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. test # [ 0.017184] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns second # [ 0.042645] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.020527] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 second # [ 0.042664] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.022195] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 second # [ 0.042665] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.022227] kvm-guest: PV spinlocks disabled, single CPU second # [ 0.042666] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.046096] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 second # [ 0.046356] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.046363] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns test # [ 0.022229] 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/8f83hrdz2mq01n7jlxrjbsdxh73r414s-nixos-system-test-test/init regInfo=/nix/.ro-store/rq5nplragyhsmq1yyhx5l22m4gykil33-closure-info/registration console=ttyS0,115200n8 console=tty0 second # [ 0.046526] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.051807] Console: colour VGA+ 80x25 test # [ 0.022302] Unknown kernel command line parameters "regInfo=/nix/.ro-store/rq5nplragyhsmq1yyhx5l22m4gykil33-closure-info/registration", will be passed to user space. second # [ 0.051812] printk: legacy console [tty0] enabled test # [ 0.022495] random: crng init done second # [ 0.082968] printk: legacy console [ttyS0] enabled test # [ 0.022496] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes second # [ 0.221500] ACPI: Core revision 20250807 test # [ 0.023294] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.023306] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) second # [ 0.222640] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns test # [ 0.023336] Fallback order for Node 0: 0 second # [ 0.224778] APIC: Switch to symmetric I/O mode setup test # [ 0.023338] Built 1 zonelists, mobility grouping on. Total pages: 262006 second # [ 0.226049] x2apic enabled test # [ 0.023339] Policy zone: DMA32 second # [ 0.226920] APIC: Switched APIC routing to: physical x2apic test # [ 0.025260] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.027871] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 test # [ 0.029814] allocated 2097152 bytes of page_ext second # [ 0.229000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 test # [ 0.039993] ftrace: allocating 48804 entries in 192 pages test # [ 0.039995] ftrace: allocated 192 pages with 2 groups test # [ 0.041159] Dynamic Preempt: lazy second # [ 0.230332] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns test # [ 0.041293] rcu: Preemptible hierarchical RCU implementation. test # [ 0.041294] rcu: RCU event tracing is enabled. second # [ 0.232585] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120) test # [ 0.041295] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. second # [ 0.234709] x86/cpu: User Mode Instruction Prevention (UMIP) activated test # [ 0.041297] Trampoline variant of Tasks RCU enabled. test # [ 0.041298] Rude variant of Tasks RCU enabled. second # [ 0.235885] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 test # [ 0.041298] Tracing variant of Tasks RCU enabled. second # [ 0.236583] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 test # [ 0.041299] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. test # [ 0.041299] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 second # [ 0.238587] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto test # [ 0.041325] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.239583] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl test # [ 0.041326] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.241583] Spectre V2 : Mitigation: Enhanced / Automatic IBRS test # [ 0.041327] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.242583] Speculative Return Stack Overflow: Mitigation: Safe RET test # [ 0.045023] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 test # [ 0.045280] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.243583] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization test # [ 0.045288] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns test # [ 0.045459] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.050799] Console: colour VGA+ 80x25 test # [ 0.050803] printk: legacy console [tty0] enabled second # [ 0.244590] Spectre V2 : Enabling IBPB for BPF test # [ 0.081732] printk: legacy console [ttyS0] enabled test # [ 0.221758] ACPI: Core revision 20250807 second # [ 0.246584] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier second # [ 0.247584] active return thunk: srso_alias_return_thunk test # [ 0.222925] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns second # [ 0.248612] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' test # [ 0.225011] APIC: Switch to symmetric I/O mode setup test # [ 0.226377] x2apic enabled second # [ 0.249583] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' second # [ 0.250583] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' test # [ 0.227433] APIC: Switched APIC routing to: physical x2apic second # [ 0.251583] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' second # [ 0.253583] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' test # [ 0.230014] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 second # [ 0.254583] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' test # [ 0.231430] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.255583] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' test # [ 0.233882] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120) second # [ 0.256583] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' test # [ 0.236879] x86/cpu: User Mode Instruction Prevention (UMIP) activated second # [ 0.258583] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' second # [ 0.259584] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 test # [ 0.238360] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 second # [ 0.260583] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 test # [ 0.239877] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 second # [ 0.261584] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 test # [ 0.240883] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto second # [ 0.263583] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 second # [ 0.264583] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 test # [ 0.241878] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl test # [ 0.243878] Spectre V2 : Mitigation: Enhanced / Automatic IBRS second # [ 0.265583] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 test # [ 0.244878] Speculative Return Stack Overflow: Mitigation: Safe RET second # [ 0.267583] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 test # [ 0.246877] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization second # [ 0.268583] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. test # [ 0.247884] Spectre V2 : Enabling IBPB for BPF test # [ 0.249879] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier test # [ 0.251879] active return thunk: srso_alias_return_thunk test # [ 0.252909] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' test # [ 0.254878] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' test # [ 0.255878] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' test # [ 0.257878] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' test # [ 0.258877] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' test # [ 0.259878] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' test # [ 0.260878] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' test # [ 0.261878] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' test # [ 0.262877] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' test # [ 0.263878] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 test # [ 0.264877] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 test # [ 0.265877] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 test # [ 0.267879] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 test # [ 0.268878] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 test # [ 0.269877] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 second # [ 0.299447] Freeing SMP alternatives memory: 44K test # [ 0.270877] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 second # [ 0.300406] pid_max: default: 32768 minimum: 301 test # [ 0.272877] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. second # [ 0.301711] LSM: initializing lsm=capability,landlock,yama,bpf,ima second # [ 0.302725] landlock: Up and running. second # [ 0.303583] Yama: becoming mindful. second # [ 0.304841] LSM support for eBPF active second # [ 0.305722] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.306605] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.309457] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) second # [ 0.310321] Performance Events: Fam17h+ core perfctr, AMD PMU driver. second # [ 0.310588] ... version: 2 second # [ 0.311538] ... bit width: 48 second # [ 0.312346] ... generic counters: 6 second # [ 0.312677] ... generic bitmap: 000000000000003f second # [ 0.313585] ... fixed-purpose counters: 0 second # [ 0.314539] ... fixed-purpose bitmap: 0000000000000000 second # [ 0.315563] ... value mask: 0000ffffffffffff second # [ 0.316560] ... max period: 00007fffffffffff second # [ 0.317561] ... global_ctrl mask: 000000000000003f second # [ 0.318656] signal: max sigframe size: 3376 second # [ 0.319775] rcu: Hierarchical SRCU implementation. second # [ 0.320590] rcu: Max phase no-delay instances is 400. second # [ 0.325115] smp: Bringing up secondary CPUs ... second # [ 0.325608] smp: Brought up 1 node, 1 CPU second # [ 0.326509] smpboot: Total of 1 processors activated (8384.24 BogoMIPS) test # [ 0.305679] Freeing SMP alternatives memory: 44K test # [ 0.306642] pid_max: default: 32768 minimum: 301 second # [ 0.327805] Memory: 943000K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 97572K reserved, 0K cma-reserved) test # [ 0.307709] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.309068] landlock: Up and running. second # [ 0.328930] devtmpfs: initialized test # [ 0.309878] Yama: becoming mindful. second # [ 0.329814] x86/mm: Memory block size: 128MB test # [ 0.311064] LSM support for eBPF active test # [ 0.311973] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.331391] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.312907] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.332613] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). second # [ 0.333669] pinctrl core: initialized pinctrl subsystem test # [ 0.314993] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2) second # [ 0.334850] PM: RTC time: 20:10:34, date: 2026-09-27 test # [ 0.316330] Performance Events: Fam17h+ core perfctr, AMD PMU driver. test # [ 0.316890] ... version: 2 test # [ 0.317806] ... bit width: 48 second # [ 0.337836] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.318608] ... generic counters: 6 second # [ 0.338893] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.318880] ... generic bitmap: 000000000000003f test # [ 0.319881] ... fixed-purpose counters: 0 second # [ 0.339607] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations test # [ 0.320796] ... fixed-purpose bitmap: 0000000000000000 test # [ 0.321800] ... value mask: 0000ffffffffffff second # [ 0.340695] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations test # [ 0.322806] ... max period: 00007fffffffffff second # [ 0.341599] audit: initializing netlink subsys (disabled) test # [ 0.323815] ... global_ctrl mask: 000000000000003f second # [ 0.342900] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.324898] signal: max sigframe size: 3376 second # [ 0.342902] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.325952] rcu: Hierarchical SRCU implementation. test # [ 0.326886] rcu: Max phase no-delay instances is 400. second # [ 0.343589] audit: type=2000 audit(1790539835.336:1): state=initialized audit_enabled=0 res=1 second # [ 0.345587] thermal_sys: Registered thermal governor 'step_wise' second # [ 0.345589] thermal_sys: Registered thermal governor 'user_space' second # [ 0.346585] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.331538] smp: Bringing up secondary CPUs ... second # [ 0.347611] cpuidle: using governor menu test # [ 0.331901] smp: Brought up 1 node, 1 CPU test # [ 0.332813] smpboot: Total of 1 processors activated (8384.24 BogoMIPS) second # [ 0.350431] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 second # [ 0.351931] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] test # [ 0.334129] Memory: 943040K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 97576K reserved, 0K cma-reserved) test # [ 0.335406] devtmpfs: initialized second # [ 0.352588] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry test # [ 0.336127] x86/mm: Memory block size: 128MB second # [ 0.353600] PCI: Using configuration type 1 for base access second # [ 0.354863] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. test # [ 0.337959] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.338903] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.340029] pinctrl core: initialized pinctrl subsystem test # [ 0.341133] PM: RTC time: 20:10:34, date: 2026-09-27 second # [ 0.359796] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.360584] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.343965] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.345199] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.345920] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.365584] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.347018] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.366585] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.347896] audit: initializing netlink subsys (disabled) test # [ 0.349162] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.349164] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.349880] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.350884] audit: type=2000 audit(1790539835.371:1): state=initialized audit_enabled=0 res=1 test # [ 0.352881] thermal_sys: Registered thermal governor 'user_space' test # [ 0.352884] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.353904] cpuidle: using governor menu second # [ 0.376440] ACPI: Added _OSI(Module Device) second # [ 0.377354] ACPI: Added _OSI(Processor Device) test # [ 0.356672] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 second # [ 0.377586] ACPI: Added _OSI(Processor Aggregator Device) test # [ 0.358156] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] test # [ 0.358882] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry test # [ 0.359897] PCI: Using configuration type 1 for base access second # [ 0.382509] ACPI: 1 ACPI AML tables successfully acquired and loaded test # [ 0.361105] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. second # [ 0.388620] ACPI: Interpreter enabled test # [ 0.366139] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.389493] ACPI: PM: (supports S0 S3 S4 S5) second # [ 0.390343] ACPI: Using IOAPIC for interrupt routing test # [ 0.366879] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.392645] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug second # [ 0.393585] PCI: Using E820 reservations for host bridge windows test # [ 0.371879] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages second # [ 0.394898] ACPI: Enabled 2 GPEs in block 00 to 3F test # [ 0.372879] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.399086] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) second # [ 0.399592] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] second # [ 0.400649] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] test # [ 0.381728] ACPI: Added _OSI(Module Device) test # [ 0.382589] ACPI: Added _OSI(Processor Device) second # [ 0.401690] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] test # [ 0.382880] ACPI: Added _OSI(Processor Aggregator Device) second # [ 0.403042] PCI host bridge to bus 0000:00 second # [ 0.403589] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] second # [ 0.404586] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] second # [ 0.405586] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] test # [ 0.387845] ACPI: 1 ACPI AML tables successfully acquired and loaded second # [ 0.406586] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] second # [ 0.407586] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] second # [ 0.408586] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] second # [ 0.409587] pci_bus 0000:00: root bus resource [bus 00-ff] test # [ 0.393881] ACPI: Interpreter enabled test # [ 0.394750] ACPI: PM: (supports S0 S3 S4 S5) second # [ 0.410699] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint test # [ 0.395624] ACPI: Using IOAPIC for interrupt routing second # [ 0.412271] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint test # [ 0.397925] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug test # [ 0.398880] PCI: Using E820 reservations for host bridge windows test # [ 0.401521] ACPI: Enabled 2 GPEs in block 00 to 3F second # [ 0.415652] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] second # [ 0.416607] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] second # [ 0.417627] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] test # [ 0.406019] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) second # [ 0.418763] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] test # [ 0.406886] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] second # [ 0.420472] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.407946] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] test # [ 0.408983] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] second # [ 0.423596] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] test # [ 0.411032] PCI host bridge to bus 0000:00 second # [ 0.424598] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] test # [ 0.411885] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] second # [ 0.425625] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] test # [ 0.412881] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] second # [ 0.426597] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] test # [ 0.413881] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] test # [ 0.414881] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] second # [ 0.428677] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.415880] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] test # [ 0.416880] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] second # [ 0.431451] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] test # [ 0.417881] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.432546] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] second # [ 0.433626] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] test # [ 0.419582] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint test # [ 0.421684] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint second # [ 0.435811] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.437596] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] second # [ 0.438598] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] second # [ 0.439624] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] test # [ 0.425963] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] test # [ 0.426905] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] second # [ 0.441695] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.427927] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] second # [ 0.444292] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] test # [ 0.429247] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] second # [ 0.444598] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] test # [ 0.430762] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.445635] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] second # [ 0.446597] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] test # [ 0.433899] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] second # [ 0.448632] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.434906] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] test # [ 0.435917] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] second # [ 0.450612] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] test # [ 0.436889] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] second # [ 0.451630] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] test # [ 0.438857] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.453585] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint test # [ 0.440892] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] second # [ 0.455619] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] test # [ 0.441899] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] second # [ 0.456627] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] test # [ 0.442923] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] second # [ 0.458623] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint test # [ 0.444991] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.460519] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] second # [ 0.461594] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] test # [ 0.447689] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] test # [ 0.448765] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] test # [ 0.449923] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] second # [ 0.463536] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint second # [ 0.465584] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] test # [ 0.451947] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.466624] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] test # [ 0.454892] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] second # [ 0.468636] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint test # [ 0.455891] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] test # [ 0.456919] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] second # [ 0.470605] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] test # [ 0.457891] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] second # [ 0.471595] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] second # [ 0.472624] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] test # [ 0.459937] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.474579] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.461900] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] second # [ 0.476595] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] test # [ 0.462919] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] second # [ 0.477595] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] test # [ 0.464828] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint second # [ 0.478624] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] second # [ 0.480773] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint test # [ 0.466900] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] test # [ 0.467919] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] second # [ 0.482383] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] test # [ 0.470029] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint test # [ 0.471904] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] test # [ 0.472919] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] test # [ 0.475073] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint second # [ 0.483745] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint second # [ 0.486460] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] test # [ 0.476909] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] test # [ 0.477919] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] second # [ 0.487780] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint second # [ 0.489627] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] test # [ 0.479835] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.490944] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.492264] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] test # [ 0.483545] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] test # [ 0.483893] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] second # [ 0.492888] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint test # [ 0.484921] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] second # [ 0.494072] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO test # [ 0.486828] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.494929] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint second # [ 0.496634] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] test # [ 0.489719] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] second # [ 0.497602] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] test # [ 0.490893] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] second # [ 0.499073] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint test # [ 0.491922] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] second # [ 0.500492] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] test # [ 0.493836] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint test # [ 0.495733] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] second # [ 0.506584] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 second # [ 0.507725] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 second # [ 0.508710] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 second # [ 0.509710] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 second # [ 0.510728] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 second # [ 0.511716] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 test # [ 0.497035] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint second # [ 0.512717] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 test # [ 0.499721] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] second # [ 0.513709] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 second # [ 0.514633] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 test # [ 0.501285] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint second # [ 0.515601] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 test # [ 0.502702] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] second # [ 0.516600] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 second # [ 0.517600] ACPI: PCI: Interrupt link GSID configured for IRQ 19 test # [ 0.504128] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.518597] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 second # [ 0.519597] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 test # [ 0.505592] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] second # [ 0.520598] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 test # [ 0.506245] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint second # [ 0.521597] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 test # [ 0.507530] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO second # [ 0.524160] iommu: Default domain type: Translated second # [ 0.524592] iommu: DMA domain TLB invalidation policy: lazy mode test # [ 0.508230] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint second # [ 0.525814] ACPI: bus type USB registered second # [ 0.526636] usbcore: registered new interface driver usbfs test # [ 0.509935] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] second # [ 0.527600] usbcore: registered new interface driver hub test # [ 0.510890] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] second # [ 0.528597] usbcore: registered new device driver usb second # [ 0.530503] NetLabel: Initializing test # [ 0.512482] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint second # [ 0.531189] NetLabel: domain hash size = 128 second # [ 0.531584] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO test # [ 0.513928] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] second # [ 0.532625] NetLabel: unlabeled traffic allowed by default second # [ 0.533598] PCI: Using ACPI for IRQ routing test # [ 0.520179] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 test # [ 0.521010] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 test # [ 0.522016] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 test # [ 0.523016] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 test # [ 0.524017] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 test # [ 0.525074] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 test # [ 0.526085] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 test # [ 0.527005] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 test # [ 0.527929] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 test # [ 0.528899] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 test # [ 0.529896] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 test # [ 0.530893] ACPI: PCI: Interrupt link GSID configured for IRQ 19 test # [ 0.531893] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 test # [ 0.532897] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 test # [ 0.533895] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 test # [ 0.534902] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 test # [ 0.537027] iommu: Default domain type: Translated test # [ 0.537890] iommu: DMA domain TLB invalidation policy: lazy mode test # [ 0.539131] ACPI: bus type USB registered test # [ 0.539951] usbcore: registered new interface driver usbfs test # [ 0.540910] usbcore: registered new interface driver hub test # [ 0.541893] usbcore: registered new device driver usb test # [ 0.543694] NetLabel: Initializing test # [ 0.544485] NetLabel: domain hash size = 128 test # [ 0.544881] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO test # [ 0.545958] NetLabel: unlabeled traffic allowed by default test # [ 0.546894] PCI: Using ACPI for IRQ routing second # [ 0.613144] pci 0000:00:01.0: vgaarb: setting as boot VGA device second # [ 0.613581] pci 0000:00:01.0: vgaarb: bridge control possible second # [ 0.613581] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none second # [ 0.613592] vgaarb: loaded second # [ 0.614518] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 second # [ 0.615412] hpet0: 3 comparators, 64-bit 100.000000 MHz counter second # [ 0.619671] clocksource: Switched to clocksource kvm-clock second # [ 0.622932] VFS: Disk quotas dquot_6.6.0 second # [ 0.623818] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.625479] pnp: PnP ACPI init second # [ 0.626417] ACPI: IRQ 4 override to edge(!), high(!) second # [ 0.627600] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved second # [ 0.629535] pnp: PnP ACPI: found 5 devices second # [ 0.636793] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns second # [ 0.638617] clocksource: Switched to clocksource acpi_pm second # [ 0.639829] NET: Registered PF_INET protocol family second # [ 0.641454] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.626499] pci 0000:00:01.0: vgaarb: setting as boot VGA device test # [ 0.626875] pci 0000:00:01.0: vgaarb: bridge control possible test # [ 0.626875] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none test # [ 0.626885] vgaarb: loaded test # [ 0.627746] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 test # [ 0.628717] hpet0: 3 comparators, 64-bit 100.000000 MHz counter second # [ 0.655096] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.657072] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.633012] clocksource: Switched to clocksource kvm-clock second # [ 0.658739] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.660403] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.661974] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.636564] VFS: Disk quotas dquot_6.6.0 test # [ 0.637456] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.663390] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.639106] pnp: PnP ACPI init second # [ 0.664995] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.640166] ACPI: IRQ 4 override to edge(!), high(!) second # [ 0.666424] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.641546] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved second # [ 0.667968] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.643411] pnp: PnP ACPI: found 5 devices second # [ 0.669171] NET: Registered PF_XDP protocol family second # [ 0.670263] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] second # [ 0.671538] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] second # [ 0.672811] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] second # [ 0.674260] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] second # [ 0.675658] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] test # [ 0.650628] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns second # [ 0.677064] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] test # [ 0.652416] clocksource: Switched to clocksource acpi_pm second # [ 0.679116] ACPI: \_SB_.GSIA: Enabled at IRQ 16 test # [ 0.653666] NET: Registered PF_INET protocol family second # [ 0.681169] ACPI: \_SB_.GSIB: Enabled at IRQ 17 test # [ 0.654922] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) second # [ 0.683102] ACPI: \_SB_.GSIC: Enabled at IRQ 18 second # [ 0.685101] ACPI: \_SB_.GSID: Enabled at IRQ 19 second # [ 0.686872] PCI: CLS 0 bytes, default 64 second # [ 0.687951] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.690365] Trying to unpack rootfs image as initramfs... test # [ 0.669873] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.671750] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.673405] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.675066] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) test # [ 0.676584] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.678040] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.679639] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.681030] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.682544] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.683805] NET: Registered PF_XDP protocol family test # [ 0.684905] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] test # [ 0.686192] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] test # [ 0.687461] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] test # [ 0.688883] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] test # [ 0.690275] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] test # [ 0.691661] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] test # [ 0.693761] ACPI: \_SB_.GSIA: Enabled at IRQ 16 test # [ 0.695932] ACPI: \_SB_.GSIB: Enabled at IRQ 17 test # [ 0.697972] ACPI: \_SB_.GSIC: Enabled at IRQ 18 test # [ 0.699963] ACPI: \_SB_.GSID: Enabled at IRQ 19 second # [ 0.726592] Initialise system trusted keyrings test # [ 0.701795] PCI: CLS 0 bytes, default 64 test # [ 0.702874] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns second # [ 0.730301] workingset: timestamp_bits=40 max_order=18 bucket_order=0 test # [ 0.705012] Trying to unpack rootfs image as initramfs... second # [ 0.749945] Key type asymmetric registered second # [ 0.750989] Asymmetric key parser 'x509' registered second # [ 0.754317] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) second # [ 0.758311] io scheduler mq-deadline registered second # [ 0.761258] io scheduler kyber registered second # [ 0.762712] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled second # [ 0.764602] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A test # [ 0.743143] Initialise system trusted keyrings second # [ 0.772294] Linux agpgart interface v0.103 test # [ 0.746674] workingset: timestamp_bits=40 max_order=18 bucket_order=0 second # [ 0.775327] ACPI: bus type drm_connector registered second # [ 0.776835] usbcore: registered new interface driver usbserial_generic second # [ 0.778277] usbserial: USB Serial support registered for generic second # [ 0.782273] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. second # [ 0.782273] Please enable it if your BIOS has the CPPC option. second # [ 0.785434] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled test # [ 0.762009] Key type asymmetric registered test # [ 0.766631] Asymmetric key parser 'x509' registered second # [ 0.792433] drop_monitor: Initializing network drop monitor service second # [ 0.793978] NET: Registered PF_INET6 protocol family test # [ 0.767808] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) test # [ 0.771743] io scheduler mq-deadline registered second # [ 0.797948] Segment Routing with IPv6 test # [ 0.774629] io scheduler kyber registered second # [ 0.801266] In-situ OAM (IOAM) with IPv6 second # [ 0.802532] IPI shorthand broadcast: enabled test # [ 0.777141] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.780784] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A second # [ 0.810540] sched_clock: Marking stable (629022345, 181218001)->(911178955, -100938609) test # [ 0.786635] Linux agpgart interface v0.103 test # [ 0.787556] ACPI: bus type drm_connector registered second # [ 0.816412] registered taskstats version 1 second # [ 0.817486] Loading compiled-in X.509 certificates test # [ 0.792218] usbcore: registered new interface driver usbserial_generic test # [ 0.793582] usbserial: USB Serial support registered for generic test # [ 0.796642] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. test # [ 0.796642] Please enable it if your BIOS has the CPPC option. test # [ 0.799364] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled test # [ 0.803753] drop_monitor: Initializing network drop monitor service test # [ 0.805154] NET: Registered PF_INET6 protocol family second # [ 0.832389] Demotion targets for Node 0: null second # [ 0.833481] Key type .fscrypt registered test # [ 0.809079] Segment Routing with IPv6 second # [ 0.836269] Key type fscrypt-provisioning registered second # [ 0.837448] ima: No TPM chip found, activating TPM-bypass! test # [ 0.812656] In-situ OAM (IOAM) with IPv6 test # [ 0.813842] IPI shorthand broadcast: enabled second # [ 0.840267] ima: Allocated hash algorithm: sha1 second # [ 0.841332] ima: No architecture policies found second # [ 0.844414] PM: Magic number: 10:786:195 test # [ 0.819486] sched_clock: Marking stable (635021010, 183588558)->(914398926, -95789358) second # [ 0.846096] RAS: Correctable Errors collector initialized. test # [ 0.825894] registered taskstats version 1 test # [ 0.826979] Loading compiled-in X.509 certificates second # [ 0.856297] clk: Disabling unused clocks second # [ 0.857172] PM: genpd: Disabling unused power domains test # [ 0.842759] Demotion targets for Node 0: null test # [ 0.843852] Key type .fscrypt registered test # [ 0.846631] Key type fscrypt-provisioning registered test # [ 0.847788] ima: No TPM chip found, activating TPM-bypass! test # [ 0.850629] ima: Allocated hash algorithm: sha1 test # [ 0.851679] ima: No architecture policies found test # [ 0.854933] PM: Magic number: 10:786:195 test # [ 0.858821] RAS: Correctable Errors collector initialized. test # [ 0.866969] clk: Disabling unused clocks test # [ 0.869642] PM: genpd: Disabling unused power domains second # [ 0.997086] Freeing initrd memory: 29068K second # [ 1.000192] Freeing unused decrypted memory: 2028K second # [ 1.003413] Freeing unused kernel image (initmem) memory: 3656K second # [ 1.004881] Write protecting the kernel read-only data: 32768k second # [ 1.006865] Freeing unused kernel image (text/rodata gap) memory: 1168K second # [ 1.008582] Freeing unused kernel image (rodata/data gap) memory: 676K test # [ 1.015090] Freeing initrd memory: 29072K second # [ 1.042717] x86/mm: Checked W+X mappings: passed, no W+X pages found. second # [ 1.044120] Run /init as init process test # [ 1.018240] Freeing unused decrypted memory: 2028K test # [ 1.021140] Freeing unused kernel image (initmem) memory: 3656K test # [ 1.022641] Write protecting the kernel read-only data: 32768k test # [ 1.024702] Freeing unused kernel image (text/rodata gap) memory: 1168K test # [ 1.026508] Freeing unused kernel image (rodata/data gap) memory: 676K second # [ 1.054411] systemd[1]: Inserted module 'autofs4' second # [ 1.070270] fuse: init (API version 7.45) second # [ 1.076661] ACPI: \_SB_.GSIG: Enabled at IRQ 22 second # [ 1.079501] ACPI: \_SB_.GSIH: Enabled at IRQ 23 second # [ 1.082915] ACPI: \_SB_.GSIE: Enabled at IRQ 20 second # [ 1.085523] ACPI: \_SB_.GSIF: Enabled at IRQ 21 test # [ 1.059882] x86/mm: Checked W+X mappings: passed, no W+X pages found. test # [ 1.061243] Run /init as init process second # [ 1.091109] virtiofs virtio5: discovered new tag: nix-store second # [ 1.093437] virtiofs virtio5: virtio_fs_setup_dax: No cache capability test # [ 1.071445] systemd[1]: Inserted module 'autofs4' second # [ 1.101061] virtiofs virtio6: discovered new tag: shared second # [ 1.103281] virtiofs virtio6: virtio_fs_setup_dax: No cache capability second # [ 1.107262] virtiofs virtio7: discovered new tag: xchg second # [ 1.109298] virtiofs virtio7: virtio_fs_setup_dax: No cache capability test # [ 1.088551] fuse: init (API version 7.45) test # [ 1.095129] ACPI: \_SB_.GSIG: Enabled at IRQ 22 test # [ 1.097926] ACPI: \_SB_.GSIH: Enabled at IRQ 23 test # [ 1.101282] ACPI: \_SB_.GSIE: Enabled at IRQ 20 test # [ 1.103562] ACPI: \_SB_.GSIF: Enabled at IRQ 21 second # [ 1.129873] systemd[1]: Successfully made /usr/ read-only. test # [ 1.109333] virtiofs virtio5: discovered new tag: nix-store test # [ 1.111408] virtiofs virtio5: virtio_fs_setup_dax: No cache capability test # [ 1.119948] virtiofs virtio6: discovered new tag: shared test # [ 1.121966] virtiofs virtio6: virtio_fs_setup_dax: No cache capability test # [ 1.126187] virtiofs virtio7: discovered new tag: xchg test # [ 1.128256] virtiofs virtio7: virtio_fs_setup_dax: No cache capability test # [ 1.149140] systemd[1]: Successfully made /usr/ read-only. second # [ 1.466036] systemd[1]: systemd 261.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.472068] systemd[1]: Detected virtualization kvm. second # [ 1.473159] systemd[1]: Detected architecture x86-64. second # [ 1.474275] systemd[1]: Running in initrd. second # [ 1.475483] systemd[1]: Initializing machine ID from random generator. second # [ 1.477059] systemd[1]: Hostname set to . test # [ 1.485692] systemd[1]: systemd 261.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.491817] systemd[1]: Detected virtualization kvm. test # [ 1.493049] systemd[1]: Detected architecture x86-64. test # [ 1.494244] systemd[1]: Running in initrd. test # [ 1.495542] systemd[1]: Initializing machine ID from random generator. test # [ 1.497293] systemd[1]: Hostname set to . second # [ 1.661082] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.693141] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.670279] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.697457] systemd[1]: Created slice Slice /system/modprobe. second # [ 1.698946] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 1.700707] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.702123] systemd[1]: Reached target Path Units. second # [ 1.703289] systemd[1]: Reached target Slice Units. second # [ 1.704436] systemd[1]: Reached target Swaps. second # [ 1.705487] systemd[1]: Reached target Timer Units. second # [ 1.706751] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.708332] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.709795] systemd[1]: Listening on Journal Sockets. second # [ 1.711065] systemd[1]: Listening on udev Control Socket. second # [ 1.720886] systemd[1]: Listening on udev Kernel Socket. second # [ 1.722118] systemd[1]: Reached target Socket Units. second # [ 1.724307] systemd[1]: Starting Create List of Static Device Nodes... test # [ 1.701677] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.729136] systemd[1]: Starting Load Kernel Module configfs... test # [ 1.705870] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.707362] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.709148] systemd[1]: Expecting device /dev/disk/by-label/nixos... test # [ 1.710616] systemd[1]: Reached target Path Units. second # [ 1.737304] systemd[1]: Starting Journal Service... test # [ 1.711757] systemd[1]: Reached target Slice Units. test # [ 1.712943] systemd[1]: Reached target Swaps. test # [ 1.714008] systemd[1]: Reached target Timer Units. test # [ 1.715263] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.716795] systemd[1]: Listening on Journal Socket (/dev/log). test # [ 1.718299] systemd[1]: Listening on Journal Sockets. second # [ 1.744602] systemd[1]: Starting Load Kernel Modules... second # [ 1.747368] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 1.754030] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.719686] systemd[1]: Listening on udev Control Socket. test # [ 1.730687] systemd[1]: Listening on udev Kernel Socket. test # [ 1.731929] systemd[1]: Reached target Socket Units. test # [ 1.734069] systemd[1]: Starting Create List of Static Device Nodes... test # [ 1.740715] systemd[1]: Starting Load Kernel Module configfs... second # [ 1.769518] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.775881] systemd[1]: modprobe@configfs.service: Deactivated successfully. test # [ 1.750831] systemd[1]: Starting Journal Service... second # [ 1.779067] systemd-journald[65]: Collecting audit messages is disabled. second # [ 1.784769] systemd[1]: Finished Load Kernel Module configfs. test # [ 1.759160] systemd[1]: Starting Load Kernel Modules... test # [ 1.762710] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 1.791843] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config second # [ 1.795537] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.771685] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.804418] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 1.807357] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.785761] systemd[1]: Finished Create List of Static Device Nodes. test # [ 1.788029] systemd-journald[65]: Collecting audit messages is disabled. test # [ 1.794259] systemd[1]: modprobe@configfs.service: Deactivated successfully. test # [ 1.802150] systemd[1]: Finished Load Kernel Module configfs. test # [ 1.808091] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config second # [ 1.838893] systemd[1]: Finished Load Kernel Modules. test # [ 1.813073] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. second # [ 1.845400] systemd[1]: Starting Apply Kernel Variables... test # [ 1.819265] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.822649] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev second # [ 1.860413] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.870465] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 1.857143] systemd[1]: Finished Load Kernel Modules. second # [ 1.885471] systemd[1]: Finished Apply Kernel Variables. test # [ 1.863757] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.873040] systemd[1]: Starting Apply Kernel Variables... second # [ 1.906039] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.885688] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.911590] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.915383] systemd[1]: Reached target Local File Systems. second # [ 1.923453] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 1.744331] systemd-modules-load[66]: Inserted module 'dm_mod' second # [ 1.747500] systemd-modules-load[66]: Inserted module 'virtio_balloon' second # [ 1.749427] systemd-modules-load[66]: Inserted module 'virtio_gpu' second # [ 1.938520] systemd[1]: Started Journal Service. test # [ 1.918379] systemd[1]: Finished Apply Kernel Variables. test # [ 1.924710] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.774276] systemd[1]: Starting Create System Files and Directories... test # [ 1.930948] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.749604] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.935698] systemd[1]: Reached target Local File Systems. test # test # [ 1.753429] systemd-modules-load[66]: Inserted module 'virtio_balloon' test # [ 1.754797] systemd-modules-load[66]: Inserted module 'virtio_gpu' test # [ 1.943811] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.950809] systemd[1]: Started Journal Service. second # [ 1.797273] systemd[1]: Finished Create System Files and Directories. second # [ 1.805236] systemd-udevd[73]: Using default interface naming scheme 'v261'. test # [ 1.785381] systemd[1]: Starting Create System Files and Directories... second # [ 1.827388] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.810312] systemd-udevd[73]: Using default interface naming scheme 'v261'. second # [ 1.839790] systemd[1]: Finished Coldplug All udev Devices. test # [ 1.812134] systemd[1]: Finished Create System Files and Directories. second # [ 1.840959] systemd[1]: Reached target System Initialization. second # [ 1.842104] systemd[1]: Reached target Basic System. test # [ 1.834849] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.842808] systemd[1]: Finished Coldplug All udev Devices. test # [ 1.843896] systemd[1]: Reached target System Initialization. test # [ 1.845061] systemd[1]: Reached target Basic System. second # [ 2.233641] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 second # [ 2.245641] serio: i8042 KBD port at 0x60,0x64 irq 1 second # [ 2.246583] serio: i8042 AUX port at 0x60,0x64 irq 12 second # [ 2.248668] virtio_blk virtio2: 1/0/0 default/read/poll queues second # [ 2.255116] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) test # [ 2.231529] virtio_blk virtio2: 1/0/0 default/read/poll queues second # [ 2.266319] ehci-pci 0000:00:1d.7: EHCI Host Controller second # [ 2.267181] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 test # [ 2.242497] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 second # [ 2.269094] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 second # [ 2.276361] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 test # [ 2.250944] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 2.277443] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 second # [ 2.279310] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 test # [ 2.255393] serio: i8042 KBD port at 0x60,0x64 irq 1 second # [ 2.281995] usb usb1: Product: EHCI Host Controller second # [ 2.283017] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd second # [ 2.285273] usb usb1: SerialNumber: 0000:00:1d.7 second # [ 2.286466] hub 1-0:1.0: USB hub found test # [ 2.261612] serio: i8042 AUX port at 0x60,0x64 irq 12 second # [ 2.288243] hub 1-0:1.0: 6 ports detected second # [ 2.294834] uhci_hcd 0000:00:1d.0: UHCI Host Controller second # [ 2.295725] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 test # [ 2.270376] ehci-pci 0000:00:1d.7: EHCI Host Controller test # [ 2.271289] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 test # [ 2.273422] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 second # [ 2.306266] uhci_hcd 0000:00:1d.0: detected 2 ports test # [ 2.281648] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 test # [ 2.282797] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 test # [ 2.285537] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 second # [ 2.313805] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 test # [ 2.289616] usb usb1: Product: EHCI Host Controller test # [ 2.290476] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd test # [ 2.291669] usb usb1: SerialNumber: 0000:00:1d.7 test # [ 2.294152] hub 1-0:1.0: USB hub found test # [ 2.295875] hub 1-0:1.0: 6 ports detected second # [ 2.321601] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 second # [ 2.322941] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 test # [ 2.298125] uhci_hcd 0000:00:1d.0: UHCI Host Controller test # [ 2.299043] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 second # [ 2.327200] SCSI subsystem initialized test # [ 2.311668] uhci_hcd 0000:00:1d.0: detected 2 ports second # [ 2.339810] usb usb2: Product: UHCI Host Controller test # [ 2.319411] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 second # [ 2.349535] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd test # [ 2.326471] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 second # [ 2.172188] systemd[1]: Starting Virtual Console Setup... test # [ 2.328801] SCSI subsystem initialized second # [ 2.174916] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.333231] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 second # [ 2.362655] usb usb2: SerialNumber: 0000:00:1d.0 second # [ 2.366433] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 test # [ 2.341864] usb usb2: Product: UHCI Host Controller test # [ 2.349408] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd test # [ 2.350615] usb usb2: SerialNumber: 0000:00:1d.0 second # [ 2.196717] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.173617] systemd[1]: Starting Virtual Console Setup... second # [ 2.206314] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 2.389757] hub 2-0:1.0: USB hub found second # [ 2.209364] systemd[1]: Finished Virtual Console Setup. second # [ 2.393720] hub 2-0:1.0: 2 ports detected test # [ 2.369759] hub 2-0:1.0: USB hub found test # [ 2.191247] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.404088] uhci_hcd 0000:00:1d.1: UHCI Host Controller test # [ 2.199167] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.413242] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 test # [ 2.388936] hub 2-0:1.0: 2 ports detected test # [ 2.207653] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 2.418348] uhci_hcd 0000:00:1d.1: detected 2 ports second # [ 2.239359] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.211358] systemd[1]: Finished Virtual Console Setup. second # [ 2.240503] systemd[1]: Reached target Initrd Root Device. second # [ 2.244923] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 2.403147] uhci_hcd 0000:00:1d.1: UHCI Host Controller second # [ 2.429312] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 test # [ 2.404055] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 second # [ 2.430842] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 second # [ 2.438296] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 test # [ 2.412438] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 second # [ 2.441177] usb usb3: Product: UHCI Host Controller second # [ 2.444157] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd second # [ 2.445738] usb usb3: SerialNumber: 0000:00:1d.1 second # [ 2.447918] hub 3-0:1.0: USB hub found test # [ 2.241263] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.242708] systemd[1]: Reached target Initrd Root Device. second # [ 2.273496] systemd-fsck[105]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 2.456735] hub 3-0:1.0: 2 ports detected test # [ 2.246735] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 2.459322] uhci_hcd 0000:00:1d.2: UHCI Host Controller test # [ 2.434045] uhci_hcd 0000:00:1d.1: detected 2 ports second # [ 2.460197] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 second # [ 2.465317] uhci_hcd 0000:00:1d.2: detected 2 ports test # [ 2.440235] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 second # [ 2.467293] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 second # [ 2.469172] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode second # [ 2.471012] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 second # [ 2.472384] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 test # [ 2.446814] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 second # [ 2.473886] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) second # [ 2.475290] ahci 0000:00:1f.2: flags: 64bit ncq only test # [ 2.452711] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 second # [ 2.297920] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.454191] usb usb3: Product: UHCI Host Controller second # [ 2.481054] usb usb4: Product: UHCI Host Controller second # [ 2.482345] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd test # [ 2.456666] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd test # [ 2.457566] usb usb3: SerialNumber: 0000:00:1d.1 second # [ 2.486280] usb usb4: SerialNumber: 0000:00:1d.2 second # [ 2.488373] hub 4-0:1.0: USB hub found second # [ 2.489601] scsi host0: ahci second # [ 2.491958] scsi host1: ahci test # [ 2.281890] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 2.493352] hub 4-0:1.0: 2 ports detected test # [ 2.467614] hub 3-0:1.0: USB hub found second # [ 2.496278] scsi host2: ahci test # [ 2.288669] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.473548] hub 3-0:1.0: 2 ports detected second # [ 2.500522] scsi host3: ahci second # [ 2.502523] scsi host4: ahci test # [ 2.477423] uhci_hcd 0000:00:1d.2: UHCI Host Controller test # [ 2.480752] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 test # [ 2.484714] uhci_hcd 0000:00:1d.2: detected 2 ports second # [ 2.511603] scsi host5: ahci test # [ 2.486110] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 second # [ 2.512889] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 test # [ 2.487759] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode test # [ 2.490182] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 test # [ 2.491954] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) test # [ 2.493452] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 test # [ 2.495678] ahci 0000:00:1f.2: flags: 64bit ncq only second # [ 2.522293] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 test # [ 2.497428] usb usb4: Product: UHCI Host Controller test # [ 2.499616] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd test # [ 2.500503] usb usb4: SerialNumber: 0000:00:1d.2 test # [ 2.503769] scsi host0: ahci second # [ 2.529253] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 second # [ 2.533007] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 test # [ 2.508829] scsi host1: ahci second # [ 2.534379] usb 1-1: new high-speed USB device number 2 using ehci-pci test # [ 2.509912] hub 4-0:1.0: USB hub found second # [ 2.535779] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 test # [ 2.511889] scsi host2: ahci second # [ 2.537367] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 test # [ 2.512869] hub 4-0:1.0: 2 ports detected test # [ 2.515737] scsi host3: ahci test # [ 2.519703] scsi host4: ahci test # [ 2.521362] scsi host5: ahci test # [ 2.526772] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 test # [ 2.533628] usb 1-1: new high-speed USB device number 2 using ehci-pci test # [ 2.539082] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 test # [ 2.545770] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 test # [ 2.550642] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 test # [ 2.552887] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 test # [ 2.554340] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 second # [ 2.665286] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 second # [ 2.666673] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 second # [ 2.668369] usb 1-1: Product: QEMU USB Tablet second # [ 2.669169] usb 1-1: Manufacturer: QEMU second # [ 2.670248] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 second # [ 2.685849] hid: raw HID events driver (C) Jiri Kosina test # [ 2.664783] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 test # [ 2.666250] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 test # [ 2.668066] usb 1-1: Product: QEMU USB Tablet test # [ 2.669026] usb 1-1: Manufacturer: QEMU test # [ 2.669933] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 test # [ 2.688349] hid: raw HID events driver (C) Jiri Kosina second # [ 2.586389] systemd[1]: Mounting /sysroot... test # [ 2.601148] systemd[1]: Mounting /sysroot... second # [ 2.851864] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) second # [ 2.852972] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 second # [ 2.854096] ata3.00: applying bridge limits second # [ 2.854988] ata3.00: configured for UDMA/100 second # [ 2.855970] ata4: SATA link down (SStatus 0 SControl 300) second # [ 2.857101] ata6: SATA link down (SStatus 0 SControl 300) second # [ 2.858245] ata2: SATA link down (SStatus 0 SControl 300) second # [ 2.859366] ata5: SATA link down (SStatus 0 SControl 300) second # [ 2.860407] ata1: SATA link down (SStatus 0 SControl 300) second # [ 2.861850] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 test # [ 2.869321] ata2: SATA link down (SStatus 0 SControl 300) test # [ 2.870664] ata1: SATA link down (SStatus 0 SControl 300) test # [ 2.872187] ata4: SATA link down (SStatus 0 SControl 300) test # [ 2.873561] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) test # [ 2.874774] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 test # [ 2.875899] ata3.00: applying bridge limits test # [ 2.876891] ata5: SATA link down (SStatus 0 SControl 300) test # [ 2.878054] ata6: SATA link down (SStatus 0 SControl 300) test # [ 2.879148] ata3.00: configured for UDMA/100 test # [ 2.880381] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 second # [ 2.917428] usbcore: registered new interface driver usbhid second # [ 2.924251] usbhid: USB HID core driver second # [ 2.938598] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 second # [ 2.946462] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 second # [ 2.949897] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray second # [ 2.958110] EXT4-fs (vda): mounted filesystem 57bfd2a7-f3f6-450a-a090-9dc8994d558e r/w with ordered data mode. Quota mode: none. test # [ 2.935185] usbcore: registered new interface driver usbhid second # [ 2.782598] systemd[1]: Mounted /sysroot. second # [ 2.786079] systemd[1]: Reached target Initrd Root File System. test # [ 2.941632] usbhid: USB HID core driver second # [ 2.968517] cdrom: Uniform CD-ROM driver Revision: 3.20 second # [ 2.789084] systemd[1]: Starting Mountpoints Configured in the Real Root... second # [ 2.805614] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.960688] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 second # [ 2.809395] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)... second # [ 2.812619] systemd[1]: Reloading... test # [ 2.968063] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 test # [ 2.974977] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray test # [ 2.979563] EXT4-fs (vda): mounted filesystem d01fb6e5-30d5-460a-b0f0-876d1e7314a7 r/w with ordered data mode. Quota mode: none. test # [ 2.803813] systemd[1]: Mounted /sysroot. test # [ 2.805458] systemd[1]: Reached target Initrd Root File System. test # [ 2.990280] cdrom: Uniform CD-ROM driver Revision: 3.20 test # [ 2.809394] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.825962] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.830430] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.833084] systemd[1]: Reloading... second # [ 2.882607] systemd[1]: Reloading finished in 70 ms. second # [ 2.892827] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace... second # [ 2.896122] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace... second # [ 2.901156] systemd[1]: initrd-parse-etc.service: Deactivated successfully. second # [ 2.902896] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.904218] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.900698] systemd[1]: Reloading finished in 68 ms. test # [ 2.914586] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... test # [ 2.918173] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... test # [ 2.923949] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.925847] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 2.927658] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. second # [ 3.587106] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.590088] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.593911] systemd[1]: Mounting /sysroot/run... second # [ 3.597695] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.602171] systemd[1]: Mounting /sysroot/tmp/xchg... second # [ 3.629327] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.602143] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.630911] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 3.605157] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.635080] systemd[1]: Mounted /sysroot/run. second # [ 3.638063] systemd[1]: Mounted /sysroot/tmp/shared. test # [ 3.610146] systemd[1]: Mounting /sysroot/run... second # [ 3.639440] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.615473] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.643831] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.622159] systemd[1]: Mounting /sysroot/tmp/xchg... second # [ 3.654646] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.656586] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.659113] systemd[1]: Mounting /sysroot/nix/store... test # [ 3.640818] systemd[1]: Mounted /sysroot/run. test # [ 3.643094] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.644206] systemd[1]: Mounted /sysroot/nix/.rw-store. second # [ 3.677327] systemd[1]: Mounted /sysroot/nix/store. test # [ 3.649380] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.678984] systemd[1]: Reached target Initrd File Systems. test # [ 3.652189] systemd[1]: Mounted /sysroot/tmp/xchg. second # [ 3.680928] systemd[1]: Starting Find NixOS closure... second # [ 3.683743] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 3.655828] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.665560] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.667620] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.670118] systemd[1]: Mounting /sysroot/nix/store... second # [ 3.702727] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 3.707749] systemd[1]: Finished Find NixOS closure. second # [ 3.709185] systemd[1]: Reached target Initrd Default Target. second # [ 3.711092] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 3.689778] systemd[1]: Mounted /sysroot/nix/store. test # [ 3.690761] systemd[1]: Reached target Initrd File Systems. test # [ 3.692778] systemd[1]: Starting Find NixOS closure... second # [ 3.722901] systemd[1]: Stopped target Initrd Default Target. second # [ 3.724301] systemd[1]: Stopped target Basic System. test # [ 3.695702] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 3.726166] systemd[1]: Stopped target Initrd Root Device. second # [ 3.727241] systemd[1]: Stopped target Path Units. second # [ 3.728323] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. second # [ 3.730255] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 3.732041] systemd[1]: Stopped target Slice Units. second # [ 3.733560] systemd[1]: Stopped target Socket Units. second # [ 3.734905] systemd[1]: Stopped target System Initialization. second # [ 3.736314] systemd[1]: Stopped target Swaps. second # [ 3.738058] systemd[1]: Stopped target Timer Units. second # [ 3.739105] systemd[1]: dbus.socket: Deactivated successfully. second # [ 3.740214] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 3.741465] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 3.712613] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 3.743153] systemd[1]: Stopped Find NixOS closure. second # [ 3.745134] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.746235] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 3.747601] systemd[1]: Stopped Apply Kernel Variables. second # [ 3.748869] systemd[1]: systemd-modules-load.service: Deactivated successfully. test # [ 3.721230] systemd[1]: Finished Find NixOS closure. second # [ 3.751167] systemd[1]: Stopped Load Kernel Modules. test # [ 3.722631] systemd[1]: Reached target Initrd Default Target. second # [ 3.752149] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 3.724661] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... second # [ 3.753640] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 3.754990] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 3.757119] systemd[1]: Stopped Create System Files and Directories. second # [ 3.758283] systemd[1]: Stopped target Local File Systems. second # [ 3.759350] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.760579] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 3.762171] systemd[1]: Stopped Coldplug All udev Devices. second # [ 3.763926] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 3.736787] systemd[1]: Stopped target Initrd Default Target. second # [ 3.766169] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.738599] systemd[1]: Stopped target Basic System. second # [ 3.767994] systemd[1]: Stopped Virtual Console Setup. test # [ 3.739982] systemd[1]: Stopped target Initrd Root Device. test # [ 3.742149] systemd[1]: Stopped target Path Units. test # [ 3.743130] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 3.744605] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. test # [ 3.745985] systemd[1]: Stopped target Slice Units. second # [ 3.774747] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 3.747155] systemd[1]: Stopped target Socket Units. test # [ 3.748569] systemd[1]: Stopped target System Initialization. test # [ 3.749980] systemd[1]: Stopped target Swaps. test # [ 3.751872] systemd[1]: Stopped target Timer Units. second # [ 3.780284] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 3.752846] systemd[1]: dbus.socket: Deactivated successfully. test # [ 3.753963] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 3.783675] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.755211] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 3.757149] systemd[1]: Stopped Find NixOS closure. second # [ 3.785188] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 3.758222] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.759466] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 3.788166] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.761183] systemd[1]: Stopped Apply Kernel Variables. second # [ 3.790166] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.763162] systemd[1]: systemd-modules-load.service: Deactivated successfully. test # [ 3.764457] systemd[1]: Stopped Load Kernel Modules. second # [ 3.792881] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 3.765717] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 3.795110] systemd[1]: Closed udev Control Socket. test # [ 3.767862] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 3.796537] systemd[1]: Starting Cleanup udev Database... test # [ 3.769240] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 3.798185] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 3.770529] systemd[1]: Stopped Create System Files and Directories. second # [ 3.799563] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 3.771675] systemd[1]: Stopped target Local File Systems. second # [ 3.800797] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 3.774200] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.803169] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 3.775683] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 3.804439] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 3.805682] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 3.777538] systemd[1]: Stopped Coldplug All udev Devices. test # [ 3.779223] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 3.781308] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.783152] systemd[1]: Stopped Virtual Console Setup. test # [ 3.789876] systemd[1]: initrd-cleanup.service: Deactivated successfully. second # [ 3.819149] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. second # [ 3.820771] systemd[1]: Finished Cleanup udev Database. test # [ 3.794226] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 3.823059] systemd[1]: Reached target Switch Root. second # [ 3.824205] systemd[1]: Starting NixOS Activation... test # [ 3.797509] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.799352] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 3.801663] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.803149] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.806215] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 3.807553] systemd[1]: Closed udev Control Socket. test # [ 3.809085] systemd[1]: Starting Cleanup udev Database... test # [ 3.810145] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 3.812172] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 3.813362] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 3.814817] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 3.816529] systemd[1]: kmod-static-nodes.service: Deactivated successfully. test # [ 3.817802] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 3.831299] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 3.832710] systemd[1]: Finished Cleanup udev Database. test # [ 3.834162] systemd[1]: Reached target Switch Root. test # [ 3.835790] systemd[1]: Starting NixOS Activation... second # [ 3.871198] initrd-nixos-activation-start[188]: booting system configuration /nix/store/w79m1hl5gbjrvxc7wqb4l1lnjgkhgz23-nixos-system-second-test second # [ 3.892133] initrd-nixos-activation-start[188]: running activation script... test # [ 3.884109] initrd-nixos-activation-start[189]: booting system configuration /nix/store/8f83hrdz2mq01n7jlxrjbsdxh73r414s-nixos-system-test-test test # [ 3.905079] initrd-nixos-activation-start[189]: running activation script... second # [ 4.046442] initrd-nixos-activation-start[211]: setting up /etc... test # [ 4.054781] initrd-nixos-activation-start[212]: setting up /etc... second # [ 4.122114] initrd-nixos-activation-start[211]: setting up age secrets... test # [ 4.134324] initrd-nixos-activation-start[212]: setting up age secrets... second # [ 4.198396] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 4.200416] systemd[1]: Finished NixOS Activation. second # [ 4.202544] systemd[1]: Starting Switch Root... second # [ 4.212757] systemd[1]: Switching root. test # [ 4.234405] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 4.236443] systemd[1]: Finished NixOS Activation. test # [ 4.238628] systemd[1]: Starting Switch Root... test # [ 4.250283] systemd[1]: Switching root. second # [ 4.519680] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). test # [ 4.561104] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). second # [ 8.730293] NET: Registered PF_VSOCK protocol family test # [ 8.706699] NET: Registered PF_VSOCK protocol family second # [ 9.084855] systemd[1]: systemd 261.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 # [ 9.058944] systemd[1]: systemd 261.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 # [ 9.089404] systemd[1]: Detected virtualization kvm. test # [ 9.063568] systemd[1]: Detected virtualization kvm. second # [ 9.090279] systemd[1]: Detected architecture x86-64. test # [ 9.064416] systemd[1]: Detected architecture x86-64. second # [ 9.091223] systemd[1]: Detected first boot. test # [ 9.065354] systemd[1]: Detected first boot. second # [ 9.092856] systemd[1]: Initializing machine ID from random generator. test # [ 9.066941] systemd[1]: Initializing machine ID from random generator. test # [ 9.254020] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 9.284855] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 9.347603] systemd[1]: Applying preset policy. test # [ 9.323844] systemd[1]: Applying preset policy. test # [ 9.488033] systemd[1]: Populated /etc with preset unit settings. second # [ 9.529646] systemd[1]: Populated /etc with preset unit settings. test # [ 9.672327] systemd[1]: initrd-switch-root.service: Deactivated successfully. test # [ 9.674043] systemd[1]: Stopped initrd-switch-root.service. test # [ 9.676960] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. test # [ 9.679327] systemd[1]: Created slice Slice /system/getty. test # [ 9.680824] systemd[1]: Created slice User and Session Slice. test # [ 9.681926] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 9.683334] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 9.684679] systemd[1]: Expecting device /dev/hvc0... test # [ 9.685583] systemd[1]: Expecting device /dev/ttyS0... test # [ 9.686517] systemd[1]: Reached target Local Encrypted Volumes. test # [ 9.687594] systemd[1]: Stopped target initrd-fs.target. second # [ 9.714930] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 9.716715] systemd[1]: Stopped initrd-switch-root.service. second # [ 9.719717] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 9.722063] systemd[1]: Created slice Slice /system/getty. test # [ 9.688517] systemd[1]: Stopped target initrd-root-fs.target. second # [ 9.723602] systemd[1]: Created slice User and Session Slice. test # [ 9.697923] systemd[1]: Stopped target initrd-switch-root.target. second # [ 9.724680] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 9.698991] systemd[1]: Reached target Virtual Machines and Containers. test # [ 9.700100] systemd[1]: Reached target Path Units. second # [ 9.726080] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 9.700998] systemd[1]: Reached target Remote File Systems. second # [ 9.727391] systemd[1]: Expecting device /dev/hvc0... test # [ 9.701986] systemd[1]: Reached target Slice Units. second # [ 9.728300] systemd[1]: Expecting device /dev/ttyS0... test # [ 9.702898] systemd[1]: Reached target Swaps. second # [ 9.729339] systemd[1]: Reached target Local Encrypted Volumes. second # [ 9.730363] systemd[1]: Stopped target initrd-fs.target. test # [ 9.704916] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 9.707394] systemd[1]: Listening on Process Core Dump Socket. test # [ 9.709373] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 9.711293] systemd[1]: Listening on Factory Reset Management. test # [ 9.712500] systemd[1]: Listening on Hostname Service Socket. second # [ 9.731289] systemd[1]: Stopped target initrd-root-fs.target. second # [ 9.740980] systemd[1]: Stopped target initrd-switch-root.target. test # [ 9.715351] systemd[1]: Starting Journal Log Access Socket... second # [ 9.742200] systemd[1]: Reached target Virtual Machines and Containers. test # [ 9.716898] systemd[1]: Listening on Journal Audit Socket. second # [ 9.743466] systemd[1]: Reached target Path Units. second # [ 9.744446] systemd[1]: Reached target Remote File Systems. second # [ 9.745539] systemd[1]: Reached target Slice Units. test # [ 9.719614] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 9.746533] systemd[1]: Reached target Swaps. test # [ 9.720944] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 9.722388] systemd[1]: Listening on Network Management Varlink Socket. second # [ 9.748783] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 9.723700] systemd[1]: Listening on Network Management Netlink Socket. test # [ 9.725014] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 9.751584] systemd[1]: Listening on Process Core Dump Socket. test # [ 9.726332] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 9.753585] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 9.727941] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 9.755590] systemd[1]: Listening on Factory Reset Management. second # [ 9.756715] systemd[1]: Listening on Hostname Service Socket. test # [ 9.732682] systemd[1]: Listening on Disk Repartitioning Service Socket. second # [ 9.759663] systemd[1]: Starting Journal Log Access Socket... test # [ 9.734002] systemd[1]: Listening on Resolve Monitor Varlink Socket. test # [ 9.735209] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 9.762014] systemd[1]: Listening on Journal Audit Socket. test # [ 9.736433] systemd[1]: Listening on udev Control Socket. test # [ 9.737570] systemd[1]: Listening on udev Varlink Socket. second # [ 9.763940] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 9.765315] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 9.739967] systemd[1]: Mounting Huge Pages File System... second # [ 9.766742] systemd[1]: Listening on Network Management Varlink Socket. second # [ 9.768007] systemd[1]: Listening on Network Management Netlink Socket. test # [ 9.742837] systemd[1]: Mounting POSIX Message Queue File System... second # [ 9.769315] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 9.770631] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 9.772214] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki test # [ 9.748876] systemd[1]: Mounting Kernel Debug File System... second # [ 9.776119] systemd[1]: Listening on Disk Repartitioning Service Socket. second # [ 9.777398] systemd[1]: Listening on Resolve Monitor Varlink Socket. second # [ 9.778601] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 9.779787] systemd[1]: Listening on udev Control Socket. second # [ 9.780884] systemd[1]: Listening on udev Varlink Socket. test # [ 9.755856] systemd[1]: Mounting Kernel Trace File System... second # [ 9.783013] systemd[1]: Mounting Huge Pages File System... second # [ 9.786373] systemd[1]: Mounting POSIX Message Queue File System... test # [ 9.765308] systemd[1]: Starting Create List of Static Device Nodes... second # [ 9.793397] systemd[1]: Mounting Kernel Debug File System... second # [ 9.802050] systemd[1]: Mounting Kernel Trace File System... test # [ 9.778790] systemd[1]: Starting Load Kernel Module configfs... second # [ 9.811550] systemd[1]: Starting Create List of Static Device Nodes... test # [ 9.785805] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 9.827897] systemd[1]: Starting Load Kernel Module configfs... test # [ 9.803888] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 9.837698] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm test # [ 9.813915] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 9.821366] systemd[1]: Mounting FUSE Control File System... test # [ 9.822440] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 second # [ 9.851879] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 9.856414] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 9.832093] systemd[1]: Starting Journal Service... second # [ 9.860681] systemd[1]: Mounting FUSE Control File System... second # [ 9.864397] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 9.844876] systemd[1]: Starting Load Kernel Modules... second # [ 9.876442] systemd[1]: Starting Journal Service... test # [ 9.855490] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 9.884866] systemd[1]: Starting Load Kernel Modules... test # [ 9.871712] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 9.878237] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 9.907301] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 9.915399] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 9.890478] systemd-journald[337]: Collecting audit messages is enabled. second # [ 9.918439] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 9.899678] systemd[1]: Starting Coldplug All udev Devices... second # [ 9.934828] systemd-journald[315]: Collecting audit messages is enabled. second # [ 9.936141] systemd[1]: Starting Coldplug All udev Devices... test # [ 9.912442] systemd[1]: Listening on Journal Log Access Socket. test # [ 9.918812] systemd[1]: Mounted Huge Pages File System. test # [ 9.736836] systemd[1]: Queued start job for default target Multi-User System. test # [ 9.742404] systemd[1]: systemd-journald.service: Deactivated successfully. second # [ 9.952025] systemd[1]: Listening on Journal Log Access Socket. test # [ 9.748034] systemd-modules-load[338]: Module 'ctr' is built in second # [ 9.958557] systemd[1]: Mounted Huge Pages File System. test # [ 9.934704] systemd[1]: Started Journal Service. test # [ 9.937949] loop: module loaded second # [ 9.783657] systemd[1]: Queued start job for default target Multi-User System. second # [ 9.967450] systemd[1]: Started Journal Service. second # [ 9.968379] loop: module loaded test # [ 9.759873] systemd-modules-load[338]: Inserted module 'loop' second # [ 9.790567] systemd[1]: systemd-journald.service: Deactivated successfully. second # [ 9.792879] systemd-modules-load[316]: Module 'ctr' is built in test # [ 9.765360] systemd[1]: Mounted POSIX Message Queue File System. second # [ 9.796557] systemd-modules-load[316]: Inserted module 'loop' test # [ 9.770397] systemd[1]: Mounted Kernel Debug File System. test # [ 9.771622] systemd[1]: Mounted Kernel Trace File System. test # [ 9.776156] systemd[1]: Finished Create List of Static Device Nodes. second # [ 9.804967] systemd[1]: Mounted POSIX Message Queue File System. test # [ 9.777389] systemd[1]: modprobe@configfs.service: Deactivated successfully. second # [ 9.806395] systemd[1]: Mounted Kernel Debug File System. test # [ 9.783587] systemd[1]: Finished Load Kernel Module configfs. test # [ 9.968879] EXT4-fs (vda): re-mounted d01fb6e5-30d5-460a-b0f0-876d1e7314a7. second # [ 9.819097] systemd[1]: Mounted Kernel Trace File System. second # [ 10.001391] EXT4-fs (vda): re-mounted 57bfd2a7-f3f6-450a-a090-9dc8994d558e. test # [ 9.792121] systemd[1]: Mounted FUSE Control File System. test # [ 9.795108] systemd[1]: Finished Load Kernel Modules. second # [ 9.825265] systemd[1]: Finished Create List of Static Device Nodes. second # [ 9.826556] systemd[1]: modprobe@configfs.service: Deactivated successfully. second # [ 9.830218] systemd[1]: Finished Load Kernel Module configfs. second # [ 9.832385] systemd[1]: Mounted FUSE Control File System. test # [ 9.806854] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 9.836435] systemd[1]: Finished Load Kernel Modules. second # [ 9.839970] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 9.812166] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 9.816736] systemd[1]: Mounting Kernel Configuration File System... test # [ 9.819466] systemd[1]: Starting Firewall... test # [ 9.823689] systemd-oomd[340]: No swap; memory pressure usage will be degraded second # [ 9.853127] systemd[1]: Listening on Disk Image Download Service Socket. second # [ 9.858131] systemd[1]: Mounting Kernel Configuration File System... test # [ 9.832493] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 9.861944] systemd[1]: Starting Firewall... test # [ 9.833809] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore second # [ 9.866243] systemd-oomd[318]: No swap; memory pressure usage will be degraded second # [ 9.873134] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 9.846100] systemd[1]: Starting Load/Save OS Random Seed... second # [ 9.874489] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 9.856849] systemd[1]: Starting Apply Kernel Variables... second # [ 9.888092] systemd[1]: Starting Load/Save OS Random Seed... test # [ 9.867982] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 9.869488] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 9.872196] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. second # [ 9.904963] systemd[1]: Starting Apply Kernel Variables... second # [ 9.916694] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 9.920107] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 9.923872] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 10.104216] systemd-journald[337]: Received client request to flush runtime journal. second # [ 10.134193] systemd-journald[315]: Received client request to flush runtime journal. test # [ 10.114710] systemd[1]: Finished Load/Save OS Random Seed. test # [ 10.119207] systemd[1]: Mounted Kernel Configuration File System. test # [ 10.120988] systemd[1]: Reached target First Boot Complete. test # [ 10.123747] systemd[1]: Finished Apply Kernel Variables. test # [ 10.124761] systemd[1]: Starting Network Name Resolution... test # [ 10.125927] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 10.127312] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 10.129327] systemd-resolved[366]: Positive Trust Anchors: test # [ 10.132243] systemd-resolved[366]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 10.134513] systemd-resolved[366]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 10.166762] systemd[1]: Mounted Kernel Configuration File System. test # [ 10.136622] systemd-resolved[366]: 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 second # [ 10.171865] systemd[1]: Finished Load/Save OS Random Seed. second # [ 10.173385] systemd[1]: Reached target First Boot Complete. second # [ 10.175445] systemd[1]: Finished Apply Kernel Variables. second # [ 10.178352] systemd[1]: Starting Network Name Resolution... test # [ 10.150287] systemd[1]: Finished Flush Journal to Persistent Storage. second # [ 10.180467] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 10.182246] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 10.184470] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 10.166129] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 10.167394] systemd[1]: Reached target Preparation for Local File Systems. second # [ 10.195994] systemd-resolved[344]: Positive Trust Anchors: second # [ 10.198353] systemd-resolved[344]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 10.173227] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 10.202632] systemd-resolved[344]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 10.205246] systemd-resolved[344]: 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 second # [ 10.236207] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 10.209686] systemd[1]: Finished Coldplug All udev Devices. second # [ 10.240084] systemd[1]: Reached target Preparation for Local File Systems. test # [ 10.214552] systemd-resolved[366]: Using system hostname 'test'. second # [ 10.245587] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 10.218878] systemd[1]: Started Network Name Resolution. second # [ 10.262179] systemd[1]: Finished Coldplug All udev Devices. test # [ 10.236710] systemd-udevd[381]: Using default interface naming scheme 'v261'. second # [ 10.275897] systemd-resolved[344]: Using system hostname 'second'. second # [ 10.281177] systemd[1]: Started Network Name Resolution. second # [ 10.304745] systemd-udevd[361]: Using default interface naming scheme 'v261'. test # [ 10.293283] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 10.364128] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 10.434476] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse second # [ 10.497458] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse test # [ 10.494979] systemd[1]: Mounting /run/wrappers... second # [ 10.537885] systemd[1]: Mounting /run/wrappers... test # [ 10.533257] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 10.536510] systemd[1]: Mounted /run/wrappers. test # [ 10.537696] systemd[1]: Reached target Local File Systems. test # [ 10.541100] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 10.545097] systemd[1]: Starting register-nix-paths.service... second # [ 10.574665] systemd[1]: Mounted /run/wrappers. second # [ 10.575822] systemd[1]: Reached target Local File Systems. test # [ 10.550063] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 10.579468] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 10.551173] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 10.584200] systemd[1]: Starting register-nix-paths.service... test # [ 10.557326] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 10.589118] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 10.590826] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 10.574235] systemd[1]: Starting Create System Files and Directories... second # [ 10.604128] systemd[1]: Starting Save Transient machine-id to Disk... test # [ 10.585237] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. second # [ 10.622753] systemd[1]: Starting Create System Files and Directories... second # [ 10.651185] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 10.653087] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.659614] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.706458] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. test # [ 10.739549] systemd[1]: Finished Create System Files and Directories. second # [ 10.773327] systemd[1]: Finished Create System Files and Directories. test # [ 10.746434] systemd[1]: Starting Rebuild Journal Catalog... test # [ 10.752341] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 10.783658] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.791778] systemd[1]: Starting Rebuild Journal Catalog... second # [ 10.794314] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 10.832490] (udev-worker)[385]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.825135] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 10.884456] systemd[1]: Finished Record System Boot/Shutdown in UTMP. test # [ 10.860121] systemd[1]: Finished Rebuild Journal Catalog. test # [ 10.867444] systemd[1]: Starting Update is Completed... second # [ 10.915166] systemd[1]: Finished Rebuild Journal Catalog. second # [ 10.924614] systemd[1]: Starting Update is Completed... test # [ 10.934314] systemd[1]: Finished Update is Completed. second # [ 10.987160] systemd[1]: Finished Update is Completed. test # [ 11.115936] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 11.120762] systemd[1]: Finished Create SUID/SGID Wrappers. second # [ 11.172855] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. second # [ 11.177801] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 11.340779] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 test # [ 11.161422] systemd[1]: Finished Firewall. test # [ 11.165106] systemd[1]: Reached target Preparation for Network. test # [ 11.166370] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 11.172614] systemd[1]: Starting Network Management... second # [ 11.234415] systemd[1]: Finished Firewall. second # [ 11.235448] systemd[1]: Reached target Preparation for Network. test # [ 11.391562] mousedev: PS/2 mouse device common for all mice second # [ 11.236646] systemd[1]: Listening on Network Management Resolve Hook Socket. second # [ 11.241644] systemd[1]: Starting Network Management... test # [ 11.398578] ACPI: button: Power Button [PWRF] second # [ 11.432085] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 test # [ 11.259710] systemd[1]: Finished register-nix-paths.service. test # [ 11.260914] systemd[1]: Reached target System Initialization. second # [ 11.472225] ACPI: button: Power Button [PWRF] test # [ 11.265698] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 11.267035] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 11.268341] systemd[1]: Reached target Timer Units. test # [ 11.269334] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 11.272411] systemd[1]: Listening on Nix Daemon Socket. second # [ 11.485001] mousedev: PS/2 mouse device common for all mice second # [ 11.312936] systemd[1]: Finished register-nix-paths.service. test # [ 11.285099] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 11.286373] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. test # [ 11.287849] systemd[1]: Reached target Socket Units. second # [ 11.316224] systemd[1]: Reached target System Initialization. second # [ 11.318129] systemd[1]: Started Discard unused filesystem blocks once a week. second # [ 11.319993] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 11.293863] systemd[1]: Starting D-Bus System Message Bus... second # [ 11.323557] systemd[1]: Reached target Timer Units. second # [ 11.325348] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 11.326599] systemd[1]: Listening on Nix Daemon Socket. second # [ 11.332237] systemd[1]: Listening on Authorization Manager Agent Helper. second # [ 11.333465] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. second # [ 11.334945] systemd[1]: Reached target Socket Units. test # [ 11.493908] rtc_cmos PNP0B00:00: RTC can wake from S4 second # [ 11.339510] systemd[1]: Starting D-Bus System Message Bus... test # [ 11.505149] parport_pc 00:02: reported by Plug and Play ACPI test # [ 11.511613] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console test # [ 11.521715] rtc_cmos PNP0B00:00: registered as rtc0 test # [ 11.522696] rtc_cmos PNP0B00:00: setting system clock to 2026-09-27T20:10:46 UTC (1790539846) test # [ 11.524393] systemd-journald[337]: Time jumped backwards, rotating. second # [ 11.570653] rtc_cmos PNP0B00:00: RTC can wake from S4 second # [ 11.575831] parport_pc 00:02: reported by Plug and Play ACPI second # [ 11.576877] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] test # [ 11.384333] systemd-resolved[366]: Clock change detected. Flushing caches. second # [ 11.613011] rtc_cmos PNP0B00:00: registered as rtc0 second # [ 11.623459] rtc_cmos PNP0B00:00: setting system clock to 2026-09-27T20:10:46 UTC (1790539846) second # [ 11.625397] systemd-journald[315]: Time jumped backwards, rotating. second # [ 11.634305] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs second # [ 11.641870] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 second # [ 11.643929] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 11.438402] dbus-broker-launch[564]: Looking up NSS user entry for 'systemd-timesync'... second # [ 11.648590] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console test # [ 11.442702] systemd-networkd[560]: /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 # [ 11.447289] systemd-networkd[560]: /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 # [ 11.451319] dbus-broker-launch[564]: NSS returned no entry for 'systemd-timesync' test # [ 11.453920] dbus-broker-launch[564]: Invalid user-name in /nix/store/nizpdw05vqv7gssybrdr45l0i6d31b0c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 11.484877] systemd-resolved[344]: Clock change detected. Flushing caches. test # [ 11.457160] systemd-networkd[560]: lo: Link UP test # [ 11.458187] systemd-networkd[560]: lo: Gained carrier test # [ 11.466144] systemd[1]: Started Network Management. test # [ 11.470416] systemd-networkd[560]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 11.474300] systemd-networkd[560]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 11.477428] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 11.480815] systemd-networkd[560]: eth1: Link UP test # [ 11.484126] systemd-networkd[560]: eth1: Gained carrier test # [ 11.485232] systemd-networkd[560]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 11.513972] dbus-broker-launch[543]: Looking up NSS user entry for 'systemd-timesync'... second # [ 11.519660] dbus-broker-launch[543]: NSS returned no entry for 'systemd-timesync' second # [ 11.521294] dbus-broker-launch[543]: Invalid user-name in /nix/store/nizpdw05vqv7gssybrdr45l0i6d31b0c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 11.576638] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] second # [ 11.535398] systemd-networkd[539]: /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 # [ 11.508916] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' second # [ 11.540423] systemd-networkd[539]: /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 # [ 11.513407] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 11.545075] systemd-networkd[539]: lo: Link UP second # [ 11.545990] systemd-networkd[539]: lo: Gained carrier test # [ 11.523134] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' second # [ 11.555105] systemd[1]: Started Network Management. test # [ 11.527241] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 11.556292] systemd-networkd[539]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 11.558822] systemd-networkd[539]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 11.533075] systemd[1]: Started D-Bus System Message Bus. test # [ 11.535111] systemd[1]: Reached target Basic System. second # [ 11.565743] systemd-networkd[539]: eth1: Link UP second # [ 11.566858] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 11.541161] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 11.569857] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 11.546335] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.575425] systemd-networkd[539]: eth1: Gained carrier second # [ 11.578413] systemd-networkd[539]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 11.580974] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 11.585447] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 11.563102] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.591059] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 11.598319] systemd[1]: Started D-Bus System Message Bus. second # [ 11.599411] systemd[1]: Reached target Basic System. test # [ 11.576266] dbus-broker-launch[564]: Ready second # [ 11.607540] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 11.583089] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.616112] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.623140] systemd[1]: Starting Network Manager... test # [ 11.599339] systemd[1]: Starting Network Manager... test # [ 11.577618] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 11.596443] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 test # [ 11.613731] systemd[1]: Started backdoor.service. second # [ 11.646861] dbus-broker-launch[543]: Ready second # [ 11.647925] systemd[1]: Started backdoor.service. test # [ 11.627102] systemd[1]: Starting Import lastlog data into lastlog2 database... second # [ 11.675193] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 11.655106] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[576]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 11.688988] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 11.667727] systemd[1]: Starting Name Service Cache Daemon (nsncd)... second # [ 11.714434] systemd[1]: Starting Post-Boot Actions... test # [ 11.685235] vb8pc9wcqy39qa3q5alv51h0jms1a1wl-wifi-secrets[577]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 11.700869] systemd[1]: Starting Post-Boot Actions... test # [ 11.705193] 7x3chz0b0917ic6jha19q7m5hcdq301r-wifi-secrets[578]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 11.736170] systemd[1]: Started Reset console on configuration changes. second # [ 11.757108] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[555]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 11.732981] systemd[1]: Started Reset console on configuration changes. second # [ 11.763684] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 11.597032] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs test # [ 11.598773] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized test # [ 11.745421] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. second # connecting to host... test # connecting to host... second # [ 11.814568] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 11.829660] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. second # [ 11.837499] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. test # [ 11.811162] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 11.847160] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.820827] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 11.600826] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 11.600921] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' test # [ 11.826375] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. test: Guest shell says: b'Spawning backdoor root shell...\n' test # [ 11.831703] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.837352] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test: connected to guest root shell test # [ 11.845849] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test: (connecting took 12.58 seconds) test: (finished: waiting for the VM to finish booting, in 12.58 seconds) test # [ 11.847113] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. test # [ 11.853440] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. second # [ 11.688491] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' second # [ 11.688582] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 11.902826] systemd[1]: Finished Post-Boot Actions. test # [ 11.875566] nsncd[584]: Sep 27 20:10:47.033 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test # [ 11.882145] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 11.910320] nsncd[560]: Sep 27 20:10:46.966 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 11.915871] systemd[1]: Started Name Service Cache Daemon (nsncd). test # [ 11.681209] Console: switching to colour dummy device 80x25 test # [ 11.688248] NET: Registered PF_PACKET protocol family test # [ 12.058129] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 test # [ 11.899456] systemd[1]: Finished Post-Boot Actions. second # [ 11.929654] systemd[1]: Started Network Manager Script Dispatcher Service. second # [ 11.937464] systemd[1]: Reached target Host and Network Name Lookups. second # [ 11.938680] systemd[1]: Reached target User and Group Name Lookups. second # [ 11.948824] systemd[1]: Starting User Login Management... second # [ 11.706285] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized second # [ 11.806972] NET: Registered PF_PACKET protocol family second # [ 11.959970] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 11.936295] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 11.950487] systemd[1]: Finished Import lastlog data into lastlog2 database. second # [ 11.981519] systemd[1]: Starting Hostname Service... test # [ 12.058426] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 second # [ 12.070187] Console: switching to colour dummy device 80x25 second # [ 12.148518] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt second # [ 12.148636] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD test # [ 11.971643] systemd[1]: Reached target Host and Network Name Lookups. test # [ 11.972860] systemd[1]: Reached target User and Group Name Lookups. test # [ 11.978613] systemd[1]: Starting Hostname Service... test # [ 12.076021] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt test # [ 12.076132] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD test # [ 11.986719] systemd[1]: Starting User Login Management... second # [ 12.199894] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 second # [ 12.200239] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 test # [ 12.205578] [drm] Found bochs VGA, ID 0xb0c5. test # [ 12.206128] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. second # [ 12.259796] [drm] Found bochs VGA, ID 0xb0c5. second # [ 12.259799] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. second # [ 12.081612] systemd-logind[596]: New seat seat0. second # [ 12.085157] systemd[1]: Started User Login Management. second # [ 12.270252] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic second # [ 12.271102] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 second # [ 12.092476] systemd[1]: Starting linger-users.service... test # [ 12.065314] systemd[1]: Starting Virtual Console Setup... second # [ 12.105857] systemd[1]: Started Hostname Service. test # [ 12.270172] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic test # [ 12.090526] systemd-logind[638]: New seat seat0. test # [ 12.096113] systemd[1]: Started User Login Management. test # [ 12.105146] systemd[1]: Starting linger-users.service... second # [ 12.135431] systemd[1]: Starting Virtual Console Setup... test # [ 12.295199] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 second # [ 12.151116] systemd[1]: linger-users.service: Deactivated successfully. test # [ 12.123244] systemd[1]: Started Hostname Service. second # [ 12.153674] systemd[1]: Finished linger-users.service. test # [ 12.135323] systemd-logind[638]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) test # [ 12.156100] systemd[1]: linger-users.service: Deactivated successfully. test # [ 12.160504] systemd[1]: Finished linger-users.service. second # [ 12.202100] systemd-networkd[539]: eth0: Link UP second # [ 12.203274] systemd-networkd[539]: eth0: Gained carrier test # [ 12.196821] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. test # [ 12.199644] systemd-logind[638]: Watching system buttons on /dev/input/event2 (Power Button) second # [ 12.232074] systemd[1]: Started Network Manager. second # [ 12.233090] systemd[1]: Reached target Network. test # [ 12.206113] systemd-networkd[560]: eth0: Link UP test # [ 12.207533] systemd-networkd[560]: eth0: Gained carrier second # [ 12.239918] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 12.244493] systemd[1]: Starting Permit User Sessions... test # [ 12.233286] systemd[1]: Started Network Manager. test # [ 12.239104] systemd[1]: Reached target Network. test # [ 12.243118] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 12.249159] systemd[1]: Starting Permit User Sessions... second # [ 12.278185] systemd-logind[596]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) second # [ 12.301140] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. second # [ 12.321092] systemd-logind[596]: Watching system buttons on /dev/input/event2 (Power Button) test # [ 12.377104] systemd[1]: Finished Permit User Sessions. second # [ 12.410629] systemd[1]: Finished Permit User Sessions. second # [ 12.423086] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. second # [ 12.430087] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. second # [ 12.588713] Console: switching to colour frame buffer device 160x50 second # [ 12.630630] ppdev: user-space parallel port driver test # [ 12.427593] NetworkManager[579]: [1790539847.5857] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 12.648696] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device second # [ 12.470247] systemd[1]: Started Getty on tty1. second # [ 12.474225] systemd[1]: Reached target Login Prompts. second # [ 12.475362] systemd[1]: Reached target Multi-User System. test # [ 12.558394] ppdev: user-space parallel port driver test # [ 12.460751] systemd-logind[638]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) test # [ 12.631668] Console: switching to colour frame buffer device 160x50 test # [ 12.648317] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device test # [ 12.466809] systemd[1]: Started Getty on tty1. test # [ 12.468477] systemd[1]: Reached target Login Prompts. test # [ 12.472079] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. test # [ 12.474244] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. second # [ 12.507342] systemd-logind[596]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) test # [ 12.483492] systemd[1]: Reached target Multi-User System. second # [ 12.699826] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) test # [ 12.491314] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 12.494265] systemd[1]: Stopped Virtual Console Setup. second # [ 12.523261] systemd-resolved[344]: eth0: Bus client set default route setting: yes second # [ 12.526965] systemd-resolved[344]: eth0: Bus client set DNS server list to: 10.0.2.3 test # [ 12.504815] systemd-resolved[366]: eth0: Bus client set default route setting: yes test # [ 12.508940] systemd-resolved[366]: eth0: Bus client set DNS server list to: 10.0.2.3 test # [ 12.696344] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) test # [ 12.728768] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) second # [ 12.573448] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 12.577533] systemd[1]: Stopped Virtual Console Setup. second # [ 12.768177] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) second # [ 12.595071] systemd[1]: Starting Virtual Console Setup... test # [ 12.842033] kvm_amd: TSC scaling supported test # [ 12.842796] kvm_amd: Nested Virtualization enabled test # [ 12.843453] kvm_amd: Nested Paging enabled test # [ 12.844559] kvm_amd: LBR virtualization supported test # [ 12.845192] kvm_amd: Virtual GIF supported test # [ 12.845979] kvm_amd: Virtual NMI enabled second # [ 12.888364] kvm_amd: TSC scaling supported second # [ 12.888910] kvm_amd: Nested Virtualization enabled second # [ 12.889887] kvm_amd: Nested Paging enabled second # [ 12.890655] kvm_amd: LBR virtualization supported second # [ 12.891579] kvm_amd: Virtual GIF supported second # [ 12.892105] kvm_amd: Virtual NMI enabled test # [ 12.875649] EDAC MC: Ver: 3.0.0 second # [ 12.922812] EDAC MC: Ver: 3.0.0 test # [ 12.715384] systemd[1]: Starting Virtual Console Setup... second # [ 12.744962] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 12.747845] systemd[1]: Stopped Virtual Console Setup. second # [ 12.757828] systemd[1]: Starting Virtual Console Setup... test # [ 12.752704] systemd-networkd[560]: eth1: Gained IPv6LL test # [ 12.823220] systemd-vconsole-setup[690]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 12.827320] systemd[1]: Finished Virtual Console Setup. second # [ 12.858949] systemd-vconsole-setup[649]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 12.831264] systemd[1]: Startup finished in 881ms (kernel) + 7.602s (initrd) + 4.346s (userspace) = 12.830s. second # [ 12.862906] systemd[1]: Finished Virtual Console Setup. second # [ 12.867211] systemd[1]: Startup finished in 866ms (kernel) + 7.646s (initrd) + 4.352s (userspace) = 12.866s. second # [ 13.009128] systemd-networkd[539]: eth1: Gained IPv6LL test: (finished: waiting for unit NetworkManager.service, in 13.73 seconds) test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds) test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds) test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds) (finished: run the VM test script, in 13.91 seconds) second # [ 13.586445] systemd-networkd[539]: eth0: Gained IPv6LL test # [ 13.906128] systemd-networkd[560]: eth0: Gained IPv6LL test script finished in 15.36s cleanup kill QemuMachine (pid 47) second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14) second # [2026-09-27T20:10:49Z INFO virtiofsd] Client disconnected, shutting down second # [2026-09-27T20:10:49Z INFO virtiofsd] Client disconnected, shutting down second # [2026-09-27T20:10:49Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 48) test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14) test # [2026-09-27T20:10:50Z INFO virtiofsd] Client disconnected, shutting down test # [2026-09-27T20:10:50Z INFO virtiofsd] Client disconnected, shutting down test # [2026-09-27T20:10:50Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.25 seconds)