vm-test-run-wifi
checks.x86_64-linux.wifi
· build #118
· 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: QEMU running (pid 47)14test # Disk image does not exist, creating the virtualisation disk image...15test # Formatting '/build/vm-state-test/tmp.OLCy8QGzCl', fmt=raw size=107374182416test # mke2fs 1.47.4 (6-Mar-2025)17test # Discarding device blocks: 0/262144 done18test # Creating filesystem with 262144 4k blocks and 65536 inodes19test # Filesystem UUID: 990f079d-897f-427c-873a-560d81df825120test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29second # Disk image does not exist, creating the virtualisation disk image...30second: QEMU running (pid 48)31second # Formatting '/build/vm-state-second/tmp.wyvAnmZ7Rq', fmt=raw size=107374182432second # mke2fs 1.47.4 (6-Mar-2025)33second # Discarding device blocks: 0/262144 done34second # Creating filesystem with 262144 4k blocks and 65536 inodes35second # Filesystem UUID: 00b6cb82-20e9-4e21-855e-747d1ebbaa1f36second # Superblock backups stored on blocks:37second # 32768, 98304, 163840, 22937638second # 39second # Allocating group tables: 0/8 done40second # Writing inode tables: 0/8 done41second # Creating journal (8192 blocks): done42second # Writing superblocks and filesystem accounting information: 0/8 done43second # 44second # Virtualisation disk image created.45(finished: start all VMs, in 0.08 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50test # 51test # 52test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0053second # 54second # 55test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...56test # 57test # 58test # 59test # 60second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0061test # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0062second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...63second # 64second # 65second # 66second # 67second # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0068test # Press Ctrl-B to configure iPXE (PCI 00:08.0)...69test # 70test # 71second # Press Ctrl-B to configure iPXE (PCI 00:08.0)...72second # 73second # 74second # Booting from ROM...75test # Booting from ROM...76test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 202677second # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 202678test # [ 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/wqq7ghkaln1q722v5pr9lzhq2jzvg43n-nixos-system-test-test/init regInfo=/nix/store/d588vsb6fi4labgps1vj2q446vzh3s6q-closure-info/registration console=ttyS0,115200n8 console=tty079second # [ 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/m2ql4j9layanqqvsg8zxfyhjdl0mz1mb-nixos-system-second-test/init regInfo=/nix/store/q72d553qhqg4y7nq3z3r4y4p8vwn2w79-closure-info/registration console=ttyS0,115200n8 console=tty080test # [ 0.000000] BIOS-provided physical RAM map:81second # [ 0.000000] BIOS-provided physical RAM map:82test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable83second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable84test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved85second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved86test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved87second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved88test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable89second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable90test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved91second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved92test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved93second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved94test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved95second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved96test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved97second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved98test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved99second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved100test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved101second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved102test # [ 0.000000] NX (Execute Disable) protection: active103second # [ 0.000000] NX (Execute Disable) protection: active104test # [ 0.000000] APIC: Static calls initialized105test # [ 0.000000] SMBIOS 2.8 present.106second # [ 0.000000] APIC: Static calls initialized107second # [ 0.000000] SMBIOS 2.8 present.108test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014109second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014110test # [ 0.000000] DMI: Memory slots populated: 1/1111second # [ 0.000000] DMI: Memory slots populated: 1/1112test # [ 0.000000] Hypervisor detected: KVM113second # [ 0.000000] Hypervisor detected: KVM114test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000115second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000116test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00117second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00118test # [ 0.000000] kvm-clock: using sched offset of 433419847 cycles119second # [ 0.000001] kvm-clock: using sched offset of 433076702 cycles120test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns121second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns122test # [ 0.000004] tsc: Detected 4192.120 MHz processor123second # [ 0.000004] tsc: Detected 4192.120 MHz processor124test # [ 0.000584] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000125second # [ 0.000584] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000126test # [ 0.000611] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs127second # [ 0.000611] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs128test # [ 0.000613] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT129second # [ 0.000613] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT130test # [ 0.002242] found SMP MP-table at [mem 0x000f5450-0x000f545f]131second # [ 0.002245] found SMP MP-table at [mem 0x000f5450-0x000f545f]132test # [ 0.002253] Using GB pages for direct mapping133second # [ 0.002256] Using GB pages for direct mapping134test # [ 0.002342] RAMDISK: [mem 0x3e36a000-0x3ffcffff]135second # [ 0.002315] RAMDISK: [mem 0x3e36b000-0x3ffcffff]136test # [ 0.002348] ACPI: Early table checksum verification disabled137second # [ 0.002320] ACPI: Early table checksum verification disabled138test # [ 0.002350] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )139second # [ 0.002323] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )140test # [ 0.002353] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)141second # [ 0.002326] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)142test # [ 0.002357] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)143second # [ 0.002329] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)144test # [ 0.002362] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)145second # [ 0.002334] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)146test # [ 0.002364] ACPI: FACS 0x000000003FFE0000 000040147second # [ 0.002336] ACPI: FACS 0x000000003FFE0000 000040148test # [ 0.002365] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)149second # [ 0.002337] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)150test # [ 0.002366] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)151second # [ 0.002338] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)152test # [ 0.002367] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)153second # [ 0.002339] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)154test # [ 0.002368] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)155second # [ 0.002340] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)156test # [ 0.002369] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]157second # [ 0.002341] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]158test # [ 0.002370] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]159second # [ 0.002342] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]160test # [ 0.002371] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]161second # [ 0.002342] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]162test # [ 0.002371] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]163second # [ 0.002343] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]164test # [ 0.002371] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]165second # [ 0.002343] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]166test # [ 0.002372] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]167second # [ 0.002343] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]168test # [ 0.002372] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]169test # [ 0.002715] No NUMA configuration found170second # [ 0.002344] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]171second # [ 0.002684] No NUMA configuration found172test # [ 0.002717] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]173second # [ 0.002685] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]174test # [ 0.002719] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]175test # [ 0.002785] Zone ranges:176second # [ 0.002688] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]177second # [ 0.002758] Zone ranges:178test # [ 0.002785] DMA [mem 0x0000000000001000-0x0000000000ffffff]179second # [ 0.002758] DMA [mem 0x0000000000001000-0x0000000000ffffff]180test # [ 0.002786] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]181test # [ 0.002787] Normal empty182second # [ 0.002759] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]183test # [ 0.002788] Device empty184second # [ 0.002760] Normal empty185test # [ 0.002788] Movable zone start for each node186second # [ 0.002761] Device empty187test # [ 0.002789] Early memory node ranges188second # [ 0.002761] Movable zone start for each node189second # [ 0.002762] Early memory node ranges190test # [ 0.002789] node 0: [mem 0x0000000000001000-0x000000000009efff]191second # [ 0.002762] node 0: [mem 0x0000000000001000-0x000000000009efff]192test # [ 0.002790] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]193second # [ 0.002763] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]194test # [ 0.002791] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]195test # [ 0.002807] On node 0, zone DMA: 1 pages in unavailable ranges196second # [ 0.002764] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]197test # [ 0.003004] On node 0, zone DMA: 97 pages in unavailable ranges198second # [ 0.002778] On node 0, zone DMA: 1 pages in unavailable ranges199test # [ 0.016258] On node 0, zone DMA32: 40 pages in unavailable ranges200second # [ 0.002970] On node 0, zone DMA: 97 pages in unavailable ranges201test # [ 0.017035] ACPI: PM-Timer IO Port: 0x608202second # [ 0.016104] On node 0, zone DMA32: 40 pages in unavailable ranges203test # [ 0.017045] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])204second # [ 0.016874] ACPI: PM-Timer IO Port: 0x608205second # [ 0.016884] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])206test # [ 0.017067] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23207second # [ 0.016904] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23208test # [ 0.017068] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)209second # [ 0.016906] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)210test # [ 0.017070] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)211second # [ 0.016908] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)212test # [ 0.017070] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)213second # [ 0.016908] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)214test # [ 0.017071] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)215second # [ 0.016909] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)216test # [ 0.017072] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)217test # [ 0.017073] ACPI: Using ACPI (MADT) for SMP configuration information218second # [ 0.016910] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)219test # [ 0.017074] ACPI: HPET id: 0x8086a201 base: 0xfed00000220second # [ 0.016912] ACPI: Using ACPI (MADT) for SMP configuration information221test # [ 0.017078] TSC deadline timer available222second # [ 0.016913] ACPI: HPET id: 0x8086a201 base: 0xfed00000223test # [ 0.017082] CPU topo: Max. logical packages: 1224second # [ 0.016916] TSC deadline timer available225test # [ 0.017082] CPU topo: Max. logical dies: 1226second # [ 0.016919] CPU topo: Max. logical packages: 1227test # [ 0.017083] CPU topo: Max. dies per package: 1228second # [ 0.016919] CPU topo: Max. logical dies: 1229test # [ 0.017085] CPU topo: Max. threads per core: 1230second # [ 0.016920] CPU topo: Max. dies per package: 1231test # [ 0.017086] CPU topo: Num. cores per package: 1232second # [ 0.016922] CPU topo: Max. threads per core: 1233test # [ 0.017086] CPU topo: Num. threads per package: 1234second # [ 0.016922] CPU topo: Num. cores per package: 1235test # [ 0.017086] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs236second # [ 0.016923] CPU topo: Num. threads per package: 1237test # [ 0.017101] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()238second # [ 0.016923] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs239second # [ 0.016935] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()240test # [ 0.017128] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]241second # [ 0.016962] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]242test # [ 0.017129] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]243test # [ 0.017130] [mem 0x40000000-0xafffffff] available for PCI devices244second # [ 0.016963] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]245test # [ 0.017131] Booting paravirtualized kernel on KVM246second # [ 0.016964] [mem 0x40000000-0xafffffff] available for PCI devices247second # [ 0.016965] Booting paravirtualized kernel on KVM248test # [ 0.017134] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns249test # [ 0.020333] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1250second # [ 0.016968] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns251test # [ 0.021921] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152252second # [ 0.020200] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1253test # [ 0.021952] kvm-guest: PV spinlocks disabled, single CPU254second # [ 0.022039] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152255second # [ 0.022069] kvm-guest: PV spinlocks disabled, single CPU256test # [ 0.021953] 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/wqq7ghkaln1q722v5pr9lzhq2jzvg43n-nixos-system-test-test/init regInfo=/nix/store/d588vsb6fi4labgps1vj2q446vzh3s6q-closure-info/registration console=ttyS0,115200n8 console=tty0257second # [ 0.022070] 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/m2ql4j9layanqqvsg8zxfyhjdl0mz1mb-nixos-system-second-test/init regInfo=/nix/store/q72d553qhqg4y7nq3z3r4y4p8vwn2w79-closure-info/registration console=ttyS0,115200n8 console=tty0258test # [ 0.022022] Unknown kernel command line parameters "regInfo=/nix/store/d588vsb6fi4labgps1vj2q446vzh3s6q-closure-info/registration", will be passed to user space.259test # [ 0.022211] random: crng init done260test # [ 0.022212] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes261second # [ 0.022139] Unknown kernel command line parameters "regInfo=/nix/store/q72d553qhqg4y7nq3z3r4y4p8vwn2w79-closure-info/registration", will be passed to user space.262second # [ 0.022329] random: crng init done263test # [ 0.022995] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)264second # [ 0.022330] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes265test # [ 0.023005] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)266second # [ 0.023108] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)267test # [ 0.023035] Fallback order for Node 0: 0268test # [ 0.023038] Built 1 zonelists, mobility grouping on. Total pages: 262006269second # [ 0.023117] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)270test # [ 0.023039] Policy zone: DMA32271second # [ 0.023141] Fallback order for Node 0: 0272test # [ 0.025055] mem auto-init: stack:all(zero), heap alloc:on, heap free:off273second # [ 0.023143] Built 1 zonelists, mobility grouping on. Total pages: 262006274second # [ 0.023144] Policy zone: DMA32275test # [ 0.027453] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1276test # [ 0.029088] allocated 2097152 bytes of page_ext277second # [ 0.024919] mem auto-init: stack:all(zero), heap alloc:on, heap free:off278test # [ 0.037867] ftrace: allocating 48732 entries in 192 pages279second # [ 0.027361] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1280test # [ 0.037868] ftrace: allocated 192 pages with 2 groups281second # [ 0.028996] allocated 2097152 bytes of page_ext282test # [ 0.038525] Dynamic Preempt: lazy283second # [ 0.037720] ftrace: allocating 48732 entries in 192 pages284test # [ 0.038642] rcu: Preemptible hierarchical RCU implementation.285second # [ 0.037721] ftrace: allocated 192 pages with 2 groups286test # [ 0.038643] rcu: RCU event tracing is enabled.287second # [ 0.038369] Dynamic Preempt: lazy288test # [ 0.038643] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.289second # [ 0.038491] rcu: Preemptible hierarchical RCU implementation.290test # [ 0.038644] Trampoline variant of Tasks RCU enabled.291second # [ 0.038492] rcu: RCU event tracing is enabled.292test # [ 0.038645] Rude variant of Tasks RCU enabled.293second # [ 0.038492] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.294test # [ 0.038645] Tracing variant of Tasks RCU enabled.295second # [ 0.038493] Trampoline variant of Tasks RCU enabled.296test # [ 0.038645] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.297second # [ 0.038494] Rude variant of Tasks RCU enabled.298second # [ 0.038494] Tracing variant of Tasks RCU enabled.299test # [ 0.038646] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1300second # [ 0.038495] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.301test # [ 0.038662] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.302second # [ 0.038495] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1303test # [ 0.038663] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.304second # [ 0.038507] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.305test # [ 0.038664] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.306second # [ 0.038508] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.307test # [ 0.041845] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16308second # [ 0.038508] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.309test # [ 0.042090] rcu: srcu_init: Setting srcu_struct sizes based on contention.310second # [ 0.041687] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16311test # [ 0.042096] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns312second # [ 0.042166] rcu: srcu_init: Setting srcu_struct sizes based on contention.313test # [ 0.042252] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)314second # [ 0.042170] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns315test # [ 0.047335] Console: colour VGA+ 80x25316test # [ 0.047338] printk: legacy console [tty0] enabled317second # [ 0.042325] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)318test # [ 0.077248] printk: legacy console [ttyS0] enabled319second # [ 0.047378] Console: colour VGA+ 80x25320test # [ 0.209688] ACPI: Core revision 20250807321second # [ 0.047381] printk: legacy console [tty0] enabled322second # [ 0.077320] printk: legacy console [ttyS0] enabled323test # [ 0.210761] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns324second # [ 0.211495] ACPI: Core revision 20250807325test # [ 0.212658] APIC: Switch to symmetric I/O mode setup326test # [ 0.213825] x2apic enabled327second # [ 0.212519] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns328second # [ 0.214424] APIC: Switch to symmetric I/O mode setup329test # [ 0.214627] APIC: Switched APIC routing to: physical x2apic330second # [ 0.215591] x2apic enabled331second # [ 0.216392] APIC: Switched APIC routing to: physical x2apic332test # [ 0.216605] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1333second # [ 0.218330] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1334test # [ 0.217829] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns335test # [ 0.219870] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)336second # [ 0.219534] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns337test # [ 0.220954] x86/cpu: User Mode Instruction Prevention (UMIP) activated338second # [ 0.221589] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)339test # [ 0.222974] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127340second # [ 0.222671] x86/cpu: User Mode Instruction Prevention (UMIP) activated341test # [ 0.223869] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0342second # [ 0.224700] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127343second # [ 0.225588] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0344test # [ 0.224872] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto345test # [ 0.226868] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl346second # [ 0.226590] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto347test # [ 0.228869] Spectre V2 : Mitigation: Enhanced / Automatic IBRS348second # [ 0.228588] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl349test # [ 0.229868] Speculative Return Stack Overflow: Mitigation: Safe RET350second # [ 0.230588] Spectre V2 : Mitigation: Enhanced / Automatic IBRS351test # [ 0.230868] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization352second # [ 0.231588] Speculative Return Stack Overflow: Mitigation: Safe RET353second # [ 0.232587] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization354test # [ 0.231873] Spectre V2 : Enabling IBPB for BPF355test # [ 0.233869] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier356second # [ 0.234593] Spectre V2 : Enabling IBPB for BPF357test # [ 0.234869] active return thunk: srso_alias_return_thunk358second # [ 0.236588] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier359test # [ 0.236737] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'360second # [ 0.237588] active return thunk: srso_alias_return_thunk361test # [ 0.237868] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'362second # [ 0.239455] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'363test # [ 0.238868] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'364second # [ 0.240587] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'365test # [ 0.239868] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'366second # [ 0.241587] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'367test # [ 0.241868] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'368second # [ 0.242587] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'369test # [ 0.242868] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'370second # [ 0.244587] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'371test # [ 0.243868] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'372second # [ 0.245587] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'373test # [ 0.245868] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'374second # [ 0.246587] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'375test # [ 0.246868] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'376second # [ 0.247587] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'377test # [ 0.248868] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256378second # [ 0.248587] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'379test # [ 0.249868] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64380second # [ 0.249588] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256381test # [ 0.250868] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512382second # [ 0.250587] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64383test # [ 0.252868] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024384second # [ 0.251587] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512385test # [ 0.253868] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8386second # [ 0.253587] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024387test # [ 0.254868] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16388second # [ 0.254587] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8389test # [ 0.255868] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24390second # [ 0.255587] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16391test # [ 0.257868] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.392second # [ 0.256587] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24393second # [ 0.257587] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.394test # [ 0.285275] Freeing SMP alternatives memory: 44K395test # [ 0.285870] pid_max: default: 32768 minimum: 301396second # [ 0.285883] Freeing SMP alternatives memory: 44K397test # [ 0.286940] LSM: initializing lsm=capability,landlock,yama,bpf,ima398second # [ 0.286589] pid_max: default: 32768 minimum: 301399test # [ 0.287953] landlock: Up and running.400test # [ 0.288868] Yama: becoming mindful.401second # [ 0.287652] LSM: initializing lsm=capability,landlock,yama,bpf,ima402test # [ 0.290056] LSM support for eBPF active403second # [ 0.288666] landlock: Up and running.404second # [ 0.289588] Yama: becoming mindful.405test # [ 0.290934] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)406second # [ 0.290767] LSM support for eBPF active407test # [ 0.291885] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)408second # [ 0.291663] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)409second # [ 0.292606] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)410test # [ 0.294914] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)411test # [ 0.296258] Performance Events: Fam17h+ core perfctr, AMD PMU driver.412second # [ 0.294341] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)413test # [ 0.296875] ... version: 2414test # [ 0.297748] ... bit width: 48415second # [ 0.294997] Performance Events: Fam17h+ core perfctr, AMD PMU driver.416test # [ 0.298564] ... generic counters: 6417second # [ 0.295590] ... version: 2418second # [ 0.296453] ... bit width: 48419test # [ 0.298870] ... generic bitmap: 000000000000003f420second # [ 0.297276] ... generic counters: 6421test # [ 0.299869] ... fixed-purpose counters: 0422second # [ 0.297597] ... generic bitmap: 000000000000003f423test # [ 0.300739] ... fixed-purpose bitmap: 0000000000000000424second # [ 0.298588] ... fixed-purpose counters: 0425test # [ 0.301751] ... value mask: 0000ffffffffffff426second # [ 0.299452] ... fixed-purpose bitmap: 0000000000000000427test # [ 0.302749] ... max period: 00007fffffffffff428second # [ 0.300461] ... value mask: 0000ffffffffffff429test # [ 0.303758] ... global_ctrl mask: 000000000000003f430second # [ 0.301464] ... max period: 00007fffffffffff431test # [ 0.304810] signal: max sigframe size: 3376432second # [ 0.302459] ... global_ctrl mask: 000000000000003f433test # [ 0.305601] rcu: Hierarchical SRCU implementation.434second # [ 0.303547] signal: max sigframe size: 3376435test # [ 0.305873] rcu: Max phase no-delay instances is 400.436second # [ 0.304321] rcu: Hierarchical SRCU implementation.437second # [ 0.304592] rcu: Max phase no-delay instances is 400.438test # [ 0.309999] smp: Bringing up secondary CPUs ...439test # [ 0.310880] smp: Brought up 1 node, 1 CPU440second # [ 0.308529] smp: Bringing up secondary CPUs ...441test # [ 0.311716] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)442second # [ 0.309323] smp: Brought up 1 node, 1 CPU443second # [ 0.309589] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)444test # [ 0.312983] Memory: 942992K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 97588K reserved, 0K cma-reserved)445test # [ 0.314015] devtmpfs: initialized446second # [ 0.310770] Memory: 943028K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 97580K reserved, 0K cma-reserved)447test # [ 0.314834] x86/mm: Memory block size: 128MB448second # [ 0.311751] devtmpfs: initialized449second # [ 0.312602] x86/mm: Memory block size: 128MB450test # [ 0.316282] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)451second # [ 0.314254] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)452test # [ 0.316890] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).453test # [ 0.317930] pinctrl core: initialized pinctrl subsystem454second # [ 0.314609] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).455test # [ 0.319104] PM: RTC time: 10:01:54, date: 2026-09-06456second # [ 0.315649] pinctrl core: initialized pinctrl subsystem457second # [ 0.316814] PM: RTC time: 10:01:54, date: 2026-09-06458test # [ 0.321819] NET: Registered PF_NETLINK/PF_ROUTE protocol family459test # [ 0.323079] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations460second # [ 0.319640] NET: Registered PF_NETLINK/PF_ROUTE protocol family461test # [ 0.323885] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations462second # [ 0.320853] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations463test # [ 0.324975] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations464second # [ 0.321604] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations465test # [ 0.325876] audit: initializing netlink subsys (disabled)466second # [ 0.322692] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations467test # [ 0.327077] thermal_sys: Registered thermal governor 'fair_share'468second # [ 0.323596] audit: initializing netlink subsys (disabled)469test # [ 0.327079] thermal_sys: Registered thermal governor 'bang_bang'470second # [ 0.324807] thermal_sys: Registered thermal governor 'fair_share'471test # [ 0.327870] thermal_sys: Registered thermal governor 'step_wise'472second # [ 0.324808] thermal_sys: Registered thermal governor 'bang_bang'473test # [ 0.328872] audit: type=2000 audit(1788688915.200:1): state=initialized audit_enabled=0 res=1474second # [ 0.325589] thermal_sys: Registered thermal governor 'step_wise'475test # [ 0.330871] thermal_sys: Registered thermal governor 'user_space'476second # [ 0.326591] audit: type=2000 audit(1788688915.196:1): state=initialized audit_enabled=0 res=1477test # [ 0.330872] thermal_sys: Registered thermal governor 'power_allocator'478second # [ 0.328590] thermal_sys: Registered thermal governor 'user_space'479test # [ 0.331881] cpuidle: using governor menu480second # [ 0.328591] thermal_sys: Registered thermal governor 'power_allocator'481second # [ 0.329600] cpuidle: using governor menu482test # [ 0.334484] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5483second # [ 0.332201] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5484test # [ 0.335073] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]485test # [ 0.335871] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry486second # [ 0.332784] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]487test # [ 0.336880] PCI: Using configuration type 1 for base access488second # [ 0.333590] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry489second # [ 0.334599] PCI: Using configuration type 1 for base access490test # [ 0.338017] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.491second # [ 0.335738] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.492test # [ 0.343066] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages493test # [ 0.343870] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page494second # [ 0.342779] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages495second # [ 0.343589] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page496test # [ 0.348869] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages497test # [ 0.349870] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page498second # [ 0.348588] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages499second # [ 0.349589] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page500test # [ 0.359269] ACPI: Added _OSI(Module Device)501test # [ 0.359870] ACPI: Added _OSI(Processor Device)502second # [ 0.356852] ACPI: Added _OSI(Module Device)503test # [ 0.360782] ACPI: Added _OSI(Processor Aggregator Device)504second # [ 0.357589] ACPI: Added _OSI(Processor Device)505second # [ 0.358502] ACPI: Added _OSI(Processor Aggregator Device)506test # [ 0.365681] ACPI: 1 ACPI AML tables successfully acquired and loaded507second # [ 0.363384] ACPI: 1 ACPI AML tables successfully acquired and loaded508test # [ 0.372176] ACPI: Interpreter enabled509second # [ 0.369372] ACPI: Interpreter enabled510test # [ 0.372882] ACPI: PM: (supports S0 S3 S4 S5)511second # [ 0.369602] ACPI: PM: (supports S0 S3 S4 S5)512test # [ 0.373758] ACPI: Using IOAPIC for interrupt routing513second # [ 0.370481] ACPI: Using IOAPIC for interrupt routing514test # [ 0.374883] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug515second # [ 0.371407] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug516test # [ 0.375870] PCI: Using E820 reservations for host bridge windows517test # [ 0.376978] ACPI: Enabled 2 GPEs in block 00 to 3F518second # [ 0.373352] PCI: Using E820 reservations for host bridge windows519second # [ 0.373707] ACPI: Enabled 2 GPEs in block 00 to 3F520test # [ 0.381003] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])521test # [ 0.381874] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]522second # [ 0.377885] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])523test # [ 0.382938] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]524second # [ 0.378595] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]525test # [ 0.383963] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]526second # [ 0.379658] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]527test # [ 0.385253] PCI host bridge to bus 0000:00528second # [ 0.380703] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]529test # [ 0.385874] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]530second # [ 0.382012] PCI host bridge to bus 0000:00531test # [ 0.386870] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]532second # [ 0.382595] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]533test # [ 0.387870] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]534second # [ 0.383591] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]535test # [ 0.388870] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]536second # [ 0.384590] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]537test # [ 0.389870] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]538second # [ 0.385590] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]539test # [ 0.390870] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]540test # [ 0.391871] pci_bus 0000:00: root bus resource [bus 00-ff]541second # [ 0.386591] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]542second # [ 0.387590] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]543test # [ 0.392990] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint544second # [ 0.388590] pci_bus 0000:00: root bus resource [bus 00-ff]545test # [ 0.394507] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint546second # [ 0.389713] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint547second # [ 0.391240] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint548test # [ 0.396866] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]549test # [ 0.397890] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]550test # [ 0.398975] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]551second # [ 0.393585] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]552second # [ 0.394609] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]553test # [ 0.400188] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]554second # [ 0.395627] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]555test # [ 0.401591] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint556second # [ 0.396756] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]557test # [ 0.403880] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]558second # [ 0.398308] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint559test # [ 0.404880] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]560test # [ 0.405908] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]561second # [ 0.400650] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]562test # [ 0.406880] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]563second # [ 0.401631] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]564second # [ 0.402627] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]565test # [ 0.408730] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint566second # [ 0.403599] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]567test # [ 0.411479] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]568second # [ 0.405576] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint569test # [ 0.411880] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]570test # [ 0.412908] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]571second # [ 0.407599] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]572second # [ 0.408599] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]573test # [ 0.414733] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint574second # [ 0.409627] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]575test # [ 0.416880] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]576second # [ 0.411459] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint577test # [ 0.417880] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]578test # [ 0.418912] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]579second # [ 0.414535] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]580test # [ 0.420726] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint581second # [ 0.415599] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]582second # [ 0.416627] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]583test # [ 0.422881] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]584test # [ 0.423888] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]585second # [ 0.418460] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint586test # [ 0.424910] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]587second # [ 0.420599] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]588second # [ 0.421599] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]589test # [ 0.426967] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint590second # [ 0.422627] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]591test # [ 0.428880] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]592test # [ 0.429882] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]593second # [ 0.424463] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint594test # [ 0.430913] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]595second # [ 0.426599] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]596test # [ 0.432730] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint597second # [ 0.427599] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]598second # [ 0.428627] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]599test # [ 0.435205] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]600test # [ 0.435883] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]601second # [ 0.430442] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint602test # [ 0.436915] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]603second # [ 0.432599] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]604test # [ 0.438767] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint605second # [ 0.433599] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]606second # [ 0.434626] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]607test # [ 0.440880] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]608test # [ 0.441882] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]609second # [ 0.436478] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint610test # [ 0.442910] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]611test # [ 0.443883] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]612second # [ 0.438599] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]613test # [ 0.445708] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint614second # [ 0.439599] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]615second # [ 0.440626] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]616test # [ 0.447645] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]617second # [ 0.441599] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]618test # [ 0.447910] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]619second # [ 0.443430] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint620test # [ 0.449719] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint621second # [ 0.445589] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]622test # [ 0.451880] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]623second # [ 0.446626] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]624test # [ 0.452882] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]625test # [ 0.453910] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]626second # [ 0.448426] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint627test # [ 0.455697] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint628second # [ 0.450599] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]629second # [ 0.451599] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]630test # [ 0.457880] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]631second # [ 0.452626] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]632test # [ 0.458880] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]633test # [ 0.459910] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]634second # [ 0.454437] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint635second # [ 0.456599] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]636second # [ 0.457599] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]637second # [ 0.458626] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]638test # [ 0.461746] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint639test # [ 0.463792] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]640test # [ 0.465014] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint641second # [ 0.460461] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint642test # [ 0.466776] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]643second # [ 0.462302] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]644test # [ 0.468020] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint645second # [ 0.462829] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint646test # [ 0.469782] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]647second # [ 0.464269] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]648test # [ 0.471049] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint649second # [ 0.465058] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint650test # [ 0.472499] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]651second # [ 0.466289] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]652test # [ 0.473209] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint653second # [ 0.466868] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint654test # [ 0.474342] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO655second # [ 0.468223] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]656test # [ 0.475196] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint657second # [ 0.468901] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint658test # [ 0.476922] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]659second # [ 0.470047] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO660test # [ 0.477882] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]661second # [ 0.470913] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint662test # [ 0.479390] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint663second # [ 0.472552] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]664second # [ 0.473441] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]665test # [ 0.480675] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]666second # [ 0.474998] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint667second # [ 0.476271] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]668test # [ 0.486548] ACPI: PCI: Interrupt link LNKA configured for IRQ 10669test # [ 0.486986] ACPI: PCI: Interrupt link LNKB configured for IRQ 10670test # [ 0.487980] ACPI: PCI: Interrupt link LNKC configured for IRQ 11671second # [ 0.481283] ACPI: PCI: Interrupt link LNKA configured for IRQ 10672test # [ 0.488995] ACPI: PCI: Interrupt link LNKD configured for IRQ 11673second # [ 0.481703] ACPI: PCI: Interrupt link LNKB configured for IRQ 10674test # [ 0.490005] ACPI: PCI: Interrupt link LNKE configured for IRQ 10675second # [ 0.482702] ACPI: PCI: Interrupt link LNKC configured for IRQ 11676test # [ 0.490994] ACPI: PCI: Interrupt link LNKF configured for IRQ 10677second # [ 0.483704] ACPI: PCI: Interrupt link LNKD configured for IRQ 11678test # [ 0.491997] ACPI: PCI: Interrupt link LNKG configured for IRQ 11679second # [ 0.484701] ACPI: PCI: Interrupt link LNKE configured for IRQ 10680test # [ 0.492996] ACPI: PCI: Interrupt link LNKH configured for IRQ 11681second # [ 0.485708] ACPI: PCI: Interrupt link LNKF configured for IRQ 10682test # [ 0.493923] ACPI: PCI: Interrupt link GSIA configured for IRQ 16683second # [ 0.486709] ACPI: PCI: Interrupt link LNKG configured for IRQ 11684test # [ 0.494890] ACPI: PCI: Interrupt link GSIB configured for IRQ 17685second # [ 0.487698] ACPI: PCI: Interrupt link LNKH configured for IRQ 11686test # [ 0.495885] ACPI: PCI: Interrupt link GSIC configured for IRQ 18687second # [ 0.488634] ACPI: PCI: Interrupt link GSIA configured for IRQ 16688test # [ 0.496885] ACPI: PCI: Interrupt link GSID configured for IRQ 19689second # [ 0.489605] ACPI: PCI: Interrupt link GSIB configured for IRQ 17690test # [ 0.497885] ACPI: PCI: Interrupt link GSIE configured for IRQ 20691second # [ 0.490604] ACPI: PCI: Interrupt link GSIC configured for IRQ 18692test # [ 0.498885] ACPI: PCI: Interrupt link GSIF configured for IRQ 21693second # [ 0.491604] ACPI: PCI: Interrupt link GSID configured for IRQ 19694second # [ 0.492601] ACPI: PCI: Interrupt link GSIE configured for IRQ 20695test # [ 0.499891] ACPI: PCI: Interrupt link GSIG configured for IRQ 22696second # [ 0.493601] ACPI: PCI: Interrupt link GSIF configured for IRQ 21697test # [ 0.500888] ACPI: PCI: Interrupt link GSIH configured for IRQ 23698second # [ 0.494605] ACPI: PCI: Interrupt link GSIG configured for IRQ 22699test # [ 0.502792] iommu: Default domain type: Translated700second # [ 0.495601] ACPI: PCI: Interrupt link GSIH configured for IRQ 23701test # [ 0.503721] iommu: DMA domain TLB invalidation policy: lazy mode702second # [ 0.497426] iommu: Default domain type: Translated703test # [ 0.505093] ACPI: bus type USB registered704second # [ 0.498353] iommu: DMA domain TLB invalidation policy: lazy mode705test # [ 0.505930] usbcore: registered new interface driver usbfs706second # [ 0.498809] ACPI: bus type USB registered707test # [ 0.506889] usbcore: registered new interface driver hub708second # [ 0.499646] usbcore: registered new interface driver usbfs709test # [ 0.507891] usbcore: registered new device driver usb710second # [ 0.500606] usbcore: registered new interface driver hub711test # [ 0.509615] NetLabel: Initializing712second # [ 0.501611] usbcore: registered new device driver usb713test # [ 0.509875] NetLabel: domain hash size = 128714second # [ 0.503217] NetLabel: Initializing715test # [ 0.510781] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO716second # [ 0.503593] NetLabel: domain hash size = 128717second # [ 0.504469] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO718test # [ 0.511900] NetLabel: unlabeled traffic allowed by default719test # [ 0.512883] PCI: Using ACPI for IRQ routing720second # [ 0.505506] NetLabel: unlabeled traffic allowed by default721second # [ 0.506507] PCI: Using ACPI for IRQ routing722test # [ 0.587609] pci 0000:00:01.0: vgaarb: setting as boot VGA device723second # [ 0.580613] pci 0000:00:01.0: vgaarb: setting as boot VGA device724test # [ 0.587866] pci 0000:00:01.0: vgaarb: bridge control possible725second # [ 0.581585] pci 0000:00:01.0: vgaarb: bridge control possible726test # [ 0.587866] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none727test # [ 0.587878] vgaarb: loaded728second # [ 0.581585] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none729second # [ 0.581591] vgaarb: loaded730test # [ 0.588653] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0731second # [ 0.582366] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0732test # [ 0.589637] hpet0: 3 comparators, 64-bit 100.000000 MHz counter733second # [ 0.582590] hpet0: 3 comparators, 64-bit 100.000000 MHz counter734test # [ 0.592926] clocksource: Switched to clocksource kvm-clock735test # [ 0.594585] VFS: Disk quotas dquot_6.6.0736second # [ 0.588650] clocksource: Switched to clocksource kvm-clock737test # [ 0.596745] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)738second # [ 0.590401] VFS: Disk quotas dquot_6.6.0739test # [ 0.598247] pnp: PnP ACPI init740test # [ 0.599117] ACPI: IRQ 4 override to edge(!), high(!)741second # [ 0.592602] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)742test # [ 0.600229] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved743second # [ 0.594100] pnp: PnP ACPI init744test # [ 0.601997] pnp: PnP ACPI: found 6 devices745second # [ 0.594940] ACPI: IRQ 4 override to edge(!), high(!)746second # [ 0.596040] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved747second # [ 0.597772] pnp: PnP ACPI: found 6 devices748test # [ 0.609065] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns749test # [ 0.610799] clocksource: Switched to clocksource acpi_pm750test # [ 0.611943] NET: Registered PF_INET protocol family751second # [ 0.604822] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns752test # [ 0.613083] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)753second # [ 0.606523] clocksource: Switched to clocksource acpi_pm754second # [ 0.607644] NET: Registered PF_INET protocol family755second # [ 0.608773] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)756test # [ 0.625895] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)757test # [ 0.627603] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)758second # [ 0.621714] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)759test # [ 0.629171] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)760second # [ 0.623471] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)761test # [ 0.630717] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)762test # [ 0.632198] TCP: Hash tables configured (established 8192 bind 8192)763second # [ 0.624996] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)764second # [ 0.626531] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)765test # [ 0.633497] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)766second # [ 0.627980] TCP: Hash tables configured (established 8192 bind 8192)767test # [ 0.635039] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)768test # [ 0.636353] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)769second # [ 0.629266] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)770test # [ 0.637814] NET: Registered PF_UNIX/PF_LOCAL protocol family771second # [ 0.630770] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)772test # [ 0.638955] NET: Registered PF_XDP protocol family773second # [ 0.632085] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)774test # [ 0.639958] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]775second # [ 0.633496] NET: Registered PF_UNIX/PF_LOCAL protocol family776test # [ 0.641178] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]777second # [ 0.634645] NET: Registered PF_XDP protocol family778test # [ 0.642388] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]779second # [ 0.635642] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]780second # [ 0.636857] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]781test # [ 0.643723] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]782second # [ 0.638065] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]783test # [ 0.645084] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]784second # [ 0.639386] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]785test # [ 0.646410] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]786second # [ 0.640736] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]787test # [ 0.648293] ACPI: \_SB_.GSIA: Enabled at IRQ 16788second # [ 0.642068] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]789test # [ 0.650164] ACPI: \_SB_.GSIB: Enabled at IRQ 17790second # [ 0.643950] ACPI: \_SB_.GSIA: Enabled at IRQ 16791test # [ 0.651986] ACPI: \_SB_.GSIC: Enabled at IRQ 18792second # [ 0.645860] ACPI: \_SB_.GSIB: Enabled at IRQ 17793test # [ 0.653823] ACPI: \_SB_.GSID: Enabled at IRQ 19794second # [ 0.647662] ACPI: \_SB_.GSIC: Enabled at IRQ 18795test # [ 0.655414] PCI: CLS 0 bytes, default 64796second # [ 0.649491] ACPI: \_SB_.GSID: Enabled at IRQ 19797test # [ 0.656416] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns798second # [ 0.651091] PCI: CLS 0 bytes, default 64799test # [ 0.658409] Trying to unpack rootfs image as initramfs...800second # [ 0.652096] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns801second # [ 0.654086] Trying to unpack rootfs image as initramfs...802test # [ 0.693115] Initialise system trusted keyrings803second # [ 0.686735] Initialise system trusted keyrings804test # [ 0.694204] workingset: timestamp_bits=40 max_order=18 bucket_order=0805second # [ 0.689495] workingset: timestamp_bits=40 max_order=18 bucket_order=0806test # [ 0.711101] Key type asymmetric registered807second # [ 0.705668] Key type asymmetric registered808test # [ 0.713824] Asymmetric key parser 'x509' registered809test # [ 0.714876] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)810second # [ 0.708454] Asymmetric key parser 'x509' registered811second # [ 0.709473] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)812test # [ 0.720948] io scheduler mq-deadline registered813second # [ 0.714608] io scheduler mq-deadline registered814test # [ 0.721928] io scheduler kyber registered815second # [ 0.717473] io scheduler kyber registered816test # [ 0.725277] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled817second # [ 0.718824] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled818second # [ 0.720337] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A819test # [ 0.728824] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A820test # [ 0.733937] Linux agpgart interface v0.103821second # [ 0.727259] Linux agpgart interface v0.103822test # [ 0.734873] ACPI: bus type drm_connector registered823second # [ 0.728181] ACPI: bus type drm_connector registered824test # [ 0.738138] usbcore: registered new interface driver usbserial_generic825test # [ 0.739432] usbserial: USB Serial support registered for generic826second # [ 0.732789] usbcore: registered new interface driver usbserial_generic827second # [ 0.734084] usbserial: USB Serial support registered for generic828test # [ 0.743816] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.829second # [ 0.737462] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.830test # [ 0.743816] Please enable it if your BIOS has the CPPC option.831second # [ 0.737462] Please enable it if your BIOS has the CPPC option.832test # [ 0.746437] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled833second # [ 0.740084] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled834test # [ 0.750915] drop_monitor: Initializing network drop monitor service835test # [ 0.752263] NET: Registered PF_INET6 protocol family836second # [ 0.745535] drop_monitor: Initializing network drop monitor service837second # [ 0.746882] NET: Registered PF_INET6 protocol family838test # [ 0.756173] Segment Routing with IPv6839second # [ 0.749822] Segment Routing with IPv6840second # [ 0.752472] In-situ OAM (IOAM) with IPv6841test # [ 0.759828] In-situ OAM (IOAM) with IPv6842second # [ 0.753601] IPI shorthand broadcast: enabled843test # [ 0.760949] IPI shorthand broadcast: enabled844second # [ 0.758855] sched_clock: Marking stable (584020497, 174415828)->(843258133, -84821808)845test # [ 0.766203] sched_clock: Marking stable (593027769, 172770622)->(843873868, -78075477)846second # [ 0.764605] registered taskstats version 1847test # [ 0.772036] registered taskstats version 1848second # [ 0.765627] Loading compiled-in X.509 certificates849test # [ 0.773069] Loading compiled-in X.509 certificates850second # [ 0.779451] Demotion targets for Node 0: null851test # [ 0.786811] Demotion targets for Node 0: null852second # [ 0.781478] Key type .fscrypt registered853second # [ 0.782285] Key type fscrypt-provisioning registered854test # [ 0.789846] Key type .fscrypt registered855test # [ 0.790657] Key type fscrypt-provisioning registered856test # [ 0.791759] ima: No TPM chip found, activating TPM-bypass!857second # [ 0.785532] ima: No TPM chip found, activating TPM-bypass!858second # [ 0.786640] ima: Allocated hash algorithm: sha1859test # [ 0.794932] ima: Allocated hash algorithm: sha1860second # [ 0.788465] ima: No architecture policies found861test # [ 0.795899] ima: No architecture policies found862second # [ 0.791451] PM: Magic number: 10:489:21863test # [ 0.798964] PM: Magic number: 10:489:21864second # [ 0.792296] pci 0000:00:09.0: hash matches865test # [ 0.799848] pci 0000:00:09.0: hash matches866second # [ 0.795873] RAS: Correctable Errors collector initialized.867test # [ 0.803362] RAS: Correctable Errors collector initialized.868second # [ 0.803606] clk: Disabling unused clocks869test # [ 0.811080] clk: Disabling unused clocks870second # [ 0.804442] PM: genpd: Disabling unused power domains871test # [ 0.811926] PM: genpd: Disabling unused power domains872test # [ 0.908869] Freeing initrd memory: 29080K873second # [ 0.904222] Freeing initrd memory: 29076K874test # [ 0.911775] Freeing unused decrypted memory: 2028K875second # [ 0.906987] Freeing unused decrypted memory: 2028K876test # [ 0.914281] Freeing unused kernel image (initmem) memory: 3644K877test # [ 0.915535] Write protecting the kernel read-only data: 32768k878second # [ 0.909478] Freeing unused kernel image (initmem) memory: 3644K879test # [ 0.917420] Freeing unused kernel image (text/rodata gap) memory: 1216K880second # [ 0.910733] Write protecting the kernel read-only data: 32768k881test # [ 0.919109] Freeing unused kernel image (rodata/data gap) memory: 752K882second # [ 0.912627] Freeing unused kernel image (text/rodata gap) memory: 1216K883second # [ 0.914277] Freeing unused kernel image (rodata/data gap) memory: 752K884test # [ 0.951051] x86/mm: Checked W+X mappings: passed, no W+X pages found.885test # [ 0.952340] Run /init as init process886second # [ 0.946206] x86/mm: Checked W+X mappings: passed, no W+X pages found.887second # [ 0.947513] Run /init as init process888test # [ 0.960182] systemd[1]: Inserted module 'autofs4'889second # [ 0.955338] systemd[1]: Inserted module 'autofs4'890test # [ 0.972260] fuse: init (API version 7.45)891second # [ 0.967370] fuse: init (API version 7.45)892test # [ 0.976728] ACPI: \_SB_.GSIG: Enabled at IRQ 22893second # [ 0.971876] ACPI: \_SB_.GSIG: Enabled at IRQ 22894test # [ 0.979201] ACPI: \_SB_.GSIH: Enabled at IRQ 23895second # [ 0.974314] ACPI: \_SB_.GSIH: Enabled at IRQ 23896test # [ 0.982319] ACPI: \_SB_.GSIE: Enabled at IRQ 20897second # [ 0.977402] ACPI: \_SB_.GSIE: Enabled at IRQ 20898test # [ 0.984733] ACPI: \_SB_.GSIF: Enabled at IRQ 21899second # [ 0.979930] ACPI: \_SB_.GSIF: Enabled at IRQ 21900test # [ 1.008077] systemd[1]: Successfully made /usr/ read-only.901second # [ 1.003687] systemd[1]: Successfully made /usr/ read-only.902test # [ 1.343892] 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)903test # [ 1.349640] systemd[1]: Detected virtualization kvm.904test # [ 1.350703] systemd[1]: Detected architecture x86-64.905second # [ 1.339480] 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)906test # [ 1.351826] systemd[1]: Running in initrd.907second # [ 1.345565] systemd[1]: Detected virtualization kvm.908test # [ 1.352991] systemd[1]: Initializing machine ID from random generator.909second # [ 1.346626] systemd[1]: Detected architecture x86-64.910test # [ 1.354382] systemd[1]: Hostname set to <test>.911second # [ 1.347699] systemd[1]: Running in initrd.912second # [ 1.348847] systemd[1]: Initializing machine ID from random generator.913second # [ 1.350228] systemd[1]: Hostname set to <second>.914test # [ 1.527369] systemd[1]: bpf-restrict-fs: LSM BPF program attached915second # [ 1.521027] systemd[1]: bpf-restrict-fs: LSM BPF program attached916test # [ 1.555846] systemd[1]: Queued start job for default target Initrd Default Target.917second # [ 1.549495] systemd[1]: Queued start job for default target Initrd Default Target.918test # [ 1.558871] systemd[1]: Created slice Slice /system/modprobe.919second # [ 1.552519] systemd[1]: Created slice Slice /system/modprobe.920test # [ 1.560233] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.921second # [ 1.553887] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.922test # [ 1.561869] systemd[1]: Expecting device /dev/disk/by-label/nixos...923second # [ 1.555500] systemd[1]: Expecting device /dev/disk/by-label/nixos...924test # [ 1.563259] systemd[1]: Reached target Path Units.925second # [ 1.556815] systemd[1]: Reached target Path Units.926test # [ 1.564411] systemd[1]: Reached target Slice Units.927second # [ 1.557864] systemd[1]: Reached target Slice Units.928test # [ 1.565478] systemd[1]: Reached target Swaps.929second # [ 1.558922] systemd[1]: Reached target Swaps.930test # [ 1.566444] systemd[1]: Reached target Timer Units.931second # [ 1.559887] systemd[1]: Reached target Timer Units.932test # [ 1.567569] systemd[1]: Listening on D-Bus System Message Bus Socket.933second # [ 1.561040] systemd[1]: Listening on D-Bus System Message Bus Socket.934test # [ 1.569018] systemd[1]: Listening on Journal Socket (/dev/log).935second # [ 1.562480] systemd[1]: Listening on Journal Socket (/dev/log).936test # [ 1.570369] systemd[1]: Listening on Journal Sockets.937second # [ 1.563833] systemd[1]: Listening on Journal Sockets.938test # [ 1.571541] systemd[1]: Listening on udev Control Socket.939second # [ 1.564988] systemd[1]: Listening on udev Control Socket.940test # [ 1.572764] systemd[1]: Listening on udev Kernel Socket.941second # [ 1.566188] systemd[1]: Listening on udev Kernel Socket.942test # [ 1.573920] systemd[1]: Reached target Socket Units.943second # [ 1.567325] systemd[1]: Reached target Socket Units.944test # [ 1.583413] systemd[1]: Starting Create List of Static Device Nodes...945second # [ 1.576815] systemd[1]: Starting Create List of Static Device Nodes...946second # [ 1.580840] systemd[1]: Starting Load Kernel Module 9pnet_virtio...947test # [ 1.589961] systemd[1]: Starting Load Kernel Module 9pnet_virtio...948second # [ 1.588093] systemd[1]: Starting Load Kernel Module configfs...949test # [ 1.595884] systemd[1]: Starting Load Kernel Module configfs...950test # [ 1.604302] systemd[1]: Starting Journal Service...951second # [ 1.600691] systemd[1]: Starting Journal Service...952test # [ 1.613850] systemd[1]: Starting Load Kernel Modules...953second # [ 1.609492] systemd[1]: Starting Load Kernel Modules...954second # [ 1.611513] netfs: FS-Cache loaded955test # [ 1.617878] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os956second # [ 1.613610] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os957test # [ 1.623564] netfs: FS-Cache loaded958second # [ 1.618252] 9pnet: Installing 9P2000 support959test # [ 1.626339] systemd[1]: Starting Coldplug All udev Devices...960second # [ 1.621106] systemd[1]: Starting Coldplug All udev Devices...961test # [ 1.641915] systemd[1]: Finished Create List of Static Device Nodes.962test # [ 1.643341] 9pnet: Installing 9P2000 support963second # [ 1.637481] systemd[1]: Finished Create List of Static Device Nodes.964second # [ 1.643022] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.965test # [ 1.652412] systemd[1]: modprobe@configfs.service: Deactivated successfully.966second # [ 1.647203] systemd-journald[67]: Collecting audit messages is disabled.967test # [ 1.655904] systemd-journald[67]: Collecting audit messages is disabled.968second # [ 1.652886] systemd[1]: Finished Load Kernel Module 9pnet_virtio.969test # [ 1.662349] systemd[1]: Finished Load Kernel Module configfs.970second # [ 1.658854] systemd[1]: modprobe@configfs.service: Deactivated successfully.971test # [ 1.667828] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.972second # [ 1.661236] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.973test # [ 1.672293] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config974second # [ 1.667851] systemd[1]: Finished Load Kernel Module configfs.975second # [ 1.671976] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config976test # [ 1.679957] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...977second # [ 1.674223] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev978test # [ 1.683038] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev979second # [ 1.684498] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...980test # [ 1.696096] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.981test # [ 1.705862] systemd[1]: Finished Load Kernel Module 9pnet_virtio.982second # [ 1.699510] systemd[1]: Finished Load Kernel Modules.983second # [ 1.707583] systemd[1]: Starting Apply Kernel Variables...984test # [ 1.715916] systemd[1]: Finished Load Kernel Modules.985test # [ 1.718923] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.986second # [ 1.720570] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.987test # [ 1.727947] systemd[1]: Starting Apply Kernel Variables...988second # [ 1.729346] systemd[1]: Starting Create Static Device Nodes in /dev...989test # [ 1.738851] systemd[1]: Starting Create Static Device Nodes in /dev...990second # [ 1.739577] systemd[1]: Finished Apply Kernel Variables.991test # [ 1.753208] systemd[1]: Finished Apply Kernel Variables.992second # [ 1.753044] systemd[1]: Finished Create Static Device Nodes in /dev.993second # [ 1.757689] systemd[1]: Reached target Preparation for Local File Systems.994test # [ 1.766855] systemd[1]: Finished Create Static Device Nodes in /dev.995second # [ 1.762512] systemd[1]: Reached target Local File Systems.996test # [ 1.771022] systemd[1]: Reached target Preparation for Local File Systems.997second # [ 1.767496] systemd[1]: Starting Rule-based Manager for Device Events and Files...998test # [ 1.774868] systemd[1]: Reached target Local File Systems.999test # [ 1.780945] systemd[1]: Starting Rule-based Manager for Device Events and Files...1000second # [ 1.605535] systemd-modules-load[68]: Inserted module 'dm_mod'[ 1.781198] systemd[1]: Started Journal Service.1001second # 1002second # [ 1.607920] systemd-modules-load[68]: Inserted module 'virtio_balloon'1003test # [ 1.791952] systemd[1]: Started Journal Service.1004test # [ 1.616816] systemd-modules-load[68]: Inserted module 'dm_mod'1005second # [ 1.612097] systemd-modules-load[68]: Inserted module 'virtio_gpu'1006test # [ 1.621196] systemd-modules-load[68]: Inserted module 'virtio_balloon'1007test # [ 1.622442] systemd-modules-load[68]: Inserted module 'virtio_gpu'1008second # [ 1.618324] systemd[1]: Starting Create System Files and Directories...1009test # [ 1.637838] systemd[1]: Starting Create System Files and Directories...1010second # [ 1.641557] systemd[1]: Finished Create System Files and Directories.1011second # [ 1.647323] systemd-udevd[76]: Using default interface naming scheme 'v261'.1012test # [ 1.658186] systemd-udevd[75]: Using default interface naming scheme 'v261'.1013test # [ 1.661077] systemd[1]: Finished Create System Files and Directories.1014second # [ 1.671069] systemd[1]: Started Rule-based Manager for Device Events and Files.1015test # [ 1.684346] systemd[1]: Started Rule-based Manager for Device Events and Files.1016second # [ 1.681830] systemd[1]: Finished Coldplug All udev Devices.1017second # [ 1.684348] systemd[1]: Reached target System Initialization.1018test # [ 1.693122] systemd[1]: Finished Coldplug All udev Devices.1019second # [ 1.685374] systemd[1]: Reached target Basic System.1020test # [ 1.695482] systemd[1]: Reached target System Initialization.1021test # [ 1.696757] systemd[1]: Reached target Basic System.1022second # [ 2.049997] virtio_blk virtio5: 1/0/0 default/read/poll queues1023second # [ 2.051838] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121024test # [ 2.063904] virtio_blk virtio5: 1/0/0 default/read/poll queues1025test # [ 2.064877] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121026second # [ 2.070267] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1027test # [ 2.077694] serio: i8042 KBD port at 0x60,0x64 irq 11028test # [ 2.078484] serio: i8042 AUX port at 0x60,0x64 irq 121029second # [ 2.073043] serio: i8042 KBD port at 0x60,0x64 irq 11030second # [ 2.073842] serio: i8042 AUX port at 0x60,0x64 irq 121031test # [ 2.084258] uhci_hcd 0000:00:1d.0: UHCI Host Controller1032second # [ 2.079350] ehci-pci 0000:00:1d.7: EHCI Host Controller1033second # [ 2.080183] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11034second # [ 2.081989] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001035test # [ 2.090580] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1036second # [ 2.088461] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001037second # [ 2.089689] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181038second # [ 2.090977] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11039test # [ 2.097924] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11040second # [ 2.093655] usb usb1: Product: EHCI Host Controller1041second # [ 2.094544] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd1042second # [ 2.095373] usb usb1: SerialNumber: 0000:00:1d.71043test # [ 2.102825] uhci_hcd 0000:00:1d.0: detected 2 ports1044second # [ 2.096576] hub 1-0:1.0: USB hub found1045test # [ 2.103683] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001046second # [ 2.097330] hub 1-0:1.0: 6 ports detected1047test # [ 2.107044] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181048second # [ 2.101495] uhci_hcd 0000:00:1d.0: UHCI Host Controller1049second # [ 2.102291] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21050test # [ 2.109830] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11051test # [ 2.112128] SCSI subsystem initialized1052test # [ 2.113166] usb usb1: Product: UHCI Host Controller1053test # [ 2.114055] usb usb1: Manufacturer: Linux 6.18.49 uhci_hcd1054test # [ 2.115012] usb usb1: SerialNumber: 0000:00:1d.01055test # [ 2.116111] hub 1-0:1.0: USB hub found1056test # [ 2.117114] hub 1-0:1.0: 2 ports detected1057test # [ 2.118661] uhci_hcd 0000:00:1d.1: UHCI Host Controller1058test # [ 2.120310] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 21059test # [ 2.121857] uhci_hcd 0000:00:1d.1: detected 2 ports1060second # [ 2.115458] uhci_hcd 0000:00:1d.0: detected 2 ports1061test # [ 2.122713] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201062second # [ 2.116305] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001063test # [ 2.124224] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181064test # [ 2.125576] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11065test # [ 2.126836] usb usb2: Product: UHCI Host Controller1066test # [ 2.127600] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd1067test # [ 2.128619] usb usb2: SerialNumber: 0000:00:1d.11068test # [ 2.129683] hub 2-0:1.0: USB hub found1069test # [ 2.130724] hub 2-0:1.0: 2 ports detected1070second # [ 2.126722] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181071second # [ 2.134313] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11072second # [ 2.141952] usb usb2: Product: UHCI Host Controller1073second # [ 2.145189] SCSI subsystem initialized1074second # [ 2.150441] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd1075second # [ 2.151259] usb usb2: SerialNumber: 0000:00:1d.01076second # [ 1.983310] systemd[1]: Starting Virtual Console Setup...1077second # [ 2.164383] hub 2-0:1.0: USB hub found1078test # [ 2.174421] ehci-pci 0000:00:1d.7: EHCI Host Controller1079test # [ 2.175277] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 31080second # [ 1.994222] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1081test # [ 2.177079] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001082second # [ 1.996497] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1083second # [ 2.173698] hub 2-0:1.0: 2 ports detected1084test # [ 2.183878] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001085test # [ 2.184963] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181086second # [ 2.178997] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01087test # [ 2.186496] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11088test # [ 2.187707] usb usb3: Product: EHCI Host Controller1089test # [ 2.188579] usb usb3: Manufacturer: Linux 6.18.49 ehci_hcd1090test # [ 2.189515] usb usb3: SerialNumber: 0000:00:1d.71091test # [ 2.190623] hub 3-0:1.0: USB hub found1092test # [ 2.191624] hub 3-0:1.0: 6 ports detected1093second # [ 2.013142] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1094second # [ 2.016357] systemd[1]: Finished Virtual Console Setup.1095second # [ 2.203747] uhci_hcd 0000:00:1d.1: UHCI Host Controller1096second # [ 2.204575] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31097test # [ 2.214105] hub 1-0:1.0: USB hub found1098test # [ 2.215002] hub 1-0:1.0: 2 ports detected1099second # [ 2.216907] uhci_hcd 0000:00:1d.1: detected 2 ports1100second # [ 2.222020] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201101second # [ 2.049299] systemd[1]: Found device /dev/disk/by-label/nixos.1102second # [ 2.050947] systemd[1]: Reached target Initrd Root Device.1103second # [ 2.055097] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1104test # [ 2.236955] hub 2-0:1.0: USB hub found1105test # [ 2.238129] hub 2-0:1.0: 2 ports detected1106second # [ 2.231540] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181107test # [ 2.240745] uhci_hcd 0000:00:1d.2: UHCI Host Controller1108test # [ 2.241591] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41109second # [ 2.236435] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11110second # [ 2.238679] usb usb3: Product: UHCI Host Controller1111second # [ 2.242437] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd1112second # [ 2.243261] usb usb3: SerialNumber: 0000:00:1d.11113test # [ 2.251820] uhci_hcd 0000:00:1d.2: detected 2 ports1114test # [ 2.252677] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401115second # [ 2.075353] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1116test # [ 2.261210] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181117second # [ 2.080108] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1118second # [ 2.257573] hub 3-0:1.0: USB hub found1119second # [ 2.258678] hub 3-0:1.0: 2 ports detected1120test # [ 2.270413] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11121test # [ 2.271540] usb usb4: Product: UHCI Host Controller1122second # [ 2.264814] uhci_hcd 0000:00:1d.2: UHCI Host Controller1123second # [ 2.265662] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41124second # [ 2.268344] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1125second # [ 2.270898] uhci_hcd 0000:00:1d.2: detected 2 ports1126second # [ 2.272261] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1127second # [ 2.273629] ahci 0000:00:1f.2: flags: 64bit ncq only1128second # [ 2.274793] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401129second # [ 2.276870] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181130test # [ 2.284816] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd1131second # [ 2.278247] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11132test # [ 2.285652] usb usb4: SerialNumber: 0000:00:1d.21133second # [ 2.282266] usb usb4: Product: UHCI Host Controller1134second # [ 2.283066] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd1135second # [ 2.284245] scsi host0: ahci1136second # [ 2.287959] scsi host1: ahci1137test # [ 2.122476] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1138test # [ 2.297034] hub 4-0:1.0: USB hub found1139second # [ 2.290347] usb usb4: SerialNumber: 0000:00:1d.21140second # [ 2.291524] scsi host2: ahci1141second # [ 2.292962] hub 4-0:1.0: USB hub found1142second # [ 2.295080] scsi host3: ahci1143test # [ 2.129083] systemd[1]: Starting Virtual Console Setup...1144second # [ 2.295639] hub 4-0:1.0: 2 ports detected1145test # [ 2.303805] hub 4-0:1.0: 2 ports detected1146second # [ 2.298478] scsi host4: ahci1147test # [ 2.137871] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1148second # [ 2.304555] scsi host5: ahci1149second # [ 2.305151] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11150second # [ 2.309864] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11151second # [ 2.315218] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11152second # [ 2.321238] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11153test # [ 2.155196] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1154second # [ 2.324215] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11155second # [ 2.325568] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11156test # [ 2.163075] systemd[1]: Finished Virtual Console Setup.1157test # [ 2.344799] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01158second # [ 2.338504] usb 1-1: new high-speed USB device number 2 using ehci-pci1159test # [ 2.193299] systemd[1]: Found device /dev/disk/by-label/nixos.1160test # [ 2.194339] systemd[1]: Reached target Initrd Root Device.1161test # [ 2.196078] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1162test # [ 2.390303] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1163test # [ 2.219100] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks1164test # [ 2.221868] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1165test # [ 2.400594] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1166test # [ 2.402103] ahci 0000:00:1f.2: flags: 64bit ncq only1167test # [ 2.408680] scsi host0: ahci1168test # [ 2.410089] scsi host1: ahci1169test # [ 2.412511] scsi host2: ahci1170test # [ 2.414557] scsi host3: ahci1171test # [ 2.416683] scsi host4: ahci1172test # [ 2.418360] scsi host5: ahci1173test # [ 2.421222] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11174test # [ 2.423243] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11175test # [ 2.424736] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11176test # [ 2.428810] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11177test # [ 2.430324] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11178test # [ 2.431664] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11179test # [ 2.432944] usb 3-1: new high-speed USB device number 2 using ehci-pci1180second # [ 2.468276] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001181second # [ 2.469521] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101182second # [ 2.470846] usb 1-1: Product: QEMU USB Tablet1183second # [ 2.471650] usb 1-1: Manufacturer: QEMU1184second # [ 2.472269] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11185second # [ 2.481486] hid: raw HID events driver (C) Jiri Kosina1186test # [ 2.562650] usb 3-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001187test # [ 2.563906] usb 3-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101188test # [ 2.565227] usb 3-1: Product: QEMU USB Tablet1189test # [ 2.566045] usb 3-1: Manufacturer: QEMU1190test # [ 2.566677] usb 3-1: SerialNumber: 28754-0000:00:1d.7-11191test # [ 2.579439] hid: raw HID events driver (C) Jiri Kosina1192second # [ 2.631768] ata1: SATA link down (SStatus 0 SControl 300)1193test # [ 2.467127] systemd[1]: Mounting /sysroot...1194second # [ 2.459472] systemd[1]: Mounting /sysroot...1195second # [ 2.639919] ata4: SATA link down (SStatus 0 SControl 300)1196second # [ 2.640951] ata5: SATA link down (SStatus 0 SControl 300)1197second # [ 2.643624] ata2: SATA link down (SStatus 0 SControl 300)1198second # [ 2.645613] ata6: SATA link down (SStatus 0 SControl 300)1199second # [ 2.647612] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1200second # [ 2.648708] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001201second # [ 2.652432] ata3.00: applying bridge limits1202second # [ 2.653179] ata3.00: configured for UDMA/1001203second # [ 2.654450] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51204second # [ 2.681507] usbcore: registered new interface driver usbhid1205second # [ 2.682342] usbhid: USB HID core driver1206second # [ 2.712653] 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/input21207second # [ 2.719883] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01208second # [ 2.725173] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1209second # [ 2.726819] EXT4-fs (vda): mounted filesystem 00b6cb82-20e9-4e21-855e-747d1ebbaa1f r/w with ordered data mode. Quota mode: none.1210second # [ 2.556535] systemd[1]: Mounted /sysroot.1211second # [ 2.559075] systemd[1]: Reached target Initrd Root File System.1212test # [ 2.742410] ata1: SATA link down (SStatus 0 SControl 300)1213test # [ 2.743795] ata6: SATA link down (SStatus 0 SControl 300)1214second # [ 2.563077] systemd[1]: Starting Mountpoints Configured in the Real Root...1215test # [ 2.744814] ata5: SATA link down (SStatus 0 SControl 300)1216test # [ 2.745825] ata4: SATA link down (SStatus 0 SControl 300)1217test # [ 2.746849] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1218second # [ 2.740435] cdrom: Uniform CD-ROM driver Revision: 3.201219test # [ 2.747884] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001220test # [ 2.748733] ata3.00: applying bridge limits1221test # [ 2.750020] ata3.00: configured for UDMA/1001222test # [ 2.750967] ata2: SATA link down (SStatus 0 SControl 300)1223test # [ 2.752207] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51224second # [ 2.575545] systemd-sysroot-fstab-check[140]: /sysroot should be mounted in the initrd, will request daemon-reload.1225second # [ 2.580379] systemd[1]: Reload requested from client PID 140 ('systemd-sysroot') (unit initrd-parse-etc.service)...1226second # [ 2.582203] systemd[1]: Reloading...1227test # [ 2.795476] usbcore: registered new interface driver usbhid1228test # [ 2.801961] usbhid: USB HID core driver1229test # [ 2.812332] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb3/3-1/3-1:1.0/0003:0627:0001.0001/input/input21230test # [ 2.819424] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01231second # [ 2.639903] systemd[1]: Reloading finished in 60 ms.1232test # [ 2.825167] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1233test # [ 2.826511] EXT4-fs (vda): mounted filesystem 990f079d-897f-427c-873a-560d81df8251 r/w with ordered data mode. Quota mode: none.1234test # [ 2.659862] systemd[1]: Mounted /sysroot.1235second # [ 2.651642] systemd-sysroot-fstab-check[140]: Requesting initrd-fs.target/start/replace...1236test # [ 2.661328] systemd[1]: Reached target Initrd Root File System.1237second # [ 2.654159] systemd-sysroot-fstab-check[140]: Requesting swap.target/start/replace...1238test # [ 2.665082] systemd[1]: Mounting /sysroot/nix/.ro-store...1239second # [ 2.657051] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1240second # [ 2.659973] systemd[1]: Finished Mountpoints Configured in the Real Root.1241test # [ 2.841806] cdrom: Uniform CD-ROM driver Revision: 3.201242second # [ 2.661119] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1243test # [ 2.671610] systemd[1]: Mounting /sysroot/nix/.rw-store...1244second # [ 2.662370] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1245test # [ 2.672757] systemd[1]: Mounting /sysroot/run...1246test # [ 2.680979] systemd[1]: Mounting /sysroot/tmp/shared...1247test # [ 2.685142] systemd[1]: Mounting /sysroot/tmp/xchg...1248test # [ 2.692768] systemd[1]: Starting Mountpoints Configured in the Real Root...1249test # [ 2.878649] 9p: Installing v9fs 9p2000 file system support1250test # [ 2.717727] systemd[1]: Mounted /sysroot/nix/.rw-store.1251test # [ 2.724242] systemd[1]: Mounted /sysroot/nix/.ro-store.1252test # [ 2.725776] systemd-sysroot-fstab-check[146]: /sysroot should be mounted in the initrd, will request daemon-reload.1253test # [ 2.729917] systemd[1]: Mounted /sysroot/run.1254test # [ 2.734106] systemd[1]: Mounted /sysroot/tmp/shared.1255test # [ 2.734974] systemd[1]: Mounted /sysroot/tmp/xchg.1256test # [ 2.743081] systemd[1]: Reload requested from client PID 146 ('systemd-sysroot') (unit initrd-parse-etc.service)...1257test # [ 2.744821] systemd[1]: Reloading...1258test # [ 2.799687] systemd[1]: Reloading finished in 56 ms.1259test # [ 2.806594] systemd-sysroot-fstab-check[146]: Requesting initrd-fs.target/start/replace...1260test # [ 2.810939] systemd-sysroot-fstab-check[146]: Requesting swap.target/start/replace...1261test # [ 2.812500] systemd[1]: Starting rw-sysroot-nix-store.service...1262test # [ 2.815163] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1263test # [ 2.817133] systemd[1]: Finished Mountpoints Configured in the Real Root.1264test # [ 2.819122] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1265test # [ 2.825415] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1266test # [ 2.827189] systemd[1]: Finished rw-sysroot-nix-store.service.1267test # [ 3.467466] systemd[1]: Mounting /sysroot/nix/store...1268second # [ 3.460122] systemd[1]: Mounting /sysroot/nix/.ro-store...1269second # [ 3.463065] systemd[1]: Mounting /sysroot/nix/.rw-store...1270second # [ 3.467129] systemd[1]: Mounting /sysroot/run...1271second # [ 3.468658] systemd[1]: Mounting /sysroot/tmp/shared...1272second # [ 3.472777] systemd[1]: Mounting /sysroot/tmp/xchg...1273test # [ 3.481872] systemd[1]: Mounted /sysroot/nix/store.1274test # [ 3.483353] systemd[1]: Reached target Initrd File Systems.1275test # [ 3.484984] systemd[1]: Starting Find NixOS closure...1276test # [ 3.488133] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1277second # [ 3.665097] 9p: Installing v9fs 9p2000 file system support1278test # [ 3.502133] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1279test # [ 3.504593] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1280second # [ 3.496926] systemd[1]: Mounted /sysroot/nix/.rw-store.1281second # [ 3.502495] systemd[1]: Mounted /sysroot/nix/.ro-store.1282test # [ 3.511579] systemd[1]: Finished Find NixOS closure.1283second # [ 3.503682] systemd[1]: Mounted /sysroot/run.1284test # [ 3.513198] systemd[1]: Reached target Initrd Default Target.1285second # [ 3.504723] systemd[1]: Mounted /sysroot/tmp/shared.1286second # [ 3.506175] systemd[1]: Mounted /sysroot/tmp/xchg.1287test # [ 3.514698] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1288second # [ 3.509833] systemd[1]: Starting rw-sysroot-nix-store.service...1289test # [ 3.525980] systemd[1]: Stopped target Initrd Default Target.1290test # [ 3.527420] systemd[1]: Stopped target Basic System.1291second # [ 3.519160] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1292test # [ 3.529072] systemd[1]: Stopped target Initrd Root Device.1293second # [ 3.520904] systemd[1]: Finished rw-sysroot-nix-store.service.1294test # [ 3.530070] systemd[1]: Stopped target Path Units.1295test # [ 3.531064] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1296test # [ 3.532345] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1297test # [ 3.533978] systemd[1]: Stopped target Slice Units.1298test # [ 3.535281] systemd[1]: Stopped target Socket Units.1299test # [ 3.537150] systemd[1]: Stopped target System Initialization.1300test # [ 3.538259] systemd[1]: Stopped target Swaps.1301test # [ 3.539103] systemd[1]: Stopped target Timer Units.1302test # [ 3.539976] systemd[1]: dbus.socket: Deactivated successfully.1303test # [ 3.541328] systemd[1]: Closed D-Bus System Message Bus Socket.1304test # [ 3.542675] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1305test # [ 3.544165] systemd[1]: Stopped Find NixOS closure.1306test # [ 3.546148] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1307test # [ 3.548083] systemd[1]: Starting rw-sysroot-nix-store.service...1308test # [ 3.549136] systemd[1]: systemd-sysctl.service: Deactivated successfully.1309test # [ 3.550273] systemd[1]: Stopped Apply Kernel Variables.1310test # [ 3.551210] systemd[1]: systemd-modules-load.service: Deactivated successfully.1311test # [ 3.553167] systemd[1]: Stopped Load Kernel Modules.1312test # [ 3.554108] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1313test # [ 3.555417] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1314test # [ 3.557128] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1315test # [ 3.558341] systemd[1]: Stopped Create System Files and Directories.1316test # [ 3.559969] systemd[1]: Stopped target Local File Systems.1317test # [ 3.561214] systemd[1]: Stopped target Preparation for Local File Systems.1318test # [ 3.562974] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1319test # [ 3.564809] systemd[1]: Stopped Coldplug All udev Devices.1320test # [ 3.567152] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1321test # [ 3.568700] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1322test # [ 3.571243] systemd[1]: Stopped Virtual Console Setup.1323test # [ 3.575456] systemd[1]: initrd-cleanup.service: Deactivated successfully.1324test # [ 3.579145] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1325test # [ 3.582078] systemd[1]: systemd-udevd.service: Deactivated successfully.1326test # [ 3.583586] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1327test # [ 3.585367] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1328test # [ 3.587145] systemd[1]: Finished rw-sysroot-nix-store.service.1329test # [ 3.589934] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1330test # [ 3.591824] systemd[1]: Closed udev Control Socket.1331test # [ 3.592885] systemd[1]: Starting Cleanup udev Database...1332test # [ 3.594180] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1333test # [ 3.595444] systemd[1]: Stopped Create Static Device Nodes in /dev.1334test # [ 3.597166] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1335test # [ 3.598494] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1336test # [ 3.599705] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1337test # [ 3.601154] systemd[1]: Stopped Create List of Static Device Nodes.1338test # [ 3.612923] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1339test # [ 3.614291] systemd[1]: Finished Cleanup udev Database.1340test # [ 3.615674] systemd[1]: Reached target Switch Root.1341test # [ 3.617625] systemd[1]: Starting NixOS Activation...1342test # [ 3.697758] initrd-nixos-activation-start[194]: booting system configuration /nix/store/wqq7ghkaln1q722v5pr9lzhq2jzvg43n-nixos-system-test-test1343test # [ 3.727376] initrd-nixos-activation-start[194]: running activation script...1344test # [ 3.914232] initrd-nixos-activation-start[217]: setting up /etc...1345test # [ 4.019798] initrd-nixos-activation-start[217]: setting up age secrets...1346test # [ 4.144721] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1347test # [ 4.147140] systemd[1]: Finished NixOS Activation.1348test # [ 4.148325] systemd[1]: Starting Switch Root...1349test # [ 4.158946] systemd[1]: Switching root.1350test # [ 4.459211] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1351test # [ 4.525851] NET: Registered PF_VSOCK protocol family1352second # [ 4.460134] systemd[1]: Mounting /sysroot/nix/store...1353second # [ 4.475631] systemd[1]: Mounted /sysroot/nix/store.1354second # [ 4.477165] systemd[1]: Reached target Initrd File Systems.1355second # [ 4.478809] systemd[1]: Starting Find NixOS closure...1356second # [ 4.481437] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1357second # [ 4.496099] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1358second # [ 4.498940] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1359second # [ 4.504771] systemd[1]: Finished Find NixOS closure.1360second # [ 4.506212] systemd[1]: Reached target Initrd Default Target.1361second # [ 4.507801] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1362second # [ 4.519363] systemd[1]: Stopped target Initrd Default Target.1363second # [ 4.520390] systemd[1]: Stopped target Basic System.1364second # [ 4.521302] systemd[1]: Stopped target Initrd Root Device.1365second # [ 4.522262] systemd[1]: Stopped target Path Units.1366second # [ 4.523156] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1367second # [ 4.524512] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1368second # [ 4.526159] systemd[1]: Stopped target Slice Units.1369second # [ 4.527370] systemd[1]: Stopped target Socket Units.1370second # [ 4.529239] systemd[1]: Stopped target System Initialization.1371second # [ 4.530236] systemd[1]: Stopped target Swaps.1372second # [ 4.531044] systemd[1]: Stopped target Timer Units.1373second # [ 4.531910] systemd[1]: dbus.socket: Deactivated successfully.1374second # [ 4.533222] systemd[1]: Closed D-Bus System Message Bus Socket.1375second # [ 4.535152] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1376second # [ 4.536430] systemd[1]: Stopped Find NixOS closure.1377second # [ 4.537317] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1378second # [ 4.539127] systemd[1]: Starting rw-sysroot-nix-store.service...1379second # [ 4.540425] systemd[1]: systemd-sysctl.service: Deactivated successfully.1380second # [ 4.541860] systemd[1]: Stopped Apply Kernel Variables.1381second # [ 4.543177] systemd[1]: systemd-modules-load.service: Deactivated successfully.1382second # [ 4.545181] systemd[1]: Stopped Load Kernel Modules.1383second # [ 4.546102] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1384second # [ 4.547803] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1385second # [ 4.549861] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1386second # [ 4.551431] systemd[1]: Stopped Create System Files and Directories.1387second # [ 4.552779] systemd[1]: Stopped target Local File Systems.1388second # [ 4.555102] systemd[1]: Stopped target Preparation for Local File Systems.1389second # [ 4.556542] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1390second # [ 4.560131] systemd[1]: Stopped Coldplug All udev Devices.1391second # [ 4.561095] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1392second # [ 4.562334] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1393second # [ 4.565162] systemd[1]: Stopped Virtual Console Setup.1394second # [ 4.569511] systemd[1]: initrd-cleanup.service: Deactivated successfully.1395second # [ 4.571732] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1396second # [ 4.573259] systemd[1]: systemd-udevd.service: Deactivated successfully.1397second # [ 4.574902] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1398second # [ 4.576969] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1399second # [ 4.578267] systemd[1]: Finished rw-sysroot-nix-store.service.1400second # [ 4.581078] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1401second # [ 4.582339] systemd[1]: Closed udev Control Socket.1402second # [ 4.583978] systemd[1]: Starting Cleanup udev Database...1403second # [ 4.584967] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1404second # [ 4.586264] systemd[1]: Stopped Create Static Device Nodes in /dev.1405second # [ 4.588151] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1406second # [ 4.589473] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1407second # [ 4.590686] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1408second # [ 4.591857] systemd[1]: Stopped Create List of Static Device Nodes.1409second # [ 4.602373] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1410second # [ 4.604270] systemd[1]: Finished Cleanup udev Database.1411second # [ 4.606143] systemd[1]: Reached target Switch Root.1412second # [ 4.607417] systemd[1]: Starting NixOS Activation...1413second # [ 4.685227] initrd-nixos-activation-start[193]: booting system configuration /nix/store/m2ql4j9layanqqvsg8zxfyhjdl0mz1mb-nixos-system-second-test1414test # [ 4.883451] 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)1415test # [ 4.887804] systemd[1]: Detected virtualization kvm.1416test # [ 4.888616] systemd[1]: Detected architecture x86-64.1417test # [ 4.889501] systemd[1]: Detected first boot.1418test # [ 4.891826] systemd[1]: Initializing machine ID from random generator.1419second # [ 4.716295] initrd-nixos-activation-start[193]: running activation script...1420test # [ 5.079728] systemd[1]: bpf-restrict-fs: LSM BPF program attached1421second # [ 4.905335] initrd-nixos-activation-start[216]: setting up /etc...1422test # [ 5.151859] systemd[1]: Applying preset policy.1423second # [ 5.014621] initrd-nixos-activation-start[216]: setting up age secrets...1424second # [ 5.109447] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1425second # [ 5.112084] systemd[1]: Finished NixOS Activation.1426second # [ 5.113208] systemd[1]: Starting Switch Root...1427second # [ 5.123194] systemd[1]: Switching root.1428test # [ 5.399671] systemd[1]: Populated /etc with preset unit settings.1429second # [ 5.428800] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1430second # [ 5.492276] NET: Registered PF_VSOCK protocol family1431test # [ 5.639300] systemd[1]: initrd-switch-root.service: Deactivated successfully.1432test # [ 5.640884] systemd[1]: Stopped initrd-switch-root.service.1433test # [ 5.643310] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1434test # [ 5.645355] systemd[1]: Created slice Slice /system/getty.1435test # [ 5.646675] systemd[1]: Created slice User and Session Slice.1436test # [ 5.655478] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1437test # [ 5.656853] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1438test # [ 5.658042] systemd[1]: Expecting device /dev/hvc0...1439test # [ 5.658878] systemd[1]: Expecting device /dev/ttyS0...1440test # [ 5.659705] systemd[1]: Reached target Local Encrypted Volumes.1441test # [ 5.660649] systemd[1]: Stopped target initrd-fs.target.1442test # [ 5.661518] systemd[1]: Stopped target initrd-root-fs.target.1443test # [ 5.662428] systemd[1]: Stopped target initrd-switch-root.target.1444test # [ 5.663405] systemd[1]: Reached target Virtual Machines and Containers.1445test # [ 5.664443] systemd[1]: Reached target Path Units.1446test # [ 5.665267] systemd[1]: Reached target Remote File Systems.1447test # [ 5.666180] systemd[1]: Reached target Slice Units.1448test # [ 5.667014] systemd[1]: Reached target Swaps.1449test # [ 5.668932] systemd[1]: Listening on Query the User Interactively for a Password.1450test # [ 5.671388] systemd[1]: Listening on Process Core Dump Socket.1451test # [ 5.673299] systemd[1]: Listening on Credential Encryption/Decryption.1452test # [ 5.675226] systemd[1]: Listening on Factory Reset Management.1453test # [ 5.676262] systemd[1]: Listening on Hostname Service Socket.1454test # [ 5.678926] systemd[1]: Starting Journal Log Access Socket...1455test # [ 5.680136] systemd[1]: Listening on Journal Audit Socket.1456test # [ 5.682296] systemd[1]: Listening on Console Output Muting Service Socket.1457test # [ 5.683491] systemd[1]: Listening on Network Management Metrics Varlink Socket.1458test # [ 5.684858] systemd[1]: Listening on Network Management Varlink Socket.1459test # [ 5.686001] systemd[1]: Listening on Network Management Netlink Socket.1460test # [ 5.687158] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1461test # [ 5.688510] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1462test # [ 5.689978] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1463test # [ 5.694557] systemd[1]: Listening on Disk Repartitioning Service Socket.1464test # [ 5.695708] systemd[1]: Listening on Resolve Monitor Varlink Socket.1465test # [ 5.696853] systemd[1]: Listening on Resolve Service Varlink Socket.1466test # [ 5.697942] systemd[1]: Listening on udev Control Socket.1467test # [ 5.698926] systemd[1]: Listening on udev Varlink Socket.1468test # [ 5.701269] systemd[1]: Mounting Huge Pages File System...1469test # [ 5.705273] systemd[1]: Mounting POSIX Message Queue File System...1470test # [ 5.708879] systemd[1]: Mounting Kernel Debug File System...1471test # [ 5.714981] systemd[1]: Mounting Kernel Trace File System...1472test # [ 5.720246] systemd[1]: Starting Create List of Static Device Nodes...1473test # [ 5.726786] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1474test # [ 5.740000] systemd[1]: Starting Load Kernel Module configfs...1475test # [ 5.743845] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1476test # [ 5.748124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1477test # [ 5.755024] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1478test # [ 5.758539] systemd[1]: Mounting FUSE Control File System...1479test # [ 5.759640] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671480test # [ 5.769472] systemd[1]: Starting Journal Service...1481test # [ 5.775380] systemd[1]: Starting Load Kernel Modules...1482test # [ 5.785400] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1483test # [ 5.796208] systemd[1]: Starting Remount Root and Kernel File Systems...1484test # [ 5.798340] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1485test # [ 5.808931] systemd-journald[341]: Collecting audit messages is enabled.1486test # [ 5.813077] systemd[1]: Starting Coldplug All udev Devices...1487test # [ 5.827919] loop: module loaded1488test # [ 5.834224] systemd[1]: Listening on Journal Log Access Socket.1489test # [ 5.838970] systemd[1]: Mounted Huge Pages File System.1490test # [ 5.843164] systemd[1]: Mounted POSIX Message Queue File System.1491test # [ 5.847946] systemd[1]: Started Journal Service.1492test # [ 5.676115] systemd[1]: Queued start job for default target Multi-User System.1493test # [ 5.678336] systemd[1]: systemd-journald.service: Deactivated successfully.1494test # [ 5.852344] EXT4-fs (vda): re-mounted 990f079d-897f-427c-873a-560d81df8251.1495test # [ 5.682544] systemd-modules-load[342]: Module 'ctr' is built in1496second # [ 5.848358] 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)1497second # [ 5.852890] systemd[1]: Detected virtualization kvm.1498test # [ 5.687125] systemd-modules-load[342]: Inserted module 'loop'1499second # [ 5.853705] systemd[1]: Detected architecture x86-64.1500test # [ 5.688545] systemd[1]: Mounted Kernel Debug File System.1501second # [ 5.854576] systemd[1]: Detected first boot.1502second # [ 5.856536] systemd[1]: Initializing machine ID from random generator.1503test # [ 5.691427] systemd[1]: Mounted Kernel Trace File System.1504test # [ 5.699144] systemd[1]: Finished Create List of Static Device Nodes.1505test # [ 5.700307] systemd[1]: modprobe@configfs.service: Deactivated successfully.1506test # [ 5.701614] systemd[1]: Finished Load Kernel Module configfs.1507test # [ 5.704162] systemd[1]: Mounted FUSE Control File System.1508test # [ 5.705662] systemd[1]: Finished Load Kernel Modules.1509test # [ 5.709223] systemd[1]: Finished Remount Root and Kernel File Systems.1510test # [ 5.720002] systemd[1]: Listening on Disk Image Download Service Socket.1511test # [ 5.726788] systemd[1]: Mounting Kernel Configuration File System...1512test # [ 5.729702] systemd-oomd[344]: No swap; memory pressure usage will be degraded1513test # [ 5.731880] systemd[1]: Starting Firewall...1514test # [ 5.742105] systemd[1]: Starting Flush Journal to Persistent Storage...1515test # [ 5.743278] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1516test # [ 5.752570] systemd[1]: Starting Load/Save OS Random Seed...1517test # [ 5.764830] systemd[1]: Starting Apply Kernel Variables...1518second # [ 5.933796] systemd[1]: bpf-restrict-fs: LSM BPF program attached1519test # [ 5.783134] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1520test # [ 5.784441] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1521test # [ 5.786734] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1522test # [ 5.968846] systemd-journald[341]: Received client request to flush runtime journal.1523second # [ 6.003676] systemd[1]: Applying preset policy.1524test # [ 6.021777] systemd[1]: Mounted Kernel Configuration File System.1525test # [ 6.026296] systemd[1]: Finished Load/Save OS Random Seed.1526test # [ 6.029355] systemd[1]: Reached target First Boot Complete.1527test # [ 6.032983] systemd[1]: Finished Apply Kernel Variables.1528test # [ 6.037319] systemd[1]: Starting Network Name Resolution...1529test # [ 6.039572] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1530test # [ 6.044105] systemd[1]: Starting Create Static Device Nodes in /dev...1531test # [ 6.046497] systemd[1]: Finished Create Static Device Nodes in /dev.1532test # [ 6.049164] systemd[1]: Reached target Preparation for Local File Systems.1533test # [ 6.052789] systemd[1]: Starting Rule-based Manager for Device Events and Files...1534test # [ 6.055308] systemd-resolved[369]: Positive Trust Anchors:1535test # [ 6.056437] systemd-resolved[369]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1536test # [ 6.060219] systemd-resolved[369]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161537test # [ 6.063096] systemd-resolved[369]: 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 test1538test # [ 6.080340] systemd[1]: Finished Flush Journal to Persistent Storage.1539test # [ 6.083093] systemd-udevd[379]: Using default interface naming scheme 'v261'.1540second # [ 6.264983] systemd[1]: Populated /etc with preset unit settings.1541test # [ 6.113846] systemd[1]: Finished Coldplug All udev Devices.1542test # [ 6.136531] systemd-resolved[369]: Using system hostname 'test'.1543test # [ 6.143748] systemd[1]: Started Network Name Resolution.1544test # [ 6.183841] systemd[1]: Started Rule-based Manager for Device Events and Files.1545test # [ 6.341164] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1546second # [ 6.517102] systemd[1]: initrd-switch-root.service: Deactivated successfully.1547second # [ 6.518675] systemd[1]: Stopped initrd-switch-root.service.1548second # [ 6.521082] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1549second # [ 6.523112] systemd[1]: Created slice Slice /system/getty.1550second # [ 6.524487] systemd[1]: Created slice User and Session Slice.1551second # [ 6.525541] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1552second # [ 6.526857] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1553second # [ 6.535803] systemd[1]: Expecting device /dev/hvc0...1554second # [ 6.536631] systemd[1]: Expecting device /dev/ttyS0...1555second # [ 6.537529] systemd[1]: Reached target Local Encrypted Volumes.1556second # [ 6.538487] systemd[1]: Stopped target initrd-fs.target.1557second # [ 6.539327] systemd[1]: Stopped target initrd-root-fs.target.1558second # [ 6.540263] systemd[1]: Stopped target initrd-switch-root.target.1559second # [ 6.541255] systemd[1]: Reached target Virtual Machines and Containers.1560second # [ 6.542306] systemd[1]: Reached target Path Units.1561second # [ 6.543130] systemd[1]: Reached target Remote File Systems.1562second # [ 6.544054] systemd[1]: Reached target Slice Units.1563second # [ 6.544897] systemd[1]: Reached target Swaps.1564second # [ 6.546848] systemd[1]: Listening on Query the User Interactively for a Password.1565second # [ 6.549342] systemd[1]: Listening on Process Core Dump Socket.1566second # [ 6.551284] systemd[1]: Listening on Credential Encryption/Decryption.1567second # [ 6.553260] systemd[1]: Listening on Factory Reset Management.1568second # [ 6.554298] systemd[1]: Listening on Hostname Service Socket.1569second # [ 6.556923] systemd[1]: Starting Journal Log Access Socket...1570second # [ 6.558283] systemd[1]: Listening on Journal Audit Socket.1571second # [ 6.560610] systemd[1]: Listening on Console Output Muting Service Socket.1572second # [ 6.561820] systemd[1]: Listening on Network Management Metrics Varlink Socket.1573second # [ 6.563156] systemd[1]: Listening on Network Management Varlink Socket.1574second # [ 6.564303] systemd[1]: Listening on Network Management Netlink Socket.1575second # [ 6.565503] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1576second # [ 6.566866] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1577second # [ 6.568303] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1578second # [ 6.573297] systemd[1]: Listening on Disk Repartitioning Service Socket.1579second # [ 6.574487] systemd[1]: Listening on Resolve Monitor Varlink Socket.1580second # [ 6.575588] systemd[1]: Listening on Resolve Service Varlink Socket.1581second # [ 6.576678] systemd[1]: Listening on udev Control Socket.1582second # [ 6.577664] systemd[1]: Listening on udev Varlink Socket.1583second # [ 6.580061] systemd[1]: Mounting Huge Pages File System...1584second # [ 6.583848] systemd[1]: Mounting POSIX Message Queue File System...1585second # [ 6.587744] systemd[1]: Mounting Kernel Debug File System...1586test # [ 6.426687] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1587second # [ 6.594473] systemd[1]: Mounting Kernel Trace File System...1588second # [ 6.598827] systemd[1]: Starting Create List of Static Device Nodes...1589second # [ 6.601492] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1590test # [ 6.447060] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1591second # [ 6.620336] systemd[1]: Starting Load Kernel Module configfs...1592second # [ 6.622351] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1593second # [ 6.628483] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1594second # [ 6.630591] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1595second # [ 6.633736] systemd[1]: Mounting FUSE Control File System...1596second # [ 6.634869] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671597test # [ 6.471389] systemd[1]: Mounting /run/wrappers...1598second # [ 6.646759] systemd[1]: Starting Journal Service...1599second # [ 6.654229] systemd[1]: Starting Load Kernel Modules...1600test # [ 6.489824] (udev-worker)[443]: Network interface NamePolicy= disabled on kernel command line.1601test # [ 6.496242] (udev-worker)[439]: Network interface NamePolicy= disabled on kernel command line.1602second # [ 6.664792] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1603test # [ 6.504636] systemd[1]: Mounted /run/wrappers.1604second # [ 6.674931] systemd[1]: Starting Remount Root and Kernel File Systems...1605test # [ 6.510398] systemd[1]: Finished Firewall.1606test # [ 6.511769] systemd[1]: Reached target Local File Systems.1607test # [ 6.513179] systemd[1]: Reached target Preparation for Network.1608test # [ 6.516267] systemd[1]: Listening on Boot Loader Control Service Socket.1609second # [ 6.682784] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1610test # [ 6.518494] systemd[1]: Listening on Network Management Resolve Hook Socket.1611test # [ 6.522599] systemd[1]: Starting register-nix-paths.service...1612test # [ 6.525389] systemd[1]: Starting Create SUID/SGID Wrappers...1613test # [ 6.526396] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1614second # [ 6.693612] systemd[1]: Starting Coldplug All udev Devices...1615second # [ 6.700432] systemd-journald[319]: Collecting audit messages is enabled.1616test # [ 6.535052] systemd[1]: Starting Save Transient machine-id to Disk...1617second # [ 6.704082] loop: module loaded1618second # [ 6.711274] systemd[1]: Listening on Journal Log Access Socket.1619test # [ 6.547219] systemd[1]: Starting Network Management...1620second # [ 6.719490] systemd[1]: Mounted Huge Pages File System.1621test # [ 6.555936] systemd[1]: Starting Create System Files and Directories...1622second # [ 6.722627] systemd[1]: Mounted POSIX Message Queue File System.1623second # [ 6.724536] EXT4-fs (vda): re-mounted 00b6cb82-20e9-4e21-855e-747d1ebbaa1f.1624second # [ 6.729109] systemd[1]: Mounted Kernel Debug File System.1625second # [ 6.734835] systemd[1]: Mounted Kernel Trace File System.1626second # [ 6.739678] systemd[1]: Finished Create List of Static Device Nodes.1627second # [ 6.570721] systemd[1]: Queued start job for default target Multi-User System.1628second # [ 6.572205] systemd[1]: systemd-journald.service: Deactivated successfully.1629second # [ 6.573714] systemd-modules-load[320]: Module 'ctr' is built in1630second # [ 6.749275] systemd[1]: Started Journal Service.1631second # [ 6.577414] systemd-modules-load[320]: Inserted module 'loop'1632second # [ 6.585172] systemd[1]: modprobe@configfs.service: Deactivated successfully.1633second # [ 6.586452] systemd[1]: Finished Load Kernel Module configfs.1634second # [ 6.587658] systemd[1]: Mounted FUSE Control File System.1635second # [ 6.592318] systemd[1]: Finished Load Kernel Modules.1636test # [ 6.603373] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1637second # [ 6.595654] systemd[1]: Finished Remount Root and Kernel File Systems.1638test # [ 6.613472] systemd[1]: Finished Save Transient machine-id to Disk.1639second # [ 6.607291] systemd-oomd[322]: No swap; memory pressure usage will be degraded1640second # [ 6.612125] systemd[1]: Listening on Disk Image Download Service Socket.1641second # [ 6.614510] systemd[1]: Mounting Kernel Configuration File System...1642second # [ 6.618784] systemd[1]: Starting Firewall...1643second # [ 6.624834] systemd[1]: Starting Flush Journal to Persistent Storage...1644second # [ 6.625976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1645second # [ 6.634077] systemd[1]: Starting Load/Save OS Random Seed...1646second # [ 6.648311] systemd[1]: Starting Apply Kernel Variables...1647second # [ 6.658292] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1648second # [ 6.659899] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1649second # [ 6.665138] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1650test # [ 6.685263] systemd[1]: Finished Create System Files and Directories.1651second # [ 6.860475] systemd-journald[319]: Received client request to flush runtime journal.1652test # [ 6.697108] systemd[1]: Starting Rebuild Journal Catalog...1653test # [ 6.702051] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1654test # [ 6.777638] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1655test # [ 6.822850] systemd[1]: Finished Rebuild Journal Catalog.1656test # [ 6.831662] systemd[1]: Starting Update is Completed...1657test # [ 6.871273] systemd[1]: Finished Update is Completed.1658test # [ 7.074107] cfg80211: Loading compiled-in X.509 certificates for regulatory database1659test # [ 7.086569] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31660second # [ 6.910906] systemd[1]: Finished Load/Save OS Random Seed.1661test # [ 7.096327] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1662test # [ 7.097319] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1663second # [ 6.917082] systemd[1]: Reached target First Boot Complete.1664second # [ 6.918273] systemd[1]: Mounted Kernel Configuration File System.1665second # [ 6.921480] systemd[1]: Finished Apply Kernel Variables.1666second # [ 6.927195] systemd[1]: Starting Network Name Resolution...1667second # [ 6.929678] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1668second # [ 6.932120] systemd[1]: Starting Create Static Device Nodes in /dev...1669second # [ 6.934573] systemd[1]: Finished Create Static Device Nodes in /dev.1670second # [ 6.937216] systemd[1]: Reached target Preparation for Local File Systems.1671second # [ 6.939909] systemd[1]: Starting Rule-based Manager for Device Events and Files...1672second # [ 6.941893] systemd-resolved[348]: Positive Trust Anchors:1673second # [ 6.944245] systemd-resolved[348]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1674second # [ 6.946992] systemd-resolved[348]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161675test # [ 7.137137] ACPI: button: Power Button [PWRF]1676second # [ 6.951126] systemd-resolved[348]: 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 test1677test # [ 6.967759] systemd-networkd[497]: /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.1678test # [ 6.971920] systemd-networkd[497]: /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.1679second # [ 6.967510] systemd[1]: Finished Flush Journal to Persistent Storage.1680test # [ 6.977885] systemd-networkd[497]: lo: Link UP1681test # [ 6.979959] systemd-networkd[497]: lo: Gained carrier1682test # [ 6.989216] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1683test # [ 6.992712] systemd[1]: Finished Create SUID/SGID Wrappers.1684second # [ 6.984416] systemd-udevd[359]: Using default interface naming scheme 'v261'.1685test # [ 6.996602] systemd-networkd[497]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1686test # [ 6.999107] systemd-networkd[497]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1687test # [ 7.000904] systemd[1]: Started Network Management.1688test # [ 7.008130] systemd-networkd[497]: eth1: Link UP1689second # [ 7.000787] systemd[1]: Finished Coldplug All udev Devices.1690test # [ 7.009756] systemd-networkd[497]: eth1: Gained carrier1691test # [ 7.011254] systemd-networkd[497]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1692test # [ 7.016298] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1693test # [ 7.202995] NET: Registered PF_PACKET protocol family1694second # [ 7.025146] systemd-resolved[348]: Using system hostname 'second'.1695test # [ 7.210681] mousedev: PS/2 mouse device common for all mice1696second # [ 7.031936] systemd[1]: Started Network Name Resolution.1697test # [ 7.061502] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1698second # [ 7.082146] systemd[1]: Started Rule-based Manager for Device Events and Files.1699test # [ 7.276527] rtc_cmos 00:04: RTC can wake from S41700test # [ 7.300903] parport_pc 00:02: reported by Plug and Play ACPI1701test # [ 7.307541] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1702test # [ 7.311651] rtc_cmos 00:04: registered as rtc01703test # [ 7.312563] rtc_cmos 00:04: setting system clock to 2026-09-06T10:02:01 UTC (1788688921)1704test # [ 7.314047] systemd-journald[341]: Time jumped backwards, rotating.1705test # [ 7.160613] systemd-resolved[369]: Clock change detected. Flushing caches.1706test # [ 7.169647] systemd[1]: Finished register-nix-paths.service.1707test # [ 7.172425] systemd[1]: Reached target System Initialization.1708test # [ 7.175205] systemd[1]: Started Discard unused filesystem blocks once a week.1709test # [ 7.177145] systemd[1]: Started Daily Cleanup of Temporary Directories.1710test # [ 7.181264] systemd[1]: Reached target Timer Units.1711test # [ 7.182267] systemd[1]: Listening on D-Bus System Message Bus Socket.1712test # [ 7.183672] systemd[1]: Listening on Nix Daemon Socket.1713test # [ 7.185269] systemd[1]: Listening on Authorization Manager Agent Helper.1714test # [ 7.186702] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1715test # [ 7.189178] systemd[1]: Reached target Socket Units.1716test # [ 7.191847] systemd[1]: Starting D-Bus System Message Bus...1717second # [ 7.238804] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1718test # [ 7.253643] dbus-broker-launch[578]: Looking up NSS user entry for 'systemd-timesync'...1719test # [ 7.258300] dbus-broker-launch[578]: NSS returned no entry for 'systemd-timesync'1720test # [ 7.259725] dbus-broker-launch[578]: Invalid user-name in /nix/store/52kvjg19h04x096xdxhxzszgvqskmsc2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1721test # [ 7.353320] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1722test # [ 7.363382] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1723test # [ 7.369968] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41724test # [ 7.280121] dbus-broker-launch[578]: 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'1725test # [ 7.283524] dbus-broker-launch[578]: 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'1726test # [ 7.287153] dbus-broker-launch[578]: 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'1727test # [ 7.290721] dbus-broker-launch[578]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1728test # [ 7.294168] systemd[1]: Started D-Bus System Message Bus.1729test # [ 7.296150] systemd[1]: Reached target Basic System.1730test # [ 7.302783] systemd[1]: Starting Network Manager Script Dispatcher Service...1731test # [ 7.309637] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1732test # [ 7.317235] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1733second # [ 7.320488] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1734test # [ 7.335721] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1735test # [ 7.391430] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1736test # [ 7.437681] Console: switching to colour dummy device 80x251737test # [ 7.341252] dbus-broker-launch[578]: Ready1738test # [ 7.347818] systemd[1]: Starting Network Manager...1739second # [ 7.348132] systemd[1]: Mounting /run/wrappers...1740test # [ 7.362041] systemd[1]: Started backdoor.service.1741second # [ 7.354223] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1742test # [ 7.386726] systemd[1]: Starting Import lastlog data into lastlog2 database...1743second # [ 7.381360] systemd[1]: Mounted /run/wrappers.1744second # [ 7.382250] systemd[1]: Reached target Local File Systems.1745test # [ 7.473227] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1746test # [ 7.473325] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1747second # [ 7.385991] systemd[1]: Listening on Boot Loader Control Service Socket.1748second # [ 7.391505] systemd[1]: Starting register-nix-paths.service...1749second # [ 7.393426] systemd[1]: Starting Create SUID/SGID Wrappers...1750test # [ 7.402944] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[582]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1751second # [ 7.396264] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1752test # [ 7.407643] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1753test # [ 7.411585] iif2wwqra6cyixya934jn1gzixwi7l6v-wifi-secrets[583]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1754second # [ 7.408206] (udev-worker)[414]: Network interface NamePolicy= disabled on kernel command line.1755second # [ 7.409630] systemd[1]: Starting Save Transient machine-id to Disk...1756second # [ 7.412398] (udev-worker)[413]: Network interface NamePolicy= disabled on kernel command line.1757test # [ 7.423842] d1nj6zvw29gdp15fx855q5n4s3rj0h43-wifi-secrets[584]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1758second # [ 7.422195] systemd[1]: Starting Create System Files and Directories...1759test # [ 7.439245] systemd[1]: Starting Post-Boot Actions...1760test # [ 7.449960] systemd[1]: Started Reset console on configuration changes.1761test # [ 7.478737] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1762test # [ 7.481466] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1763test # [ 7.605072] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61764second # [ 7.477167] systemd[1]: Finished Firewall.1765test # [ 7.605507] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51766test # connecting to host...1767second # [ 7.479232] systemd[1]: Reached target Preparation for Network.1768second # [ 7.482350] systemd[1]: Listening on Network Management Resolve Hook Socket.1769test # [ 7.500676] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1770second # [ 7.493549] systemd[1]: Starting Network Management...1771test # [ 7.509284] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1772test # [ 7.513293] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1773test: Guest shell says: b'Spawning backdoor root shell...\n'1774test: connected to guest root shell1775test # [ 7.522183] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1776test: (connecting took 8.21 seconds)1777second # [ 7.510461] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1778test: (finished: waiting for the VM to finish booting, in 8.21 seconds)1779second # [ 7.518548] systemd[1]: Finished Save Transient machine-id to Disk.1780test # [ 7.549240] systemd[1]: Started Name Service Cache Daemon (nsncd).1781test # [ 7.550484] nsncd[592]: Sep 06 10:02:01.903 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1782test # [ 7.559835] systemd[1]: Finished Post-Boot Actions.1783second # [ 7.560916] systemd[1]: Finished Create System Files and Directories.1784test # [ 7.745288] [drm] Found bochs VGA, ID 0xb0c5.1785test # [ 7.745290] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1786second # [ 7.570279] systemd[1]: Starting Rebuild Journal Catalog...1787test # [ 7.753693] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1788second # [ 7.575087] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1789test # [ 7.588288] systemd[1]: Reached target Host and Network Name Lookups.1790test # [ 7.589884] systemd[1]: Reached target User and Group Name Lookups.1791test # [ 7.602071] systemd[1]: Starting User Login Management...1792test # [ 7.604907] systemd[1]: Finished Import lastlog data into lastlog2 database.1793test # [ 7.785135] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01794test # [ 7.640339] systemd[1]: Started Network Manager Script Dispatcher Service.1795second # [ 7.645835] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1796test # [ 7.655551] systemd[1]: Starting Hostname Service...1797test # [ 7.669551] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1798test # [ 7.694252] systemd[1]: Starting Virtual Console Setup...1799second # [ 7.686103] systemd[1]: Finished Rebuild Journal Catalog.1800second # [ 7.696944] systemd[1]: Starting Update is Completed...1801test # [ 7.722680] systemd-logind[638]: New seat seat0.1802test # [ 7.725395] systemd[1]: Started User Login Management.1803test # [ 7.732102] systemd[1]: Starting linger-users.service...1804second # [ 7.747954] systemd[1]: Finished Update is Completed.1805second # [ 7.974841] cfg80211: Loading compiled-in X.509 certificates for regulatory database1806second # [ 7.996537] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1807second # [ 7.997528] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1808test # [ 7.984525] Console: switching to colour frame buffer device 160x501809test # [ 8.028780] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1810test # [ 7.758753] systemd-logind[638]: Watching system buttons on /dev/input/event2 (Power Button)1811test # [ 7.858891] systemd[1]: linger-users.service: Deactivated successfully.1812test # [ 7.860158] systemd[1]: Finished linger-users.service.1813test # [ 7.863901] systemd[1]: Started Hostname Service.1814test # [ 7.866247] systemd-logind[638]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1815test # [ 7.867823] systemd-networkd[497]: eth0: Link UP1816test # [ 7.870598] systemd-networkd[497]: eth0: Gained carrier1817test # [ 7.871613] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1818second # [ 7.863762] systemd-networkd[479]: /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.1819test # [ 7.874587] systemd[1]: Stopped Virtual Console Setup.1820second # [ 7.868684] systemd-networkd[479]: /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.1821second # [ 8.047606] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31822test # [ 8.055771] ppdev: user-space parallel port driver1823second # [ 7.875344] systemd-networkd[479]: lo: Link UP1824test # [ 7.884343] systemd[1]: Starting Virtual Console Setup...1825second # [ 7.876275] systemd-networkd[479]: lo: Gained carrier1826test # [ 7.890797] systemd[1]: Started Network Manager.1827test # [ 7.894249] systemd[1]: Reached target Network.1828second # [ 7.888191] systemd[1]: Started Network Management.1829second # [ 7.890413] systemd-networkd[479]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1830test # [ 7.900306] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1831second # [ 7.892873] systemd-networkd[479]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1832second # [ 7.899240] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1833second # [ 7.900766] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1834test # [ 7.913956] systemd[1]: Starting Permit User Sessions...1835second # [ 7.905769] systemd-networkd[479]: eth1: Link UP1836second # [ 7.907542] systemd[1]: Finished Create SUID/SGID Wrappers.1837second # [ 7.911228] systemd-networkd[479]: eth1: Gained carrier1838second # [ 7.912767] systemd-networkd[479]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1839second # [ 8.105264] NET: Registered PF_PACKET protocol family1840second # [ 8.112176] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1841second # [ 7.962638] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1842test # [ 7.973359] systemd[1]: Finished Permit User Sessions.1843test # [ 8.173689] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1844test # [ 8.019132] systemd[1]: Started Getty on tty1.1845test # [ 8.019984] systemd[1]: Reached target Login Prompts.1846test # [ 8.041492] systemd-logind[638]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1847second # [ 8.049571] systemd[1]: Finished register-nix-paths.service.1848second # [ 8.052154] systemd[1]: Reached target System Initialization.1849second # [ 8.054594] systemd[1]: Started Discard unused filesystem blocks once a week.1850second # [ 8.055837] systemd[1]: Started Daily Cleanup of Temporary Directories.1851second # [ 8.057511] systemd[1]: Reached target Timer Units.1852second # [ 8.058718] systemd[1]: Listening on D-Bus System Message Bus Socket.1853second # [ 8.061350] systemd[1]: Listening on Nix Daemon Socket.1854test # [ 8.242784] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1855second # [ 8.065077] systemd[1]: Listening on Authorization Manager Agent Helper.1856second # [ 8.066244] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1857second # [ 8.067697] systemd[1]: Reached target Socket Units.1858test # [ 8.075277] NetworkManager[585]: <warn> [1788688922.4348] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1859second # [ 8.072171] systemd[1]: Starting D-Bus System Message Bus...1860test # [ 8.079573] NetworkManager[585]: <warn> [1788688922.4392] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1861second # [ 8.073857] systemd-resolved[348]: Clock change detected. Flushing caches.1862test # [ 8.112669] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1863test # [ 8.114391] systemd-resolved[369]: eth0: Bus client set default route setting: yes1864second # [ 8.126767] mousedev: PS/2 mouse device common for all mice1865second # [ 8.146557] ACPI: button: Power Button [PWRF]1866test # [ 8.120532] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1867test # [ 8.122583] systemd-resolved[369]: eth0: Bus client set DNS server list to: 10.0.2.31868test # [ 8.126692] systemd[1]: Reached target Multi-User System.1869second # [ 8.225682] rtc_cmos 00:04: RTC can wake from S41870second # [ 8.247503] rtc_cmos 00:04: registered as rtc01871second # [ 8.247596] rtc_cmos 00:04: setting system clock to 2026-09-06T10:02:02 UTC (1788688922)1872second # [ 8.247677] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1873second # [ 8.148889] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...1874second # [ 8.152209] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'1875second # [ 8.153641] dbus-broker-launch[555]: Invalid user-name in /nix/store/52kvjg19h04x096xdxhxzszgvqskmsc2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1876second # [ 8.249914] systemd-journald[319]: Time jumped backwards, rotating.1877second # [ 8.257175] parport_pc 00:02: reported by Plug and Play ACPI1878second # [ 8.257258] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1879second # [ 8.174184] dbus-broker-launch[555]: 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'1880second # [ 8.177984] dbus-broker-launch[555]: 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'1881second # [ 8.181988] dbus-broker-launch[555]: 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'1882second # [ 8.185689] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1883second # [ 8.189599] systemd[1]: Started D-Bus System Message Bus.1884second # [ 8.192162] systemd[1]: Reached target Basic System.1885second # [ 8.196300] systemd[1]: Starting Network Manager Script Dispatcher Service...1886second # [ 8.202408] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1887second # [ 8.284702] Console: switching to colour dummy device 80x251888second # [ 8.292988] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41889second # [ 8.219069] systemd[1]: Starting Network Manager...1890second # [ 8.226788] dbus-broker-launch[555]: Ready1891test # [ 8.409948] kvm_amd: TSC scaling supported1892test # [ 8.410428] kvm_amd: Nested Virtualization enabled1893test # [ 8.411380] kvm_amd: Nested Paging enabled1894test # [ 8.412236] kvm_amd: LBR virtualization supported1895second # [ 8.230712] systemd[1]: Started backdoor.service.1896test # [ 8.413072] kvm_amd: Virtual GIF supported1897test # [ 8.413570] kvm_amd: Virtual NMI enabled1898test # [ 8.246814] systemd-vconsole-setup[656]: Configuration of first virtual console was skipped, ignoring remaining ones.1899second # [ 8.239428] systemd[1]: Starting Import lastlog data into lastlog2 database...1900test # [ 8.252742] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1901test # [ 8.254402] systemd[1]: Stopped Virtual Console Setup.1902test # [ 8.263170] systemd[1]: Starting Virtual Console Setup...1903second # [ 8.254948] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1904second # [ 8.279960] systemd[1]: Starting Post-Boot Actions...1905second # [ 8.281755] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1906second # [ 8.320763] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1907second # [ 8.469201] [drm] Found bochs VGA, ID 0xb0c5.1908second # [ 8.469203] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1909test # [ 8.478838] EDAC MC: Ver: 3.0.01910second # [ 8.481266] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1911second # [ 8.482064] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1912second # [ 8.311231] systemd[1]: Started Reset console on configuration changes.1913second # [ 8.330266] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1914second # [ 8.343403] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1915second # [ 8.526485] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1916second # [ 8.527274] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01917second # connecting to host...1918second # [ 8.388195] systemd[1]: Finished Post-Boot Actions.1919test # [ 8.408176] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones.1920test # [ 8.411908] systemd[1]: Finished Virtual Console Setup.1921second # [ 8.403529] nsncd[565]: Sep 06 10:02:02.827 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1922test # [ 8.417536] systemd[1]: Startup finished in 782ms (kernel) + 3.543s (initrd) + 4.091s (userspace) = 8.417s.1923second # [ 8.414699] systemd[1]: Started Name Service Cache Daemon (nsncd).1924second # [ 8.424846] systemd[1]: Started Network Manager Script Dispatcher Service.1925second # [ 8.431303] systemd[1]: Finished Import lastlog data into lastlog2 database.1926second # [ 8.434032] systemd[1]: Reached target Host and Network Name Lookups.1927second # [ 8.437856] systemd[1]: Reached target User and Group Name Lookups.1928second # [ 8.443177] systemd[1]: Starting User Login Management...1929second # [ 8.470214] systemd[1]: Starting Hostname Service...1930second # [ 8.664939] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61931second # [ 8.666271] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51932second # [ 8.743299] Console: switching to colour frame buffer device 160x501933second # [ 8.799452] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1934second # [ 8.555923] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1935second # [ 8.629529] systemd[1]: Started Hostname Service.1936second # [ 8.634664] systemd[1]: Starting Virtual Console Setup...1937second # [ 8.637418] systemd-logind[600]: New seat seat0.1938second # [ 8.639744] systemd[1]: Started User Login Management.1939second # [ 8.642450] systemd-logind[600]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1940second # [ 8.647360] systemd[1]: Starting linger-users.service...1941test: (finished: waiting for unit NetworkManager.service, in 9.35 seconds)1942second # [ 8.657574] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1943test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1944second # [ 8.662293] systemd-networkd[479]: eth0: Link UP1945second # [ 8.663256] systemd-networkd[479]: eth0: Gained carrier1946second # [ 8.666544] systemd[1]: Stopped Virtual Console Setup.1947test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1948test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1949second # [ 8.670415] systemd-logind[600]: Watching system buttons on /dev/input/event2 (Power Button)1950test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1951test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1952second # [ 8.686430] systemd[1]: Starting Virtual Console Setup...1953test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1954(finished: run the VM test script, in 9.47 seconds)1955second # [ 8.701991] systemd[1]: Started Network Manager.1956second # [ 8.704156] systemd[1]: Reached target Network.1957test script finished in 9.48s1958cleanup1959kill QemuMachine (pid 48)1960second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1961kill QemuMachine (pid 47)1962test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1963(finished: cleanup, in 0.20 seconds)