vm-test-run-wifi
checks.x86_64-linux.wifi
· build #93
· 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 vm13test # Disk image does not exist, creating the virtualisation disk image...14test # Formatting '/build/vm-state-test/tmp.irCVjtAGf1', fmt=raw size=107374182415second # Disk image does not exist, creating the virtualisation disk image...16test: QEMU running (pid 48)17second: QEMU running (pid 47)18second # Formatting '/build/vm-state-second/tmp.PtXBWUWewg', fmt=raw size=107374182419test # mke2fs 1.47.4 (6-Mar-2025)20second # mke2fs 1.47.4 (6-Mar-2025)21test # Discarding device blocks: 0/262144 done22(finished: start all VMs, in 0.09 seconds)23test # Creating filesystem with 262144 4k blocks and 65536 inodes24test: waiting for unit NetworkManager.service25test # Filesystem UUID: 72290853-c859-466b-acff-efac921b820526test: waiting for the VM to finish booting27test # Superblock backups stored on blocks:28second # Discarding device blocks: 0/262144 done29test # 32768, 98304, 163840, 22937630second # Creating filesystem with 262144 4k blocks and 65536 inodes31test # 32second # Filesystem UUID: d922f15c-7655-4a7a-9e9f-f48eb024ea3f33test # Allocating group tables: 0/8 done34second # Superblock backups stored on blocks:35test # Writing inode tables: 0/8 done36second # 32768, 98304, 163840, 22937637test # Creating journal (8192 blocks): done38test # Writing superblocks and filesystem accounting information: 0/8 done39second # 40test # 41second # Allocating group tables: 0/8 done42test # Virtualisation disk image created.43second # Writing inode tables: 0/8 done44second # Creating journal (8192 blocks): done45second # Writing superblocks and filesystem accounting information: 0/8 done46second # 47second # Virtualisation disk image created.48second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50second # 51second # 52test # 53test # 54second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0055test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0056second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...57second # 58second # 59second # 60second # 61test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...62test # 63test # 64test # 65test # 66second # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0067test # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0068second # Press Ctrl-B to configure iPXE (PCI 00:08.0)...69second # 70second # 71test # Press Ctrl-B to configure iPXE (PCI 00:08.0)...72test # 73test # 74second # Booting from ROM...75test # Booting from ROM...76second # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 202677test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 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/v66fwmypp297w0v1lrvy2h4swlmxwmyy-nixos-system-second-test/init regInfo=/nix/store/i7r6qb6mcvw0gjfknc2pjvcf9069fnas-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] reserved82second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved83test # [ 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/gnn3zrhfi1qq3vl059j7k4hrbbw664hr-nixos-system-test-test/init regInfo=/nix/store/g2h4xz1dzi5yghqzb97ljmy383r5x9sy-closure-info/registration console=ttyS0,115200n8 console=tty084test # [ 0.000000] BIOS-provided physical RAM map:85second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable86test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable87second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved88test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved89second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved90test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved91second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved92test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable93second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved94test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved95second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved96test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved97second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved98second # [ 0.000000] NX (Execute Disable) protection: active99test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved100second # [ 0.000000] APIC: Static calls initialized101second # [ 0.000000] SMBIOS 2.8 present.102test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved103test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved104second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014105test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved106second # [ 0.000000] DMI: Memory slots populated: 1/1107second # [ 0.000000] Hypervisor detected: KVM108test # [ 0.000000] NX (Execute Disable) protection: active109test # [ 0.000000] APIC: Static calls initialized110second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000111test # [ 0.000000] SMBIOS 2.8 present.112second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00113second # [ 0.000000] kvm-clock: using sched offset of 400492936 cycles114test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014115test # [ 0.000000] DMI: Memory slots populated: 1/1116test # [ 0.000000] Hypervisor detected: KVM117second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns118second # [ 0.000005] tsc: Detected 4192.100 MHz processor119test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000120second # [ 0.000587] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000121test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00122test # [ 0.000000] kvm-clock: using sched offset of 406280080 cycles123second # [ 0.000614] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs124second # [ 0.000617] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT125test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns126test # [ 0.000006] tsc: Detected 4192.100 MHz processor127second # [ 0.002232] found SMP MP-table at [mem 0x000f5450-0x000f545f]128second # [ 0.002245] Using GB pages for direct mapping129test # [ 0.000583] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000130second # [ 0.002323] RAMDISK: [mem 0x3e369000-0x3ffcffff]131test # [ 0.000611] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs132second # [ 0.002328] ACPI: Early table checksum verification disabled133test # [ 0.000613] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT134second # [ 0.002332] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )135test # [ 0.002244] found SMP MP-table at [mem 0x000f5450-0x000f545f]136second # [ 0.002335] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)137test # [ 0.002257] Using GB pages for direct mapping138test # [ 0.002331] RAMDISK: [mem 0x3e368000-0x3ffcffff]139second # [ 0.002339] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)140test # [ 0.002336] ACPI: Early table checksum verification disabled141second # [ 0.002345] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)142test # [ 0.002339] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )143second # [ 0.002347] ACPI: FACS 0x000000003FFE0000 000040144test # [ 0.002342] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)145second # [ 0.002348] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)146test # [ 0.002346] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)147second # [ 0.002349] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)148test # [ 0.002352] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)149test # [ 0.002354] ACPI: FACS 0x000000003FFE0000 000040150second # [ 0.002351] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)151test # [ 0.002355] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)152second # [ 0.002352] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)153second # [ 0.002353] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]154test # [ 0.002356] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)155second # [ 0.002354] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]156test # [ 0.002357] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)157second # [ 0.002354] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]158test # [ 0.002358] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)159second # [ 0.002354] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]160test # [ 0.002359] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]161second # [ 0.002355] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]162test # [ 0.002360] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]163second # [ 0.002355] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]164test # [ 0.002360] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]165second # [ 0.002355] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]166test # [ 0.002361] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]167second # [ 0.002700] No NUMA configuration found168second # [ 0.002702] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]169test # [ 0.002361] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]170second # [ 0.002704] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]171test # [ 0.002361] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]172second # [ 0.002774] Zone ranges:173test # [ 0.002362] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]174second # [ 0.002775] DMA [mem 0x0000000000001000-0x0000000000ffffff]175test # [ 0.002700] No NUMA configuration found176second # [ 0.002776] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]177second # [ 0.002777] Normal empty178test # [ 0.002701] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]179second # [ 0.002778] Device empty180test # [ 0.002704] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]181second # [ 0.002778] Movable zone start for each node182test # [ 0.002769] Zone ranges:183second # [ 0.002779] Early memory node ranges184test # [ 0.002770] DMA [mem 0x0000000000001000-0x0000000000ffffff]185second # [ 0.002779] node 0: [mem 0x0000000000001000-0x000000000009efff]186test # [ 0.002771] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]187second # [ 0.002780] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]188test # [ 0.002772] Normal empty189test # [ 0.002773] Device empty190second # [ 0.002781] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]191test # [ 0.002773] Movable zone start for each node192test # [ 0.002774] Early memory node ranges193second # [ 0.002796] On node 0, zone DMA: 1 pages in unavailable ranges194test # [ 0.002774] node 0: [mem 0x0000000000001000-0x000000000009efff]195second # [ 0.002986] On node 0, zone DMA: 97 pages in unavailable ranges196test # [ 0.002775] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]197second # [ 0.015883] On node 0, zone DMA32: 40 pages in unavailable ranges198second # [ 0.016658] ACPI: PM-Timer IO Port: 0x608199test # [ 0.002776] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]200second # [ 0.016670] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])201test # [ 0.002791] On node 0, zone DMA: 1 pages in unavailable ranges202second # [ 0.016692] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23203test # [ 0.002990] On node 0, zone DMA: 97 pages in unavailable ranges204second # [ 0.016694] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)205test # [ 0.015777] On node 0, zone DMA32: 40 pages in unavailable ranges206test # [ 0.016549] ACPI: PM-Timer IO Port: 0x608207second # [ 0.016696] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)208test # [ 0.016561] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])209second # [ 0.016696] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)210test # [ 0.016581] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23211second # [ 0.016697] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)212test # [ 0.016583] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)213second # [ 0.016698] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)214test # [ 0.016585] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)215second # [ 0.016699] ACPI: Using ACPI (MADT) for SMP configuration information216test # [ 0.016585] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)217second # [ 0.016700] ACPI: HPET id: 0x8086a201 base: 0xfed00000218second # [ 0.016705] TSC deadline timer available219test # [ 0.016586] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)220second # [ 0.016708] CPU topo: Max. logical packages: 1221test # [ 0.016587] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)222second # [ 0.016708] CPU topo: Max. logical dies: 1223second # [ 0.016708] CPU topo: Max. dies per package: 1224test # [ 0.016589] ACPI: Using ACPI (MADT) for SMP configuration information225second # [ 0.016711] CPU topo: Max. threads per core: 1226test # [ 0.016589] ACPI: HPET id: 0x8086a201 base: 0xfed00000227test # [ 0.016594] TSC deadline timer available228second # [ 0.016712] CPU topo: Num. cores per package: 1229test # [ 0.016598] CPU topo: Max. logical packages: 1230second # [ 0.016712] CPU topo: Num. threads per package: 1231test # [ 0.016598] CPU topo: Max. logical dies: 1232second # [ 0.016712] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs233test # [ 0.016598] CPU topo: Max. dies per package: 1234second # [ 0.016728] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()235test # [ 0.016601] CPU topo: Max. threads per core: 1236test # [ 0.016602] CPU topo: Num. cores per package: 1237second # [ 0.016758] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]238test # [ 0.016602] CPU topo: Num. threads per package: 1239second # [ 0.016759] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]240test # [ 0.016602] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs241second # [ 0.016761] [mem 0x40000000-0xafffffff] available for PCI devices242test # [ 0.016619] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()243second # [ 0.016762] Booting paravirtualized kernel on KVM244test # [ 0.016649] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]245second # [ 0.016765] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns246test # [ 0.016650] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]247test # [ 0.016651] [mem 0x40000000-0xafffffff] available for PCI devices248second # [ 0.019983] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1249test # [ 0.016652] Booting paravirtualized kernel on KVM250second # [ 0.021734] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152251second # [ 0.021770] kvm-guest: PV spinlocks disabled, single CPU252test # [ 0.016655] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns253test # [ 0.019894] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1254test # [ 0.021521] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152255test # [ 0.021553] kvm-guest: PV spinlocks disabled, single CPU256second # [ 0.021772] 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/v66fwmypp297w0v1lrvy2h4swlmxwmyy-nixos-system-second-test/init regInfo=/nix/store/i7r6qb6mcvw0gjfknc2pjvcf9069fnas-closure-info/registration console=ttyS0,115200n8 console=tty0257second # [ 0.021843] Unknown kernel command line parameters "regInfo=/nix/store/i7r6qb6mcvw0gjfknc2pjvcf9069fnas-closure-info/registration", will be passed to user space.258second # [ 0.022033] random: crng init done259test # [ 0.021555] 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/gnn3zrhfi1qq3vl059j7k4hrbbw664hr-nixos-system-test-test/init regInfo=/nix/store/g2h4xz1dzi5yghqzb97ljmy383r5x9sy-closure-info/registration console=ttyS0,115200n8 console=tty0260second # [ 0.022034] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes261second # [ 0.022810] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)262test # [ 0.021624] Unknown kernel command line parameters "regInfo=/nix/store/g2h4xz1dzi5yghqzb97ljmy383r5x9sy-closure-info/registration", will be passed to user space.263test # [ 0.021815] random: crng init done264second # [ 0.022830] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)265second # [ 0.022859] Fallback order for Node 0: 0266test # [ 0.021815] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes267second # [ 0.022861] Built 1 zonelists, mobility grouping on. Total pages: 262006268second # [ 0.022862] Policy zone: DMA32269test # [ 0.022592] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)270second # [ 0.024634] mem auto-init: stack:all(zero), heap alloc:on, heap free:off271test # [ 0.022605] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)272test # [ 0.022633] Fallback order for Node 0: 0273second # [ 0.026990] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1274second # [ 0.028617] allocated 2097152 bytes of page_ext275test # [ 0.022636] Built 1 zonelists, mobility grouping on. Total pages: 262006276test # [ 0.022636] Policy zone: DMA32277second # [ 0.037966] ftrace: allocating 48733 entries in 192 pages278test # [ 0.024411] mem auto-init: stack:all(zero), heap alloc:on, heap free:off279second # [ 0.037970] ftrace: allocated 192 pages with 2 groups280second # [ 0.038695] Dynamic Preempt: lazy281test # [ 0.026680] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1282second # [ 0.038831] rcu: Preemptible hierarchical RCU implementation.283test # [ 0.028460] allocated 2097152 bytes of page_ext284second # [ 0.038832] rcu: RCU event tracing is enabled.285test # [ 0.037282] ftrace: allocating 48733 entries in 192 pages286second # [ 0.038832] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.287test # [ 0.037284] ftrace: allocated 192 pages with 2 groups288test # [ 0.037973] Dynamic Preempt: lazy289second # [ 0.038833] Trampoline variant of Tasks RCU enabled.290test # [ 0.038066] rcu: Preemptible hierarchical RCU implementation.291second # [ 0.038834] Rude variant of Tasks RCU enabled.292test # [ 0.038067] rcu: RCU event tracing is enabled.293second # [ 0.038834] Tracing variant of Tasks RCU enabled.294test # [ 0.038067] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.295second # [ 0.038835] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.296test # [ 0.038068] Trampoline variant of Tasks RCU enabled.297second # [ 0.038836] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1298test # [ 0.038068] Rude variant of Tasks RCU enabled.299test # [ 0.038069] Tracing variant of Tasks RCU enabled.300second # [ 0.038856] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.301test # [ 0.038069] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.302second # [ 0.038857] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.303test # [ 0.038070] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1304second # [ 0.038858] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.305test # [ 0.038110] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.306second # [ 0.042075] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16307test # [ 0.038112] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.308second # [ 0.042492] rcu: srcu_init: Setting srcu_struct sizes based on contention.309test # [ 0.038112] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.310second # [ 0.042501] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns311test # [ 0.041278] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16312second # [ 0.042656] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)313test # [ 0.041528] rcu: srcu_init: Setting srcu_struct sizes based on contention.314second # [ 0.047762] Console: colour VGA+ 80x25315second # [ 0.047765] printk: legacy console [tty0] enabled316test # [ 0.041532] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns317second # [ 0.077548] printk: legacy console [ttyS0] enabled318second # [ 0.209665] ACPI: Core revision 20250807319test # [ 0.041690] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)320test # [ 0.046761] Console: colour VGA+ 80x25321test # [ 0.046764] printk: legacy console [tty0] enabled322second # [ 0.210759] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns323test # [ 0.076498] printk: legacy console [ttyS0] enabled324test # [ 0.207391] ACPI: Core revision 20250807325second # [ 0.212688] APIC: Switch to symmetric I/O mode setup326second # [ 0.213875] x2apic enabled327test # [ 0.208432] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns328second # [ 0.214708] APIC: Switched APIC routing to: physical x2apic329test # [ 0.210329] APIC: Switch to symmetric I/O mode setup330test # [ 0.211504] x2apic enabled331second # [ 0.216693] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1332test # [ 0.212325] APIC: Switched APIC routing to: physical x2apic333second # [ 0.217940] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns334test # [ 0.214283] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1335second # [ 0.220018] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)336test # [ 0.215502] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns337second # [ 0.221107] x86/cpu: User Mode Instruction Prevention (UMIP) activated338second # [ 0.222141] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127339test # [ 0.217544] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)340second # [ 0.223017] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0341test # [ 0.218628] x86/cpu: User Mode Instruction Prevention (UMIP) activated342test # [ 0.220686] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127343second # [ 0.225019] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto344test # [ 0.221542] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0345second # [ 0.226015] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl346second # [ 0.227016] Spectre V2 : Mitigation: Enhanced / Automatic IBRS347test # [ 0.222545] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto348second # [ 0.229015] Speculative Return Stack Overflow: Mitigation: Safe RET349test # [ 0.224542] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl350test # [ 0.226542] Spectre V2 : Mitigation: Enhanced / Automatic IBRS351second # [ 0.230015] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization352test # [ 0.227542] Speculative Return Stack Overflow: Mitigation: Safe RET353test # [ 0.229541] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization354second # [ 0.231021] Spectre V2 : Enabling IBPB for BPF355second # [ 0.233016] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier356second # [ 0.234016] active return thunk: srso_alias_return_thunk357test # [ 0.230547] Spectre V2 : Enabling IBPB for BPF358second # [ 0.235038] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'359test # [ 0.232543] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier360second # [ 0.236015] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'361test # [ 0.233542] active return thunk: srso_alias_return_thunk362second # [ 0.238015] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'363test # [ 0.234563] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'364second # [ 0.239015] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'365test # [ 0.235542] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'366second # [ 0.240021] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'367test # [ 0.237541] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'368second # [ 0.241015] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'369test # [ 0.238541] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'370second # [ 0.242015] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'371test # [ 0.239541] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'372test # [ 0.240541] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'373second # [ 0.243015] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'374test # [ 0.242541] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'375second # [ 0.245015] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'376test # [ 0.243542] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'377second # [ 0.246015] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256378second # [ 0.247015] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64379test # [ 0.244542] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'380second # [ 0.248015] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512381test # [ 0.245542] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256382second # [ 0.249015] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024383test # [ 0.247541] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64384second # [ 0.250015] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8385test # [ 0.248542] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512386second # [ 0.252015] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16387test # [ 0.249541] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024388second # [ 0.253015] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24389test # [ 0.250541] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8390test # [ 0.252541] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16391second # [ 0.254015] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.392test # [ 0.253542] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24393test # [ 0.254541] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.394second # [ 0.283290] Freeing SMP alternatives memory: 44K395second # [ 0.284019] pid_max: default: 32768 minimum: 301396second # [ 0.285097] LSM: initializing lsm=capability,landlock,yama,bpf,ima397test # [ 0.282564] Freeing SMP alternatives memory: 44K398second # [ 0.286107] landlock: Up and running.399test # [ 0.283533] pid_max: default: 32768 minimum: 301400second # [ 0.287016] Yama: becoming mindful.401second # [ 0.288224] LSM support for eBPF active402test # [ 0.284558] LSM: initializing lsm=capability,landlock,yama,bpf,ima403test # [ 0.285627] landlock: Up and running.404second # [ 0.289102] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)405test # [ 0.286542] Yama: becoming mindful.406test # [ 0.287614] LSM support for eBPF active407second # [ 0.290033] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)408test # [ 0.288494] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)409second # [ 0.293123] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)410test # [ 0.289560] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)411second # [ 0.294439] Performance Events: Fam17h+ core perfctr, AMD PMU driver.412second # [ 0.295023] ... version: 2413test # [ 0.292293] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)414second # [ 0.295904] ... bit width: 48415second # [ 0.296717] ... generic counters: 6416test # [ 0.292941] Performance Events: Fam17h+ core perfctr, AMD PMU driver.417test # [ 0.293545] ... version: 2418second # [ 0.297017] ... generic bitmap: 000000000000003f419test # [ 0.294425] ... bit width: 48420second # [ 0.298016] ... fixed-purpose counters: 0421test # [ 0.295243] ... generic counters: 6422second # [ 0.298898] ... fixed-purpose bitmap: 0000000000000000423test # [ 0.295552] ... generic bitmap: 000000000000003f424second # [ 0.299904] ... value mask: 0000ffffffffffff425test # [ 0.296543] ... fixed-purpose counters: 0426second # [ 0.300898] ... max period: 00007fffffffffff427test # [ 0.297411] ... fixed-purpose bitmap: 0000000000000000428second # [ 0.301907] ... global_ctrl mask: 000000000000003f429test # [ 0.298427] ... value mask: 0000ffffffffffff430second # [ 0.302984] signal: max sigframe size: 3376431test # [ 0.299425] ... max period: 00007fffffffffff432second # [ 0.303803] rcu: Hierarchical SRCU implementation.433test # [ 0.300423] ... global_ctrl mask: 000000000000003f434second # [ 0.304020] rcu: Max phase no-delay instances is 400.435test # [ 0.301518] signal: max sigframe size: 3376436test # [ 0.302301] rcu: Hierarchical SRCU implementation.437test # [ 0.302546] rcu: Max phase no-delay instances is 400.438second # [ 0.308139] smp: Bringing up secondary CPUs ...439second # [ 0.309034] smp: Brought up 1 node, 1 CPU440second # [ 0.309855] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)441test # [ 0.306619] smp: Bringing up secondary CPUs ...442test # [ 0.307551] smp: Brought up 1 node, 1 CPU443test # [ 0.308383] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)444second # [ 0.311158] Memory: 942988K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97588K reserved, 0K cma-reserved)445second # [ 0.312218] devtmpfs: initialized446second # [ 0.313091] x86/mm: Memory block size: 128MB447test # [ 0.309737] Memory: 943000K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97592K reserved, 0K cma-reserved)448test # [ 0.310774] devtmpfs: initialized449second # [ 0.314694] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)450test # [ 0.311638] x86/mm: Memory block size: 128MB451second # [ 0.315042] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).452test # [ 0.313264] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)453second # [ 0.316111] pinctrl core: initialized pinctrl subsystem454second # [ 0.317300] PM: RTC time: 05:02:14, date: 2026-09-02455test # [ 0.314567] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).456test # [ 0.315615] pinctrl core: initialized pinctrl subsystem457test # [ 0.316792] PM: RTC time: 05:02:14, date: 2026-09-02458second # [ 0.320167] NET: Registered PF_NETLINK/PF_ROUTE protocol family459second # [ 0.321313] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations460test # [ 0.319520] NET: Registered PF_NETLINK/PF_ROUTE protocol family461second # [ 0.322039] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations462test # [ 0.320772] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations463second # [ 0.323125] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations464test # [ 0.321560] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations465second # [ 0.324030] audit: initializing netlink subsys (disabled)466test # [ 0.322650] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations467second # [ 0.325281] thermal_sys: Registered thermal governor 'fair_share'468test # [ 0.323555] audit: initializing netlink subsys (disabled)469second # [ 0.325283] thermal_sys: Registered thermal governor 'bang_bang'470second # [ 0.326017] thermal_sys: Registered thermal governor 'step_wise'471test # [ 0.324771] thermal_sys: Registered thermal governor 'fair_share'472test # [ 0.324772] thermal_sys: Registered thermal governor 'bang_bang'473second # [ 0.327021] audit: type=2000 audit(1788325335.082:1): state=initialized audit_enabled=0 res=1474test # [ 0.325543] thermal_sys: Registered thermal governor 'step_wise'475second # [ 0.329018] thermal_sys: Registered thermal governor 'user_space'476test # [ 0.326547] audit: type=2000 audit(1788325335.089:1): state=initialized audit_enabled=0 res=1477second # [ 0.329020] thermal_sys: Registered thermal governor 'power_allocator'478second # [ 0.330035] cpuidle: using governor menu479test # [ 0.328544] thermal_sys: Registered thermal governor 'user_space'480test # [ 0.328546] thermal_sys: Registered thermal governor 'power_allocator'481second # [ 0.332673] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5482test # [ 0.329573] cpuidle: using governor menu483second # [ 0.333262] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]484test # [ 0.332195] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5485second # [ 0.334019] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry486test # [ 0.332787] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]487second # [ 0.335029] PCI: Using configuration type 1 for base access488test # [ 0.333546] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry489second # [ 0.336219] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.490test # [ 0.334555] PCI: Using configuration type 1 for base access491test # [ 0.335730] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.492second # [ 0.341219] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages493second # [ 0.342017] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page494test # [ 0.342767] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages495test # [ 0.343544] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page496second # [ 0.347017] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages497second # [ 0.348017] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page498test # [ 0.348543] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages499test # [ 0.349544] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page500second # [ 0.356793] ACPI: Added _OSI(Module Device)501second # [ 0.357017] ACPI: Added _OSI(Processor Device)502second # [ 0.357921] ACPI: Added _OSI(Processor Aggregator Device)503test # [ 0.357048] ACPI: Added _OSI(Module Device)504test # [ 0.357544] ACPI: Added _OSI(Processor Device)505test # [ 0.358441] ACPI: Added _OSI(Processor Aggregator Device)506second # [ 0.362746] ACPI: 1 ACPI AML tables successfully acquired and loaded507test # [ 0.363416] ACPI: 1 ACPI AML tables successfully acquired and loaded508second # [ 0.368369] ACPI: Interpreter enabled509second # [ 0.369033] ACPI: PM: (supports S0 S3 S4 S5)510second # [ 0.369903] ACPI: Using IOAPIC for interrupt routing511test # [ 0.369434] ACPI: Interpreter enabled512test # [ 0.370149] ACPI: PM: (supports S0 S3 S4 S5)513test # [ 0.370544] ACPI: Using IOAPIC for interrupt routing514second # [ 0.372431] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug515second # [ 0.373023] PCI: Using E820 reservations for host bridge windows516test # [ 0.372685] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug517second # [ 0.374145] ACPI: Enabled 2 GPEs in block 00 to 3F518test # [ 0.373543] PCI: Using E820 reservations for host bridge windows519test # [ 0.374661] ACPI: Enabled 2 GPEs in block 00 to 3F520second # [ 0.378258] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])521second # [ 0.379022] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]522test # [ 0.378700] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])523second # [ 0.380089] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]524test # [ 0.379548] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]525second # [ 0.381119] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]526test # [ 0.380603] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]527second # [ 0.382412] PCI host bridge to bus 0000:00528test # [ 0.381637] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]529second # [ 0.383022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]530test # [ 0.382932] PCI host bridge to bus 0000:00531second # [ 0.384017] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]532test # [ 0.383547] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]533second # [ 0.385017] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]534test # [ 0.384543] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]535second # [ 0.386017] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]536test # [ 0.385543] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]537second # [ 0.387017] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]538test # [ 0.386543] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]539second # [ 0.388017] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]540test # [ 0.387543] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]541second # [ 0.389018] pci_bus 0000:00: root bus resource [bus 00-ff]542test # [ 0.388543] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]543second # [ 0.390120] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint544test # [ 0.389544] pci_bus 0000:00: root bus resource [bus 00-ff]545test # [ 0.390680] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint546second # [ 0.391668] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint547test # [ 0.392185] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint548second # [ 0.394024] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]549second # [ 0.395036] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]550test # [ 0.394539] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]551second # [ 0.396055] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]552test # [ 0.395563] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]553second # [ 0.397191] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]554test # [ 0.396642] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]555test # [ 0.397875] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]556second # [ 0.398793] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint557test # [ 0.399298] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint558second # [ 0.401068] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]559second # [ 0.402027] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]560test # [ 0.401554] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]561second # [ 0.403055] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]562test # [ 0.402553] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]563second # [ 0.404027] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]564test # [ 0.403580] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]565test # [ 0.404553] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]566second # [ 0.406027] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint567test # [ 0.406408] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint568second # [ 0.408820] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]569second # [ 0.409856] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]570test # [ 0.409250] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]571second # [ 0.410990] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]572test # [ 0.409554] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]573test # [ 0.410581] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]574second # [ 0.412902] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint575test # [ 0.412425] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint576second # [ 0.415028] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]577test # [ 0.414554] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]578second # [ 0.416027] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]579test # [ 0.415553] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]580second # [ 0.417055] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]581test # [ 0.416581] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]582second # [ 0.418895] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint583test # [ 0.418421] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint584second # [ 0.421027] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]585test # [ 0.420554] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]586second # [ 0.422027] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]587test # [ 0.421553] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]588second # [ 0.423055] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]589test # [ 0.422581] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]590second # [ 0.425273] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint591test # [ 0.424446] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint592second # [ 0.427028] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]593test # [ 0.426554] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]594second # [ 0.428027] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]595test # [ 0.427553] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]596second # [ 0.429055] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]597test # [ 0.428580] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]598second # [ 0.430892] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint599test # [ 0.430418] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint600second # [ 0.433784] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]601test # [ 0.432648] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]602second # [ 0.434027] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]603test # [ 0.433554] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]604second # [ 0.435054] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]605test # [ 0.434581] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]606second # [ 0.436950] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint607test # [ 0.436447] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint608second # [ 0.439027] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]609test # [ 0.438554] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]610second # [ 0.440027] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]611test # [ 0.439554] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]612second # [ 0.441055] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]613test # [ 0.440580] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]614second # [ 0.442027] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]615test # [ 0.441559] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]616second # [ 0.443888] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint617test # [ 0.443406] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint618second # [ 0.446036] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]619test # [ 0.445383] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]620second # [ 0.447054] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]621test # [ 0.446510] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]622second # [ 0.448896] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint623test # [ 0.448404] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint624test # [ 0.450554] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]625second # [ 0.451029] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]626test # [ 0.451553] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]627second # [ 0.452027] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]628test # [ 0.452587] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]629second # [ 0.453055] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]630test # [ 0.454405] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint631second # [ 0.454887] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint632test # [ 0.456553] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]633second # [ 0.457027] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]634test # [ 0.457553] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]635second # [ 0.458027] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]636test # [ 0.458748] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]637second # [ 0.459055] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]638test # [ 0.460439] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint639second # [ 0.460909] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint640test # [ 0.462500] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]641second # [ 0.463018] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]642test # [ 0.463663] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint643second # [ 0.464291] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint644test # [ 0.465453] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]645second # [ 0.466064] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]646test # [ 0.466644] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint647second # [ 0.467299] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint648test # [ 0.468590] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]649second # [ 0.469027] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]650test # [ 0.469839] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint651second # [ 0.470312] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint652test # [ 0.471222] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]653second # [ 0.471773] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]654test # [ 0.471870] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint655second # [ 0.472346] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint656test # [ 0.473010] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO657second # [ 0.473488] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO658test # [ 0.473882] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint659second # [ 0.474355] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint660test # [ 0.475869] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]661second # [ 0.476409] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]662test # [ 0.476553] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]663second # [ 0.477028] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]664test # [ 0.478018] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint665second # [ 0.478486] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint666test # [ 0.479224] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]667second # [ 0.479835] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]668test # [ 0.483984] ACPI: PCI: Interrupt link LNKA configured for IRQ 10669second # [ 0.485635] ACPI: PCI: Interrupt link LNKA configured for IRQ 10670test # [ 0.484665] ACPI: PCI: Interrupt link LNKB configured for IRQ 10671second # [ 0.486165] ACPI: PCI: Interrupt link LNKB configured for IRQ 10672test # [ 0.485659] ACPI: PCI: Interrupt link LNKC configured for IRQ 11673second # [ 0.487151] ACPI: PCI: Interrupt link LNKC configured for IRQ 11674test # [ 0.486654] ACPI: PCI: Interrupt link LNKD configured for IRQ 11675test # [ 0.487657] ACPI: PCI: Interrupt link LNKE configured for IRQ 10676second # [ 0.488149] ACPI: PCI: Interrupt link LNKD configured for IRQ 11677test # [ 0.488657] ACPI: PCI: Interrupt link LNKF configured for IRQ 10678second # [ 0.489157] ACPI: PCI: Interrupt link LNKE configured for IRQ 10679test # [ 0.489659] ACPI: PCI: Interrupt link LNKG configured for IRQ 11680second # [ 0.490153] ACPI: PCI: Interrupt link LNKF configured for IRQ 10681test # [ 0.490657] ACPI: PCI: Interrupt link LNKH configured for IRQ 11682second # [ 0.491136] ACPI: PCI: Interrupt link LNKG configured for IRQ 11683test # [ 0.491590] ACPI: PCI: Interrupt link GSIA configured for IRQ 16684second # [ 0.492130] ACPI: PCI: Interrupt link LNKH configured for IRQ 11685test # [ 0.492556] ACPI: PCI: Interrupt link GSIB configured for IRQ 17686second # [ 0.493061] ACPI: PCI: Interrupt link GSIA configured for IRQ 16687test # [ 0.493556] ACPI: PCI: Interrupt link GSIC configured for IRQ 18688second # [ 0.494033] ACPI: PCI: Interrupt link GSIB configured for IRQ 17689test # [ 0.494556] ACPI: PCI: Interrupt link GSID configured for IRQ 19690second # [ 0.495032] ACPI: PCI: Interrupt link GSIC configured for IRQ 18691test # [ 0.495559] ACPI: PCI: Interrupt link GSIE configured for IRQ 20692second # [ 0.496033] ACPI: PCI: Interrupt link GSID configured for IRQ 19693test # [ 0.496559] ACPI: PCI: Interrupt link GSIF configured for IRQ 21694second # [ 0.497031] ACPI: PCI: Interrupt link GSIE configured for IRQ 20695test # [ 0.497559] ACPI: PCI: Interrupt link GSIG configured for IRQ 22696second # [ 0.498030] ACPI: PCI: Interrupt link GSIF configured for IRQ 21697test # [ 0.498559] ACPI: PCI: Interrupt link GSIH configured for IRQ 23698second # [ 0.499035] ACPI: PCI: Interrupt link GSIG configured for IRQ 22699test # [ 0.500433] iommu: Default domain type: Translated700second # [ 0.500033] ACPI: PCI: Interrupt link GSIH configured for IRQ 23701test # [ 0.501349] iommu: DMA domain TLB invalidation policy: lazy mode702second # [ 0.501920] iommu: Default domain type: Translated703test # [ 0.502791] ACPI: bus type USB registered704second # [ 0.502800] iommu: DMA domain TLB invalidation policy: lazy mode705test # [ 0.503601] usbcore: registered new interface driver usbfs706second # [ 0.504280] ACPI: bus type USB registered707test # [ 0.504557] usbcore: registered new interface driver hub708second # [ 0.505081] usbcore: registered new interface driver usbfs709test # [ 0.505562] usbcore: registered new device driver usb710second # [ 0.506032] usbcore: registered new interface driver hub711test # [ 0.507238] NetLabel: Initializing712second # [ 0.507037] usbcore: registered new device driver usb713test # [ 0.507549] NetLabel: domain hash size = 128714second # [ 0.508727] NetLabel: Initializing715test # [ 0.508455] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO716second # [ 0.509023] NetLabel: domain hash size = 128717test # [ 0.509487] NetLabel: unlabeled traffic allowed by default718second # [ 0.509926] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO719test # [ 0.510446] PCI: Using ACPI for IRQ routing720second # [ 0.510966] NetLabel: unlabeled traffic allowed by default721second # [ 0.511921] PCI: Using ACPI for IRQ routing722test # [ 0.585213] pci 0000:00:01.0: vgaarb: setting as boot VGA device723test # [ 0.585539] pci 0000:00:01.0: vgaarb: bridge control possible724second # [ 0.586839] pci 0000:00:01.0: vgaarb: setting as boot VGA device725test # [ 0.585539] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none726test # [ 0.585547] vgaarb: loaded727second # [ 0.587013] pci 0000:00:01.0: vgaarb: bridge control possible728test # [ 0.586355] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0729second # [ 0.587013] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none730test # [ 0.587312] hpet0: 3 comparators, 64-bit 100.000000 MHz counter731second # [ 0.587025] vgaarb: loaded732second # [ 0.587852] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0733second # [ 0.588849] hpet0: 3 comparators, 64-bit 100.000000 MHz counter734test # [ 0.590629] clocksource: Switched to clocksource kvm-clock735test # [ 0.593669] VFS: Disk quotas dquot_6.6.0736test # [ 0.594528] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)737second # [ 0.595128] clocksource: Switched to clocksource kvm-clock738test # [ 0.596095] pnp: PnP ACPI init739test # [ 0.596970] ACPI: IRQ 4 override to edge(!), high(!)740second # [ 0.598360] VFS: Disk quotas dquot_6.6.0741test # [ 0.598145] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved742test # [ 0.599922] pnp: PnP ACPI: found 6 devices743second # [ 0.599302] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)744second # [ 0.601029] pnp: PnP ACPI init745second # [ 0.602013] ACPI: IRQ 4 override to edge(!), high(!)746second # [ 0.603256] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved747second # [ 0.605183] pnp: PnP ACPI: found 6 devices748test # [ 0.607132] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns749test # [ 0.608968] clocksource: Switched to clocksource acpi_pm750test # [ 0.610357] NET: Registered PF_INET protocol family751test # [ 0.611563] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)752second # [ 0.612493] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns753second # [ 0.614866] clocksource: Switched to clocksource acpi_pm754second # [ 0.616096] NET: Registered PF_INET protocol family755second # [ 0.617293] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)756test # [ 0.625651] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)757test # [ 0.627503] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)758test # [ 0.629078] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)759test # [ 0.630687] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)760second # [ 0.630895] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)761test # [ 0.632176] TCP: Hash tables configured (established 8192 bind 8192)762second # [ 0.632739] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)763test # [ 0.633522] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)764second # [ 0.634353] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)765test # [ 0.635096] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)766second # [ 0.636007] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)767test # [ 0.636458] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)768second # [ 0.637519] TCP: Hash tables configured (established 8192 bind 8192)769test # [ 0.637933] NET: Registered PF_UNIX/PF_LOCAL protocol family770test # [ 0.639169] NET: Registered PF_XDP protocol family771second # [ 0.638933] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)772test # [ 0.640214] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]773second # [ 0.640543] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)774test # [ 0.641452] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]775second # [ 0.641923] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)776test # [ 0.642686] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]777second # [ 0.643414] NET: Registered PF_UNIX/PF_LOCAL protocol family778test # [ 0.644039] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]779second # [ 0.644641] NET: Registered PF_XDP protocol family780test # [ 0.645393] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]781second # [ 0.645705] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]782test # [ 0.646746] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]783second # [ 0.646987] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]784test # [ 0.648761] ACPI: \_SB_.GSIA: Enabled at IRQ 16785second # [ 0.648278] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]786second # [ 0.649707] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]787test # [ 0.650988] ACPI: \_SB_.GSIB: Enabled at IRQ 17788second # [ 0.651110] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]789second # [ 0.652513] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]790test # [ 0.653292] ACPI: \_SB_.GSIC: Enabled at IRQ 18791second # [ 0.654625] ACPI: \_SB_.GSIA: Enabled at IRQ 16792test # [ 0.655394] ACPI: \_SB_.GSID: Enabled at IRQ 19793second # [ 0.656723] ACPI: \_SB_.GSIB: Enabled at IRQ 17794test # [ 0.657296] PCI: CLS 0 bytes, default 64795second # [ 0.658708] ACPI: \_SB_.GSIC: Enabled at IRQ 18796test # [ 0.658392] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns797test # [ 0.660486] Trying to unpack rootfs image as initramfs...798second # [ 0.660671] ACPI: \_SB_.GSID: Enabled at IRQ 19799second # [ 0.662393] PCI: CLS 0 bytes, default 64800second # [ 0.663476] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns801second # [ 0.665655] Trying to unpack rootfs image as initramfs...802test # [ 0.696566] Initialise system trusted keyrings803test # [ 0.699103] workingset: timestamp_bits=40 max_order=18 bucket_order=0804second # [ 0.703696] Initialise system trusted keyrings805second # [ 0.706723] workingset: timestamp_bits=40 max_order=18 bucket_order=0806test # [ 0.718126] Key type asymmetric registered807test # [ 0.719052] Asymmetric key parser 'x509' registered808test # [ 0.722107] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)809second # [ 0.723153] Key type asymmetric registered810test # [ 0.727102] io scheduler mq-deadline registered811test # [ 0.728092] io scheduler kyber registered812second # [ 0.728557] Asymmetric key parser 'x509' registered813second # [ 0.729656] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)814test # [ 0.730503] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled815test # [ 0.734063] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A816second # [ 0.734738] io scheduler mq-deadline registered817second # [ 0.735705] io scheduler kyber registered818test # [ 0.739489] Linux agpgart interface v0.103819second # [ 0.739072] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled820test # [ 0.740440] ACPI: bus type drm_connector registered821test # [ 0.743429] usbcore: registered new interface driver usbserial_generic822test # [ 0.744767] usbserial: USB Serial support registered for generic823second # [ 0.744703] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A824test # [ 0.748061] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.825second # [ 0.749598] Linux agpgart interface v0.103826test # [ 0.748061] Please enable it if your BIOS has the CPPC option.827second # [ 0.750523] ACPI: bus type drm_connector registered828test # [ 0.750761] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled829second # [ 0.753955] usbcore: registered new interface driver usbserial_generic830test # [ 0.755239] drop_monitor: Initializing network drop monitor service831second # [ 0.755296] usbserial: USB Serial support registered for generic832test # [ 0.756661] NET: Registered PF_INET6 protocol family833second # [ 0.758546] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.834test # [ 0.760514] Segment Routing with IPv6835second # [ 0.758546] Please enable it if your BIOS has the CPPC option.836second # [ 0.761147] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled837test # [ 0.763056] In-situ OAM (IOAM) with IPv6838test # [ 0.765295] IPI shorthand broadcast: enabled839second # [ 0.766701] drop_monitor: Initializing network drop monitor service840second # [ 0.768118] NET: Registered PF_INET6 protocol family841second # [ 0.770945] Segment Routing with IPv6842test # [ 0.770733] sched_clock: Marking stable (599020847, 171008069)->(848877865, -78848949)843second # [ 0.774562] In-situ OAM (IOAM) with IPv6844second # [ 0.775770] IPI shorthand broadcast: enabled845test # [ 0.776226] registered taskstats version 1846test # [ 0.777298] Loading compiled-in X.509 certificates847second # [ 0.781168] sched_clock: Marking stable (608020818, 172513219)->(865028486, -84494449)848second # [ 0.788731] registered taskstats version 1849second # [ 0.789803] Loading compiled-in X.509 certificates850test # [ 0.792065] Demotion targets for Node 0: null851test # [ 0.795083] Key type .fscrypt registered852test # [ 0.795920] Key type fscrypt-provisioning registered853test # [ 0.799101] ima: No TPM chip found, activating TPM-bypass!854test # [ 0.800231] ima: Allocated hash algorithm: sha1855test # [ 0.803071] ima: No architecture policies found856test # [ 0.804192] PM: Magic number: 10:656:10857test # [ 0.805747] RAS: Correctable Errors collector initialized.858second # [ 0.804548] Demotion targets for Node 0: null859second # [ 0.805613] Key type .fscrypt registered860second # [ 0.806415] Key type fscrypt-provisioning registered861second # [ 0.809656] ima: No TPM chip found, activating TPM-bypass!862second # [ 0.810800] ima: Allocated hash algorithm: sha1863second # [ 0.813587] ima: No architecture policies found864second # [ 0.814753] PM: Magic number: 10:656:10865test # [ 0.816035] clk: Disabling unused clocks866second # [ 0.816364] RAS: Correctable Errors collector initialized.867test # [ 0.816915] PM: genpd: Disabling unused power domains868second # [ 0.826405] clk: Disabling unused clocks869second # [ 0.828549] PM: genpd: Disabling unused power domains870test # [ 0.938767] Freeing initrd memory: 29088K871test # [ 0.941563] Freeing unused decrypted memory: 2028K872test # [ 0.944042] Freeing unused kernel image (initmem) memory: 3644K873test # [ 0.945407] Write protecting the kernel read-only data: 32768k874second # [ 0.946625] Freeing initrd memory: 29084K875test # [ 0.947369] Freeing unused kernel image (text/rodata gap) memory: 1216K876test # [ 0.949060] Freeing unused kernel image (rodata/data gap) memory: 756K877second # [ 0.949355] Freeing unused decrypted memory: 2028K878second # [ 0.951831] Freeing unused kernel image (initmem) memory: 3644K879second # [ 0.953115] Write protecting the kernel read-only data: 32768k880second # [ 0.955031] Freeing unused kernel image (text/rodata gap) memory: 1216K881second # [ 0.956716] Freeing unused kernel image (rodata/data gap) memory: 756K882test # [ 0.981794] x86/mm: Checked W+X mappings: passed, no W+X pages found.883test # [ 0.983130] Run /init as init process884second # [ 0.989851] x86/mm: Checked W+X mappings: passed, no W+X pages found.885second # [ 0.991214] Run /init as init process886test # [ 0.991662] systemd[1]: Inserted module 'autofs4'887second # [ 1.000395] systemd[1]: Inserted module 'autofs4'888test # [ 1.005449] fuse: init (API version 7.45)889test # [ 1.010739] ACPI: \_SB_.GSIG: Enabled at IRQ 22890test # [ 1.013588] ACPI: \_SB_.GSIH: Enabled at IRQ 23891second # [ 1.013919] fuse: init (API version 7.45)892test # [ 1.017076] ACPI: \_SB_.GSIE: Enabled at IRQ 20893second # [ 1.019346] ACPI: \_SB_.GSIG: Enabled at IRQ 22894test # [ 1.019941] ACPI: \_SB_.GSIF: Enabled at IRQ 21895second # [ 1.022060] ACPI: \_SB_.GSIH: Enabled at IRQ 23896second # [ 1.025615] ACPI: \_SB_.GSIE: Enabled at IRQ 20897second # [ 1.029720] ACPI: \_SB_.GSIF: Enabled at IRQ 21898test # [ 1.048546] systemd[1]: Successfully made /usr/ read-only.899second # [ 1.058052] systemd[1]: Successfully made /usr/ read-only.900test # [ 1.384767] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)901test # [ 1.390622] systemd[1]: Detected virtualization kvm.902test # [ 1.391681] systemd[1]: Detected architecture x86-64.903test # [ 1.392753] systemd[1]: Running in initrd.904test # [ 1.393904] systemd[1]: Initializing machine ID from random generator.905test # [ 1.395411] systemd[1]: Hostname set to <test>.906second # [ 1.393912] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)907second # [ 1.399849] systemd[1]: Detected virtualization kvm.908second # [ 1.400916] systemd[1]: Detected architecture x86-64.909second # [ 1.402048] systemd[1]: Running in initrd.910second # [ 1.403281] systemd[1]: Initializing machine ID from random generator.911second # [ 1.404710] systemd[1]: Hostname set to <second>.912test # [ 1.564995] systemd[1]: bpf-restrict-fs: LSM BPF program attached913second # [ 1.576805] systemd[1]: bpf-restrict-fs: LSM BPF program attached914test # [ 1.598116] systemd[1]: Queued start job for default target Initrd Default Target.915test # [ 1.602251] systemd[1]: Created slice Slice /system/modprobe.916test # [ 1.603701] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.917test # [ 1.605435] systemd[1]: Expecting device /dev/disk/by-label/nixos...918test # [ 1.606822] systemd[1]: Reached target Path Units.919test # [ 1.607925] systemd[1]: Reached target Slice Units.920test # [ 1.609090] systemd[1]: Reached target Swaps.921second # [ 1.608259] systemd[1]: Queued start job for default target Initrd Default Target.922test # [ 1.610138] systemd[1]: Reached target Timer Units.923test # [ 1.611332] systemd[1]: Listening on D-Bus System Message Bus Socket.924test # [ 1.612820] systemd[1]: Listening on Journal Socket (/dev/log).925second # [ 1.612769] systemd[1]: Created slice Slice /system/modprobe.926test # [ 1.614278] systemd[1]: Listening on Journal Sockets.927second # [ 1.614228] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.928test # [ 1.615506] systemd[1]: Listening on udev Control Socket.929second # [ 1.615986] systemd[1]: Expecting device /dev/disk/by-label/nixos...930test # [ 1.616765] systemd[1]: Listening on udev Kernel Socket.931second # [ 1.617365] systemd[1]: Reached target Path Units.932test # [ 1.618066] systemd[1]: Reached target Socket Units.933second # [ 1.618461] systemd[1]: Reached target Slice Units.934second # [ 1.619590] systemd[1]: Reached target Swaps.935second # [ 1.620613] systemd[1]: Reached target Timer Units.936second # [ 1.621836] systemd[1]: Listening on D-Bus System Message Bus Socket.937second # [ 1.623322] systemd[1]: Listening on Journal Socket (/dev/log).938second # [ 1.624778] systemd[1]: Listening on Journal Sockets.939second # [ 1.626012] systemd[1]: Listening on udev Control Socket.940second # [ 1.627300] systemd[1]: Listening on udev Kernel Socket.941test # [ 1.619953] systemd[1]: Starting Create List of Static Device Nodes...942second # [ 1.628505] systemd[1]: Reached target Socket Units.943test # [ 1.632985] systemd[1]: Starting Load Kernel Module 9pnet_virtio...944second # [ 1.630696] systemd[1]: Starting Create List of Static Device Nodes...945test # [ 1.640747] systemd[1]: Starting Load Kernel Module configfs...946second # [ 1.643752] systemd[1]: Starting Load Kernel Module 9pnet_virtio...947test # [ 1.654275] systemd[1]: Starting Journal Service...948second # [ 1.654094] systemd[1]: Starting Load Kernel Module configfs...949test # [ 1.663972] systemd[1]: Starting Load Kernel Modules...950second # [ 1.664707] systemd[1]: Starting Journal Service...951test # [ 1.669648] netfs: FS-Cache loaded952test # [ 1.671141] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os953second # [ 1.675695] systemd[1]: Starting Load Kernel Modules...954test # [ 1.681556] systemd[1]: Starting Coldplug All udev Devices...955second # [ 1.681628] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os956test # [ 1.683224] 9pnet: Installing 9P2000 support957second # [ 1.684258] netfs: FS-Cache loaded958second # [ 1.694220] systemd[1]: Starting Coldplug All udev Devices...959second # [ 1.698686] 9pnet: Installing 9P2000 support960test # [ 1.702883] systemd[1]: Finished Create List of Static Device Nodes.961test # [ 1.704537] systemd-journald[67]: Collecting audit messages is disabled.962test # [ 1.712095] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.963second # [ 1.716979] systemd[1]: Finished Create List of Static Device Nodes.964second # [ 1.720000] systemd-journald[67]: Collecting audit messages is disabled.965test # [ 1.720554] systemd[1]: Finished Load Kernel Module 9pnet_virtio.966second # [ 1.723190] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.967test # [ 1.724606] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.968test # [ 1.728469] systemd[1]: modprobe@configfs.service: Deactivated successfully.969second # [ 1.733056] systemd[1]: Finished Load Kernel Module 9pnet_virtio.970test # [ 1.734539] systemd[1]: Finished Load Kernel Module configfs.971test # [ 1.738177] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev972second # [ 1.739050] systemd[1]: modprobe@configfs.service: Deactivated successfully.973test # [ 1.742646] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config974second # [ 1.742575] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.975second # [ 1.748026] systemd[1]: Finished Load Kernel Module configfs.976second # [ 1.751604] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev977test # [ 1.755140] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...978second # [ 1.755183] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config979second # [ 1.767614] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...980test # [ 1.772167] systemd[1]: Finished Load Kernel Modules.981test # [ 1.782246] systemd[1]: Starting Apply Kernel Variables...982second # [ 1.785690] systemd[1]: Finished Load Kernel Modules.983second # [ 1.795737] systemd[1]: Starting Apply Kernel Variables...984test # [ 1.797570] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.985second # [ 1.809679] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.986test # [ 1.813130] systemd[1]: Starting Create Static Device Nodes in /dev...987second # [ 1.819755] systemd[1]: Starting Create Static Device Nodes in /dev...988test # [ 1.823200] systemd[1]: Finished Apply Kernel Variables.989second # [ 1.836677] systemd[1]: Finished Apply Kernel Variables.990test # [ 1.839750] systemd[1]: Finished Create Static Device Nodes in /dev.991test # [ 1.845339] systemd[1]: Reached target Preparation for Local File Systems.992test # [ 1.677520] systemd-modules-load[68]: Inserted module 'dm_mod'993test # [ 1.850161] systemd[1]: Reached target Local File Systems.994test # [ 1.680157] systemd-modules-load[68]: Inserted module 'virtio_balloon'995test # [ 1.681562] systemd-modules-load[68]: Inserted module 'virtio_gpu'996second # [ 1.852645] systemd[1]: Finished Create Static Device Nodes in /dev.997test # [ 1.858106] systemd[1]: Starting Rule-based Manager for Device Events and Files...998second # [ 1.857789] systemd[1]: Reached target Preparation for Local File Systems.999second # [ 1.862616] systemd[1]: Reached target Local File Systems.1000second # [ 1.687862] systemd-modules-load[68]: Inserted module 'dm_mod'1001test # [ 1.864206] systemd[1]: Started Journal Service.1002second # [ 1.692295] systemd-modules-load[68]: Inserted module 'virtio_balloon'1003second # [ 1.693680] systemd-modules-load[68]: Inserted module 'virtio_gpu'1004second # [ 1.870722] systemd[1]: Starting Rule-based Manager for Device Events and Files...1005second # [ 1.877721] systemd[1]: Started Journal Service.1006test # [ 1.710379] systemd[1]: Starting Create System Files and Directories...1007second # [ 1.722595] systemd[1]: Starting Create System Files and Directories...1008test # [ 1.736208] systemd[1]: Finished Create System Files and Directories.1009test # [ 1.740371] systemd-udevd[75]: Using default interface naming scheme 'v261'.1010second # [ 1.750133] systemd[1]: Finished Create System Files and Directories.1011second # [ 1.751561] systemd-udevd[75]: Using default interface naming scheme 'v261'.1012test # [ 1.760141] systemd[1]: Finished Coldplug All udev Devices.1013test # [ 1.762825] systemd[1]: Started Rule-based Manager for Device Events and Files.1014test # [ 1.764337] systemd[1]: Reached target System Initialization.1015test # [ 1.765462] systemd[1]: Reached target Basic System.1016second # [ 1.774088] systemd[1]: Finished Coldplug All udev Devices.1017second # [ 1.776093] systemd[1]: Started Rule-based Manager for Device Events and Files.1018second # [ 1.777376] systemd[1]: Reached target System Initialization.1019second # [ 1.778391] systemd[1]: Reached target Basic System.1020test # [ 2.127594] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121021second # [ 2.141579] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022test # [ 2.142654] virtio_blk virtio5: 1/0/0 default/read/poll queues1023test # [ 2.148776] serio: i8042 KBD port at 0x60,0x64 irq 11024second # [ 2.160309] virtio_blk virtio5: 1/0/0 default/read/poll queues1025test # [ 2.162254] serio: i8042 AUX port at 0x60,0x64 irq 121026second # [ 2.165269] serio: i8042 KBD port at 0x60,0x64 irq 11027test # [ 2.166221] ehci-pci 0000:00:1d.7: EHCI Host Controller1028test # [ 2.167079] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11029test # [ 2.169873] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1030second # [ 2.171442] uhci_hcd 0000:00:1d.0: UHCI Host Controller1031test # [ 2.171643] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001032test # [ 2.178057] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001033second # [ 2.178765] serio: i8042 AUX port at 0x60,0x64 irq 121034test # [ 2.179071] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181035test # [ 2.180349] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11036second # [ 2.181395] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1037test # [ 2.183031] usb usb1: Product: EHCI Host Controller1038test # [ 2.183796] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd1039test # [ 2.185641] usb usb1: SerialNumber: 0000:00:1d.71040second # [ 2.185902] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11041test # [ 2.187370] hub 1-0:1.0: USB hub found1042test # [ 2.189044] hub 1-0:1.0: 6 ports detected1043second # [ 2.192017] uhci_hcd 0000:00:1d.0: detected 2 ports1044test # [ 2.192168] uhci_hcd 0000:00:1d.0: UHCI Host Controller1045test # [ 2.192974] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21046second # [ 2.193116] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001047second # [ 2.194487] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181048second # [ 2.195890] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11049second # [ 2.197133] usb usb1: Product: UHCI Host Controller1050second # [ 2.198025] usb usb1: Manufacturer: Linux 6.18.48 uhci_hcd1051second # [ 2.198981] usb usb1: SerialNumber: 0000:00:1d.01052second # [ 2.200094] hub 1-0:1.0: USB hub found1053second # [ 2.201133] hub 1-0:1.0: 2 ports detected1054second # [ 2.202685] ehci-pci 0000:00:1d.7: EHCI Host Controller1055test # [ 2.203256] uhci_hcd 0000:00:1d.0: detected 2 ports1056second # [ 2.203493] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 21057second # [ 2.205311] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001058test # [ 2.208382] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001059second # [ 2.211604] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001060second # [ 2.212733] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181061second # [ 2.214298] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11062second # [ 2.215552] usb usb2: Product: EHCI Host Controller1063second # [ 2.216314] usb usb2: Manufacturer: Linux 6.18.48 ehci_hcd1064second # [ 2.217377] usb usb2: SerialNumber: 0000:00:1d.71065test # [ 2.217470] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181066second # [ 2.218465] hub 2-0:1.0: USB hub found1067test # [ 2.218738] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11068second # [ 2.219477] hub 2-0:1.0: 6 ports detected1069test # [ 2.221551] SCSI subsystem initialized1070test # [ 2.235711] usb usb2: Product: UHCI Host Controller1071second # [ 2.241897] hub 1-0:1.0: USB hub found1072test # [ 2.241962] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd1073second # [ 2.242829] hub 1-0:1.0: 2 ports detected1074test # [ 2.243042] usb usb2: SerialNumber: 0000:00:1d.01075second # [ 2.247570] uhci_hcd 0000:00:1d.1: UHCI Host Controller1076second # [ 2.248384] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31077test # [ 2.080929] systemd[1]: Starting Virtual Console Setup...1078test # [ 2.256113] hub 2-0:1.0: USB hub found1079second # [ 2.260564] uhci_hcd 0000:00:1d.1: detected 2 ports1080second # [ 2.261450] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201081test # [ 2.263911] hub 2-0:1.0: 2 ports detected1082test # [ 2.267651] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01083second # [ 2.271221] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181084second # [ 2.274541] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11085test # [ 2.104449] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1086test # [ 2.109369] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1087second # [ 2.282712] usb usb3: Product: UHCI Host Controller1088second # [ 2.283490] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1089test # [ 2.115378] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1090test # [ 2.117725] systemd[1]: Finished Virtual Console Setup.1091second # [ 2.291438] usb usb3: SerialNumber: 0000:00:1d.11092second # [ 2.293422] hub 3-0:1.0: USB hub found1093test # [ 2.296602] uhci_hcd 0000:00:1d.1: UHCI Host Controller1094test # [ 2.297456] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31095second # [ 2.298040] hub 3-0:1.0: 2 ports detected1096second # [ 2.302627] SCSI subsystem initialized1097second # [ 2.139083] systemd[1]: Starting Virtual Console Setup...1098second # [ 2.140806] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1099test # [ 2.316569] uhci_hcd 0000:00:1d.1: detected 2 ports1100test # [ 2.319159] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201101second # [ 2.320639] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01102test # [ 2.324162] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181103second # [ 2.154315] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1104test # [ 2.327702] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11105second # [ 2.331646] uhci_hcd 0000:00:1d.2: UHCI Host Controller1106test # [ 2.160938] systemd[1]: Found device /dev/disk/by-label/nixos.1107second # [ 2.332462] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41108test # [ 2.162135] systemd[1]: Reached target Initrd Root Device.1109test # [ 2.163775] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1110test # [ 2.336044] usb usb3: Product: UHCI Host Controller1111test # [ 2.336813] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1112second # [ 2.170269] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1113second # [ 2.174123] systemd[1]: Finished Virtual Console Setup.1114test # [ 2.348157] usb usb3: SerialNumber: 0000:00:1d.11115test # [ 2.354241] hub 3-0:1.0: USB hub found1116test # [ 2.356129] hub 3-0:1.0: 2 ports detected1117second # [ 2.357570] uhci_hcd 0000:00:1d.2: detected 2 ports1118second # [ 2.358456] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401119test # [ 2.359986] uhci_hcd 0000:00:1d.2: UHCI Host Controller1120test # [ 2.362521] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1121test # [ 2.193094] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1122second # [ 2.366034] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181123second # [ 2.367284] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11124test # [ 2.197201] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1125test # [ 2.369785] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41126test # [ 2.371707] uhci_hcd 0000:00:1d.2: detected 2 ports1127test # [ 2.372764] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1128test # [ 2.374089] ahci 0000:00:1f.2: flags: 64bit ncq only1129second # [ 2.374602] usb usb4: Product: UHCI Host Controller1130test # [ 2.375400] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401131second # [ 2.375375] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1132second # [ 2.205161] systemd[1]: Found device /dev/disk/by-label/nixos.1133second # [ 2.206332] systemd[1]: Reached target Initrd Root Device.1134test # [ 2.379470] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181135test # [ 2.381779] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11136test # [ 2.383077] usb usb4: Product: UHCI Host Controller1137test # [ 2.383855] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1138second # [ 2.211068] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1139second # [ 2.384827] usb usb4: SerialNumber: 0000:00:1d.21140test # [ 2.385341] scsi host0: ahci1141test # [ 2.386650] scsi host1: ahci1142second # [ 2.386819] hub 4-0:1.0: USB hub found1143test # [ 2.389769] scsi host2: ahci1144second # [ 2.389539] hub 4-0:1.0: 2 ports detected1145test # [ 2.391336] scsi host3: ahci1146test # [ 2.392713] usb usb4: SerialNumber: 0000:00:1d.21147test # [ 2.393596] scsi host4: ahci1148test # [ 2.396065] scsi host5: ahci1149test # [ 2.396701] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11150test # [ 2.399978] hub 4-0:1.0: USB hub found1151test # [ 2.401754] hub 4-0:1.0: 2 ports detected1152test # [ 2.402694] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11153test # [ 2.405221] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11154second # [ 2.235677] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1155second # [ 2.240644] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1156test # [ 2.414790] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11157test # [ 2.421867] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11158test # [ 2.428555] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11159test # [ 2.429839] usb 1-1: new high-speed USB device number 2 using ehci-pci1160second # [ 2.434499] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1161second # [ 2.440332] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1162second # [ 2.441546] ahci 0000:00:1f.2: flags: 64bit ncq only1163second # [ 2.450027] scsi host0: ahci1164second # [ 2.451478] scsi host1: ahci1165second # [ 2.453273] scsi host2: ahci1166second # [ 2.454869] scsi host3: ahci1167second # [ 2.456435] scsi host4: ahci1168second # [ 2.457000] usb 2-1: new high-speed USB device number 2 using ehci-pci1169second # [ 2.459136] scsi host5: ahci1170second # [ 2.460406] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11171second # [ 2.461993] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11172second # [ 2.463327] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11173second # [ 2.464821] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11174second # [ 2.466155] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11175second # [ 2.467494] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11176test # [ 2.559916] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001177test # [ 2.561201] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101178test # [ 2.562639] usb 1-1: Product: QEMU USB Tablet1179test # [ 2.563459] usb 1-1: Manufacturer: QEMU1180test # [ 2.564213] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11181test # [ 2.577532] hid: raw HID events driver (C) Jiri Kosina1182second # [ 2.586371] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001183second # [ 2.587639] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101184second # [ 2.589065] usb 2-1: Product: QEMU USB Tablet1185second # [ 2.589880] usb 2-1: Manufacturer: QEMU1186second # [ 2.590657] usb 2-1: SerialNumber: 28754-0000:00:1d.7-11187second # [ 2.607762] hid: raw HID events driver (C) Jiri Kosina1188test # [ 2.530163] systemd[1]: Mounting /sysroot...1189second # [ 2.536821] systemd[1]: Mounting /sysroot...1190test # [ 2.749939] ata6: SATA link down (SStatus 0 SControl 300)1191test # [ 2.750979] ata1: SATA link down (SStatus 0 SControl 300)1192test # [ 2.752232] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1193test # [ 2.753357] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001194test # [ 2.754304] ata3.00: applying bridge limits1195test # [ 2.755222] ata2: SATA link down (SStatus 0 SControl 300)1196test # [ 2.756244] ata4: SATA link down (SStatus 0 SControl 300)1197test # [ 2.757405] ata5: SATA link down (SStatus 0 SControl 300)1198test # [ 2.758440] ata3.00: configured for UDMA/1001199test # [ 2.759551] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51200second # [ 2.773746] ata1: SATA link down (SStatus 0 SControl 300)1201second # [ 2.782065] ata4: SATA link down (SStatus 0 SControl 300)1202second # [ 2.783454] ata6: SATA link down (SStatus 0 SControl 300)1203second # [ 2.784480] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1204second # [ 2.785540] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001205second # [ 2.786395] ata3.00: applying bridge limits1206second # [ 2.787654] ata5: SATA link down (SStatus 0 SControl 300)1207second # [ 2.788736] ata2: SATA link down (SStatus 0 SControl 300)1208second # [ 2.789736] ata3.00: configured for UDMA/1001209second # [ 2.790948] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51210test # [ 2.808225] usbcore: registered new interface driver usbhid1211test # [ 2.812523] usbhid: USB HID core driver1212test # [ 2.823901] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21213test # [ 2.827600] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1214test # [ 2.829314] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01215second # [ 2.833876] usbcore: registered new interface driver usbhid1216test # [ 2.834734] EXT4-fs (vda): mounted filesystem 72290853-c859-466b-acff-efac921b8205 r/w with ordered data mode. Quota mode: none.1217test # [ 2.667867] systemd[1]: Mounted /sysroot.1218second # [ 2.840674] usbhid: USB HID core driver1219test # [ 2.670071] systemd[1]: Reached target Initrd Root File System.1220test # [ 2.843338] cdrom: Uniform CD-ROM driver Revision: 3.201221test # [ 2.674090] systemd[1]: Starting Mountpoints Configured in the Real Root...1222second # [ 2.856132] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input21223second # [ 2.858981] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01224test # [ 2.690942] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.1225second # [ 2.863353] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1226test # [ 2.693077] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...1227test # [ 2.694878] systemd[1]: Reloading...1228second # [ 2.866351] EXT4-fs (vda): mounted filesystem d922f15c-7655-4a7a-9e9f-f48eb024ea3f r/w with ordered data mode. Quota mode: none.1229second # [ 2.700165] systemd[1]: Mounted /sysroot.1230second # [ 2.873673] cdrom: Uniform CD-ROM driver Revision: 3.201231second # [ 2.702745] systemd[1]: Reached target Initrd Root File System.1232second # [ 2.707064] systemd[1]: Starting Mountpoints Configured in the Real Root...1233second # [ 2.720811] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.1234second # [ 2.724554] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...1235second # [ 2.727546] systemd[1]: Reloading...1236test # [ 2.757425] systemd[1]: Reloading finished in 63 ms.1237test # [ 2.766719] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...1238test # [ 2.772385] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...1239test # [ 2.774566] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1240test # [ 2.777352] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1241test # [ 2.780397] systemd[1]: Finished Mountpoints Configured in the Real Root.1242test # [ 2.781567] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1243second # [ 2.790489] systemd[1]: Reloading finished in 63 ms.1244second # [ 2.801654] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...1245second # [ 2.806974] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...1246second # [ 2.810829] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1247second # [ 2.812934] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1248second # [ 2.814630] systemd[1]: Finished Mountpoints Configured in the Real Root.1249second # [ 2.816162] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1250test # [ 3.530925] systemd[1]: Mounting /sysroot/nix/.ro-store...1251test # [ 3.534614] systemd[1]: Mounting /sysroot/nix/.rw-store...1252test # [ 3.536134] systemd[1]: Mounting /sysroot/run...1253second # [ 3.538676] systemd[1]: Mounting /sysroot/nix/.ro-store...1254second # [ 3.539947] systemd[1]: Mounting /sysroot/nix/.rw-store...1255test # [ 3.541773] systemd[1]: Mounting /sysroot/tmp/shared...1256second # [ 3.543636] systemd[1]: Mounting /sysroot/run...1257test # [ 3.546330] systemd[1]: Mounting /sysroot/tmp/xchg...1258second # [ 3.548275] systemd[1]: Mounting /sysroot/tmp/shared...1259second # [ 3.553737] systemd[1]: Mounting /sysroot/tmp/xchg...1260test # [ 3.561416] systemd[1]: Mounted /sysroot/nix/.rw-store.1261test # [ 3.565245] systemd[1]: Mounted /sysroot/run.1262test # [ 3.739421] 9p: Installing v9fs 9p2000 file system support1263second # [ 3.742771] 9p: Installing v9fs 9p2000 file system support1264second # [ 3.572169] systemd[1]: Mounted /sysroot/nix/.rw-store.1265test # [ 3.578582] systemd[1]: Starting rw-sysroot-nix-store.service...1266second # [ 3.577939] systemd[1]: Mounted /sysroot/run.1267second # [ 3.581808] systemd[1]: Mounted /sysroot/nix/.ro-store.1268test # [ 3.583974] systemd[1]: Mounted /sysroot/nix/.ro-store.1269second # [ 3.584216] systemd[1]: Mounted /sysroot/tmp/shared.1270test # [ 3.586301] systemd[1]: Mounted /sysroot/tmp/shared.1271second # [ 3.586156] systemd[1]: Mounted /sysroot/tmp/xchg.1272test # [ 3.587844] systemd[1]: Mounted /sysroot/tmp/xchg.1273second # [ 3.589099] systemd[1]: Starting rw-sysroot-nix-store.service...1274test # [ 3.595417] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1275test # [ 3.597220] systemd[1]: Finished rw-sysroot-nix-store.service.1276second # [ 3.598444] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1277second # [ 3.601079] systemd[1]: Finished rw-sysroot-nix-store.service.1278second # [ 3.602337] systemd[1]: Mounting /sysroot/nix/store...1279second # [ 3.619148] systemd[1]: Mounted /sysroot/nix/store.1280second # [ 3.620082] systemd[1]: Reached target Initrd File Systems.1281second # [ 3.621934] systemd[1]: Starting Find NixOS closure...1282second # [ 3.625126] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1283second # [ 3.636604] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1284second # [ 3.643072] systemd[1]: Finished Find NixOS closure.1285second # [ 3.644512] systemd[1]: Reached target Initrd Default Target.1286second # [ 3.646381] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1287second # [ 3.656497] systemd[1]: Stopped target Initrd Default Target.1288second # [ 3.658038] systemd[1]: Stopped target Basic System.1289second # [ 3.659227] systemd[1]: Stopped target Initrd Root Device.1290second # [ 3.660492] systemd[1]: Stopped target Path Units.1291second # [ 3.662137] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1292second # [ 3.663396] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1293second # [ 3.664773] systemd[1]: Stopped target Slice Units.1294second # [ 3.665688] systemd[1]: Stopped target Socket Units.1295second # [ 3.666969] systemd[1]: Stopped target System Initialization.1296second # [ 3.668430] systemd[1]: Stopped target Swaps.1297second # [ 3.669690] systemd[1]: Stopped target Timer Units.1298second # [ 3.670757] systemd[1]: dbus.socket: Deactivated successfully.1299second # [ 3.672185] systemd[1]: Closed D-Bus System Message Bus Socket.1300second # [ 3.673434] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1301second # [ 3.674785] systemd[1]: Stopped Find NixOS closure.1302second # [ 3.675952] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1303second # [ 3.678169] systemd[1]: Starting rw-sysroot-nix-store.service...1304second # [ 3.679220] systemd[1]: systemd-sysctl.service: Deactivated successfully.1305second # [ 3.681151] systemd[1]: Stopped Apply Kernel Variables.1306second # [ 3.682181] systemd[1]: systemd-modules-load.service: Deactivated successfully.1307second # [ 3.683395] systemd[1]: Stopped Load Kernel Modules.1308second # [ 3.685143] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1309second # [ 3.686445] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1310second # [ 3.687737] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1311second # [ 3.688942] systemd[1]: Stopped Create System Files and Directories.1312second # [ 3.690462] systemd[1]: Stopped target Local File Systems.1313second # [ 3.692151] systemd[1]: Stopped target Preparation for Local File Systems.1314second # [ 3.693834] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1315second # [ 3.695405] systemd[1]: Stopped Coldplug All udev Devices.1316second # [ 3.696847] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1317second # [ 3.698164] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1318second # [ 3.702502] systemd[1]: Stopped Virtual Console Setup.1319second # [ 3.707588] systemd[1]: initrd-cleanup.service: Deactivated successfully.1320second # [ 3.711080] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1321second # [ 3.714196] systemd[1]: systemd-udevd.service: Deactivated successfully.1322second # [ 3.715864] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1323second # [ 3.717602] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1324second # [ 3.719381] systemd[1]: Finished rw-sysroot-nix-store.service.1325second # [ 3.722081] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1326second # [ 3.723312] systemd[1]: Closed udev Control Socket.1327second # [ 3.724472] systemd[1]: Starting Cleanup udev Database...1328second # [ 3.726058] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1329second # [ 3.727346] systemd[1]: Stopped Create Static Device Nodes in /dev.1330second # [ 3.728457] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1331second # [ 3.730158] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1332second # [ 3.731413] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1333second # [ 3.733126] systemd[1]: Stopped Create List of Static Device Nodes.1334second # [ 3.744219] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1335second # [ 3.746108] systemd[1]: Finished Cleanup udev Database.1336second # [ 3.747485] systemd[1]: Reached target Switch Root.1337second # [ 3.749196] systemd[1]: Starting NixOS Activation...1338second # [ 3.825526] initrd-nixos-activation-start[192]: booting system configuration /nix/store/v66fwmypp297w0v1lrvy2h4swlmxwmyy-nixos-system-second-test1339second # [ 3.855578] initrd-nixos-activation-start[192]: running activation script...1340second # [ 4.055789] initrd-nixos-activation-start[215]: setting up /etc...1341second # [ 4.165410] initrd-nixos-activation-start[215]: setting up age secrets...1342second # [ 4.262062] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1343second # [ 4.264162] systemd[1]: Finished NixOS Activation.1344second # [ 4.265808] systemd[1]: Starting Switch Root...1345second # [ 4.275120] systemd[1]: Switching root.1346second # [ 4.571415] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1347second # [ 4.677397] NET: Registered PF_VSOCK protocol family1348test # [ 4.530520] systemd[1]: Mounting /sysroot/nix/store...1349test # [ 4.546240] systemd[1]: Mounted /sysroot/nix/store.1350test # [ 4.547696] systemd[1]: Reached target Initrd File Systems.1351test # [ 4.549579] systemd[1]: Starting Find NixOS closure...1352test # [ 4.552789] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1353test # [ 4.568080] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1354test # [ 4.569995] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1355test # [ 4.576541] systemd[1]: Finished Find NixOS closure.1356test # [ 4.578203] systemd[1]: Reached target Initrd Default Target.1357test # [ 4.579591] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1358test # [ 4.590093] systemd[1]: Stopped target Initrd Default Target.1359test # [ 4.591356] systemd[1]: Stopped target Basic System.1360test # [ 4.593153] systemd[1]: Stopped target Initrd Root Device.1361test # [ 4.594133] systemd[1]: Stopped target Path Units.1362test # [ 4.595123] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1363test # [ 4.596376] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1364test # [ 4.598217] systemd[1]: Stopped target Slice Units.1365test # [ 4.599358] systemd[1]: Stopped target Socket Units.1366test # [ 4.600576] systemd[1]: Stopped target System Initialization.1367test # [ 4.602234] systemd[1]: Stopped target Swaps.1368test # [ 4.603069] systemd[1]: Stopped target Timer Units.1369test # [ 4.604144] systemd[1]: dbus.socket: Deactivated successfully.1370test # [ 4.605302] systemd[1]: Closed D-Bus System Message Bus Socket.1371test # [ 4.606699] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1372test # [ 4.608195] systemd[1]: Stopped Find NixOS closure.1373test # [ 4.610132] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1374test # [ 4.611891] systemd[1]: Starting rw-sysroot-nix-store.service...1375test # [ 4.612941] systemd[1]: systemd-sysctl.service: Deactivated successfully.1376test # [ 4.614093] systemd[1]: Stopped Apply Kernel Variables.1377test # [ 4.615235] systemd[1]: systemd-modules-load.service: Deactivated successfully.1378test # [ 4.617150] systemd[1]: Stopped Load Kernel Modules.1379test # [ 4.618177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1380test # [ 4.619484] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1381test # [ 4.621074] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1382test # [ 4.622919] systemd[1]: Stopped Create System Files and Directories.1383test # [ 4.623994] systemd[1]: Stopped target Local File Systems.1384test # [ 4.625216] systemd[1]: Stopped target Preparation for Local File Systems.1385test # [ 4.627162] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1386test # [ 4.629202] systemd[1]: Stopped Coldplug All udev Devices.1387test # [ 4.632255] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1388test # [ 4.633520] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1389test # [ 4.634754] systemd[1]: Stopped Virtual Console Setup.1390test # [ 4.640332] systemd[1]: initrd-cleanup.service: Deactivated successfully.1391test # [ 4.643084] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1392test # [ 4.644930] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1393test # [ 4.647166] systemd[1]: Finished rw-sysroot-nix-store.service.1394test # [ 4.649748] systemd[1]: systemd-udevd.service: Deactivated successfully.1395test # [ 4.650919] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1396test # [ 4.654689] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1397test # [ 4.656176] systemd[1]: Closed udev Control Socket.1398test # [ 4.657638] systemd[1]: Starting Cleanup udev Database...1399test # [ 4.658653] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1400test # [ 4.660216] systemd[1]: Stopped Create Static Device Nodes in /dev.1401test # [ 4.661696] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1402test # [ 4.663042] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1403test # [ 4.665142] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1404test # [ 4.666303] systemd[1]: Stopped Create List of Static Device Nodes.1405test # [ 4.677821] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1406test # [ 4.680178] systemd[1]: Finished Cleanup udev Database.1407test # [ 4.681364] systemd[1]: Reached target Switch Root.1408test # [ 4.683072] systemd[1]: Starting NixOS Activation...1409test # [ 4.759837] initrd-nixos-activation-start[196]: booting system configuration /nix/store/gnn3zrhfi1qq3vl059j7k4hrbbw664hr-nixos-system-test-test1410test # [ 4.790435] initrd-nixos-activation-start[196]: running activation script...1411second # [ 5.035065] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1412second # [ 5.039304] systemd[1]: Detected virtualization kvm.1413second # [ 5.040118] systemd[1]: Detected architecture x86-64.1414second # [ 5.040981] systemd[1]: Detected first boot.1415second # [ 5.043104] systemd[1]: Initializing machine ID from random generator.1416test # [ 4.990959] initrd-nixos-activation-start[219]: setting up /etc...1417second # [ 5.231751] systemd[1]: bpf-restrict-fs: LSM BPF program attached1418test # [ 5.106299] initrd-nixos-activation-start[219]: setting up age secrets...1419second # [ 5.310827] systemd[1]: Applying preset policy.1420test # [ 5.241739] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1421test # [ 5.244170] systemd[1]: Finished NixOS Activation.1422test # [ 5.245624] systemd[1]: Starting Switch Root...1423test # [ 5.255523] systemd[1]: Switching root.1424test # [ 5.553467] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1425second # [ 5.575533] systemd[1]: Populated /etc with preset unit settings.1426test # [ 5.627213] NET: Registered PF_VSOCK protocol family1427second # [ 5.825458] systemd[1]: initrd-switch-root.service: Deactivated successfully.1428second # [ 5.827019] systemd[1]: Stopped initrd-switch-root.service.1429second # [ 5.829436] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1430second # [ 5.831491] systemd[1]: Created slice Slice /system/getty.1431second # [ 5.832854] systemd[1]: Created slice User and Session Slice.1432second # [ 5.833886] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1433second # [ 5.835206] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1434second # [ 5.844111] systemd[1]: Expecting device /dev/hvc0...1435second # [ 5.844948] systemd[1]: Expecting device /dev/ttyS0...1436second # [ 5.845830] systemd[1]: Reached target Local Encrypted Volumes.1437second # [ 5.846783] systemd[1]: Stopped target initrd-fs.target.1438second # [ 5.847668] systemd[1]: Stopped target initrd-root-fs.target.1439second # [ 5.848592] systemd[1]: Stopped target initrd-switch-root.target.1440second # [ 5.849577] systemd[1]: Reached target Virtual Machines and Containers.1441second # [ 5.850625] systemd[1]: Reached target Path Units.1442second # [ 5.851431] systemd[1]: Reached target Remote File Systems.1443second # [ 5.852354] systemd[1]: Reached target Slice Units.1444second # [ 5.853192] systemd[1]: Reached target Swaps.1445second # [ 5.855124] systemd[1]: Listening on Query the User Interactively for a Password.1446second # [ 5.857676] systemd[1]: Listening on Process Core Dump Socket.1447second # [ 5.859644] systemd[1]: Listening on Credential Encryption/Decryption.1448second # [ 5.861645] systemd[1]: Listening on Factory Reset Management.1449second # [ 5.862685] systemd[1]: Listening on Hostname Service Socket.1450second # [ 5.865273] systemd[1]: Starting Journal Log Access Socket...1451second # [ 5.866666] systemd[1]: Listening on Journal Audit Socket.1452second # [ 5.869044] systemd[1]: Listening on Console Output Muting Service Socket.1453second # [ 5.870250] systemd[1]: Listening on Network Management Metrics Varlink Socket.1454second # [ 5.871620] systemd[1]: Listening on Network Management Varlink Socket.1455second # [ 5.872771] systemd[1]: Listening on Network Management Netlink Socket.1456second # [ 5.873953] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1457second # [ 5.875263] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1458second # [ 5.876725] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1459second # [ 5.881657] systemd[1]: Listening on Disk Repartitioning Service Socket.1460second # [ 5.882810] systemd[1]: Listening on Resolve Monitor Varlink Socket.1461second # [ 5.883917] systemd[1]: Listening on Resolve Service Varlink Socket.1462second # [ 5.885009] systemd[1]: Listening on udev Control Socket.1463second # [ 5.885990] systemd[1]: Listening on udev Varlink Socket.1464second # [ 5.888371] systemd[1]: Mounting Huge Pages File System...1465second # [ 5.892015] systemd[1]: Mounting POSIX Message Queue File System...1466second # [ 5.896097] systemd[1]: Mounting Kernel Debug File System...1467second # [ 5.901071] systemd[1]: Mounting Kernel Trace File System...1468second # [ 5.908073] systemd[1]: Starting Create List of Static Device Nodes...1469second # [ 5.909773] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1470second # [ 5.923770] systemd[1]: Starting Load Kernel Module configfs...1471second # [ 5.924986] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1472second # [ 5.927416] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1473second # [ 5.931977] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1474second # [ 5.936849] systemd[1]: Mounting FUSE Control File System...1475second # [ 5.938353] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671476second # [ 5.954290] systemd[1]: Starting Journal Service...1477second # [ 5.966448] systemd[1]: Starting Load Kernel Modules...1478second # [ 5.977827] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1479test # [ 5.987110] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1480test # [ 5.991393] systemd[1]: Detected virtualization kvm.1481test # [ 5.992225] systemd[1]: Detected architecture x86-64.1482second # [ 5.991859] systemd-journald[318]: Collecting audit messages is enabled.1483test # [ 5.993084] systemd[1]: Detected first boot.1484second # [ 5.994900] systemd[1]: Starting Remount Root and Kernel File Systems...1485test # [ 5.995175] systemd[1]: Initializing machine ID from random generator.1486second # [ 5.998261] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1487second # [ 6.016315] systemd[1]: Starting Coldplug All udev Devices...1488second # [ 5.850722] systemd[1]: Queued start job for default target Multi-User System.1489second # [ 6.026834] loop: module loaded1490second # [ 5.855309] systemd[1]: systemd-journald.service: Deactivated successfully.1491second # [ 5.856921] systemd-modules-load[320]: Module 'ctr' is built in1492second # [ 5.860527] systemd-modules-load[320]: Inserted module 'loop'1493second # [ 6.040991] systemd[1]: Started Journal Service.1494second # [ 5.873844] systemd[1]: Listening on Journal Log Access Socket.1495second # [ 6.051663] EXT4-fs (vda): re-mounted d922f15c-7655-4a7a-9e9f-f48eb024ea3f.1496second # [ 5.880359] systemd[1]: Mounted Huge Pages File System.1497second # [ 5.881372] systemd[1]: Mounted POSIX Message Queue File System.1498second # [ 5.882490] systemd[1]: Mounted Kernel Debug File System.1499second # [ 5.883499] systemd[1]: Mounted Kernel Trace File System.1500second # [ 5.887287] systemd[1]: Finished Create List of Static Device Nodes.1501second # [ 5.889426] systemd[1]: modprobe@configfs.service: Deactivated successfully.1502second # [ 5.893970] systemd[1]: Finished Load Kernel Module configfs.1503second # [ 5.895067] systemd[1]: Mounted FUSE Control File System.1504second # [ 5.896891] systemd[1]: Finished Load Kernel Modules.1505second # [ 5.899869] systemd[1]: Finished Remount Root and Kernel File Systems.1506test # [ 6.076648] systemd[1]: bpf-restrict-fs: LSM BPF program attached1507second # [ 5.917166] systemd[1]: Listening on Disk Image Download Service Socket.1508second # [ 5.921125] systemd[1]: Mounting Kernel Configuration File System...1509second # [ 5.927811] systemd[1]: Starting Firewall...1510second # [ 5.928818] systemd-oomd[321]: No swap; memory pressure usage will be degraded1511second # [ 5.939075] systemd[1]: Starting Flush Journal to Persistent Storage...1512second # [ 5.940237] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1513second # [ 5.951653] systemd[1]: Starting Load/Save OS Random Seed...1514second # [ 5.963986] systemd[1]: Starting Apply Kernel Variables...1515test # [ 6.150589] systemd[1]: Applying preset policy.1516second # [ 5.983117] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1517second # [ 5.985511] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1518second # [ 5.988152] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1519second # [ 6.163774] systemd-journald[318]: Received client request to flush runtime journal.1520second # [ 6.223458] systemd[1]: Mounted Kernel Configuration File System.1521second # [ 6.226251] systemd[1]: Finished Load/Save OS Random Seed.1522second # [ 6.228456] systemd[1]: Reached target First Boot Complete.1523second # [ 6.232877] systemd[1]: Finished Apply Kernel Variables.1524test # [ 6.406488] systemd[1]: Populated /etc with preset unit settings.1525second # [ 6.236446] systemd[1]: Starting Network Name Resolution...1526second # [ 6.240351] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1527second # [ 6.242765] systemd[1]: Starting Create Static Device Nodes in /dev...1528second # [ 6.245453] systemd[1]: Finished Create Static Device Nodes in /dev.1529second # [ 6.248497] systemd[1]: Reached target Preparation for Local File Systems.1530second # [ 6.252115] systemd[1]: Starting Rule-based Manager for Device Events and Files...1531second # [ 6.253546] systemd-resolved[345]: Positive Trust Anchors:1532second # [ 6.255521] systemd-resolved[345]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1533second # [ 6.258304] systemd-resolved[345]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161534second # [ 6.261684] systemd-resolved[345]: 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 test1535second # [ 6.277652] systemd[1]: Finished Flush Journal to Persistent Storage.1536second # [ 6.304276] systemd-udevd[356]: Using default interface naming scheme 'v261'.1537second # [ 6.342834] systemd-resolved[345]: Using system hostname 'second'.1538second # [ 6.345798] systemd[1]: Finished Coldplug All udev Devices.1539second # [ 6.351813] systemd[1]: Started Network Name Resolution.1540second # [ 6.406404] systemd[1]: Started Rule-based Manager for Device Events and Files.1541test # [ 6.680340] systemd[1]: initrd-switch-root.service: Deactivated successfully.1542test # [ 6.681883] systemd[1]: Stopped initrd-switch-root.service.1543test # [ 6.684404] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1544test # [ 6.686515] systemd[1]: Created slice Slice /system/getty.1545test # [ 6.687862] systemd[1]: Created slice User and Session Slice.1546test # [ 6.688892] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1547test # [ 6.690253] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1548test # [ 6.691459] systemd[1]: Expecting device /dev/hvc0...1549test # [ 6.700128] systemd[1]: Expecting device /dev/ttyS0...1550test # [ 6.700963] systemd[1]: Reached target Local Encrypted Volumes.1551test # [ 6.701932] systemd[1]: Stopped target initrd-fs.target.1552test # [ 6.702814] systemd[1]: Stopped target initrd-root-fs.target.1553test # [ 6.703745] systemd[1]: Stopped target initrd-switch-root.target.1554test # [ 6.704741] systemd[1]: Reached target Virtual Machines and Containers.1555test # [ 6.705796] systemd[1]: Reached target Path Units.1556test # [ 6.706631] systemd[1]: Reached target Remote File Systems.1557test # [ 6.707562] systemd[1]: Reached target Slice Units.1558test # [ 6.708406] systemd[1]: Reached target Swaps.1559test # [ 6.710452] systemd[1]: Listening on Query the User Interactively for a Password.1560test # [ 6.713034] systemd[1]: Listening on Process Core Dump Socket.1561test # [ 6.715032] systemd[1]: Listening on Credential Encryption/Decryption.1562test # [ 6.717105] systemd[1]: Listening on Factory Reset Management.1563test # [ 6.718153] systemd[1]: Listening on Hostname Service Socket.1564test # [ 6.720871] systemd[1]: Starting Journal Log Access Socket...1565test # [ 6.722290] systemd[1]: Listening on Journal Audit Socket.1566test # [ 6.724716] systemd[1]: Listening on Console Output Muting Service Socket.1567test # [ 6.725967] systemd[1]: Listening on Network Management Metrics Varlink Socket.1568test # [ 6.727348] systemd[1]: Listening on Network Management Varlink Socket.1569test # [ 6.728498] systemd[1]: Listening on Network Management Netlink Socket.1570test # [ 6.729677] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1571test # [ 6.731037] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1572test # [ 6.732485] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1573second # [ 6.560138] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1574test # [ 6.737444] systemd[1]: Listening on Disk Repartitioning Service Socket.1575test # [ 6.738596] systemd[1]: Listening on Resolve Monitor Varlink Socket.1576test # [ 6.739707] systemd[1]: Listening on Resolve Service Varlink Socket.1577test # [ 6.740822] systemd[1]: Listening on udev Control Socket.1578test # [ 6.741848] systemd[1]: Listening on udev Varlink Socket.1579test # [ 6.744410] systemd[1]: Mounting Huge Pages File System...1580test # [ 6.748599] systemd[1]: Mounting POSIX Message Queue File System...1581test # [ 6.753329] systemd[1]: Mounting Kernel Debug File System...1582test # [ 6.759766] systemd[1]: Mounting Kernel Trace File System...1583test # [ 6.764602] systemd[1]: Starting Create List of Static Device Nodes...1584test # [ 6.768278] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1585test # [ 6.784943] systemd[1]: Starting Load Kernel Module configfs...1586test # [ 6.786444] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1587test # [ 6.794959] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1588test # [ 6.797219] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1589test # [ 6.801468] systemd[1]: Mounting FUSE Control File System...1590test # [ 6.802777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671591test # [ 6.812838] systemd[1]: Starting Journal Service...1592second # [ 6.643836] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1593test # [ 6.820872] systemd[1]: Starting Load Kernel Modules...1594second # [ 6.657192] systemd[1]: Mounting /run/wrappers...1595test # [ 6.832351] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1596test # [ 6.844041] systemd[1]: Starting Remount Root and Kernel File Systems...1597test # [ 6.849288] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1598test # [ 6.856303] systemd-journald[343]: Collecting audit messages is enabled.1599test # [ 6.865964] systemd[1]: Starting Coldplug All udev Devices...1600second # [ 6.694594] systemd[1]: Mounted /run/wrappers.1601second # [ 6.696219] systemd[1]: Reached target Local File Systems.1602second # [ 6.699601] systemd[1]: Listening on Boot Loader Control Service Socket.1603test # [ 6.877587] loop: module loaded1604second # [ 6.704799] systemd[1]: Starting register-nix-paths.service...1605second # [ 6.708088] systemd[1]: Starting Create SUID/SGID Wrappers...1606second # [ 6.709157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1607test # [ 6.883948] systemd[1]: Listening on Journal Log Access Socket.1608test # [ 6.893127] systemd[1]: Mounted Huge Pages File System.1609second # [ 6.720719] systemd[1]: Starting Save Transient machine-id to Disk...1610test # [ 6.896747] systemd[1]: Mounted POSIX Message Queue File System.1611test # [ 6.898061] EXT4-fs (vda): re-mounted 72290853-c859-466b-acff-efac921b8205.1612test # [ 6.730403] systemd[1]: Queued start job for default target Multi-User System.1613test # [ 6.905947] systemd[1]: Started Journal Service.1614test # [ 6.735873] systemd[1]: systemd-journald.service: Deactivated successfully.1615second # [ 6.736679] systemd[1]: Starting Create System Files and Directories...1616test # [ 6.738828] systemd-modules-load[344]: Module 'ctr' is built in1617test # [ 6.742085] systemd-modules-load[344]: Inserted module 'loop'1618second # [ 6.742675] (udev-worker)[411]: Network interface NamePolicy= disabled on kernel command line.1619test # [ 6.745363] systemd[1]: Mounted Kernel Debug File System.1620test # [ 6.746622] systemd[1]: Mounted Kernel Trace File System.1621test # [ 6.750089] systemd[1]: Finished Create List of Static Device Nodes.1622test # [ 6.752251] systemd[1]: modprobe@configfs.service: Deactivated successfully.1623second # [ 6.752945] (udev-worker)[412]: Network interface NamePolicy= disabled on kernel command line.1624test # [ 6.757164] systemd[1]: Finished Load Kernel Module configfs.1625test # [ 6.758565] systemd[1]: Mounted FUSE Control File System.1626second # [ 6.758550] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1627test # [ 6.764113] systemd[1]: Finished Load Kernel Modules.1628test # [ 6.765141] systemd[1]: Finished Remount Root and Kernel File Systems.1629test # [ 6.779123] systemd[1]: Listening on Disk Image Download Service Socket.1630test # [ 6.786871] systemd-oomd[346]: No swap; memory pressure usage will be degraded1631test # [ 6.788518] systemd[1]: Mounting Kernel Configuration File System...1632test # [ 6.790837] systemd[1]: Starting Firewall...1633second # [ 6.793572] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1634test # [ 6.799450] systemd[1]: Starting Flush Journal to Persistent Storage...1635test # [ 6.801497] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1636second # [ 6.800751] systemd[1]: Finished Save Transient machine-id to Disk.1637test # [ 6.810770] systemd[1]: Starting Load/Save OS Random Seed...1638test # [ 6.825094] systemd[1]: Starting Apply Kernel Variables...1639test # [ 6.837864] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1640second # [ 6.839363] systemd[1]: Finished Firewall.1641test # [ 6.841284] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1642test # [ 6.842753] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1643second # [ 6.842234] systemd[1]: Reached target Preparation for Network.1644second # [ 6.843909] systemd[1]: Listening on Network Management Resolve Hook Socket.1645test # [ 7.023835] systemd-journald[343]: Received client request to flush runtime journal.1646second # [ 6.853938] systemd[1]: Starting Network Management...1647second # [ 6.872765] systemd[1]: Finished Create System Files and Directories.1648second # [ 6.889310] systemd[1]: Starting Rebuild Journal Catalog...1649second # [ 6.904545] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1650second # [ 6.976649] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1651second # [ 7.002326] systemd[1]: Finished Rebuild Journal Catalog.1652second # [ 7.010462] systemd[1]: Starting Update is Completed...1653second # [ 7.056527] systemd[1]: Finished Update is Completed.1654test # [ 7.086961] systemd[1]: Mounted Kernel Configuration File System.1655test # [ 7.090740] systemd[1]: Finished Load/Save OS Random Seed.1656test # [ 7.096186] systemd[1]: Reached target First Boot Complete.1657test # [ 7.099984] systemd[1]: Finished Apply Kernel Variables.1658test # [ 7.105557] systemd[1]: Starting Network Name Resolution...1659test # [ 7.106902] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1660test # [ 7.109302] systemd[1]: Starting Create Static Device Nodes in /dev...1661test # [ 7.114169] systemd[1]: Finished Create Static Device Nodes in /dev.1662test # [ 7.115932] systemd[1]: Reached target Preparation for Local File Systems.1663test # [ 7.118180] systemd[1]: Starting Rule-based Manager for Device Events and Files...1664test # [ 7.120944] systemd-resolved[371]: Positive Trust Anchors:1665test # [ 7.126112] systemd-resolved[371]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1666test # [ 7.127837] systemd-resolved[371]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161667test # [ 7.129466] systemd-resolved[371]: 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 test1668test # [ 7.148838] systemd[1]: Finished Flush Journal to Persistent Storage.1669second # [ 7.337775] cfg80211: Loading compiled-in X.509 certificates for regulatory database1670test # [ 7.179694] systemd-udevd[383]: Using default interface naming scheme 'v261'.1671second # [ 7.357673] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1672second # [ 7.358677] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1673test # [ 7.197418] systemd[1]: Finished Coldplug All udev Devices.1674second # [ 7.196403] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1675second # [ 7.200914] systemd[1]: Finished Create SUID/SGID Wrappers.1676test # [ 7.211268] systemd-resolved[371]: Using system hostname 'test'.1677test # [ 7.217661] systemd[1]: Started Network Name Resolution.1678second # [ 7.226331] systemd-networkd[486]: /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.1679second # [ 7.230214] systemd-networkd[486]: /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.1680second # [ 7.234946] systemd-networkd[486]: lo: Link UP1681second # [ 7.236430] systemd-networkd[486]: lo: Gained carrier1682second # [ 7.247084] systemd[1]: Started Network Management.1683second # [ 7.252720] systemd-networkd[486]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1684second # [ 7.255845] systemd-networkd[486]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1685second # [ 7.262171] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1686second # [ 7.263450] systemd-networkd[486]: eth1: Link UP1687second # [ 7.264326] systemd-networkd[486]: eth1: Gained carrier1688second # [ 7.265283] systemd-networkd[486]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1689test # [ 7.281119] systemd[1]: Started Rule-based Manager for Device Events and Files.1690second # [ 7.456994] NET: Registered PF_PACKET protocol family1691second # [ 7.314170] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1692second # [ 7.501415] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31693second # [ 7.513590] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1694second # [ 7.524665] mousedev: PS/2 mouse device common for all mice1695second # [ 7.381572] systemd[1]: Finished register-nix-paths.service.1696second # [ 7.382917] systemd[1]: Reached target System Initialization.1697second # [ 7.385581] systemd[1]: Started Discard unused filesystem blocks once a week.1698second # [ 7.387268] systemd[1]: Started Daily Cleanup of Temporary Directories.1699second # [ 7.389395] systemd[1]: Reached target Timer Units.1700second # [ 7.390991] systemd[1]: Listening on D-Bus System Message Bus Socket.1701second # [ 7.392274] systemd[1]: Listening on Nix Daemon Socket.1702second # [ 7.397792] systemd[1]: Listening on Authorization Manager Agent Helper.1703second # [ 7.399000] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1704second # [ 7.400450] systemd[1]: Reached target Socket Units.1705second # [ 7.404491] systemd[1]: Starting D-Bus System Message Bus...1706test # [ 7.439618] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1707second # [ 7.450097] systemd-resolved[345]: Clock change detected. Flushing caches.1708second # [ 7.543614] ACPI: button: Power Button [PWRF]1709second # [ 7.609933] rtc_cmos 00:04: RTC can wake from S41710second # [ 7.621765] rtc_cmos 00:04: registered as rtc01711second # [ 7.476614] dbus-broker-launch[553]: Looking up NSS user entry for 'systemd-timesync'...1712second # [ 7.481153] dbus-broker-launch[553]: NSS returned no entry for 'systemd-timesync'1713second # [ 7.482680] dbus-broker-launch[553]: Invalid user-name in /nix/store/w10146x5br2zk655hnwq4nr9vn6nv24f-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1714second # [ 7.621859] rtc_cmos 00:04: setting system clock to 2026-09-02T05:02:22 UTC (1788325342)1715second # [ 7.621952] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1716second # [ 7.639606] parport_pc 00:02: reported by Plug and Play ACPI1717second # [ 7.639689] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1718second # [ 7.504163] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1719second # [ 7.507692] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1720second # [ 7.511351] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nhsrpbakhmswx0ykmkxj8q0ykm2ifjlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1721test # [ 7.516143] systemd[1]: Mounting /run/wrappers...1722second # [ 7.516544] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1723second # [ 7.519513] systemd[1]: Started D-Bus System Message Bus.1724second # [ 7.522069] systemd[1]: Reached target Basic System.1725test # [ 7.523493] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1726second # [ 7.525767] systemd[1]: Starting Network Manager Script Dispatcher Service...1727second # [ 7.529757] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1728second # [ 7.541073] systemd[1]: Starting Network Manager...1729test # [ 7.550093] systemd[1]: Mounted /run/wrappers.1730test # [ 7.551161] systemd[1]: Reached target Local File Systems.1731test # [ 7.555887] systemd[1]: Listening on Boot Loader Control Service Socket.1732second # [ 7.554469] systemd[1]: Started backdoor.service.1733test # [ 7.560294] systemd[1]: Starting register-nix-paths.service...1734second # [ 7.560261] dbus-broker-launch[553]: Ready1735test # [ 7.562872] systemd[1]: Starting Create SUID/SGID Wrappers...1736second # [ 7.643311] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41737test # [ 7.565039] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1738second # [ 7.644394] Console: switching to colour dummy device 80x251739second # [ 7.571404] systemd[1]: Starting Import lastlog data into lastlog2 database...1740test # [ 7.576091] systemd[1]: Starting Save Transient machine-id to Disk...1741second # [ 7.585205] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1742test # [ 7.599555] systemd[1]: Starting Create System Files and Directories...1743second # [ 7.608044] systemd[1]: Starting Post-Boot Actions...1744test # [ 7.619371] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1745second # [ 7.624202] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[557]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1746second # [ 7.633253] systemd[1]: Started Reset console on configuration changes.1747test # [ 7.644334] (udev-worker)[440]: Network interface NamePolicy= disabled on kernel command line.1748second # [ 7.697132] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1749second # [ 7.818081] [drm] Found bochs VGA, ID 0xb0c5.1750second # [ 7.818082] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1751test # [ 7.649435] (udev-worker)[442]: Network interface NamePolicy= disabled on kernel command line.1752second # [ 7.652613] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1753second # [ 7.676698] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1754test # [ 7.679681] systemd[1]: Finished Firewall.1755second # connecting to host...1756test # [ 7.683065] systemd[1]: Reached target Preparation for Network.1757test # [ 7.685129] systemd[1]: Listening on Network Management Resolve Hook Socket.1758test # [ 7.696357] systemd[1]: Starting Network Management...1759test # [ 7.698397] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1760second # [ 7.706335] systemd[1]: Finished Post-Boot Actions.1761test # [ 7.711378] systemd[1]: Finished Save Transient machine-id to Disk.1762second # [ 7.895199] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1763test # [ 7.732583] systemd[1]: Finished Create System Files and Directories.1764second # [ 7.730576] nsncd[561]: Sep 02 05:02:22.775 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1765second # [ 7.734410] systemd[1]: Started Name Service Cache Daemon (nsncd).1766test # [ 7.749963] systemd[1]: Starting Rebuild Journal Catalog...1767test # [ 7.755641] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1768second # [ 7.754707] systemd[1]: Reached target Host and Network Name Lookups.1769second # [ 7.755829] systemd[1]: Reached target User and Group Name Lookups.1770second # [ 7.768042] systemd[1]: Starting User Login Management...1771second # [ 7.943617] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01772second # [ 7.773259] systemd[1]: Finished Import lastlog data into lastlog2 database.1773second # [ 7.785222] systemd[1]: Started Network Manager Script Dispatcher Service.1774second # [ 7.964954] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1775second # [ 7.965756] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1776test # [ 7.836537] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1777second # [ 7.839906] systemd[1]: Starting Hostname Service...1778test # [ 7.873306] systemd[1]: Finished Rebuild Journal Catalog.1779test # [ 7.881460] systemd[1]: Starting Update is Completed...1780test # [ 7.936459] systemd[1]: Finished Update is Completed.1781second # [ 8.041820] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61782second # [ 8.042101] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51783test # [ 8.188526] cfg80211: Loading compiled-in X.509 certificates for regulatory database1784second # [ 8.084369] Console: switching to colour frame buffer device 160x501785test # [ 8.208657] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1786test # [ 8.209658] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1787second # [ 8.211612] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1788second # [ 7.939909] systemd[1]: Started Hostname Service.1789second # [ 8.044474] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1790second # [ 8.045880] systemd[1]: Starting Virtual Console Setup...1791second # [ 8.047862] systemd-networkd[486]: eth0: Link UP1792second # [ 8.049674] systemd-networkd[486]: eth0: Gained carrier1793second # [ 8.052138] systemd[1]: Started Network Manager.1794second # [ 8.052972] systemd[1]: Reached target Network.1795second # [ 8.057207] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1796second # [ 8.058769] systemd-logind[593]: New seat seat0.1797second # [ 8.062196] systemd-logind[593]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1798test # [ 8.066261] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1799second # [ 8.065723] systemd[1]: Starting Permit User Sessions...1800second # [ 8.067332] systemd[1]: Started User Login Management.1801test # [ 8.069993] systemd[1]: Finished Create SUID/SGID Wrappers.1802second # [ 8.072511] systemd-logind[593]: Watching system buttons on /dev/input/event2 (Power Button)1803test # [ 8.080330] systemd-networkd[506]: /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.1804test # [ 8.085531] systemd-networkd[506]: /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.1805test # [ 8.089903] systemd-networkd[506]: lo: Link UP1806second # [ 8.088843] systemd[1]: Starting linger-users.service...1807test # [ 8.091500] systemd-networkd[506]: lo: Gained carrier1808test # [ 8.100464] systemd[1]: Started Network Management.1809test # [ 8.107192] systemd-networkd[506]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1810test # [ 8.110558] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1811test # [ 8.112796] systemd-networkd[506]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1812test # [ 8.118675] systemd-networkd[506]: eth1: Link UP1813test # [ 8.119568] systemd-networkd[506]: eth1: Gained carrier1814test # [ 8.120507] systemd-networkd[506]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1815second # [ 8.130129] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1816test # [ 8.310219] NET: Registered PF_PACKET protocol family1817second # [ 8.138970] systemd[1]: Stopped Virtual Console Setup.1818second # [ 8.154375] systemd[1]: Finished Permit User Sessions.1819test # [ 8.167158] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1820second # [ 8.370047] ppdev: user-space parallel port driver1821second # [ 8.203899] systemd[1]: linger-users.service: Deactivated successfully.1822test # [ 8.377701] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1823second # [ 8.208181] systemd[1]: Finished linger-users.service.1824second # [ 8.228689] systemd[1]: Started Getty on tty1.1825second # [ 8.231668] systemd[1]: Reached target Login Prompts.1826test # [ 8.235628] systemd[1]: Finished register-nix-paths.service.1827test # [ 8.237443] systemd[1]: Reached target System Initialization.1828test # [ 8.240667] systemd[1]: Started Discard unused filesystem blocks once a week.1829test # [ 8.242169] systemd[1]: Started Daily Cleanup of Temporary Directories.1830test # [ 8.244169] systemd[1]: Reached target Timer Units.1831test # [ 8.245621] systemd[1]: Listening on D-Bus System Message Bus Socket.1832test # [ 8.246766] systemd[1]: Listening on Nix Daemon Socket.1833second # [ 8.246949] systemd[1]: Starting Virtual Console Setup...1834test # [ 8.250472] systemd[1]: Listening on Authorization Manager Agent Helper.1835test # [ 8.252274] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1836test # [ 8.254576] systemd[1]: Reached target Socket Units.1837test # [ 8.258432] systemd[1]: Starting D-Bus System Message Bus...1838second # [ 8.260127] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1839second # [ 8.263093] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1840second # [ 8.295891] systemd-logind[593]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1841second # [ 8.308569] systemd[1]: Reached target Multi-User System.1842second # [ 8.315134] systemd-resolved[345]: eth0: Bus client set default route setting: yes1843second # [ 8.319132] systemd-resolved[345]: eth0: Bus client set DNS server list to: 10.0.2.31844test # [ 8.324042] systemd-resolved[371]: Clock change detected. Flushing caches.1845second # [ 8.495951] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1846test # [ 8.386733] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31847test # [ 8.347291] dbus-broker-launch[579]: Looking up NSS user entry for 'systemd-timesync'...1848test # [ 8.349682] dbus-broker-launch[579]: NSS returned no entry for 'systemd-timesync'1849test # [ 8.353834] dbus-broker-launch[579]: Invalid user-name in /nix/store/w10146x5br2zk655hnwq4nr9vn6nv24f-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1850test # [ 8.359866] dbus-broker-launch[579]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1851test # [ 8.395127] ACPI: button: Power Button [PWRF]1852test # [ 8.409462] mousedev: PS/2 mouse device common for all mice1853second # [ 8.543297] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1854test # [ 8.372915] dbus-broker-launch[579]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1855second # [ 8.378220] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1856test # [ 8.378164] dbus-broker-launch[579]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nhsrpbakhmswx0ykmkxj8q0ykm2ifjlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1857second # [ 8.380518] systemd[1]: Stopped Virtual Console Setup.1858test # [ 8.382277] dbus-broker-launch[579]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1859test # [ 8.387485] systemd[1]: Started D-Bus System Message Bus.1860test # [ 8.388675] systemd[1]: Reached target Basic System.1861test # [ 8.390337] systemd[1]: Starting Network Manager Script Dispatcher Service...1862test # [ 8.394345] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1863test # [ 8.481820] rtc_cmos 00:04: RTC can wake from S41864test # [ 8.494115] rtc_cmos 00:04: registered as rtc01865test # [ 8.494208] rtc_cmos 00:04: setting system clock to 2026-09-02T05:02:22 UTC (1788325342)1866test # [ 8.400636] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1867test # [ 8.410384] dbus-broker-launch[579]: Ready1868test # [ 8.416728] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1869test # [ 8.435146] systemd[1]: Starting Network Manager...1870test # [ 8.442253] systemd[1]: Started backdoor.service.1871second # [ 8.632759] kvm_amd: TSC scaling supported1872second # [ 8.633265] kvm_amd: Nested Virtualization enabled1873second # [ 8.634163] kvm_amd: Nested Paging enabled1874second # [ 8.634885] kvm_amd: LBR virtualization supported1875second # [ 8.635444] kvm_amd: Virtual GIF supported1876second # [ 8.636214] kvm_amd: Virtual NMI enabled1877test # [ 8.470083] systemd[1]: Starting Import lastlog data into lastlog2 database...1878second # [ 8.481815] systemd[1]: Starting Virtual Console Setup...1879test # [ 8.483420] iif2wwqra6cyixya934jn1gzixwi7l6v-wifi-secrets[585]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1880test # [ 8.490264] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[583]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1881test # [ 8.495342] d1nj6zvw29gdp15fx855q5n4s3rj0h43-wifi-secrets[586]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1882test # [ 8.497843] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1883test # [ 8.494295] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1884test # [ 8.496180] systemd-journald[343]: Time jumped backwards, rotating.1885second # [ 8.683349] EDAC MC: Ver: 3.0.01886test # [ 8.525249] systemd[1]: Starting Post-Boot Actions...1887test # [ 8.535616] systemd[1]: Started Reset console on configuration changes.1888test # [ 8.555191] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1889test # [ 8.579395] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1890test # [ 8.506774] parport_pc 00:02: reported by Plug and Play ACPI1891test # [ 8.506859] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1892test # [ 8.593374] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1893test # [ 8.598974] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1894test # connecting to host...1895test # [ 8.605876] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1896test # [ 8.607528] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1897test # [ 8.627371] systemd[1]: Started Name Service Cache Daemon (nsncd).1898test # [ 8.628992] nsncd[597]: Sep 02 05:02:22.800 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1899test: Guest shell says: b'Spawning backdoor root shell...\n'1900test # [ 8.638268] systemd[1]: Finished Post-Boot Actions.1901test: connected to guest root shell1902test: (connecting took 9.30 seconds)1903test: (finished: waiting for the VM to finish booting, in 9.30 seconds)1904second # [ 8.647366] systemd-vconsole-setup[648]: Configuration of first virtual console was skipped, ignoring remaining ones.1905second # [ 8.651194] systemd[1]: Finished Virtual Console Setup.1906second # [ 8.656160] systemd[1]: Startup finished in 822ms (kernel) + 3.655s (initrd) + 4.177s (userspace) = 8.656s.1907test # [ 8.510247] Console: switching to colour dummy device 80x251908test # [ 8.656939] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1909test # [ 8.665838] systemd[1]: Started Network Manager Script Dispatcher Service.1910test # [ 8.667063] systemd[1]: Reached target Host and Network Name Lookups.1911test # [ 8.668173] systemd[1]: Reached target User and Group Name Lookups.1912test # [ 8.681092] systemd[1]: Starting User Login Management...1913test # [ 8.686240] systemd[1]: Finished Import lastlog data into lastlog2 database.1914test # [ 8.666106] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41915test # [ 8.892694] [drm] Found bochs VGA, ID 0xb0c5.1916test # [ 8.892696] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1917test # [ 8.922263] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1918test # [ 8.924809] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1919test # [ 8.931351] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1920test # [ 8.932176] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01921test # [ 8.766990] systemd[1]: Starting Hostname Service...1922test # [ 8.799595] systemd-logind[635]: New seat seat0.1923test # [ 8.804723] systemd[1]: Started User Login Management.1924test # [ 8.809161] systemd[1]: Starting linger-users.service...1925test # [ 9.004664] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61926test # [ 9.006341] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51927test # [ 8.866413] systemd[1]: linger-users.service: Deactivated successfully.1928test # [ 8.869739] systemd[1]: Finished linger-users.service.1929test # [ 8.873482] systemd[1]: Started Hostname Service.1930test # [ 9.088388] Console: switching to colour frame buffer device 160x501931test # [ 8.938833] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1932test # [ 8.942591] systemd-networkd[506]: eth0: Link UP1933test # [ 8.943584] systemd-networkd[506]: eth0: Gained carrier1934test # [ 9.130612] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1935test # [ 8.966633] systemd[1]: Started Network Manager.1936test # [ 8.967524] systemd[1]: Reached target Network.1937test # [ 8.974074] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1938test # [ 8.980077] systemd[1]: Starting Permit User Sessions...1939test # [ 9.010968] systemd[1]: Starting Virtual Console Setup...1940test # [ 9.058464] systemd-logind[635]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1941test # [ 9.088689] systemd-logind[635]: Watching system buttons on /dev/input/event2 (Power Button)1942test # [ 9.097275] systemd[1]: Finished Permit User Sessions.1943test # [ 9.114445] systemd[1]: Started Getty on tty1.1944test # [ 9.115463] systemd[1]: Reached target Login Prompts.1945test # [ 9.172131] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1946test # [ 9.173484] systemd[1]: Stopped Virtual Console Setup.1947test # [ 9.192180] systemd[1]: Starting Virtual Console Setup...1948test # [ 9.195298] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1949test # [ 9.202287] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1950test # [ 9.211670] systemd[1]: Reached target Multi-User System.1951test # [ 9.399036] ppdev: user-space parallel port driver1952second # [ 9.228976] systemd-networkd[486]: eth1: Gained IPv6LL1953test # [ 9.235427] systemd-resolved[371]: eth0: Bus client set default route setting: yes1954test # [ 9.240209] systemd-resolved[371]: eth0: Bus client set DNS server list to: 10.0.2.31955test # [ 9.435547] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1956test # [ 9.466118] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1957test # [ 9.314570] systemd-logind[635]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1958test # [ 9.368085] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1959test # [ 9.371399] systemd[1]: Stopped Virtual Console Setup.1960test # [ 9.378943] systemd[1]: Starting Virtual Console Setup...1961test # [ 9.603581] kvm_amd: TSC scaling supported1962test # [ 9.604175] kvm_amd: Nested Virtualization enabled1963test # [ 9.604740] kvm_amd: Nested Paging enabled1964test # [ 9.605673] kvm_amd: LBR virtualization supported1965test # [ 9.606427] kvm_amd: Virtual GIF supported1966test # [ 9.606899] kvm_amd: Virtual NMI enabled1967test # [ 9.638148] EDAC MC: Ver: 3.0.01968test # [ 9.482513] systemd-networkd[506]: eth1: Gained IPv6LL1969test # [ 9.564953] systemd-vconsole-setup[699]: Configuration of first virtual console was skipped, ignoring remaining ones.1970test # [ 9.568608] systemd[1]: Finished Virtual Console Setup.1971test # [ 9.572979] systemd[1]: Startup finished in 815ms (kernel) + 4.610s (initrd) + 4.146s (userspace) = 9.572s.1972second # [ 9.740759] systemd-networkd[486]: eth0: Gained IPv6LL1973test: (finished: waiting for unit NetworkManager.service, in 10.42 seconds)1974test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1975test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1976test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1977test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1978test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1979test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1980(finished: run the VM test script, in 10.55 seconds)1981test script finished in 10.56s1982cleanup1983kill QemuMachine (pid 47)1984second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1985kill QemuMachine (pid 48)1986test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1987(finished: cleanup, in 0.09 seconds)