nixbot

builds

failed vm-test-run-wifi checks.x86_64-linux.wifi · build #64 · raw

1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test # Disk image does not exist, creating the virtualisation disk image...14test: QEMU running (pid 48)15test # Formatting '/build/vm-state-test/tmp.LZwAspuiZL', fmt=raw size=107374182416test # mke2fs 1.47.4 (6-Mar-2025)17test # Discarding device blocks: 0/262144 done18test # Creating filesystem with 262144 4k blocks and 65536 inodes19test # Filesystem UUID: 2cde335c-55ee-4e64-a4da-2803be9b9f1320test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29second # Disk image does not exist, creating the virtualisation disk image...30second # Formatting '/build/vm-state-second/tmp.4AxgEUvaha', fmt=raw size=107374182431second # mke2fs 1.47.4 (6-Mar-2025)32second # Discarding device blocks: 0/262144 done33second # Creating filesystem with 262144 4k blocks and 65536 inodes34second # Filesystem UUID: b311eada-82a4-4c0f-87e9-874e5cc44eaf35second # Superblock backups stored on blocks:36second # 32768, 98304, 163840, 22937637second # 38second # Allocating group tables: 0/8 done39second # Writing inode tables: 0/8 done40second # Creating journal (8192 blocks): done41second # Writing superblocks and filesystem accounting information: 0/8 done42second # 43second # Virtualisation disk image created.44second: QEMU running (pid 47)45(finished: start all VMs, in 0.09 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50second # 51second # 52test # 53test # 54second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0055test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0056second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...57second # 58second # 59second # 60second # 61test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...62test # 63test # 64test # 65test # 66second # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0067test # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0068second # Press Ctrl-B to configure iPXE (PCI 00:08.0)...69second # 70second # 71test # Press Ctrl-B to configure iPXE (PCI 00:08.0)...72test # 73test # 74second # Booting from ROM...75test # Booting from ROM...76test # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Aug 19 16:18:21 UTC 202677second # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Aug 19 16:18:21 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/g64n1mz2pkrifyixrpwdhipg01gjpg44-nixos-system-test-test/init regInfo=/nix/store/hxrpanhs0cg7va2a9dig0q2a9lfh8dnw-closure-info/registration console=ttyS0,115200n8 console=tty079test # [ 0.000000] BIOS-provided physical RAM map:80test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable81second # [ 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/bxssfc18jb6if0y0sb0fvgiaklzmk3np-nixos-system-second-test/init regInfo=/nix/store/77vfh9g6455qizzywsv3nrp40ckfh17p-closure-info/registration console=ttyS0,115200n8 console=tty082test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved83second # [ 0.000000] BIOS-provided physical RAM map:84test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved85second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable86test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable87second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved88test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved89second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved90second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable91test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved92second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved93test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved94second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved95test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved96second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved97test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved98second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved99test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved100test # [ 0.000000] NX (Execute Disable) protection: active101second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved102test # [ 0.000000] APIC: Static calls initialized103test # [ 0.000000] SMBIOS 2.8 present.104second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved105second # [ 0.000000] NX (Execute Disable) protection: active106test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014107second # [ 0.000000] APIC: Static calls initialized108second # [ 0.000000] SMBIOS 2.8 present.109test # [ 0.000000] DMI: Memory slots populated: 1/1110test # [ 0.000000] Hypervisor detected: KVM111test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000112second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014113second # [ 0.000000] DMI: Memory slots populated: 1/1114test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00115second # [ 0.000000] Hypervisor detected: KVM116test # [ 0.000000] kvm-clock: using sched offset of 395542417 cycles117second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000118second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00119test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns120second # [ 0.000000] kvm-clock: using sched offset of 395039271 cycles121test # [ 0.000005] tsc: Detected 4192.100 MHz processor122test # [ 0.000566] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000123second # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns124test # [ 0.000593] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs125second # [ 0.000004] tsc: Detected 4192.100 MHz processor126second # [ 0.000566] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000127test # [ 0.000594] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT128test # [ 0.002157] found SMP MP-table at [mem 0x000f5450-0x000f545f]129second # [ 0.000592] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs130test # [ 0.002168] Using GB pages for direct mapping131second # [ 0.000594] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT132test # [ 0.002227] RAMDISK: [mem 0x3e347000-0x3ffcffff]133second # [ 0.002153] found SMP MP-table at [mem 0x000f5450-0x000f545f]134test # [ 0.002232] ACPI: Early table checksum verification disabled135second # [ 0.002163] Using GB pages for direct mapping136test # [ 0.002235] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )137second # [ 0.002203] RAMDISK: [mem 0x3e348000-0x3ffcffff]138second # [ 0.002206] ACPI: Early table checksum verification disabled139test # [ 0.002237] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)140second # [ 0.002209] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )141test # [ 0.002241] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)142second # [ 0.002211] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)143test # [ 0.002247] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)144test # [ 0.002248] ACPI: FACS 0x000000003FFE0000 000040145second # [ 0.002215] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)146test # [ 0.002249] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)147second # [ 0.002220] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)148second # [ 0.002221] ACPI: FACS 0x000000003FFE0000 000040149test # [ 0.002250] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)150second # [ 0.002222] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)151test # [ 0.002252] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)152second # [ 0.002224] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)153test # [ 0.002253] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)154second # [ 0.002225] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)155test # [ 0.002254] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]156second # [ 0.002226] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)157test # [ 0.002254] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]158second # [ 0.002227] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]159test # [ 0.002255] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]160second # [ 0.002228] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]161test # [ 0.002255] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]162second # [ 0.002228] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]163test # [ 0.002255] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]164second # [ 0.002228] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]165test # [ 0.002256] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]166second # [ 0.002229] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]167test # [ 0.002256] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]168test # [ 0.002579] No NUMA configuration found169second # [ 0.002229] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]170test # [ 0.002581] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]171second # [ 0.002229] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]172test # [ 0.002583] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]173second # [ 0.002557] No NUMA configuration found174test # [ 0.002646] Zone ranges:175second # [ 0.002558] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]176test # [ 0.002647] DMA [mem 0x0000000000001000-0x0000000000ffffff]177second # [ 0.002560] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]178test # [ 0.002648] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]179second # [ 0.002624] Zone ranges:180test # [ 0.002649] Normal empty181test # [ 0.002649] Device empty182second # [ 0.002625] DMA [mem 0x0000000000001000-0x0000000000ffffff]183test # [ 0.002650] Movable zone start for each node184second # [ 0.002626] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]185test # [ 0.002650] Early memory node ranges186second # [ 0.002627] Normal empty187second # [ 0.002627] Device empty188test # [ 0.002650] node 0: [mem 0x0000000000001000-0x000000000009efff]189second # [ 0.002628] Movable zone start for each node190test # [ 0.002651] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]191second # [ 0.002628] Early memory node ranges192test # [ 0.002652] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]193second # [ 0.002628] node 0: [mem 0x0000000000001000-0x000000000009efff]194test # [ 0.002666] On node 0, zone DMA: 1 pages in unavailable ranges195second # [ 0.002629] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]196test # [ 0.002849] On node 0, zone DMA: 97 pages in unavailable ranges197second # [ 0.002630] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]198test # [ 0.015306] On node 0, zone DMA32: 40 pages in unavailable ranges199second # [ 0.002646] On node 0, zone DMA: 1 pages in unavailable ranges200test # [ 0.016044] ACPI: PM-Timer IO Port: 0x608201second # [ 0.002829] On node 0, zone DMA: 97 pages in unavailable ranges202test # [ 0.016053] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])203second # [ 0.015308] On node 0, zone DMA32: 40 pages in unavailable ranges204test # [ 0.016073] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23205second # [ 0.016046] ACPI: PM-Timer IO Port: 0x608206test # [ 0.016075] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)207second # [ 0.016054] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])208test # [ 0.016076] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)209second # [ 0.016073] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23210test # [ 0.016077] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)211second # [ 0.016074] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)212test # [ 0.016078] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)213second # [ 0.016076] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)214second # [ 0.016077] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)215test # [ 0.016078] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)216test # [ 0.016080] ACPI: Using ACPI (MADT) for SMP configuration information217second # [ 0.016077] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)218test # [ 0.016081] ACPI: HPET id: 0x8086a201 base: 0xfed00000219second # [ 0.016078] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)220test # [ 0.016083] TSC deadline timer available221second # [ 0.016080] ACPI: Using ACPI (MADT) for SMP configuration information222test # [ 0.016087] CPU topo: Max. logical packages: 1223test # [ 0.016087] CPU topo: Max. logical dies: 1224second # [ 0.016081] ACPI: HPET id: 0x8086a201 base: 0xfed00000225second # [ 0.016083] TSC deadline timer available226test # [ 0.016087] CPU topo: Max. dies per package: 1227second # [ 0.016086] CPU topo: Max. logical packages: 1228test # [ 0.016090] CPU topo: Max. threads per core: 1229second # [ 0.016087] CPU topo: Max. logical dies: 1230test # [ 0.016090] CPU topo: Num. cores per package: 1231second # [ 0.016087] CPU topo: Max. dies per package: 1232test # [ 0.016090] CPU topo: Num. threads per package: 1233second # [ 0.016089] CPU topo: Max. threads per core: 1234test # [ 0.016091] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs235second # [ 0.016090] CPU topo: Num. cores per package: 1236test # [ 0.016103] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()237second # [ 0.016090] CPU topo: Num. threads per package: 1238second # [ 0.016090] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs239second # [ 0.016102] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()240test # [ 0.016128] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]241test # [ 0.016129] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]242test # [ 0.016131] [mem 0x40000000-0xafffffff] available for PCI devices243second # [ 0.016128] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]244test # [ 0.016131] Booting paravirtualized kernel on KVM245second # [ 0.016129] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]246second # [ 0.016130] [mem 0x40000000-0xafffffff] available for PCI devices247test # [ 0.016134] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns248second # [ 0.016131] Booting paravirtualized kernel on KVM249test # [ 0.019230] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1250second # [ 0.016134] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns251test # [ 0.020776] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152252test # [ 0.020808] kvm-guest: PV spinlocks disabled, single CPU253second # [ 0.019240] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1254second # [ 0.020784] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152255second # [ 0.020811] kvm-guest: PV spinlocks disabled, single CPU256test # [ 0.020809] 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/g64n1mz2pkrifyixrpwdhipg01gjpg44-nixos-system-test-test/init regInfo=/nix/store/hxrpanhs0cg7va2a9dig0q2a9lfh8dnw-closure-info/registration console=ttyS0,115200n8 console=tty0257second # [ 0.020813] 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/bxssfc18jb6if0y0sb0fvgiaklzmk3np-nixos-system-second-test/init regInfo=/nix/store/77vfh9g6455qizzywsv3nrp40ckfh17p-closure-info/registration console=ttyS0,115200n8 console=tty0258test # [ 0.020875] Unknown kernel command line parameters "regInfo=/nix/store/hxrpanhs0cg7va2a9dig0q2a9lfh8dnw-closure-info/registration", will be passed to user space.259test # [ 0.021065] random: crng init done260test # [ 0.021065] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes261second # [ 0.020877] Unknown kernel command line parameters "regInfo=/nix/store/77vfh9g6455qizzywsv3nrp40ckfh17p-closure-info/registration", will be passed to user space.262second # [ 0.021067] random: crng init done263test # [ 0.021829] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)264second # [ 0.021068] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes265test # [ 0.021841] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)266test # [ 0.021864] Fallback order for Node 0: 0267second # [ 0.021826] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)268test # [ 0.021867] Built 1 zonelists, mobility grouping on. Total pages: 262006269test # [ 0.021867] Policy zone: DMA32270second # [ 0.021838] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)271second # [ 0.021865] Fallback order for Node 0: 0272test # [ 0.023579] mem auto-init: stack:all(zero), heap alloc:on, heap free:off273second # [ 0.021868] Built 1 zonelists, mobility grouping on. Total pages: 262006274test # [ 0.025780] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1275second # [ 0.021869] Policy zone: DMA32276test # [ 0.027463] allocated 2097152 bytes of page_ext277second # [ 0.023682] mem auto-init: stack:all(zero), heap alloc:on, heap free:off278test # [ 0.036174] ftrace: allocating 48728 entries in 192 pages279second # [ 0.025981] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1280test # [ 0.036175] ftrace: allocated 192 pages with 2 groups281test # [ 0.036834] Dynamic Preempt: lazy282second # [ 0.027583] allocated 2097152 bytes of page_ext283second # [ 0.036365] ftrace: allocating 48728 entries in 192 pages284test # [ 0.036954] rcu: Preemptible hierarchical RCU implementation.285test # [ 0.036954] rcu: RCU event tracing is enabled.286second # [ 0.036366] ftrace: allocated 192 pages with 2 groups287second # [ 0.037063] Dynamic Preempt: lazy288test # [ 0.036954] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.289second # [ 0.037181] rcu: Preemptible hierarchical RCU implementation.290test # [ 0.036956] Trampoline variant of Tasks RCU enabled.291second # [ 0.037181] rcu: RCU event tracing is enabled.292test # [ 0.036956] Rude variant of Tasks RCU enabled.293second # [ 0.037182] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.294test # [ 0.036956] Tracing variant of Tasks RCU enabled.295second # [ 0.037183] Trampoline variant of Tasks RCU enabled.296test # [ 0.036957] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.297second # [ 0.037183] Rude variant of Tasks RCU enabled.298second # [ 0.037183] Tracing variant of Tasks RCU enabled.299test # [ 0.036957] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1300second # [ 0.037184] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.301test # [ 0.036973] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.302second # [ 0.037185] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1303test # [ 0.036974] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.304second # [ 0.037197] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.305test # [ 0.036975] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.306second # [ 0.037198] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.307test # [ 0.040188] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16308test # [ 0.040430] rcu: srcu_init: Setting srcu_struct sizes based on contention.309second # [ 0.037199] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.310second # [ 0.040458] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16311test # [ 0.040437] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns312second # [ 0.040704] rcu: srcu_init: Setting srcu_struct sizes based on contention.313test # [ 0.040597] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)314test # [ 0.045741] Console: colour VGA+ 80x25315second # [ 0.040710] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns316test # [ 0.045745] printk: legacy console [tty0] enabled317test # [ 0.075762] printk: legacy console [ttyS0] enabled318second # [ 0.040863] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)319second # [ 0.045977] Console: colour VGA+ 80x25320test # [ 0.205974] ACPI: Core revision 20250807321second # [ 0.045980] printk: legacy console [tty0] enabled322second # [ 0.075990] printk: legacy console [ttyS0] enabled323test # [ 0.207007] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns324second # [ 0.206300] ACPI: Core revision 20250807325test # [ 0.208880] APIC: Switch to symmetric I/O mode setup326test # [ 0.210033] x2apic enabled327second # [ 0.207321] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns328test # [ 0.210831] APIC: Switched APIC routing to: physical x2apic329second # [ 0.209197] APIC: Switch to symmetric I/O mode setup330second # [ 0.210356] x2apic enabled331test # [ 0.212753] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1332second # [ 0.211155] APIC: Switched APIC routing to: physical x2apic333test # [ 0.213950] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns334second # [ 0.213092] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1335test # [ 0.215961] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)336second # [ 0.214289] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns337test # [ 0.217046] x86/cpu: User Mode Instruction Prevention (UMIP) activated338second # [ 0.216304] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)339test # [ 0.219103] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127340second # [ 0.217386] x86/cpu: User Mode Instruction Prevention (UMIP) activated341test # [ 0.219961] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0342second # [ 0.219408] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127343test # [ 0.220963] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto344second # [ 0.220303] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0345test # [ 0.221961] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl346second # [ 0.221306] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto347test # [ 0.223961] Spectre V2 : Mitigation: Enhanced / Automatic IBRS348second # [ 0.222303] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl349test # [ 0.224961] Speculative Return Stack Overflow: Mitigation: Safe RET350second # [ 0.224303] Spectre V2 : Mitigation: Enhanced / Automatic IBRS351test # [ 0.225961] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization352second # [ 0.225303] Speculative Return Stack Overflow: Mitigation: Safe RET353second # [ 0.226303] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization354test # [ 0.227966] Spectre V2 : Enabling IBPB for BPF355test # [ 0.229668] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier356second # [ 0.228308] Spectre V2 : Enabling IBPB for BPF357test # [ 0.230961] active return thunk: srso_alias_return_thunk358second # [ 0.230012] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier359test # [ 0.231981] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'360second # [ 0.231303] active return thunk: srso_alias_return_thunk361test # [ 0.232961] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'362second # [ 0.232322] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'363test # [ 0.233961] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'364second # [ 0.233303] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'365test # [ 0.234961] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'366second # [ 0.234303] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'367test # [ 0.235961] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'368second # [ 0.235303] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'369test # [ 0.236961] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'370second # [ 0.236303] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'371test # [ 0.238961] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'372second # [ 0.238303] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'373test # [ 0.239961] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'374second # [ 0.239302] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'375test # [ 0.241961] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'376second # [ 0.240303] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'377test # [ 0.242961] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256378second # [ 0.242303] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'379test # [ 0.244961] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64380second # [ 0.243303] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256381test # [ 0.245961] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512382second # [ 0.245302] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64383test # [ 0.246961] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024384second # [ 0.246303] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512385test # [ 0.247961] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8386second # [ 0.247303] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024387test # [ 0.248961] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16388second # [ 0.248303] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8389test # [ 0.250961] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24390second # [ 0.249303] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16391test # [ 0.251961] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.392second # [ 0.251302] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24393second # [ 0.252302] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.394test # [ 0.278095] Freeing SMP alternatives memory: 44K395test # [ 0.278962] pid_max: default: 32768 minimum: 301396test # [ 0.280007] LSM: initializing lsm=capability,landlock,yama,bpf,ima397second # [ 0.278618] Freeing SMP alternatives memory: 44K398test # [ 0.281052] landlock: Up and running.399second # [ 0.279304] pid_max: default: 32768 minimum: 301400test # [ 0.281961] Yama: becoming mindful.401second # [ 0.280351] LSM: initializing lsm=capability,landlock,yama,bpf,ima402test # [ 0.282980] LSM support for eBPF active403second # [ 0.281377] landlock: Up and running.404second # [ 0.282303] Yama: becoming mindful.405test # [ 0.283840] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)406second # [ 0.283477] LSM support for eBPF active407test # [ 0.284978] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)408second # [ 0.284371] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)409second # [ 0.285320] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)410test # [ 0.287515] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)411test # [ 0.288375] Performance Events: Fam17h+ core perfctr, AMD PMU driver.412second # [ 0.287049] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)413test # [ 0.288964] ... version: 2414test # [ 0.289823] ... bit width: 48415second # [ 0.287676] Performance Events: Fam17h+ core perfctr, AMD PMU driver.416test # [ 0.290643] ... generic counters: 6417second # [ 0.288306] ... version: 2418test # [ 0.290970] ... generic bitmap: 000000000000003f419second # [ 0.289172] ... bit width: 48420test # [ 0.291962] ... fixed-purpose counters: 0421second # [ 0.289981] ... generic counters: 6422test # [ 0.292826] ... fixed-purpose bitmap: 0000000000000000423second # [ 0.290312] ... generic bitmap: 000000000000003f424test # [ 0.293834] ... value mask: 0000ffffffffffff425second # [ 0.291304] ... fixed-purpose counters: 0426test # [ 0.294834] ... max period: 00007fffffffffff427second # [ 0.292168] ... fixed-purpose bitmap: 0000000000000000428test # [ 0.295827] ... global_ctrl mask: 000000000000003f429second # [ 0.293170] ... value mask: 0000ffffffffffff430test # [ 0.296918] signal: max sigframe size: 3376431second # [ 0.294171] ... max period: 00007fffffffffff432test # [ 0.297684] rcu: Hierarchical SRCU implementation.433second # [ 0.295172] ... global_ctrl mask: 000000000000003f434test # [ 0.297965] rcu: Max phase no-delay instances is 400.435second # [ 0.296250] signal: max sigframe size: 3376436second # [ 0.297026] rcu: Hierarchical SRCU implementation.437second # [ 0.297307] rcu: Max phase no-delay instances is 400.438test # [ 0.301870] smp: Bringing up secondary CPUs ...439test # [ 0.302682] smp: Brought up 1 node, 1 CPU440test # [ 0.302962] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)441second # [ 0.301220] smp: Bringing up secondary CPUs ...442second # [ 0.302022] smp: Brought up 1 node, 1 CPU443second # [ 0.302304] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)444test # [ 0.304101] Memory: 942888K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97724K reserved, 0K cma-reserved)445test # [ 0.305119] devtmpfs: initialized446test # [ 0.305981] x86/mm: Memory block size: 128MB447second # [ 0.303450] Memory: 942848K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97720K reserved, 0K cma-reserved)448second # [ 0.304450] devtmpfs: initialized449test # [ 0.307510] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)450second # [ 0.305413] x86/mm: Memory block size: 128MB451test # [ 0.307983] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).452second # [ 0.307036] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)453test # [ 0.309026] pinctrl core: initialized pinctrl subsystem454test # [ 0.310204] PM: RTC time: 11:33:18, date: 2026-08-25455second # [ 0.308330] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).456second # [ 0.309373] pinctrl core: initialized pinctrl subsystem457second # [ 0.310616] PM: RTC time: 11:33:18, date: 2026-08-25458test # [ 0.313053] NET: Registered PF_NETLINK/PF_ROUTE protocol family459test # [ 0.314211] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations460second # [ 0.313308] NET: Registered PF_NETLINK/PF_ROUTE protocol family461test # [ 0.314977] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations462second # [ 0.314576] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations463test # [ 0.316066] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations464test # [ 0.316968] audit: initializing netlink subsys (disabled)465second # [ 0.315319] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations466test # [ 0.318167] thermal_sys: Registered thermal governor 'fair_share'467second # [ 0.316415] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations468test # [ 0.318169] thermal_sys: Registered thermal governor 'bang_bang'469second # [ 0.317311] audit: initializing netlink subsys (disabled)470test # [ 0.318962] thermal_sys: Registered thermal governor 'step_wise'471second # [ 0.318459] thermal_sys: Registered thermal governor 'fair_share'472second # [ 0.318461] thermal_sys: Registered thermal governor 'bang_bang'473test # [ 0.319964] audit: type=2000 audit(1787657599.308:1): state=initialized audit_enabled=0 res=1474second # [ 0.319304] thermal_sys: Registered thermal governor 'step_wise'475test # [ 0.321964] thermal_sys: Registered thermal governor 'user_space'476test # [ 0.321965] thermal_sys: Registered thermal governor 'power_allocator'477second # [ 0.320306] audit: type=2000 audit(1787657599.310:1): state=initialized audit_enabled=0 res=1478test # [ 0.322973] cpuidle: using governor menu479second # [ 0.322305] thermal_sys: Registered thermal governor 'user_space'480second # [ 0.322307] thermal_sys: Registered thermal governor 'power_allocator'481test # [ 0.325556] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5482second # [ 0.323316] cpuidle: using governor menu483test # [ 0.326151] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]484second # [ 0.326069] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5485test # [ 0.326965] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry486test # [ 0.327970] PCI: Using configuration type 1 for base access487second # [ 0.326508] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]488second # [ 0.327306] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry489test # [ 0.329119] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.490second # [ 0.328314] PCI: Using configuration type 1 for base access491second # [ 0.329447] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.492test # [ 0.336134] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages493test # [ 0.336962] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page494second # [ 0.336502] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages495second # [ 0.337304] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page496test # [ 0.341962] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages497test # [ 0.342963] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page498second # [ 0.342303] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages499second # [ 0.343305] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page500test # [ 0.350235] ACPI: Added _OSI(Module Device)501test # [ 0.350963] ACPI: Added _OSI(Processor Device)502test # [ 0.351874] ACPI: Added _OSI(Processor Aggregator Device)503second # [ 0.350621] ACPI: Added _OSI(Module Device)504second # [ 0.351305] ACPI: Added _OSI(Processor Device)505second # [ 0.352209] ACPI: Added _OSI(Processor Aggregator Device)506test # [ 0.356755] ACPI: 1 ACPI AML tables successfully acquired and loaded507second # [ 0.357123] ACPI: 1 ACPI AML tables successfully acquired and loaded508test # [ 0.362714] ACPI: Interpreter enabled509test # [ 0.362974] ACPI: PM: (supports S0 S3 S4 S5)510test # [ 0.363850] ACPI: Using IOAPIC for interrupt routing511second # [ 0.363079] ACPI: Interpreter enabled512test # [ 0.364790] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug513second # [ 0.363317] ACPI: PM: (supports S0 S3 S4 S5)514second # [ 0.364185] ACPI: Using IOAPIC for interrupt routing515test # [ 0.366781] PCI: Using E820 reservations for host bridge windows516second # [ 0.365114] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug517test # [ 0.368031] ACPI: Enabled 2 GPEs in block 00 to 3F518second # [ 0.367129] PCI: Using E820 reservations for host bridge windows519second # [ 0.368369] ACPI: Enabled 2 GPEs in block 00 to 3F520test # [ 0.372103] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])521test # [ 0.372967] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]522second # [ 0.372436] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])523test # [ 0.374019] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]524test # [ 0.375055] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]525second # [ 0.373309] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]526test # [ 0.376348] PCI host bridge to bus 0000:00527second # [ 0.374372] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]528test # [ 0.376966] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]529second # [ 0.375397] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]530test # [ 0.377963] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]531second # [ 0.376680] PCI host bridge to bus 0000:00532test # [ 0.378963] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]533second # [ 0.377308] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]534second # [ 0.378305] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]535test # [ 0.379963] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]536test # [ 0.380963] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]537second # [ 0.379304] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]538second # [ 0.380304] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]539test # [ 0.381963] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]540test # [ 0.382963] pci_bus 0000:00: root bus resource [bus 00-ff]541second # [ 0.381304] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]542test # [ 0.384044] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint543second # [ 0.382304] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]544second # [ 0.383304] pci_bus 0000:00: root bus resource [bus 00-ff]545test # [ 0.385573] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint546second # [ 0.384374] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint547second # [ 0.385915] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint548test # [ 0.387931] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]549test # [ 0.388981] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]550test # [ 0.389999] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]551second # [ 0.388262] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]552second # [ 0.389323] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]553test # [ 0.391129] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]554second # [ 0.390341] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]555test # [ 0.392660] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint556second # [ 0.391469] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]557test # [ 0.393972] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]558second # [ 0.393002] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint559test # [ 0.395016] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]560test # [ 0.396029] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]561second # [ 0.394314] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]562test # [ 0.396972] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]563second # [ 0.395359] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]564second # [ 0.396376] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]565test # [ 0.398900] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint566second # [ 0.397314] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]567second # [ 0.399244] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint568test # [ 0.401659] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]569test # [ 0.401972] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]570test # [ 0.402999] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]571second # [ 0.402317] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]572second # [ 0.403316] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]573test # [ 0.404791] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint574second # [ 0.404344] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]575test # [ 0.406972] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]576second # [ 0.406141] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint577test # [ 0.407972] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]578test # [ 0.409000] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]579second # [ 0.408314] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]580second # [ 0.409320] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]581test # [ 0.410815] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint582second # [ 0.410341] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]583test # [ 0.412972] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]584second # [ 0.412153] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint585test # [ 0.413972] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]586test # [ 0.414999] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]587second # [ 0.414315] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]588test # [ 0.416793] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint589second # [ 0.415317] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]590second # [ 0.416343] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]591test # [ 0.418977] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]592test # [ 0.419972] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]593second # [ 0.418150] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint594test # [ 0.421000] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]595second # [ 0.420314] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]596test # [ 0.422848] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint597second # [ 0.421317] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]598second # [ 0.422343] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]599test # [ 0.425115] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]600test # [ 0.425983] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]601second # [ 0.424161] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint602test # [ 0.427001] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]603second # [ 0.426314] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]604test # [ 0.428876] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint605second # [ 0.427314] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]606second # [ 0.428341] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]607test # [ 0.430973] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]608test # [ 0.431972] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]609second # [ 0.430185] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint610test # [ 0.433000] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]611test # [ 0.433972] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]612second # [ 0.432314] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]613second # [ 0.433315] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]614test # [ 0.435835] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint615second # [ 0.434342] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]616second # [ 0.435314] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]617test # [ 0.437938] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]618test # [ 0.438942] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]619second # [ 0.437148] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint620test # [ 0.440814] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint621second # [ 0.439314] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]622second # [ 0.440342] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]623test # [ 0.442972] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]624test # [ 0.443973] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]625second # [ 0.442143] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint626test # [ 0.445000] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]627second # [ 0.444314] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]628test # [ 0.446830] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint629second # [ 0.445314] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]630second # [ 0.446342] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]631test # [ 0.448973] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]632test # [ 0.449973] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]633second # [ 0.448144] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint634test # [ 0.451000] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]635second # [ 0.450314] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]636second # [ 0.451315] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]637second # [ 0.452342] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]638test # [ 0.452850] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint639test # [ 0.454972] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]640test # [ 0.456221] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint641second # [ 0.454181] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint642second # [ 0.456039] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]643test # [ 0.457939] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]644second # [ 0.456583] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint645test # [ 0.459042] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint646second # [ 0.458008] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]647test # [ 0.460886] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]648second # [ 0.458560] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint649test # [ 0.462097] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint650second # [ 0.460014] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]651test # [ 0.463701] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]652second # [ 0.460591] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint653test # [ 0.464249] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint654second # [ 0.461934] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]655test # [ 0.465423] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO656test # [ 0.466298] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint657second # [ 0.462640] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint658second # [ 0.463773] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO659test # [ 0.468263] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]660test # [ 0.468972] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]661second # [ 0.464641] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint662test # [ 0.470414] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint663second # [ 0.466242] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]664second # [ 0.467170] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]665test # [ 0.471695] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]666second # [ 0.468698] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint667second # [ 0.470355] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]668test # [ 0.476409] ACPI: PCI: Interrupt link LNKA configured for IRQ 10669test # [ 0.477079] ACPI: PCI: Interrupt link LNKB configured for IRQ 10670test # [ 0.478085] ACPI: PCI: Interrupt link LNKC configured for IRQ 11671test # [ 0.479074] ACPI: PCI: Interrupt link LNKD configured for IRQ 11672second # [ 0.475801] ACPI: PCI: Interrupt link LNKA configured for IRQ 10673test # [ 0.480071] ACPI: PCI: Interrupt link LNKE configured for IRQ 10674second # [ 0.476419] ACPI: PCI: Interrupt link LNKB configured for IRQ 10675test # [ 0.481072] ACPI: PCI: Interrupt link LNKF configured for IRQ 10676second # [ 0.477415] ACPI: PCI: Interrupt link LNKC configured for IRQ 11677test # [ 0.482075] ACPI: PCI: Interrupt link LNKG configured for IRQ 11678second # [ 0.478419] ACPI: PCI: Interrupt link LNKD configured for IRQ 11679test # [ 0.483071] ACPI: PCI: Interrupt link LNKH configured for IRQ 11680second # [ 0.479418] ACPI: PCI: Interrupt link LNKE configured for IRQ 10681test # [ 0.484008] ACPI: PCI: Interrupt link GSIA configured for IRQ 16682second # [ 0.480436] ACPI: PCI: Interrupt link LNKF configured for IRQ 10683test # [ 0.484978] ACPI: PCI: Interrupt link GSIB configured for IRQ 17684second # [ 0.481431] ACPI: PCI: Interrupt link LNKG configured for IRQ 11685test # [ 0.485977] ACPI: PCI: Interrupt link GSIC configured for IRQ 18686second # [ 0.482430] ACPI: PCI: Interrupt link LNKH configured for IRQ 11687test # [ 0.486975] ACPI: PCI: Interrupt link GSID configured for IRQ 19688second # [ 0.483358] ACPI: PCI: Interrupt link GSIA configured for IRQ 16689test # [ 0.487978] ACPI: PCI: Interrupt link GSIE configured for IRQ 20690test # [ 0.488978] ACPI: PCI: Interrupt link GSIF configured for IRQ 21691second # [ 0.484323] ACPI: PCI: Interrupt link GSIB configured for IRQ 17692test # [ 0.489977] ACPI: PCI: Interrupt link GSIG configured for IRQ 22693second # [ 0.485317] ACPI: PCI: Interrupt link GSIC configured for IRQ 18694test # [ 0.490975] ACPI: PCI: Interrupt link GSIH configured for IRQ 23695second # [ 0.486321] ACPI: PCI: Interrupt link GSID configured for IRQ 19696second # [ 0.487322] ACPI: PCI: Interrupt link GSIE configured for IRQ 20697test # [ 0.492809] iommu: Default domain type: Translated698second # [ 0.488317] ACPI: PCI: Interrupt link GSIF configured for IRQ 21699test # [ 0.493767] iommu: DMA domain TLB invalidation policy: lazy mode700second # [ 0.489320] ACPI: PCI: Interrupt link GSIG configured for IRQ 22701test # [ 0.495172] ACPI: bus type USB registered702second # [ 0.490316] ACPI: PCI: Interrupt link GSIH configured for IRQ 23703test # [ 0.496017] usbcore: registered new interface driver usbfs704test # [ 0.496976] usbcore: registered new interface driver hub705second # [ 0.492161] iommu: Default domain type: Translated706test # [ 0.497980] usbcore: registered new device driver usb707second # [ 0.493112] iommu: DMA domain TLB invalidation policy: lazy mode708test # [ 0.499683] NetLabel: Initializing709second # [ 0.494493] ACPI: bus type USB registered710test # [ 0.499966] NetLabel: domain hash size = 128711second # [ 0.495367] usbcore: registered new interface driver usbfs712test # [ 0.500877] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO713second # [ 0.496322] usbcore: registered new interface driver hub714test # [ 0.501913] NetLabel: unlabeled traffic allowed by default715second # [ 0.497323] usbcore: registered new device driver usb716test # [ 0.502866] PCI: Using ACPI for IRQ routing717second # [ 0.499007] NetLabel: Initializing718second # [ 0.499317] NetLabel: domain hash size = 128719second # [ 0.500223] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO720second # [ 0.501273] NetLabel: unlabeled traffic allowed by default721second # [ 0.502209] PCI: Using ACPI for IRQ routing722test # [ 0.577800] pci 0000:00:01.0: vgaarb: setting as boot VGA device723test # [ 0.577959] pci 0000:00:01.0: vgaarb: bridge control possible724test # [ 0.577959] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none725test # [ 0.577964] vgaarb: loaded726test # [ 0.578761] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0727second # [ 0.577265] pci 0000:00:01.0: vgaarb: setting as boot VGA device728test # [ 0.579746] hpet0: 3 comparators, 64-bit 100.000000 MHz counter729second # [ 0.577301] pci 0000:00:01.0: vgaarb: bridge control possible730second # [ 0.577301] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none731second # [ 0.577306] vgaarb: loaded732second # [ 0.578103] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0733test # [ 0.584048] clocksource: Switched to clocksource kvm-clock734second # [ 0.579112] hpet0: 3 comparators, 64-bit 100.000000 MHz counter735test # [ 0.587076] VFS: Disk quotas dquot_6.6.0736test # [ 0.587939] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)737second # [ 0.582368] clocksource: Switched to clocksource kvm-clock738test # [ 0.589480] pnp: PnP ACPI init739test # [ 0.590397] ACPI: IRQ 4 override to edge(!), high(!)740second # [ 0.585448] VFS: Disk quotas dquot_6.6.0741test # [ 0.591542] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved742test # [ 0.593294] pnp: PnP ACPI: found 6 devices743second # [ 0.586300] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)744second # [ 0.587918] pnp: PnP ACPI init745second # [ 0.588816] ACPI: IRQ 4 override to edge(!), high(!)746second # [ 0.589977] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved747second # [ 0.591792] pnp: PnP ACPI: found 6 devices748test # [ 0.600374] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns749test # [ 0.602120] clocksource: Switched to clocksource acpi_pm750test # [ 0.603289] NET: Registered PF_INET protocol family751test # [ 0.604442] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)752second # [ 0.598985] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns753second # [ 0.600729] clocksource: Switched to clocksource acpi_pm754second # [ 0.601887] NET: Registered PF_INET protocol family755second # [ 0.603068] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)756test # [ 0.617352] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)757test # [ 0.619124] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)758test # [ 0.620670] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)759test # [ 0.622226] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)760second # [ 0.616214] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)761test # [ 0.623675] TCP: Hash tables configured (established 8192 bind 8192)762second # [ 0.617953] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)763test # [ 0.624983] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)764second # [ 0.619492] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)765test # [ 0.626496] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)766second # [ 0.621071] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)767test # [ 0.627856] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)768second # [ 0.622520] TCP: Hash tables configured (established 8192 bind 8192)769test # [ 0.629300] NET: Registered PF_UNIX/PF_LOCAL protocol family770test # [ 0.630463] NET: Registered PF_XDP protocol family771second # [ 0.623856] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)772test # [ 0.631479] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]773second # [ 0.625355] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)774test # [ 0.632720] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]775second # [ 0.626684] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)776test # [ 0.633934] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]777second # [ 0.628111] NET: Registered PF_UNIX/PF_LOCAL protocol family778test # [ 0.635284] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]779second # [ 0.629269] NET: Registered PF_XDP protocol family780test # [ 0.636610] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]781second # [ 0.630273] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]782test # [ 0.637932] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]783second # [ 0.631488] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]784second # [ 0.632745] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]785test # [ 0.639815] ACPI: \_SB_.GSIA: Enabled at IRQ 16786second # [ 0.634075] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]787test # [ 0.641793] ACPI: \_SB_.GSIB: Enabled at IRQ 17788second # [ 0.635409] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]789test # [ 0.643673] ACPI: \_SB_.GSIC: Enabled at IRQ 18790second # [ 0.636776] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]791second # [ 0.638644] ACPI: \_SB_.GSIA: Enabled at IRQ 16792test # [ 0.645492] ACPI: \_SB_.GSID: Enabled at IRQ 19793test # [ 0.647136] PCI: CLS 0 bytes, default 64794second # [ 0.640542] ACPI: \_SB_.GSIB: Enabled at IRQ 17795second # [ 0.642399] ACPI: \_SB_.GSIC: Enabled at IRQ 18796test # [ 0.648161] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns797test # [ 0.650145] Trying to unpack rootfs image as initramfs...798second # [ 0.644232] ACPI: \_SB_.GSID: Enabled at IRQ 19799second # [ 0.645889] PCI: CLS 0 bytes, default 64800second # [ 0.646887] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns801second # [ 0.648875] Trying to unpack rootfs image as initramfs...802test # [ 0.683195] Initialise system trusted keyrings803test # [ 0.686602] workingset: timestamp_bits=40 max_order=18 bucket_order=0804second # [ 0.684958] Initialise system trusted keyrings805second # [ 0.686072] workingset: timestamp_bits=40 max_order=18 bucket_order=0806test # [ 0.704014] Key type asymmetric registered807test # [ 0.706568] Asymmetric key parser 'x509' registered808test # [ 0.707661] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)809second # [ 0.706715] Key type asymmetric registered810test # [ 0.713699] io scheduler mq-deadline registered811second # [ 0.707569] Asymmetric key parser 'x509' registered812test # [ 0.714675] io scheduler kyber registered813second # [ 0.710659] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)814test # [ 0.718037] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled815second # [ 0.714667] io scheduler mq-deadline registered816test # [ 0.721561] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A817second # [ 0.715583] io scheduler kyber registered818second # [ 0.719059] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled819test # [ 0.726686] Linux agpgart interface v0.103820second # [ 0.720569] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A821test # [ 0.727655] ACPI: bus type drm_connector registered822test # [ 0.730907] usbcore: registered new interface driver usbserial_generic823test # [ 0.732263] usbserial: USB Serial support registered for generic824second # [ 0.726030] Linux agpgart interface v0.103825second # [ 0.726958] ACPI: bus type drm_connector registered826test # [ 0.735561] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.827second # [ 0.729983] usbcore: registered new interface driver usbserial_generic828test # [ 0.735561] Please enable it if your BIOS has the CPPC option.829second # [ 0.731277] usbserial: USB Serial support registered for generic830test # [ 0.738200] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled831second # [ 0.734629] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.832second # [ 0.734629] Please enable it if your BIOS has the CPPC option.833test # [ 0.742679] drop_monitor: Initializing network drop monitor service834test # [ 0.744086] NET: Registered PF_INET6 protocol family835second # [ 0.737292] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled836second # [ 0.741740] drop_monitor: Initializing network drop monitor service837test # [ 0.748971] Segment Routing with IPv6838second # [ 0.743119] NET: Registered PF_INET6 protocol family839test # [ 0.751582] In-situ OAM (IOAM) with IPv6840test # [ 0.752797] IPI shorthand broadcast: enabled841second # [ 0.746999] Segment Routing with IPv6842second # [ 0.749645] In-situ OAM (IOAM) with IPv6843second # [ 0.751839] IPI shorthand broadcast: enabled844test # [ 0.758240] sched_clock: Marking stable (587021056, 170522115)->(838704324, -81161153)845test # [ 0.763697] registered taskstats version 1846second # [ 0.757207] sched_clock: Marking stable (586021228, 170591435)->(842497537, -85884874)847test # [ 0.764740] Loading compiled-in X.509 certificates848second # [ 0.762886] registered taskstats version 1849second # [ 0.763938] Loading compiled-in X.509 certificates850test # [ 0.780583] Demotion targets for Node 0: null851test # [ 0.781641] Key type .fscrypt registered852test # [ 0.782457] Key type fscrypt-provisioning registered853test # [ 0.784662] ima: No TPM chip found, activating TPM-bypass!854test # [ 0.785787] ima: Allocated hash algorithm: sha1855second # [ 0.779638] Demotion targets for Node 0: null856second # [ 0.780700] Key type .fscrypt registered857second # [ 0.781523] Key type fscrypt-provisioning registered858test # [ 0.788599] ima: No architecture policies found859test # [ 0.791562] PM: Magic number: 6:88:581860second # [ 0.784734] ima: No TPM chip found, activating TPM-bypass!861second # [ 0.785855] ima: Allocated hash algorithm: sha1862test # [ 0.793250] RAS: Correctable Errors collector initialized.863second # [ 0.788695] ima: No architecture policies found864second # [ 0.789809] PM: Magic number: 6:88:581865second # [ 0.791358] RAS: Correctable Errors collector initialized.866test # [ 0.801424] clk: Disabling unused clocks867test # [ 0.805567] PM: genpd: Disabling unused power domains868second # [ 0.801274] clk: Disabling unused clocks869second # [ 0.802136] PM: genpd: Disabling unused power domains870test # [ 0.910072] Freeing initrd memory: 29220K871test # [ 0.912935] Freeing unused decrypted memory: 2028K872second # [ 0.907662] Freeing initrd memory: 29216K873test # [ 0.915442] Freeing unused kernel image (initmem) memory: 3644K874test # [ 0.916742] Write protecting the kernel read-only data: 32768k875second # [ 0.910367] Freeing unused decrypted memory: 2028K876test # [ 0.918614] Freeing unused kernel image (text/rodata gap) memory: 1216K877second # [ 0.912790] Freeing unused kernel image (initmem) memory: 3644K878test # [ 0.920254] Freeing unused kernel image (rodata/data gap) memory: 756K879second # [ 0.914049] Write protecting the kernel read-only data: 32768k880second # [ 0.915931] Freeing unused kernel image (text/rodata gap) memory: 1216K881second # [ 0.917561] Freeing unused kernel image (rodata/data gap) memory: 756K882test # [ 0.952238] x86/mm: Checked W+X mappings: passed, no W+X pages found.883test # [ 0.953516] Run /init as init process884second # [ 0.949502] x86/mm: Checked W+X mappings: passed, no W+X pages found.885second # [ 0.950820] Run /init as init process886test # [ 0.961497] systemd[1]: Inserted module 'autofs4'887second # [ 0.958702] systemd[1]: Inserted module 'autofs4'888test # [ 0.974005] fuse: init (API version 7.45)889second # [ 0.970772] fuse: init (API version 7.45)890test # [ 0.978626] ACPI: \_SB_.GSIG: Enabled at IRQ 22891test # [ 0.981110] ACPI: \_SB_.GSIH: Enabled at IRQ 23892second # [ 0.975223] ACPI: \_SB_.GSIG: Enabled at IRQ 22893test # [ 0.984247] ACPI: \_SB_.GSIE: Enabled at IRQ 20894second # [ 0.977720] ACPI: \_SB_.GSIH: Enabled at IRQ 23895test # [ 0.986657] ACPI: \_SB_.GSIF: Enabled at IRQ 21896second # [ 0.980846] ACPI: \_SB_.GSIE: Enabled at IRQ 20897second # [ 0.983188] ACPI: \_SB_.GSIF: Enabled at IRQ 21898test # [ 1.009799] systemd[1]: Successfully made /usr/ read-only.899second # [ 1.006827] systemd[1]: Successfully made /usr/ read-only.900test # [ 1.345449] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)901test # [ 1.351289] systemd[1]: Detected virtualization kvm.902test # [ 1.352320] systemd[1]: Detected architecture x86-64.903test # [ 1.353349] systemd[1]: Running in initrd.904second # [ 1.342652] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)905test # [ 1.354382] systemd[1]: Initializing machine ID from random generator.906second # [ 1.348317] systemd[1]: Detected virtualization kvm.907test # [ 1.355755] systemd[1]: Hostname set to <test>.908second # [ 1.349410] systemd[1]: Detected architecture x86-64.909second # [ 1.350446] systemd[1]: Running in initrd.910second # [ 1.351568] systemd[1]: Initializing machine ID from random generator.911second # [ 1.352937] systemd[1]: Hostname set to <second>.912test # [ 1.522995] systemd[1]: bpf-restrict-fs: LSM BPF program attached913second # [ 1.523011] systemd[1]: bpf-restrict-fs: LSM BPF program attached914test # [ 1.551414] systemd[1]: Queued start job for default target Initrd Default Target.915test # [ 1.555661] systemd[1]: Created slice Slice /system/modprobe.916test # [ 1.557003] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.917second # [ 1.551285] systemd[1]: Queued start job for default target Initrd Default Target.918test # [ 1.558603] systemd[1]: Expecting device /dev/disk/by-label/nixos...919test # [ 1.559900] systemd[1]: Reached target Path Units.920test # [ 1.560940] systemd[1]: Reached target Slice Units.921test # [ 1.561985] systemd[1]: Reached target Swaps.922second # [ 1.555669] systemd[1]: Created slice Slice /system/modprobe.923test # [ 1.562938] systemd[1]: Reached target Timer Units.924second # [ 1.557008] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.925test # [ 1.564062] systemd[1]: Listening on D-Bus System Message Bus Socket.926second # [ 1.558647] systemd[1]: Expecting device /dev/disk/by-label/nixos...927test # [ 1.565459] systemd[1]: Listening on Journal Socket (/dev/log).928second # [ 1.559951] systemd[1]: Reached target Path Units.929test # [ 1.566826] systemd[1]: Listening on Journal Sockets.930second # [ 1.560992] systemd[1]: Reached target Slice Units.931test # [ 1.567982] systemd[1]: Listening on udev Control Socket.932second # [ 1.562040] systemd[1]: Reached target Swaps.933test # [ 1.569166] systemd[1]: Listening on udev Kernel Socket.934second # [ 1.562996] systemd[1]: Reached target Timer Units.935test # [ 1.570291] systemd[1]: Reached target Socket Units.936second # [ 1.564140] systemd[1]: Listening on D-Bus System Message Bus Socket.937second # [ 1.565538] systemd[1]: Listening on Journal Socket (/dev/log).938second # [ 1.566910] systemd[1]: Listening on Journal Sockets.939second # [ 1.568070] systemd[1]: Listening on udev Control Socket.940second # [ 1.569258] systemd[1]: Listening on udev Kernel Socket.941second # [ 1.570385] systemd[1]: Reached target Socket Units.942test # [ 1.571993] systemd[1]: Starting Create List of Static Device Nodes...943test # [ 1.583328] systemd[1]: Starting Load Kernel Module 9pnet_virtio...944second # [ 1.572101] systemd[1]: Starting Create List of Static Device Nodes...945second # [ 1.583377] systemd[1]: Starting Load Kernel Module 9pnet_virtio...946test # [ 1.592098] systemd[1]: Starting Load Kernel Module configfs...947second # [ 1.592768] systemd[1]: Starting Load Kernel Module configfs...948test # [ 1.601710] systemd[1]: Starting Journal Service...949second # [ 1.601776] systemd[1]: Starting Journal Service...950test # [ 1.609614] systemd[1]: Starting Load Kernel Modules...951second # [ 1.609670] systemd[1]: Starting Load Kernel Modules...952test # [ 1.616513] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os953test # [ 1.620043] netfs: FS-Cache loaded954second # [ 1.617689] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os955test # [ 1.625718] systemd[1]: Starting Coldplug All udev Devices...956second # [ 1.622671] netfs: FS-Cache loaded957second # [ 1.626706] systemd[1]: Starting Coldplug All udev Devices...958test # [ 1.637549] 9pnet: Installing 9P2000 support959test # [ 1.643654] systemd[1]: Finished Create List of Static Device Nodes.960second # [ 1.639679] 9pnet: Installing 9P2000 support961second # [ 1.641516] systemd-journald[67]: Collecting audit messages is disabled.962test # [ 1.650144] systemd[1]: modprobe@configfs.service: Deactivated successfully.963second # [ 1.646967] systemd[1]: Finished Create List of Static Device Nodes.964test # [ 1.653774] systemd-journald[67]: Collecting audit messages is disabled.965test # [ 1.660604] systemd[1]: Finished Load Kernel Module configfs.966second # [ 1.655214] systemd[1]: modprobe@configfs.service: Deactivated successfully.967test # [ 1.664793] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.968test # [ 1.667613] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.969second # [ 1.661283] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.970second # [ 1.666048] systemd[1]: Finished Load Kernel Module configfs.971test # [ 1.673983] systemd[1]: Finished Load Kernel Module 9pnet_virtio.972test # [ 1.675205] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev973second # [ 1.669993] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.974test # [ 1.680076] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config975second # [ 1.675725] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev976second # [ 1.677996] systemd[1]: Finished Load Kernel Module 9pnet_virtio.977second # [ 1.683150] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config978test # [ 1.693229] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...979second # [ 1.695252] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...980test # [ 1.706863] systemd[1]: Finished Load Kernel Modules.981second # [ 1.708725] systemd[1]: Finished Load Kernel Modules.982test # [ 1.715702] systemd[1]: Starting Apply Kernel Variables...983second # [ 1.717791] systemd[1]: Starting Apply Kernel Variables...984test # [ 1.726946] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.985second # [ 1.728759] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.986test # [ 1.738681] systemd[1]: Starting Create Static Device Nodes in /dev...987second # [ 1.738765] systemd[1]: Starting Create Static Device Nodes in /dev...988test # [ 1.749662] systemd[1]: Finished Apply Kernel Variables.989second # [ 1.750719] systemd[1]: Finished Apply Kernel Variables.990test # [ 1.760154] systemd[1]: Finished Create Static Device Nodes in /dev.991test # [ 1.765793] systemd[1]: Reached target Preparation for Local File Systems.992test # [ 1.769619] systemd[1]: Reached target Local File Systems.993second # [ 1.763213] systemd[1]: Finished Create Static Device Nodes in /dev.994second # [ 1.767886] systemd[1]: Reached target Preparation for Local File Systems.995test # [ 1.775703] systemd[1]: Starting Rule-based Manager for Device Events and Files...996second # [ 1.772724] systemd[1]: Reached target Local File Systems.997second # [ 1.778805] systemd[1]: Starting Rule-based Manager for Device Events and Files...998test # [ 1.786760] systemd[1]: Started Journal Service.999test # [ 1.617249] systemd-modules-load[68]: Inserted module 'dm_mod'1000test # [ 1.618827] systemd-modules-load[68]: Inserted module 'virtio_balloon'1001second # [ 1.612234] systemd-modules-load[68]: Inserted module 'dm_mod'1002second # [ 1.614338] systemd-modules-load[68]: Inserted module 'virtio_balloon'1003test # [ 1.621333] systemd-modules-load[68]: Inserted module 'virtio_gpu'1004second # [ 1.616334] systemd-modules-load[68]: Inserted module 'virtio_gpu'1005second # [ 1.793055] systemd[1]: Started Journal Service.1006test # [ 1.638294] systemd[1]: Starting Create System Files and Directories...1007second # [ 1.640083] systemd[1]: Starting Create System Files and Directories...1008test # [ 1.660879] systemd[1]: Finished Create System Files and Directories.1009test # [ 1.662884] systemd-udevd[75]: Using default interface naming scheme 'v261'.1010second # [ 1.662695] systemd-udevd[75]: Using default interface naming scheme 'v261'.1011second # [ 1.663991] systemd[1]: Finished Create System Files and Directories.1012test # [ 1.686143] systemd[1]: Started Rule-based Manager for Device Events and Files.1013second # [ 1.685381] systemd[1]: Started Rule-based Manager for Device Events and Files.1014test # [ 1.696527] systemd[1]: Finished Coldplug All udev Devices.1015test # [ 1.697553] systemd[1]: Reached target System Initialization.1016test # [ 1.698618] systemd[1]: Reached target Basic System.1017second # [ 1.698096] systemd[1]: Finished Coldplug All udev Devices.1018second # [ 1.699130] systemd[1]: Reached target System Initialization.1019second # [ 1.700152] systemd[1]: Reached target Basic System.1020test # [ 2.058049] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121021second # [ 2.054231] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022test # [ 2.065410] virtio_blk virtio5: 1/0/0 default/read/poll queues1023second # [ 2.062146] virtio_blk virtio5: 1/0/0 default/read/poll queues1024test # [ 2.082060] serio: i8042 KBD port at 0x60,0x64 irq 11025test # [ 2.082866] serio: i8042 AUX port at 0x60,0x64 irq 121026second # [ 2.078138] serio: i8042 KBD port at 0x60,0x64 irq 11027test # [ 2.085863] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1028second # [ 2.085346] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1029test # [ 2.094793] ehci-pci 0000:00:1d.7: EHCI Host Controller1030test # [ 2.095621] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11031second # [ 2.089622] serio: i8042 AUX port at 0x60,0x64 irq 121032test # [ 2.098781] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001033second # [ 2.092723] ehci-pci 0000:00:1d.7: EHCI Host Controller1034second # [ 2.093539] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11035second # [ 2.095356] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001036test # [ 2.106277] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001037test # [ 2.107814] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181038test # [ 2.109059] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11039second # [ 2.103642] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001040second # [ 2.104842] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181041test # [ 2.112763] usb usb1: Product: EHCI Host Controller1042second # [ 2.106074] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11043test # [ 2.113513] usb usb1: Manufacturer: Linux 6.18.45 ehci_hcd1044second # [ 2.109305] usb usb1: Product: EHCI Host Controller1045test # [ 2.116288] SCSI subsystem initialized1046test # [ 2.116936] usb usb1: SerialNumber: 0000:00:1d.71047second # [ 2.111007] usb usb1: Manufacturer: Linux 6.18.45 ehci_hcd1048test # [ 2.117941] hub 1-0:1.0: USB hub found1049test # [ 2.119336] hub 1-0:1.0: 6 ports detected1050second # [ 2.112969] usb usb1: SerialNumber: 0000:00:1d.71051test # [ 2.120674] uhci_hcd 0000:00:1d.0: UHCI Host Controller1052second # [ 2.114727] hub 1-0:1.0: USB hub found1053test # [ 2.121481] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21054second # [ 2.116361] hub 1-0:1.0: 6 ports detected1055second # [ 2.120158] uhci_hcd 0000:00:1d.0: UHCI Host Controller1056second # [ 2.120986] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21057test # [ 2.130581] uhci_hcd 0000:00:1d.0: detected 2 ports1058test # [ 2.131425] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001059second # [ 2.133058] SCSI subsystem initialized1060second # [ 2.135169] uhci_hcd 0000:00:1d.0: detected 2 ports1061test # [ 2.142588] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181062test # [ 2.143826] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11063second # [ 2.140443] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001064second # [ 2.143751] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181065second # [ 2.144997] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11066test # [ 2.159025] usb usb2: Product: UHCI Host Controller1067test # [ 2.166214] usb usb2: Manufacturer: Linux 6.18.45 uhci_hcd1068second # [ 2.161798] usb usb2: Product: UHCI Host Controller1069second # [ 2.162560] usb usb2: Manufacturer: Linux 6.18.45 uhci_hcd1070test # [ 2.173446] usb usb2: SerialNumber: 0000:00:1d.01071test # [ 2.176638] hub 2-0:1.0: USB hub found1072second # [ 2.000600] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1073test # [ 2.008174] systemd[1]: Starting Virtual Console Setup...1074second # [ 2.002873] systemd[1]: Starting Virtual Console Setup...1075second # [ 2.176619] usb usb2: SerialNumber: 0000:00:1d.01076test # [ 2.185548] hub 2-0:1.0: 2 ports detected1077second # [ 2.182971] hub 2-0:1.0: USB hub found1078test # [ 2.018644] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1079second # [ 2.017220] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1080second # [ 2.190091] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01081test # [ 2.027361] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1082test # [ 2.205247] uhci_hcd 0000:00:1d.1: UHCI Host Controller1083second # [ 2.199633] hub 2-0:1.0: 2 ports detected1084test # [ 2.206076] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31085second # [ 2.035917] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1086second # [ 2.041083] systemd[1]: Finished Virtual Console Setup.1087test # [ 2.053233] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1088test # [ 2.056637] systemd[1]: Finished Virtual Console Setup.1089second # [ 2.223671] uhci_hcd 0000:00:1d.1: UHCI Host Controller1090test # [ 2.230159] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01091second # [ 2.224526] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31092test # [ 2.236699] uhci_hcd 0000:00:1d.1: detected 2 ports1093second # [ 2.233385] uhci_hcd 0000:00:1d.1: detected 2 ports1094second # [ 2.234531] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201095test # [ 2.242593] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201096second # [ 2.237835] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181097second # [ 2.239078] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11098second # [ 2.071166] systemd[1]: Found device /dev/disk/by-label/nixos.1099second # [ 2.072303] systemd[1]: Reached target Initrd Root Device.1100test # [ 2.250377] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1101test # [ 2.082105] systemd[1]: Found device /dev/disk/by-label/nixos.1102second # [ 2.076067] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1103test # [ 2.083141] systemd[1]: Reached target Initrd Root Device.1104test # [ 2.085069] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1105second # [ 2.250210] usb usb3: Product: UHCI Host Controller1106test # [ 2.257646] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181107test # [ 2.258890] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11108test # [ 2.261065] usb usb3: Product: UHCI Host Controller1109test # [ 2.261951] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1110second # [ 2.257619] usb usb3: Manufacturer: Linux 6.18.45 uhci_hcd1111second # [ 2.258447] usb usb3: SerialNumber: 0000:00:1d.11112test # [ 2.265554] usb usb3: Manufacturer: Linux 6.18.45 uhci_hcd1113test # [ 2.266374] usb usb3: SerialNumber: 0000:00:1d.11114test # [ 2.268551] ahci 0000:00:1f.2: flags: 64bit ncq only1115second # [ 2.263966] hub 3-0:1.0: USB hub found1116test # [ 2.271436] hub 3-0:1.0: USB hub found1117test # [ 2.272447] hub 3-0:1.0: 2 ports detected1118second # [ 2.268688] hub 3-0:1.0: 2 ports detected1119second # [ 2.100495] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1120test # [ 2.109563] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1121second # [ 2.104606] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1122second # [ 2.276726] uhci_hcd 0000:00:1d.2: UHCI Host Controller1123second # [ 2.277523] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41124test # [ 2.114776] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1125test # [ 2.286629] scsi host0: ahci1126second # [ 2.279786] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1127test # [ 2.287862] uhci_hcd 0000:00:1d.2: UHCI Host Controller1128second # [ 2.281118] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1129test # [ 2.288694] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41130second # [ 2.282565] uhci_hcd 0000:00:1d.2: detected 2 ports1131test # [ 2.290472] scsi host1: ahci1132second # [ 2.283817] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401133second # [ 2.284930] ahci 0000:00:1f.2: flags: 64bit ncq only1134test # [ 2.292340] scsi host2: ahci1135second # [ 2.286499] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181136test # [ 2.293898] scsi host3: ahci1137test # [ 2.295994] scsi host4: ahci1138test # [ 2.297441] uhci_hcd 0000:00:1d.2: detected 2 ports1139second # [ 2.291579] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11140test # [ 2.298818] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401141second # [ 2.293306] scsi host0: ahci1142test # [ 2.302180] scsi host5: ahci1143second # [ 2.296428] scsi host1: ahci1144second # [ 2.297340] usb usb4: Product: UHCI Host Controller1145test # [ 2.303664] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11146second # [ 2.298655] scsi host2: ahci1147test # [ 2.305810] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181148second # [ 2.300893] usb usb4: Manufacturer: Linux 6.18.45 uhci_hcd1149test # [ 2.308064] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11150second # [ 2.302284] scsi host3: ahci1151test # [ 2.309656] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11152second # [ 2.304304] scsi host4: ahci1153test # [ 2.310999] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11154second # [ 2.305660] usb usb4: SerialNumber: 0000:00:1d.21155test # [ 2.312352] usb usb4: Product: UHCI Host Controller1156test # [ 2.313310] usb usb4: Manufacturer: Linux 6.18.45 uhci_hcd1157second # [ 2.307510] scsi host5: ahci1158test # [ 2.314309] usb usb4: SerialNumber: 0000:00:1d.21159second # [ 2.308183] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11160test # [ 2.315737] hub 4-0:1.0: USB hub found1161test # [ 2.316873] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11162test # [ 2.318265] hub 4-0:1.0: 2 ports detected1163second # [ 2.312625] hub 4-0:1.0: USB hub found1164second # [ 2.313363] hub 4-0:1.0: 2 ports detected1165second # [ 2.314467] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11166second # [ 2.320689] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11167test # [ 2.329830] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11168test # [ 2.336241] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11169second # [ 2.329789] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11170second # [ 2.334715] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11171second # [ 2.339105] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11172test # [ 2.355613] usb 1-1: new high-speed USB device number 2 using ehci-pci1173second # [ 2.355671] usb 1-1: new high-speed USB device number 2 using ehci-pci1174test # [ 2.485390] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001175test # [ 2.486635] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101176test # [ 2.487940] usb 1-1: Product: QEMU USB Tablet1177test # [ 2.488745] usb 1-1: Manufacturer: QEMU1178test # [ 2.489369] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11179second # [ 2.485440] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001180second # [ 2.486698] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101181second # [ 2.488036] usb 1-1: Product: QEMU USB Tablet1182second # [ 2.488853] usb 1-1: Manufacturer: QEMU1183second # [ 2.489481] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11184test # [ 2.498506] hid: raw HID events driver (C) Jiri Kosina1185second # [ 2.498702] hid: raw HID events driver (C) Jiri Kosina1186test # [ 2.466197] systemd[1]: Mounting /sysroot...1187second # [ 2.468796] systemd[1]: Mounting /sysroot...1188test # [ 2.650764] ata5: SATA link down (SStatus 0 SControl 300)1189test # [ 2.651781] ata6: SATA link down (SStatus 0 SControl 300)1190test # [ 2.652964] ata2: SATA link down (SStatus 0 SControl 300)1191test # [ 2.654057] ata4: SATA link down (SStatus 0 SControl 300)1192test # [ 2.655157] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1193test # [ 2.656255] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001194test # [ 2.657206] ata3.00: applying bridge limits1195second # [ 2.650722] ata5: SATA link down (SStatus 0 SControl 300)1196test # [ 2.658110] ata1: SATA link down (SStatus 0 SControl 300)1197test # [ 2.659153] ata3.00: configured for UDMA/1001198second # [ 2.653936] ata1: SATA link down (SStatus 0 SControl 300)1199test # [ 2.660235] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51200second # [ 2.654950] ata6: SATA link down (SStatus 0 SControl 300)1201second # [ 2.656141] ata2: SATA link down (SStatus 0 SControl 300)1202second # [ 2.657233] ata4: SATA link down (SStatus 0 SControl 300)1203second # [ 2.658322] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1204second # [ 2.659412] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001205second # [ 2.660345] ata3.00: applying bridge limits1206second # [ 2.661187] ata3.00: configured for UDMA/1001207second # [ 2.662273] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51208test # [ 2.704721] usbcore: registered new interface driver usbhid1209test # [ 2.705624] usbhid: USB HID core driver1210second # [ 2.706784] usbcore: registered new interface driver usbhid1211second # [ 2.707668] usbhid: USB HID core driver1212test # [ 2.718223] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21213test # [ 2.722497] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01214second # [ 2.721293] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21215test # [ 2.730764] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1216test # [ 2.732164] EXT4-fs (vda): mounted filesystem 2cde335c-55ee-4e64-a4da-2803be9b9f13 r/w with ordered data mode. Quota mode: none.1217second # [ 2.725823] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01218test # [ 2.565760] systemd[1]: Mounted /sysroot.1219test # [ 2.567982] systemd[1]: Reached target Initrd Root File System.1220second # [ 2.732895] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1221test # [ 2.570936] systemd[1]: Starting Mountpoints Configured in the Real Root...1222second # [ 2.735221] EXT4-fs (vda): mounted filesystem b311eada-82a4-4c0f-87e9-874e5cc44eaf r/w with ordered data mode. Quota mode: none.1223test # [ 2.742954] cdrom: Uniform CD-ROM driver Revision: 3.201224second # [ 2.570339] systemd[1]: Mounted /sysroot.1225second # [ 2.571221] systemd[1]: Reached target Initrd Root File System.1226second # [ 2.576066] systemd[1]: Starting Mountpoints Configured in the Real Root...1227second # [ 2.749716] cdrom: Uniform CD-ROM driver Revision: 3.201228test # [ 2.585491] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload.1229test # [ 2.589097] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)...1230test # [ 2.591798] systemd[1]: Reloading...1231second # [ 2.589868] systemd-sysroot-fstab-check[140]: /sysroot should be mounted in the initrd, will request daemon-reload.1232second # [ 2.593180] systemd[1]: Reload requested from client PID 140 ('systemd-sysroot') (unit initrd-parse-etc.service)...1233second # [ 2.596154] systemd[1]: Reloading...1234test # [ 2.649894] systemd[1]: Reloading finished in 58 ms.1235test # [ 2.659261] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace...1236second # [ 2.653461] systemd[1]: Reloading finished in 57 ms.1237test # [ 2.663137] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace...1238test # [ 2.667919] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1239second # [ 2.662290] systemd-sysroot-fstab-check[140]: Requesting initrd-fs.target/start/replace...1240test # [ 2.669830] systemd[1]: Finished Mountpoints Configured in the Real Root.1241test # [ 2.671144] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1242second # [ 2.666209] systemd-sysroot-fstab-check[140]: Requesting swap.target/start/replace...1243test # [ 2.674845] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1244second # [ 2.670552] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1245second # [ 2.674062] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1246second # [ 2.675646] systemd[1]: Finished Mountpoints Configured in the Real Root.1247second # [ 2.677204] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1248test # [ 3.466897] systemd[1]: Mounting /sysroot/nix/.ro-store...1249test # [ 3.470135] systemd[1]: Mounting /sysroot/nix/.rw-store...1250test # [ 3.472140] systemd[1]: Mounting /sysroot/run...1251second # [ 3.469079] systemd[1]: Mounting /sysroot/nix/.ro-store...1252second # [ 3.472080] systemd[1]: Mounting /sysroot/nix/.rw-store...1253test # [ 3.478768] systemd[1]: Mounting /sysroot/tmp/shared...1254second # [ 3.476160] systemd[1]: Mounting /sysroot/run...1255test # [ 3.485143] systemd[1]: Mounting /sysroot/tmp/xchg...1256second # [ 3.479059] systemd[1]: Mounting /sysroot/tmp/shared...1257second # [ 3.485155] systemd[1]: Mounting /sysroot/tmp/xchg...1258test # [ 3.667421] 9p: Installing v9fs 9p2000 file system support1259test # [ 3.506961] systemd[1]: Mounted /sysroot/nix/.ro-store.1260test # [ 3.509328] systemd[1]: Mounted /sysroot/nix/.rw-store.1261test # [ 3.510556] systemd[1]: Mounted /sysroot/run.1262second # [ 3.504910] systemd[1]: Mounted /sysroot/nix/.rw-store.1263second # [ 3.679220] 9p: Installing v9fs 9p2000 file system support1264test # [ 3.515375] systemd[1]: Mounted /sysroot/tmp/shared.1265test # [ 3.517194] systemd[1]: Mounted /sysroot/tmp/xchg.1266second # [ 3.511136] systemd[1]: Mounted /sysroot/run.1267test # [ 3.519813] systemd[1]: Starting rw-sysroot-nix-store.service...1268second # [ 3.518674] systemd[1]: Starting rw-sysroot-nix-store.service...1269second # [ 3.520989] systemd[1]: Mounted /sysroot/nix/.ro-store.1270test # [ 3.529233] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1271second # [ 3.523261] systemd[1]: Mounted /sysroot/tmp/shared.1272test # [ 3.531164] systemd[1]: Finished rw-sysroot-nix-store.service.1273second # [ 3.524802] systemd[1]: Mounted /sysroot/tmp/xchg.1274second # [ 3.532628] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1275second # [ 3.535119] systemd[1]: Finished rw-sysroot-nix-store.service.1276second # [ 3.536508] systemd[1]: Mounting /sysroot/nix/store...1277second # [ 3.551807] systemd[1]: Mounted /sysroot/nix/store.1278second # [ 3.553151] systemd[1]: Reached target Initrd File Systems.1279second # [ 3.554778] systemd[1]: Starting Find NixOS closure...1280second # [ 3.557380] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1281second # [ 3.571962] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1282second # [ 3.578798] systemd[1]: Finished Find NixOS closure.1283second # [ 3.580436] systemd[1]: Reached target Initrd Default Target.1284second # [ 3.582294] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1285second # [ 3.593675] systemd[1]: Stopped target Initrd Default Target.1286second # [ 3.595058] systemd[1]: Stopped target Basic System.1287second # [ 3.596176] systemd[1]: Stopped target Initrd Root Device.1288second # [ 3.598068] systemd[1]: Stopped target Path Units.1289second # [ 3.599058] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1290second # [ 3.600512] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1291second # [ 3.601912] systemd[1]: Stopped target Slice Units.1292second # [ 3.603339] systemd[1]: Stopped target Socket Units.1293second # [ 3.604766] systemd[1]: Stopped target System Initialization.1294second # [ 3.606224] systemd[1]: Stopped target Swaps.1295second # [ 3.607262] systemd[1]: Stopped target Timer Units.1296second # [ 3.608946] systemd[1]: dbus.socket: Deactivated successfully.1297second # [ 3.610173] systemd[1]: Closed D-Bus System Message Bus Socket.1298second # [ 3.611314] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1299second # [ 3.614090] systemd[1]: Stopped Find NixOS closure.1300second # [ 3.615090] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1301second # [ 3.617055] systemd[1]: Starting rw-sysroot-nix-store.service...1302second # [ 3.618189] systemd[1]: systemd-sysctl.service: Deactivated successfully.1303second # [ 3.619548] systemd[1]: Stopped Apply Kernel Variables.1304second # [ 3.621164] systemd[1]: systemd-modules-load.service: Deactivated successfully.1305second # [ 3.622579] systemd[1]: Stopped Load Kernel Modules.1306second # [ 3.623597] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1307second # [ 3.625482] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1308second # [ 3.627214] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1309second # [ 3.629147] systemd[1]: Stopped Create System Files and Directories.1310second # [ 3.630323] systemd[1]: Stopped target Local File Systems.1311second # [ 3.631402] systemd[1]: Stopped target Preparation for Local File Systems.1312second # [ 3.633217] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1313second # [ 3.634953] systemd[1]: Stopped Coldplug All udev Devices.1314second # [ 3.637647] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1315second # [ 3.640118] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1316second # [ 3.641457] systemd[1]: Stopped Virtual Console Setup.1317second # [ 3.648741] systemd[1]: initrd-cleanup.service: Deactivated successfully.1318second # [ 3.651206] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1319second # [ 3.653429] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1320second # [ 3.655512] systemd[1]: Finished rw-sysroot-nix-store.service.1321second # [ 3.657207] systemd[1]: systemd-udevd.service: Deactivated successfully.1322second # [ 3.658996] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1323second # [ 3.663112] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1324second # [ 3.664474] systemd[1]: Closed udev Control Socket.1325second # [ 3.665713] systemd[1]: Starting Cleanup udev Database...1326second # [ 3.667088] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1327second # [ 3.668488] systemd[1]: Stopped Create Static Device Nodes in /dev.1328second # [ 3.670162] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1329second # [ 3.671611] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1330second # [ 3.673170] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1331second # [ 3.675156] systemd[1]: Stopped Create List of Static Device Nodes.1332second # [ 3.684876] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1333second # [ 3.687270] systemd[1]: Finished Cleanup udev Database.1334second # [ 3.688606] systemd[1]: Reached target Switch Root.1335second # [ 3.690345] systemd[1]: Starting NixOS Activation...1336second # [ 3.771688] initrd-nixos-activation-start[194]: booting system configuration /nix/store/bxssfc18jb6if0y0sb0fvgiaklzmk3np-nixos-system-second-test1337second # [ 3.803920] initrd-nixos-activation-start[194]: running activation script...1338second # [ 4.007410] initrd-nixos-activation-start[217]: setting up /etc...1339second # [ 4.123553] initrd-nixos-activation-start[217]: setting up age secrets...1340second # [ 4.226176] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1341second # [ 4.228091] systemd[1]: Finished NixOS Activation.1342second # [ 4.229769] systemd[1]: Starting Switch Root...1343second # [ 4.239743] systemd[1]: Switching root.1344second # [ 4.535098] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1345second # [ 4.603401] NET: Registered PF_VSOCK protocol family1346test # [ 4.467035] systemd[1]: Mounting /sysroot/nix/store...1347test # [ 4.483577] systemd[1]: Mounted /sysroot/nix/store.1348test # [ 4.484943] systemd[1]: Reached target Initrd File Systems.1349test # [ 4.487073] systemd[1]: Starting Find NixOS closure...1350test # [ 4.489376] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1351test # [ 4.504138] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1352test # [ 4.506976] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1353test # [ 4.512854] systemd[1]: Finished Find NixOS closure.1354test # [ 4.514584] systemd[1]: Reached target Initrd Default Target.1355test # [ 4.515780] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1356test # [ 4.525957] systemd[1]: Stopped target Initrd Default Target.1357test # [ 4.527477] systemd[1]: Stopped target Basic System.1358test # [ 4.528608] systemd[1]: Stopped target Initrd Root Device.1359test # [ 4.529810] systemd[1]: Stopped target Path Units.1360test # [ 4.531133] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1361test # [ 4.532431] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1362test # [ 4.533933] systemd[1]: Stopped target Slice Units.1363test # [ 4.535197] systemd[1]: Stopped target Socket Units.1364test # [ 4.536363] systemd[1]: Stopped target System Initialization.1365test # [ 4.538155] systemd[1]: Stopped target Swaps.1366test # [ 4.538961] systemd[1]: Stopped target Timer Units.1367test # [ 4.539931] systemd[1]: dbus.socket: Deactivated successfully.1368test # [ 4.541139] systemd[1]: Closed D-Bus System Message Bus Socket.1369test # [ 4.542268] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1370test # [ 4.543864] systemd[1]: Stopped Find NixOS closure.1371test # [ 4.545145] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1372test # [ 4.546892] systemd[1]: Starting rw-sysroot-nix-store.service...1373test # [ 4.548350] systemd[1]: systemd-sysctl.service: Deactivated successfully.1374test # [ 4.549642] systemd[1]: Stopped Apply Kernel Variables.1375test # [ 4.551151] systemd[1]: systemd-modules-load.service: Deactivated successfully.1376test # [ 4.552352] systemd[1]: Stopped Load Kernel Modules.1377test # [ 4.553447] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1378test # [ 4.554955] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1379test # [ 4.556939] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1380test # [ 4.558574] systemd[1]: Stopped Create System Files and Directories.1381test # [ 4.560148] systemd[1]: Stopped target Local File Systems.1382test # [ 4.561132] systemd[1]: Stopped target Preparation for Local File Systems.1383test # [ 4.563202] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1384test # [ 4.564389] systemd[1]: Stopped Coldplug All udev Devices.1385test # [ 4.565326] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1386test # [ 4.566557] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1387test # [ 4.569714] systemd[1]: Stopped Virtual Console Setup.1388test # [ 4.574397] systemd[1]: initrd-cleanup.service: Deactivated successfully.1389test # [ 4.577243] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1390test # [ 4.580503] systemd[1]: systemd-udevd.service: Deactivated successfully.1391test # [ 4.582200] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1392test # [ 4.584283] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1393test # [ 4.585532] systemd[1]: Finished rw-sysroot-nix-store.service.1394test # [ 4.589102] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1395test # [ 4.590325] systemd[1]: Closed udev Control Socket.1396test # [ 4.591390] systemd[1]: Starting Cleanup udev Database...1397test # [ 4.592397] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1398test # [ 4.594207] systemd[1]: Stopped Create Static Device Nodes in /dev.1399test # [ 4.595363] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1400test # [ 4.597174] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1401test # [ 4.598360] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1402test # [ 4.600133] systemd[1]: Stopped Create List of Static Device Nodes.1403test # [ 4.610655] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1404test # [ 4.612178] systemd[1]: Finished Cleanup udev Database.1405test # [ 4.614100] systemd[1]: Reached target Switch Root.1406test # [ 4.615259] systemd[1]: Starting NixOS Activation...1407test # [ 4.691370] initrd-nixos-activation-start[194]: booting system configuration /nix/store/g64n1mz2pkrifyixrpwdhipg01gjpg44-nixos-system-test-test1408test # [ 4.721076] initrd-nixos-activation-start[194]: running activation script...1409second # [ 4.962032] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1410second # [ 4.966251] systemd[1]: Detected virtualization kvm.1411second # [ 4.967064] systemd[1]: Detected architecture x86-64.1412second # [ 4.967926] systemd[1]: Detected first boot.1413second # [ 4.969859] systemd[1]: Initializing machine ID from random generator.1414second # [ 5.046936] systemd[1]: bpf-restrict-fs: LSM BPF program attached1415test # [ 4.921289] initrd-nixos-activation-start[217]: setting up /etc...1416second # [ 5.119085] systemd[1]: Applying preset policy.1417test # [ 5.029934] initrd-nixos-activation-start[217]: setting up age secrets...1418test # [ 5.158434] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1419test # [ 5.160213] systemd[1]: Finished NixOS Activation.1420test # [ 5.162155] systemd[1]: Starting Switch Root...1421test # [ 5.173294] systemd[1]: Switching root.1422second # [ 5.383080] systemd[1]: Populated /etc with preset unit settings.1423test # [ 5.471311] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1424test # [ 5.535903] NET: Registered PF_VSOCK protocol family1425second # [ 5.632568] systemd[1]: initrd-switch-root.service: Deactivated successfully.1426second # [ 5.634158] systemd[1]: Stopped initrd-switch-root.service.1427second # [ 5.636461] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1428second # [ 5.638488] systemd[1]: Created slice Slice /system/getty.1429second # [ 5.639865] systemd[1]: Created slice User and Session Slice.1430second # [ 5.640890] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1431second # [ 5.642191] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1432second # [ 5.643386] systemd[1]: Expecting device /dev/hvc0...1433second # [ 5.651854] systemd[1]: Expecting device /dev/ttyS0...1434second # [ 5.652729] systemd[1]: Reached target Local Encrypted Volumes.1435second # [ 5.653672] systemd[1]: Stopped target initrd-fs.target.1436second # [ 5.654498] systemd[1]: Stopped target initrd-root-fs.target.1437second # [ 5.655422] systemd[1]: Stopped target initrd-switch-root.target.1438second # [ 5.656398] systemd[1]: Reached target Virtual Machines and Containers.1439second # [ 5.657438] systemd[1]: Reached target Path Units.1440second # [ 5.658256] systemd[1]: Reached target Remote File Systems.1441second # [ 5.659167] systemd[1]: Reached target Slice Units.1442second # [ 5.659994] systemd[1]: Reached target Swaps.1443second # [ 5.662072] systemd[1]: Listening on Query the User Interactively for a Password.1444second # [ 5.664657] systemd[1]: Listening on Process Core Dump Socket.1445second # [ 5.666670] systemd[1]: Listening on Credential Encryption/Decryption.1446second # [ 5.668720] systemd[1]: Listening on Factory Reset Management.1447second # [ 5.669750] systemd[1]: Listening on Hostname Service Socket.1448second # [ 5.672325] systemd[1]: Starting Journal Log Access Socket...1449second # [ 5.673752] systemd[1]: Listening on Journal Audit Socket.1450second # [ 5.675988] systemd[1]: Listening on Console Output Muting Service Socket.1451second # [ 5.677197] systemd[1]: Listening on Network Management Metrics Varlink Socket.1452second # [ 5.678515] systemd[1]: Listening on Network Management Varlink Socket.1453second # [ 5.679694] systemd[1]: Listening on Network Management Netlink Socket.1454second # [ 5.680848] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1455second # [ 5.682208] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1456second # [ 5.683649] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1457second # [ 5.688625] systemd[1]: Listening on Disk Repartitioning Service Socket.1458second # [ 5.689765] systemd[1]: Listening on Resolve Monitor Varlink Socket.1459second # [ 5.690855] systemd[1]: Listening on Resolve Service Varlink Socket.1460second # [ 5.691941] systemd[1]: Listening on udev Control Socket.1461second # [ 5.692913] systemd[1]: Listening on udev Varlink Socket.1462second # [ 5.695211] systemd[1]: Mounting Huge Pages File System...1463second # [ 5.699056] systemd[1]: Mounting POSIX Message Queue File System...1464second # [ 5.702785] systemd[1]: Mounting Kernel Debug File System...1465second # [ 5.707834] systemd[1]: Mounting Kernel Trace File System...1466second # [ 5.713639] systemd[1]: Starting Create List of Static Device Nodes...1467second # [ 5.718759] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1468second # [ 5.733336] systemd[1]: Starting Load Kernel Module configfs...1469second # [ 5.734869] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1470second # [ 5.741545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1471second # [ 5.743775] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1472second # [ 5.746987] systemd[1]: Mounting FUSE Control File System...1473second # [ 5.747966] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671474second # [ 5.757126] systemd[1]: Starting Journal Service...1475second # [ 5.765155] systemd[1]: Starting Load Kernel Modules...1476second # [ 5.775373] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1477second # [ 5.785081] systemd[1]: Starting Remount Root and Kernel File Systems...1478second # [ 5.788715] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1479second # [ 5.803796] systemd-journald[320]: Collecting audit messages is enabled.1480second # [ 5.805296] systemd[1]: Starting Coldplug All udev Devices...1481second # [ 5.816734] loop: module loaded1482second # [ 5.825392] systemd[1]: Listening on Journal Log Access Socket.1483second # [ 5.831704] systemd[1]: Mounted Huge Pages File System.1484second # [ 5.835330] systemd[1]: Mounted POSIX Message Queue File System.1485second # [ 5.836337] EXT4-fs (vda): re-mounted b311eada-82a4-4c0f-87e9-874e5cc44eaf.1486second # [ 5.842166] systemd[1]: Mounted Kernel Debug File System.1487second # [ 5.673232] systemd[1]: Queued start job for default target Multi-User System.1488second # [ 5.674761] systemd[1]: systemd-journald.service: Deactivated successfully.1489second # [ 5.676322] systemd-modules-load[321]: Module 'ctr' is built in1490second # [ 5.679191] systemd-modules-load[321]: Inserted module 'loop'1491second # [ 5.851393] systemd[1]: Started Journal Service.1492second # [ 5.687613] systemd[1]: Mounted Kernel Trace File System.1493second # [ 5.691227] systemd[1]: Finished Create List of Static Device Nodes.1494second # [ 5.694139] systemd[1]: modprobe@configfs.service: Deactivated successfully.1495second # [ 5.696874] systemd[1]: Finished Load Kernel Module configfs.1496second # [ 5.697929] systemd[1]: Mounted FUSE Control File System.1497second # [ 5.702097] systemd[1]: Finished Load Kernel Modules.1498second # [ 5.702986] systemd[1]: Finished Remount Root and Kernel File Systems.1499second # [ 5.714309] systemd-oomd[323]: No swap; memory pressure usage will be degraded1500second # [ 5.716947] systemd[1]: Listening on Disk Image Download Service Socket.1501test # [ 5.892780] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1502test # [ 5.897163] systemd[1]: Detected virtualization kvm.1503test # [ 5.897970] systemd[1]: Detected architecture x86-64.1504test # [ 5.898906] systemd[1]: Detected first boot.1505second # [ 5.721764] systemd[1]: Mounting Kernel Configuration File System...1506test # [ 5.900873] systemd[1]: Initializing machine ID from random generator.1507second # [ 5.726943] systemd[1]: Starting Firewall...1508second # [ 5.734283] systemd[1]: Starting Flush Journal to Persistent Storage...1509second # [ 5.735569] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1510second # [ 5.746075] systemd[1]: Starting Load/Save OS Random Seed...1511second # [ 5.750092] systemd[1]: Starting Apply Kernel Variables...1512second # [ 5.769726] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1513second # [ 5.944921] systemd-journald[320]: Received client request to flush runtime journal.1514test # [ 6.083241] systemd[1]: bpf-restrict-fs: LSM BPF program attached1515second # [ 5.967434] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1516second # [ 5.970974] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1517test # [ 6.153698] systemd[1]: Applying preset policy.1518second # [ 5.975863] systemd[1]: Mounted Kernel Configuration File System.1519second # [ 5.980896] systemd[1]: Finished Load/Save OS Random Seed.1520second # [ 5.982867] systemd[1]: Reached target First Boot Complete.1521second # [ 5.985960] systemd[1]: Finished Apply Kernel Variables.1522second # [ 5.988512] systemd[1]: Starting Network Name Resolution...1523second # [ 5.991508] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1524second # [ 5.994441] systemd[1]: Starting Create Static Device Nodes in /dev...1525second # [ 5.996397] systemd[1]: Finished Create Static Device Nodes in /dev.1526second # [ 5.998846] systemd[1]: Reached target Preparation for Local File Systems.1527second # [ 6.001179] systemd[1]: Starting Rule-based Manager for Device Events and Files...1528second # [ 6.002481] systemd[1]: Finished Flush Journal to Persistent Storage.1529second # [ 6.005332] systemd-resolved[348]: Positive Trust Anchors:1530second # [ 6.008176] systemd-resolved[348]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1531second # [ 6.011226] systemd-resolved[348]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161532second # [ 6.013652] systemd-resolved[348]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1533second # [ 6.051727] systemd-udevd[357]: Using default interface naming scheme 'v261'.1534second # [ 6.102437] systemd[1]: Finished Coldplug All udev Devices.1535second # [ 6.109378] systemd-resolved[348]: Using system hostname 'second'.1536second # [ 6.116202] systemd[1]: Started Network Name Resolution.1537second # [ 6.158468] systemd[1]: Started Rule-based Manager for Device Events and Files.1538test # [ 6.414019] systemd[1]: Populated /etc with preset unit settings.1539second # [ 6.308041] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1540second # [ 6.394331] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1541second # [ 6.421274] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1542second # [ 6.435230] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line.1543second # [ 6.444737] (udev-worker)[411]: Network interface NamePolicy= disabled on kernel command line.1544second # [ 6.466479] systemd[1]: Mounting /run/wrappers...1545test # [ 6.661452] systemd[1]: initrd-switch-root.service: Deactivated successfully.1546test # [ 6.663072] systemd[1]: Stopped initrd-switch-root.service.1547test # [ 6.665459] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1548test # [ 6.667553] systemd[1]: Created slice Slice /system/getty.1549test # [ 6.668887] systemd[1]: Created slice User and Session Slice.1550test # [ 6.669902] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1551test # [ 6.671261] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1552second # [ 6.497089] systemd[1]: Mounted /run/wrappers.1553second # [ 6.497930] systemd[1]: Reached target Local File Systems.1554second # [ 6.501368] systemd[1]: Listening on Boot Loader Control Service Socket.1555test # [ 6.672453] systemd[1]: Expecting device /dev/hvc0...1556test # [ 6.680974] systemd[1]: Expecting device /dev/ttyS0...1557second # [ 6.504110] systemd[1]: Starting register-nix-paths.service...1558test # [ 6.681847] systemd[1]: Reached target Local Encrypted Volumes.1559test # [ 6.682804] systemd[1]: Stopped target initrd-fs.target.1560test # [ 6.683661] systemd[1]: Stopped target initrd-root-fs.target.1561test # [ 6.684582] systemd[1]: Stopped target initrd-switch-root.target.1562second # [ 6.507628] systemd[1]: Starting Create SUID/SGID Wrappers...1563test # [ 6.685560] systemd[1]: Reached target Virtual Machines and Containers.1564test # [ 6.686601] systemd[1]: Reached target Path Units.1565second # [ 6.508910] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1566test # [ 6.687390] systemd[1]: Reached target Remote File Systems.1567test # [ 6.688305] systemd[1]: Reached target Slice Units.1568test # [ 6.689140] systemd[1]: Reached target Swaps.1569test # [ 6.691251] systemd[1]: Listening on Query the User Interactively for a Password.1570second # [ 6.516559] systemd[1]: Starting Save Transient machine-id to Disk...1571test # [ 6.693851] systemd[1]: Listening on Process Core Dump Socket.1572test # [ 6.695848] systemd[1]: Listening on Credential Encryption/Decryption.1573test # [ 6.697862] systemd[1]: Listening on Factory Reset Management.1574test # [ 6.698897] systemd[1]: Listening on Hostname Service Socket.1575test # [ 6.701438] systemd[1]: Starting Journal Log Access Socket...1576test # [ 6.702921] systemd[1]: Listening on Journal Audit Socket.1577second # [ 6.527177] systemd[1]: Starting Create System Files and Directories...1578test # [ 6.705082] systemd[1]: Listening on Console Output Muting Service Socket.1579test # [ 6.706293] systemd[1]: Listening on Network Management Metrics Varlink Socket.1580test # [ 6.707662] systemd[1]: Listening on Network Management Varlink Socket.1581test # [ 6.708801] systemd[1]: Listening on Network Management Netlink Socket.1582test # [ 6.709973] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1583test # [ 6.711310] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1584test # [ 6.712777] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1585second # [ 6.539632] systemd[1]: Finished Firewall.1586test # [ 6.717831] systemd[1]: Listening on Disk Repartitioning Service Socket.1587test # [ 6.718980] systemd[1]: Listening on Resolve Monitor Varlink Socket.1588test # [ 6.720075] systemd[1]: Listening on Resolve Service Varlink Socket.1589second # [ 6.543283] systemd[1]: Reached target Preparation for Network.1590test # [ 6.721183] systemd[1]: Listening on udev Control Socket.1591test # [ 6.722177] systemd[1]: Listening on udev Varlink Socket.1592test # [ 6.724581] systemd[1]: Mounting Huge Pages File System...1593second # [ 6.549490] systemd[1]: Listening on Network Management Resolve Hook Socket.1594test # [ 6.727160] systemd[1]: Mounting POSIX Message Queue File System...1595test # [ 6.732316] systemd[1]: Mounting Kernel Debug File System...1596second # [ 6.556639] systemd[1]: Starting Network Management...1597test # [ 6.736792] systemd[1]: Mounting Kernel Trace File System...1598test # [ 6.741733] systemd[1]: Starting Create List of Static Device Nodes...1599test # [ 6.744893] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1600test # [ 6.754895] systemd[1]: Starting Load Kernel Module configfs...1601test # [ 6.765343] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1602test # [ 6.768844] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1603second # [ 6.593284] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1604test # [ 6.773114] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1605second # [ 6.603728] systemd[1]: Finished Save Transient machine-id to Disk.1606test # [ 6.783886] systemd[1]: Mounting FUSE Control File System...1607test # [ 6.785005] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671608test # [ 6.795436] systemd[1]: Starting Journal Service...1609test # [ 6.800799] systemd[1]: Starting Load Kernel Modules...1610test # [ 6.812922] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1611second # [ 6.636165] systemd[1]: Finished Create System Files and Directories.1612test # [ 6.822773] systemd[1]: Starting Remount Root and Kernel File Systems...1613second # [ 6.646619] systemd[1]: Starting Rebuild Journal Catalog...1614second # [ 6.650594] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1615test # [ 6.829747] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1616test # [ 6.833288] systemd-journald[342]: Collecting audit messages is enabled.1617test # [ 6.847009] systemd[1]: Starting Coldplug All udev Devices...1618test # [ 6.862653] loop: module loaded1619test # [ 6.870629] systemd[1]: Started Journal Service.1620test # [ 6.702355] systemd[1]: Queued start job for default target Multi-User System.1621test # [ 6.875576] EXT4-fs (vda): re-mounted 2cde335c-55ee-4e64-a4da-2803be9b9f13.1622test # [ 6.706491] systemd[1]: systemd-journald.service: Deactivated successfully.1623test # [ 6.711220] systemd-modules-load[343]: Module 'ctr' is built in1624test # [ 6.713403] systemd-modules-load[343]: Inserted module 'loop'1625test # [ 6.715408] systemd[1]: Listening on Journal Log Access Socket.1626test # [ 6.718402] systemd[1]: Mounted Huge Pages File System.1627test # [ 6.721686] systemd[1]: Mounted POSIX Message Queue File System.1628test # [ 6.724330] systemd[1]: Mounted Kernel Debug File System.1629test # [ 6.725965] systemd[1]: Mounted Kernel Trace File System.1630test # [ 6.729545] systemd[1]: Finished Create List of Static Device Nodes.1631second # [ 6.723116] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1632test # [ 6.731282] systemd[1]: modprobe@configfs.service: Deactivated successfully.1633test # [ 6.734223] systemd[1]: Finished Load Kernel Module configfs.1634test # [ 6.735896] systemd[1]: Mounted FUSE Control File System.1635test # [ 6.742199] systemd[1]: Finished Load Kernel Modules.1636test # [ 6.743123] systemd[1]: Finished Remount Root and Kernel File Systems.1637test # [ 6.754676] systemd[1]: Listening on Disk Image Download Service Socket.1638test # [ 6.761121] systemd-oomd[345]: No swap; memory pressure usage will be degraded1639test # [ 6.762729] systemd[1]: Mounting Kernel Configuration File System...1640test # [ 6.766243] systemd[1]: Starting Firewall...1641second # [ 6.760819] systemd[1]: Finished Rebuild Journal Catalog.1642test # [ 6.774127] systemd[1]: Starting Flush Journal to Persistent Storage...1643second # [ 6.770116] systemd[1]: Starting Update is Completed...1644test # [ 6.775979] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1645test # [ 6.786120] systemd[1]: Starting Load/Save OS Random Seed...1646test # [ 6.797949] systemd[1]: Starting Apply Kernel Variables...1647test # [ 6.815449] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1648test # [ 6.818059] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1649test # [ 6.821115] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1650second # [ 6.818600] systemd[1]: Finished Update is Completed.1651test # [ 7.006129] systemd-journald[342]: Received client request to flush runtime journal.1652second # [ 7.045541] cfg80211: Loading compiled-in X.509 certificates for regulatory database1653second # [ 7.065324] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31654second # [ 7.068353] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1655second # [ 7.069316] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1656second # [ 7.086520] mousedev: PS/2 mouse device common for all mice1657second # [ 6.938322] systemd-networkd[479]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1658second # [ 6.942649] systemd-networkd[479]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1659second # [ 7.116164] ACPI: button: Power Button [PWRF]1660second # [ 6.948432] systemd-networkd[479]: lo: Link UP1661second # [ 6.949731] systemd-networkd[479]: lo: Gained carrier1662second # [ 6.960630] systemd[1]: Started Network Management.1663second # [ 6.966951] systemd-networkd[479]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1664second # [ 6.970719] systemd-networkd[479]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1665second # [ 6.973935] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1666second # [ 6.979456] systemd-networkd[479]: eth1: Link UP1667second # [ 6.984582] systemd-networkd[479]: eth1: Gained carrier1668second # [ 6.985585] systemd-networkd[479]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1669second # [ 6.994565] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1670second # [ 6.998261] systemd[1]: Finished Create SUID/SGID Wrappers.1671second # [ 7.180379] NET: Registered PF_PACKET protocol family1672test # [ 7.018455] systemd[1]: Mounted Kernel Configuration File System.1673test # [ 7.021484] systemd[1]: Finished Load/Save OS Random Seed.1674test # [ 7.023224] systemd[1]: Reached target First Boot Complete.1675test # [ 7.026406] systemd[1]: Finished Apply Kernel Variables.1676test # [ 7.028279] systemd[1]: Starting Network Name Resolution...1677test # [ 7.031095] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1678test # [ 7.033225] systemd[1]: Starting Create Static Device Nodes in /dev...1679second # [ 7.028680] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1680test # [ 7.035624] systemd[1]: Finished Create Static Device Nodes in /dev.1681test # [ 7.038097] systemd[1]: Reached target Preparation for Local File Systems.1682test # [ 7.040739] systemd[1]: Starting Rule-based Manager for Device Events and Files...1683test # [ 7.043161] systemd[1]: Finished Flush Journal to Persistent Storage.1684test # [ 7.047971] systemd-resolved[372]: Positive Trust Anchors:1685test # [ 7.050403] systemd-resolved[372]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1686test # [ 7.053196] systemd-resolved[372]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161687test # [ 7.056548] systemd-resolved[372]: 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 test1688second # [ 7.235758] rtc_cmos 00:04: RTC can wake from S41689second # [ 7.273671] parport_pc 00:02: reported by Plug and Play ACPI1690second # [ 7.274971] rtc_cmos 00:04: registered as rtc01691second # [ 7.279877] rtc_cmos 00:04: setting system clock to 2026-08-25T11:33:25 UTC (1787657605)1692test # [ 7.116866] systemd-udevd[382]: Using default interface naming scheme 'v261'.1693second # [ 7.281294] systemd-journald[320]: Time jumped backwards, rotating.1694second # [ 7.287550] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1695second # [ 7.129548] systemd-resolved[348]: Clock change detected. Flushing caches.1696second # [ 7.132313] systemd[1]: Finished register-nix-paths.service.1697second # [ 7.140625] systemd[1]: Reached target System Initialization.1698second # [ 7.141778] systemd[1]: Started Discard unused filesystem blocks once a week.1699test # [ 7.152513] systemd[1]: Finished Coldplug All udev Devices.1700second # [ 7.143174] systemd[1]: Started Daily Cleanup of Temporary Directories.1701second # [ 7.148543] systemd[1]: Reached target Timer Units.1702second # [ 7.149476] systemd[1]: Listening on D-Bus System Message Bus Socket.1703second # [ 7.151906] systemd[1]: Listening on Nix Daemon Socket.1704test # [ 7.161849] systemd-resolved[372]: Using system hostname 'test'.1705second # [ 7.156661] systemd[1]: Listening on Authorization Manager Agent Helper.1706second # [ 7.157888] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1707second # [ 7.159272] systemd[1]: Reached target Socket Units.1708second # [ 7.160184] systemd[1]: Starting D-Bus System Message Bus...1709test # [ 7.168133] systemd[1]: Started Network Name Resolution.1710test # [ 7.217208] systemd[1]: Started Rule-based Manager for Device Events and Files.1711second # [ 7.213245] dbus-broker-launch[557]: Looking up NSS user entry for 'systemd-timesync'...1712second # [ 7.218166] dbus-broker-launch[557]: NSS returned no entry for 'systemd-timesync'1713second # [ 7.219480] dbus-broker-launch[557]: Invalid user-name in /nix/store/y5g83ihxjak0dp03i8x01s3lkza55svb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1714second # [ 7.296243] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1715second # [ 7.321144] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1716second # [ 7.333018] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41717second # [ 7.240178] dbus-broker-launch[557]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1718second # [ 7.243491] dbus-broker-launch[557]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1719second # [ 7.247240] dbus-broker-launch[557]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nasw2v3yzqxbcz7633zjygg42hdv0i2f-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1720second # [ 7.250925] dbus-broker-launch[557]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1721second # [ 7.255106] systemd[1]: Started D-Bus System Message Bus.1722second # [ 7.274459] dbus-broker-launch[557]: Ready1723second # [ 7.285126] systemd[1]: Reached target Basic System.1724second # [ 7.346082] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1725second # [ 7.398502] Console: switching to colour dummy device 80x251726second # [ 7.441159] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1727second # [ 7.290055] systemd[1]: Starting Network Manager Script Dispatcher Service...1728second # [ 7.291986] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1729second # [ 7.301557] systemd[1]: Starting Network Manager...1730second # [ 7.314043] systemd[1]: Started backdoor.service.1731second # [ 7.441257] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1732second # [ 7.477962] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61733second # [ 7.329819] systemd[1]: Starting Import lastlog data into lastlog2 database...1734second # [ 7.341573] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1735second # [ 7.363395] systemd[1]: Starting Post-Boot Actions...1736test # [ 7.375493] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1737second # [ 7.370435] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1738second # [ 7.378297] systemd[1]: Started Reset console on configuration changes.1739second # connecting to host...1740second # [ 7.414897] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1741second # [ 7.424701] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1742second # [ 7.478366] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51743second # [ 7.600019] [drm] Found bochs VGA, ID 0xb0c5.1744second # [ 7.600021] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1745test # [ 7.455968] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1746second # [ 7.460046] systemd[1]: Started Name Service Cache Daemon (nsncd).1747second # [ 7.462900] nsncd[566]: Aug 25 11:33:25.847 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1748second # [ 7.476322] systemd[1]: Finished Post-Boot Actions.1749test # [ 7.483170] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1750second # [ 7.486809] systemd[1]: Reached target Host and Network Name Lookups.1751second # [ 7.658909] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1752test # [ 7.495227] systemd[1]: Mounting /run/wrappers...1753second # [ 7.659727] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01754second # [ 7.491103] systemd[1]: Reached target User and Group Name Lookups.1755second # [ 7.501812] systemd[1]: Starting User Login Management...1756second # [ 7.507279] systemd[1]: Finished Import lastlog data into lastlog2 database.1757second # [ 7.511411] systemd[1]: Started Network Manager Script Dispatcher Service.1758test # [ 7.520077] (udev-worker)[437]: Network interface NamePolicy= disabled on kernel command line.1759test # [ 7.525745] (udev-worker)[438]: Network interface NamePolicy= disabled on kernel command line.1760test # [ 7.530080] systemd[1]: Mounted /run/wrappers.1761test # [ 7.531054] systemd[1]: Reached target Local File Systems.1762test # [ 7.534554] systemd[1]: Listening on Boot Loader Control Service Socket.1763test # [ 7.539085] systemd[1]: Starting register-nix-paths.service...1764test # [ 7.545570] systemd[1]: Starting Create SUID/SGID Wrappers...1765test # [ 7.546926] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1766test # [ 7.555347] systemd[1]: Starting Save Transient machine-id to Disk...1767second # [ 7.557457] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1768test # [ 7.569071] systemd[1]: Starting Create System Files and Directories...1769second # [ 7.567659] systemd[1]: Starting Hostname Service...1770test # [ 7.579503] systemd[1]: Finished Firewall.1771test # [ 7.592368] systemd[1]: Reached target Preparation for Network.1772test # [ 7.595445] systemd[1]: Listening on Network Management Resolve Hook Socket.1773second # [ 7.596158] systemd-logind[598]: New seat seat0.1774second # [ 7.597937] systemd[1]: Started User Login Management.1775test # [ 7.604926] systemd[1]: Starting Network Management...1776second # [ 7.607329] systemd[1]: Starting linger-users.service...1777second # [ 7.616661] systemd[1]: Starting Virtual Console Setup...1778test # [ 7.633607] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1779test # [ 7.642910] systemd[1]: Finished Save Transient machine-id to Disk.1780test # [ 7.698537] systemd[1]: Finished Create System Files and Directories.1781test # [ 7.706502] systemd[1]: Starting Rebuild Journal Catalog...1782test # [ 7.714053] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1783second # [ 7.870438] Console: switching to colour frame buffer device 160x501784second # [ 7.899496] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1785second # [ 7.669828] systemd[1]: linger-users.service: Deactivated successfully.1786second # [ 7.731332] systemd[1]: Finished linger-users.service.1787second # [ 7.732300] systemd-logind[598]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1788second # [ 7.734644] systemd-logind[598]: Watching system buttons on /dev/input/event2 (Power Button)1789second # [ 7.736598] systemd[1]: Started Hostname Service.1790second # [ 7.753631] systemd-networkd[479]: eth0: Link UP1791second # [ 7.756293] systemd-networkd[479]: eth0: Gained carrier1792second # [ 7.761585] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1793second # [ 7.763160] systemd[1]: Stopped Virtual Console Setup.1794second # [ 7.774528] systemd[1]: Starting Virtual Console Setup...1795second # [ 7.947615] ppdev: user-space parallel port driver1796test # [ 7.787967] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1797second # [ 7.788801] systemd[1]: Started Network Manager.1798second # [ 7.795272] systemd[1]: Reached target Network.1799second # [ 7.802524] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1800second # [ 7.809671] systemd[1]: Starting Permit User Sessions...1801test # [ 7.823942] systemd[1]: Finished Rebuild Journal Catalog.1802test # [ 7.832479] systemd[1]: Starting Update is Completed...1803second # [ 7.871393] systemd[1]: Finished Permit User Sessions.1804test # [ 7.879641] systemd[1]: Finished Update is Completed.1805second # [ 7.883733] systemd[1]: Started Getty on tty1.1806second # [ 7.885066] systemd[1]: Reached target Login Prompts.1807second # [ 7.891682] systemd-logind[598]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1808second # [ 8.071810] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1809test # [ 8.101359] cfg80211: Loading compiled-in X.509 certificates for regulatory database1810test # [ 8.120196] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1811test # [ 8.121181] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1812second # [ 8.125328] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1813test # [ 7.987525] systemd-networkd[501]: /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.1814test # [ 7.992991] systemd-networkd[501]: /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.1815test # [ 7.998762] systemd-networkd[501]: lo: Link UP1816test # [ 7.999900] systemd-networkd[501]: lo: Gained carrier1817second # [ 7.999372] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1818test # [ 8.178423] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31819second # [ 8.002259] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1820test # [ 8.012282] systemd[1]: Started Network Management.1821second # [ 8.012316] systemd[1]: Reached target Multi-User System.1822test # [ 8.017853] systemd-networkd[501]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1823test # [ 8.021284] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1824test # [ 8.022576] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1825test # [ 8.024961] systemd-networkd[501]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1826test # [ 8.030916] systemd-networkd[501]: eth1: Link UP1827test # [ 8.031807] systemd-networkd[501]: eth1: Gained carrier1828test # [ 8.033159] systemd-networkd[501]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1829test # [ 8.037151] systemd[1]: Finished Create SUID/SGID Wrappers.1830second # [ 8.037812] systemd-resolved[348]: eth0: Bus client set default route setting: yes1831second # [ 8.041665] systemd-resolved[348]: eth0: Bus client set DNS server list to: 10.0.2.31832test # [ 8.221148] NET: Registered PF_PACKET protocol family1833test # [ 8.083493] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1834test # [ 8.258574] mousedev: PS/2 mouse device common for all mice1835test # [ 8.265048] ACPI: button: Power Button [PWRF]1836second # [ 8.102545] systemd-vconsole-setup[621]: Configuration of first virtual console was skipped, ignoring remaining ones.1837second # [ 8.286197] kvm_amd: TSC scaling supported1838second # [ 8.286811] kvm_amd: Nested Virtualization enabled1839second # [ 8.287380] kvm_amd: Nested Paging enabled1840second # [ 8.288198] kvm_amd: LBR virtualization supported1841second # [ 8.289002] kvm_amd: Virtual GIF supported1842second # [ 8.289484] kvm_amd: Virtual NMI enabled1843second # [ 8.123117] systemd[1]: Finished Virtual Console Setup.1844second # [ 8.129089] systemd[1]: Startup finished in 783ms (kernel) + 3.620s (initrd) + 3.724s (userspace) = 8.128s.1845test # [ 8.325582] rtc_cmos 00:04: RTC can wake from S41846test # [ 8.168194] systemd[1]: Finished register-nix-paths.service.1847test # [ 8.169783] systemd[1]: Reached target System Initialization.1848test # [ 8.343754] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1849test # [ 8.174605] systemd[1]: Started Discard unused filesystem blocks once a week.1850test # [ 8.175805] systemd[1]: Started Daily Cleanup of Temporary Directories.1851test # [ 8.176927] systemd[1]: Reached target Timer Units.1852second # [ 8.169910] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1853test # [ 8.177835] systemd[1]: Listening on D-Bus System Message Bus Socket.1854second # [ 8.172257] systemd[1]: Stopped Virtual Console Setup.1855test # [ 8.179729] systemd[1]: Listening on Nix Daemon Socket.1856second # [ 8.174856] systemd[1]: Stopping Virtual Console Setup...1857test # [ 8.182862] systemd[1]: Listening on Authorization Manager Agent Helper.1858test # [ 8.184312] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1859test # [ 8.186176] systemd[1]: Reached target Socket Units.1860second # [ 8.351051] EDAC MC: Ver: 3.0.01861second # [ 8.182339] systemd[1]: Starting Virtual Console Setup...1862test # [ 8.190550] systemd[1]: Starting D-Bus System Message Bus...1863test # [ 8.365578] parport_pc 00:02: reported by Plug and Play ACPI1864test # [ 8.373821] rtc_cmos 00:04: registered as rtc01865test # [ 8.213859] systemd-resolved[372]: Clock change detected. Flushing caches.1866test # [ 8.268278] dbus-broker-launch[578]: Looking up NSS user entry for 'systemd-timesync'...1867test # [ 8.272975] dbus-broker-launch[578]: NSS returned no entry for 'systemd-timesync'1868test # [ 8.274249] dbus-broker-launch[578]: Invalid user-name in /nix/store/y5g83ihxjak0dp03i8x01s3lkza55svb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1869test # [ 8.383979] rtc_cmos 00:04: setting system clock to 2026-08-25T11:33:26 UTC (1787657606)1870test # [ 8.292621] dbus-broker-launch[578]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1871test # [ 8.296076] dbus-broker-launch[578]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/smg6s5kfg2m8nbcq6kq8bsdbqbh7naw9-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1872test # [ 8.299903] dbus-broker-launch[578]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nasw2v3yzqxbcz7633zjygg42hdv0i2f-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1873test # [ 8.304236] dbus-broker-launch[578]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1874test # [ 8.307544] systemd[1]: Started D-Bus System Message Bus.1875test # [ 8.384064] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1876test # [ 8.385440] systemd-journald[342]: Time jumped backwards, rotating.1877second # [ 8.320766] systemd-vconsole-setup[652]: Configuration of first virtual console was skipped, ignoring remaining ones.1878test # [ 8.329208] dbus-broker-launch[578]: Ready1879second # [ 8.324078] systemd[1]: Finished Virtual Console Setup.1880test # [ 8.339318] systemd[1]: Reached target Basic System.1881test # [ 8.341541] systemd[1]: Starting Network Manager Script Dispatcher Service...1882test # [ 8.347765] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1883test # [ 8.355952] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1884test # [ 8.392190] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1885test # [ 8.407621] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41886test # [ 8.363409] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1887test # [ 8.379315] systemd[1]: Starting Network Manager...1888test # [ 8.391985] systemd[1]: Started backdoor.service.1889second # [ 8.394812] systemd-networkd[479]: eth1: Gained IPv6LL1890test # [ 8.408261] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[583]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1891test # [ 8.417791] systemd[1]: Starting Import lastlog data into lastlog2 database...1892test # [ 8.429251] 3n8ky6qdcbw1k7vj7jk5r1y02d17nk2g-wifi-secrets[584]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1893test # [ 8.432273] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1894test # [ 8.456357] Console: switching to colour dummy device 80x251895test # [ 8.548084] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1896test # [ 8.441180] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1897test # [ 8.450434] systemd[1]: Starting Post-Boot Actions...1898test # [ 8.463489] f7i4m9qbq8xk00yg42rzh0mg47dda2zy-wifi-secrets[585]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1899test # [ 8.475587] systemd[1]: Started Reset console on configuration changes.1900test # [ 8.504490] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1901test # connecting to host...1902test # [ 8.513405] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1903test # [ 8.520449] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1904test # [ 8.524862] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1905test # [ 8.528136] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1906test # [ 8.548191] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1907test # [ 8.667691] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61908test # [ 8.534546] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1909test: Guest shell says: b'Spawning backdoor root shell...\n'1910test: connected to guest root shell1911test: (connecting took 9.20 seconds)1912test: (finished: waiting for the VM to finish booting, in 9.20 seconds)1913test # [ 8.561887] systemd[1]: Finished Post-Boot Actions.1914test # [ 8.587978] nsncd[597]: Aug 25 11:33:26.873 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1915test # [ 8.592516] systemd[1]: Started Name Service Cache Daemon (nsncd).1916test # [ 8.594550] systemd[1]: Started Network Manager Script Dispatcher Service.1917test # [ 8.600190] systemd[1]: Reached target Host and Network Name Lookups.1918test # [ 8.601423] systemd[1]: Reached target User and Group Name Lookups.1919test # [ 8.667951] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51920test # [ 8.781691] [drm] Found bochs VGA, ID 0xb0c5.1921test # [ 8.781692] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1922test # [ 8.613377] systemd[1]: Starting User Login Management...1923test # [ 8.623627] systemd[1]: Finished Import lastlog data into lastlog2 database.1924test # [ 8.811992] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1925test # [ 8.845883] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01926test # [ 8.678178] systemd[1]: Starting Hostname Service...1927test # [ 8.699622] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1928test # [ 8.713943] systemd[1]: Starting Virtual Console Setup...1929test # [ 8.723650] systemd-logind[636]: New seat seat0.1930test # [ 8.730080] systemd[1]: Started User Login Management.1931test # [ 8.734363] systemd[1]: Starting linger-users.service...1932test # [ 8.776898] systemd-logind[636]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1933test # [ 8.783664] systemd[1]: linger-users.service: Deactivated successfully.1934test # [ 8.784756] systemd[1]: Finished linger-users.service.1935test # [ 8.798819] systemd[1]: Started Hostname Service.1936test # [ 8.825266] systemd-logind[636]: Watching system buttons on /dev/input/event2 (Power Button)1937test # [ 8.875068] systemd-networkd[501]: eth0: Link UP1938test # [ 8.876702] systemd-networkd[501]: eth0: Gained carrier1939test # [ 8.903807] systemd[1]: Started Network Manager.1940test # [ 8.906316] systemd[1]: Reached target Network.1941test # [ 9.037160] Console: switching to colour frame buffer device 160x501942test # [ 8.911157] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1943test # [ 8.921080] systemd[1]: Starting Permit User Sessions...1944test # [ 9.109852] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1945test # [ 9.120064] ppdev: user-space parallel port driver1946test # [ 8.950499] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1947test # [ 8.954910] systemd[1]: Stopped Virtual Console Setup.1948test # [ 8.975075] systemd[1]: Starting Virtual Console Setup...1949second # [ 8.970601] systemd-networkd[479]: eth0: Gained IPv6LL1950test # [ 8.996133] systemd[1]: Finished Permit User Sessions.1951test # [ 9.021122] systemd[1]: Started Getty on tty1.1952test # [ 9.023188] systemd[1]: Reached target Login Prompts.1953test # [ 9.227032] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1954test # [ 9.066759] systemd-logind[636]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1955test # [ 9.089456] NetworkManager[586]: <warn> [1787657607.3747] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1956test # [ 9.094151] NetworkManager[586]: <warn> [1787657607.3752] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1957test # [ 9.287951] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1958test # [ 9.123254] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1959test # [ 9.126474] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1960test # [ 9.134827] systemd[1]: Reached target Multi-User System.1961test # [ 9.163701] systemd-resolved[372]: eth0: Bus client set default route setting: yes1962test # [ 9.167958] systemd-resolved[372]: eth0: Bus client set DNS server list to: 10.0.2.31963test # [ 9.246702] systemd-vconsole-setup[662]: Configuration of first virtual console was skipped, ignoring remaining ones.1964test # [ 9.256176] systemd[1]: Finished Virtual Console Setup.1965test # [ 9.257103] systemd[1]: Startup finished in 786ms (kernel) + 4.552s (initrd) + 3.914s (userspace) = 9.253s.1966test # [ 9.442601] kvm_amd: TSC scaling supported1967test # [ 9.443091] kvm_amd: Nested Virtualization enabled1968test # [ 9.444024] kvm_amd: Nested Paging enabled1969test # [ 9.444968] kvm_amd: LBR virtualization supported1970test # [ 9.445743] kvm_amd: Virtual GIF supported1971test # [ 9.446228] kvm_amd: Virtual NMI enabled1972test # [ 9.304359] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1973test # [ 9.306151] systemd[1]: Stopped Virtual Console Setup.1974test # [ 9.307288] systemd[1]: Stopping Virtual Console Setup...1975test # [ 9.313208] systemd[1]: Starting Virtual Console Setup...1976test # [ 9.495474] EDAC MC: Ver: 3.0.01977test # [ 9.447441] systemd-vconsole-setup[698]: Configuration of first virtual console was skipped, ignoring remaining ones.1978test # [ 9.450867] systemd[1]: Finished Virtual Console Setup.1979test: (finished: waiting for unit NetworkManager.service, in 10.33 seconds)1980test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1981test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1982cleanup1983kill QemuMachine (pid 47)1984second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1985kill QemuMachine (pid 48)1986test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1987(finished: cleanup, in 0.17 seconds)1988Traceback (most recent call last):1989 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1990 sys.exit(main())1991 ~~~~^^1992 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main1993 driver.run_tests()1994 ~~~~~~~~~~~~~~~~^^1995 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests1996 self.test_script()1997 ~~~~~~~~~~~~~~~~^^1998 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script1999 exec(self.tests, symbols, None)2000 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^2001 File "<string>", line 4, in <module>2002AssertionError: Expected mock password in connection file:2003[connection]2004autoconnect=true2005id=2006type=wifi20072008[wifi]2009mode=infrastructure2010ssid=20112012[wifi-security]2013key-mgmt=wpa-psk2014psk=2015