vm-test-run-wifi
checks.x86_64-linux.wifi
· build #28
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 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_ssh10start all VMs11second: starting vm12test: starting vm13second # Disk image does not exist, creating the virtualisation disk image...14second # Formatting '/build/vm-state-second/tmp.7psgJiQyym', fmt=raw size=107374182415second # mke2fs 1.47.4 (6-Mar-2025)16second # Discarding device blocks: 0/262144 done17second # Creating filesystem with 262144 4k blocks and 65536 inodes18second # Filesystem UUID: 788cf2da-8294-4bb0-be60-7f851a0a86d919second # Superblock backups stored on blocks:20second # 32768, 98304, 163840, 22937621second # 22second # Allocating group tables: 0/8 done23second # Writing inode tables: 0/8 done24second # Creating journal (8192 blocks): done25second # Writing superblocks and filesystem accounting information: 0/8 done26second # 27second # Virtualisation disk image created.28second: QEMU running (pid 47)29test # Disk image does not exist, creating the virtualisation disk image...30test: QEMU running (pid 48)31test # Formatting '/build/vm-state-test/tmp.l1w8EmeRPK', fmt=raw size=107374182432test # mke2fs 1.47.4 (6-Mar-2025)33test # Discarding device blocks: 0/262144 done34test # Creating filesystem with 262144 4k blocks and 65536 inodes35test # Filesystem UUID: 46050892-c6c6-4f38-bea6-753875e3de5336test # Superblock backups stored on blocks:37test # 32768, 98304, 163840, 22937638test # 39test # Allocating group tables: 0/8 done40test # Writing inode tables: 0/8 done41test # Creating journal (8192 blocks): done42test # Writing superblocks and filesystem accounting information: 0/8 done43test # 44test # Virtualisation disk image created.45(finished: start all VMs, in 0.09 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50test # 51test # 52second # 53second # 54test # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA0055second # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA0056test # Press Ctrl-B to configure iPXE (PCI 00:03.0)...57test # 58test # 59test # 60test # 61second # Press Ctrl-B to configure iPXE (PCI 00:03.0)...62second # 63second # 64second # 65second # 66test # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB0067second # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB0068test # Press Ctrl-B to configure iPXE (PCI 00:09.0)...69test # 70test # 71second # Press Ctrl-B to configure iPXE (PCI 00:09.0)...72second # 73second # 74test # Booting from ROM...75second # Booting from ROM...76second # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 UTC 202677test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 UTC 202678second # [ 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/sccznmhx0nrv0pzmp4igkxa4kircv506-nixos-system-second-test/init regInfo=/nix/store/l93hfyjg4pn829z8g76ldcxgh15k1rnq-closure-info/registration console=ttyS0,115200n8 console=tty079second # [ 0.000000] BIOS-provided physical RAM map:80second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable81second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved82test # [ 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/4chh5garxqihjk361khlwcj0hwv9s51v-nixos-system-test-test/init regInfo=/nix/store/54yi71gl55p1piqxnn4zbs1iff7wgzvx-closure-info/registration console=ttyS0,115200n8 console=tty083test # [ 0.000000] BIOS-provided physical RAM map:84second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved85test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable86second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable87test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved88second # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved89test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved90second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved91test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable92second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved93test # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved94second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved95second # [ 0.000000] NX (Execute Disable) protection: active96test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved97second # [ 0.000000] APIC: Static calls initialized98second # [ 0.000000] SMBIOS 2.8 present.99test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved100test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved101second # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014102test # [ 0.000000] NX (Execute Disable) protection: active103second # [ 0.000000] DMI: Memory slots populated: 1/1104test # [ 0.000000] APIC: Static calls initialized105second # [ 0.000000] Hypervisor detected: KVM106test # [ 0.000000] SMBIOS 2.8 present.107second # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000108second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00109test # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014110test # [ 0.000000] DMI: Memory slots populated: 1/1111second # [ 0.000000] kvm-clock: using sched offset of 356162354 cycles112test # [ 0.000000] Hypervisor detected: KVM113test # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000114second # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns115test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00116second # [ 0.000004] tsc: Detected 4192.100 MHz processor117test # [ 0.000000] kvm-clock: using sched offset of 359493438 cycles118second # [ 0.000584] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000119second # [ 0.000611] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs120test # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns121test # [ 0.000004] tsc: Detected 4192.100 MHz processor122second # [ 0.000613] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT123test # [ 0.000585] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000124second # [ 0.002229] found SMP MP-table at [mem 0x000f5470-0x000f547f]125second # [ 0.002241] Using GB pages for direct mapping126test # [ 0.000612] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs127second # [ 0.002335] RAMDISK: [mem 0x3e34b000-0x3ffcffff]128test # [ 0.000614] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT129second # [ 0.002339] ACPI: Early table checksum verification disabled130test # [ 0.002228] found SMP MP-table at [mem 0x000f5470-0x000f547f]131second # [ 0.002342] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )132test # [ 0.002240] Using GB pages for direct mapping133test # [ 0.002332] RAMDISK: [mem 0x3e349000-0x3ffcffff]134second # [ 0.002346] ACPI: RSDT 0x000000003FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)135test # [ 0.002337] ACPI: Early table checksum verification disabled136second # [ 0.002349] ACPI: FACP 0x000000003FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)137test # [ 0.002339] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )138second # [ 0.002354] ACPI: DSDT 0x000000003FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)139test # [ 0.002342] ACPI: RSDT 0x000000003FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)140second # [ 0.002356] ACPI: FACS 0x000000003FFE0000 000040141test # [ 0.002345] ACPI: FACP 0x000000003FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)142second # [ 0.002357] ACPI: APIC 0x000000003FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)143test # [ 0.002349] ACPI: DSDT 0x000000003FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)144second # [ 0.002358] ACPI: HPET 0x000000003FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)145test # [ 0.002351] ACPI: FACS 0x000000003FFE0000 000040146second # [ 0.002359] ACPI: WAET 0x000000003FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)147test # [ 0.002352] ACPI: APIC 0x000000003FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)148second # [ 0.002360] ACPI: Reserving FACP table memory at [mem 0x3ffe2280-0x3ffe22f3]149test # [ 0.002353] ACPI: HPET 0x000000003FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)150second # [ 0.002361] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe227f]151test # [ 0.002354] ACPI: WAET 0x000000003FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)152second # [ 0.002361] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]153test # [ 0.002355] ACPI: Reserving FACP table memory at [mem 0x3ffe2280-0x3ffe22f3]154second # [ 0.002362] ACPI: Reserving APIC table memory at [mem 0x3ffe22f4-0x3ffe236b]155test # [ 0.002356] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe227f]156second # [ 0.002362] ACPI: Reserving HPET table memory at [mem 0x3ffe236c-0x3ffe23a3]157test # [ 0.002356] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]158second # [ 0.002362] ACPI: Reserving WAET table memory at [mem 0x3ffe23a4-0x3ffe23cb]159second # [ 0.002703] No NUMA configuration found160test # [ 0.002357] ACPI: Reserving APIC table memory at [mem 0x3ffe22f4-0x3ffe236b]161second # [ 0.002704] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]162test # [ 0.002357] ACPI: Reserving HPET table memory at [mem 0x3ffe236c-0x3ffe23a3]163second # [ 0.002707] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]164second # [ 0.002772] Zone ranges:165test # [ 0.002357] ACPI: Reserving WAET table memory at [mem 0x3ffe23a4-0x3ffe23cb]166test # [ 0.002693] No NUMA configuration found167second # [ 0.002772] DMA [mem 0x0000000000001000-0x0000000000ffffff]168test # [ 0.002694] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]169second # [ 0.002774] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]170second # [ 0.002775] Normal empty171test # [ 0.002697] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]172second # [ 0.002775] Device empty173test # [ 0.002763] Zone ranges:174second # [ 0.002776] Movable zone start for each node175test # [ 0.002763] DMA [mem 0x0000000000001000-0x0000000000ffffff]176second # [ 0.002776] Early memory node ranges177test # [ 0.002764] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]178second # [ 0.002776] node 0: [mem 0x0000000000001000-0x000000000009efff]179test # [ 0.002765] Normal empty180test # [ 0.002766] Device empty181second # [ 0.002777] node 0: [mem 0x0000000000100000-0x000000003ffdafff]182test # [ 0.002766] Movable zone start for each node183second # [ 0.002778] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]184test # [ 0.002766] Early memory node ranges185second # [ 0.002793] On node 0, zone DMA: 1 pages in unavailable ranges186test # [ 0.002767] node 0: [mem 0x0000000000001000-0x000000000009efff]187second # [ 0.002977] On node 0, zone DMA: 97 pages in unavailable ranges188test # [ 0.002768] node 0: [mem 0x0000000000100000-0x000000003ffdafff]189second # [ 0.015414] On node 0, zone DMA32: 37 pages in unavailable ranges190test # [ 0.002769] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]191second # [ 0.016105] ACPI: PM-Timer IO Port: 0x608192test # [ 0.002783] On node 0, zone DMA: 1 pages in unavailable ranges193second # [ 0.016116] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])194test # [ 0.002967] On node 0, zone DMA: 97 pages in unavailable ranges195second # [ 0.016140] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23196test # [ 0.015414] On node 0, zone DMA32: 37 pages in unavailable ranges197second # [ 0.016143] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)198test # [ 0.016110] ACPI: PM-Timer IO Port: 0x608199test # [ 0.016124] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])200second # [ 0.016144] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)201second # [ 0.016145] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)202test # [ 0.016145] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23203test # [ 0.016147] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)204second # [ 0.016146] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)205test # [ 0.016148] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)206second # [ 0.016147] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)207test # [ 0.016149] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)208second # [ 0.016148] ACPI: Using ACPI (MADT) for SMP configuration information209second # [ 0.016149] ACPI: HPET id: 0x8086a201 base: 0xfed00000210test # [ 0.016150] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)211second # [ 0.016153] TSC deadline timer available212test # [ 0.016151] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)213second # [ 0.016157] CPU topo: Max. logical packages: 1214second # [ 0.016157] CPU topo: Max. logical dies: 1215test # [ 0.016153] ACPI: Using ACPI (MADT) for SMP configuration information216second # [ 0.016158] CPU topo: Max. dies per package: 1217test # [ 0.016153] ACPI: HPET id: 0x8086a201 base: 0xfed00000218second # [ 0.016160] CPU topo: Max. threads per core: 1219test # [ 0.016158] TSC deadline timer available220second # [ 0.016161] CPU topo: Num. cores per package: 1221test # [ 0.016162] CPU topo: Max. logical packages: 1222second # [ 0.016161] CPU topo: Num. threads per package: 1223test # [ 0.016163] CPU topo: Max. logical dies: 1224test # [ 0.016163] CPU topo: Max. dies per package: 1225second # [ 0.016161] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs226test # [ 0.016166] CPU topo: Max. threads per core: 1227second # [ 0.016175] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()228test # [ 0.016166] CPU topo: Num. cores per package: 1229test # [ 0.016166] CPU topo: Num. threads per package: 1230second # [ 0.016204] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]231test # [ 0.016167] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs232second # [ 0.016205] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]233test # [ 0.016184] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()234second # [ 0.016206] [mem 0x40000000-0xfeffbfff] available for PCI devices235second # [ 0.016207] Booting paravirtualized kernel on KVM236test # [ 0.016212] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]237test # [ 0.016213] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]238second # [ 0.016210] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns239test # [ 0.016214] [mem 0x40000000-0xfeffbfff] available for PCI devices240second # [ 0.019444] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1241test # [ 0.016216] Booting paravirtualized kernel on KVM242second # [ 0.021022] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152243second # [ 0.021056] kvm-guest: PV spinlocks disabled, single CPU244test # [ 0.016219] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns245test # [ 0.019515] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1246test # [ 0.021108] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152247test # [ 0.021145] kvm-guest: PV spinlocks disabled, single CPU248second # [ 0.021057] 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/sccznmhx0nrv0pzmp4igkxa4kircv506-nixos-system-second-test/init regInfo=/nix/store/l93hfyjg4pn829z8g76ldcxgh15k1rnq-closure-info/registration console=ttyS0,115200n8 console=tty0249second # [ 0.021128] Unknown kernel command line parameters "regInfo=/nix/store/l93hfyjg4pn829z8g76ldcxgh15k1rnq-closure-info/registration", will be passed to user space.250second # [ 0.021319] random: crng init done251test # [ 0.021146] 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/4chh5garxqihjk361khlwcj0hwv9s51v-nixos-system-test-test/init regInfo=/nix/store/54yi71gl55p1piqxnn4zbs1iff7wgzvx-closure-info/registration console=ttyS0,115200n8 console=tty0252second # [ 0.021320] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes253second # [ 0.022235] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)254test # [ 0.021227] Unknown kernel command line parameters "regInfo=/nix/store/54yi71gl55p1piqxnn4zbs1iff7wgzvx-closure-info/registration", will be passed to user space.255test # [ 0.021426] random: crng init done256second # [ 0.022247] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)257second # [ 0.022273] Fallback order for Node 0: 0258test # [ 0.021427] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes259second # [ 0.022275] Built 1 zonelists, mobility grouping on. Total pages: 262009260test # [ 0.022218] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)261second # [ 0.022275] Policy zone: DMA32262second # [ 0.023835] mem auto-init: stack:all(zero), heap alloc:on, heap free:off263test # [ 0.022230] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)264test # [ 0.022262] Fallback order for Node 0: 0265second # [ 0.026096] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1266second # [ 0.027735] allocated 2097152 bytes of page_ext267test # [ 0.022264] Built 1 zonelists, mobility grouping on. Total pages: 262009268test # [ 0.022265] Policy zone: DMA32269second # [ 0.036777] ftrace: allocating 48717 entries in 192 pages270test # [ 0.023817] mem auto-init: stack:all(zero), heap alloc:on, heap free:off271second # [ 0.036779] ftrace: allocated 192 pages with 2 groups272second # [ 0.037424] Dynamic Preempt: lazy273test # [ 0.026124] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1274second # [ 0.037562] rcu: Preemptible hierarchical RCU implementation.275test # [ 0.027848] allocated 2097152 bytes of page_ext276second # [ 0.037563] rcu: RCU event tracing is enabled.277test # [ 0.036701] ftrace: allocating 48717 entries in 192 pages278second # [ 0.037563] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.279test # [ 0.036702] ftrace: allocated 192 pages with 2 groups280test # [ 0.037346] Dynamic Preempt: lazy281second # [ 0.037565] Trampoline variant of Tasks RCU enabled.282second # [ 0.037565] Rude variant of Tasks RCU enabled.283test # [ 0.037440] rcu: Preemptible hierarchical RCU implementation.284test # [ 0.037441] rcu: RCU event tracing is enabled.285second # [ 0.037565] Tracing variant of Tasks RCU enabled.286test # [ 0.037441] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.287second # [ 0.037566] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.288test # [ 0.037442] Trampoline variant of Tasks RCU enabled.289second # [ 0.037567] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1290test # [ 0.037442] Rude variant of Tasks RCU enabled.291test # [ 0.037443] Tracing variant of Tasks RCU enabled.292second # [ 0.037579] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.293test # [ 0.037443] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.294second # [ 0.037581] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.295test # [ 0.037444] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1296second # [ 0.037581] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.297test # [ 0.037484] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.298second # [ 0.040774] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16299test # [ 0.037485] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.300second # [ 0.041011] rcu: srcu_init: Setting srcu_struct sizes based on contention.301test # [ 0.037485] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.302second # [ 0.041016] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns303test # [ 0.040663] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16304second # [ 0.041164] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)305test # [ 0.040890] rcu: srcu_init: Setting srcu_struct sizes based on contention.306second # [ 0.046318] Console: colour VGA+ 80x25307second # [ 0.046321] printk: legacy console [tty0] enabled308test # [ 0.040894] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns309second # [ 0.075510] printk: legacy console [ttyS0] enabled310second # [ 0.202605] ACPI: Core revision 20250807311test # [ 0.041033] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)312test # [ 0.046166] Console: colour VGA+ 80x25313test # [ 0.046169] printk: legacy console [tty0] enabled314second # [ 0.203654] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns315test # [ 0.075416] printk: legacy console [ttyS0] enabled316second # [ 0.205561] APIC: Switch to symmetric I/O mode setup317test # [ 0.202680] ACPI: Core revision 20250807318second # [ 0.206715] x2apic enabled319second # [ 0.207515] APIC: Switched APIC routing to: physical x2apic320test # [ 0.203725] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns321test # [ 0.205615] APIC: Switch to symmetric I/O mode setup322second # [ 0.209438] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1323test # [ 0.206766] x2apic enabled324test # [ 0.207571] APIC: Switched APIC routing to: physical x2apic325second # [ 0.210645] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns326test # [ 0.209558] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1327second # [ 0.212670] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)328second # [ 0.213752] x86/cpu: User Mode Instruction Prevention (UMIP) activated329test # [ 0.210774] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns330second # [ 0.215794] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127331test # [ 0.212797] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)332second # [ 0.216668] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0333test # [ 0.213879] x86/cpu: User Mode Instruction Prevention (UMIP) activated334second # [ 0.217671] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto335test # [ 0.215903] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127336test # [ 0.216796] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0337second # [ 0.219669] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl338second # [ 0.221669] Spectre V2 : Mitigation: Enhanced / Automatic IBRS339test # [ 0.217799] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto340second # [ 0.222668] Speculative Return Stack Overflow: Mitigation: Safe RET341test # [ 0.219796] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl342second # [ 0.223668] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization343test # [ 0.221796] Spectre V2 : Mitigation: Enhanced / Automatic IBRS344second # [ 0.225679] Spectre V2 : Enabling IBPB for BPF345test # [ 0.222795] Speculative Return Stack Overflow: Mitigation: Safe RET346second # [ 0.226669] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier347test # [ 0.223795] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization348second # [ 0.227669] active return thunk: srso_alias_return_thunk349test # [ 0.225801] Spectre V2 : Enabling IBPB for BPF350test # [ 0.226796] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier351test # [ 0.227796] active return thunk: srso_alias_return_thunk352second # [ 0.228696] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'353second # [ 0.230668] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'354second # [ 0.231668] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'355test # [ 0.228816] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'356second # [ 0.232668] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'357test # [ 0.230795] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'358second # [ 0.234668] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'359test # [ 0.231795] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'360second # [ 0.235668] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'361test # [ 0.232795] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'362second # [ 0.236668] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'363test # [ 0.234795] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'364second # [ 0.237668] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'365test # [ 0.235795] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'366second # [ 0.238668] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'367test # [ 0.236795] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'368second # [ 0.239669] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256369test # [ 0.237795] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'370second # [ 0.240668] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64371test # [ 0.238795] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'372second # [ 0.241668] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512373test # [ 0.239796] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256374second # [ 0.243668] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024375test # [ 0.240795] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64376second # [ 0.244668] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8377test # [ 0.241795] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512378second # [ 0.245668] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16379test # [ 0.242795] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024380second # [ 0.246668] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24381test # [ 0.244795] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8382second # [ 0.247668] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.383test # [ 0.245795] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16384test # [ 0.246795] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24385test # [ 0.247795] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.386second # [ 0.276195] Freeing SMP alternatives memory: 44K387second # [ 0.276670] pid_max: default: 32768 minimum: 301388second # [ 0.277732] LSM: initializing lsm=capability,landlock,yama,bpf,ima389test # [ 0.275986] Freeing SMP alternatives memory: 44K390second # [ 0.278762] landlock: Up and running.391second # [ 0.279669] Yama: becoming mindful.392test # [ 0.276797] pid_max: default: 32768 minimum: 301393second # [ 0.280855] LSM support for eBPF active394test # [ 0.277854] LSM: initializing lsm=capability,landlock,yama,bpf,ima395test # [ 0.278876] landlock: Up and running.396second # [ 0.281744] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)397test # [ 0.279795] Yama: becoming mindful.398test # [ 0.280878] LSM support for eBPF active399second # [ 0.282686] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)400test # [ 0.281742] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)401second # [ 0.285834] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)402test # [ 0.282812] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)403second # [ 0.287083] Performance Events: Fam17h+ core perfctr, AMD PMU driver.404second # [ 0.287681] ... version: 2405test # [ 0.285412] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)406second # [ 0.288546] ... bit width: 48407second # [ 0.289360] ... generic counters: 6408test # [ 0.286179] Performance Events: Fam17h+ core perfctr, AMD PMU driver.409test # [ 0.286799] ... version: 2410second # [ 0.289674] ... generic bitmap: 000000000000003f411test # [ 0.287652] ... bit width: 48412second # [ 0.290670] ... fixed-purpose counters: 0413test # [ 0.288475] ... generic counters: 6414second # [ 0.291538] ... fixed-purpose bitmap: 0000000000000000415test # [ 0.288805] ... generic bitmap: 000000000000003f416second # [ 0.292545] ... value mask: 0000ffffffffffff417test # [ 0.289797] ... fixed-purpose counters: 0418second # [ 0.293551] ... max period: 00007fffffffffff419test # [ 0.290654] ... fixed-purpose bitmap: 0000000000000000420second # [ 0.294548] ... global_ctrl mask: 000000000000003f421test # [ 0.291668] ... value mask: 0000ffffffffffff422second # [ 0.295620] signal: max sigframe size: 3376423test # [ 0.292674] ... max period: 00007fffffffffff424second # [ 0.296392] rcu: Hierarchical SRCU implementation.425test # [ 0.293655] ... global_ctrl mask: 000000000000003f426second # [ 0.296673] rcu: Max phase no-delay instances is 400.427test # [ 0.294731] signal: max sigframe size: 3376428test # [ 0.295530] rcu: Hierarchical SRCU implementation.429test # [ 0.295800] rcu: Max phase no-delay instances is 400.430second # [ 0.300621] smp: Bringing up secondary CPUs ...431second # [ 0.301395] smp: Brought up 1 node, 1 CPU432second # [ 0.301676] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)433test # [ 0.299700] smp: Bringing up secondary CPUs ...434test # [ 0.300513] smp: Brought up 1 node, 1 CPU435test # [ 0.300797] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)436second # [ 0.302785] Memory: 942892K/1048036K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97708K reserved, 0K cma-reserved)437second # [ 0.303832] devtmpfs: initialized438second # [ 0.304709] x86/mm: Memory block size: 128MB439test # [ 0.301933] Memory: 942912K/1048036K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97716K reserved, 0K cma-reserved)440test # [ 0.302962] devtmpfs: initialized441second # [ 0.306232] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)442test # [ 0.303786] x86/mm: Memory block size: 128MB443second # [ 0.306695] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).444test # [ 0.305155] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)445second # [ 0.307742] pinctrl core: initialized pinctrl subsystem446second # [ 0.308898] PM: RTC time: 08:10:46, date: 2026-08-20447test # [ 0.305817] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).448test # [ 0.306871] pinctrl core: initialized pinctrl subsystem449test # [ 0.308015] PM: RTC time: 08:10:46, date: 2026-08-20450second # [ 0.311616] NET: Registered PF_NETLINK/PF_ROUTE protocol family451second # [ 0.312852] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations452test # [ 0.310684] NET: Registered PF_NETLINK/PF_ROUTE protocol family453second # [ 0.313684] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations454test # [ 0.311986] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations455second # [ 0.314771] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations456test # [ 0.312811] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations457second # [ 0.315681] audit: initializing netlink subsys (disabled)458test # [ 0.313897] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations459second # [ 0.316867] thermal_sys: Registered thermal governor 'fair_share'460test # [ 0.314803] audit: initializing netlink subsys (disabled)461second # [ 0.316869] thermal_sys: Registered thermal governor 'bang_bang'462second # [ 0.317670] thermal_sys: Registered thermal governor 'step_wise'463test # [ 0.316140] thermal_sys: Registered thermal governor 'fair_share'464test # [ 0.316142] thermal_sys: Registered thermal governor 'bang_bang'465second # [ 0.318672] audit: type=2000 audit(1787213446.972:1): state=initialized audit_enabled=0 res=1466test # [ 0.316797] thermal_sys: Registered thermal governor 'step_wise'467second # [ 0.320676] thermal_sys: Registered thermal governor 'user_space'468second # [ 0.320677] thermal_sys: Registered thermal governor 'power_allocator'469test # [ 0.317799] audit: type=2000 audit(1787213446.974:1): state=initialized audit_enabled=0 res=1470second # [ 0.321681] cpuidle: using governor menu471test # [ 0.319798] thermal_sys: Registered thermal governor 'user_space'472test # [ 0.319800] thermal_sys: Registered thermal governor 'power_allocator'473second # [ 0.324282] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5474test # [ 0.320817] cpuidle: using governor menu475second # [ 0.324870] PCI: Using configuration type 1 for base access476second # [ 0.325673] PCI: Using configuration type 1 for extended access477test # [ 0.323379] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5478test # [ 0.323990] PCI: Using configuration type 1 for base access479second # [ 0.326834] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.480test # [ 0.324797] PCI: Using configuration type 1 for extended access481test # [ 0.325937] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.482second # [ 0.331844] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages483second # [ 0.332670] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page484test # [ 0.332950] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages485test # [ 0.333797] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page486second # [ 0.337669] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages487second # [ 0.338670] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page488test # [ 0.338796] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages489test # [ 0.339797] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page490second # [ 0.348009] ACPI: Added _OSI(Module Device)491second # [ 0.348670] ACPI: Added _OSI(Processor Device)492second # [ 0.349561] ACPI: Added _OSI(Processor Aggregator Device)493test # [ 0.347021] ACPI: Added _OSI(Module Device)494test # [ 0.347797] ACPI: Added _OSI(Processor Device)495test # [ 0.348685] ACPI: Added _OSI(Processor Aggregator Device)496second # [ 0.353952] ACPI: 1 ACPI AML tables successfully acquired and loaded497test # [ 0.353092] ACPI: 1 ACPI AML tables successfully acquired and loaded498second # [ 0.357237] ACPI: Interpreter enabled499second # [ 0.357683] ACPI: PM: (supports S0 S3 S4 S5)500second # [ 0.358544] ACPI: Using IOAPIC for interrupt routing501test # [ 0.356360] ACPI: Interpreter enabled502test # [ 0.356809] ACPI: PM: (supports S0 S3 S4 S5)503test # [ 0.357663] ACPI: Using IOAPIC for interrupt routing504second # [ 0.361680] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug505test # [ 0.358583] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug506second # [ 0.362670] PCI: Using E820 reservations for host bridge windows507second # [ 0.364074] ACPI: Enabled 2 GPEs in block 00 to 0F508test # [ 0.362244] PCI: Using E820 reservations for host bridge windows509test # [ 0.362901] ACPI: Enabled 2 GPEs in block 00 to 0F510second # [ 0.367731] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])511second # [ 0.368675] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]512test # [ 0.366805] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])513second # [ 0.369943] acpiphp: Slot [3] registered514second # [ 0.370707] acpiphp: Slot [4] registered515test # [ 0.367801] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]516second # [ 0.371533] acpiphp: Slot [5] registered517test # [ 0.369029] acpiphp: Slot [3] registered518second # [ 0.372319] acpiphp: Slot [6] registered519test # [ 0.369829] acpiphp: Slot [4] registered520second # [ 0.372694] acpiphp: Slot [7] registered521test # [ 0.370656] acpiphp: Slot [5] registered522second # [ 0.373526] acpiphp: Slot [8] registered523test # [ 0.371438] acpiphp: Slot [6] registered524second # [ 0.374303] acpiphp: Slot [9] registered525test # [ 0.371819] acpiphp: Slot [7] registered526second # [ 0.374695] acpiphp: Slot [10] registered527test # [ 0.372653] acpiphp: Slot [8] registered528second # [ 0.375538] acpiphp: Slot [11] registered529test # [ 0.373433] acpiphp: Slot [9] registered530second # [ 0.376344] acpiphp: Slot [12] registered531test # [ 0.373820] acpiphp: Slot [10] registered532second # [ 0.376694] acpiphp: Slot [13] registered533test # [ 0.374672] acpiphp: Slot [11] registered534second # [ 0.377546] acpiphp: Slot [14] registered535test # [ 0.375477] acpiphp: Slot [12] registered536second # [ 0.378325] acpiphp: Slot [15] registered537test # [ 0.375831] acpiphp: Slot [13] registered538second # [ 0.378701] acpiphp: Slot [16] registered539test # [ 0.376674] acpiphp: Slot [14] registered540second # [ 0.379564] acpiphp: Slot [17] registered541test # [ 0.377460] acpiphp: Slot [15] registered542second # [ 0.380350] acpiphp: Slot [18] registered543test # [ 0.377828] acpiphp: Slot [16] registered544second # [ 0.380707] acpiphp: Slot [19] registered545test # [ 0.378678] acpiphp: Slot [17] registered546second # [ 0.381582] acpiphp: Slot [20] registered547test # [ 0.379469] acpiphp: Slot [18] registered548second # [ 0.382347] acpiphp: Slot [21] registered549test # [ 0.379829] acpiphp: Slot [19] registered550second # [ 0.382697] acpiphp: Slot [22] registered551test # [ 0.380690] acpiphp: Slot [20] registered552second # [ 0.383565] acpiphp: Slot [23] registered553test # [ 0.381460] acpiphp: Slot [21] registered554second # [ 0.384342] acpiphp: Slot [24] registered555test # [ 0.381820] acpiphp: Slot [22] registered556second # [ 0.384698] acpiphp: Slot [25] registered557test # [ 0.382683] acpiphp: Slot [23] registered558second # [ 0.385566] acpiphp: Slot [26] registered559test # [ 0.383456] acpiphp: Slot [24] registered560second # [ 0.386359] acpiphp: Slot [27] registered561test # [ 0.383820] acpiphp: Slot [25] registered562second # [ 0.386697] acpiphp: Slot [28] registered563test # [ 0.384676] acpiphp: Slot [26] registered564second # [ 0.387558] acpiphp: Slot [29] registered565test # [ 0.385476] acpiphp: Slot [27] registered566second # [ 0.388349] acpiphp: Slot [30] registered567test # [ 0.385821] acpiphp: Slot [28] registered568second # [ 0.388703] acpiphp: Slot [31] registered569test # [ 0.386677] acpiphp: Slot [29] registered570second # [ 0.389544] PCI host bridge to bus 0000:00571test # [ 0.387461] acpiphp: Slot [30] registered572test # [ 0.387835] acpiphp: Slot [31] registered573second # [ 0.390335] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]574test # [ 0.388693] PCI host bridge to bus 0000:00575second # [ 0.390670] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]576test # [ 0.389461] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]577second # [ 0.391673] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]578test # [ 0.389797] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]579second # [ 0.392688] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]580test # [ 0.390797] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]581second # [ 0.393670] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]582test # [ 0.391800] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]583second # [ 0.394671] pci_bus 0000:00: root bus resource [bus 00-ff]584test # [ 0.392814] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]585second # [ 0.395916] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint586test # [ 0.393798] pci_bus 0000:00: root bus resource [bus 00-ff]587test # [ 0.395030] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint588second # [ 0.397303] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint589test # [ 0.396414] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint590second # [ 0.398315] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint591test # [ 0.397440] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint592second # [ 0.399647] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]593second # [ 0.400548] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk594test # [ 0.398731] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]595second # [ 0.401670] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk596test # [ 0.399671] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk597second # [ 0.402670] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk598test # [ 0.400797] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk599second # [ 0.403670] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk600test # [ 0.401797] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk601second # [ 0.404884] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint602test # [ 0.402797] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk603test # [ 0.404009] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint604second # [ 0.406532] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]605test # [ 0.405698] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]606second # [ 0.408417] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint607second # [ 0.410108] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI608test # [ 0.407505] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint609second # [ 0.410681] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB610test # [ 0.409234] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI611test # [ 0.409807] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB612second # [ 0.411951] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint613test # [ 0.411076] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint614second # [ 0.414710] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]615second # [ 0.415694] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]616test # [ 0.413754] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]617second # [ 0.416712] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]618test # [ 0.414817] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]619test # [ 0.415834] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]620second # [ 0.417836] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]621test # [ 0.416967] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]622second # [ 0.419418] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint623test # [ 0.418648] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint624second # [ 0.421680] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]625second # [ 0.422681] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]626test # [ 0.420807] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]627second # [ 0.423711] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]628test # [ 0.421807] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]629second # [ 0.424681] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]630test # [ 0.422834] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]631test # [ 0.423807] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]632second # [ 0.427738] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint633test # [ 0.426404] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint634second # [ 0.429680] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]635second # [ 0.430680] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]636test # [ 0.427807] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]637test # [ 0.428807] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]638second # [ 0.431708] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]639test # [ 0.429834] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]640second # [ 0.434094] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint641test # [ 0.432185] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint642second # [ 0.435690] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]643second # [ 0.436680] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]644test # [ 0.433807] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]645test # [ 0.434807] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]646second # [ 0.437708] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]647test # [ 0.435834] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]648second # [ 0.440082] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint649test # [ 0.438167] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint650second # [ 0.441680] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]651test # [ 0.439807] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]652second # [ 0.443516] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]653second # [ 0.444646] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]654test # [ 0.441632] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]655test # [ 0.442759] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]656second # [ 0.447146] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint657test # [ 0.445192] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint658second # [ 0.449349] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]659test # [ 0.446807] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]660second # [ 0.449680] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]661test # [ 0.447807] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]662second # [ 0.450706] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]663test # [ 0.448834] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]664second # [ 0.453068] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint665test # [ 0.451219] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint666test # [ 0.452807] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]667second # [ 0.454680] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]668test # [ 0.453807] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]669second # [ 0.455680] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]670test # [ 0.454834] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]671second # [ 0.456707] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]672test # [ 0.457182] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint673second # [ 0.459072] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint674test # [ 0.458807] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]675second # [ 0.460680] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]676test # [ 0.459807] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]677second # [ 0.461685] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]678test # [ 0.460834] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]679second # [ 0.462712] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]680test # [ 0.461807] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]681second # [ 0.463685] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]682test # [ 0.464286] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint683second # [ 0.466037] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint684test # [ 0.465579] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]685second # [ 0.467641] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]686test # [ 0.465834] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]687second # [ 0.468638] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]688test # [ 0.468187] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint689second # [ 0.471066] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint690test # [ 0.469809] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]691second # [ 0.472680] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]692test # [ 0.470807] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]693second # [ 0.473685] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]694test # [ 0.471834] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]695second # [ 0.474710] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]696test # [ 0.474213] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint697second # [ 0.477093] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint698test # [ 0.475807] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]699test # [ 0.476807] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]700second # [ 0.479073] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]701second # [ 0.479685] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]702test # [ 0.477834] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]703second # [ 0.480712] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]704test # [ 0.483663] ACPI: PCI: Interrupt link LNKA configured for IRQ 10705test # [ 0.484854] ACPI: PCI: Interrupt link LNKB configured for IRQ 10706second # [ 0.486585] ACPI: PCI: Interrupt link LNKA configured for IRQ 10707test # [ 0.485927] ACPI: PCI: Interrupt link LNKC configured for IRQ 11708second # [ 0.487747] ACPI: PCI: Interrupt link LNKB configured for IRQ 10709test # [ 0.486926] ACPI: PCI: Interrupt link LNKD configured for IRQ 11710second # [ 0.488804] ACPI: PCI: Interrupt link LNKC configured for IRQ 11711test # [ 0.487872] ACPI: PCI: Interrupt link LNKS configured for IRQ 9712second # [ 0.489804] ACPI: PCI: Interrupt link LNKD configured for IRQ 11713second # [ 0.490738] ACPI: PCI: Interrupt link LNKS configured for IRQ 9714test # [ 0.489709] iommu: Default domain type: Translated715test # [ 0.490593] iommu: DMA domain TLB invalidation policy: lazy mode716second # [ 0.492590] iommu: Default domain type: Translated717test # [ 0.491936] ACPI: bus type USB registered718second # [ 0.493442] iommu: DMA domain TLB invalidation policy: lazy mode719test # [ 0.492806] usbcore: registered new interface driver usbfs720second # [ 0.493891] ACPI: bus type USB registered721test # [ 0.493822] usbcore: registered new interface driver hub722second # [ 0.494713] usbcore: registered new interface driver usbfs723test # [ 0.494806] usbcore: registered new device driver usb724second # [ 0.495713] usbcore: registered new interface driver hub725test # [ 0.496580] NetLabel: Initializing726second # [ 0.496772] usbcore: registered new device driver usb727test # [ 0.496801] NetLabel: domain hash size = 128728second # [ 0.498343] NetLabel: Initializing729test # [ 0.497679] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO730second # [ 0.498678] NetLabel: domain hash size = 128731test # [ 0.498731] NetLabel: unlabeled traffic allowed by default732second # [ 0.499557] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO733test # [ 0.499680] PCI: Using ACPI for IRQ routing734second # [ 0.500601] NetLabel: unlabeled traffic allowed by default735second # [ 0.501558] PCI: Using ACPI for IRQ routing736test # [ 0.500910] pci 0000:00:02.0: vgaarb: setting as boot VGA device737test # [ 0.501793] pci 0000:00:02.0: vgaarb: bridge control possible738second # [ 0.502792] pci 0000:00:02.0: vgaarb: setting as boot VGA device739second # [ 0.503666] pci 0000:00:02.0: vgaarb: bridge control possible740test # [ 0.501793] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none741test # [ 0.501798] vgaarb: loaded742second # [ 0.503666] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none743test # [ 0.502565] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0744second # [ 0.503675] vgaarb: loaded745test # [ 0.502799] hpet0: 3 comparators, 64-bit 100.000000 MHz counter746second # [ 0.504437] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0747second # [ 0.504671] hpet0: 3 comparators, 64-bit 100.000000 MHz counter748test # [ 0.506852] clocksource: Switched to clocksource kvm-clock749test # [ 0.508500] VFS: Disk quotas dquot_6.6.0750second # [ 0.508728] clocksource: Switched to clocksource kvm-clock751second # [ 0.510327] VFS: Disk quotas dquot_6.6.0752test # [ 0.510684] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)753test # [ 0.512176] pnp: PnP ACPI init754second # [ 0.512516] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)755test # [ 0.513266] pnp: PnP ACPI: found 6 devices756second # [ 0.514012] pnp: PnP ACPI init757second # [ 0.515110] pnp: PnP ACPI: found 6 devices758test # [ 0.520282] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns759test # [ 0.521974] clocksource: Switched to clocksource acpi_pm760second # [ 0.522131] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns761test # [ 0.523112] NET: Registered PF_INET protocol family762second # [ 0.523841] clocksource: Switched to clocksource acpi_pm763second # [ 0.524970] NET: Registered PF_INET protocol family764test # [ 0.524243] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)765second # [ 0.526111] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)766test # [ 0.536831] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)767test # [ 0.538555] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)768second # [ 0.538895] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)769test # [ 0.540073] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)770second # [ 0.540595] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)771test # [ 0.541594] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)772second # [ 0.542160] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)773test # [ 0.543020] TCP: Hash tables configured (established 8192 bind 8192)774second # [ 0.543691] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)775test # [ 0.544291] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)776second # [ 0.545127] TCP: Hash tables configured (established 8192 bind 8192)777test # [ 0.545757] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)778second # [ 0.546438] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)779test # [ 0.547099] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)780second # [ 0.547974] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)781test # [ 0.548504] NET: Registered PF_UNIX/PF_LOCAL protocol family782second # [ 0.549293] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)783test # [ 0.549664] NET: Registered PF_XDP protocol family784second # [ 0.550766] NET: Registered PF_UNIX/PF_LOCAL protocol family785test # [ 0.550653] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]786second # [ 0.551909] NET: Registered PF_XDP protocol family787test # [ 0.551854] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]788second # [ 0.552913] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]789test # [ 0.553085] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]790second # [ 0.554117] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]791test # [ 0.554398] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]792second # [ 0.555327] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]793test # [ 0.555714] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]794second # [ 0.556680] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]795test # [ 0.557132] pci 0000:00:01.0: PIIX3: Enabling Passive Release796second # [ 0.558013] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]797test # [ 0.558290] pci 0000:00:00.0: Limiting direct PCI/PCI transfers798second # [ 0.559520] pci 0000:00:01.0: PIIX3: Enabling Passive Release799test # [ 0.560539] ACPI: \_SB_.LNKD: Enabled at IRQ 11800second # [ 0.560810] pci 0000:00:00.0: Limiting direct PCI/PCI transfers801test # [ 0.562752] PCI: CLS 0 bytes, default 64802second # [ 0.563103] ACPI: \_SB_.LNKD: Enabled at IRQ 11803test # [ 0.563747] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns804second # [ 0.565353] PCI: CLS 0 bytes, default 64805test # [ 0.565744] Trying to unpack rootfs image as initramfs...806second # [ 0.566346] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns807second # [ 0.568355] Trying to unpack rootfs image as initramfs...808test # [ 0.598378] Initialise system trusted keyrings809second # [ 0.601456] Initialise system trusted keyrings810test # [ 0.602007] workingset: timestamp_bits=40 max_order=18 bucket_order=0811second # [ 0.604720] workingset: timestamp_bits=40 max_order=18 bucket_order=0812test # [ 0.619136] Key type asymmetric registered813second # [ 0.619904] Key type asymmetric registered814test # [ 0.621932] Asymmetric key parser 'x509' registered815test # [ 0.622957] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)816second # [ 0.624700] Asymmetric key parser 'x509' registered817second # [ 0.625714] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)818test # [ 0.627053] io scheduler mq-deadline registered819test # [ 0.627987] io scheduler kyber registered820second # [ 0.629778] io scheduler mq-deadline registered821second # [ 0.630698] io scheduler kyber registered822test # [ 0.631346] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled823test # [ 0.632842] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A824second # [ 0.634092] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled825second # [ 0.635560] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A826test # [ 0.638763] Linux agpgart interface v0.103827test # [ 0.639675] ACPI: bus type drm_connector registered828second # [ 0.641489] Linux agpgart interface v0.103829second # [ 0.642405] ACPI: bus type drm_connector registered830test # [ 0.644268] usbcore: registered new interface driver usbserial_generic831test # [ 0.645551] usbserial: USB Serial support registered for generic832second # [ 0.647101] usbcore: registered new interface driver usbserial_generic833second # [ 0.648379] usbserial: USB Serial support registered for generic834test # [ 0.648937] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.835test # [ 0.648937] Please enable it if your BIOS has the CPPC option.836test # [ 0.651521] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled837second # [ 0.651688] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.838second # [ 0.651688] Please enable it if your BIOS has the CPPC option.839second # [ 0.654275] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled840test # [ 0.655014] drop_monitor: Initializing network drop monitor service841test # [ 0.656355] NET: Registered PF_INET6 protocol family842second # [ 0.657790] drop_monitor: Initializing network drop monitor service843second # [ 0.659097] NET: Registered PF_INET6 protocol family844test # [ 0.661290] Segment Routing with IPv6845second # [ 0.664020] Segment Routing with IPv6846test # [ 0.663945] In-situ OAM (IOAM) with IPv6847test # [ 0.665034] IPI shorthand broadcast: enabled848second # [ 0.666699] In-situ OAM (IOAM) with IPv6849second # [ 0.667791] IPI shorthand broadcast: enabled850test # [ 0.672268] sched_clock: Marking stable (505030644, 166899943)->(747718747, -75788160)851second # [ 0.675053] sched_clock: Marking stable (508020350, 166650405)->(753431600, -78760845)852test # [ 0.676005] registered taskstats version 1853test # [ 0.677047] Loading compiled-in X.509 certificates854second # [ 0.679794] registered taskstats version 1855second # [ 0.680835] Loading compiled-in X.509 certificates856test # [ 0.690935] Demotion targets for Node 0: null857test # [ 0.692968] Key type .fscrypt registered858test # [ 0.693761] Key type fscrypt-provisioning registered859second # [ 0.694698] Demotion targets for Node 0: null860test # [ 0.694853] ima: No TPM chip found, activating TPM-bypass!861second # [ 0.695712] Key type .fscrypt registered862second # [ 0.696507] Key type fscrypt-provisioning registered863second # [ 0.697593] ima: No TPM chip found, activating TPM-bypass!864test # [ 0.699934] ima: Allocated hash algorithm: sha1865test # [ 0.700863] ima: No architecture policies found866second # [ 0.702687] ima: Allocated hash algorithm: sha1867second # [ 0.703610] ima: No architecture policies found868test # [ 0.703988] PM: Magic number: 6:977:169869test # [ 0.705637] RAS: Correctable Errors collector initialized.870second # [ 0.706728] PM: Magic number: 6:977:169871second # [ 0.708261] RAS: Correctable Errors collector initialized.872test # [ 0.713694] clk: Disabling unused clocks873test # [ 0.715939] PM: genpd: Disabling unused power domains874second # [ 0.717283] clk: Disabling unused clocks875second # [ 0.718126] PM: genpd: Disabling unused power domains876second # [ 0.814443] Freeing initrd memory: 29204K877test # [ 0.815489] Freeing initrd memory: 29212K878second # [ 0.817258] Freeing unused decrypted memory: 2028K879test # [ 0.818196] Freeing unused decrypted memory: 2028K880second # [ 0.819614] Freeing unused kernel image (initmem) memory: 3644K881test # [ 0.820580] Freeing unused kernel image (initmem) memory: 3644K882second # [ 0.820904] Write protecting the kernel read-only data: 32768k883test # [ 0.821827] Write protecting the kernel read-only data: 32768k884second # [ 0.822757] Freeing unused kernel image (text/rodata gap) memory: 1220K885test # [ 0.823672] Freeing unused kernel image (text/rodata gap) memory: 1220K886second # [ 0.824369] Freeing unused kernel image (rodata/data gap) memory: 756K887test # [ 0.825282] Freeing unused kernel image (rodata/data gap) memory: 756K888second # [ 0.856266] x86/mm: Checked W+X mappings: passed, no W+X pages found.889second # [ 0.857514] Run /init as init process890test # [ 0.857182] x86/mm: Checked W+X mappings: passed, no W+X pages found.891test # [ 0.858433] Run /init as init process892second # [ 0.865179] systemd[1]: Inserted module 'autofs4'893test # [ 0.866311] systemd[1]: Inserted module 'autofs4'894second # [ 0.876690] fuse: init (API version 7.45)895test # [ 0.878056] fuse: init (API version 7.45)896second # [ 0.881631] ACPI: \_SB_.LNKC: Enabled at IRQ 10897test # [ 0.883142] ACPI: \_SB_.LNKC: Enabled at IRQ 10898second # [ 0.887258] ACPI: \_SB_.LNKA: Enabled at IRQ 10899test # [ 0.888859] ACPI: \_SB_.LNKA: Enabled at IRQ 10900second # [ 0.890227] ACPI: \_SB_.LNKB: Enabled at IRQ 11901test # [ 0.891842] ACPI: \_SB_.LNKB: Enabled at IRQ 11902second # [ 0.916920] systemd[1]: Successfully made /usr/ read-only.903test # [ 0.918207] systemd[1]: Successfully made /usr/ read-only.904second # [ 1.252882] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)905second # [ 1.258484] systemd[1]: Detected virtualization kvm.906test # [ 1.254101] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)907second # [ 1.259505] systemd[1]: Detected architecture x86-64.908test # [ 1.259715] systemd[1]: Detected virtualization kvm.909second # [ 1.260525] systemd[1]: Running in initrd.910test # [ 1.260727] systemd[1]: Detected architecture x86-64.911second # [ 1.261545] systemd[1]: Initializing machine ID from random generator.912test # [ 1.261760] systemd[1]: Running in initrd.913second # [ 1.262918] systemd[1]: Hostname set to <second>.914test # [ 1.262784] systemd[1]: Initializing machine ID from random generator.915test # [ 1.264236] systemd[1]: Hostname set to <test>.916test # [ 1.431063] systemd[1]: bpf-restrict-fs: LSM BPF program attached917second # [ 1.431883] systemd[1]: bpf-restrict-fs: LSM BPF program attached918test # [ 1.459080] systemd[1]: Queued start job for default target Initrd Default Target.919second # [ 1.460144] systemd[1]: Queued start job for default target Initrd Default Target.920test # [ 1.463002] systemd[1]: Created slice Slice /system/modprobe.921second # [ 1.463762] systemd[1]: Created slice Slice /system/modprobe.922test # [ 1.464372] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.923second # [ 1.465094] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.924test # [ 1.465998] systemd[1]: Expecting device /dev/disk/by-label/nixos...925second # [ 1.466726] systemd[1]: Expecting device /dev/disk/by-label/nixos...926test # [ 1.467294] systemd[1]: Reached target Path Units.927second # [ 1.468029] systemd[1]: Reached target Path Units.928test # [ 1.468340] systemd[1]: Reached target Slice Units.929second # [ 1.469066] systemd[1]: Reached target Slice Units.930test # [ 1.469398] systemd[1]: Reached target Swaps.931second # [ 1.470115] systemd[1]: Reached target Swaps.932test # [ 1.470366] systemd[1]: Reached target Timer Units.933second # [ 1.471097] systemd[1]: Reached target Timer Units.934test # [ 1.471499] systemd[1]: Listening on D-Bus System Message Bus Socket.935second # [ 1.472222] systemd[1]: Listening on D-Bus System Message Bus Socket.936test # [ 1.472940] systemd[1]: Listening on Journal Socket (/dev/log).937second # [ 1.473616] systemd[1]: Listening on Journal Socket (/dev/log).938test # [ 1.474271] systemd[1]: Listening on Journal Sockets.939second # [ 1.474974] systemd[1]: Listening on Journal Sockets.940test # [ 1.475460] systemd[1]: Listening on udev Control Socket.941second # [ 1.476131] systemd[1]: Listening on udev Control Socket.942test # [ 1.476649] systemd[1]: Listening on udev Kernel Socket.943second # [ 1.477318] systemd[1]: Listening on udev Kernel Socket.944test # [ 1.477768] systemd[1]: Reached target Socket Units.945second # [ 1.478442] systemd[1]: Reached target Socket Units.946test # [ 1.479445] systemd[1]: Starting Create List of Static Device Nodes...947second # [ 1.480137] systemd[1]: Starting Create List of Static Device Nodes...948test # [ 1.483075] systemd[1]: Starting Load Kernel Module 9pnet_virtio...949second # [ 1.484726] systemd[1]: Starting Load Kernel Module 9pnet_virtio...950test # [ 1.490069] systemd[1]: Starting Load Kernel Module configfs...951second # [ 1.492175] systemd[1]: Starting Load Kernel Module configfs...952test # [ 1.500423] systemd[1]: Starting Journal Service...953second # [ 1.501183] systemd[1]: Starting Journal Service...954test # [ 1.509009] systemd[1]: Starting Load Kernel Modules...955second # [ 1.512731] systemd[1]: Starting Load Kernel Modules...956test # [ 1.514543] netfs: FS-Cache loaded957test # [ 1.516117] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os958second # [ 1.518240] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os959test # [ 1.528629] 9pnet: Installing 9P2000 support960second # [ 1.529309] netfs: FS-Cache loaded961second # [ 1.541745] 9pnet: Installing 9P2000 support962second # [ 1.542940] systemd-journald[67]: Collecting audit messages is disabled.963test # [ 1.549643] systemd-journald[67]: Collecting audit messages is disabled.964test # [ 1.551105] systemd[1]: Starting Coldplug All udev Devices...965test # [ 1.553931] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.966second # [ 1.556016] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.967second # [ 1.560394] systemd[1]: Starting Coldplug All udev Devices...968test # [ 1.560655] systemd[1]: Finished Create List of Static Device Nodes.969test # [ 1.563119] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev970second # [ 1.565525] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev971test # [ 1.567392] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.972second # [ 1.571919] systemd[1]: Finished Create List of Static Device Nodes.973test # [ 1.575021] systemd[1]: Finished Load Kernel Module 9pnet_virtio.974second # [ 1.578260] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.975test # [ 1.583028] systemd[1]: modprobe@configfs.service: Deactivated successfully.976second # [ 1.587125] systemd[1]: Finished Load Kernel Module 9pnet_virtio.977test # [ 1.587980] systemd[1]: Finished Load Kernel Module configfs.978second # [ 1.593019] systemd[1]: modprobe@configfs.service: Deactivated successfully.979test # [ 1.593541] systemd[1]: Finished Load Kernel Modules.980second # [ 1.597124] systemd[1]: Finished Load Kernel Module configfs.981test # [ 1.597454] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config982second # [ 1.602745] systemd[1]: Finished Load Kernel Modules.983test # [ 1.606570] systemd[1]: Starting Apply Kernel Variables...984second # [ 1.607201] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config985second # [ 1.615727] systemd[1]: Starting Apply Kernel Variables...986test # [ 1.616532] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...987second # [ 1.627813] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...988test # [ 1.633032] systemd[1]: Finished Apply Kernel Variables.989second # [ 1.643823] systemd[1]: Finished Apply Kernel Variables.990test # [ 1.644541] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.991second # [ 1.649378] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.992test # [ 1.651977] systemd[1]: Starting Create Static Device Nodes in /dev...993second # [ 1.657725] systemd[1]: Starting Create Static Device Nodes in /dev...994second # [ 1.497560] systemd-modules-load[68]: Inserted module 'dm_mod'[ 1.665864] systemd[1]: Started Journal Service.995second # 996second # [ 1.500386] systemd-modules-load[68]: Inserted module 'virtio_balloon'997second # [ 1.501638] systemd-modules-load[68]: Inserted module 'virtio_gpu'998test # [ 1.503575] systemd-modules-load[68]: Inserted module 'dm_mod'[ 1.671713] systemd[1]: Started Journal Service.999test # 1000test # [ 1.507940] systemd-modules-load[68]: Inserted module 'virtio_balloon'1001test # [ 1.510162] systemd-modules-load[68]: Inserted module 'virtio_gpu'1002test # [ 1.512338] systemd[1]: Finished Create Static Device Nodes in /dev.1003test # [ 1.514423] systemd[1]: Reached target Preparation for Local File Systems.1004second # [ 1.517191] systemd[1]: Finished Create Static Device Nodes in /dev.1005test # [ 1.518408] systemd[1]: Reached target Local File Systems.1006second # [ 1.519560] systemd[1]: Reached target Preparation for Local File Systems.1007test # [ 1.519563] systemd[1]: Starting Create System Files and Directories...1008second # [ 1.521062] systemd[1]: Reached target Local File Systems.1009test # [ 1.522201] systemd[1]: Starting Rule-based Manager for Device Events and Files...1010second # [ 1.524755] systemd[1]: Starting Create System Files and Directories...1011second # [ 1.531716] systemd[1]: Starting Rule-based Manager for Device Events and Files...1012test # [ 1.542698] systemd[1]: Finished Create System Files and Directories.1013second # [ 1.546056] systemd[1]: Finished Create System Files and Directories.1014test # [ 1.562191] systemd-udevd[77]: Using default interface naming scheme 'v261'.1015second # [ 1.563474] systemd-udevd[83]: Using default interface naming scheme 'v261'.1016test # [ 1.583624] systemd[1]: Started Rule-based Manager for Device Events and Files.1017second # [ 1.584629] systemd[1]: Started Rule-based Manager for Device Events and Files.1018test # [ 1.594571] systemd[1]: Finished Coldplug All udev Devices.1019test # [ 1.595614] systemd[1]: Reached target System Initialization.1020test # [ 1.596691] systemd[1]: Reached target Basic System.1021second # [ 1.599685] systemd[1]: Finished Coldplug All udev Devices.1022second # [ 1.600732] systemd[1]: Reached target System Initialization.1023second # [ 1.601769] systemd[1]: Reached target Basic System.1024second # [ 1.937596] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121025test # [ 1.938460] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121026test # [ 1.956575] serio: i8042 KBD port at 0x60,0x64 irq 11027second # [ 1.959413] serio: i8042 KBD port at 0x60,0x64 irq 11028test # [ 1.963444] uhci_hcd 0000:00:01.2: UHCI Host Controller1029second # [ 1.964269] virtio_blk virtio5: 1/0/0 default/read/poll queues1030test # [ 1.964279] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11031test # [ 1.968293] serio: i8042 AUX port at 0x60,0x64 irq 121032second # [ 1.972684] serio: i8042 AUX port at 0x60,0x64 irq 121033test # [ 1.978951] uhci_hcd 0000:00:01.2: detected 2 ports1034test # [ 1.979801] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1001035test # [ 1.982240] SCSI subsystem initialized1036second # [ 1.985557] SCSI subsystem initialized1037test # [ 1.987984] virtio_blk virtio5: 1/0/0 default/read/poll queues1038second # [ 1.992149] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1039test # [ 1.994524] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181040test # [ 1.995763] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11041second # [ 2.000147] uhci_hcd 0000:00:01.2: UHCI Host Controller1042test # [ 2.003692] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1043second # [ 2.013146] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11044test # [ 2.013703] usb usb1: Product: UHCI Host Controller1045test # [ 2.014817] usb usb1: Manufacturer: Linux 6.18.44 uhci_hcd1046test # [ 2.017933] usb usb1: SerialNumber: 0000:00:01.21047second # [ 2.020084] uhci_hcd 0000:00:01.2: detected 2 ports1048second # [ 2.020970] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1001049test # [ 2.026309] hub 1-0:1.0: USB hub found1050test # [ 2.030214] hub 1-0:1.0: 2 ports detected1051second # [ 2.036980] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181052second # [ 2.038217] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11053second # [ 1.879511] systemd[1]: Starting Virtual Console Setup...1054second # [ 1.886872] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1055test # [ 1.891501] systemd[1]: Starting Virtual Console Setup...1056second # [ 2.062980] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01057test # [ 1.898554] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1058test # [ 1.900545] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1059second # [ 1.908423] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1060second # [ 1.909970] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1061second # [ 1.914445] systemd[1]: Finished Virtual Console Setup.1062test # [ 2.081467] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01063second # [ 2.084457] usb usb1: Product: UHCI Host Controller1064second # [ 2.085249] usb usb1: Manufacturer: Linux 6.18.44 uhci_hcd1065second # [ 2.094542] usb usb1: SerialNumber: 0000:00:01.21066test # [ 1.929281] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1067second # [ 2.099260] hub 1-0:1.0: USB hub found1068second # [ 2.100031] hub 1-0:1.0: 2 ports detected1069test # [ 1.934423] systemd[1]: Finished Virtual Console Setup.1070second # [ 1.939265] systemd[1]: Found device /dev/disk/by-label/nixos.1071second # [ 1.940945] systemd[1]: Reached target Initrd Root Device.1072test # [ 2.107965] scsi host0: ata_piix1073second # [ 1.943800] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1074test # [ 1.945458] systemd[1]: Found device /dev/disk/by-label/nixos.1075test # [ 1.946505] systemd[1]: Reached target Initrd Root Device.1076test # [ 2.115640] scsi host1: ata_piix1077test # [ 1.950071] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1078test # [ 2.120655] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 01079second # [ 2.121557] scsi host0: ata_piix1080test # [ 2.123296] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 01081second # [ 2.124753] scsi host1: ata_piix1082second # [ 2.125369] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 01083second # [ 2.131306] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 01084test # [ 1.967576] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks1085second # [ 1.969335] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks1086test # [ 1.973393] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1087second # [ 1.974184] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1088test # [ 2.255984] usb 1-1: new full-speed USB device number 2 using uhci_hcd1089test # [ 2.280459] ata2: found unknown device (class 0)1090test # [ 2.282104] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001091test # [ 2.284107] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51092second # [ 2.289285] ata2: found unknown device (class 0)1093second # [ 2.290799] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001094second # [ 2.293255] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51095test # [ 2.306438] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1096test # [ 2.315220] cdrom: Uniform CD-ROM driver Revision: 3.201097second # [ 2.316208] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1098second # [ 2.320683] usb 1-1: new full-speed USB device number 2 using uhci_hcd1099second # [ 2.325975] cdrom: Uniform CD-ROM driver Revision: 3.201100test # [ 2.421503] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001101test # [ 2.422734] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101102test # [ 2.423828] usb 1-1: Product: QEMU USB Tablet1103test # [ 2.424804] usb 1-1: Manufacturer: QEMU1104test # [ 2.425539] usb 1-1: SerialNumber: 28754-0000:00:01.2-11105test # [ 2.437807] hid: raw HID events driver (C) Jiri Kosina1106test # [ 2.445692] usbcore: registered new interface driver usbhid1107test # [ 2.447231] usbhid: USB HID core driver1108test # [ 2.450561] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21109test # [ 2.452373] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01110second # [ 2.486142] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001111second # [ 2.487387] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101112second # [ 2.488489] usb 1-1: Product: QEMU USB Tablet1113second # [ 2.489478] usb 1-1: Manufacturer: QEMU1114second # [ 2.490224] usb 1-1: SerialNumber: 28754-0000:00:01.2-11115second # [ 2.502486] hid: raw HID events driver (C) Jiri Kosina1116second # [ 2.510336] usbcore: registered new interface driver usbhid1117second # [ 2.511900] usbhid: USB HID core driver1118second # [ 2.515260] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21119second # [ 2.517047] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01120test # [ 2.392742] systemd[1]: Mounting /sysroot...1121second # [ 2.405400] systemd[1]: Mounting /sysroot...1122test # [ 2.606427] EXT4-fs (vda): mounted filesystem 46050892-c6c6-4f38-bea6-753875e3de53 r/w with ordered data mode. Quota mode: none.1123test # [ 2.444042] systemd[1]: Mounted /sysroot.1124test # [ 2.444824] systemd[1]: Reached target Initrd Root File System.1125test # [ 2.446198] systemd[1]: Starting Mountpoints Configured in the Real Root...1126second # [ 2.619261] EXT4-fs (vda): mounted filesystem 788cf2da-8294-4bb0-be60-7f851a0a86d9 r/w with ordered data mode. Quota mode: none.1127second # [ 2.455747] systemd[1]: Mounted /sysroot.1128test # [ 2.455834] systemd-sysroot-fstab-check[127]: /sysroot should be mounted in the initrd, will request daemon-reload.1129second # [ 2.457258] systemd[1]: Reached target Initrd Root File System.1130test # [ 2.458121] systemd[1]: Reload requested from client PID 127 ('systemd-sysroot') (unit initrd-parse-etc.service)...1131second # [ 2.459350] systemd[1]: Starting Mountpoints Configured in the Real Root...1132test # [ 2.459861] systemd[1]: Reloading...1133second # [ 2.468349] systemd-sysroot-fstab-check[127]: /sysroot should be mounted in the initrd, will request daemon-reload.1134second # [ 2.471864] systemd[1]: Reload requested from client PID 127 ('systemd-sysroot') (unit initrd-parse-etc.service)...1135second # [ 2.473590] systemd[1]: Reloading...1136test # [ 2.506166] systemd[1]: Reloading finished in 48 ms.1137test # [ 2.514079] systemd-sysroot-fstab-check[127]: Requesting initrd-fs.target/start/replace...1138test # [ 2.516080] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1139test # [ 2.517840] systemd-sysroot-fstab-check[127]: Requesting swap.target/start/replace...1140second # [ 2.519626] systemd[1]: Reloading finished in 48 ms.1141test # [ 2.520701] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1142test # [ 2.522419] systemd[1]: Finished Mountpoints Configured in the Real Root.1143test # [ 2.523646] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1144second # [ 2.527081] systemd-sysroot-fstab-check[127]: Requesting initrd-fs.target/start/replace...1145second # [ 2.529176] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1146second # [ 2.530984] systemd-sysroot-fstab-check[127]: Requesting swap.target/start/replace...1147second # [ 2.534080] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1148second # [ 2.535263] systemd[1]: Finished Mountpoints Configured in the Real Root.1149second # [ 2.536383] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1150test # [ 3.394361] systemd[1]: Mounting /sysroot/nix/.ro-store...1151test # [ 3.398660] systemd[1]: Mounting /sysroot/nix/.rw-store...1152test # [ 3.399900] systemd[1]: Mounting /sysroot/run...1153test # [ 3.404665] systemd[1]: Mounting /sysroot/tmp/shared...1154second # [ 3.406841] systemd[1]: Mounting /sysroot/nix/.ro-store...1155test # [ 3.410159] systemd[1]: Mounting /sysroot/tmp/xchg...1156second # [ 3.410670] systemd[1]: Mounting /sysroot/nix/.rw-store...1157second # [ 3.412696] systemd[1]: Mounting /sysroot/run...1158second # [ 3.418260] systemd[1]: Mounting /sysroot/tmp/shared...1159second # [ 3.422157] systemd[1]: Mounting /sysroot/tmp/xchg...1160test # [ 3.594716] 9p: Installing v9fs 9p2000 file system support1161test # [ 3.430687] systemd[1]: Mounted /sysroot/nix/.rw-store.1162test # [ 3.438189] systemd[1]: Mounted /sysroot/run.1163second # [ 3.606195] 9p: Installing v9fs 9p2000 file system support1164test # [ 3.440854] systemd[1]: Mounted /sysroot/nix/.ro-store.1165test # [ 3.443145] systemd[1]: Mounted /sysroot/tmp/shared.1166test # [ 3.444147] systemd[1]: Mounted /sysroot/tmp/xchg.1167second # [ 3.445695] systemd[1]: Mounted /sysroot/nix/.rw-store.1168test # [ 3.448380] systemd[1]: Starting rw-sysroot-nix-store.service...1169second # [ 3.454864] systemd[1]: Mounted /sysroot/nix/.ro-store.1170second # [ 3.456871] systemd[1]: Mounted /sysroot/run.1171test # [ 3.456343] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1172second # [ 3.458100] systemd[1]: Mounted /sysroot/tmp/shared.1173second # [ 3.459396] systemd[1]: Mounted /sysroot/tmp/xchg.1174test # [ 3.459094] systemd[1]: Finished rw-sysroot-nix-store.service.1175test # [ 3.460704] systemd[1]: Mounting /sysroot/nix/store...1176second # [ 3.463527] systemd[1]: Starting rw-sysroot-nix-store.service...1177second # [ 3.472575] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1178second # [ 3.474584] systemd[1]: Finished rw-sysroot-nix-store.service.1179test # [ 3.477716] systemd[1]: Mounted /sysroot/nix/store.1180test # [ 3.479967] systemd[1]: Reached target Initrd File Systems.1181test # [ 3.481253] systemd[1]: Starting Find NixOS closure...1182test # [ 3.485389] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1183test # [ 3.500183] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1184test # [ 3.506798] systemd[1]: Finished Find NixOS closure.1185test # [ 3.508481] systemd[1]: Reached target Initrd Default Target.1186test # [ 3.510529] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1187test # [ 3.523409] systemd[1]: Stopped target Initrd Default Target.1188test # [ 3.524831] systemd[1]: Stopped target Basic System.1189test # [ 3.526093] systemd[1]: Stopped target Initrd Root Device.1190test # [ 3.528148] systemd[1]: Stopped target Path Units.1191test # [ 3.529238] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1192test # [ 3.530630] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1193test # [ 3.532043] systemd[1]: Stopped target Slice Units.1194test # [ 3.533396] systemd[1]: Stopped target Socket Units.1195test # [ 3.534742] systemd[1]: Stopped target System Initialization.1196test # [ 3.536295] systemd[1]: Stopped target Swaps.1197test # [ 3.537405] systemd[1]: Stopped target Timer Units.1198test # [ 3.538988] systemd[1]: dbus.socket: Deactivated successfully.1199test # [ 3.540142] systemd[1]: Closed D-Bus System Message Bus Socket.1200test # [ 3.541480] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1201test # [ 3.543153] systemd[1]: Stopped Find NixOS closure.1202test # [ 3.545136] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1203test # [ 3.547158] systemd[1]: Starting rw-sysroot-nix-store.service...1204test # [ 3.548272] systemd[1]: systemd-sysctl.service: Deactivated successfully.1205test # [ 3.549509] systemd[1]: Stopped Apply Kernel Variables.1206test # [ 3.550808] systemd[1]: systemd-modules-load.service: Deactivated successfully.1207test # [ 3.553132] systemd[1]: Stopped Load Kernel Modules.1208test # [ 3.554309] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1209test # [ 3.556257] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1210test # [ 3.557991] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1211test # [ 3.560137] systemd[1]: Stopped Create System Files and Directories.1212test # [ 3.561313] systemd[1]: Stopped target Local File Systems.1213test # [ 3.562924] systemd[1]: Stopped target Preparation for Local File Systems.1214test # [ 3.565591] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1215test # [ 3.566919] systemd[1]: Stopped Coldplug All udev Devices.1216test # [ 3.568487] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1217test # [ 3.569884] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1218test # [ 3.571707] systemd[1]: Stopped Virtual Console Setup.1219test # [ 3.578547] systemd[1]: initrd-cleanup.service: Deactivated successfully.1220test # [ 3.581152] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1221test # [ 3.584113] systemd[1]: systemd-udevd.service: Deactivated successfully.1222test # [ 3.586624] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1223test # [ 3.588542] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1224test # [ 3.591123] systemd[1]: Finished rw-sysroot-nix-store.service.1225test # [ 3.594079] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1226test # [ 3.595396] systemd[1]: Closed udev Control Socket.1227test # [ 3.597083] systemd[1]: Starting Cleanup udev Database...1228test # [ 3.598142] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1229test # [ 3.600165] systemd[1]: Stopped Create Static Device Nodes in /dev.1230test # [ 3.601331] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1231test # [ 3.602782] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1232test # [ 3.604463] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1233test # [ 3.605709] systemd[1]: Stopped Create List of Static Device Nodes.1234test # [ 3.615963] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1235test # [ 3.618331] systemd[1]: Finished Cleanup udev Database.1236test # [ 3.619594] systemd[1]: Reached target Switch Root.1237test # [ 3.621217] systemd[1]: Starting NixOS Activation...1238test # [ 3.695320] initrd-nixos-activation-start[176]: booting system configuration /nix/store/4chh5garxqihjk361khlwcj0hwv9s51v-nixos-system-test-test1239test # [ 3.724348] initrd-nixos-activation-start[176]: running activation script...1240test # [ 3.920982] initrd-nixos-activation-start[199]: setting up /etc...1241test # [ 4.039783] initrd-nixos-activation-start[199]: setting up age secrets...1242test # [ 4.170953] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1243test # [ 4.173190] systemd[1]: Finished NixOS Activation.1244test # [ 4.174720] systemd[1]: Starting Switch Root...1245test # [ 4.185179] systemd[1]: Switching root.1246test # [ 4.475799] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1247test # [ 4.546508] NET: Registered PF_VSOCK protocol family1248second # [ 4.405978] systemd[1]: Mounting /sysroot/nix/store...1249second # [ 4.423141] systemd[1]: Mounted /sysroot/nix/store.1250second # [ 4.424541] systemd[1]: Reached target Initrd File Systems.1251second # [ 4.426437] systemd[1]: Starting Find NixOS closure...1252second # [ 4.430136] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1253second # [ 4.443949] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1254second # [ 4.446501] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1255second # [ 4.452938] systemd[1]: Finished Find NixOS closure.1256second # [ 4.454364] systemd[1]: Reached target Initrd Default Target.1257second # [ 4.456130] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1258second # [ 4.467745] systemd[1]: Stopped target Initrd Default Target.1259second # [ 4.468992] systemd[1]: Stopped target Basic System.1260second # [ 4.471062] systemd[1]: Stopped target Initrd Root Device.1261second # [ 4.472036] systemd[1]: Stopped target Path Units.1262second # [ 4.472923] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1263second # [ 4.474315] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1264second # [ 4.475605] systemd[1]: Stopped target Slice Units.1265second # [ 4.476896] systemd[1]: Stopped target Socket Units.1266second # [ 4.478164] systemd[1]: Stopped target System Initialization.1267second # [ 4.479441] systemd[1]: Stopped target Swaps.1268second # [ 4.480650] systemd[1]: Stopped target Timer Units.1269second # [ 4.482106] systemd[1]: dbus.socket: Deactivated successfully.1270second # [ 4.483194] systemd[1]: Closed D-Bus System Message Bus Socket.1271second # [ 4.484499] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1272second # [ 4.486156] systemd[1]: Stopped Find NixOS closure.1273second # [ 4.487133] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1274second # [ 4.490278] systemd[1]: Starting rw-sysroot-nix-store.service...1275second # [ 4.492148] systemd[1]: systemd-sysctl.service: Deactivated successfully.1276second # [ 4.493313] systemd[1]: Stopped Apply Kernel Variables.1277second # [ 4.494283] systemd[1]: systemd-modules-load.service: Deactivated successfully.1278second # [ 4.495671] systemd[1]: Stopped Load Kernel Modules.1279second # [ 4.497264] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1280second # [ 4.498633] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1281second # [ 4.499975] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1282second # [ 4.501874] systemd[1]: Stopped Create System Files and Directories.1283second # [ 4.502989] systemd[1]: Stopped target Local File Systems.1284second # [ 4.506227] systemd[1]: Stopped target Preparation for Local File Systems.1285second # [ 4.507422] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1286second # [ 4.508642] systemd[1]: Stopped Coldplug All udev Devices.1287second # [ 4.509633] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1288second # [ 4.510860] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1289second # [ 4.515245] systemd[1]: Stopped Virtual Console Setup.1290second # [ 4.520135] systemd[1]: initrd-cleanup.service: Deactivated successfully.1291second # [ 4.522348] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1292second # [ 4.524659] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1293second # [ 4.526113] systemd[1]: Finished rw-sysroot-nix-store.service.1294second # [ 4.529534] systemd[1]: systemd-udevd.service: Deactivated successfully.1295second # [ 4.531279] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1296second # [ 4.533896] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1297second # [ 4.535922] systemd[1]: Closed udev Control Socket.1298second # [ 4.537082] systemd[1]: Starting Cleanup udev Database...1299second # [ 4.538175] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1300second # [ 4.540202] systemd[1]: Stopped Create Static Device Nodes in /dev.1301second # [ 4.541816] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1302second # [ 4.543214] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1303second # [ 4.545160] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1304second # [ 4.546363] systemd[1]: Stopped Create List of Static Device Nodes.1305second # [ 4.557226] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1306second # [ 4.559066] systemd[1]: Finished Cleanup udev Database.1307second # [ 4.560456] systemd[1]: Reached target Switch Root.1308second # [ 4.562093] systemd[1]: Starting NixOS Activation...1309second # [ 4.635781] initrd-nixos-activation-start[177]: booting system configuration /nix/store/sccznmhx0nrv0pzmp4igkxa4kircv506-nixos-system-second-test1310second # [ 4.665666] initrd-nixos-activation-start[177]: running activation script...1311test # [ 4.905830] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1312test # [ 4.910107] systemd[1]: Detected virtualization kvm.1313test # [ 4.910951] systemd[1]: Detected architecture x86-64.1314test # [ 4.911815] systemd[1]: Detected first boot.1315test # [ 4.913928] systemd[1]: Initializing machine ID from random generator.1316second # [ 4.868257] initrd-nixos-activation-start[200]: setting up /etc...1317second # [ 4.980454] initrd-nixos-activation-start[200]: setting up age secrets...1318test # [ 5.200954] systemd[1]: bpf-restrict-fs: LSM BPF program attached1319second # [ 5.080768] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1320second # [ 5.083199] systemd[1]: Finished NixOS Activation.1321second # [ 5.084707] systemd[1]: Starting Switch Root...1322second # [ 5.094587] systemd[1]: Switching root.1323test # [ 5.273136] systemd[1]: Applying preset policy.1324second # [ 5.388321] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1325second # [ 5.455024] NET: Registered PF_VSOCK protocol family1326test # [ 5.527558] systemd[1]: Populated /etc with preset unit settings.1327test # [ 5.779544] systemd[1]: initrd-switch-root.service: Deactivated successfully.1328test # [ 5.781170] systemd[1]: Stopped initrd-switch-root.service.1329test # [ 5.783582] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1330test # [ 5.785606] systemd[1]: Created slice Slice /system/getty.1331test # [ 5.786979] systemd[1]: Created slice User and Session Slice.1332test # [ 5.788005] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1333test # [ 5.789313] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1334test # [ 5.790521] systemd[1]: Expecting device /dev/hvc0...1335test # [ 5.791342] systemd[1]: Expecting device /dev/ttyS0...1336test # [ 5.792218] systemd[1]: Reached target Local Encrypted Volumes.1337test # [ 5.793169] systemd[1]: Stopped target initrd-fs.target.1338test # [ 5.794063] systemd[1]: Stopped target initrd-root-fs.target.1339test # [ 5.794995] systemd[1]: Stopped target initrd-switch-root.target.1340test # [ 5.795986] systemd[1]: Reached target Virtual Machines and Containers.1341test # [ 5.797040] systemd[1]: Reached target Path Units.1342test # [ 5.797846] systemd[1]: Reached target Remote File Systems.1343test # [ 5.798754] systemd[1]: Reached target Slice Units.1344test # [ 5.799582] systemd[1]: Reached target Swaps.1345test # [ 5.801672] systemd[1]: Listening on Query the User Interactively for a Password.1346test # [ 5.804210] systemd[1]: Listening on Process Core Dump Socket.1347test # [ 5.806139] systemd[1]: Listening on Credential Encryption/Decryption.1348test # [ 5.808093] systemd[1]: Listening on Factory Reset Management.1349test # [ 5.809135] systemd[1]: Listening on Hostname Service Socket.1350test # [ 5.811686] systemd[1]: Starting Journal Log Access Socket...1351test # [ 5.813173] systemd[1]: Listening on Journal Audit Socket.1352test # [ 5.815339] systemd[1]: Listening on Console Output Muting Service Socket.1353test # [ 5.816558] systemd[1]: Listening on Network Management Metrics Varlink Socket.1354test # [ 5.817930] systemd[1]: Listening on Network Management Varlink Socket.1355test # [ 5.819088] systemd[1]: Listening on Network Management Netlink Socket.1356test # [ 5.820263] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1357test # [ 5.821597] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1358second # [ 5.819774] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1359test # [ 5.823049] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1360second # [ 5.824013] systemd[1]: Detected virtualization kvm.1361second # [ 5.824864] systemd[1]: Detected architecture x86-64.1362second # [ 5.825734] systemd[1]: Detected first boot.1363second # [ 5.827600] systemd[1]: Initializing machine ID from random generator.1364test # [ 5.827989] systemd[1]: Listening on Disk Repartitioning Service Socket.1365test # [ 5.829170] systemd[1]: Listening on Resolve Monitor Varlink Socket.1366test # [ 5.830283] systemd[1]: Listening on Resolve Service Varlink Socket.1367test # [ 5.831394] systemd[1]: Listening on udev Control Socket.1368test # [ 5.832389] systemd[1]: Listening on udev Varlink Socket.1369test # [ 5.834681] systemd[1]: Mounting Huge Pages File System...1370test # [ 5.838508] systemd[1]: Mounting POSIX Message Queue File System...1371test # [ 5.842530] systemd[1]: Mounting Kernel Debug File System...1372test # [ 5.848629] systemd[1]: Mounting Kernel Trace File System...1373test # [ 5.853744] systemd[1]: Starting Create List of Static Device Nodes...1374test # [ 5.857545] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1375test # [ 5.874935] systemd[1]: Starting Load Kernel Module configfs...1376test # [ 5.877958] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1377test # [ 5.886115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1378test # [ 5.888016] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1379test # [ 5.891248] systemd[1]: Mounting FUSE Control File System...1380test # [ 5.892586] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671381test # [ 5.903338] systemd[1]: Starting Journal Service...1382second # [ 5.907185] systemd[1]: bpf-restrict-fs: LSM BPF program attached1383test # [ 5.911059] systemd[1]: Starting Load Kernel Modules...1384test # [ 5.923051] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1385test # [ 5.932983] systemd[1]: Starting Remount Root and Kernel File Systems...1386test # [ 5.942118] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1387test # [ 5.944633] systemd-journald[324]: Collecting audit messages is enabled.1388test # [ 5.956362] systemd[1]: Starting Coldplug All udev Devices...1389test # [ 5.965056] loop: module loaded1390test # [ 5.978538] systemd[1]: Listening on Journal Log Access Socket.1391second # [ 5.979203] systemd[1]: Applying preset policy.1392test # [ 5.815273] systemd[1]: Queued start job for default target Multi-User System.1393test # [ 5.984454] systemd[1]: Started Journal Service.1394test # [ 5.818588] systemd[1]: systemd-journald.service: Deactivated successfully.1395test # [ 5.821633] systemd-modules-load[325]: Module 'ctr' is built in1396test # [ 5.989824] EXT4-fs (vda): re-mounted 46050892-c6c6-4f38-bea6-753875e3de53.1397test # [ 5.826467] systemd-modules-load[325]: Inserted module 'loop'1398test # [ 5.834105] systemd[1]: Mounted Huge Pages File System.1399test # [ 5.836359] systemd[1]: Mounted POSIX Message Queue File System.1400test # [ 5.838795] systemd[1]: Mounted Kernel Debug File System.1401test # [ 5.841103] systemd[1]: Mounted Kernel Trace File System.1402test # [ 5.844187] systemd[1]: Finished Create List of Static Device Nodes.1403test # [ 5.845352] systemd[1]: modprobe@configfs.service: Deactivated successfully.1404test # [ 5.846774] systemd[1]: Finished Load Kernel Module configfs.1405test # [ 5.849191] systemd[1]: Mounted FUSE Control File System.1406test # [ 5.852163] systemd[1]: Finished Load Kernel Modules.1407test # [ 5.856180] systemd[1]: Finished Remount Root and Kernel File Systems.1408test # [ 5.870054] systemd[1]: Listening on Disk Image Download Service Socket.1409test # [ 5.872707] systemd[1]: Mounting Kernel Configuration File System...1410test # [ 5.879073] systemd[1]: Starting Firewall...1411test # [ 5.881203] systemd[1]: Starting Flush Journal to Persistent Storage...1412test # [ 5.882512] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1413test # [ 5.886326] systemd-oomd[327]: No swap; memory pressure usage will be degraded1414test # [ 5.901801] systemd[1]: Starting Load/Save OS Random Seed...1415test # [ 5.911399] systemd[1]: Starting Apply Kernel Variables...1416test # [ 5.926907] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1417test # [ 5.930294] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1418test # [ 5.931837] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1419test # [ 6.117875] systemd-journald[324]: Received client request to flush runtime journal.1420second # [ 6.254524] systemd[1]: Populated /etc with preset unit settings.1421test # [ 6.126613] systemd[1]: Mounted Kernel Configuration File System.1422test # [ 6.128586] systemd[1]: Finished Load/Save OS Random Seed.1423test # [ 6.131340] systemd[1]: Reached target First Boot Complete.1424test # [ 6.134512] systemd[1]: Finished Apply Kernel Variables.1425test # [ 6.138111] systemd[1]: Starting Network Name Resolution...1426test # [ 6.140249] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1427test # [ 6.142275] systemd[1]: Starting Create Static Device Nodes in /dev...1428test # [ 6.143608] systemd[1]: Finished Create Static Device Nodes in /dev.1429test # [ 6.146138] systemd[1]: Reached target Preparation for Local File Systems.1430test # [ 6.149537] systemd[1]: Starting Rule-based Manager for Device Events and Files...1431test # [ 6.150793] systemd[1]: Finished Flush Journal to Persistent Storage.1432test # [ 6.177204] systemd-resolved[353]: Positive Trust Anchors:1433test # [ 6.178682] systemd-resolved[353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1434test # [ 6.182227] systemd-resolved[353]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161435test # [ 6.184237] systemd-resolved[353]: 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 test1436test # [ 6.232530] systemd[1]: Finished Coldplug All udev Devices.1437test # [ 6.241784] systemd-udevd[363]: Using default interface naming scheme 'v261'.1438test # [ 6.275112] systemd-resolved[353]: Using system hostname 'test'.1439test # [ 6.281420] systemd[1]: Started Network Name Resolution.1440test # [ 6.342300] systemd[1]: Started Rule-based Manager for Device Events and Files.1441second # [ 6.521591] systemd[1]: initrd-switch-root.service: Deactivated successfully.1442second # [ 6.523248] systemd[1]: Stopped initrd-switch-root.service.1443second # [ 6.525709] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1444second # [ 6.527811] systemd[1]: Created slice Slice /system/getty.1445second # [ 6.529169] systemd[1]: Created slice User and Session Slice.1446second # [ 6.530209] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1447second # [ 6.531563] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1448second # [ 6.532821] systemd[1]: Expecting device /dev/hvc0...1449second # [ 6.533623] systemd[1]: Expecting device /dev/ttyS0...1450second # [ 6.534526] systemd[1]: Reached target Local Encrypted Volumes.1451second # [ 6.535506] systemd[1]: Stopped target initrd-fs.target.1452second # [ 6.536398] systemd[1]: Stopped target initrd-root-fs.target.1453second # [ 6.537370] systemd[1]: Stopped target initrd-switch-root.target.1454second # [ 6.538391] systemd[1]: Reached target Virtual Machines and Containers.1455second # [ 6.539469] systemd[1]: Reached target Path Units.1456second # [ 6.540316] systemd[1]: Reached target Remote File Systems.1457second # [ 6.541255] systemd[1]: Reached target Slice Units.1458second # [ 6.542118] systemd[1]: Reached target Swaps.1459second # [ 6.544218] systemd[1]: Listening on Query the User Interactively for a Password.1460second # [ 6.546772] systemd[1]: Listening on Process Core Dump Socket.1461second # [ 6.548752] systemd[1]: Listening on Credential Encryption/Decryption.1462second # [ 6.550809] systemd[1]: Listening on Factory Reset Management.1463second # [ 6.551873] systemd[1]: Listening on Hostname Service Socket.1464second # [ 6.554442] systemd[1]: Starting Journal Log Access Socket...1465second # [ 6.555954] systemd[1]: Listening on Journal Audit Socket.1466second # [ 6.558149] systemd[1]: Listening on Console Output Muting Service Socket.1467second # [ 6.559390] systemd[1]: Listening on Network Management Metrics Varlink Socket.1468second # [ 6.560793] systemd[1]: Listening on Network Management Varlink Socket.1469second # [ 6.561972] systemd[1]: Listening on Network Management Netlink Socket.1470second # [ 6.563174] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1471second # [ 6.564550] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1472second # [ 6.566077] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1473second # [ 6.571047] systemd[1]: Listening on Disk Repartitioning Service Socket.1474second # [ 6.572445] systemd[1]: Listening on Resolve Monitor Varlink Socket.1475second # [ 6.573698] systemd[1]: Listening on Resolve Service Varlink Socket.1476second # [ 6.574844] systemd[1]: Listening on udev Control Socket.1477second # [ 6.575896] systemd[1]: Listening on udev Varlink Socket.1478second # [ 6.578500] systemd[1]: Mounting Huge Pages File System...1479second # [ 6.582144] systemd[1]: Mounting POSIX Message Queue File System...1480second # [ 6.586909] systemd[1]: Mounting Kernel Debug File System...1481second # [ 6.592327] systemd[1]: Mounting Kernel Trace File System...1482second # [ 6.599794] systemd[1]: Starting Create List of Static Device Nodes...1483second # [ 6.601243] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1484second # [ 6.613511] systemd[1]: Starting Load Kernel Module configfs...1485second # [ 6.621855] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1486second # [ 6.626854] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1487second # [ 6.629911] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1488second # [ 6.638519] systemd[1]: Mounting FUSE Control File System...1489second # [ 6.642885] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671490second # [ 6.652114] systemd[1]: Starting Journal Service...1491test # [ 6.484360] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1492second # [ 6.657433] systemd[1]: Starting Load Kernel Modules...1493second # [ 6.673689] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1494second # [ 6.692617] systemd-journald[303]: Collecting audit messages is enabled.1495second # [ 6.694249] systemd[1]: Starting Remount Root and Kernel File Systems...1496second # [ 6.697343] loop: module loaded1497second # [ 6.698169] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1498second # [ 6.713116] systemd[1]: Starting Coldplug All udev Devices...1499second # [ 6.553597] systemd[1]: Queued start job for default target Multi-User System.1500second # [ 6.555359] systemd[1]: systemd-journald.service: Deactivated successfully.1501second # [ 6.558653] systemd-modules-load[304]: Module 'ctr' is built in1502second # [ 6.563432] systemd-modules-load[304]: Inserted module 'loop'1503test # [ 6.566572] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1504second # [ 6.736970] systemd[1]: Started Journal Service.1505second # [ 6.575159] systemd[1]: Listening on Journal Log Access Socket.1506second # [ 6.580119] systemd[1]: Mounted Huge Pages File System.1507second # [ 6.581176] systemd[1]: Mounted POSIX Message Queue File System.1508second # [ 6.583177] systemd[1]: Mounted Kernel Debug File System.1509second # [ 6.585527] systemd[1]: Mounted Kernel Trace File System.1510second # [ 6.586719] systemd[1]: Finished Create List of Static Device Nodes.1511second # [ 6.754388] EXT4-fs (vda): re-mounted 788cf2da-8294-4bb0-be60-7f851a0a86d9.1512second # [ 6.590409] systemd[1]: modprobe@configfs.service: Deactivated successfully.1513second # [ 6.593737] systemd[1]: Finished Load Kernel Module configfs.1514second # [ 6.597125] systemd[1]: Mounted FUSE Control File System.1515second # [ 6.600329] systemd[1]: Finished Load Kernel Modules.1516test # [ 6.603827] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1517second # [ 6.608086] systemd[1]: Finished Remount Root and Kernel File Systems.1518test # [ 6.616293] (udev-worker)[420]: Network interface NamePolicy= disabled on kernel command line.1519test # [ 6.618172] systemd[1]: Mounting /run/wrappers...1520second # [ 6.621073] systemd[1]: Listening on Disk Image Download Service Socket.1521test # [ 6.625662] (udev-worker)[417]: Network interface NamePolicy= disabled on kernel command line.1522second # [ 6.627173] systemd[1]: Mounting Kernel Configuration File System...1523second # [ 6.631219] systemd[1]: Starting Firewall...1524second # [ 6.637279] systemd[1]: Starting Flush Journal to Persistent Storage...1525second # [ 6.638472] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1526second # [ 6.641325] systemd-oomd[306]: No swap; memory pressure usage will be degraded1527test # [ 6.649455] systemd[1]: Mounted /run/wrappers.1528test # [ 6.650365] systemd[1]: Reached target Local File Systems.1529second # [ 6.653276] systemd[1]: Starting Load/Save OS Random Seed...1530test # [ 6.654090] systemd[1]: Listening on Boot Loader Control Service Socket.1531test # [ 6.658293] systemd[1]: Starting register-nix-paths.service...1532test # [ 6.663053] systemd[1]: Starting Create SUID/SGID Wrappers...1533test # [ 6.664113] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1534second # [ 6.670957] systemd[1]: Starting Apply Kernel Variables...1535test # [ 6.676081] systemd[1]: Starting Save Transient machine-id to Disk...1536test # [ 6.683486] systemd[1]: Starting Create System Files and Directories...1537second # [ 6.687906] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1538second # [ 6.690719] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1539second # [ 6.698825] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1540second # [ 6.881389] systemd-journald[303]: Received client request to flush runtime journal.1541test # [ 6.766713] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1542test # [ 6.773529] systemd[1]: Finished Save Transient machine-id to Disk.1543test # [ 6.807849] systemd[1]: Finished Firewall.1544test # [ 6.809547] systemd[1]: Reached target Preparation for Network.1545test # [ 6.812479] systemd[1]: Listening on Network Management Resolve Hook Socket.1546test # [ 6.822524] systemd[1]: Starting Network Management...1547test # [ 6.835967] systemd[1]: Finished Create System Files and Directories.1548test # [ 6.850532] systemd[1]: Starting Rebuild Journal Catalog...1549test # [ 6.857137] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1550second # [ 6.898412] systemd[1]: Mounted Kernel Configuration File System.1551second # [ 6.902419] systemd[1]: Finished Load/Save OS Random Seed.1552second # [ 6.905808] systemd[1]: Reached target First Boot Complete.1553second # [ 6.908265] systemd[1]: Finished Apply Kernel Variables.1554second # [ 6.910677] systemd[1]: Starting Network Name Resolution...1555second # [ 6.913864] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1556second # [ 6.915373] systemd[1]: Starting Create Static Device Nodes in /dev...1557second # [ 6.918301] systemd[1]: Finished Flush Journal to Persistent Storage.1558second # [ 6.924129] systemd[1]: Finished Create Static Device Nodes in /dev.1559second # [ 6.925321] systemd[1]: Reached target Preparation for Local File Systems.1560test # [ 6.925661] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1561second # [ 6.931761] systemd[1]: Starting Rule-based Manager for Device Events and Files...1562second # [ 6.938810] systemd-resolved[332]: Positive Trust Anchors:1563second # [ 6.941208] systemd-resolved[332]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1564second # [ 6.944506] systemd-resolved[332]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161565second # [ 6.948137] systemd-resolved[332]: 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 test1566test # [ 6.968399] systemd[1]: Finished Rebuild Journal Catalog.1567test # [ 6.979373] systemd[1]: Starting Update is Completed...1568second # [ 7.014548] systemd[1]: Finished Coldplug All udev Devices.1569second # [ 7.022424] systemd-udevd[348]: Using default interface naming scheme 'v261'.1570test # [ 7.031427] systemd[1]: Finished Update is Completed.1571second # [ 7.047700] systemd-resolved[332]: Using system hostname 'second'.1572second # [ 7.054188] systemd[1]: Started Network Name Resolution.1573second # [ 7.117239] systemd[1]: Started Rule-based Manager for Device Events and Files.1574test # [ 7.307151] cfg80211: Loading compiled-in X.509 certificates for regulatory database1575test # [ 7.313147] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31576test # [ 7.160392] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1577test # [ 7.329562] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1578test # [ 7.330569] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1579test # [ 7.167037] systemd[1]: Finished Create SUID/SGID Wrappers.1580test # [ 7.354790] mousedev: PS/2 mouse device common for all mice1581test # [ 7.356578] ACPI: button: Power Button [PWRF]1582test # [ 7.198721] systemd-networkd[492]: /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.1583test # [ 7.203352] systemd-networkd[492]: /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.1584test # [ 7.208232] systemd-networkd[492]: lo: Link UP1585test # [ 7.210100] systemd-networkd[492]: lo: Gained carrier1586test # [ 7.219407] systemd[1]: Started Network Management.1587test # [ 7.225689] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1588test # [ 7.229180] systemd-networkd[492]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1589test # [ 7.232633] systemd-networkd[492]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1590test # [ 7.238737] systemd-networkd[492]: eth1: Link UP1591test # [ 7.242731] systemd-networkd[492]: eth1: Gained carrier1592test # [ 7.243795] systemd-networkd[492]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1593second # [ 7.268429] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1594test # [ 7.427567] NET: Registered PF_PACKET protocol family1595test # [ 7.439597] rtc_cmos 00:05: RTC can wake from S41596test # [ 7.299335] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1597test # [ 7.477692] parport_pc 00:03: reported by Plug and Play ACPI1598test # [ 7.478688] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1599test # [ 7.483036] rtc_cmos 00:05: registered as rtc01600test # [ 7.483845] rtc_cmos 00:05: setting system clock to 2026-08-20T08:10:53 UTC (1787213453)1601test # [ 7.485363] systemd-journald[324]: Time jumped backwards, rotating.1602test # [ 7.491976] Floppy drive(s): fd0 is 2.88M AMI BIOS1603test # [ 7.515848] FDC 0 is a S82078B1604test # [ 7.353494] systemd-resolved[353]: Clock change detected. Flushing caches.1605second # [ 7.353954] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1606test # [ 7.525595] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1607second # [ 7.359726] systemd[1]: Mounting /run/wrappers...1608test # [ 7.376773] systemd[1]: Finished register-nix-paths.service.1609test # [ 7.378538] systemd[1]: Reached target System Initialization.1610test # [ 7.380329] systemd[1]: Started Discard unused filesystem blocks once a week.1611test # [ 7.381900] systemd[1]: Started Daily Cleanup of Temporary Directories.1612test # [ 7.384468] systemd[1]: Reached target Timer Units.1613test # [ 7.385692] systemd[1]: Listening on D-Bus System Message Bus Socket.1614test # [ 7.387574] systemd[1]: Listening on Nix Daemon Socket.1615second # [ 7.391240] systemd[1]: Mounted /run/wrappers.1616test # [ 7.390953] systemd[1]: Listening on Authorization Manager Agent Helper.1617test # [ 7.393101] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1618test # [ 7.394512] systemd[1]: Reached target Socket Units.1619second # [ 7.394922] systemd[1]: Reached target Local File Systems.1620second # [ 7.398843] systemd[1]: Listening on Boot Loader Control Service Socket.1621test # [ 7.399275] systemd[1]: Starting D-Bus System Message Bus...1622second # [ 7.403035] systemd[1]: Starting register-nix-paths.service...1623second # [ 7.406790] systemd[1]: Starting Create SUID/SGID Wrappers...1624second # [ 7.408469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1625second # [ 7.421274] systemd[1]: Starting Save Transient machine-id to Disk...1626test # [ 7.597646] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1627second # [ 7.435856] systemd[1]: Starting Create System Files and Directories...1628second # [ 7.442791] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1629second # [ 7.452348] (udev-worker)[401]: Network interface NamePolicy= disabled on kernel command line.1630second # [ 7.463443] (udev-worker)[397]: Network interface NamePolicy= disabled on kernel command line.1631test # [ 7.469039] dbus-broker-launch[561]: Looking up NSS user entry for 'systemd-timesync'...1632test # [ 7.472906] dbus-broker-launch[561]: NSS returned no entry for 'systemd-timesync'1633test # [ 7.474419] dbus-broker-launch[561]: Invalid user-name in /nix/store/k8mcybsk00yz5c71xrv2qs5ayxc4bp6w-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1634second # [ 7.497566] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1635test # [ 7.495205] dbus-broker-launch[561]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1636second # [ 7.501439] systemd[1]: Finished Save Transient machine-id to Disk.1637test # [ 7.499181] dbus-broker-launch[561]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1638test # [ 7.504576] dbus-broker-launch[561]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nasw2v3yzqxbcz7633zjygg42hdv0i2f-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1639test # [ 7.507851] dbus-broker-launch[561]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1640test # [ 7.511758] systemd[1]: Started D-Bus System Message Bus.1641test # [ 7.533969] dbus-broker-launch[561]: Ready1642second # [ 7.540359] systemd[1]: Finished Firewall.1643second # [ 7.541356] systemd[1]: Reached target Preparation for Network.1644test # [ 7.543410] systemd[1]: Reached target Basic System.1645second # [ 7.544428] systemd[1]: Listening on Network Management Resolve Hook Socket.1646test # [ 7.546449] systemd[1]: Starting Network Manager Script Dispatcher Service...1647second # [ 7.553417] systemd[1]: Starting Network Management...1648test # [ 7.553226] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1649test # [ 7.562218] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1650test # [ 7.615444] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01651test # [ 7.566543] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1652second # [ 7.580153] systemd[1]: Finished Create System Files and Directories.1653test # [ 7.584394] systemd[1]: Starting Network Manager...1654test # [ 7.615493] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1655test # [ 7.627265] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41656second # [ 7.591671] systemd[1]: Starting Rebuild Journal Catalog...1657second # [ 7.603255] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1658test # [ 7.606235] systemd[1]: Started backdoor.service.1659test # [ 7.612749] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[566]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1660test # [ 7.619766] systemd[1]: Starting Import lastlog data into lastlog2 database...1661test # [ 7.645730] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1662test # [ 7.656324] 3n8ky6qdcbw1k7vj7jk5r1y02d17nk2g-wifi-secrets[567]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1663test # [ 7.665849] f7i4m9qbq8xk00yg42rzh0mg47dda2zy-wifi-secrets[568]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1664test # [ 7.678447] systemd[1]: Starting Post-Boot Actions...1665second # [ 7.682916] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1666test # [ 7.690838] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61667test # [ 7.691178] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51668second # [ 7.709668] systemd[1]: Finished Rebuild Journal Catalog.1669test # [ 7.709497] systemd[1]: Started Reset console on configuration changes.1670second # [ 7.718987] systemd[1]: Starting Update is Completed...1671test # connecting to host...1672test # [ 7.745900] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1673test # [ 7.755807] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1674test # [ 7.756995] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1675test # [ 7.760276] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1676test # [ 7.769754] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1677second # [ 7.774467] systemd[1]: Finished Update is Completed.1678test # [ 7.778106] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1679test: Guest shell says: b'Spawning backdoor root shell...\n'1680test: connected to guest root shell1681test: (connecting took 8.39 seconds)1682test: (finished: waiting for the VM to finish booting, in 8.39 seconds)1683test # [ 7.801715] systemd[1]: Finished Post-Boot Actions.1684test # [ 7.813216] systemd[1]: Started Name Service Cache Daemon (nsncd).1685test # [ 7.816677] nsncd[577]: Aug 20 08:10:53.991 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1686test # [ 7.835293] systemd[1]: Started Network Manager Script Dispatcher Service.1687test # [ 7.730461] Console: switching to colour dummy device 80x251688test # [ 8.006638] [drm] Found bochs VGA, ID 0xb0c5.1689test # [ 8.006640] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1690test # [ 7.853929] systemd[1]: Finished Import lastlog data into lastlog2 database.1691test # [ 8.035354] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1692second # [ 8.043567] cfg80211: Loading compiled-in X.509 certificates for regulatory database1693test # [ 7.882034] systemd[1]: Reached target Host and Network Name Lookups.1694test # [ 7.885275] systemd[1]: Reached target User and Group Name Lookups.1695test # [ 7.886390] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1696test # [ 8.060133] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01697test # [ 7.895328] systemd[1]: Starting User Login Management...1698second # [ 8.062877] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1699second # [ 8.063889] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1700test # [ 7.900203] systemd[1]: Starting Virtual Console Setup...1701test # [ 7.922603] systemd[1]: Starting Hostname Service...1702second # [ 7.931306] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1703second # [ 7.935605] systemd[1]: Finished Create SUID/SGID Wrappers.1704second # [ 7.940741] systemd-networkd[469]: /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.1705second # [ 7.945577] systemd-networkd[469]: /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.1706second # [ 7.950842] systemd-networkd[469]: lo: Link UP1707second # [ 7.952286] systemd-networkd[469]: lo: Gained carrier1708second # [ 7.965177] systemd[1]: Started Network Management.1709second # [ 7.969725] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1710second # [ 7.971666] systemd-networkd[469]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1711second # [ 7.974962] systemd-networkd[469]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1712second # [ 7.983810] systemd-networkd[469]: eth1: Link UP1713second # [ 7.984967] systemd-networkd[469]: eth1: Gained carrier1714second # [ 7.986225] systemd-networkd[469]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1715second # [ 8.169961] NET: Registered PF_PACKET protocol family1716test # [ 8.016505] systemd-logind[623]: Watching system buttons on /dev/input/event2 (Power Button)1717second # [ 8.195787] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31718second # [ 8.032523] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1719second # [ 8.222733] mousedev: PS/2 mouse device common for all mice1720second # [ 8.244983] ACPI: button: Power Button [PWRF]1721second # [ 8.256393] rtc_cmos 00:05: RTC can wake from S41722second # [ 8.277379] Floppy drive(s): fd0 is 2.88M AMI BIOS1723test # [ 8.190517] ppdev: user-space parallel port driver1724test # [ 8.257604] Console: switching to colour frame buffer device 160x501725second # [ 8.116805] systemd[1]: Finished register-nix-paths.service.1726second # [ 8.119202] systemd[1]: Reached target System Initialization.1727second # [ 8.121160] systemd[1]: Started Discard unused filesystem blocks once a week.1728second # [ 8.123571] systemd[1]: Started Daily Cleanup of Temporary Directories.1729second # [ 8.125978] systemd[1]: Reached target Timer Units.1730second # [ 8.127369] systemd[1]: Listening on D-Bus System Message Bus Socket.1731second # [ 8.129140] systemd[1]: Listening on Nix Daemon Socket.1732second # [ 8.299062] parport_pc 00:03: reported by Plug and Play ACPI1733second # [ 8.135124] systemd[1]: Listening on Authorization Manager Agent Helper.1734second # [ 8.136311] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1735second # [ 8.137729] systemd[1]: Reached target Socket Units.1736second # [ 8.141073] systemd[1]: Starting D-Bus System Message Bus...1737test # [ 8.312246] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1738test # [ 8.018726] systemd-logind[623]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1739test # [ 8.148431] systemd[1]: Started Hostname Service.1740test # [ 8.149454] systemd-networkd[492]: eth0: Link UP1741test # [ 8.153761] systemd-networkd[492]: eth0: Gained carrier1742test # [ 8.159701] systemd-logind[623]: New seat seat0.1743second # [ 8.327752] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1744test # [ 8.160577] systemd-logind[623]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1745test # [ 8.161959] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1746test # [ 8.164649] systemd[1]: Stopped Virtual Console Setup.1747second # [ 8.335894] FDC 0 is a S82078B1748test # [ 8.170442] systemd[1]: Started User Login Management.1749test # [ 8.173156] systemd[1]: Started Network Manager.1750test # [ 8.176336] systemd[1]: Reached target Network.1751test # [ 8.182231] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1752test # [ 8.188437] systemd[1]: Starting linger-users.service...1753test # [ 8.204152] systemd[1]: Starting Permit User Sessions...1754second # [ 8.206280] dbus-broker-launch[539]: Looking up NSS user entry for 'systemd-timesync'...1755second # [ 8.210105] dbus-broker-launch[539]: NSS returned no entry for 'systemd-timesync'1756second # [ 8.211738] dbus-broker-launch[539]: Invalid user-name in /nix/store/k8mcybsk00yz5c71xrv2qs5ayxc4bp6w-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1757second # [ 8.383125] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1758test # [ 8.225598] systemd[1]: Starting Virtual Console Setup...1759second # [ 8.393513] rtc_cmos 00:05: registered as rtc01760second # [ 8.397552] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01761second # [ 8.399123] rtc_cmos 00:05: setting system clock to 2026-08-20T08:10:54 UTC (1787213454)1762second # [ 8.401001] systemd-journald[303]: Time jumped backwards, rotating.1763second # [ 8.260804] systemd-resolved[332]: Clock change detected. Flushing caches.1764second # [ 8.268278] dbus-broker-launch[539]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1765second # [ 8.275948] dbus-broker-launch[539]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1766second # [ 8.280524] dbus-broker-launch[539]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nasw2v3yzqxbcz7633zjygg42hdv0i2f-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1767second # [ 8.289274] dbus-broker-launch[539]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1768second # [ 8.293380] systemd[1]: Started D-Bus System Message Bus.1769second # [ 8.295738] dbus-broker-launch[539]: Ready1770second # [ 8.304078] systemd[1]: Reached target Basic System.1771second # [ 8.306173] systemd[1]: Starting Network Manager Script Dispatcher Service...1772second # [ 8.309185] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1773second # [ 8.318058] systemd[1]: Starting Network Manager...1774second # [ 8.332671] systemd[1]: Started backdoor.service.1775test # [ 8.338920] systemd[1]: linger-users.service: Deactivated successfully.1776test # [ 8.342183] systemd[1]: Finished linger-users.service.1777second # [ 8.347663] systemd[1]: Starting Import lastlog data into lastlog2 database...1778test # [ 8.351405] systemd[1]: Finished Permit User Sessions.1779second # [ 8.369513] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1780second # [ 8.375686] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[544]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1781test # [ 8.550849] kvm_amd: TSC scaling supported1782test # [ 8.551997] kvm_amd: Nested Virtualization enabled1783test # [ 8.552587] kvm_amd: Nested Paging enabled1784test # [ 8.553643] kvm_amd: LBR virtualization supported1785test # [ 8.556222] kvm_amd: Virtual GIF supported1786test # [ 8.556717] kvm_amd: Virtual NMI enabled1787second # [ 8.397481] systemd[1]: Starting Post-Boot Actions...1788test # [ 8.410479] NetworkManager[569]: <warn> [1787213454.5928] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1789second # [ 8.427542] systemd[1]: Started Reset console on configuration changes.1790test # [ 8.431630] systemd[1]: Started Getty on tty1.1791second # connecting to host...1792test # [ 8.436752] systemd[1]: Reached target Login Prompts.1793test # [ 8.442285] systemd-resolved[353]: eth0: Bus client set default route setting: yes1794second # [ 8.431121] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41795test # [ 8.444642] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1796second # [ 8.432996] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1797test # [ 8.451448] systemd-resolved[353]: eth0: Bus client set DNS server list to: 10.0.2.31798test # [ 8.452828] systemd[1]: Stopped Virtual Console Setup.1799test # [ 8.461666] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1800test # [ 8.467076] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1801test # [ 8.638476] EDAC MC: Ver: 3.0.01802second # [ 8.453401] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1803test # [ 8.478264] systemd[1]: Reached target Multi-User System.1804second # [ 8.610568] Console: switching to colour dummy device 80x251805test # [ 8.485389] systemd[1]: Starting Virtual Console Setup...1806second # [ 8.507569] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1807second # [ 8.512903] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1808second # [ 8.667331] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61809second # [ 8.667616] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51810second # [ 8.539367] systemd[1]: Finished Post-Boot Actions.1811second # [ 8.552405] systemd[1]: Started Name Service Cache Daemon (nsncd).1812second # [ 8.554921] nsncd[551]: Aug 20 08:10:54.816 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1813second # [ 8.559336] systemd[1]: Started Network Manager Script Dispatcher Service.1814second # [ 8.564263] systemd[1]: Reached target Host and Network Name Lookups.1815second # [ 8.565405] systemd[1]: Reached target User and Group Name Lookups.1816second # [ 8.576951] systemd[1]: Starting User Login Management...1817second # [ 8.585815] systemd[1]: Finished Import lastlog data into lastlog2 database.1818second # [ 8.760807] [drm] Found bochs VGA, ID 0xb0c5.1819second # [ 8.760809] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1820second # [ 8.764200] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1821second # [ 8.765072] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01822second # [ 8.600996] systemd[1]: Starting Hostname Service...1823second # [ 8.643373] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1824test # [ 8.648759] systemd-vconsole-setup[673]: Configuration of first virtual console was skipped, ignoring remaining ones.1825test # [ 8.653284] systemd[1]: Finished Virtual Console Setup.1826test # [ 8.657462] systemd[1]: Startup finished in 694ms (kernel) + 3.654s (initrd) + 4.307s (userspace) = 8.657s.1827second # [ 8.683427] systemd-logind[585]: New seat seat0.1828second # [ 8.685716] systemd[1]: Started User Login Management.1829second # [ 8.691131] systemd[1]: Starting linger-users.service...1830second # [ 8.714186] systemd[1]: Started Hostname Service.1831second # [ 8.730070] systemd[1]: Starting Virtual Console Setup...1832second # [ 8.731085] systemd[1]: linger-users.service: Deactivated successfully.1833second # [ 8.734364] systemd[1]: Finished linger-users.service.1834second # [ 8.960575] Console: switching to colour frame buffer device 160x501835second # [ 9.028581] ppdev: user-space parallel port driver1836second # [ 9.071306] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1837second # [ 8.770771] systemd-logind[585]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1838test # [ 8.907034] systemd-networkd[492]: eth1: Gained IPv6LL1839second # [ 8.907683] systemd-logind[585]: Watching system buttons on /dev/input/event2 (Power Button)1840second # [ 8.909224] systemd-networkd[469]: eth0: Link UP1841second # [ 8.911507] systemd-networkd[469]: eth0: Gained carrier1842test: (finished: waiting for unit NetworkManager.service, in 9.52 seconds)1843test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1844second # [ 8.918828] systemd[1]: Started Network Manager.1845second # [ 8.920716] systemd[1]: Reached target Network.1846second # [ 8.923056] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1847second # [ 8.925658] systemd[1]: Starting Permit User Sessions...1848second # [ 8.928420] systemd[1]: Finished Permit User Sessions.1849test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.02 seconds)1850test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1851test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1852test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1853test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1854(finished: run the VM test script, in 9.65 seconds)1855second # [ 8.969283] systemd[1]: Started Getty on tty1.1856second # [ 8.971734] systemd[1]: Reached target Login Prompts.1857second # [ 9.037383] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1858second # [ 9.040435] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1859second # [ 9.053115] systemd[1]: Reached target Multi-User System.1860second # [ 9.062646] systemd-logind[585]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1861second # [ 9.065981] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1862second # [ 9.067769] systemd[1]: Stopped Virtual Console Setup.1863test script finished in 9.76s1864cleanup1865kill QemuMachine (pid 47)1866second # [ 9.078357] systemd[1]: Starting Virtual Console Setup...1867second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1868kill QemuMachine (pid 48)1869test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1870(finished: cleanup, in 0.22 seconds)