vm-test-run-wifi
checks.x86_64-linux.wifi
· build #65
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test: QEMU running (pid 48)14test # Disk image does not exist, creating the virtualisation disk image...15test # Formatting '/build/vm-state-test/tmp.DsQl4P2I2E', 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: 7128c6dd-50f2-4348-840b-32d6d09e16c020test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29second # Disk image does not exist, creating the virtualisation disk image...30second: QEMU running (pid 47)31second # Formatting '/build/vm-state-second/tmp.E7fzA0ixpz', fmt=raw size=107374182432second # mke2fs 1.47.4 (6-Mar-2025)33second # Discarding device blocks: 0/262144 done34second # Creating filesystem with 262144 4k blocks and 65536 inodes35second # Filesystem UUID: 9f2de449-5fec-4ca4-8226-775a443d453f36second # Superblock backups stored on blocks:37second # 32768, 98304, 163840, 22937638second # 39second # Allocating group tables: 0/8 done40second # Writing inode tables: 0/8 done41second # Creating journal (8192 blocks): done42second # Writing superblocks and filesystem accounting information: 0/8 done43second # 44second # Virtualisation disk image created.45(finished: start all VMs, in 0.09 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50test # 51test # 52test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0053second # 54second # 55second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0056test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...57test # 58test # 59test # 60test # 61test # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0062second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...63second # 64second # 65second # 66second # 67second # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0068test # Press Ctrl-B to configure iPXE (PCI 00:08.0)...69test # 70test # 71second # Press Ctrl-B to configure iPXE (PCI 00:08.0)...72second # 73second # 74test # Booting from ROM...75second # Booting from ROM...76test # Probing EDD (edd=off to disable)... o[ 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 202677test # [ 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=tty078test # [ 0.000000] BIOS-provided physical RAM map:79test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable80test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved81second # Probing EDD (edd=off to disable)... o[ 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 202682test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved83test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable84test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved85test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved86second # [ 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=tty087test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved88second # [ 0.000000] BIOS-provided physical RAM map:89test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved90second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable91test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved92second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved93test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved94second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved95test # [ 0.000000] NX (Execute Disable) protection: active96test # [ 0.000000] APIC: Static calls initialized97second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable98test # [ 0.000000] SMBIOS 2.8 present.99second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved100test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014101second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved102test # [ 0.000000] DMI: Memory slots populated: 1/1103test # [ 0.000000] Hypervisor detected: KVM104second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved105test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000106second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved107test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00108second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved109test # [ 0.000001] kvm-clock: using sched offset of 424554103 cycles110second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved111second # [ 0.000000] NX (Execute Disable) protection: active112test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns113second # [ 0.000000] APIC: Static calls initialized114test # [ 0.000004] tsc: Detected 4192.100 MHz processor115second # [ 0.000000] SMBIOS 2.8 present.116test # [ 0.000589] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000117second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014118test # [ 0.000616] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs119second # [ 0.000000] DMI: Memory slots populated: 1/1120test # [ 0.000619] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT121second # [ 0.000000] Hypervisor detected: KVM122second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000123test # [ 0.002250] found SMP MP-table at [mem 0x000f5450-0x000f545f]124test # [ 0.002263] Using GB pages for direct mapping125second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00126test # [ 0.002311] RAMDISK: [mem 0x3e347000-0x3ffcffff]127second # [ 0.000001] kvm-clock: using sched offset of 429198898 cycles128test # [ 0.002316] ACPI: Early table checksum verification disabled129test # [ 0.002319] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )130second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns131second # [ 0.000006] tsc: Detected 4192.100 MHz processor132test # [ 0.002321] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)133second # [ 0.000594] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000134test # [ 0.002325] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)135second # [ 0.000621] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs136test # [ 0.002330] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)137second # [ 0.000624] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT138test # [ 0.002332] ACPI: FACS 0x000000003FFE0000 000040139second # [ 0.002252] found SMP MP-table at [mem 0x000f5450-0x000f545f]140second # [ 0.002267] Using GB pages for direct mapping141test # [ 0.002333] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)142second # [ 0.002351] RAMDISK: [mem 0x3e348000-0x3ffcffff]143second # [ 0.002356] ACPI: Early table checksum verification disabled144test # [ 0.002334] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)145second # [ 0.002360] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )146test # [ 0.002335] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)147second # [ 0.002363] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)148test # [ 0.002336] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)149second # [ 0.002367] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)150test # [ 0.002337] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]151second # [ 0.002372] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)152test # [ 0.002338] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]153second # [ 0.002374] ACPI: FACS 0x000000003FFE0000 000040154test # [ 0.002339] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]155second # [ 0.002375] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)156test # [ 0.002339] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]157test # [ 0.002340] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]158second # [ 0.002376] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)159test # [ 0.002340] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]160second # [ 0.002377] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)161test # [ 0.002340] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]162second # [ 0.002378] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)163test # [ 0.002678] No NUMA configuration found164second # [ 0.002379] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]165test # [ 0.002679] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]166test # [ 0.002681] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]167second # [ 0.002380] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]168test # [ 0.002748] Zone ranges:169second # [ 0.002381] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]170test # [ 0.002749] DMA [mem 0x0000000000001000-0x0000000000ffffff]171second # [ 0.002381] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]172test # [ 0.002750] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]173test # [ 0.002751] Normal empty174test # [ 0.002751] Device empty175second # [ 0.002381] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]176test # [ 0.002752] Movable zone start for each node177second # [ 0.002382] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]178test # [ 0.002752] Early memory node ranges179test # [ 0.002753] node 0: [mem 0x0000000000001000-0x000000000009efff]180second # [ 0.002382] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]181second # [ 0.002733] No NUMA configuration found182test # [ 0.002753] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]183second # [ 0.002734] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]184test # [ 0.002754] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]185second # [ 0.002737] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]186test # [ 0.002770] On node 0, zone DMA: 1 pages in unavailable ranges187second # [ 0.002806] Zone ranges:188test # [ 0.002967] On node 0, zone DMA: 97 pages in unavailable ranges189second # [ 0.002806] DMA [mem 0x0000000000001000-0x0000000000ffffff]190test # [ 0.015881] On node 0, zone DMA32: 40 pages in unavailable ranges191second # [ 0.002807] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]192second # [ 0.002808] Normal empty193test # [ 0.016640] ACPI: PM-Timer IO Port: 0x608194second # [ 0.002809] Device empty195test # [ 0.016648] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])196second # [ 0.002809] Movable zone start for each node197second # [ 0.002810] Early memory node ranges198test # [ 0.016668] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23199second # [ 0.002810] node 0: [mem 0x0000000000001000-0x000000000009efff]200test # [ 0.016670] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)201second # [ 0.002811] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]202test # [ 0.016671] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)203second # [ 0.002812] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]204test # [ 0.016672] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)205second # [ 0.002827] On node 0, zone DMA: 1 pages in unavailable ranges206test # [ 0.016673] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)207second # [ 0.003018] On node 0, zone DMA: 97 pages in unavailable ranges208test # [ 0.016673] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)209second # [ 0.016416] On node 0, zone DMA32: 40 pages in unavailable ranges210test # [ 0.016675] ACPI: Using ACPI (MADT) for SMP configuration information211second # [ 0.017200] ACPI: PM-Timer IO Port: 0x608212test # [ 0.016676] ACPI: HPET id: 0x8086a201 base: 0xfed00000213second # [ 0.017210] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])214test # [ 0.016679] TSC deadline timer available215second # [ 0.017231] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23216test # [ 0.016682] CPU topo: Max. logical packages: 1217test # [ 0.016683] CPU topo: Max. logical dies: 1218second # [ 0.017233] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)219test # [ 0.016683] CPU topo: Max. dies per package: 1220second # [ 0.017234] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)221test # [ 0.016686] CPU topo: Max. threads per core: 1222second # [ 0.017235] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)223test # [ 0.016687] CPU topo: Num. cores per package: 1224test # [ 0.016687] CPU topo: Num. threads per package: 1225second # [ 0.017236] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)226test # [ 0.016687] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs227second # [ 0.017236] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)228test # [ 0.016698] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()229second # [ 0.017238] ACPI: Using ACPI (MADT) for SMP configuration information230second # [ 0.017238] ACPI: HPET id: 0x8086a201 base: 0xfed00000231test # [ 0.016726] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]232second # [ 0.017241] TSC deadline timer available233test # [ 0.016727] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]234second # [ 0.017245] CPU topo: Max. logical packages: 1235second # [ 0.017245] CPU topo: Max. logical dies: 1236test # [ 0.016728] [mem 0x40000000-0xafffffff] available for PCI devices237second # [ 0.017246] CPU topo: Max. dies per package: 1238test # [ 0.016729] Booting paravirtualized kernel on KVM239second # [ 0.017249] CPU topo: Max. threads per core: 1240second # [ 0.017250] CPU topo: Num. cores per package: 1241test # [ 0.016732] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns242second # [ 0.017250] CPU topo: Num. threads per package: 1243test # [ 0.020011] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1244second # [ 0.017250] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs245test # [ 0.021630] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152246second # [ 0.017265] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()247test # [ 0.021665] kvm-guest: PV spinlocks disabled, single CPU248second # [ 0.017294] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]249second # [ 0.017295] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]250second # [ 0.017296] [mem 0x40000000-0xafffffff] available for PCI devices251second # [ 0.017298] Booting paravirtualized kernel on KVM252test # [ 0.021666] 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=tty0253second # [ 0.017300] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns254second # [ 0.020792] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1255test # [ 0.021736] Unknown kernel command line parameters "regInfo=/nix/store/hxrpanhs0cg7va2a9dig0q2a9lfh8dnw-closure-info/registration", will be passed to user space.256second # [ 0.022410] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152257test # [ 0.021930] random: crng init done258second # [ 0.022445] kvm-guest: PV spinlocks disabled, single CPU259test # [ 0.021931] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes260test # [ 0.022715] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)261test # [ 0.022727] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)262test # [ 0.022754] Fallback order for Node 0: 0263test # [ 0.022756] Built 1 zonelists, mobility grouping on. Total pages: 262006264second # [ 0.022447] 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=tty0265test # [ 0.022756] Policy zone: DMA32266test # [ 0.024518] mem auto-init: stack:all(zero), heap alloc:on, heap free:off267second # [ 0.022517] Unknown kernel command line parameters "regInfo=/nix/store/77vfh9g6455qizzywsv3nrp40ckfh17p-closure-info/registration", will be passed to user space.268test # [ 0.026795] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1269second # [ 0.022714] random: crng init done270test # [ 0.028471] allocated 2097152 bytes of page_ext271second # [ 0.022715] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes272test # [ 0.038114] ftrace: allocating 48728 entries in 192 pages273test # [ 0.038116] ftrace: allocated 192 pages with 2 groups274second # [ 0.023501] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)275test # [ 0.038779] Dynamic Preempt: lazy276test # [ 0.038881] rcu: Preemptible hierarchical RCU implementation.277second # [ 0.023523] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)278test # [ 0.038882] rcu: RCU event tracing is enabled.279second # [ 0.023557] Fallback order for Node 0: 0280test # [ 0.038882] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.281second # [ 0.023560] Built 1 zonelists, mobility grouping on. Total pages: 262006282second # [ 0.023561] Policy zone: DMA32283test # [ 0.038883] Trampoline variant of Tasks RCU enabled.284test # [ 0.038883] Rude variant of Tasks RCU enabled.285second # [ 0.025168] mem auto-init: stack:all(zero), heap alloc:on, heap free:off286test # [ 0.038883] Tracing variant of Tasks RCU enabled.287second # [ 0.027602] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1288second # [ 0.029425] allocated 2097152 bytes of page_ext289test # [ 0.038884] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.290second # [ 0.038434] ftrace: allocating 48728 entries in 192 pages291test # [ 0.038884] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1292second # [ 0.038436] ftrace: allocated 192 pages with 2 groups293second # [ 0.039145] Dynamic Preempt: lazy294test # [ 0.038926] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.295second # [ 0.039244] rcu: Preemptible hierarchical RCU implementation.296second # [ 0.039245] rcu: RCU event tracing is enabled.297test # [ 0.038928] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.298second # [ 0.039245] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.299test # [ 0.038929] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.300second # [ 0.039247] Trampoline variant of Tasks RCU enabled.301test # [ 0.042157] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16302second # [ 0.039247] Rude variant of Tasks RCU enabled.303second # [ 0.039248] Tracing variant of Tasks RCU enabled.304test # [ 0.042402] rcu: srcu_init: Setting srcu_struct sizes based on contention.305second # [ 0.039248] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.306test # [ 0.042407] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns307second # [ 0.039249] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1308test # [ 0.042554] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)309second # [ 0.039289] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.310test # [ 0.047635] Console: colour VGA+ 80x25311test # [ 0.047638] printk: legacy console [tty0] enabled312second # [ 0.039290] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.313test # [ 0.077285] printk: legacy console [ttyS0] enabled314test # [ 0.207381] ACPI: Core revision 20250807315second # [ 0.039291] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.316second # [ 0.042501] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16317test # [ 0.208373] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns318second # [ 0.042746] rcu: srcu_init: Setting srcu_struct sizes based on contention.319test # [ 0.210227] APIC: Switch to symmetric I/O mode setup320second # [ 0.042751] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns321test # [ 0.211341] x2apic enabled322test # [ 0.212121] APIC: Switched APIC routing to: physical x2apic323second # [ 0.042908] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)324second # [ 0.047986] Console: colour VGA+ 80x25325second # [ 0.047989] printk: legacy console [tty0] enabled326test # [ 0.214009] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1327second # [ 0.078009] printk: legacy console [ttyS0] enabled328second # [ 0.208203] ACPI: Core revision 20250807329test # [ 0.215189] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns330second # [ 0.209179] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns331test # [ 0.217175] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)332second # [ 0.211028] APIC: Switch to symmetric I/O mode setup333second # [ 0.212147] x2apic enabled334test # [ 0.219262] x86/cpu: User Mode Instruction Prevention (UMIP) activated335second # [ 0.212941] APIC: Switched APIC routing to: physical x2apic336test # [ 0.221205] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127337test # [ 0.222175] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0338second # [ 0.214842] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1339test # [ 0.223178] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto340second # [ 0.216028] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns341test # [ 0.224175] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl342second # [ 0.218003] Calibrating delay loop (skipped) preset value.. 8384.20 BogoMIPS (lpj=4192100)343test # [ 0.225175] Spectre V2 : Mitigation: Enhanced / Automatic IBRS344second # [ 0.220087] x86/cpu: User Mode Instruction Prevention (UMIP) activated345test # [ 0.226175] Speculative Return Stack Overflow: Mitigation: Safe RET346second # [ 0.222077] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127347test # [ 0.227175] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization348second # [ 0.223002] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0349second # [ 0.224005] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto350second # [ 0.225003] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl351test # [ 0.228180] Spectre V2 : Enabling IBPB for BPF352second # [ 0.226003] Spectre V2 : Mitigation: Enhanced / Automatic IBRS353test # [ 0.230176] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier354second # [ 0.227003] Speculative Return Stack Overflow: Mitigation: Safe RET355test # [ 0.231175] active return thunk: srso_alias_return_thunk356second # [ 0.228002] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization357test # [ 0.232194] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'358test # [ 0.233175] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'359test # [ 0.234175] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'360test # [ 0.235175] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'361second # [ 0.229009] Spectre V2 : Enabling IBPB for BPF362test # [ 0.237175] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'363second # [ 0.231003] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier364test # [ 0.238175] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'365second # [ 0.232003] active return thunk: srso_alias_return_thunk366test # [ 0.239175] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'367second # [ 0.233027] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'368test # [ 0.240175] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'369second # [ 0.234002] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'370test # [ 0.241175] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'371second # [ 0.235002] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'372test # [ 0.242175] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256373second # [ 0.237002] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'374test # [ 0.243175] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64375second # [ 0.238002] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'376test # [ 0.244175] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512377second # [ 0.239002] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'378test # [ 0.245175] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024379second # [ 0.240002] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'380test # [ 0.246175] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8381second # [ 0.241002] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'382test # [ 0.247175] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16383test # [ 0.249175] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24384second # [ 0.242002] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'385second # [ 0.243003] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256386test # [ 0.250175] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.387second # [ 0.244002] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64388second # [ 0.245002] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512389second # [ 0.246002] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024390second # [ 0.247003] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8391second # [ 0.249002] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16392second # [ 0.250002] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24393second # [ 0.251002] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.394test # [ 0.275524] Freeing SMP alternatives memory: 44K395test # [ 0.276176] pid_max: default: 32768 minimum: 301396test # [ 0.277219] LSM: initializing lsm=capability,landlock,yama,bpf,ima397test # [ 0.278256] landlock: Up and running.398test # [ 0.279175] Yama: becoming mindful.399test # [ 0.280244] LSM support for eBPF active400test # [ 0.281084] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)401test # [ 0.282191] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)402second # [ 0.276913] Freeing SMP alternatives memory: 44K403second # [ 0.277702] pid_max: default: 32768 minimum: 301404test # [ 0.284675] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)405second # [ 0.278750] LSM: initializing lsm=capability,landlock,yama,bpf,ima406test # [ 0.285532] Performance Events: Fam17h+ core perfctr, AMD PMU driver.407second # [ 0.280011] landlock: Up and running.408second # [ 0.280744] Yama: becoming mindful.409test # [ 0.286178] ... version: 2410second # [ 0.281188] LSM support for eBPF active411test # [ 0.287019] ... bit width: 48412test # [ 0.287839] ... generic counters: 6413second # [ 0.282079] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)414test # [ 0.288211] ... generic bitmap: 000000000000003f415test # [ 0.289176] ... fixed-purpose counters: 0416second # [ 0.283018] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)417test # [ 0.290017] ... fixed-purpose bitmap: 0000000000000000418test # [ 0.291019] ... value mask: 0000ffffffffffff419second # [ 0.286049] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)420test # [ 0.292024] ... max period: 00007fffffffffff421second # [ 0.287390] Performance Events: Fam17h+ core perfctr, AMD PMU driver.422test # [ 0.293014] ... global_ctrl mask: 000000000000003f423second # [ 0.288010] ... version: 2424test # [ 0.294092] signal: max sigframe size: 3376425second # [ 0.288840] ... bit width: 48426test # [ 0.294864] rcu: Hierarchical SRCU implementation.427second # [ 0.289665] ... generic counters: 6428test # [ 0.295179] rcu: Max phase no-delay instances is 400.429second # [ 0.290003] ... generic bitmap: 000000000000003f430second # [ 0.291003] ... fixed-purpose counters: 0431second # [ 0.291835] ... fixed-purpose bitmap: 0000000000000000432second # [ 0.292842] ... value mask: 0000ffffffffffff433test # [ 0.298944] smp: Bringing up secondary CPUs ...434test # [ 0.299187] smp: Brought up 1 node, 1 CPU435second # [ 0.293837] ... max period: 00007fffffffffff436second # [ 0.294834] ... global_ctrl mask: 000000000000003f437test # [ 0.299972] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)438second # [ 0.295909] signal: max sigframe size: 3376439second # [ 0.296725] rcu: Hierarchical SRCU implementation.440test # [ 0.301243] Memory: 942884K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97724K reserved, 0K cma-reserved)441second # [ 0.297006] rcu: Max phase no-delay instances is 400.442test # [ 0.302311] devtmpfs: initialized443test # [ 0.303171] x86/mm: Memory block size: 128MB444test # [ 0.304697] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)445second # [ 0.300842] smp: Bringing up secondary CPUs ...446second # [ 0.301735] smp: Brought up 1 node, 1 CPU447test # [ 0.305202] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).448second # [ 0.302004] smpboot: Total of 1 processors activated (8384.20 BogoMIPS)449test # [ 0.306236] pinctrl core: initialized pinctrl subsystem450test # [ 0.307411] PM: RTC time: 21:44:55, date: 2026-08-25451second # [ 0.303169] Memory: 942884K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97720K reserved, 0K cma-reserved)452second # [ 0.304168] devtmpfs: initialized453second # [ 0.305068] x86/mm: Memory block size: 128MB454test # [ 0.310310] NET: Registered PF_NETLINK/PF_ROUTE protocol family455test # [ 0.311441] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations456second # [ 0.306632] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)457test # [ 0.312194] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations458second # [ 0.307025] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).459second # [ 0.308075] pinctrl core: initialized pinctrl subsystem460test # [ 0.313282] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations461second # [ 0.309246] PM: RTC time: 21:44:55, date: 2026-08-25462test # [ 0.314184] audit: initializing netlink subsys (disabled)463test # [ 0.315349] thermal_sys: Registered thermal governor 'fair_share'464test # [ 0.315350] thermal_sys: Registered thermal governor 'bang_bang'465second # [ 0.311969] NET: Registered PF_NETLINK/PF_ROUTE protocol family466test # [ 0.316179] audit: type=2000 audit(1787694296.356:1): state=initialized audit_enabled=0 res=1467second # [ 0.313379] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations468test # [ 0.318178] thermal_sys: Registered thermal governor 'step_wise'469second # [ 0.314019] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations470test # [ 0.318179] thermal_sys: Registered thermal governor 'user_space'471test # [ 0.319176] thermal_sys: Registered thermal governor 'power_allocator'472second # [ 0.315110] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations473test # [ 0.320191] cpuidle: using governor menu474second # [ 0.316010] audit: initializing netlink subsys (disabled)475second # [ 0.317209] thermal_sys: Registered thermal governor 'fair_share'476test # [ 0.322779] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5477second # [ 0.317211] thermal_sys: Registered thermal governor 'bang_bang'478test # [ 0.323383] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]479second # [ 0.318004] thermal_sys: Registered thermal governor 'step_wise'480test # [ 0.324178] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry481second # [ 0.319006] audit: type=2000 audit(1787694296.364:1): state=initialized audit_enabled=0 res=1482test # [ 0.325185] PCI: Using configuration type 1 for base access483second # [ 0.321005] thermal_sys: Registered thermal governor 'user_space'484test # [ 0.326323] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.485second # [ 0.321006] thermal_sys: Registered thermal governor 'power_allocator'486second # [ 0.322016] cpuidle: using governor menu487second # [ 0.324616] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5488second # [ 0.325222] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]489second # [ 0.326005] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry490second # [ 0.327014] PCI: Using configuration type 1 for base access491test # [ 0.333237] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages492test # [ 0.334177] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page493second # [ 0.328165] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.494test # [ 0.339176] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages495second # [ 0.333176] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages496test # [ 0.340177] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page497second # [ 0.334004] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page498second # [ 0.339003] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages499test # [ 0.346789] ACPI: Added _OSI(Module Device)500second # [ 0.340003] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page501test # [ 0.347177] ACPI: Added _OSI(Processor Device)502test # [ 0.348056] ACPI: Added _OSI(Processor Aggregator Device)503test # [ 0.354795] ACPI: 1 ACPI AML tables successfully acquired and loaded504second # [ 0.349323] ACPI: Added _OSI(Module Device)505second # [ 0.350004] ACPI: Added _OSI(Processor Device)506second # [ 0.350894] ACPI: Added _OSI(Processor Aggregator Device)507test # [ 0.357909] ACPI: Interpreter enabled508test # [ 0.358189] ACPI: PM: (supports S0 S3 S4 S5)509test # [ 0.359044] ACPI: Using IOAPIC for interrupt routing510test # [ 0.360009] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug511second # [ 0.355751] ACPI: 1 ACPI AML tables successfully acquired and loaded512test # [ 0.362673] PCI: Using E820 reservations for host bridge windows513test # [ 0.363283] ACPI: Enabled 2 GPEs in block 00 to 3F514second # [ 0.358779] ACPI: Interpreter enabled515second # [ 0.359015] ACPI: PM: (supports S0 S3 S4 S5)516second # [ 0.359872] ACPI: Using IOAPIC for interrupt routing517test # [ 0.367237] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])518second # [ 0.360818] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug519test # [ 0.368181] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]520test # [ 0.369243] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]521second # [ 0.364556] PCI: Using E820 reservations for host bridge windows522test # [ 0.370267] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]523second # [ 0.365111] ACPI: Enabled 2 GPEs in block 00 to 3F524test # [ 0.371540] PCI host bridge to bus 0000:00525test # [ 0.372180] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]526test # [ 0.373177] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]527second # [ 0.369071] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])528test # [ 0.374177] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]529second # [ 0.370008] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]530test # [ 0.375177] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]531second # [ 0.371059] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]532test # [ 0.376177] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]533second # [ 0.372094] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]534test # [ 0.377177] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]535second # [ 0.373399] PCI host bridge to bus 0000:00536test # [ 0.378177] pci_bus 0000:00: root bus resource [bus 00-ff]537second # [ 0.374008] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]538test # [ 0.379246] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint539second # [ 0.375004] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]540second # [ 0.376004] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]541test # [ 0.380786] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint542second # [ 0.377004] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]543second # [ 0.378004] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]544second # [ 0.379004] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]545test # [ 0.383158] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]546second # [ 0.380004] pci_bus 0000:00: root bus resource [bus 00-ff]547test # [ 0.384196] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]548test # [ 0.385214] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]549second # [ 0.381095] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint550test # [ 0.386346] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]551second # [ 0.382620] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint552test # [ 0.387903] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint553second # [ 0.385000] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]554test # [ 0.390187] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]555second # [ 0.386023] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]556test # [ 0.391187] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]557second # [ 0.387041] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]558test # [ 0.392214] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]559test # [ 0.393187] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]560second # [ 0.388169] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]561test # [ 0.395022] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint562second # [ 0.389767] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint563test # [ 0.397854] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]564second # [ 0.392014] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]565test # [ 0.398187] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]566second # [ 0.393014] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]567test # [ 0.399214] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]568second # [ 0.394041] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]569second # [ 0.395014] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]570test # [ 0.401151] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint571second # [ 0.396976] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint572test # [ 0.403187] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]573test # [ 0.404194] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]574second # [ 0.399676] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]575test # [ 0.405214] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]576second # [ 0.400014] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]577second # [ 0.401041] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]578test # [ 0.407023] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint579second # [ 0.402857] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint580test # [ 0.409196] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]581test # [ 0.410187] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]582second # [ 0.405014] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]583test # [ 0.411214] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]584second # [ 0.406014] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]585second # [ 0.407041] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]586test # [ 0.413204] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint587test # [ 0.415187] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]588second # [ 0.408863] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint589test # [ 0.416187] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]590second # [ 0.411014] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]591test # [ 0.417215] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]592second # [ 0.412014] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]593second # [ 0.413048] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]594test # [ 0.419043] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint595second # [ 0.414853] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint596test # [ 0.421397] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]597test # [ 0.422187] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]598second # [ 0.417014] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]599second # [ 0.418014] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]600test # [ 0.423219] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]601second # [ 0.419041] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]602test # [ 0.425051] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint603second # [ 0.420856] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint604test # [ 0.427187] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]605test # [ 0.428187] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]606second # [ 0.423091] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]607test # [ 0.429214] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]608second # [ 0.424014] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]609test # [ 0.430187] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]610second # [ 0.425041] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]611test # [ 0.432016] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint612second # [ 0.426900] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint613test # [ 0.433963] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]614second # [ 0.429014] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]615test # [ 0.435153] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]616second # [ 0.430014] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]617test # [ 0.437010] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint618second # [ 0.431041] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]619second # [ 0.432014] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]620test # [ 0.439186] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]621test # [ 0.440187] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]622second # [ 0.433837] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint623test # [ 0.441214] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]624second # [ 0.435802] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]625second # [ 0.436972] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]626test # [ 0.443003] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint627test # [ 0.445186] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]628second # [ 0.438833] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint629test # [ 0.446187] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]630second # [ 0.441026] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]631test # [ 0.447214] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]632second # [ 0.442014] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]633second # [ 0.443040] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]634second # [ 0.444846] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint635second # [ 0.447014] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]636second # [ 0.448013] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]637second # [ 0.449041] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]638test # [ 0.449030] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint639test # [ 0.451101] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]640test # [ 0.452284] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint641test # [ 0.454223] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]642test # [ 0.455424] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint643second # [ 0.450875] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint644test # [ 0.457111] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]645second # [ 0.452943] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]646test # [ 0.458313] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint647second # [ 0.454095] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint648test # [ 0.459824] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]649test # [ 0.460480] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint650second # [ 0.456051] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]651second # [ 0.457251] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint652test # [ 0.461636] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO653test # [ 0.462506] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint654second # [ 0.459000] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]655second # [ 0.460127] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint656test # [ 0.464367] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]657test # [ 0.465192] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]658second # [ 0.461660] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]659test # [ 0.466640] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint660second # [ 0.462326] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint661test # [ 0.467899] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]662second # [ 0.463465] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO663second # [ 0.464333] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint664second # [ 0.466306] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]665test # [ 0.472824] ACPI: PCI: Interrupt link LNKA configured for IRQ 10666second # [ 0.467014] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]667test # [ 0.473302] ACPI: PCI: Interrupt link LNKB configured for IRQ 10668second # [ 0.468464] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint669test # [ 0.474293] ACPI: PCI: Interrupt link LNKC configured for IRQ 11670test # [ 0.475292] ACPI: PCI: Interrupt link LNKD configured for IRQ 11671second # [ 0.469652] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]672test # [ 0.476295] ACPI: PCI: Interrupt link LNKE configured for IRQ 10673test # [ 0.477292] ACPI: PCI: Interrupt link LNKF configured for IRQ 10674test # [ 0.478292] ACPI: PCI: Interrupt link LNKG configured for IRQ 11675test # [ 0.479289] ACPI: PCI: Interrupt link LNKH configured for IRQ 11676second # [ 0.474401] ACPI: PCI: Interrupt link LNKA configured for IRQ 10677test # [ 0.480222] ACPI: PCI: Interrupt link GSIA configured for IRQ 16678second # [ 0.475122] ACPI: PCI: Interrupt link LNKB configured for IRQ 10679test # [ 0.481192] ACPI: PCI: Interrupt link GSIB configured for IRQ 17680second # [ 0.476123] ACPI: PCI: Interrupt link LNKC configured for IRQ 11681test # [ 0.482195] ACPI: PCI: Interrupt link GSIC configured for IRQ 18682second # [ 0.477119] ACPI: PCI: Interrupt link LNKD configured for IRQ 11683test # [ 0.483194] ACPI: PCI: Interrupt link GSID configured for IRQ 19684second # [ 0.478113] ACPI: PCI: Interrupt link LNKE configured for IRQ 10685test # [ 0.484191] ACPI: PCI: Interrupt link GSIE configured for IRQ 20686second # [ 0.479116] ACPI: PCI: Interrupt link LNKF configured for IRQ 10687test # [ 0.485204] ACPI: PCI: Interrupt link GSIF configured for IRQ 21688second # [ 0.480115] ACPI: PCI: Interrupt link LNKG configured for IRQ 11689test # [ 0.486196] ACPI: PCI: Interrupt link GSIG configured for IRQ 22690second # [ 0.481126] ACPI: PCI: Interrupt link LNKH configured for IRQ 11691test # [ 0.487192] ACPI: PCI: Interrupt link GSIH configured for IRQ 23692second # [ 0.482051] ACPI: PCI: Interrupt link GSIA configured for IRQ 16693test # [ 0.489060] iommu: Default domain type: Translated694second # [ 0.483025] ACPI: PCI: Interrupt link GSIB configured for IRQ 17695test # [ 0.489970] iommu: DMA domain TLB invalidation policy: lazy mode696second # [ 0.484016] ACPI: PCI: Interrupt link GSIC configured for IRQ 18697test # [ 0.491370] ACPI: bus type USB registered698second # [ 0.485016] ACPI: PCI: Interrupt link GSID configured for IRQ 19699test # [ 0.492234] usbcore: registered new interface driver usbfs700second # [ 0.486020] ACPI: PCI: Interrupt link GSIE configured for IRQ 20701test # [ 0.493194] usbcore: registered new interface driver hub702second # [ 0.487016] ACPI: PCI: Interrupt link GSIF configured for IRQ 21703test # [ 0.494197] usbcore: registered new device driver usb704second # [ 0.488019] ACPI: PCI: Interrupt link GSIG configured for IRQ 22705test # [ 0.495797] NetLabel: Initializing706second # [ 0.489016] ACPI: PCI: Interrupt link GSIH configured for IRQ 23707test # [ 0.496181] NetLabel: domain hash size = 128708test # [ 0.497096] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO709second # [ 0.490876] iommu: Default domain type: Translated710test # [ 0.498145] NetLabel: unlabeled traffic allowed by default711second # [ 0.491779] iommu: DMA domain TLB invalidation policy: lazy mode712test # [ 0.499082] PCI: Using ACPI for IRQ routing713second # [ 0.492220] ACPI: bus type USB registered714second # [ 0.493064] usbcore: registered new interface driver usbfs715second # [ 0.494048] usbcore: registered new interface driver hub716second # [ 0.495022] usbcore: registered new device driver usb717second # [ 0.496666] NetLabel: Initializing718second # [ 0.497008] NetLabel: domain hash size = 128719second # [ 0.497910] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO720second # [ 0.498963] NetLabel: unlabeled traffic allowed by default721second # [ 0.499909] PCI: Using ACPI for IRQ routing722test # [ 0.573580] pci 0000:00:01.0: vgaarb: setting as boot VGA device723test # [ 0.574173] pci 0000:00:01.0: vgaarb: bridge control possible724test # [ 0.574173] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none725test # [ 0.574180] vgaarb: loaded726test # [ 0.574971] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0727test # [ 0.575952] hpet0: 3 comparators, 64-bit 100.000000 MHz counter728second # [ 0.574423] pci 0000:00:01.0: vgaarb: setting as boot VGA device729second # [ 0.575000] pci 0000:00:01.0: vgaarb: bridge control possible730test # [ 0.580245] clocksource: Switched to clocksource kvm-clock731second # [ 0.575000] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none732second # [ 0.575006] vgaarb: loaded733test # [ 0.583214] VFS: Disk quotas dquot_6.6.0734second # [ 0.575781] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0735test # [ 0.584060] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)736second # [ 0.576005] hpet0: 3 comparators, 64-bit 100.000000 MHz counter737test # [ 0.585557] pnp: PnP ACPI init738test # [ 0.586422] ACPI: IRQ 4 override to edge(!), high(!)739test # [ 0.587531] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved740second # [ 0.580073] clocksource: Switched to clocksource kvm-clock741test # [ 0.589278] pnp: PnP ACPI: found 6 devices742second # [ 0.583052] VFS: Disk quotas dquot_6.6.0743second # [ 0.583906] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)744second # [ 0.585404] pnp: PnP ACPI init745second # [ 0.586235] ACPI: IRQ 4 override to edge(!), high(!)746second # [ 0.587390] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved747test # [ 0.596327] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns748second # [ 0.589117] pnp: PnP ACPI: found 6 devices749test # [ 0.598019] clocksource: Switched to clocksource acpi_pm750test # [ 0.599158] NET: Registered PF_INET protocol family751test # [ 0.600294] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)752second # [ 0.596161] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns753second # [ 0.597876] clocksource: Switched to clocksource acpi_pm754second # [ 0.599018] NET: Registered PF_INET protocol family755second # [ 0.600166] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)756test # [ 0.613166] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)757test # [ 0.614904] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)758test # [ 0.616425] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)759test # [ 0.617959] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)760test # [ 0.619400] TCP: Hash tables configured (established 8192 bind 8192)761test # [ 0.620686] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)762second # [ 0.612941] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)763test # [ 0.622194] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)764second # [ 0.614647] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)765test # [ 0.623482] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)766test # [ 0.624890] NET: Registered PF_UNIX/PF_LOCAL protocol family767second # [ 0.616176] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)768test # [ 0.626036] NET: Registered PF_XDP protocol family769second # [ 0.617730] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)770test # [ 0.627050] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]771second # [ 0.619173] TCP: Hash tables configured (established 8192 bind 8192)772test # [ 0.628269] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]773second # [ 0.620492] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)774test # [ 0.629475] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]775second # [ 0.621978] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)776test # [ 0.630802] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]777second # [ 0.623318] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)778test # [ 0.632133] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]779second # [ 0.624711] NET: Registered PF_UNIX/PF_LOCAL protocol family780test # [ 0.633452] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]781second # [ 0.625853] NET: Registered PF_XDP protocol family782test # [ 0.635287] ACPI: \_SB_.GSIA: Enabled at IRQ 16783second # [ 0.626853] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]784second # [ 0.628061] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]785test # [ 0.637354] ACPI: \_SB_.GSIB: Enabled at IRQ 17786second # [ 0.629306] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]787test # [ 0.639169] ACPI: \_SB_.GSIC: Enabled at IRQ 18788second # [ 0.630627] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]789second # [ 0.631945] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]790test # [ 0.640995] ACPI: \_SB_.GSID: Enabled at IRQ 19791second # [ 0.633268] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]792test # [ 0.642588] PCI: CLS 0 bytes, default 64793second # [ 0.635084] ACPI: \_SB_.GSIA: Enabled at IRQ 16794test # [ 0.643580] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns795second # [ 0.637152] ACPI: \_SB_.GSIB: Enabled at IRQ 17796test # [ 0.645597] Trying to unpack rootfs image as initramfs...797second # [ 0.638980] ACPI: \_SB_.GSIC: Enabled at IRQ 18798second # [ 0.640808] ACPI: \_SB_.GSID: Enabled at IRQ 19799second # [ 0.642454] PCI: CLS 0 bytes, default 64800second # [ 0.643454] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d3a52f6d, max_idle_ns: 440795275709 ns801second # [ 0.645451] Trying to unpack rootfs image as initramfs...802test # [ 0.681116] Initialise system trusted keyrings803test # [ 0.682215] workingset: timestamp_bits=40 max_order=18 bucket_order=0804second # [ 0.681661] Initialise system trusted keyrings805second # [ 0.685338] workingset: timestamp_bits=40 max_order=18 bucket_order=0806test # [ 0.699177] Key type asymmetric registered807test # [ 0.701812] Asymmetric key parser 'x509' registered808test # [ 0.702864] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)809test # [ 0.706909] io scheduler mq-deadline registered810second # [ 0.699981] Key type asymmetric registered811second # [ 0.700862] Asymmetric key parser 'x509' registered812test # [ 0.709808] io scheduler kyber registered813test # [ 0.712933] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled814second # [ 0.704356] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)815test # [ 0.714432] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A816second # [ 0.708322] io scheduler mq-deadline registered817second # [ 0.709232] io scheduler kyber registered818test # [ 0.720612] Linux agpgart interface v0.103819second # [ 0.712725] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled820test # [ 0.721557] ACPI: bus type drm_connector registered821second # [ 0.714216] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A822test # [ 0.726157] usbcore: registered new interface driver usbserial_generic823test # [ 0.727457] usbserial: USB Serial support registered for generic824second # [ 0.719698] Linux agpgart interface v0.103825second # [ 0.720619] ACPI: bus type drm_connector registered826test # [ 0.730809] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.827test # [ 0.730809] Please enable it if your BIOS has the CPPC option.828second # [ 0.723653] usbcore: registered new interface driver usbserial_generic829second # [ 0.724958] usbserial: USB Serial support registered for generic830test # [ 0.733456] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled831second # [ 0.728297] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.832second # [ 0.728297] Please enable it if your BIOS has the CPPC option.833test # [ 0.739021] drop_monitor: Initializing network drop monitor service834second # [ 0.730931] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled835test # [ 0.740416] NET: Registered PF_INET6 protocol family836test # [ 0.743176] Segment Routing with IPv6837second # [ 0.735403] drop_monitor: Initializing network drop monitor service838second # [ 0.736770] NET: Registered PF_INET6 protocol family839test # [ 0.745835] In-situ OAM (IOAM) with IPv6840test # [ 0.747004] IPI shorthand broadcast: enabled841second # [ 0.741683] Segment Routing with IPv6842second # [ 0.744323] In-situ OAM (IOAM) with IPv6843second # [ 0.745453] IPI shorthand broadcast: enabled844test # [ 0.754340] sched_clock: Marking stable (584020840, 169766865)->(832816040, -79028335)845test # [ 0.757864] registered taskstats version 1846test # [ 0.758933] Loading compiled-in X.509 certificates847second # [ 0.750747] sched_clock: Marking stable (580026966, 170250054)->(830559137, -80282117)848second # [ 0.756440] registered taskstats version 1849second # [ 0.757498] Loading compiled-in X.509 certificates850test # [ 0.773476] Demotion targets for Node 0: null851test # [ 0.776852] Key type .fscrypt registered852test # [ 0.777673] Key type fscrypt-provisioning registered853second # [ 0.772293] Demotion targets for Node 0: null854test # [ 0.781002] ima: No TPM chip found, activating TPM-bypass!855test # [ 0.782115] ima: Allocated hash algorithm: sha1856second # [ 0.775350] Key type .fscrypt registered857second # [ 0.776168] Key type fscrypt-provisioning registered858test # [ 0.784867] ima: No architecture policies found859test # [ 0.787804] PM: Magic number: 6:804:753860second # [ 0.779331] ima: No TPM chip found, activating TPM-bypass!861second # [ 0.780451] ima: Allocated hash algorithm: sha1862test # [ 0.789429] RAS: Correctable Errors collector initialized.863second # [ 0.783327] ima: No architecture policies found864second # [ 0.786292] PM: Magic number: 6:804:753865test # [ 0.796492] clk: Disabling unused clocks866second # [ 0.788005] RAS: Correctable Errors collector initialized.867test # [ 0.797347] PM: genpd: Disabling unused power domains868second # [ 0.797101] clk: Disabling unused clocks869second # [ 0.797998] PM: genpd: Disabling unused power domains870test # [ 0.903604] Freeing initrd memory: 29220K871test # [ 0.906573] Freeing unused decrypted memory: 2028K872second # [ 0.898649] Freeing initrd memory: 29216K873test # [ 0.909062] Freeing unused kernel image (initmem) memory: 3644K874second # [ 0.901362] Freeing unused decrypted memory: 2028K875test # [ 0.910327] Write protecting the kernel read-only data: 32768k876second # [ 0.903755] Freeing unused kernel image (initmem) memory: 3644K877test # [ 0.912219] Freeing unused kernel image (text/rodata gap) memory: 1216K878second # [ 0.905012] Write protecting the kernel read-only data: 32768k879test # [ 0.913895] Freeing unused kernel image (rodata/data gap) memory: 756K880second # [ 0.906915] Freeing unused kernel image (text/rodata gap) memory: 1216K881second # [ 0.908559] Freeing unused kernel image (rodata/data gap) memory: 756K882test # [ 0.945703] x86/mm: Checked W+X mappings: passed, no W+X pages found.883test # [ 0.946988] Run /init as init process884second # [ 0.940334] x86/mm: Checked W+X mappings: passed, no W+X pages found.885second # [ 0.941609] Run /init as init process886test # [ 0.954912] systemd[1]: Inserted module 'autofs4'887second # [ 0.949528] systemd[1]: Inserted module 'autofs4'888test # [ 0.967119] fuse: init (API version 7.45)889second # [ 0.961585] fuse: init (API version 7.45)890test # [ 0.971525] ACPI: \_SB_.GSIG: Enabled at IRQ 22891test # [ 0.974079] ACPI: \_SB_.GSIH: Enabled at IRQ 23892second # [ 0.966075] ACPI: \_SB_.GSIG: Enabled at IRQ 22893second # [ 0.968604] ACPI: \_SB_.GSIH: Enabled at IRQ 23894test # [ 0.977171] ACPI: \_SB_.GSIE: Enabled at IRQ 20895test # [ 0.979523] ACPI: \_SB_.GSIF: Enabled at IRQ 21896second # [ 0.971613] ACPI: \_SB_.GSIE: Enabled at IRQ 20897second # [ 0.973935] ACPI: \_SB_.GSIF: Enabled at IRQ 21898test # [ 1.003054] systemd[1]: Successfully made /usr/ read-only.899second # [ 0.997504] systemd[1]: Successfully made /usr/ read-only.900test # [ 1.339116] 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.344671] systemd[1]: Detected virtualization kvm.902test # [ 1.345853] systemd[1]: Detected architecture x86-64.903test # [ 1.346888] systemd[1]: Running in initrd.904second # [ 1.333598] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)905second # [ 1.339280] systemd[1]: Detected virtualization kvm.906test # [ 1.347948] systemd[1]: Initializing machine ID from random generator.907second # [ 1.340309] systemd[1]: Detected architecture x86-64.908test # [ 1.349293] systemd[1]: Hostname set to <test>.909second # [ 1.341351] systemd[1]: Running in initrd.910second # [ 1.342475] systemd[1]: Initializing machine ID from random generator.911second # [ 1.343819] systemd[1]: Hostname set to <second>.912test # [ 1.516138] systemd[1]: bpf-restrict-fs: LSM BPF program attached913second # [ 1.508561] systemd[1]: bpf-restrict-fs: LSM BPF program attached914test # [ 1.544156] systemd[1]: Queued start job for default target Initrd Default Target.915second # [ 1.536462] systemd[1]: Queued start job for default target Initrd Default Target.916test # [ 1.547906] systemd[1]: Created slice Slice /system/modprobe.917second # [ 1.540312] systemd[1]: Created slice Slice /system/modprobe.918test # [ 1.549226] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.919second # [ 1.541638] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.920test # [ 1.550831] systemd[1]: Expecting device /dev/disk/by-label/nixos...921second # [ 1.543222] systemd[1]: Expecting device /dev/disk/by-label/nixos...922test # [ 1.552107] systemd[1]: Reached target Path Units.923second # [ 1.544541] systemd[1]: Reached target Path Units.924test # [ 1.553117] systemd[1]: Reached target Slice Units.925test # [ 1.554138] systemd[1]: Reached target Swaps.926second # [ 1.545588] systemd[1]: Reached target Slice Units.927test # [ 1.555084] systemd[1]: Reached target Timer Units.928second # [ 1.546623] systemd[1]: Reached target Swaps.929second # [ 1.547563] systemd[1]: Reached target Timer Units.930test # [ 1.556180] systemd[1]: Listening on D-Bus System Message Bus Socket.931second # [ 1.548672] systemd[1]: Listening on D-Bus System Message Bus Socket.932test # [ 1.557549] systemd[1]: Listening on Journal Socket (/dev/log).933second # [ 1.550038] systemd[1]: Listening on Journal Socket (/dev/log).934test # [ 1.558924] systemd[1]: Listening on Journal Sockets.935second # [ 1.551396] systemd[1]: Listening on Journal Sockets.936test # [ 1.560051] systemd[1]: Listening on udev Control Socket.937second # [ 1.552532] systemd[1]: Listening on udev Control Socket.938test # [ 1.561209] systemd[1]: Listening on udev Kernel Socket.939test # [ 1.562315] systemd[1]: Reached target Socket Units.940second # [ 1.553704] systemd[1]: Listening on udev Kernel Socket.941second # [ 1.554819] systemd[1]: Reached target Socket Units.942test # [ 1.564018] systemd[1]: Starting Create List of Static Device Nodes...943second # [ 1.556517] systemd[1]: Starting Create List of Static Device Nodes...944test # [ 1.577951] systemd[1]: Starting Load Kernel Module 9pnet_virtio...945second # [ 1.570450] systemd[1]: Starting Load Kernel Module 9pnet_virtio...946second # [ 1.576369] systemd[1]: Starting Load Kernel Module configfs...947test # [ 1.586337] systemd[1]: Starting Load Kernel Module configfs...948second # [ 1.585580] systemd[1]: Starting Journal Service...949test # [ 1.595971] systemd[1]: Starting Journal Service...950second # [ 1.592973] systemd[1]: Starting Load Kernel Modules...951test # [ 1.605939] systemd[1]: Starting Load Kernel Modules...952second # [ 1.597559] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os953test # [ 1.610116] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os954test # [ 1.613248] netfs: FS-Cache loaded955second # [ 1.607429] systemd[1]: Starting Coldplug All udev Devices...956second # [ 1.609808] netfs: FS-Cache loaded957test # [ 1.621941] systemd[1]: Starting Coldplug All udev Devices...958test # [ 1.627291] 9pnet: Installing 9P2000 support959second # [ 1.622198] 9pnet: Installing 9P2000 support960second # [ 1.628344] systemd[1]: Finished Create List of Static Device Nodes.961test # [ 1.638135] systemd[1]: Finished Create List of Static Device Nodes.962test # [ 1.643157] systemd-journald[67]: Collecting audit messages is disabled.963second # [ 1.635953] systemd[1]: modprobe@configfs.service: Deactivated successfully.964second # [ 1.638358] systemd-journald[67]: Collecting audit messages is disabled.965test # [ 1.647374] systemd[1]: modprobe@configfs.service: Deactivated successfully.966second # [ 1.644828] systemd[1]: Finished Load Kernel Module configfs.967test # [ 1.654452] systemd[1]: Finished Load Kernel Module configfs.968second # [ 1.649635] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.969test # [ 1.659026] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.970second # [ 1.653740] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config971test # [ 1.663179] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.972test # [ 1.668241] systemd[1]: Finished Load Kernel Module 9pnet_virtio.973second # [ 1.660380] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev974second # [ 1.663354] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...975test # [ 1.671916] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev976test # [ 1.676350] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config977second # [ 1.679672] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.978test # [ 1.689882] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...979second # [ 1.687351] systemd[1]: Finished Load Kernel Module 9pnet_virtio.980test # [ 1.701989] systemd[1]: Finished Load Kernel Modules.981second # [ 1.696397] systemd[1]: Finished Load Kernel Modules.982test # [ 1.710954] systemd[1]: Starting Apply Kernel Variables...983second # [ 1.704774] systemd[1]: Starting Apply Kernel Variables...984test # [ 1.723946] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.985second # [ 1.715410] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.986second # [ 1.725448] systemd[1]: Starting Create Static Device Nodes in /dev...987test # [ 1.734947] systemd[1]: Starting Create Static Device Nodes in /dev...988second # [ 1.739465] systemd[1]: Finished Apply Kernel Variables.989test # [ 1.749243] systemd[1]: Finished Apply Kernel Variables.990test # [ 1.762509] systemd[1]: Finished Create Static Device Nodes in /dev.991second # [ 1.758003] systemd[1]: Finished Create Static Device Nodes in /dev.992test # [ 1.767109] systemd[1]: Reached target Preparation for Local File Systems.993test # [ 1.770877] systemd[1]: Reached target Local File Systems.994second # [ 1.762597] systemd[1]: Reached target Preparation for Local File Systems.995second # [ 1.766364] systemd[1]: Reached target Local File Systems.996test # [ 1.777971] systemd[1]: Starting Rule-based Manager for Device Events and Files...997test # [ 1.610875] systemd-modules-load[68]: Inserted module 'dm_mod'998second # [ 1.773473] systemd[1]: Starting Rule-based Manager for Device Events and Files...999test # [ 1.613180] systemd-modules-load[68]: Inserted module 'virtio_balloon'1000second # [ 1.605224] systemd-modules-load[68]: Inserted module 'dm_mod'1001test # [ 1.615363] systemd-modules-load[68]: Inserted module 'virtio_gpu'1002second # [ 1.607490] systemd-modules-load[68]: Inserted module 'virtio_balloon'1003second # [ 1.609366] systemd-modules-load[68]: Inserted module 'virtio_gpu'1004test # [ 1.791008] systemd[1]: Started Journal Service.1005second # [ 1.785486] systemd[1]: Started Journal Service.1006test # [ 1.639089] systemd[1]: Starting Create System Files and Directories...1007second # [ 1.631182] systemd[1]: Starting Create System Files and Directories...1008test # [ 1.660238] systemd-udevd[75]: Using default interface naming scheme 'v261'.1009test # [ 1.662162] systemd[1]: Finished Create System Files and Directories.1010second # [ 1.653947] systemd[1]: Finished Create System Files and Directories.1011second # [ 1.660332] systemd-udevd[75]: Using default interface naming scheme 'v261'.1012test # [ 1.686071] systemd[1]: Started Rule-based Manager for Device Events and Files.1013second # [ 1.679492] systemd[1]: Finished Coldplug All udev Devices.1014test # [ 1.689810] systemd[1]: Finished Coldplug All udev Devices.1015second # [ 1.681548] systemd[1]: Started Rule-based Manager for Device Events and Files.1016test # [ 1.690815] systemd[1]: Reached target System Initialization.1017test # [ 1.691870] systemd[1]: Reached target Basic System.1018second # [ 1.682767] systemd[1]: Reached target System Initialization.1019second # [ 1.683767] systemd[1]: Reached target Basic System.1020second # [ 2.037779] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121021test # [ 2.047421] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022test # [ 2.057290] virtio_blk virtio5: 1/0/0 default/read/poll queues1023second # [ 2.049814] virtio_blk virtio5: 1/0/0 default/read/poll queues1024second # [ 2.057993] serio: i8042 KBD port at 0x60,0x64 irq 11025test # [ 2.073434] ehci-pci 0000:00:1d.7: EHCI Host Controller1026test # [ 2.074262] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11027test # [ 2.077004] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001028test # [ 2.079582] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1029test # [ 2.083520] serio: i8042 KBD port at 0x60,0x64 irq 11030second # [ 2.074635] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1031second # [ 2.076074] serio: i8042 AUX port at 0x60,0x64 irq 121032test # [ 2.086810] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001033test # [ 2.087730] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181034second # [ 2.080293] ehci-pci 0000:00:1d.7: EHCI Host Controller1035second # [ 2.081079] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11036test # [ 2.090507] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11037test # [ 2.092791] usb usb1: Product: EHCI Host Controller1038second # [ 2.084498] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001039test # [ 2.093530] usb usb1: Manufacturer: Linux 6.18.45 ehci_hcd1040test # [ 2.094850] serio: i8042 AUX port at 0x60,0x64 irq 121041test # [ 2.095688] usb usb1: SerialNumber: 0000:00:1d.71042test # [ 2.097847] hub 1-0:1.0: USB hub found1043test # [ 2.098743] hub 1-0:1.0: 6 ports detected1044second # [ 2.092310] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001045test # [ 2.101454] uhci_hcd 0000:00:1d.0: UHCI Host Controller1046second # [ 2.093224] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181047test # [ 2.102266] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21048second # [ 2.095289] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11049second # [ 2.097485] usb usb1: Product: EHCI Host Controller1050second # [ 2.099209] usb usb1: Manufacturer: Linux 6.18.45 ehci_hcd1051second # [ 2.100285] usb usb1: SerialNumber: 0000:00:1d.71052second # [ 2.102056] hub 1-0:1.0: USB hub found1053second # [ 2.103778] hub 1-0:1.0: 6 ports detected1054test # [ 2.113523] uhci_hcd 0000:00:1d.0: detected 2 ports1055second # [ 2.106447] uhci_hcd 0000:00:1d.0: UHCI Host Controller1056second # [ 2.107234] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21057test # [ 2.119917] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001058second # [ 2.117639] uhci_hcd 0000:00:1d.0: detected 2 ports1059test # [ 2.129832] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181060test # [ 2.131051] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11061second # [ 2.124852] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001062second # [ 2.131009] SCSI subsystem initialized1063second # [ 2.132917] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181064test # [ 2.146619] usb usb2: Product: UHCI Host Controller1065second # [ 2.140845] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11066test # [ 2.152469] SCSI subsystem initialized1067test # [ 2.155802] usb usb2: Manufacturer: Linux 6.18.45 uhci_hcd1068test # [ 2.156626] usb usb2: SerialNumber: 0000:00:1d.01069second # [ 2.150896] usb usb2: Product: UHCI Host Controller1070second # [ 1.981893] systemd[1]: Starting Virtual Console Setup...1071test # [ 1.991135] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1072test # [ 1.997361] systemd[1]: Starting Virtual Console Setup...1073test # [ 2.168336] hub 2-0:1.0: USB hub found1074test # [ 2.000358] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1075second # [ 2.165833] usb usb2: Manufacturer: Linux 6.18.45 uhci_hcd1076second # [ 2.165835] usb usb2: SerialNumber: 0000:00:1d.01077second # [ 2.167676] hub 2-0:1.0: USB hub found1078second # [ 2.168911] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01079test # [ 2.180000] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01080second # [ 2.003135] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1081second # [ 2.174775] hub 2-0:1.0: 2 ports detected1082second # [ 2.177060] uhci_hcd 0000:00:1d.1: UHCI Host Controller1083test # [ 2.187558] hub 2-0:1.0: 2 ports detected1084second # [ 2.010674] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1085second # [ 2.177066] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31086second # [ 2.177082] uhci_hcd 0000:00:1d.1: detected 2 ports1087second # [ 2.177176] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201088test # [ 2.027540] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1089test # [ 2.029391] systemd[1]: Finished Virtual Console Setup.1090second # [ 2.195448] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181091second # [ 2.196685] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11092second # [ 2.028264] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1093test # [ 2.208340] uhci_hcd 0000:00:1d.1: UHCI Host Controller1094test # [ 2.209174] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31095second # [ 2.032523] systemd[1]: Finished Virtual Console Setup.1096test # [ 2.220887] uhci_hcd 0000:00:1d.1: detected 2 ports1097test # [ 2.221738] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201098test # [ 2.226854] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181099second # [ 2.218916] usb usb3: Product: UHCI Host Controller1100test # [ 2.228090] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11101second # [ 2.224413] usb usb3: Manufacturer: Linux 6.18.45 uhci_hcd1102second # [ 2.225226] usb usb3: SerialNumber: 0000:00:1d.11103test # [ 2.065226] systemd[1]: Found device /dev/disk/by-label/nixos.1104test # [ 2.066411] systemd[1]: Reached target Initrd Root Device.1105test # [ 2.237626] usb usb3: Product: UHCI Host Controller1106second # [ 2.229638] hub 3-0:1.0: USB hub found1107test # [ 2.068938] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1108second # [ 2.060802] systemd[1]: Found device /dev/disk/by-label/nixos.1109test # [ 2.239931] usb usb3: Manufacturer: Linux 6.18.45 uhci_hcd1110test # [ 2.240743] usb usb3: SerialNumber: 0000:00:1d.11111second # [ 2.066072] systemd[1]: Reached target Initrd Root Device.1112test # [ 2.245738] hub 3-0:1.0: USB hub found1113second # [ 2.067046] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1114test # [ 2.246956] hub 3-0:1.0: 2 ports detected1115second # [ 2.238540] hub 3-0:1.0: 2 ports detected1116second # [ 2.241234] uhci_hcd 0000:00:1d.2: UHCI Host Controller1117test # [ 2.251828] uhci_hcd 0000:00:1d.2: UHCI Host Controller1118second # [ 2.244002] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41119test # [ 2.252620] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41120second # [ 2.250406] uhci_hcd 0000:00:1d.2: detected 2 ports1121test # [ 2.260215] uhci_hcd 0000:00:1d.2: detected 2 ports1122second # [ 2.256630] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401123test # [ 2.265697] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401124test # [ 2.098198] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1125second # [ 2.260175] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181126test # [ 2.269210] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181127second # [ 2.092690] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1128test # [ 2.273047] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11129second # [ 2.265312] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11130test # [ 2.105988] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1131second # [ 2.098235] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1132test # [ 2.278370] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1133test # [ 2.279578] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1134second # [ 2.270995] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1135second # [ 2.272222] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1136test # [ 2.281195] usb usb4: Product: UHCI Host Controller1137test # [ 2.282124] usb usb4: Manufacturer: Linux 6.18.45 uhci_hcd1138second # [ 2.273668] usb usb4: Product: UHCI Host Controller1139test # [ 2.283138] usb usb4: SerialNumber: 0000:00:1d.21140second # [ 2.274640] usb usb4: Manufacturer: Linux 6.18.45 uhci_hcd1141test # [ 2.284142] ahci 0000:00:1f.2: flags: 64bit ncq only1142second # [ 2.275666] usb usb4: SerialNumber: 0000:00:1d.21143second # [ 2.276571] ahci 0000:00:1f.2: flags: 64bit ncq only1144test # [ 2.285508] hub 4-0:1.0: USB hub found1145second # [ 2.277834] hub 4-0:1.0: USB hub found1146test # [ 2.286477] hub 4-0:1.0: 2 ports detected1147second # [ 2.278809] hub 4-0:1.0: 2 ports detected1148second # [ 2.298339] scsi host0: ahci1149test # [ 2.308861] scsi host0: ahci1150second # [ 2.300344] scsi host1: ahci1151test # [ 2.309566] scsi host1: ahci1152second # [ 2.301960] scsi host2: ahci1153test # [ 2.312213] scsi host2: ahci1154test # [ 2.314371] scsi host3: ahci1155second # [ 2.306180] scsi host3: ahci1156second # [ 2.308862] scsi host4: ahci1157test # [ 2.320894] scsi host4: ahci1158second # [ 2.313313] scsi host5: ahci1159test # [ 2.323148] scsi host5: ahci1160second # [ 2.313896] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11161test # [ 2.323733] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11162test # [ 2.326682] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11163second # [ 2.319059] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11164test # [ 2.328062] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11165second # [ 2.320387] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11166test # [ 2.329365] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11167second # [ 2.321686] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11168test # [ 2.330664] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11169second # [ 2.322981] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11170test # [ 2.331992] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11171second # [ 2.324302] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11172test # [ 2.340864] usb 1-1: new high-speed USB device number 2 using ehci-pci1173second # [ 2.341313] usb 1-1: new high-speed USB device number 2 using ehci-pci1174test # [ 2.470635] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001175test # [ 2.471861] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101176test # [ 2.473147] usb 1-1: Product: QEMU USB Tablet1177test # [ 2.473946] usb 1-1: Manufacturer: QEMU1178test # [ 2.474557] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11179second # [ 2.471165] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001180second # [ 2.472389] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101181second # [ 2.473704] usb 1-1: Product: QEMU USB Tablet1182second # [ 2.474501] usb 1-1: Manufacturer: QEMU1183test # [ 2.483471] hid: raw HID events driver (C) Jiri Kosina1184second # [ 2.475110] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11185second # [ 2.483761] hid: raw HID events driver (C) Jiri Kosina1186test # [ 2.462167] systemd[1]: Mounting /sysroot...1187second # [ 2.454481] systemd[1]: Mounting /sysroot...1188test # [ 2.644467] ata2: SATA link down (SStatus 0 SControl 300)1189test # [ 2.645470] ata6: SATA link down (SStatus 0 SControl 300)1190second # [ 2.636986] ata6: SATA link down (SStatus 0 SControl 300)1191second # [ 2.637993] ata1: SATA link down (SStatus 0 SControl 300)1192test # [ 2.647144] ata1: SATA link down (SStatus 0 SControl 300)1193second # [ 2.639620] ata5: SATA link down (SStatus 0 SControl 300)1194test # [ 2.648243] ata4: SATA link down (SStatus 0 SControl 300)1195second # [ 2.640695] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1196test # [ 2.649326] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1197second # [ 2.641782] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001198test # [ 2.650404] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001199second # [ 2.642712] ata3.00: applying bridge limits1200test # [ 2.651343] ata3.00: applying bridge limits1201second # [ 2.643613] ata4: SATA link down (SStatus 0 SControl 300)1202test # [ 2.652244] ata5: SATA link down (SStatus 0 SControl 300)1203test # [ 2.653255] ata3.00: configured for UDMA/1001204second # [ 2.644672] ata2: SATA link down (SStatus 0 SControl 300)1205second # [ 2.645692] ata3.00: configured for UDMA/1001206test # [ 2.654312] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51207second # [ 2.646762] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51208test # [ 2.697027] usbcore: registered new interface driver usbhid1209second # [ 2.690457] usbcore: registered new interface driver usbhid1210second # [ 2.691313] usbhid: USB HID core driver1211test # [ 2.701454] usbhid: USB HID core driver1212second # [ 2.704954] 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.715920] 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/input21214second # [ 2.709079] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01215test # [ 2.718927] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01216test # [ 2.721326] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1217second # [ 2.717510] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1218test # [ 2.726060] EXT4-fs (vda): mounted filesystem 7128c6dd-50f2-4348-840b-32d6d09e16c0 r/w with ordered data mode. Quota mode: none.1219second # [ 2.719903] EXT4-fs (vda): mounted filesystem 9f2de449-5fec-4ca4-8226-775a443d453f r/w with ordered data mode. Quota mode: none.1220test # [ 2.561720] systemd[1]: Mounted /sysroot.1221test # [ 2.563566] systemd[1]: Reached target Initrd Root File System.1222second # [ 2.555522] systemd[1]: Mounted /sysroot.1223test # [ 2.734418] cdrom: Uniform CD-ROM driver Revision: 3.201224second # [ 2.557939] systemd[1]: Reached target Initrd Root File System.1225test # [ 2.569075] systemd[1]: Starting Mountpoints Configured in the Real Root...1226second # [ 2.560229] systemd[1]: Starting Mountpoints Configured in the Real Root...1227second # [ 2.734151] cdrom: Uniform CD-ROM driver Revision: 3.201228second # [ 2.572534] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload.1229test # [ 2.582099] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.1230second # [ 2.576435] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)...1231test # [ 2.586075] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...1232second # [ 2.578134] systemd[1]: Reloading...1233test # [ 2.587861] systemd[1]: Reloading...1234second # [ 2.632289] systemd[1]: Reloading finished in 56 ms.1235test # [ 2.645757] systemd[1]: Reloading finished in 59 ms.1236second # [ 2.642111] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace...1237second # [ 2.645957] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace...1238test # [ 2.656095] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...1239test # [ 2.658455] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...1240second # [ 2.650312] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1241second # [ 2.653180] systemd[1]: Finished Mountpoints Configured in the Real Root.1242test # [ 2.662301] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1243second # [ 2.654286] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1244second # [ 2.655548] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1245test # [ 2.665917] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1246test # [ 2.667222] systemd[1]: Finished Mountpoints Configured in the Real Root.1247test # [ 2.668481] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1248test # [ 3.463085] systemd[1]: Mounting /sysroot/nix/.ro-store...1249second # [ 3.455087] systemd[1]: Mounting /sysroot/nix/.ro-store...1250test # [ 3.465847] systemd[1]: Mounting /sysroot/nix/.rw-store...1251second # [ 3.458086] systemd[1]: Mounting /sysroot/nix/.rw-store...1252test # [ 3.470693] systemd[1]: Mounting /sysroot/run...1253second # [ 3.462142] systemd[1]: Mounting /sysroot/run...1254test # [ 3.472503] systemd[1]: Mounting /sysroot/tmp/shared...1255second # [ 3.465085] systemd[1]: Mounting /sysroot/tmp/shared...1256test # [ 3.479150] systemd[1]: Mounting /sysroot/tmp/xchg...1257second # [ 3.471161] systemd[1]: Mounting /sysroot/tmp/xchg...1258test # [ 3.665564] 9p: Installing v9fs 9p2000 file system support1259second # [ 3.658758] 9p: Installing v9fs 9p2000 file system support1260test # [ 3.500917] systemd[1]: Mounted /sysroot/run.1261second # [ 3.493860] systemd[1]: Mounted /sysroot/nix/.rw-store.1262test # [ 3.505947] systemd[1]: Mounted /sysroot/nix/.ro-store.1263second # [ 3.499093] systemd[1]: Starting rw-sysroot-nix-store.service...1264test # [ 3.511136] systemd[1]: Mounted /sysroot/nix/.rw-store.1265test # [ 3.512187] systemd[1]: Mounted /sysroot/tmp/shared.1266test # [ 3.513456] systemd[1]: Mounted /sysroot/tmp/xchg.1267second # [ 3.504912] systemd[1]: Mounted /sysroot/nix/.ro-store.1268second # [ 3.507111] systemd[1]: Mounted /sysroot/run.1269second # [ 3.507973] systemd[1]: Mounted /sysroot/tmp/shared.1270test # [ 3.516929] systemd[1]: Starting rw-sysroot-nix-store.service...1271second # [ 3.508962] systemd[1]: Mounted /sysroot/tmp/xchg.1272second # [ 3.516177] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1273test # [ 3.526222] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1274second # [ 3.518154] systemd[1]: Finished rw-sysroot-nix-store.service.1275test # [ 3.528185] systemd[1]: Finished rw-sysroot-nix-store.service.1276second # [ 3.520491] systemd[1]: Mounting /sysroot/nix/store...1277test # [ 3.530608] systemd[1]: Mounting /sysroot/nix/store...1278second # [ 3.536148] systemd[1]: Mounted /sysroot/nix/store.1279second # [ 3.537418] systemd[1]: Reached target Initrd File Systems.1280test # [ 3.546971] systemd[1]: Mounted /sysroot/nix/store.1281test # [ 3.548459] systemd[1]: Reached target Initrd File Systems.1282second # [ 3.540646] systemd[1]: Starting Find NixOS closure...1283test # [ 3.550353] systemd[1]: Starting Find NixOS closure...1284second # [ 3.542089] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1285test # [ 3.554257] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1286second # [ 3.557241] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1287test # [ 3.572181] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1288second # [ 3.563632] systemd[1]: Finished Find NixOS closure.1289second # [ 3.565877] systemd[1]: Reached target Initrd Default Target.1290test # [ 3.576431] systemd[1]: Finished Find NixOS closure.1291second # [ 3.567233] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1292test # [ 3.578271] systemd[1]: Reached target Initrd Default Target.1293test # [ 3.580252] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1294second # [ 3.580317] systemd[1]: Stopped target Initrd Default Target.1295second # [ 3.581428] systemd[1]: Stopped target Basic System.1296second # [ 3.582419] systemd[1]: Stopped target Initrd Root Device.1297second # [ 3.583460] systemd[1]: Stopped target Path Units.1298test # [ 3.592552] systemd[1]: Stopped target Initrd Default Target.1299second # [ 3.584427] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1300test # [ 3.594386] systemd[1]: Stopped target Basic System.1301second # [ 3.585846] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1302test # [ 3.595732] systemd[1]: Stopped target Initrd Root Device.1303second # [ 3.587613] systemd[1]: Stopped target Slice Units.1304test # [ 3.597222] systemd[1]: Stopped target Path Units.1305second # [ 3.589196] systemd[1]: Stopped target Socket Units.1306test # [ 3.599159] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1307second # [ 3.591146] systemd[1]: Stopped target System Initialization.1308test # [ 3.600568] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1309second # [ 3.592236] systemd[1]: Stopped target Swaps.1310second # [ 3.593213] systemd[1]: Stopped target Timer Units.1311test # [ 3.602225] systemd[1]: Stopped target Slice Units.1312second # [ 3.594198] systemd[1]: dbus.socket: Deactivated successfully.1313test # [ 3.603301] systemd[1]: Stopped target Socket Units.1314second # [ 3.595670] systemd[1]: Closed D-Bus System Message Bus Socket.1315test # [ 3.604698] systemd[1]: Stopped target System Initialization.1316test # [ 3.606377] systemd[1]: Stopped target Swaps.1317second # [ 3.597185] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1318second # [ 3.598551] systemd[1]: Stopped Find NixOS closure.1319test # [ 3.607942] systemd[1]: Stopped target Timer Units.1320test # [ 3.609260] systemd[1]: dbus.socket: Deactivated successfully.1321second # [ 3.599937] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1322test # [ 3.611136] systemd[1]: Closed D-Bus System Message Bus Socket.1323second # [ 3.602186] systemd[1]: Starting rw-sysroot-nix-store.service...1324second # [ 3.603518] systemd[1]: systemd-sysctl.service: Deactivated successfully.1325test # [ 3.612369] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1326second # [ 3.605184] systemd[1]: Stopped Apply Kernel Variables.1327test # [ 3.614262] systemd[1]: Stopped Find NixOS closure.1328second # [ 3.606419] systemd[1]: systemd-modules-load.service: Deactivated successfully.1329test # [ 3.616176] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1330second # [ 3.608176] systemd[1]: Stopped Load Kernel Modules.1331test # [ 3.618250] systemd[1]: Starting rw-sysroot-nix-store.service...1332second # [ 3.610180] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1333test # [ 3.619394] systemd[1]: systemd-sysctl.service: Deactivated successfully.1334second # [ 3.611577] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1335test # [ 3.621130] systemd[1]: Stopped Apply Kernel Variables.1336second # [ 3.612976] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1337test # [ 3.622501] systemd[1]: systemd-modules-load.service: Deactivated successfully.1338second # [ 3.614329] systemd[1]: Stopped Create System Files and Directories.1339test # [ 3.624312] systemd[1]: Stopped Load Kernel Modules.1340second # [ 3.615493] systemd[1]: Stopped target Local File Systems.1341second # [ 3.616966] systemd[1]: Stopped target Preparation for Local File Systems.1342test # [ 3.626206] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1343test # [ 3.627827] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1344second # [ 3.619861] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1345test # [ 3.629313] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1346second # [ 3.621186] systemd[1]: Stopped Coldplug All udev Devices.1347second # [ 3.622221] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1348test # [ 3.631793] systemd[1]: Stopped Create System Files and Directories.1349second # [ 3.623566] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1350test # [ 3.633119] systemd[1]: Stopped target Local File Systems.1351test # [ 3.634258] systemd[1]: Stopped target Preparation for Local File Systems.1352second # [ 3.626164] systemd[1]: Stopped Virtual Console Setup.1353test # [ 3.635576] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1354second # [ 3.629703] systemd[1]: initrd-cleanup.service: Deactivated successfully.1355test # [ 3.640451] systemd[1]: Stopped Coldplug All udev Devices.1356test # [ 3.641531] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1357second # [ 3.634581] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1358test # [ 3.642989] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1359test # [ 3.645435] systemd[1]: Stopped Virtual Console Setup.1360second # [ 3.640773] systemd[1]: systemd-udevd.service: Deactivated successfully.1361second # [ 3.642295] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1362test # [ 3.651527] systemd[1]: initrd-cleanup.service: Deactivated successfully.1363second # [ 3.644186] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1364test # [ 3.654469] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1365second # [ 3.646131] systemd[1]: Finished rw-sysroot-nix-store.service.1366second # [ 3.648186] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1367test # [ 3.657366] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1368second # [ 3.649515] systemd[1]: Closed udev Control Socket.1369test # [ 3.659908] systemd[1]: Finished rw-sysroot-nix-store.service.1370second # [ 3.651447] systemd[1]: Starting Cleanup udev Database...1371test # [ 3.661593] systemd[1]: systemd-udevd.service: Deactivated successfully.1372second # [ 3.653191] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1373test # [ 3.663484] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1374second # [ 3.654583] systemd[1]: Stopped Create Static Device Nodes in /dev.1375second # [ 3.655777] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1376test # [ 3.667127] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1377second # [ 3.658185] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1378test # [ 3.668469] systemd[1]: Closed udev Control Socket.1379second # [ 3.659485] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1380second # [ 3.660735] systemd[1]: Stopped Create List of Static Device Nodes.1381test # [ 3.670197] systemd[1]: Starting Cleanup udev Database...1382test # [ 3.672124] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1383test # [ 3.674143] systemd[1]: Stopped Create Static Device Nodes in /dev.1384test # [ 3.675316] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1385test # [ 3.676765] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1386test # [ 3.679205] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1387test # [ 3.680461] systemd[1]: Stopped Create List of Static Device Nodes.1388second # [ 3.671369] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1389second # [ 3.673432] systemd[1]: Finished Cleanup udev Database.1390second # [ 3.674961] systemd[1]: Reached target Switch Root.1391second # [ 3.677104] systemd[1]: Starting NixOS Activation...1392test # [ 3.691417] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1393test # [ 3.694081] systemd[1]: Finished Cleanup udev Database.1394test # [ 3.695171] systemd[1]: Reached target Switch Root.1395test # [ 3.696964] systemd[1]: Starting NixOS Activation...1396second # [ 3.759075] initrd-nixos-activation-start[194]: booting system configuration /nix/store/bxssfc18jb6if0y0sb0fvgiaklzmk3np-nixos-system-second-test1397test # [ 3.779187] initrd-nixos-activation-start[192]: booting system configuration /nix/store/g64n1mz2pkrifyixrpwdhipg01gjpg44-nixos-system-test-test1398second # [ 3.791617] initrd-nixos-activation-start[194]: running activation script...1399test # [ 3.812302] initrd-nixos-activation-start[192]: running activation script...1400second # [ 3.986293] initrd-nixos-activation-start[217]: setting up /etc...1401test # [ 4.003550] initrd-nixos-activation-start[215]: setting up /etc...1402second # [ 4.091587] initrd-nixos-activation-start[217]: setting up age secrets...1403test # [ 4.112270] initrd-nixos-activation-start[215]: setting up age secrets...1404second # [ 4.186390] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1405second # [ 4.188945] systemd[1]: Finished NixOS Activation.1406second # [ 4.189980] systemd[1]: Starting Switch Root...1407second # [ 4.200977] systemd[1]: Switching root.1408test # [ 4.241645] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1409test # [ 4.243483] systemd[1]: Finished NixOS Activation.1410test # [ 4.245501] systemd[1]: Starting Switch Root...1411test # [ 4.255263] systemd[1]: Switching root.1412second # [ 4.496807] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1413test # [ 4.552344] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1414second # [ 4.560952] NET: Registered PF_VSOCK protocol family1415test # [ 4.615814] NET: Registered PF_VSOCK protocol family1416second # [ 4.916788] 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)1417second # [ 4.920951] systemd[1]: Detected virtualization kvm.1418second # [ 4.921749] systemd[1]: Detected architecture x86-64.1419second # [ 4.922572] systemd[1]: Detected first boot.1420second # [ 4.924409] systemd[1]: Initializing machine ID from random generator.1421test # [ 4.973144] 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)1422test # [ 4.977270] systemd[1]: Detected virtualization kvm.1423test # [ 4.978053] systemd[1]: Detected architecture x86-64.1424test # [ 4.978859] systemd[1]: Detected first boot.1425test # [ 4.980690] systemd[1]: Initializing machine ID from random generator.1426second # [ 5.108700] systemd[1]: bpf-restrict-fs: LSM BPF program attached1427test # [ 5.164280] systemd[1]: bpf-restrict-fs: LSM BPF program attached1428second # [ 5.178052] systemd[1]: Applying preset policy.1429test # [ 5.233555] systemd[1]: Applying preset policy.1430second # [ 5.433486] systemd[1]: Populated /etc with preset unit settings.1431test # [ 5.494831] systemd[1]: Populated /etc with preset unit settings.1432second # [ 5.674485] systemd[1]: initrd-switch-root.service: Deactivated successfully.1433second # [ 5.676055] systemd[1]: Stopped initrd-switch-root.service.1434second # [ 5.678416] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1435second # [ 5.680453] systemd[1]: Created slice Slice /system/getty.1436second # [ 5.681765] systemd[1]: Created slice User and Session Slice.1437second # [ 5.682770] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1438second # [ 5.684083] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1439second # [ 5.685315] systemd[1]: Expecting device /dev/hvc0...1440second # [ 5.693853] systemd[1]: Expecting device /dev/ttyS0...1441second # [ 5.694733] systemd[1]: Reached target Local Encrypted Volumes.1442second # [ 5.695681] systemd[1]: Stopped target initrd-fs.target.1443second # [ 5.696537] systemd[1]: Stopped target initrd-root-fs.target.1444second # [ 5.697459] systemd[1]: Stopped target initrd-switch-root.target.1445second # [ 5.698448] systemd[1]: Reached target Virtual Machines and Containers.1446second # [ 5.699490] systemd[1]: Reached target Path Units.1447second # [ 5.700319] systemd[1]: Reached target Remote File Systems.1448second # [ 5.701204] systemd[1]: Reached target Slice Units.1449second # [ 5.702038] systemd[1]: Reached target Swaps.1450second # [ 5.703961] systemd[1]: Listening on Query the User Interactively for a Password.1451second # [ 5.706393] systemd[1]: Listening on Process Core Dump Socket.1452second # [ 5.708241] systemd[1]: Listening on Credential Encryption/Decryption.1453second # [ 5.710189] systemd[1]: Listening on Factory Reset Management.1454second # [ 5.711224] systemd[1]: Listening on Hostname Service Socket.1455second # [ 5.713742] systemd[1]: Starting Journal Log Access Socket...1456second # [ 5.715143] systemd[1]: Listening on Journal Audit Socket.1457second # [ 5.717399] systemd[1]: Listening on Console Output Muting Service Socket.1458second # [ 5.718596] systemd[1]: Listening on Network Management Metrics Varlink Socket.1459second # [ 5.719907] systemd[1]: Listening on Network Management Varlink Socket.1460second # [ 5.721048] systemd[1]: Listening on Network Management Netlink Socket.1461second # [ 5.722210] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1462second # [ 5.723558] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1463second # [ 5.724985] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1464second # [ 5.729711] systemd[1]: Listening on Disk Repartitioning Service Socket.1465second # [ 5.730849] systemd[1]: Listening on Resolve Monitor Varlink Socket.1466second # [ 5.731939] systemd[1]: Listening on Resolve Service Varlink Socket.1467second # [ 5.733036] systemd[1]: Listening on udev Control Socket.1468second # [ 5.734022] systemd[1]: Listening on udev Varlink Socket.1469test # [ 5.742869] systemd[1]: initrd-switch-root.service: Deactivated successfully.1470test # [ 5.744430] systemd[1]: Stopped initrd-switch-root.service.1471second # [ 5.736362] systemd[1]: Mounting Huge Pages File System...1472test # [ 5.746727] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1473second # [ 5.739330] systemd[1]: Mounting POSIX Message Queue File System...1474test # [ 5.748849] systemd[1]: Created slice Slice /system/getty.1475test # [ 5.750179] systemd[1]: Created slice User and Session Slice.1476test # [ 5.751197] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1477test # [ 5.752504] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1478second # [ 5.744225] systemd[1]: Mounting Kernel Debug File System...1479second # [ 5.748527] systemd[1]: Mounting Kernel Trace File System...1480second # [ 5.751924] systemd[1]: Starting Create List of Static Device Nodes...1481test # [ 5.753714] systemd[1]: Expecting device /dev/hvc0...1482test # [ 5.762297] systemd[1]: Expecting device /dev/ttyS0...1483test # [ 5.763179] systemd[1]: Reached target Local Encrypted Volumes.1484test # [ 5.764122] systemd[1]: Stopped target initrd-fs.target.1485test # [ 5.765002] systemd[1]: Stopped target initrd-root-fs.target.1486second # [ 5.756462] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1487test # [ 5.765925] systemd[1]: Stopped target initrd-switch-root.target.1488test # [ 5.766924] systemd[1]: Reached target Virtual Machines and Containers.1489test # [ 5.767973] systemd[1]: Reached target Path Units.1490test # [ 5.768802] systemd[1]: Reached target Remote File Systems.1491test # [ 5.769693] systemd[1]: Reached target Slice Units.1492test # [ 5.770535] systemd[1]: Reached target Swaps.1493test # [ 5.772593] systemd[1]: Listening on Query the User Interactively for a Password.1494test # [ 5.775164] systemd[1]: Listening on Process Core Dump Socket.1495test # [ 5.777104] systemd[1]: Listening on Credential Encryption/Decryption.1496test # [ 5.779107] systemd[1]: Listening on Factory Reset Management.1497test # [ 5.780139] systemd[1]: Listening on Hostname Service Socket.1498second # [ 5.771877] systemd[1]: Starting Load Kernel Module configfs...1499test # [ 5.782952] systemd[1]: Starting Journal Log Access Socket...1500second # [ 5.774892] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1501test # [ 5.784257] systemd[1]: Listening on Journal Audit Socket.1502test # [ 5.786512] systemd[1]: Listening on Console Output Muting Service Socket.1503test # [ 5.787721] systemd[1]: Listening on Network Management Metrics Varlink Socket.1504test # [ 5.789086] systemd[1]: Listening on Network Management Varlink Socket.1505second # [ 5.780937] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1506test # [ 5.790238] systemd[1]: Listening on Network Management Netlink Socket.1507test # [ 5.791407] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1508second # [ 5.783056] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1509test # [ 5.792748] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1510test # [ 5.794216] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1511test # [ 5.799135] systemd[1]: Listening on Disk Repartitioning Service Socket.1512second # [ 5.791612] systemd[1]: Mounting FUSE Control File System...1513test # [ 5.800284] systemd[1]: Listening on Resolve Monitor Varlink Socket.1514test # [ 5.801380] systemd[1]: Listening on Resolve Service Varlink Socket.1515test # [ 5.802478] systemd[1]: Listening on udev Control Socket.1516second # [ 5.792796] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671517test # [ 5.803468] systemd[1]: Listening on udev Varlink Socket.1518test # [ 5.805860] systemd[1]: Mounting Huge Pages File System...1519test # [ 5.808847] systemd[1]: Mounting POSIX Message Queue File System...1520second # [ 5.801326] systemd[1]: Starting Journal Service...1521test # [ 5.813715] systemd[1]: Mounting Kernel Debug File System...1522second # [ 5.808037] systemd[1]: Starting Load Kernel Modules...1523test # [ 5.818137] systemd[1]: Mounting Kernel Trace File System...1524test # [ 5.825137] systemd[1]: Starting Create List of Static Device Nodes...1525test # [ 5.826696] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1526second # [ 5.820714] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1527test # [ 5.834514] systemd[1]: Starting Load Kernel Module configfs...1528test # [ 5.835706] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1529second # [ 5.831393] systemd[1]: Starting Remount Root and Kernel File Systems...1530test # [ 5.839881] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1531second # [ 5.837166] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1532test # [ 5.848173] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1533second # [ 5.843042] systemd-journald[320]: Collecting audit messages is enabled.1534second # [ 5.846336] systemd[1]: Starting Coldplug All udev Devices...1535second # [ 5.862344] EXT4-fs (vda): re-mounted 9f2de449-5fec-4ca4-8226-775a443d453f.1536second # [ 5.866231] systemd[1]: Listening on Journal Log Access Socket.1537test # [ 5.878098] systemd[1]: Mounting FUSE Control File System...1538second # [ 5.871486] loop: module loaded1539second # [ 5.875687] systemd[1]: Mounted Huge Pages File System.1540test # [ 5.882915] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671541second # [ 5.879580] systemd[1]: Mounted POSIX Message Queue File System.1542second # [ 5.712200] systemd[1]: Queued start job for default target Multi-User System.1543second # [ 5.714489] systemd[1]: systemd-journald.service: Deactivated successfully.1544test # [ 5.894197] systemd[1]: Starting Journal Service...1545second # [ 5.885921] systemd[1]: Started Journal Service.1546second # [ 5.719140] systemd-modules-load[321]: Module 'ctr' is built in1547second # [ 5.720474] systemd-modules-load[321]: Inserted module 'loop'1548test # [ 5.900104] systemd[1]: Starting Load Kernel Modules...1549second # [ 5.723675] systemd[1]: Mounted Kernel Debug File System.1550second # [ 5.725422] systemd[1]: Mounted Kernel Trace File System.1551second # [ 5.727959] systemd[1]: Finished Create List of Static Device Nodes.1552test # [ 5.908962] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1553second # [ 5.730738] systemd[1]: modprobe@configfs.service: Deactivated successfully.1554second # [ 5.733752] systemd[1]: Finished Load Kernel Module configfs.1555second # [ 5.739067] systemd[1]: Mounted FUSE Control File System.1556second # [ 5.740207] systemd[1]: Finished Load Kernel Modules.1557test # [ 5.919289] systemd[1]: Starting Remount Root and Kernel File Systems...1558second # [ 5.741382] systemd[1]: Finished Remount Root and Kernel File Systems.1559test # [ 5.923161] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1560test # [ 5.935018] systemd[1]: Starting Coldplug All udev Devices...1561second # [ 5.757422] systemd[1]: Listening on Disk Image Download Service Socket.1562second # [ 5.760639] systemd[1]: Mounting Kernel Configuration File System...1563test # [ 5.940504] systemd-journald[339]: Collecting audit messages is enabled.1564second # [ 5.765578] systemd[1]: Starting Firewall...1565second # [ 5.767799] systemd-oomd[323]: No swap; memory pressure usage will be degraded1566test # [ 5.954367] systemd[1]: Listening on Journal Log Access Socket.1567test # [ 5.956677] loop: module loaded1568second # [ 5.778736] systemd[1]: Starting Flush Journal to Persistent Storage...1569second # [ 5.779907] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1570test # [ 5.963473] systemd[1]: Mounted Huge Pages File System.1571second # [ 5.787661] systemd[1]: Starting Load/Save OS Random Seed...1572test # [ 5.966846] EXT4-fs (vda): re-mounted 7128c6dd-50f2-4348-840b-32d6d09e16c0.1573test # [ 5.970012] systemd[1]: Mounted POSIX Message Queue File System.1574test # [ 5.973412] systemd[1]: Mounted Kernel Debug File System.1575test # [ 5.978293] systemd[1]: Mounted Kernel Trace File System.1576second # [ 5.802005] systemd[1]: Starting Apply Kernel Variables...1577test # [ 5.982371] systemd[1]: Started Journal Service.1578test # [ 5.813579] systemd[1]: Queued start job for default target Multi-User System.1579test # [ 5.817360] systemd[1]: systemd-journald.service: Deactivated successfully.1580test # [ 5.819903] systemd-modules-load[340]: Module 'ctr' is built in1581test # [ 5.824833] systemd-modules-load[340]: Inserted module 'loop'1582second # [ 5.817127] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1583test # [ 5.826339] systemd[1]: Finished Create List of Static Device Nodes.1584second # [ 5.818436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1585test # [ 5.828299] systemd[1]: modprobe@configfs.service: Deactivated successfully.1586test # [ 5.831413] systemd[1]: Finished Load Kernel Module configfs.1587test # [ 5.833431] systemd[1]: Mounted FUSE Control File System.1588second # [ 5.824702] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1589second # [ 5.999295] systemd-journald[320]: Received client request to flush runtime journal.1590test # [ 5.840121] systemd[1]: Finished Load Kernel Modules.1591test # [ 5.842251] systemd[1]: Finished Remount Root and Kernel File Systems.1592test # [ 5.853676] systemd[1]: Listening on Disk Image Download Service Socket.1593test # [ 5.855610] systemd-oomd[342]: No swap; memory pressure usage will be degraded1594test # [ 5.860875] systemd[1]: Mounting Kernel Configuration File System...1595test # [ 5.863105] systemd[1]: Starting Firewall...1596test # [ 5.869902] systemd[1]: Starting Flush Journal to Persistent Storage...1597test # [ 5.871167] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1598test # [ 5.878708] systemd[1]: Starting Load/Save OS Random Seed...1599test # [ 5.893297] systemd[1]: Starting Apply Kernel Variables...1600test # [ 5.908889] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1601test # [ 5.910511] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1602test # [ 5.916613] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1603test # [ 6.103227] systemd-journald[339]: Received client request to flush runtime journal.1604second # [ 6.017476] systemd[1]: Mounted Kernel Configuration File System.1605second # [ 6.020359] systemd[1]: Finished Load/Save OS Random Seed.1606second # [ 6.022798] systemd[1]: Reached target First Boot Complete.1607second # [ 6.025349] systemd[1]: Finished Apply Kernel Variables.1608second # [ 6.029351] systemd[1]: Starting Network Name Resolution...1609second # [ 6.030619] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1610second # [ 6.034199] systemd[1]: Starting Create Static Device Nodes in /dev...1611second # [ 6.038207] systemd[1]: Finished Create Static Device Nodes in /dev.1612second # [ 6.039312] systemd[1]: Reached target Preparation for Local File Systems.1613second # [ 6.041554] systemd[1]: Starting Rule-based Manager for Device Events and Files...1614second # [ 6.042874] systemd[1]: Finished Flush Journal to Persistent Storage.1615second # [ 6.047773] systemd-resolved[348]: Positive Trust Anchors:1616second # [ 6.051155] systemd-resolved[348]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1617second # [ 6.052835] systemd-resolved[348]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161618second # [ 6.055656] 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 test1619test # [ 6.122357] systemd[1]: Finished Load/Save OS Random Seed.1620test # [ 6.124904] systemd[1]: Reached target First Boot Complete.1621test # [ 6.128517] systemd[1]: Mounted Kernel Configuration File System.1622test # [ 6.131746] systemd[1]: Finished Apply Kernel Variables.1623second # [ 6.123748] systemd-udevd[360]: Using default interface naming scheme 'v261'.1624test # [ 6.133361] systemd[1]: Starting Network Name Resolution...1625test # [ 6.136280] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1626test # [ 6.139167] systemd[1]: Starting Create Static Device Nodes in /dev...1627test # [ 6.141042] systemd[1]: Finished Create Static Device Nodes in /dev.1628test # [ 6.143468] systemd[1]: Reached target Preparation for Local File Systems.1629test # [ 6.147263] systemd[1]: Starting Rule-based Manager for Device Events and Files...1630test # [ 6.148494] systemd[1]: Finished Flush Journal to Persistent Storage.1631test # [ 6.150778] systemd-resolved[368]: Positive Trust Anchors:1632test # [ 6.152788] systemd-resolved[368]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1633test # [ 6.155822] systemd-resolved[368]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161634test # [ 6.158915] systemd-resolved[368]: 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 test1635second # [ 6.158477] systemd[1]: Finished Coldplug All udev Devices.1636second # [ 6.161259] systemd-resolved[348]: Using system hostname 'second'.1637second # [ 6.167632] systemd[1]: Started Network Name Resolution.1638second # [ 6.219909] systemd[1]: Started Rule-based Manager for Device Events and Files.1639test # [ 6.240277] systemd-udevd[383]: Using default interface naming scheme 'v261'.1640test # [ 6.251970] systemd[1]: Finished Coldplug All udev Devices.1641test # [ 6.261479] systemd-resolved[368]: Using system hostname 'test'.1642test # [ 6.267989] systemd[1]: Started Network Name Resolution.1643test # [ 6.333827] systemd[1]: Started Rule-based Manager for Device Events and Files.1644second # [ 6.371206] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1645second # [ 6.448952] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1646second # [ 6.473227] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1647test # [ 6.496145] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1648second # [ 6.508491] (udev-worker)[425]: Network interface NamePolicy= disabled on kernel command line.1649second # [ 6.510478] systemd[1]: Mounting /run/wrappers...1650second # [ 6.513136] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line.1651second # [ 6.533544] systemd[1]: Finished Firewall.1652second # [ 6.534378] systemd[1]: Reached target Preparation for Network.1653second # [ 6.537093] systemd[1]: Listening on Network Management Resolve Hook Socket.1654second # [ 6.545860] systemd[1]: Starting Network Management...1655second # [ 6.553470] systemd[1]: Mounted /run/wrappers.1656second # [ 6.555204] systemd[1]: Reached target Local File Systems.1657second # [ 6.559913] systemd[1]: Listening on Boot Loader Control Service Socket.1658second # [ 6.562851] systemd[1]: Starting register-nix-paths.service...1659test # [ 6.577130] systemd[1]: Mounting /run/wrappers...1660test # [ 6.580956] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1661second # [ 6.572165] systemd[1]: Starting Create SUID/SGID Wrappers...1662second # [ 6.573175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1663second # [ 6.577664] systemd[1]: Starting Save Transient machine-id to Disk...1664second # [ 6.590088] systemd[1]: Starting Create System Files and Directories...1665test # [ 6.609632] systemd[1]: Mounted /run/wrappers.1666test # [ 6.613265] systemd[1]: Reached target Local File Systems.1667test # [ 6.616625] systemd[1]: Listening on Boot Loader Control Service Socket.1668test # [ 6.619686] systemd[1]: Starting register-nix-paths.service...1669test # [ 6.625819] systemd[1]: Starting Create SUID/SGID Wrappers...1670test # [ 6.627324] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1671test # [ 6.639972] systemd[1]: Starting Save Transient machine-id to Disk...1672test # [ 6.647961] systemd[1]: Starting Create System Files and Directories...1673second # [ 6.663700] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1674test # [ 6.671135] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1675second # [ 6.668675] systemd[1]: Finished Save Transient machine-id to Disk.1676test # [ 6.700464] systemd[1]: Finished Firewall.1677test # [ 6.701689] systemd[1]: Reached target Preparation for Network.1678test # [ 6.703914] systemd[1]: Listening on Network Management Resolve Hook Socket.1679test # [ 6.716426] systemd[1]: Starting Network Management...1680test # [ 6.717445] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1681second # [ 6.720300] systemd[1]: Finished Create System Files and Directories.1682test # [ 6.730794] systemd[1]: Finished Save Transient machine-id to Disk.1683second # [ 6.729863] systemd[1]: Starting Rebuild Journal Catalog...1684test # [ 6.746370] (udev-worker)[436]: Network interface NamePolicy= disabled on kernel command line.1685second # [ 6.741099] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1686test # [ 6.753290] (udev-worker)[444]: Network interface NamePolicy= disabled on kernel command line.1687test # [ 6.774601] systemd[1]: Finished Create System Files and Directories.1688test # [ 6.782221] systemd[1]: Starting Rebuild Journal Catalog...1689test # [ 6.789168] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1690second # [ 6.808203] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1691second # [ 6.841894] systemd[1]: Finished Rebuild Journal Catalog.1692test # [ 6.858188] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1693second # [ 6.861586] systemd[1]: Starting Update is Completed...1694second # [ 7.044677] cfg80211: Loading compiled-in X.509 certificates for regulatory database1695test # [ 6.895188] systemd[1]: Finished Rebuild Journal Catalog.1696test # [ 6.904721] systemd[1]: Starting Update is Completed...1697second # [ 7.070211] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1698second # [ 7.071193] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1699second # [ 6.907567] systemd[1]: Finished Update is Completed.1700second # [ 6.940766] systemd-networkd[472]: /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.1701second # [ 6.945908] systemd-networkd[472]: /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.1702test # [ 6.957792] systemd[1]: Finished Update is Completed.1703second # [ 6.950726] systemd-networkd[472]: lo: Link UP1704second # [ 6.952313] systemd-networkd[472]: lo: Gained carrier1705second # [ 6.963572] systemd-networkd[472]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1706second # [ 6.966090] systemd-networkd[472]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1707second # [ 6.968183] systemd[1]: Started Network Management.1708second # [ 6.976550] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1709second # [ 6.980140] systemd-networkd[472]: eth1: Link UP1710second # [ 6.985210] systemd-networkd[472]: eth1: Gained carrier1711second # [ 6.987239] systemd-networkd[472]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1712second # [ 7.176981] NET: Registered PF_PACKET protocol family1713test # [ 7.200598] cfg80211: Loading compiled-in X.509 certificates for regulatory database1714second # [ 7.031931] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1715second # [ 7.211459] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1716test # [ 7.221060] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1717test # [ 7.222035] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1718second # [ 7.044243] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1719second # [ 7.046781] systemd[1]: Finished Create SUID/SGID Wrappers.1720second # [ 7.223566] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31721test # [ 7.073780] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1722test # [ 7.076787] systemd[1]: Finished Create SUID/SGID Wrappers.1723second # [ 7.240505] mousedev: PS/2 mouse device common for all mice1724test # [ 7.090528] systemd-networkd[499]: /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.1725test # [ 7.094768] systemd-networkd[499]: /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.1726test # [ 7.099312] systemd-networkd[499]: lo: Link UP1727test # [ 7.100809] systemd-networkd[499]: lo: Gained carrier1728test # [ 7.110697] systemd[1]: Started Network Management.1729test # [ 7.115970] systemd-networkd[499]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1730test # [ 7.119628] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1731test # [ 7.121315] systemd-networkd[499]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1732test # [ 7.128995] systemd-networkd[499]: eth1: Link UP1733test # [ 7.129890] systemd-networkd[499]: eth1: Gained carrier1734test # [ 7.131412] systemd-networkd[499]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1735test # [ 7.318913] NET: Registered PF_PACKET protocol family1736second # [ 7.159607] systemd[1]: Finished register-nix-paths.service.1737second # [ 7.160725] systemd[1]: Reached target System Initialization.1738test # [ 7.171171] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1739second # [ 7.162335] systemd[1]: Started Discard unused filesystem blocks once a week.1740second # [ 7.163950] systemd[1]: Started Daily Cleanup of Temporary Directories.1741second # [ 7.165990] systemd[1]: Reached target Timer Units.1742second # [ 7.167700] systemd[1]: Listening on D-Bus System Message Bus Socket.1743second # [ 7.169188] systemd[1]: Listening on Nix Daemon Socket.1744second # [ 7.174077] systemd[1]: Listening on Authorization Manager Agent Helper.1745second # [ 7.175223] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1746second # [ 7.177149] systemd[1]: Reached target Socket Units.1747second # [ 7.181093] systemd[1]: Starting D-Bus System Message Bus...1748second # [ 7.201450] systemd-resolved[348]: Clock change detected. Flushing caches.1749second # [ 7.255345] ACPI: button: Power Button [PWRF]1750second # [ 7.320668] rtc_cmos 00:04: RTC can wake from S41751second # [ 7.351170] rtc_cmos 00:04: registered as rtc01752test # [ 7.403664] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1753second # [ 7.355077] rtc_cmos 00:04: setting system clock to 2026-08-25T21:45:02 UTC (1787694302)1754second # [ 7.355181] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1755test # [ 7.407973] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31756second # [ 7.355759] systemd-journald[320]: Time jumped backwards, rotating.1757test # [ 7.259146] systemd[1]: Finished register-nix-paths.service.1758test # [ 7.260273] systemd[1]: Reached target System Initialization.1759second # [ 7.366383] parport_pc 00:02: reported by Plug and Play ACPI1760second # [ 7.366462] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1761test # [ 7.263170] systemd[1]: Started Discard unused filesystem blocks once a week.1762second # [ 7.384309] Console: switching to colour dummy device 80x251763test # [ 7.264536] systemd[1]: Started Daily Cleanup of Temporary Directories.1764second # [ 7.255909] dbus-broker-launch[556]: Looking up NSS user entry for 'systemd-timesync'...1765test # [ 7.266812] systemd[1]: Reached target Timer Units.1766second # [ 7.258886] dbus-broker-launch[556]: NSS returned no entry for 'systemd-timesync'1767test # [ 7.268202] systemd[1]: Listening on D-Bus System Message Bus Socket.1768test # [ 7.270153] systemd[1]: Listening on Nix Daemon Socket.1769second # [ 7.260440] dbus-broker-launch[556]: Invalid user-name in /nix/store/y5g83ihxjak0dp03i8x01s3lkza55svb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1770test # [ 7.275098] systemd[1]: Listening on Authorization Manager Agent Helper.1771test # [ 7.276235] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1772test # [ 7.277612] systemd[1]: Reached target Socket Units.1773test # [ 7.280075] systemd[1]: Starting D-Bus System Message Bus...1774second # [ 7.277694] dbus-broker-launch[556]: 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'1775second # [ 7.281476] dbus-broker-launch[556]: 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'1776second # [ 7.285105] dbus-broker-launch[556]: 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'1777second # [ 7.289132] dbus-broker-launch[556]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1778second # [ 7.293391] systemd[1]: Started D-Bus System Message Bus.1779second # [ 7.391566] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41780second # [ 7.401334] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1781second # [ 7.315477] dbus-broker-launch[556]: Ready1782second # [ 7.325115] systemd[1]: Reached target Basic System.1783second # [ 7.327883] systemd[1]: Starting Network Manager Script Dispatcher Service...1784second # [ 7.503648] [drm] Found bochs VGA, ID 0xb0c5.1785test # [ 7.341829] dbus-broker-launch[575]: Looking up NSS user entry for 'systemd-timesync'...1786second # [ 7.503650] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1787second # [ 7.335304] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1788test # [ 7.346916] dbus-broker-launch[575]: NSS returned no entry for 'systemd-timesync'1789test # [ 7.348309] dbus-broker-launch[575]: Invalid user-name in /nix/store/y5g83ihxjak0dp03i8x01s3lkza55svb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1790second # [ 7.513456] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1791second # [ 7.514196] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1792second # [ 7.347288] systemd[1]: Starting Network Manager...1793test # [ 7.356376] systemd-resolved[368]: Clock change detected. Flushing caches.1794second # [ 7.518898] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1795second # [ 7.356219] systemd[1]: Started backdoor.service.1796second # [ 7.535812] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01797second # [ 7.368961] systemd[1]: Starting Import lastlog data into lastlog2 database...1798test # [ 7.379945] dbus-broker-launch[575]: 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'1799test # [ 7.387733] dbus-broker-launch[575]: 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'1800second # [ 7.385965] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1801test # [ 7.396320] dbus-broker-launch[575]: 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'1802test # [ 7.427524] mousedev: PS/2 mouse device common for all mice1803test # [ 7.400363] dbus-broker-launch[575]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/g2idqgjmv239g4g7bzs9p8ir6np5yr7m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1804test # [ 7.404359] systemd[1]: Started D-Bus System Message Bus.1805test # [ 7.456097] ACPI: button: Power Button [PWRF]1806test # [ 7.506338] rtc_cmos 00:04: RTC can wake from S41807second # [ 7.400611] systemd[1]: Starting Post-Boot Actions...1808second # [ 7.404124] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1809test # [ 7.414554] dbus-broker-launch[575]: Ready1810test # [ 7.525336] rtc_cmos 00:04: registered as rtc01811test # [ 7.525429] rtc_cmos 00:04: setting system clock to 2026-08-25T21:45:03 UTC (1787694303)1812test # [ 7.424526] systemd[1]: Reached target Basic System.1813test # [ 7.427905] systemd[1]: Starting Network Manager Script Dispatcher Service...1814test # [ 7.434282] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1815second # [ 7.428078] systemd[1]: Started Reset console on configuration changes.1816test # [ 7.443209] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1817second # [ 7.440182] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1818second # connecting to host...1819test # [ 7.458204] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1820test # [ 7.525513] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1821test # [ 7.527329] systemd-journald[339]: Time jumped backwards, rotating.1822test # [ 7.544744] parport_pc 00:02: reported by Plug and Play ACPI1823test # [ 7.467730] systemd[1]: Starting Network Manager...1824test # [ 7.473544] systemd[1]: Started backdoor.service.1825second # [ 7.635353] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61826second # [ 7.638628] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51827second # [ 7.476071] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1828test # [ 7.491450] pd59w92wyc6rjpca8n3ypvrm3c78xh1n-wifi-secrets[579]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1829test # [ 7.507587] systemd[1]: Starting Import lastlog data into lastlog2 database...1830test # [ 7.512320] 3n8ky6qdcbw1k7vj7jk5r1y02d17nk2g-wifi-secrets[580]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1831test # [ 7.523243] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1832second # [ 7.519118] systemd[1]: Finished Post-Boot Actions.1833test # [ 7.538323] systemd[1]: Starting Post-Boot Actions...1834second # [ 7.530237] systemd[1]: Started Network Manager Script Dispatcher Service.1835second # [ 7.537095] systemd[1]: Started Name Service Cache Daemon (nsncd).1836second # [ 7.540198] systemd[1]: Reached target Host and Network Name Lookups.1837second # [ 7.541270] systemd[1]: Reached target User and Group Name Lookups.1838second # [ 7.544348] nsncd[566]: Aug 25 21:45:02.851 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1839test # [ 7.554228] f7i4m9qbq8xk00yg42rzh0mg47dda2zy-wifi-secrets[582]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1840second # [ 7.555688] systemd[1]: Starting User Login Management...1841test # [ 7.565253] systemd[1]: Started Reset console on configuration changes.1842second # [ 7.557307] systemd[1]: Finished Import lastlog data into lastlog2 database.1843test # [ 7.544871] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1844test # connecting to host...1845test # [ 7.569158] Console: switching to colour dummy device 80x251846test # [ 7.606679] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41847test # [ 7.611883] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1848second # [ 7.608498] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1849test # [ 7.619631] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1850test # [ 7.628827] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1851test # [ 7.636212] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1852test: Guest shell says: b'Spawning backdoor root shell...\n'1853test # [ 7.640139] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1854test # [ 7.646678] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1855second # [ 7.637546] systemd[1]: Starting Hostname Service...1856test: connected to guest root shell1857test: (connecting took 8.32 seconds)1858test: (finished: waiting for the VM to finish booting, in 8.32 seconds)1859second # [ 7.786819] Console: switching to colour frame buffer device 160x501860test # [ 7.658770] systemd[1]: Finished Post-Boot Actions.1861second # [ 7.836275] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1862second # [ 7.656134] systemd[1]: Starting Virtual Console Setup...1863second # [ 7.672272] systemd-logind[598]: New seat seat0.1864test # [ 7.686221] nsncd[594]: Aug 25 21:45:03.828 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1865second # [ 7.679209] systemd[1]: Started User Login Management.1866test # [ 7.690955] systemd[1]: Started Name Service Cache Daemon (nsncd).1867second # [ 7.687084] systemd[1]: Starting linger-users.service...1868test # [ 7.701582] systemd[1]: Started Network Manager Script Dispatcher Service.1869second # [ 7.702374] systemd-logind[598]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1870test # [ 7.612125] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1871test # [ 7.892972] [drm] Found bochs VGA, ID 0xb0c5.1872test # [ 7.892974] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1873test # [ 7.735423] systemd[1]: Finished Import lastlog data into lastlog2 database.1874second # [ 7.730479] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1875test # [ 7.743079] systemd[1]: Reached target Host and Network Name Lookups.1876second # [ 7.734485] systemd[1]: Stopped Virtual Console Setup.1877test # [ 7.744185] systemd[1]: Reached target User and Group Name Lookups.1878second # [ 7.737395] systemd[1]: linger-users.service: Deactivated successfully.1879test # [ 7.916430] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1880test # [ 7.917265] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01881test # [ 7.750077] systemd[1]: Starting Hostname Service...1882second # [ 7.742794] systemd[1]: Finished linger-users.service.1883test # [ 7.924061] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1884test # [ 7.926853] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1885second # [ 7.749798] systemd[1]: Starting Virtual Console Setup...1886test # [ 7.762308] systemd[1]: Starting User Login Management...1887second # [ 7.768560] systemd[1]: Started Hostname Service.1888second # [ 7.774298] systemd-logind[598]: Watching system buttons on /dev/input/event2 (Power Button)1889test # [ 7.974101] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61890test # [ 7.975523] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51891second # [ 7.992866] ppdev: user-space parallel port driver1892second # [ 7.850402] systemd-networkd[472]: eth0: Link UP1893second # [ 7.853281] systemd-networkd[472]: eth0: Gained carrier1894second # [ 7.878459] systemd[1]: Started Network Manager.1895second # [ 7.881430] systemd[1]: Reached target Network.1896second # [ 7.888108] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1897second # [ 7.894515] systemd[1]: Starting Permit User Sessions...1898second # [ 8.083410] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1899test # [ 8.095741] Console: switching to colour frame buffer device 160x501900second # [ 7.945703] systemd-logind[598]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1901second # [ 7.967211] systemd[1]: Finished Permit User Sessions.1902test # [ 8.151406] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1903test # [ 7.866758] systemd[1]: Started Hostname Service.1904test # [ 7.984063] systemd[1]: Starting Virtual Console Setup...1905test # [ 7.985127] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1906second # [ 7.980621] systemd[1]: Started Getty on tty1.1907test # [ 7.989967] systemd-networkd[499]: eth0: Link UP1908second # [ 7.981590] systemd[1]: Reached target Login Prompts.1909test # [ 7.991873] systemd-networkd[499]: eth0: Gained carrier1910test # [ 7.994528] systemd[1]: Started Network Manager.1911test # [ 7.997556] systemd[1]: Reached target Network.1912test # [ 7.998618] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1913test # [ 8.000618] systemd[1]: Starting Permit User Sessions...1914test # [ 8.004615] systemd-logind[637]: New seat seat0.1915test # [ 8.006982] systemd-logind[637]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1916test # [ 8.010849] systemd[1]: Started User Login Management.1917second # [ 8.174181] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1918test # [ 8.017183] systemd-logind[637]: Watching system buttons on /dev/input/event2 (Power Button)1919test # [ 8.027197] systemd[1]: Starting linger-users.service...1920second # [ 8.023277] systemd-vconsole-setup[619]: Configuration of first virtual console was skipped, ignoring remaining ones.1921second # [ 8.032375] systemd[1]: Finished Virtual Console Setup.1922test # [ 8.051452] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1923test # [ 8.055313] systemd[1]: Stopped Virtual Console Setup.1924test # [ 8.066609] systemd[1]: Finished Permit User Sessions.1925test # [ 8.084157] systemd[1]: linger-users.service: Deactivated successfully.1926test # [ 8.087474] systemd[1]: Finished linger-users.service.1927second # [ 8.084470] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1928second # [ 8.088089] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1929second # [ 8.098079] systemd[1]: Reached target Multi-User System.1930second # [ 8.099083] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1931second # [ 8.100294] systemd[1]: Stopped Virtual Console Setup.1932second # [ 8.101210] systemd[1]: Stopping Virtual Console Setup...1933second # [ 8.105660] systemd[1]: Starting Virtual Console Setup...1934test # [ 8.137803] systemd[1]: Started Getty on tty1.1935test # [ 8.309517] ppdev: user-space parallel port driver1936test # [ 8.143187] systemd[1]: Reached target Login Prompts.1937test # [ 8.152262] NetworkManager[583]: <warn> [1787694304.2955] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1938test # [ 8.156543] NetworkManager[583]: <warn> [1787694304.2958] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1939test # [ 8.161692] systemd[1]: Starting Virtual Console Setup...1940second # [ 8.161421] systemd-resolved[348]: eth0: Bus client set default route setting: yes1941second # [ 8.167204] systemd-resolved[348]: eth0: Bus client set DNS server list to: 10.0.2.31942second # [ 8.359697] kvm_amd: TSC scaling supported1943second # [ 8.360179] kvm_amd: Nested Virtualization enabled1944second # [ 8.361654] kvm_amd: Nested Paging enabled1945second # [ 8.362182] kvm_amd: LBR virtualization supported1946second # [ 8.363134] kvm_amd: Virtual GIF supported1947second # [ 8.363974] kvm_amd: Virtual NMI enabled1948test # [ 8.205136] systemd-networkd[499]: eth1: Gained IPv6LL1949test # [ 8.376258] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1950test # [ 8.211341] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1951test # [ 8.215513] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1952test # [ 8.225106] systemd[1]: Reached target Multi-User System.1953test # [ 8.235816] systemd-logind[637]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1954second # [ 8.406077] EDAC MC: Ver: 3.0.01955test # [ 8.429448] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1956test # [ 8.263747] systemd-resolved[368]: eth0: Bus client set default route setting: yes1957test # [ 8.268182] systemd-resolved[368]: eth0: Bus client set DNS server list to: 10.0.2.31958second # [ 8.315646] systemd-vconsole-setup[646]: Configuration of first virtual console was skipped, ignoring remaining ones.1959second # [ 8.319228] systemd[1]: Finished Virtual Console Setup.1960second # [ 8.323906] systemd[1]: Startup finished in 774ms (kernel) + 3.590s (initrd) + 3.958s (userspace) = 8.323s.1961test # [ 8.399571] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1962test # [ 8.572685] kvm_amd: TSC scaling supported1963test # [ 8.404514] systemd[1]: Stopped Virtual Console Setup.1964test # [ 8.578364] kvm_amd: Nested Virtualization enabled1965test # [ 8.580886] kvm_amd: Nested Paging enabled1966test # [ 8.581383] kvm_amd: LBR virtualization supported1967test # [ 8.414300] systemd[1]: Starting Virtual Console Setup...1968test # [ 8.587929] kvm_amd: Virtual GIF supported1969test # [ 8.588395] kvm_amd: Virtual NMI enabled1970test # [ 8.626693] EDAC MC: Ver: 3.0.01971test # [ 8.562669] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones.1972test # [ 8.566039] systemd[1]: Finished Virtual Console Setup.1973test # [ 8.571433] systemd[1]: Startup finished in 780ms (kernel) + 3.640s (initrd) + 4.150s (userspace) = 8.571s.1974test: (finished: waiting for unit NetworkManager.service, in 9.43 seconds)1975test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1976test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1977cleanup1978kill QemuMachine (pid 47)1979second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1980kill QemuMachine (pid 48)1981test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1982(finished: cleanup, in 0.11 seconds)1983Traceback (most recent call last):1984 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1985 sys.exit(main())1986 ~~~~^^1987 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main1988 driver.run_tests()1989 ~~~~~~~~~~~~~~~~^^1990 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests1991 self.test_script()1992 ~~~~~~~~~~~~~~~~^^1993 File "/nix/store/xiwlamfw4m4v2wy4al1nipip5hjwy2wa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script1994 exec(self.tests, symbols, None)1995 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^1996 File "<string>", line 4, in <module>1997AssertionError: Expected mock password in connection file:1998[connection]1999autoconnect=true2000id=2001type=wifi20022003[wifi]2004mode=infrastructure2005ssid=20062007[wifi-security]2008key-mgmt=wpa-psk2009psk=2010