vm-test-run-wifi
checks.x86_64-linux.wifi
· build #128
· 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 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test # Disk image does not exist, creating the virtualisation disk image...14test: QEMU running (pid 15)15second # Disk image does not exist, creating the virtualisation disk image...16second: QEMU running (pid 14)17second # Formatting '/build/vm-state-second/tmp.PWrMhtlNSn', fmt=raw size=107374182418test # Formatting '/build/vm-state-test/tmp.V82eNnQNV0', fmt=raw size=107374182419second # mke2fs 1.47.4 (6-Mar-2025)20test # mke2fs 1.47.4 (6-Mar-2025)21(finished: start all VMs, in 0.10 seconds)22test # Discarding device blocks: 0/262144 done23test # Creating filesystem with 262144 4k blocks and 65536 inodes24second # Discarding device blocks: 0/262144 done25test: waiting for unit NetworkManager.service26test # Filesystem UUID: 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f27test: waiting for the VM to finish booting28test # Superblock backups stored on blocks:29test # 32768, 98304, 163840, 22937630second # Creating filesystem with 262144 4k blocks and 65536 inodes31test # 32second # Filesystem UUID: f50fd241-d8d6-4d19-bf09-b4298b3a2ef833test # Allocating group tables: 0/8 done34second # Superblock backups stored on blocks:35test # Writing inode tables: 0/8 done36second # 32768, 98304, 163840, 22937637test # Creating journal (8192 blocks): done38second # 39test # Writing superblocks and filesystem accounting information: 0/8 done40second # Allocating group tables: 0/8 done41test # 42second # Writing inode tables: 0/8 done43test # Virtualisation disk image created.44second # Creating journal (8192 blocks): done45second # Writing superblocks and filesystem accounting information: 0/8 done46second # 47second # Virtualisation disk image created.48test # 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 # 52second # 53second # 54test # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA0055second # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA0056test # Press Ctrl-B to configure iPXE (PCI 00:03.0)...57test # 58test # 59second # Press Ctrl-B to configure iPXE (PCI 00:03.0)...60second # 61second # 62second # 63second # 64test # 65test # 66test # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB0067second # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB0068test # Press Ctrl-B to configure iPXE (PCI 00:09.0)...69test # 70test # 71second # Press Ctrl-B to configure iPXE (PCI 00:09.0)...72second # 73second # 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.2.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.2.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/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test/init regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-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/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test/init regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration console=ttyS0,115200n8 console=tty080test # [ 0.000000] BIOS-provided physical RAM map:81second # [ 0.000000] BIOS-provided physical RAM map:82second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable83test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable84second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved85test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved86second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved87test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved88second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable89test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable90second # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved91test # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved92second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved93test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved94second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved95test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved96second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved97test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved98second # [ 0.000000] NX (Execute Disable) protection: active99test # [ 0.000000] NX (Execute Disable) protection: active100second # [ 0.000000] APIC: Static calls initialized101test # [ 0.000000] APIC: Static calls initialized102second # [ 0.000000] SMBIOS 2.8 present.103test # [ 0.000000] SMBIOS 2.8 present.104second # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014105test # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014106second # [ 0.000000] DMI: Memory slots populated: 1/1107test # [ 0.000000] DMI: Memory slots populated: 1/1108second # [ 0.000000] Hypervisor detected: KVM109test # [ 0.000000] Hypervisor detected: KVM110second # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000111test # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000112second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00113test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00114second # [ 0.000000] kvm-clock: using sched offset of 369937072 cycles115test # [ 0.000000] kvm-clock: using sched offset of 370548639 cycles116test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns117second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns118second # [ 0.000006] tsc: Detected 4192.120 MHz processor119test # [ 0.000005] tsc: Detected 4192.120 MHz processor120second # [ 0.000605] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000121test # [ 0.000601] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000122second # [ 0.000633] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs123test # [ 0.000629] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs124second # [ 0.000635] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT125test # [ 0.000632] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT126second # [ 0.002293] found SMP MP-table at [mem 0x000f5470-0x000f547f]127test # [ 0.002304] found SMP MP-table at [mem 0x000f5470-0x000f547f]128second # [ 0.002306] Using GB pages for direct mapping129test # [ 0.002318] Using GB pages for direct mapping130second # [ 0.002368] RAMDISK: [mem 0x3e4d9000-0x3ffcffff]131test # [ 0.002390] RAMDISK: [mem 0x3e4dc000-0x3ffcffff]132second # [ 0.002372] ACPI: Early table checksum verification disabled133test # [ 0.002395] ACPI: Early table checksum verification disabled134second # [ 0.002376] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )135test # [ 0.002398] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )136second # [ 0.002379] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)137test # [ 0.002401] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)138second # [ 0.002383] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)139test # [ 0.002405] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)140second # [ 0.002388] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001)141test # [ 0.002411] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001)142second # [ 0.002390] ACPI: FACS 0x000000003FFE0000 000040143test # [ 0.002413] ACPI: FACS 0x000000003FFE0000 000040144second # [ 0.002392] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)145test # [ 0.002414] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)146second # [ 0.002393] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)147test # [ 0.002415] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)148second # [ 0.002394] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)149test # [ 0.002416] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)150second # [ 0.002395] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]151test # [ 0.002417] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]152second # [ 0.002396] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]153test # [ 0.002418] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]154second # [ 0.002396] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]155test # [ 0.002419] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]156second # [ 0.002397] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]157test # [ 0.002419] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]158second # [ 0.002397] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]159test # [ 0.002419] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]160second # [ 0.002398] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]161test # [ 0.002420] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]162second # [ 0.002757] No NUMA configuration found163test # [ 0.002782] No NUMA configuration found164second # [ 0.002758] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]165test # [ 0.002783] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]166second # [ 0.002760] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]167test # [ 0.002786] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]168second # [ 0.002834] Zone ranges:169test # [ 0.002859] Zone ranges:170second # [ 0.002835] DMA [mem 0x0000000000001000-0x0000000000ffffff]171test # [ 0.002859] DMA [mem 0x0000000000001000-0x0000000000ffffff]172test # [ 0.002861] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]173second # [ 0.002836] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]174test # [ 0.002861] Normal empty175second # [ 0.002837] Normal empty176second # [ 0.002838] Device empty177test # [ 0.002862] Device empty178test # [ 0.002863] Movable zone start for each node179second # [ 0.002838] Movable zone start for each node180test # [ 0.002863] Early memory node ranges181second # [ 0.002839] Early memory node ranges182test # [ 0.002863] node 0: [mem 0x0000000000001000-0x000000000009efff]183second # [ 0.002839] node 0: [mem 0x0000000000001000-0x000000000009efff]184test # [ 0.002864] node 0: [mem 0x0000000000100000-0x000000003ffdafff]185second # [ 0.002840] node 0: [mem 0x0000000000100000-0x000000003ffdafff]186test # [ 0.002865] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]187second # [ 0.002841] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]188test # [ 0.002881] On node 0, zone DMA: 1 pages in unavailable ranges189second # [ 0.002858] On node 0, zone DMA: 1 pages in unavailable ranges190test # [ 0.003084] On node 0, zone DMA: 97 pages in unavailable ranges191second # [ 0.003058] On node 0, zone DMA: 97 pages in unavailable ranges192test # [ 0.016806] On node 0, zone DMA32: 37 pages in unavailable ranges193second # [ 0.016745] On node 0, zone DMA32: 37 pages in unavailable ranges194test # [ 0.017550] ACPI: PM-Timer IO Port: 0x608195second # [ 0.017476] ACPI: PM-Timer IO Port: 0x608196test # [ 0.017564] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])197second # [ 0.017490] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])198test # [ 0.017591] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23199second # [ 0.017513] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23200test # [ 0.017593] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)201second # [ 0.017516] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)202test # [ 0.017595] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)203second # [ 0.017518] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)204test # [ 0.017596] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)205second # [ 0.017518] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)206test # [ 0.017597] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)207second # [ 0.017519] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)208test # [ 0.017597] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)209second # [ 0.017520] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)210second # [ 0.017522] ACPI: Using ACPI (MADT) for SMP configuration information211test # [ 0.017599] ACPI: Using ACPI (MADT) for SMP configuration information212second # [ 0.017522] ACPI: HPET id: 0x8086a201 base: 0xfed00000213test # [ 0.017600] ACPI: HPET id: 0x8086a201 base: 0xfed00000214second # [ 0.017526] TSC deadline timer available215test # [ 0.017605] TSC deadline timer available216second # [ 0.017529] CPU topo: Max. logical packages: 1217test # [ 0.017609] CPU topo: Max. logical packages: 1218second # [ 0.017530] CPU topo: Max. logical dies: 1219test # [ 0.017609] CPU topo: Max. logical dies: 1220second # [ 0.017530] CPU topo: Max. dies per package: 1221test # [ 0.017610] CPU topo: Max. dies per package: 1222second # [ 0.017533] CPU topo: Max. threads per core: 1223test # [ 0.017613] CPU topo: Max. threads per core: 1224second # [ 0.017534] CPU topo: Num. cores per package: 1225test # [ 0.017614] CPU topo: Num. cores per package: 1226second # [ 0.017534] CPU topo: Num. threads per package: 1227test # [ 0.017614] CPU topo: Num. threads per package: 1228second # [ 0.017534] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs229test # [ 0.017614] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs230second # [ 0.017552] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()231test # [ 0.017631] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()232second # [ 0.017589] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]233test # [ 0.017668] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]234second # [ 0.017591] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]235test # [ 0.017669] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]236second # [ 0.017592] [mem 0x40000000-0xfeffbfff] available for PCI devices237test # [ 0.017671] [mem 0x40000000-0xfeffbfff] available for PCI devices238test # [ 0.017672] Booting paravirtualized kernel on KVM239second # [ 0.017593] Booting paravirtualized kernel on KVM240test # [ 0.017675] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns241second # [ 0.017596] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns242test # [ 0.021016] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1243second # [ 0.020924] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1244test # [ 0.022697] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152245second # [ 0.022603] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152246test # [ 0.022733] kvm-guest: PV spinlocks disabled, single CPU247second # [ 0.022643] kvm-guest: PV spinlocks disabled, single CPU248test # [ 0.022734] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test/init regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-closure-info/registration console=ttyS0,115200n8 console=tty0249second # [ 0.022645] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test/init regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration console=ttyS0,115200n8 console=tty0250test # [ 0.022809] Unknown kernel command line parameters "regInfo=/nix/store/s11nc3z3rk1sms9fip77ma80cxbhh1xb-closure-info/registration", will be passed to user space.251second # [ 0.022720] Unknown kernel command line parameters "regInfo=/nix/store/j0nxgw631q3kmm1dbq948j41d76mg8vj-closure-info/registration", will be passed to user space.252test # [ 0.023175] random: crng init done253second # [ 0.023080] random: crng init done254test # [ 0.023175] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes255second # [ 0.023081] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes256test # [ 0.023194] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)257second # [ 0.023099] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)258test # [ 0.023603] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)259second # [ 0.023509] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)260test # [ 0.023631] Fallback order for Node 0: 0261second # [ 0.023539] Fallback order for Node 0: 0262test # [ 0.023633] Built 1 zonelists, mobility grouping on. Total pages: 262009263second # [ 0.023541] Built 1 zonelists, mobility grouping on. Total pages: 262009264test # [ 0.023634] Policy zone: DMA32265second # [ 0.023542] Policy zone: DMA32266test # [ 0.025515] mem auto-init: stack:all(zero), heap alloc:on, heap free:off267second # [ 0.025444] mem auto-init: stack:all(zero), heap alloc:on, heap free:off268test # [ 0.028198] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1269second # [ 0.028144] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1270test # [ 0.030206] allocated 2097152 bytes of page_ext271second # [ 0.030149] allocated 2097152 bytes of page_ext272test # [ 0.039704] ftrace: allocating 48650 entries in 192 pages273second # [ 0.039656] ftrace: allocating 48650 entries in 192 pages274test # [ 0.039706] ftrace: allocated 192 pages with 2 groups275second # [ 0.039659] ftrace: allocated 192 pages with 2 groups276test # [ 0.040462] Dynamic Preempt: lazy277second # [ 0.040411] Dynamic Preempt: lazy278test # [ 0.040581] rcu: Preemptible hierarchical RCU implementation.279second # [ 0.040549] rcu: Preemptible hierarchical RCU implementation.280test # [ 0.040582] rcu: RCU event tracing is enabled.281second # [ 0.040550] rcu: RCU event tracing is enabled.282test # [ 0.040582] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.283second # [ 0.040550] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.284test # [ 0.040583] Trampoline variant of Tasks RCU enabled.285second # [ 0.040551] Trampoline variant of Tasks RCU enabled.286test # [ 0.040584] Rude variant of Tasks RCU enabled.287second # [ 0.040551] Rude variant of Tasks RCU enabled.288test # [ 0.040584] Tracing variant of Tasks RCU enabled.289second # [ 0.040551] Tracing variant of Tasks RCU enabled.290test # [ 0.040585] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.291second # [ 0.040552] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.292test # [ 0.040586] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1293second # [ 0.040553] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1294test # [ 0.040600] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.295second # [ 0.040580] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.296test # [ 0.040601] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.297second # [ 0.040582] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.298test # [ 0.040603] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.299second # [ 0.040583] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.300test # [ 0.044015] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16301second # [ 0.044118] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16302test # [ 0.044273] rcu: srcu_init: Setting srcu_struct sizes based on contention.303second # [ 0.044367] rcu: srcu_init: Setting srcu_struct sizes based on contention.304test # [ 0.044282] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns305second # [ 0.044373] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns306test # [ 0.044457] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)307second # [ 0.044544] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)308test # [ 0.049928] Console: colour VGA+ 80x25309second # [ 0.049986] Console: colour VGA+ 80x25310test # [ 0.049931] printk: legacy console [tty0] enabled311second # [ 0.049990] printk: legacy console [tty0] enabled312test # [ 0.080274] printk: legacy console [ttyS0] enabled313second # [ 0.080312] printk: legacy console [ttyS0] enabled314test # [ 0.212895] ACPI: Core revision 20250807315second # [ 0.213256] ACPI: Core revision 20250807316test # [ 0.214010] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns317second # [ 0.214330] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns318test # [ 0.215990] APIC: Switch to symmetric I/O mode setup319second # [ 0.216281] APIC: Switch to symmetric I/O mode setup320test # [ 0.217205] x2apic enabled321second # [ 0.217500] x2apic enabled322test # [ 0.218049] APIC: Switched APIC routing to: physical x2apic323second # [ 0.218364] APIC: Switched APIC routing to: physical x2apic324test # [ 0.220054] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1325second # [ 0.220371] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1326test # [ 0.221327] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns327second # [ 0.221642] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns328test # [ 0.223448] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)329second # [ 0.223745] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)330test # [ 0.224538] x86/cpu: User Mode Instruction Prevention (UMIP) activated331second # [ 0.224841] x86/cpu: User Mode Instruction Prevention (UMIP) activated332test # [ 0.225583] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127333second # [ 0.225881] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127334test # [ 0.226447] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0335second # [ 0.227743] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0336test # [ 0.228450] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto337second # [ 0.228748] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto338test # [ 0.229446] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl339second # [ 0.230743] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl340test # [ 0.230446] Spectre V2 : Mitigation: Enhanced / Automatic IBRS341second # [ 0.232744] Spectre V2 : Mitigation: Enhanced / Automatic IBRS342test # [ 0.231446] Speculative Return Stack Overflow: Mitigation: Safe RET343second # [ 0.233744] Speculative Return Stack Overflow: Mitigation: Safe RET344test # [ 0.232446] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization345second # [ 0.235748] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization346test # [ 0.234453] Spectre V2 : Enabling IBPB for BPF347second # [ 0.236753] Spectre V2 : Enabling IBPB for BPF348test # [ 0.235447] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier349test # [ 0.236447] active return thunk: srso_alias_return_thunk350second # [ 0.237711] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier351second # [ 0.238745] active return thunk: srso_alias_return_thunk352test # [ 0.237469] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'353second # [ 0.240766] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'354test # [ 0.239447] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'355second # [ 0.242744] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'356test # [ 0.241446] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'357second # [ 0.243743] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'358test # [ 0.242446] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'359test # [ 0.243446] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'360second # [ 0.244746] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'361second # [ 0.245745] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'362test # [ 0.245447] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'363second # [ 0.247744] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'364test # [ 0.246447] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'365test # [ 0.247447] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256366second # [ 0.248743] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'367test # [ 0.248447] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64368second # [ 0.249744] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256369test # [ 0.249446] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512370second # [ 0.250743] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64371test # [ 0.251446] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024372second # [ 0.252743] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512373test # [ 0.252446] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8374second # [ 0.253743] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024375test # [ 0.253446] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.376second # [ 0.254744] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8377second # [ 0.256743] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.378test # [ 0.281758] Freeing SMP alternatives memory: 44K379test # [ 0.282450] pid_max: default: 32768 minimum: 301380second # [ 0.284887] Freeing SMP alternatives memory: 44K381test # [ 0.283529] LSM: initializing lsm=capability,landlock,yama,bpf,ima382test # [ 0.284557] landlock: Up and running.383second # [ 0.285747] pid_max: default: 32768 minimum: 301384test # [ 0.286063] Yama: becoming mindful.385second # [ 0.286825] LSM: initializing lsm=capability,landlock,yama,bpf,ima386test # [ 0.286673] LSM support for eBPF active387second # [ 0.287829] landlock: Up and running.388second # [ 0.289386] Yama: becoming mindful.389test # [ 0.288196] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)390second # [ 0.290624] LSM support for eBPF active391test # [ 0.289465] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)392second # [ 0.291555] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)393second # [ 0.292763] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)394test # [ 0.292298] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)395test # [ 0.292879] Performance Events: Fam17h+ core perfctr, AMD PMU driver.396test # [ 0.293450] ... version: 2397second # [ 0.294969] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)398test # [ 0.294378] ... bit width: 48399test # [ 0.295172] ... generic counters: 6400second # [ 0.296257] Performance Events: Fam17h+ core perfctr, AMD PMU driver.401test # [ 0.295493] ... generic bitmap: 000000000000003f402second # [ 0.296757] ... version: 2403test # [ 0.296448] ... fixed-purpose counters: 0404second # [ 0.297745] ... bit width: 48405test # [ 0.297406] ... fixed-purpose bitmap: 0000000000000000406second # [ 0.298745] ... generic counters: 6407test # [ 0.298375] ... value mask: 0000ffffffffffff408second # [ 0.299745] ... generic bitmap: 000000000000003f409test # [ 0.299368] ... max period: 00007fffffffffff410second # [ 0.300752] ... fixed-purpose counters: 0411test # [ 0.300377] ... global_ctrl mask: 000000000000003f412second # [ 0.301735] ... fixed-purpose bitmap: 0000000000000000413test # [ 0.301494] signal: max sigframe size: 3376414second # [ 0.302668] ... value mask: 0000ffffffffffff415test # [ 0.302490] rcu: Hierarchical SRCU implementation.416second # [ 0.303675] ... max period: 00007fffffffffff417test # [ 0.303452] rcu: Max phase no-delay instances is 400.418second # [ 0.304667] ... global_ctrl mask: 000000000000003f419second # [ 0.305752] signal: max sigframe size: 3376420second # [ 0.306750] rcu: Hierarchical SRCU implementation.421second # [ 0.307747] rcu: Max phase no-delay instances is 400.422test # [ 0.307845] smp: Bringing up secondary CPUs ...423test # [ 0.308471] smp: Brought up 1 node, 1 CPU424test # [ 0.309367] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)425second # [ 0.312005] smp: Bringing up secondary CPUs ...426second # [ 0.312766] smp: Brought up 1 node, 1 CPU427test # [ 0.310655] Memory: 944512K/1048036K available (17135K kernel code, 2721K rwdata, 13540K rodata, 3644K init, 3000K bss, 96104K reserved, 0K cma-reserved)428second # [ 0.313726] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)429test # [ 0.311743] devtmpfs: initialized430test # [ 0.312655] x86/mm: Memory block size: 128MB431second # [ 0.314899] Memory: 944516K/1048036K available (17135K kernel code, 2721K rwdata, 13540K rodata, 3644K init, 3000K bss, 96116K reserved, 0K cma-reserved)432second # [ 0.315974] devtmpfs: initialized433test # [ 0.314255] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)434second # [ 0.316934] x86/mm: Memory block size: 128MB435test # [ 0.315489] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).436test # [ 0.316544] pinctrl core: initialized pinctrl subsystem437second # [ 0.318518] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)438test # [ 0.317707] PM: RTC time: 00:04:56, date: 2026-09-09439second # [ 0.319776] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).440second # [ 0.320869] pinctrl core: initialized pinctrl subsystem441second # [ 0.322080] PM: RTC time: 00:04:56, date: 2026-09-09442test # [ 0.320787] NET: Registered PF_NETLINK/PF_ROUTE protocol family443test # [ 0.321742] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations444test # [ 0.322469] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations445second # [ 0.325121] NET: Registered PF_NETLINK/PF_ROUTE protocol family446second # [ 0.326058] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations447test # [ 0.323584] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations448test # [ 0.324470] audit: initializing netlink subsys (disabled)449second # [ 0.326768] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations450test # [ 0.325770] thermal_sys: Registered thermal governor 'fair_share'451second # [ 0.327864] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations452test # [ 0.325772] thermal_sys: Registered thermal governor 'bang_bang'453second # [ 0.328761] audit: initializing netlink subsys (disabled)454test # [ 0.326454] audit: type=2000 audit(1788912297.071:1): state=initialized audit_enabled=0 res=1455second # [ 0.330019] thermal_sys: Registered thermal governor 'fair_share'456test # [ 0.328451] thermal_sys: Registered thermal governor 'step_wise'457second # [ 0.330021] thermal_sys: Registered thermal governor 'bang_bang'458second # [ 0.330745] thermal_sys: Registered thermal governor 'step_wise'459test # [ 0.328453] thermal_sys: Registered thermal governor 'user_space'460second # [ 0.331749] audit: type=2000 audit(1788912297.076:1): state=initialized audit_enabled=0 res=1461test # [ 0.329449] thermal_sys: Registered thermal governor 'power_allocator'462test # [ 0.330492] cpuidle: using governor menu463second # [ 0.333749] thermal_sys: Registered thermal governor 'user_space'464second # [ 0.333751] thermal_sys: Registered thermal governor 'power_allocator'465test # [ 0.333403] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5466second # [ 0.334769] cpuidle: using governor menu467test # [ 0.334696] PCI: Using configuration type 1 for base access468second # [ 0.337514] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5469test # [ 0.335448] PCI: Using configuration type 1 for extended access470second # [ 0.338998] PCI: Using configuration type 1 for base access471test # [ 0.336637] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.472second # [ 0.339745] PCI: Using configuration type 1 for extended access473second # [ 0.340935] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.474test # [ 0.343479] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages475second # [ 0.345960] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages476test # [ 0.344448] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page477second # [ 0.346745] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page478test # [ 0.349448] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages479second # [ 0.351745] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages480test # [ 0.350449] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page481second # [ 0.352745] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page482test # [ 0.357301] ACPI: Added _OSI(Module Device)483test # [ 0.358154] ACPI: Added _OSI(Processor Device)484test # [ 0.358448] ACPI: Added _OSI(Processor Aggregator Device)485second # [ 0.362381] ACPI: Added _OSI(Module Device)486second # [ 0.362758] ACPI: Added _OSI(Processor Device)487second # [ 0.363746] ACPI: Added _OSI(Processor Aggregator Device)488test # [ 0.364817] ACPI: 1 ACPI AML tables successfully acquired and loaded489second # [ 0.368132] ACPI: 1 ACPI AML tables successfully acquired and loaded490test # [ 0.368659] ACPI: Interpreter enabled491test # [ 0.369463] ACPI: PM: (supports S0 S3 S4 S5)492test # [ 0.370370] ACPI: Using IOAPIC for interrupt routing493second # [ 0.373932] ACPI: Interpreter enabled494second # [ 0.374759] ACPI: PM: (supports S0 S3 S4 S5)495second # [ 0.375673] ACPI: Using IOAPIC for interrupt routing496test # [ 0.373470] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug497test # [ 0.374449] PCI: Using E820 reservations for host bridge windows498second # [ 0.378154] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug499test # [ 0.375737] ACPI: Enabled 2 GPEs in block 00 to 0F500second # [ 0.378745] PCI: Using E820 reservations for host bridge windows501second # [ 0.379905] ACPI: Enabled 2 GPEs in block 00 to 0F502test # [ 0.379943] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])503second # [ 0.384072] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])504test # [ 0.380456] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]505test # [ 0.381747] acpiphp: Slot [3] registered506second # [ 0.384750] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]507test # [ 0.382487] acpiphp: Slot [4] registered508second # [ 0.386045] acpiphp: Slot [3] registered509test # [ 0.383417] acpiphp: Slot [5] registered510second # [ 0.386780] acpiphp: Slot [4] registered511test # [ 0.384170] acpiphp: Slot [6] registered512second # [ 0.387645] acpiphp: Slot [5] registered513test # [ 0.384480] acpiphp: Slot [7] registered514second # [ 0.388472] acpiphp: Slot [6] registered515test # [ 0.385457] acpiphp: Slot [8] registered516second # [ 0.388770] acpiphp: Slot [7] registered517test # [ 0.386411] acpiphp: Slot [9] registered518second # [ 0.389659] acpiphp: Slot [8] registered519test # [ 0.387176] acpiphp: Slot [10] registered520second # [ 0.390429] acpiphp: Slot [9] registered521second # [ 0.390769] acpiphp: Slot [10] registered522test # [ 0.387478] acpiphp: Slot [11] registered523second # [ 0.391660] acpiphp: Slot [11] registered524test # [ 0.388474] acpiphp: Slot [12] registered525second # [ 0.392432] acpiphp: Slot [12] registered526test # [ 0.389441] acpiphp: Slot [13] registered527second # [ 0.392770] acpiphp: Slot [13] registered528test # [ 0.390201] acpiphp: Slot [14] registered529second # [ 0.393664] acpiphp: Slot [14] registered530test # [ 0.390488] acpiphp: Slot [15] registered531second # [ 0.394426] acpiphp: Slot [15] registered532test # [ 0.391487] acpiphp: Slot [16] registered533second # [ 0.394779] acpiphp: Slot [16] registered534test # [ 0.392464] acpiphp: Slot [17] registered535second # [ 0.395722] acpiphp: Slot [17] registered536test # [ 0.393413] acpiphp: Slot [18] registered537second # [ 0.396456] acpiphp: Slot [18] registered538test # [ 0.394156] acpiphp: Slot [19] registered539second # [ 0.396782] acpiphp: Slot [19] registered540test # [ 0.394475] acpiphp: Slot [20] registered541second # [ 0.397674] acpiphp: Slot [20] registered542test # [ 0.395373] acpiphp: Slot [21] registered543second # [ 0.398425] acpiphp: Slot [21] registered544test # [ 0.396149] acpiphp: Slot [22] registered545second # [ 0.398768] acpiphp: Slot [22] registered546test # [ 0.396482] acpiphp: Slot [23] registered547second # [ 0.399668] acpiphp: Slot [23] registered548test # [ 0.397381] acpiphp: Slot [24] registered549second # [ 0.400428] acpiphp: Slot [24] registered550test # [ 0.398147] acpiphp: Slot [25] registered551second # [ 0.400769] acpiphp: Slot [25] registered552test # [ 0.398472] acpiphp: Slot [26] registered553second # [ 0.401647] acpiphp: Slot [26] registered554test # [ 0.399362] acpiphp: Slot [27] registered555second # [ 0.402453] acpiphp: Slot [27] registered556test # [ 0.400132] acpiphp: Slot [28] registered557test # [ 0.400472] acpiphp: Slot [29] registered558second # [ 0.402795] acpiphp: Slot [28] registered559test # [ 0.401390] acpiphp: Slot [30] registered560second # [ 0.404477] acpiphp: Slot [29] registered561test # [ 0.402157] acpiphp: Slot [31] registered562second # [ 0.404805] acpiphp: Slot [30] registered563test # [ 0.402473] PCI host bridge to bus 0000:00564second # [ 0.405711] acpiphp: Slot [31] registered565second # [ 0.406425] PCI host bridge to bus 0000:00566test # [ 0.403379] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]567second # [ 0.406751] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]568test # [ 0.404480] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]569second # [ 0.407746] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]570test # [ 0.405448] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]571second # [ 0.408745] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]572test # [ 0.406448] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]573second # [ 0.409747] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]574test # [ 0.407448] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]575second # [ 0.410747] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]576test # [ 0.408449] pci_bus 0000:00: root bus resource [bus 00-ff]577second # [ 0.411749] pci_bus 0000:00: root bus resource [bus 00-ff]578test # [ 0.409741] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint579second # [ 0.413046] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint580test # [ 0.411194] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint581second # [ 0.414470] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint582test # [ 0.413150] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint583second # [ 0.416444] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint584test # [ 0.415498] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]585second # [ 0.418794] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]586test # [ 0.416499] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk587second # [ 0.419794] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk588test # [ 0.417449] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk589second # [ 0.420745] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk590test # [ 0.418449] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk591second # [ 0.421746] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk592test # [ 0.419448] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk593second # [ 0.422746] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk594test # [ 0.420791] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint595second # [ 0.424062] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint596test # [ 0.422499] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]597second # [ 0.425799] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]598test # [ 0.424420] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint599second # [ 0.427711] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint600test # [ 0.425926] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI601second # [ 0.429256] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI602test # [ 0.426459] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB603second # [ 0.429758] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB604test # [ 0.427766] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint605second # [ 0.431093] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint606test # [ 0.430444] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]607test # [ 0.431470] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]608second # [ 0.433767] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]609test # [ 0.432487] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]610second # [ 0.434766] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]611test # [ 0.433627] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]612second # [ 0.435792] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]613second # [ 0.436930] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]614test # [ 0.435292] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint615second # [ 0.438597] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint616test # [ 0.438165] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]617test # [ 0.438459] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]618second # [ 0.441756] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]619test # [ 0.439488] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]620second # [ 0.442756] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]621test # [ 0.440458] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]622second # [ 0.443791] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]623second # [ 0.444756] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]624test # [ 0.443141] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint625test # [ 0.445973] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]626second # [ 0.447403] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint627test # [ 0.446459] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]628test # [ 0.447488] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]629second # [ 0.449515] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]630second # [ 0.449756] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]631second # [ 0.450785] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]632test # [ 0.449983] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint633second # [ 0.453340] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint634test # [ 0.451459] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]635test # [ 0.452459] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]636test # [ 0.453488] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]637second # [ 0.455756] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]638second # [ 0.456756] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]639second # [ 0.457784] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]640test # [ 0.455980] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint641test # [ 0.457459] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]642second # [ 0.460250] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint643test # [ 0.458459] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]644test # [ 0.459491] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]645second # [ 0.461756] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]646second # [ 0.462756] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]647test # [ 0.461958] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint648second # [ 0.463785] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]649test # [ 0.463459] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]650second # [ 0.466239] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint651second # [ 0.467756] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]652test # [ 0.464460] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]653test # [ 0.466480] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]654second # [ 0.468755] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]655test # [ 0.468988] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint656second # [ 0.470780] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]657second # [ 0.473400] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint658test # [ 0.471462] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]659test # [ 0.472459] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]660test # [ 0.473488] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]661second # [ 0.475758] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]662second # [ 0.476757] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]663second # [ 0.477785] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]664test # [ 0.476103] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint665second # [ 0.480486] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint666test # [ 0.478266] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]667test # [ 0.479401] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]668test # [ 0.480467] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]669second # [ 0.483755] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]670second # [ 0.484757] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]671test # [ 0.481460] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]672second # [ 0.485789] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]673second # [ 0.486757] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]674test # [ 0.484036] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint675second # [ 0.489293] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint676test # [ 0.485923] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]677test # [ 0.486491] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]678second # [ 0.491100] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]679second # [ 0.491792] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]680test # [ 0.488978] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint681second # [ 0.494261] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint682test # [ 0.490459] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]683test # [ 0.491460] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]684second # [ 0.496397] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]685test # [ 0.492491] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]686second # [ 0.496758] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]687second # [ 0.497911] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]688test # [ 0.495035] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint689test # [ 0.496459] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]690second # [ 0.500351] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint691test # [ 0.497459] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]692second # [ 0.501756] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]693test # [ 0.498495] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]694second # [ 0.502763] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]695second # [ 0.503784] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]696test # [ 0.504866] ACPI: PCI: Interrupt link LNKA configured for IRQ 10697test # [ 0.505606] ACPI: PCI: Interrupt link LNKB configured for IRQ 10698test # [ 0.506662] ACPI: PCI: Interrupt link LNKC configured for IRQ 11699second # [ 0.510448] ACPI: PCI: Interrupt link LNKA configured for IRQ 10700second # [ 0.510928] ACPI: PCI: Interrupt link LNKB configured for IRQ 10701test # [ 0.507804] ACPI: PCI: Interrupt link LNKD configured for IRQ 11702second # [ 0.511892] ACPI: PCI: Interrupt link LNKC configured for IRQ 11703test # [ 0.508535] ACPI: PCI: Interrupt link LNKS configured for IRQ 9704second # [ 0.512877] ACPI: PCI: Interrupt link LNKD configured for IRQ 11705test # [ 0.510308] iommu: Default domain type: Translated706second # [ 0.513838] ACPI: PCI: Interrupt link LNKS configured for IRQ 9707test # [ 0.511302] iommu: DMA domain TLB invalidation policy: lazy mode708test # [ 0.512702] ACPI: bus type USB registered709second # [ 0.515625] iommu: Default domain type: Translated710test # [ 0.513501] usbcore: registered new interface driver usbfs711second # [ 0.516538] iommu: DMA domain TLB invalidation policy: lazy mode712test # [ 0.514478] usbcore: registered new interface driver hub713second # [ 0.517970] ACPI: bus type USB registered714test # [ 0.515460] usbcore: registered new device driver usb715second # [ 0.518796] usbcore: registered new interface driver usbfs716test # [ 0.517210] NetLabel: Initializing717second # [ 0.519770] usbcore: registered new interface driver hub718test # [ 0.517452] NetLabel: domain hash size = 128719second # [ 0.520757] usbcore: registered new device driver usb720test # [ 0.518391] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO721second # [ 0.522480] NetLabel: Initializing722test # [ 0.519447] NetLabel: unlabeled traffic allowed by default723second # [ 0.522753] NetLabel: domain hash size = 128724test # [ 0.520458] PCI: Using ACPI for IRQ routing725second # [ 0.523690] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO726test # [ 0.521878] pci 0000:00:02.0: vgaarb: setting as boot VGA device727second # [ 0.524728] NetLabel: unlabeled traffic allowed by default728second # [ 0.525717] PCI: Using ACPI for IRQ routing729test # [ 0.522444] pci 0000:00:02.0: vgaarb: bridge control possible730second # [ 0.526968] pci 0000:00:02.0: vgaarb: setting as boot VGA device731test # [ 0.522444] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none732test # [ 0.522450] vgaarb: loaded733second # [ 0.527741] pci 0000:00:02.0: vgaarb: bridge control possible734test # [ 0.523287] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0735second # [ 0.527741] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none736test # [ 0.524257] hpet0: 3 comparators, 64-bit 100.000000 MHz counter737second # [ 0.527748] vgaarb: loaded738second # [ 0.528580] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0739second # [ 0.529543] hpet0: 3 comparators, 64-bit 100.000000 MHz counter740test # [ 0.527549] clocksource: Switched to clocksource kvm-clock741test # [ 0.530685] VFS: Disk quotas dquot_6.6.0742second # [ 0.533824] clocksource: Switched to clocksource kvm-clock743test # [ 0.531587] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)744test # [ 0.533243] pnp: PnP ACPI init745test # [ 0.534474] pnp: PnP ACPI: found 6 devices746second # [ 0.537154] VFS: Disk quotas dquot_6.6.0747second # [ 0.538059] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)748second # [ 0.539666] pnp: PnP ACPI init749second # [ 0.540909] pnp: PnP ACPI: found 6 devices750test # [ 0.541730] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns751test # [ 0.543522] clocksource: Switched to clocksource acpi_pm752test # [ 0.544725] NET: Registered PF_INET protocol family753second # [ 0.548161] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns754test # [ 0.545962] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)755second # [ 0.549983] clocksource: Switched to clocksource acpi_pm756second # [ 0.551177] NET: Registered PF_INET protocol family757second # [ 0.552466] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)758test # [ 0.560001] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)759test # [ 0.561978] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)760test # [ 0.563676] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)761second # [ 0.566710] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)762test # [ 0.565353] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)763second # [ 0.568608] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)764test # [ 0.566928] TCP: Hash tables configured (established 8192 bind 8192)765second # [ 0.570255] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)766test # [ 0.568389] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)767second # [ 0.571939] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)768test # [ 0.569998] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)769second # [ 0.573490] TCP: Hash tables configured (established 8192 bind 8192)770test # [ 0.571468] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)771second # [ 0.574907] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)772test # [ 0.572988] NET: Registered PF_UNIX/PF_LOCAL protocol family773test # [ 0.574286] NET: Registered PF_XDP protocol family774second # [ 0.576506] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)775test # [ 0.575379] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]776second # [ 0.577917] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)777test # [ 0.576685] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]778second # [ 0.579506] NET: Registered PF_UNIX/PF_LOCAL protocol family779second # [ 0.580732] NET: Registered PF_XDP protocol family780test # [ 0.578012] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]781second # [ 0.581856] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]782test # [ 0.579519] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]783second # [ 0.583282] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]784test # [ 0.580977] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]785second # [ 0.584654] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]786test # [ 0.582571] pci 0000:00:01.0: PIIX3: Enabling Passive Release787test # [ 0.583844] pci 0000:00:00.0: Limiting direct PCI/PCI transfers788second # [ 0.586354] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]789test # [ 0.586298] ACPI: \_SB_.LNKD: Enabled at IRQ 11790second # [ 0.588324] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]791second # [ 0.589959] pci 0000:00:01.0: PIIX3: Enabling Passive Release792test # [ 0.588747] PCI: CLS 0 bytes, default 64793second # [ 0.591235] pci 0000:00:00.0: Limiting direct PCI/PCI transfers794test # [ 0.589827] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns795second # [ 0.593736] ACPI: \_SB_.LNKD: Enabled at IRQ 11796test # [ 0.592001] Trying to unpack rootfs image as initramfs...797second # [ 0.596435] PCI: CLS 0 bytes, default 64798second # [ 0.597542] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns799second # [ 0.599938] Trying to unpack rootfs image as initramfs...800test # [ 0.627920] Initialise system trusted keyrings801test # [ 0.631254] workingset: timestamp_bits=40 max_order=18 bucket_order=0802second # [ 0.638942] Initialise system trusted keyrings803second # [ 0.640127] workingset: timestamp_bits=40 max_order=18 bucket_order=0804test # [ 0.646561] Key type asymmetric registered805test # [ 0.651215] Asymmetric key parser 'x509' registered806test # [ 0.652393] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)807second # [ 0.659538] Key type asymmetric registered808test # [ 0.657344] io scheduler mq-deadline registered809second # [ 0.660526] Asymmetric key parser 'x509' registered810test # [ 0.658374] io scheduler kyber registered811second # [ 0.663464] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)812test # [ 0.661716] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled813second # [ 0.668445] io scheduler mq-deadline registered814test # [ 0.665380] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A815second # [ 0.669465] io scheduler kyber registered816second # [ 0.673010] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled817test # [ 0.671109] Linux agpgart interface v0.103818test # [ 0.674236] ACPI: bus type drm_connector registered819second # [ 0.677693] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A820second # [ 0.680140] Linux agpgart interface v0.103821test # [ 0.677328] usbcore: registered new interface driver usbserial_generic822second # [ 0.681113] ACPI: bus type drm_connector registered823test # [ 0.678692] usbserial: USB Serial support registered for generic824test # [ 0.682205] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.825second # [ 0.685797] usbcore: registered new interface driver usbserial_generic826test # [ 0.682205] Please enable it if your BIOS has the CPPC option.827second # [ 0.687216] usbserial: USB Serial support registered for generic828test # [ 0.685070] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled829second # [ 0.690405] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.830second # [ 0.690405] Please enable it if your BIOS has the CPPC option.831test # [ 0.690330] drop_monitor: Initializing network drop monitor service832second # [ 0.693273] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled833test # [ 0.691817] NET: Registered PF_INET6 protocol family834second # [ 0.697557] drop_monitor: Initializing network drop monitor service835test # [ 0.695623] Segment Routing with IPv6836second # [ 0.699020] NET: Registered PF_INET6 protocol family837test # [ 0.699221] In-situ OAM (IOAM) with IPv6838test # [ 0.700511] IPI shorthand broadcast: enabled839second # [ 0.703844] Segment Routing with IPv6840second # [ 0.706424] In-situ OAM (IOAM) with IPv6841second # [ 0.707653] IPI shorthand broadcast: enabled842test # [ 0.705989] sched_clock: Marking stable (531022281, 174162924)->(803871656, -98686451)843second # [ 0.713236] sched_clock: Marking stable (538022647, 174368890)->(808454174, -96062637)844test # [ 0.712561] registered taskstats version 1845test # [ 0.713663] Loading compiled-in X.509 certificates846second # [ 0.719801] registered taskstats version 1847second # [ 0.720899] Loading compiled-in X.509 certificates848test # [ 0.728550] Demotion targets for Node 0: null849test # [ 0.732260] Key type .fscrypt registered850test # [ 0.733094] Key type fscrypt-provisioning registered851second # [ 0.736713] Demotion targets for Node 0: null852test # [ 0.734284] ima: No TPM chip found, activating TPM-bypass!853test # [ 0.735423] ima: Allocated hash algorithm: sha1854second # [ 0.740453] Key type .fscrypt registered855second # [ 0.741292] Key type fscrypt-provisioning registered856second # [ 0.742485] ima: No TPM chip found, activating TPM-bypass!857test # [ 0.740222] ima: No architecture policies found858second # [ 0.743632] ima: Allocated hash algorithm: sha1859test # [ 0.741344] PM: Magic number: 10:204:51860test # [ 0.742886] RAS: Correctable Errors collector initialized.861second # [ 0.746439] ima: No architecture policies found862second # [ 0.749403] PM: Magic number: 10:204:51863second # [ 0.751150] RAS: Correctable Errors collector initialized.864test # [ 0.751920] clk: Disabling unused clocks865test # [ 0.752802] PM: genpd: Disabling unused power domains866second # [ 0.759164] clk: Disabling unused clocks867second # [ 0.761416] PM: genpd: Disabling unused power domains868test # [ 0.867868] Freeing initrd memory: 27600K869test # [ 0.870872] Freeing unused decrypted memory: 2028K870test # [ 0.873557] Freeing unused kernel image (initmem) memory: 3644K871test # [ 0.874892] Write protecting the kernel read-only data: 32768k872test # [ 0.876949] Freeing unused kernel image (text/rodata gap) memory: 1296K873test # [ 0.878764] Freeing unused kernel image (rodata/data gap) memory: 796K874second # [ 0.883878] Freeing initrd memory: 27612K875second # [ 0.887300] Freeing unused decrypted memory: 2028K876second # [ 0.889996] Freeing unused kernel image (initmem) memory: 3644K877second # [ 0.891348] Write protecting the kernel read-only data: 32768k878second # [ 0.893440] Freeing unused kernel image (text/rodata gap) memory: 1296K879second # [ 0.895226] Freeing unused kernel image (rodata/data gap) memory: 796K880test # [ 0.912224] x86/mm: Checked W+X mappings: passed, no W+X pages found.881test # [ 0.913610] Run /init as init process882test # [ 0.922407] systemd[1]: Inserted module 'autofs4'883second # [ 0.928778] x86/mm: Checked W+X mappings: passed, no W+X pages found.884second # [ 0.930186] Run /init as init process885test # [ 0.934819] fuse: init (API version 7.45)886second # [ 0.939198] systemd[1]: Inserted module 'autofs4'887test # [ 0.940333] ACPI: \_SB_.LNKC: Enabled at IRQ 10888test # [ 0.946505] ACPI: \_SB_.LNKA: Enabled at IRQ 10889second # [ 0.951842] fuse: init (API version 7.45)890test # [ 0.949651] ACPI: \_SB_.LNKB: Enabled at IRQ 11891second # [ 0.957312] ACPI: \_SB_.LNKC: Enabled at IRQ 10892second # [ 0.963434] ACPI: \_SB_.LNKA: Enabled at IRQ 10893second # [ 0.966557] ACPI: \_SB_.LNKB: Enabled at IRQ 11894test # [ 0.979085] systemd[1]: Successfully made /usr/ read-only.895second # [ 0.994956] systemd[1]: Successfully made /usr/ read-only.896test # [ 1.315922] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)897test # [ 1.322106] systemd[1]: Detected virtualization kvm.898test # [ 1.323225] systemd[1]: Detected architecture x86-64.899test # [ 1.324334] systemd[1]: Running in initrd.900test # [ 1.325545] systemd[1]: Initializing machine ID from random generator.901test # [ 1.327006] systemd[1]: Hostname set to <test>.902second # [ 1.331240] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)903second # [ 1.337301] systemd[1]: Detected virtualization kvm.904second # [ 1.338444] systemd[1]: Detected architecture x86-64.905second # [ 1.339572] systemd[1]: Running in initrd.906second # [ 1.340814] systemd[1]: Initializing machine ID from random generator.907second # [ 1.342261] systemd[1]: Hostname set to <second>.908test # [ 1.364466] systemd[1]: Queued start job for default target Initrd Default Target.909test # [ 1.368348] systemd[1]: Created slice Slice /system/modprobe.910test # [ 1.369754] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.911test # [ 1.371436] systemd[1]: Expecting device /dev/disk/by-label/nixos...912test # [ 1.372800] systemd[1]: Reached target Path Units.913test # [ 1.373884] systemd[1]: Reached target Slice Units.914test # [ 1.375010] systemd[1]: Reached target Swaps.915test # [ 1.376020] systemd[1]: Reached target Timer Units.916second # [ 1.379282] systemd[1]: Queued start job for default target Initrd Default Target.917test # [ 1.377244] systemd[1]: Listening on D-Bus System Message Bus Socket.918test # [ 1.378705] systemd[1]: Listening on Journal Socket (/dev/log).919test # [ 1.380129] systemd[1]: Listening on Journal Sockets.920second # [ 1.383566] systemd[1]: Created slice Slice /system/modprobe.921test # [ 1.381360] systemd[1]: Listening on udev Control Socket.922test # [ 1.382602] systemd[1]: Listening on udev Kernel Socket.923second # [ 1.384959] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.924test # [ 1.383787] systemd[1]: Reached target Socket Units.925second # [ 1.386643] systemd[1]: Expecting device /dev/disk/by-label/nixos...926second # [ 1.387992] systemd[1]: Reached target Path Units.927test # [ 1.385663] systemd[1]: Starting Create List of Static Device Nodes...928second # [ 1.389070] systemd[1]: Reached target Slice Units.929second # [ 1.390162] systemd[1]: Reached target Swaps.930second # [ 1.391160] systemd[1]: Reached target Timer Units.931second # [ 1.392346] systemd[1]: Listening on D-Bus System Message Bus Socket.932test # [ 1.389976] systemd[1]: Starting Load Kernel Module 9pnet_virtio...933second # [ 1.393846] systemd[1]: Listening on Journal Socket (/dev/log).934second # [ 1.395296] systemd[1]: Listening on Journal Sockets.935second # [ 1.396582] systemd[1]: Listening on udev Control Socket.936second # [ 1.397876] systemd[1]: Listening on udev Kernel Socket.937second # [ 1.399088] systemd[1]: Reached target Socket Units.938test # [ 1.396755] systemd[1]: Starting Load Kernel Module configfs...939second # [ 1.401119] systemd[1]: Starting Create List of Static Device Nodes...940second # [ 1.405105] systemd[1]: Starting Load Kernel Module 9pnet_virtio...941second # [ 1.412014] systemd[1]: Starting Load Kernel Module configfs...942test # [ 1.409048] systemd[1]: Starting Journal Service...943test # [ 1.419658] systemd[1]: Starting Load Kernel Modules...944second # [ 1.425463] systemd[1]: Starting Journal Service...945test # [ 1.426736] netfs: FS-Cache loaded946test # [ 1.428332] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki947second # [ 1.437562] systemd[1]: Starting Load Kernel Modules...948test # [ 1.437781] 9pnet: Installing 9P2000 support949second # [ 1.440931] netfs: FS-Cache loaded950test # [ 1.441553] systemd[1]: Starting Coldplug All udev Devices...951second # [ 1.443506] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki952second # [ 1.453002] 9pnet: Installing 9P2000 support953second # [ 1.456598] systemd[1]: Starting Coldplug All udev Devices...954test # [ 1.458797] systemd-journald[67]: Collecting audit messages is disabled.955test # [ 1.460910] systemd[1]: Finished Create List of Static Device Nodes.956second # [ 1.475034] systemd-journald[67]: Collecting audit messages is disabled.957second # [ 1.478501] systemd[1]: Finished Create List of Static Device Nodes.958test # [ 1.469236] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.959test # [ 1.482521] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.960second # [ 1.482997] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.961test # [ 1.493343] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev962second # [ 1.501604] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.963test # [ 1.510255] systemd[1]: Finished Load Kernel Module 9pnet_virtio.964second # [ 1.512536] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev965test # [ 1.515680] systemd[1]: modprobe@configfs.service: Deactivated successfully.966second # [ 1.524989] systemd[1]: Finished Load Kernel Module 9pnet_virtio.967test # [ 1.523277] systemd[1]: Finished Load Kernel Module configfs.968test # [ 1.530346] systemd[1]: Finished Load Kernel Modules.969second # [ 1.533845] systemd[1]: modprobe@configfs.service: Deactivated successfully.970test # [ 1.534838] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config971second # [ 1.539453] systemd[1]: Finished Load Kernel Module configfs.972second # [ 1.547530] systemd[1]: Finished Load Kernel Modules.973test # [ 1.545279] systemd[1]: Starting Apply Kernel Variables...974second # [ 1.551004] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config975test # [ 1.555869] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...976second # [ 1.562466] systemd[1]: Starting Apply Kernel Variables...977second # [ 1.572450] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...978test # [ 1.582620] systemd[1]: Finished Apply Kernel Variables.979test # [ 1.594860] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.980second # [ 1.601462] systemd[1]: Finished Apply Kernel Variables.981test # [ 1.600632] systemd[1]: Started Journal Service.982test # [ 1.425751] systemd-modules-load[68]: Inserted module 'dm_mod'983test # [ 1.429316] systemd-modules-load[68]: Inserted module 'virtio_balloon'984second # [ 1.607485] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.985test # [ 1.431352] systemd-modules-load[68]: Inserted module 'virtio_gpu'986test # [ 1.436762] systemd[1]: Starting Create Static Device Nodes in /dev...987second # [ 1.616584] systemd[1]: Starting Create Static Device Nodes in /dev...988second # [ 1.445678] systemd-modules-load[68]: Inserted module 'dm_mod'989second # [ 1.448233] systemd-modules-load[68]: Inserted module 'virtio_balloon'990second # [ 1.449579] systemd-modules-load[68]: Inserted module 'virtio_gpu'991second # [ 1.628574] systemd[1]: Started Journal Service.992test # [ 1.460205] systemd[1]: Finished Create Static Device Nodes in /dev.993test # [ 1.461926] systemd[1]: Reached target Preparation for Local File Systems.994test # [ 1.464712] systemd[1]: Reached target Local File Systems.995test # [ 1.466136] systemd[1]: Starting Create System Files and Directories...996second # [ 1.472244] systemd[1]: Finished Create Static Device Nodes in /dev.997second # [ 1.474336] systemd[1]: Reached target Preparation for Local File Systems.998second # [ 1.475638] systemd[1]: Reached target Local File Systems.999test # [ 1.473246] systemd[1]: Starting Rule-based Manager for Device Events and Files...1000second # [ 1.480081] systemd[1]: Starting Create System Files and Directories...1001second # [ 1.486081] systemd[1]: Starting Rule-based Manager for Device Events and Files...1002test # [ 1.493953] systemd[1]: Finished Create System Files and Directories.1003second # [ 1.507228] systemd[1]: Finished Create System Files and Directories.1004test # [ 1.512347] systemd-udevd[82]: Using default interface naming scheme 'v260'.1005second # [ 1.524296] systemd-udevd[83]: Using default interface naming scheme 'v260'.1006test # [ 1.535873] systemd[1]: Started Rule-based Manager for Device Events and Files.1007test # [ 1.541140] systemd[1]: Finished Coldplug All udev Devices.1008test # [ 1.542265] systemd[1]: Reached target System Initialization.1009test # [ 1.544192] systemd[1]: Reached target Basic System.1010second # [ 1.549106] systemd[1]: Started Rule-based Manager for Device Events and Files.1011second # [ 1.561167] systemd[1]: Finished Coldplug All udev Devices.1012second # [ 1.563735] systemd[1]: Reached target System Initialization.1013second # [ 1.564833] systemd[1]: Reached target Basic System.1014test # [ 1.915702] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121015second # [ 1.931936] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121016test # [ 1.933694] serio: i8042 KBD port at 0x60,0x64 irq 11017test # [ 1.934557] serio: i8042 AUX port at 0x60,0x64 irq 121018test # [ 1.947575] virtio_blk virtio5: 1/0/0 default/read/poll queues1019second # [ 1.957195] serio: i8042 KBD port at 0x60,0x64 irq 11020second # [ 1.965846] uhci_hcd 0000:00:01.2: UHCI Host Controller1021second # [ 1.967211] serio: i8042 AUX port at 0x60,0x64 irq 121022test # [ 1.975812] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1023second # [ 1.979927] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11024test # [ 1.983692] uhci_hcd 0000:00:01.2: UHCI Host Controller1025second # [ 1.986687] uhci_hcd 0000:00:01.2: detected 2 ports1026second # [ 1.988137] virtio_blk virtio5: 1/0/0 default/read/poll queues1027second # [ 1.994038] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1001028test # [ 1.995840] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11029second # [ 1.999919] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1030test # [ 1.999072] uhci_hcd 0000:00:01.2: detected 2 ports1031second # [ 2.001797] SCSI subsystem initialized1032test # [ 2.003089] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1001033second # [ 2.007209] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181034test # [ 2.007536] SCSI subsystem initialized1035test # [ 2.011534] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181036test # [ 2.012996] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11037second # [ 2.018985] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11038second # [ 2.020248] usb usb1: Product: UHCI Host Controller1039second # [ 2.034016] usb usb1: Manufacturer: Linux 6.18.49 uhci_hcd1040test # [ 2.036322] usb usb1: Product: UHCI Host Controller1041test # [ 2.037125] usb usb1: Manufacturer: Linux 6.18.49 uhci_hcd1042second # [ 2.039972] usb usb1: SerialNumber: 0000:00:01.21043second # [ 2.045918] hub 1-0:1.0: USB hub found1044test # [ 2.043641] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01045test # [ 1.873858] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1046test # [ 1.877910] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1047second # [ 2.055527] hub 1-0:1.0: 2 ports detected1048test # [ 2.055206] usb usb1: SerialNumber: 0000:00:01.21049test # [ 1.885720] systemd[1]: Starting Virtual Console Setup...1050second # [ 1.894968] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1051second # [ 2.072638] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01052test # [ 2.073238] hub 1-0:1.0: USB hub found1053test # [ 2.078350] hub 1-0:1.0: 2 ports detected1054second # [ 1.909888] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1055second # [ 1.913072] systemd[1]: Starting Virtual Console Setup...1056test # [ 1.916548] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1057test # [ 1.919566] systemd[1]: Finished Virtual Console Setup.1058test # [ 1.928142] systemd[1]: Found device /dev/disk/by-label/nixos.1059test # [ 1.929341] systemd[1]: Reached target Initrd Root Device.1060test # [ 1.933083] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1061second # [ 1.955130] systemd[1]: Found device /dev/disk/by-label/nixos.1062second # [ 1.956392] systemd[1]: Reached target Initrd Root Device.1063second # [ 1.957877] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1064second # [ 1.961087] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1065test # [ 1.960704] systemd-fsck[106]: nixos: clean, 12/65536 files, 13019/262144 blocks1066second # [ 1.967700] systemd[1]: Finished Virtual Console Setup.1067test # [ 1.970583] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1068second # [ 2.148145] scsi host0: ata_piix1069test # [ 2.146355] scsi host0: ata_piix1070test # [ 2.148691] scsi host1: ata_piix1071test # [ 2.150412] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 01072second # [ 2.153811] scsi host1: ata_piix1073test # [ 2.152521] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 01074second # [ 2.156560] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 01075second # [ 2.159943] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 01076second # [ 1.992288] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks1077second # [ 1.997731] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1078second # [ 2.283417] usb 1-1: new full-speed USB device number 2 using uhci_hcd1079test # [ 2.307578] ata2: found unknown device (class 0)1080test # [ 2.308949] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001081test # [ 2.312076] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51082second # [ 2.315863] ata2: found unknown device (class 0)1083second # [ 2.317221] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001084test # [ 2.315202] usb 1-1: new full-speed USB device number 2 using uhci_hcd1085second # [ 2.319448] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51086test # [ 2.336737] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1087second # [ 2.343939] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1088test # [ 2.345493] cdrom: Uniform CD-ROM driver Revision: 3.201089second # [ 2.352700] cdrom: Uniform CD-ROM driver Revision: 3.201090second # [ 2.449966] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001091second # [ 2.451316] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101092second # [ 2.452859] usb 1-1: Product: QEMU USB Tablet1093second # [ 2.453727] usb 1-1: Manufacturer: QEMU1094second # [ 2.454538] usb 1-1: SerialNumber: 28754-0000:00:01.2-11095test # [ 2.282734] systemd[1]: Mounting /sysroot...1096second # [ 2.467265] hid: raw HID events driver (C) Jiri Kosina1097second # [ 2.298726] systemd[1]: Mounting /sysroot...1098second # [ 2.476185] usbcore: registered new interface driver usbhid1099second # [ 2.478607] usbhid: USB HID core driver1100test # [ 2.482074] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001101test # [ 2.483433] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101102second # [ 2.485679] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21103test # [ 2.487182] usb 1-1: Product: QEMU USB Tablet1104test # [ 2.487898] usb 1-1: Manufacturer: QEMU1105second # [ 2.489613] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01106test # [ 2.490180] usb 1-1: SerialNumber: 28754-0000:00:01.2-11107test # [ 2.516391] hid: raw HID events driver (C) Jiri Kosina1108test # [ 2.526492] usbcore: registered new interface driver usbhid1109test # [ 2.529581] EXT4-fs (vda): mounted filesystem 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f r/w with ordered data mode. Quota mode: none.1110test # [ 2.531814] usbhid: USB HID core driver1111test # [ 2.363218] systemd[1]: Mounted /sysroot.1112test # [ 2.539078] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21113test # [ 2.367764] systemd[1]: Reached target Initrd Root File System.1114second # [ 2.545233] EXT4-fs (vda): mounted filesystem f50fd241-d8d6-4d19-bf09-b4298b3a2ef8 r/w with ordered data mode. Quota mode: none.1115test # [ 2.370075] systemd[1]: Starting Mountpoints Configured in the Real Root...1116second # [ 2.374642] systemd[1]: Mounted /sysroot.1117test # [ 2.546453] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01118second # [ 2.376265] systemd[1]: Reached target Initrd Root File System.1119second # [ 2.378228] systemd[1]: Starting Mountpoints Configured in the Real Root...1120test # [ 2.382650] systemd-sysroot-fstab-check[126]: /sysroot should be mounted in the initrd, will request daemon-reload.1121second # [ 2.388357] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload.1122test # [ 2.385965] systemd[1]: Reload requested from client PID 126 ('systemd-sysroot') (unit initrd-parse-etc.service)...1123test # [ 2.388309] systemd[1]: Reloading...1124second # [ 2.391161] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)...1125second # [ 2.393048] systemd[1]: Reloading...1126second # [ 2.447169] systemd[1]: Reloading finished in 53 ms.1127test # [ 2.449763] systemd[1]: Reloading finished in 60 ms.1128second # [ 2.452582] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace...1129second # [ 2.455880] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1130second # [ 2.457745] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace...1131test # [ 2.456073] systemd-sysroot-fstab-check[126]: Requesting initrd-fs.target/start/replace...1132second # [ 2.460561] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1133test # [ 2.459098] systemd-sysroot-fstab-check[126]: Requesting swap.target/start/replace...1134second # [ 2.461809] systemd[1]: Finished Mountpoints Configured in the Real Root.1135second # [ 2.464115] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1136test # [ 2.463117] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1137test # [ 2.464473] systemd[1]: Finished Mountpoints Configured in the Real Root.1138test # [ 2.465810] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1139test # [ 2.468346] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1140test # [ 3.283664] systemd[1]: Mounting /sysroot/nix/.ro-store...1141test # [ 3.287143] systemd[1]: Mounting /sysroot/nix/.rw-store...1142test # [ 3.289135] systemd[1]: Mounting /sysroot/run...1143test # [ 3.294618] systemd[1]: Mounting /sysroot/tmp/shared...1144test # [ 3.296529] systemd[1]: Mounting /sysroot/tmp/xchg...1145second # [ 3.299615] systemd[1]: Mounting /sysroot/nix/.ro-store...1146second # [ 3.302663] systemd[1]: Mounting /sysroot/nix/.rw-store...1147second # [ 3.307722] systemd[1]: Mounting /sysroot/run...1148second # [ 3.311082] systemd[1]: Mounting /sysroot/tmp/shared...1149test # [ 3.313847] systemd[1]: Mounted /sysroot/nix/.rw-store.1150second # [ 3.316426] systemd[1]: Mounting /sysroot/tmp/xchg...1151test # [ 3.496229] 9p: Installing v9fs 9p2000 file system support1152test # [ 3.325181] systemd[1]: Mounted /sysroot/run.1153second # [ 3.505667] 9p: Installing v9fs 9p2000 file system support1154second # [ 3.333677] systemd[1]: Mounted /sysroot/run.1155test # [ 3.333606] systemd[1]: Mounted /sysroot/nix/.ro-store.1156test # [ 3.334935] systemd[1]: Mounted /sysroot/tmp/shared.1157test # [ 3.336168] systemd[1]: Mounted /sysroot/tmp/xchg.1158second # [ 3.339621] systemd[1]: Mounted /sysroot/nix/.ro-store.1159test # [ 3.340199] systemd[1]: Starting rw-sysroot-nix-store.service...1160second # [ 3.342730] systemd[1]: Mounted /sysroot/nix/.rw-store.1161second # [ 3.344266] systemd[1]: Mounted /sysroot/tmp/shared.1162second # [ 3.347918] systemd[1]: Mounted /sysroot/tmp/xchg.1163second # [ 3.350773] systemd[1]: Starting rw-sysroot-nix-store.service...1164test # [ 3.349673] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1165test # [ 3.351573] systemd[1]: Finished rw-sysroot-nix-store.service.1166test # [ 3.353775] systemd[1]: Mounting /sysroot/nix/store...1167second # [ 3.359914] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1168second # [ 3.361725] systemd[1]: Finished rw-sysroot-nix-store.service.1169second # [ 3.363963] systemd[1]: Mounting /sysroot/nix/store...1170test # [ 3.370579] systemd[1]: Mounted /sysroot/nix/store.1171test # [ 3.371902] systemd[1]: Reached target Initrd File Systems.1172test # [ 3.373634] systemd[1]: Starting Find NixOS closure...1173test # [ 3.377130] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1174second # [ 3.380275] systemd[1]: Mounted /sysroot/nix/store.1175second # [ 3.381655] systemd[1]: Reached target Initrd File Systems.1176second # [ 3.383877] systemd[1]: Starting Find NixOS closure...1177second # [ 3.387129] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1178test # [ 3.393438] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1179second # [ 3.399889] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1180test # [ 3.398434] systemd[1]: Finished Find NixOS closure.1181test # [ 3.399900] systemd[1]: Reached target Initrd Default Target.1182test # [ 3.402099] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1183second # [ 3.405781] systemd[1]: Finished Find NixOS closure.1184second # [ 3.407917] systemd[1]: Reached target Initrd Default Target.1185second # [ 3.409217] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1186test # [ 3.413746] systemd[1]: Stopped target Initrd Default Target.1187test # [ 3.415081] systemd[1]: Stopped target Basic System.1188test # [ 3.416171] systemd[1]: Stopped target Initrd Root Device.1189test # [ 3.417342] systemd[1]: Stopped target Path Units.1190second # [ 3.419954] systemd[1]: Stopped target Initrd Default Target.1191second # [ 3.421557] systemd[1]: Stopped target Basic System.1192test # [ 3.419142] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1193second # [ 3.422726] systemd[1]: Stopped target Initrd Root Device.1194test # [ 3.420431] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1195second # [ 3.424031] systemd[1]: Stopped target Path Units.1196test # [ 3.421850] systemd[1]: Stopped target Slice Units.1197test # [ 3.422784] systemd[1]: Stopped target Socket Units.1198test # [ 3.423915] systemd[1]: Stopped target System Initialization.1199second # [ 3.426143] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1200test # [ 3.425163] systemd[1]: Stopped target Swaps.1201second # [ 3.427410] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1202second # [ 3.428704] systemd[1]: Stopped target Slice Units.1203test # [ 3.426432] systemd[1]: Stopped target Timer Units.1204second # [ 3.429759] systemd[1]: Stopped target Socket Units.1205test # [ 3.427807] systemd[1]: dbus.socket: Deactivated successfully.1206second # [ 3.430693] systemd[1]: Stopped target System Initialization.1207second # [ 3.431716] systemd[1]: Stopped target Swaps.1208test # [ 3.429196] systemd[1]: Closed D-Bus System Message Bus Socket.1209second # [ 3.432896] systemd[1]: Stopped target Timer Units.1210test # [ 3.430639] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1211second # [ 3.434173] systemd[1]: dbus.socket: Deactivated successfully.1212test # [ 3.431930] systemd[1]: Stopped Find NixOS closure.1213second # [ 3.435360] systemd[1]: Closed D-Bus System Message Bus Socket.1214test # [ 3.432951] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1215second # [ 3.436755] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1216test # [ 3.435159] systemd[1]: Starting rw-sysroot-nix-store.service...1217second # [ 3.438161] systemd[1]: Stopped Find NixOS closure.1218test # [ 3.437147] systemd[1]: systemd-sysctl.service: Deactivated successfully.1219test # [ 3.438441] systemd[1]: Stopped Apply Kernel Variables.1220second # [ 3.440140] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1221test # [ 3.439407] systemd[1]: systemd-modules-load.service: Deactivated successfully.1222second # [ 3.441971] systemd[1]: Starting rw-sysroot-nix-store.service...1223test # [ 3.440626] systemd[1]: Stopped Load Kernel Modules.1224second # [ 3.443276] systemd[1]: systemd-sysctl.service: Deactivated successfully.1225test # [ 3.441562] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1226second # [ 3.444864] systemd[1]: Stopped Apply Kernel Variables.1227test # [ 3.443203] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1228second # [ 3.446152] systemd[1]: systemd-modules-load.service: Deactivated successfully.1229second # [ 3.447653] systemd[1]: Stopped Load Kernel Modules.1230test # [ 3.445152] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1231test # [ 3.446399] systemd[1]: Stopped Create System Files and Directories.1232second # [ 3.449177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1233test # [ 3.447491] systemd[1]: Stopped target Local File Systems.1234second # [ 3.450580] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1235test # [ 3.449155] systemd[1]: Stopped target Preparation for Local File Systems.1236second # [ 3.452126] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1237test # [ 3.450317] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1238test # [ 3.451711] systemd[1]: Stopped Coldplug All udev Devices.1239second # [ 3.454131] systemd[1]: Stopped Create System Files and Directories.1240second # [ 3.455216] systemd[1]: Stopped target Local File Systems.1241test # [ 3.453432] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1242second # [ 3.456203] systemd[1]: Stopped target Preparation for Local File Systems.1243second # [ 3.457363] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1244second # [ 3.458757] systemd[1]: Stopped Coldplug All udev Devices.1245test # [ 3.456501] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1246test # [ 3.457759] systemd[1]: Stopped Virtual Console Setup.1247second # [ 3.460341] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1248second # [ 3.462521] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1249second # [ 3.463917] systemd[1]: Stopped Virtual Console Setup.1250test # [ 3.465563] systemd[1]: initrd-cleanup.service: Deactivated successfully.1251test # [ 3.470120] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1252second # [ 3.474168] systemd[1]: initrd-cleanup.service: Deactivated successfully.1253test # [ 3.472633] systemd[1]: systemd-udevd.service: Deactivated successfully.1254test # [ 3.474366] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1255second # [ 3.478122] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1256test # [ 3.476156] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1257second # [ 3.479504] systemd[1]: systemd-udevd.service: Deactivated successfully.1258test # [ 3.477849] systemd[1]: Finished rw-sysroot-nix-store.service.1259second # [ 3.482049] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1260test # [ 3.479718] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1261second # [ 3.483305] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1262test # [ 3.481958] systemd[1]: Closed udev Control Socket.1263second # [ 3.484699] systemd[1]: Finished rw-sysroot-nix-store.service.1264test # [ 3.483085] systemd[1]: Starting Cleanup udev Database...1265test # [ 3.484122] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1266second # [ 3.487261] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1267test # [ 3.486124] systemd[1]: Stopped Create Static Device Nodes in /dev.1268second # [ 3.489156] systemd[1]: Closed udev Control Socket.1269test # [ 3.487311] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1270second # [ 3.490255] systemd[1]: Starting Cleanup udev Database...1271second # [ 3.491287] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1272test # [ 3.489160] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1273test # [ 3.490384] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1274second # [ 3.493075] systemd[1]: Stopped Create Static Device Nodes in /dev.1275test # [ 3.491665] systemd[1]: Stopped Create List of Static Device Nodes.1276second # [ 3.494180] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1277second # [ 3.496161] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1278second # [ 3.497409] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1279second # [ 3.498597] systemd[1]: Stopped Create List of Static Device Nodes.1280test # [ 3.503358] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1281test # [ 3.505379] systemd[1]: Finished Cleanup udev Database.1282test # [ 3.507201] systemd[1]: Reached target Switch Root.1283second # [ 3.509771] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1284test # [ 3.508389] systemd[1]: Starting NixOS Activation...1285second # [ 3.512184] systemd[1]: Finished Cleanup udev Database.1286second # [ 3.513413] systemd[1]: Reached target Switch Root.1287second # [ 3.515356] systemd[1]: Starting NixOS Activation...1288test # [ 3.591488] initrd-nixos-activation-start[178]: booting system configuration /nix/store/5lnm0b0i5b998bi2ii90snfhkpszwx3d-nixos-system-test-test1289second # [ 3.594237] initrd-nixos-activation-start[177]: booting system configuration /nix/store/iwy0rikp3iji8f856f9apbdk03icyay5-nixos-system-second-test1290test # [ 3.622504] initrd-nixos-activation-start[178]: running activation script...1291second # [ 3.624939] initrd-nixos-activation-start[177]: running activation script...1292second # [ 3.824271] initrd-nixos-activation-start[200]: setting up /etc...1293test # [ 3.824654] initrd-nixos-activation-start[201]: setting up /etc...1294test # [ 3.939076] initrd-nixos-activation-start[201]: setting up age secrets...1295second # [ 3.941796] initrd-nixos-activation-start[200]: setting up age secrets...1296second # [ 4.049608] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1297second # [ 4.051517] systemd[1]: Finished NixOS Activation.1298second # [ 4.053594] systemd[1]: Starting Switch Root...1299second # [ 4.064112] systemd[1]: Switching root.1300test # [ 4.072800] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1301test # [ 4.075179] systemd[1]: Finished NixOS Activation.1302test # [ 4.076696] systemd[1]: Starting Switch Root...1303second # [ 4.253821] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1304test # [ 4.087424] systemd[1]: Switching root.1305test # [ 4.274468] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1306second # [ 4.330627] NET: Registered PF_VSOCK protocol family1307test # [ 4.348802] NET: Registered PF_VSOCK protocol family1308second # [ 4.690569] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1309second # [ 4.694879] systemd[1]: Detected virtualization kvm.1310second # [ 4.695723] systemd[1]: Detected architecture x86-64.1311second # [ 4.696604] systemd[1]: Detected first boot.1312second # [ 4.698982] systemd[1]: Initializing machine ID from random generator.1313test # [ 4.707665] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1314test # [ 4.712002] systemd[1]: Detected virtualization kvm.1315test # [ 4.712837] systemd[1]: Detected architecture x86-64.1316test # [ 4.713725] systemd[1]: Detected first boot.1317test # [ 4.716172] systemd[1]: Initializing machine ID from random generator.1318second # [ 4.883648] systemd[1]: bpf-restrict-fs: LSM BPF program attached1319test # [ 4.899606] systemd[1]: bpf-restrict-fs: LSM BPF program attached1320second # [ 4.952829] systemd[1]: Applying preset policy.1321test # [ 4.964628] systemd[1]: Applying preset policy.1322second # [ 5.214947] systemd[1]: Populated /etc with preset unit settings.1323test # [ 5.224521] systemd[1]: Populated /etc with preset unit settings.1324second # [ 5.453986] systemd[1]: initrd-switch-root.service: Deactivated successfully.1325second # [ 5.455623] systemd[1]: Stopped initrd-switch-root.service.1326second # [ 5.458155] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1327second # [ 5.460260] systemd[1]: Created slice Slice /system/getty.1328second # [ 5.461691] systemd[1]: Created slice User and Session Slice.1329test # [ 5.459330] systemd[1]: initrd-switch-root.service: Deactivated successfully.1330second # [ 5.462750] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1331test # [ 5.460914] systemd[1]: Stopped initrd-switch-root.service.1332second # [ 5.464096] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1333second # [ 5.465381] systemd[1]: Expecting device /dev/hvc0...1334second # [ 5.466195] systemd[1]: Expecting device /dev/ttyS0...1335test # [ 5.463487] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1336second # [ 5.467100] systemd[1]: Reached target Local Encrypted Volumes.1337second # [ 5.468073] systemd[1]: Stopped target initrd-fs.target.1338test # [ 5.465642] systemd[1]: Created slice Slice /system/getty.1339second # [ 5.468968] systemd[1]: Stopped target initrd-root-fs.target.1340test # [ 5.467031] systemd[1]: Created slice User and Session Slice.1341second # [ 5.469915] systemd[1]: Stopped target initrd-switch-root.target.1342second # [ 5.470930] systemd[1]: Reached target Virtual Machines and Containers.1343test # [ 5.468171] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1344second # [ 5.472009] systemd[1]: Reached target Path Units.1345test # [ 5.469551] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1346second # [ 5.472866] systemd[1]: Reached target Remote File Systems.1347test # [ 5.470797] systemd[1]: Expecting device /dev/hvc0...1348second # [ 5.473806] systemd[1]: Reached target Slice Units.1349test # [ 5.471668] systemd[1]: Expecting device /dev/ttyS0...1350second # [ 5.474672] systemd[1]: Reached target Swaps.1351test # [ 5.472570] systemd[1]: Reached target Local Encrypted Volumes.1352test # [ 5.473554] systemd[1]: Stopped target initrd-fs.target.1353test # [ 5.474455] systemd[1]: Stopped target initrd-root-fs.target.1354second # [ 5.477045] systemd[1]: Listening on Process Core Dump Socket.1355test # [ 5.475409] systemd[1]: Stopped target initrd-switch-root.target.1356test # [ 5.476433] systemd[1]: Reached target Virtual Machines and Containers.1357second # [ 5.479095] systemd[1]: Listening on Credential Encryption/Decryption.1358test # [ 5.477518] systemd[1]: Reached target Path Units.1359test # [ 5.478381] systemd[1]: Reached target Remote File Systems.1360test # [ 5.479334] systemd[1]: Reached target Slice Units.1361second # [ 5.481962] systemd[1]: Starting Journal Log Access Socket...1362test # [ 5.480201] systemd[1]: Reached target Swaps.1363second # [ 5.483432] systemd[1]: Listening on Journal Audit Socket.1364second # [ 5.484672] systemd[1]: Listening on Network Management Metrics Varlink Socket.1365test # [ 5.482441] systemd[1]: Listening on Process Core Dump Socket.1366second # [ 5.486473] systemd[1]: Listening on Network Management Netlink Socket.1367test # [ 5.484422] systemd[1]: Listening on Credential Encryption/Decryption.1368second # [ 5.487682] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1369second # [ 5.488909] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1370test # [ 5.487419] systemd[1]: Starting Journal Log Access Socket...1371second # [ 5.490521] systemd[1]: Listening on udev Control Socket.1372test # [ 5.488707] systemd[1]: Listening on Journal Audit Socket.1373test # [ 5.489809] systemd[1]: Listening on Network Management Metrics Varlink Socket.1374second # [ 5.493022] systemd[1]: Mounting Huge Pages File System...1375test # [ 5.491773] systemd[1]: Listening on Network Management Netlink Socket.1376test # [ 5.493001] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1377second # [ 5.495899] systemd[1]: Mounting POSIX Message Queue File System...1378test # [ 5.494255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1379test # [ 5.495864] systemd[1]: Listening on udev Control Socket.1380test # [ 5.498278] systemd[1]: Mounting Huge Pages File System...1381second # [ 5.502233] systemd[1]: Mounting Kernel Debug File System...1382test # [ 5.501517] systemd[1]: Mounting POSIX Message Queue File System...1383second # [ 5.507890] systemd[1]: Mounting Kernel Trace File System...1384test # [ 5.507470] systemd[1]: Mounting Kernel Debug File System...1385second # [ 5.511653] systemd[1]: Starting Create List of Static Device Nodes...1386test # [ 5.513213] systemd[1]: Mounting Kernel Trace File System...1387second # [ 5.516573] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1388test # [ 5.519828] systemd[1]: Starting Create List of Static Device Nodes...1389second # [ 5.525283] systemd[1]: Starting Load Kernel Module configfs...1390test # [ 5.523811] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1391second # [ 5.528107] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1392second # [ 5.539762] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1393test # [ 5.538975] systemd[1]: Starting Load Kernel Module configfs...1394test # [ 5.540275] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1395second # [ 5.545017] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1396test # [ 5.546105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1397second # [ 5.552720] systemd[1]: Mounting FUSE Control File System...1398second # [ 5.553890] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671399test # [ 5.552730] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1400test # [ 5.559336] systemd[1]: Mounting FUSE Control File System...1401second # [ 5.563781] systemd[1]: Starting Journal Service...1402test # [ 5.560417] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671403second # [ 5.570113] systemd[1]: Starting Load Kernel Modules...1404test # [ 5.572424] systemd[1]: Starting Journal Service...1405second # [ 5.578872] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1406test # [ 5.580123] systemd[1]: Starting Load Kernel Modules...1407test # [ 5.590450] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1408second # [ 5.597380] systemd[1]: Starting Remount Root and Kernel File Systems...1409second # [ 5.601735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1410test # [ 5.599743] systemd[1]: Starting Remount Root and Kernel File Systems...1411test # [ 5.606460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1412second # [ 5.613456] systemd-journald[299]: Collecting audit messages is enabled.1413second # [ 5.615962] loop: module loaded1414second # [ 5.620744] systemd[1]: Starting Coldplug All udev Devices...1415test # [ 5.619255] systemd[1]: Starting Coldplug All udev Devices...1416test # [ 5.621293] systemd-journald[320]: Collecting audit messages is enabled.1417test # [ 5.638826] systemd[1]: Listening on Journal Log Access Socket.1418second # [ 5.642522] systemd[1]: Listening on Journal Log Access Socket.1419test # [ 5.641067] loop: module loaded1420second # [ 5.648561] systemd[1]: Started Journal Service.1421second # [ 5.476086] systemd[1]: Queued start job for default target Multi-User System.1422second # [ 5.477855] systemd[1]: systemd-journald.service: Deactivated successfully.1423test # [ 5.652502] systemd[1]: Mounted Huge Pages File System.1424second # [ 5.481545] systemd-modules-load[300]: Module 'ctr' is built in1425second # [ 5.657294] EXT4-fs (vda): re-mounted f50fd241-d8d6-4d19-bf09-b4298b3a2ef8.1426test # [ 5.655696] systemd[1]: Mounted POSIX Message Queue File System.1427second # [ 5.485494] systemd-modules-load[300]: Inserted module 'loop'1428test # [ 5.657260] EXT4-fs (vda): re-mounted 243ffcd4-fcb0-439b-8d75-3bfa8a5e364f.1429second # [ 5.489299] systemd[1]: Mounted Huge Pages File System.1430test # [ 5.486506] systemd[1]: Queued start job for default target Multi-User System.1431second # [ 5.491519] systemd[1]: Mounted POSIX Message Queue File System.1432test # [ 5.489407] systemd[1]: systemd-journald.service: Deactivated successfully.1433test # [ 5.666549] systemd[1]: Started Journal Service.1434second # [ 5.494876] systemd[1]: Mounted Kernel Debug File System.1435test # [ 5.493720] systemd-modules-load[321]: Module 'ctr' is built in1436test # [ 5.496508] systemd-modules-load[321]: Inserted module 'loop'1437second # [ 5.499263] systemd[1]: Mounted Kernel Trace File System.1438second # [ 5.500511] systemd[1]: Finished Create List of Static Device Nodes.1439second # [ 5.503067] systemd[1]: modprobe@configfs.service: Deactivated successfully.1440second # [ 5.505730] systemd[1]: Finished Load Kernel Module configfs.1441test # [ 5.504113] systemd[1]: Mounted Kernel Debug File System.1442second # [ 5.508383] systemd[1]: Mounted FUSE Control File System.1443test # [ 5.505758] systemd[1]: Mounted Kernel Trace File System.1444second # [ 5.510218] systemd[1]: Finished Load Kernel Modules.1445test # [ 5.508267] systemd[1]: Finished Create List of Static Device Nodes.1446test # [ 5.511185] systemd[1]: modprobe@configfs.service: Deactivated successfully.1447second # [ 5.513726] systemd[1]: Finished Remount Root and Kernel File Systems.1448test # [ 5.512746] systemd[1]: Finished Load Kernel Module configfs.1449test # [ 5.516505] systemd[1]: Mounted FUSE Control File System.1450test # [ 5.518601] systemd[1]: Finished Load Kernel Modules.1451second # [ 5.524695] systemd-oomd[301]: No swap; memory pressure usage will be degraded1452test # [ 5.522913] systemd[1]: Finished Remount Root and Kernel File Systems.1453second # [ 5.535075] systemd[1]: Mounting Kernel Configuration File System...1454second # [ 5.537073] systemd[1]: Starting Firewall...1455test # [ 5.543081] systemd[1]: Mounting Kernel Configuration File System...1456test # [ 5.546398] systemd-oomd[323]: No swap; memory pressure usage will be degraded1457second # [ 5.549869] systemd[1]: Starting Flush Journal to Persistent Storage...1458second # [ 5.551262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1459test # [ 5.550078] systemd[1]: Starting Firewall...1460test # [ 5.555791] systemd[1]: Starting Flush Journal to Persistent Storage...1461second # [ 5.563652] systemd[1]: Starting Load/Save OS Random Seed...1462test # [ 5.561193] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1463test # [ 5.567350] systemd[1]: Starting Load/Save OS Random Seed...1464second # [ 5.573303] systemd[1]: Starting Apply Kernel Variables...1465test # [ 5.581888] systemd[1]: Starting Apply Kernel Variables...1466second # [ 5.585770] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1467second # [ 5.587101] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1468second # [ 5.588585] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1469test # [ 5.595608] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1470test # [ 5.596947] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1471test # [ 5.600071] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1472second # [ 5.806665] systemd-journald[299]: Received client request to flush runtime journal.1473test # [ 5.820373] systemd-journald[320]: Received client request to flush runtime journal.1474second # [ 5.810234] systemd[1]: Mounted Kernel Configuration File System.1475second # [ 5.814889] systemd[1]: Finished Load/Save OS Random Seed.1476test # [ 5.812639] systemd[1]: Mounted Kernel Configuration File System.1477second # [ 5.819400] systemd[1]: Reached target First Boot Complete.1478test # [ 5.817996] systemd[1]: Finished Load/Save OS Random Seed.1479second # [ 5.822736] systemd[1]: Finished Apply Kernel Variables.1480test # [ 5.822305] systemd[1]: Reached target First Boot Complete.1481test # [ 5.823468] systemd[1]: Finished Apply Kernel Variables.1482second # [ 5.826195] systemd[1]: Starting Network Name Resolution...1483second # [ 5.827252] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1484test # [ 5.826144] systemd[1]: Starting Network Name Resolution...1485second # [ 5.828537] systemd[1]: Starting Create Static Device Nodes in /dev...1486second # [ 5.830976] systemd[1]: Finished Flush Journal to Persistent Storage.1487test # [ 5.828643] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1488test # [ 5.831179] systemd[1]: Starting Create Static Device Nodes in /dev...1489test # [ 5.833191] systemd[1]: Finished Flush Journal to Persistent Storage.1490second # [ 5.836186] systemd[1]: Finished Create Static Device Nodes in /dev.1491second # [ 5.837331] systemd[1]: Reached target Preparation for Local File Systems.1492test # [ 5.835814] systemd[1]: Finished Create Static Device Nodes in /dev.1493second # [ 5.843209] systemd[1]: Starting Rule-based Manager for Device Events and Files...1494test # [ 5.841084] systemd[1]: Reached target Preparation for Local File Systems.1495test # [ 5.845587] systemd[1]: Starting Rule-based Manager for Device Events and Files...1496second # [ 5.865606] systemd-resolved[329]: Positive Trust Anchors:1497second # [ 5.868662] systemd-resolved[329]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1498second # [ 5.871313] systemd-resolved[329]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161499second # [ 5.873662] systemd-resolved[329]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1500test # [ 5.891183] systemd-resolved[351]: Positive Trust Anchors:1501test # [ 5.892973] systemd-resolved[351]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1502test # [ 5.897323] systemd-resolved[351]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161503test # [ 5.898974] systemd-resolved[351]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1504test # [ 5.930896] systemd-udevd[366]: Using default interface naming scheme 'v260'.1505second # [ 5.934754] systemd-udevd[348]: Using default interface naming scheme 'v260'.1506test # [ 5.936392] systemd[1]: Finished Coldplug All udev Devices.1507second # [ 5.958776] systemd[1]: Finished Coldplug All udev Devices.1508second # [ 5.976503] systemd-resolved[329]: Using system hostname 'second'.1509second # [ 5.984107] systemd[1]: Started Network Name Resolution.1510test # [ 5.982262] systemd-resolved[351]: Using system hostname 'test'.1511test # [ 5.992582] systemd[1]: Started Network Name Resolution.1512second # [ 6.035095] systemd[1]: Started Rule-based Manager for Device Events and Files.1513test # [ 6.036099] systemd[1]: Started Rule-based Manager for Device Events and Files.1514second # [ 6.198743] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1515test # [ 6.201682] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1516second # [ 6.284074] systemd[1]: Mounting /run/wrappers...1517test # [ 6.290096] systemd[1]: Mounting /run/wrappers...1518second # [ 6.294422] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1519test # [ 6.301129] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1520second # [ 6.319170] systemd[1]: Mounted /run/wrappers.1521second # [ 6.320893] systemd[1]: Reached target Local File Systems.1522second # [ 6.325704] systemd[1]: Listening on Boot Loader Control Service Socket.1523test # [ 6.325243] systemd[1]: Mounted /run/wrappers.1524second # [ 6.328411] systemd[1]: Starting register-nix-paths.service...1525test # [ 6.326202] systemd[1]: Reached target Local File Systems.1526test # [ 6.330310] systemd[1]: Listening on Boot Loader Control Service Socket.1527second # [ 6.334607] systemd[1]: Starting Create SUID/SGID Wrappers...1528second # [ 6.335665] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1529test # [ 6.335137] systemd[1]: Starting register-nix-paths.service...1530test # [ 6.338728] systemd[1]: Starting Create SUID/SGID Wrappers...1531test # [ 6.340757] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1532second # [ 6.344762] systemd[1]: Starting Save Transient machine-id to Disk...1533test # [ 6.349812] systemd[1]: Starting Save Transient machine-id to Disk...1534second # [ 6.360505] systemd[1]: Starting Create System Files and Directories...1535second # [ 6.371842] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1536test # [ 6.370267] systemd[1]: Starting Create System Files and Directories...1537second # [ 6.386788] systemd[1]: Finished Firewall.1538test # [ 6.387102] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1539second # [ 6.400292] systemd[1]: Reached target Preparation for Network.1540second # [ 6.407298] systemd[1]: Starting Network Management...1541test # [ 6.410432] systemd[1]: Finished Firewall.1542second # [ 6.414146] (udev-worker)[401]: Network interface NamePolicy= disabled on kernel command line.1543second # [ 6.418381] (udev-worker)[399]: Network interface NamePolicy= disabled on kernel command line.1544test # [ 6.417188] systemd[1]: Reached target Preparation for Network.1545test # [ 6.425045] systemd[1]: Starting Network Management...1546second # [ 6.439255] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1547test # [ 6.436223] (udev-worker)[417]: Network interface NamePolicy= disabled on kernel command line.1548second # [ 6.447386] systemd[1]: Finished Save Transient machine-id to Disk.1549test # [ 6.445570] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1550test # [ 6.453224] (udev-worker)[414]: Network interface NamePolicy= disabled on kernel command line.1551test # [ 6.458840] systemd[1]: Finished Save Transient machine-id to Disk.1552second # [ 6.508831] systemd[1]: Finished Create System Files and Directories.1553test # [ 6.511323] systemd[1]: Finished Create System Files and Directories.1554second # [ 6.519855] systemd[1]: Starting Rebuild Journal Catalog...1555test # [ 6.517958] systemd[1]: Starting Rebuild Journal Catalog...1556second # [ 6.528111] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1557test # [ 6.527272] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1558second # [ 6.613403] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1559test # [ 6.615326] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1560second # [ 6.651470] systemd[1]: Finished Rebuild Journal Catalog.1561test # [ 6.655514] systemd[1]: Finished Rebuild Journal Catalog.1562second # [ 6.661681] systemd[1]: Starting Update is Completed...1563test # [ 6.663147] systemd[1]: Starting Update is Completed...1564second # [ 6.715416] systemd[1]: Finished Update is Completed.1565test # [ 6.722251] systemd[1]: Finished Update is Completed.1566second # [ 6.942766] cfg80211: Loading compiled-in X.509 certificates for regulatory database1567test # [ 6.941653] cfg80211: Loading compiled-in X.509 certificates for regulatory database1568second # [ 6.963440] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1569test # [ 6.963541] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1570test # [ 6.964593] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1571second # [ 6.967262] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1572second # [ 6.836303] systemd-networkd[453]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1573test # [ 6.834375] systemd-networkd[476]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1574second # [ 6.841104] systemd-networkd[453]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1575test # [ 6.839731] systemd-networkd[476]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1576test # [ 6.844234] systemd-networkd[476]: lo: Link UP1577second # [ 6.846674] systemd-networkd[453]: lo: Link UP1578second # [ 6.847738] systemd-networkd[453]: lo: Gained carrier1579test # [ 6.846138] systemd-networkd[476]: lo: Gained carrier1580test # [ 6.859405] systemd[1]: Started Network Management.1581second # [ 6.862339] systemd[1]: Started Network Management.1582test # [ 6.866919] systemd-networkd[476]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1583test # [ 6.869891] systemd-networkd[476]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1584second # [ 6.871776] systemd-networkd[453]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1585second # [ 6.874287] systemd-networkd[453]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1586test # [ 6.872448] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1587second # [ 6.877678] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1588test # [ 6.878203] systemd-networkd[476]: eth1: Link UP1589test # [ 6.879124] systemd-networkd[476]: eth1: Gained carrier1590second # [ 6.881887] systemd-networkd[453]: eth1: Link UP1591second # [ 6.886658] systemd-networkd[453]: eth1: Gained carrier1592test # [ 6.883341] systemd-networkd[476]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1593second # [ 6.888182] systemd-networkd[453]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1594test # [ 7.074645] NET: Registered PF_PACKET protocol family1595second # [ 7.080508] NET: Registered PF_PACKET protocol family1596test # [ 6.943971] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1597second # [ 6.949865] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1598test # [ 6.952982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1599second # [ 6.957690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1600test # [ 6.956296] systemd[1]: Finished Create SUID/SGID Wrappers.1601second # [ 6.962147] systemd[1]: Finished Create SUID/SGID Wrappers.1602test # [ 7.042371] systemd[1]: Finished register-nix-paths.service.1603test # [ 7.043576] systemd[1]: Reached target System Initialization.1604second # [ 7.048111] systemd[1]: Finished register-nix-paths.service.1605test # [ 7.045626] systemd[1]: Started Discard unused filesystem blocks once a week.1606second # [ 7.049315] systemd[1]: Reached target System Initialization.1607test # [ 7.048825] systemd[1]: Started Daily Cleanup of Temporary Directories.1608second # [ 7.051751] systemd[1]: Started Discard unused filesystem blocks once a week.1609test # [ 7.050087] systemd[1]: Reached target Timer Units.1610second # [ 7.053199] systemd[1]: Started Daily Cleanup of Temporary Directories.1611test # [ 7.051387] systemd[1]: Listening on D-Bus System Message Bus Socket.1612second # [ 7.055307] systemd[1]: Reached target Timer Units.1613test # [ 7.053453] systemd[1]: Listening on Nix Daemon Socket.1614second # [ 7.057169] systemd[1]: Listening on D-Bus System Message Bus Socket.1615test # [ 7.229473] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31616second # [ 7.058298] systemd[1]: Listening on Nix Daemon Socket.1617test # [ 7.058232] systemd[1]: Listening on Authorization Manager Agent Helper.1618test # [ 7.059669] systemd[1]: Listening on Hostname Service Socket.1619second # [ 7.063291] systemd[1]: Listening on Authorization Manager Agent Helper.1620test # [ 7.061247] systemd[1]: Reached target Socket Units.1621second # [ 7.064464] systemd[1]: Listening on Hostname Service Socket.1622second # [ 7.065498] systemd[1]: Reached target Socket Units.1623second # [ 7.240709] mousedev: PS/2 mouse device common for all mice1624test # [ 7.065231] systemd[1]: Starting D-Bus System Message Bus...1625second # [ 7.068838] systemd[1]: Starting D-Bus System Message Bus...1626second # [ 7.246285] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31627test # [ 7.248164] mousedev: PS/2 mouse device common for all mice1628test # [ 7.267725] ACPI: button: Power Button [PWRF]1629second # [ 7.278282] ACPI: button: Power Button [PWRF]1630test # [ 7.279983] rtc_cmos 00:05: RTC can wake from S41631second # [ 7.290906] rtc_cmos 00:05: RTC can wake from S41632test # [ 7.292427] rtc_cmos 00:05: registered as rtc01633test # [ 7.297461] Floppy drive(s): fd0 is 2.88M AMI BIOS1634test # [ 7.298809] parport_pc 00:03: reported by Plug and Play ACPI1635test # [ 7.300518] rtc_cmos 00:05: setting system clock to 2026-09-09T00:05:03 UTC (1788912303)1636second # [ 7.304115] Floppy drive(s): fd0 is 2.88M AMI BIOS1637test # [ 7.302437] systemd-journald[320]: Time jumped backwards, rotating.1638second # [ 7.134384] dbus-broker-launch[546]: Looking up NSS user entry for 'systemd-timesync'...1639second # [ 7.140394] dbus-broker-launch[546]: NSS returned no entry for 'systemd-timesync'1640second # [ 7.141753] dbus-broker-launch[546]: Invalid user-name in /nix/store/pkmj4sdxqs18al74pm419w7mvxqvs09i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1641second # [ 7.319712] rtc_cmos 00:05: registered as rtc01642test # [ 7.317676] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1643second # [ 7.322212] parport_pc 00:03: reported by Plug and Play ACPI1644test # [ 7.151332] systemd-resolved[351]: Clock change detected. Flushing caches.1645second # [ 7.329215] rtc_cmos 00:05: setting system clock to 2026-09-09T00:05:03 UTC (1788912303)1646second # [ 7.331203] systemd-journald[299]: Time jumped backwards, rotating.1647test # [ 7.329493] FDC 0 is a S82078B1648second # [ 7.333221] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1649test # [ 7.156880] dbus-broker-launch[566]: Looking up NSS user entry for 'systemd-timesync'...1650test # [ 7.334645] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1651test # [ 7.160367] dbus-broker-launch[566]: NSS returned no entry for 'systemd-timesync'1652test # [ 7.164346] dbus-broker-launch[566]: Invalid user-name in /nix/store/pkmj4sdxqs18al74pm419w7mvxqvs09i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1653test # [ 7.170182] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1654second # [ 7.352532] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1655test # [ 7.176398] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1656second # [ 7.355933] FDC 0 is a S82078B1657second # [ 7.183782] systemd-resolved[329]: Clock change detected. Flushing caches.1658test # [ 7.182160] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/kv22l88laj89v51jwjsnf1vbg7qp3igk-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1659second # [ 7.186662] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1660test # [ 7.186925] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zalak21wkk24c0rlmaaqhvwmywz8f6bq-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1661test # [ 7.190664] systemd[1]: Started D-Bus System Message Bus.1662second # [ 7.194623] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/mgqj75cjpyibkn8bhvxym9i2r0w7iz8j-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1663second # [ 7.202740] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/kv22l88laj89v51jwjsnf1vbg7qp3igk-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1664test # [ 7.205583] dbus-broker-launch[566]: Ready1665second # [ 7.208165] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zalak21wkk24c0rlmaaqhvwmywz8f6bq-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1666second # [ 7.212260] systemd[1]: Started D-Bus System Message Bus.1667test # [ 7.215087] systemd[1]: Reached target Basic System.1668second # [ 7.219306] dbus-broker-launch[546]: Ready1669test # [ 7.218216] systemd[1]: Starting Network Manager Script Dispatcher Service...1670test # [ 7.222839] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1671second # [ 7.227069] systemd[1]: Reached target Basic System.1672second # [ 7.232046] systemd[1]: Starting Network Manager Script Dispatcher Service...1673test # [ 7.230077] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1674second # [ 7.235232] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1675second # [ 7.242792] systemd[1]: Starting Network Manager...1676test # [ 7.242211] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1677second # [ 7.250972] systemd[1]: Started backdoor.service.1678test # [ 7.254470] systemd[1]: Starting Network Manager...1679second # [ 7.272309] systemd[1]: Starting Import lastlog data into lastlog2 database...1680test # [ 7.271482] systemd[1]: Started backdoor.service.1681second # [ 7.449566] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1682second # [ 7.290714] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1683test # [ 7.302464] llkkvzg5p3xcxck0byqirpqsh987x8q2-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1684second # [ 7.309599] systemd[1]: Starting Post-Boot Actions...1685test # [ 7.309294] yci3hny1h84jin598kc3z3w5rndsylf0-wifi-secrets[571]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1686second # [ 7.312880] llkkvzg5p3xcxck0byqirpqsh987x8q2-wifi-secrets[550]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1687test # [ 7.312099] systemd[1]: Starting Import lastlog data into lastlog2 database...1688test # [ 7.494781] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1689second # [ 7.502627] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01690second # [ 7.342257] systemd[1]: Started Reset console on configuration changes.1691second # connecting to host...1692second # [ 7.555779] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41693second # [ 7.386474] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1694second # [ 7.398445] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1695test # [ 7.536163] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01696test # [ 7.536221] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1697test # [ 7.578561] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41698test # [ 7.649659] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61699second # [ 7.625423] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1700second # [ 7.688042] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61701second # [ 7.688353] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51702test # [ 7.649938] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51703test # [ 7.685176] Console: switching to colour dummy device 80x251704second # [ 7.720146] Console: switching to colour dummy device 80x251705second # [ 7.770068] [drm] Found bochs VGA, ID 0xb0c5.1706second # [ 7.770070] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1707second # [ 7.427256] systemd[1]: Finished Post-Boot Actions.1708second # [ 7.601345] systemd[1]: Started Name Service Cache Daemon (nsncd).1709second # [ 7.605876] nsncd[556]: Sep 09 00:05:03.779 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1710second # [ 7.609635] systemd[1]: Started Network Manager Script Dispatcher Service.1711test # [ 7.328407] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1712second # [ 7.613708] systemd[1]: Reached target Host and Network Name Lookups.1713test # [ 7.612856] systemd[1]: Starting Post-Boot Actions...1714second # [ 7.616625] systemd[1]: Reached target User and Group Name Lookups.1715test # [ 7.615192] qhkvsid2d53bk2b82gkhz48ypn2k3ymy-wifi-secrets[572]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1716second # [ 7.618526] systemd[1]: Starting User Login Management...1717second # [ 7.620793] systemd[1]: Starting Hostname Service...1718test # [ 7.618504] systemd[1]: Started Reset console on configuration changes.1719second # [ 7.625299] systemd[1]: Started Hostname Service.1720test # [ 7.623297] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1721second # [ 7.626690] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1722test # [ 7.628976] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1723test # [ 7.631492] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1724test # [ 7.635918] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1725test # [ 7.641283] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1726test # [ 7.645727] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1727second # [ 7.825112] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1728second # [ 7.825976] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01729test # [ 7.651517] systemd[1]: Started Network Manager Script Dispatcher Service.1730second # [ 7.655397] systemd[1]: Finished Import lastlog data into lastlog2 database.1731test # [ 7.654758] systemd[1]: Starting Hostname Service...1732test # [ 7.834263] [drm] Found bochs VGA, ID 0xb0c5.1733second # [ 7.663093] systemd-networkd[453]: eth0: Link UP1734test # [ 7.834821] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1735second # [ 7.664367] systemd-networkd[453]: eth0: Gained carrier1736test # [ 7.662227] systemd[1]: Started Hostname Service.1737test # [ 7.663264] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1738test # [ 7.666576] systemd-networkd[476]: eth0: Link UP1739test # [ 7.670393] systemd-networkd[476]: eth0: Gained carrier1740test # [ 7.689692] systemd[1]: Finished Post-Boot Actions.1741second # [ 7.699705] systemd[1]: Started Network Manager.1742second # [ 7.700658] systemd[1]: Reached target Network.1743test # connecting to host...1744second # [ 7.709360] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1745test # [ 7.707544] systemd[1]: Started Network Manager.1746second # [ 7.714323] systemd[1]: Starting Permit User Sessions...1747test # [ 7.723505] nsncd[583]: Sep 09 00:05:04.094 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1748test # [ 7.730131] systemd[1]: Started Name Service Cache Daemon (nsncd).1749second # [ 7.734225] systemd-logind[589]: New seat seat0.1750test: Guest shell says: b'Spawning backdoor root shell...\n'1751test: connected to guest root shell1752test: (connecting took 8.39 seconds)1753test: (finished: waiting for the VM to finish booting, in 8.39 seconds)1754second # [ 7.743966] systemd[1]: Started User Login Management.1755test # [ 7.732941] systemd[1]: Reached target Network.1756test # [ 7.735522] systemd[1]: Reached target Host and Network Name Lookups.1757test # [ 7.737618] systemd[1]: Reached target User and Group Name Lookups.1758test # [ 7.921784] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1759test # [ 7.922601] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01760test # [ 7.750214] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1761second # [ 7.762884] systemd[1]: Starting linger-users.service...1762test # [ 7.780100] systemd[1]: Starting User Login Management...1763second # [ 7.784275] systemd[1]: Starting Virtual Console Setup...1764test # [ 7.796538] systemd[1]: Starting Permit User Sessions...1765second # [ 7.810164] systemd[1]: Finished Permit User Sessions.1766second # [ 7.812914] systemd-logind[589]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1767test # [ 7.814107] systemd[1]: Finished Import lastlog data into lastlog2 database.1768test # [ 7.890244] systemd[1]: Finished Permit User Sessions.1769test: (finished: waiting for unit NetworkManager.service, in 8.58 seconds)1770test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1771test # [ 8.121765] ppdev: user-space parallel port driver1772test # [ 7.957654] systemd-logind[633]: Watching system buttons on /dev/input/event2 (Power Button)1773test # [ 7.961607] systemd-logind[633]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1774second # [ 8.103716] ppdev: user-space parallel port driver1775second # [ 8.127785] Console: switching to colour frame buffer device 160x501776test # [ 7.968079] systemd-logind[633]: New seat seat0.1777test # [ 7.977100] systemd-resolved[351]: eth0: Bus client set default route setting: yes1778second # [ 8.155369] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1779test # [ 7.980586] systemd-resolved[351]: eth0: Bus client set DNS server list to: 10.0.2.31780second # [ 7.872986] systemd-logind[589]: Watching system buttons on /dev/input/event2 (Power Button)1781second # [ 7.985261] systemd[1]: linger-users.service: Deactivated successfully.1782second # [ 7.986503] systemd[1]: Finished linger-users.service.1783test # [ 7.983890] NetworkManager[573]: <warn> [1788912304.3564] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1784second # [ 7.988776] systemd-resolved[329]: eth0: Bus client set default route setting: yes1785second # [ 7.990709] systemd-resolved[329]: eth0: Bus client set DNS server list to: 10.0.2.31786second # [ 7.992840] systemd-logind[589]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1787test # [ 7.988710] NetworkManager[573]: <warn> [1788912304.3609] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1788second # [ 7.994841] systemd[1]: Started Getty on tty1.1789second # [ 7.996684] systemd[1]: Reached target Login Prompts.1790second # [ 7.999455] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1791second # [ 8.000788] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1792test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.06 seconds)1793cleanup1794kill QemuMachine (pid 14)1795second # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/h3l4z7p6wny3phbckwwhy1i2g52pdnj4-python3-3.13.15/bin/python3.13)1796test # [ 8.017431] systemd[1]: Started User Login Management.1797test # [ 8.255476] Console: switching to colour frame buffer device 160x501798test # [ 8.271092] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1799kill QemuMachine (pid 15)1800test # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/h3l4z7p6wny3phbckwwhy1i2g52pdnj4-python3-3.13.15/bin/python3.13)1801(finished: cleanup, in 0.20 seconds)1802Traceback (most recent call last):1803 File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1804 sys.exit(main())1805 ~~~~^^1806 File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/__init__.py", line 183, in main1807 driver.run_tests()1808 ~~~~~~~~~~~~~~~~^^1809 File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 434, in run_tests1810 self.test_script()1811 ~~~~~~~~~~~~~~~~^^1812 File "/nix/store/rci17prbh3ngidrpkzz3fqynws1f1zqk-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 392, in test_script1813 exec(self.tests, symbols, None)1814 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^1815 File "<string>", line 4, in <module>1816AssertionError: Expected mock password in connection file:1817[connection]1818autoconnect=true1819id=1820type=wifi18211822[wifi]1823mode=infrastructure1824ssid=18251826[wifi-security]1827key-mgmt=wpa-psk1828psk=1829