vm-test-run-wifi
checks.x86_64-linux.wifi
· build #185
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test # Disk image does not exist, creating the virtualisation disk image...14test # Formatting '/build/vm-state-test/tmp.OF0jH2QZlu', fmt=raw size=107374182415test # mke2fs 1.47.4 (6-Mar-2025)16test # Discarding device blocks: 0/262144 done17test # Creating filesystem with 262144 4k blocks and 65536 inodes18test # Filesystem UUID: a7e28ca7-0dfd-44d9-89a9-7ddf859c10a919test # Superblock backups stored on blocks:20test # 32768, 98304, 163840, 22937621test # 22test # Allocating group tables: 0/8 done23test # Writing inode tables: 0/8 done24test # Creating journal (8192 blocks): done25test # Writing superblocks and filesystem accounting information: 0/8 done26test # 27test # Virtualisation disk image created.28test # Starting virtiofs daemons...29test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33test # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...34test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35test # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36test # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...37test # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...38test # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests39test # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests40test # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests41test: QEMU running (pid 47)42second # Disk image does not exist, creating the virtualisation disk image...43second: QEMU running (pid 48)44second # Formatting '/build/vm-state-second/tmp.lKDPinTOjq', fmt=raw size=107374182445second # mke2fs 1.47.4 (6-Mar-2025)46second # Discarding device blocks: 0/262144 done47second # Creating filesystem with 262144 4k blocks and 65536 inodes48second # Filesystem UUID: 831114fe-aedd-4a43-897d-1e8d04335f7449second # Superblock backups stored on blocks:50second # 32768, 98304, 163840, 22937651second # 52second # Allocating group tables: 0/8 done53second # Writing inode tables: 0/8 done54second # Creating journal (8192 blocks): done55second # Writing superblocks and filesystem accounting information: 0/8 done56second # 57second # Virtualisation disk image created.58second # Starting virtiofs daemons...59second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)60second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether61second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)62second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether63second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)64second # [2026-09-22T20:02:03Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether65second # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...66second # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...67second # [2026-09-22T20:02:03Z INFO virtiofsd] Waiting for vhost-user socket connection...68second # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests69second # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests70second # [2026-09-22T20:02:03Z INFO virtiofsd] Client connected, servicing requests71(finished: start all VMs, in 0.12 seconds)72test: waiting for unit NetworkManager.service73test: waiting for the VM to finish booting74test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)75second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)76second # 77second # 78test # 79test # 80second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0081test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0082second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...83second # 84second # 85second # 86second # 87test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...88test # 89test # 90test # 91test # 92second # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0093test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0094second # Press Ctrl-B to configure iPXE (PCI 00:05.0)...95second # 96second # 97test # Press Ctrl-B to configure iPXE (PCI 00:05.0)...98test # 99test # 100second # Booting from ROM...101test # Booting from ROM...102second # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 21 13:06:06 UTC 2026103second # [ 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/x24yqk1728id105545lbpijkfj6nkzrp-nixos-system-second-test/init regInfo=/nix/.ro-store/ikl8if3hjr0wnbjrf5zrqpf3fbvjmqdn-closure-info/registration console=ttyS0,115200n8 console=tty0104second # [ 0.000000] BIOS-provided physical RAM map:105second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable106second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved107second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved108second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable109second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved110second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved111second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved112second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved113second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved114second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved115second # [ 0.000000] NX (Execute Disable) protection: active116second # [ 0.000000] APIC: Static calls initialized117second # [ 0.000000] SMBIOS 2.8 present.118second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014119second # [ 0.000000] DMI: Memory slots populated: 1/1120second # [ 0.000000] Hypervisor detected: KVM121second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000122second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00123second # [ 0.000000] kvm-clock: using sched offset of 401507504 cycles124second # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns125second # [ 0.000004] tsc: Detected 4192.120 MHz processor126second # [ 0.000615] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000127second # [ 0.000644] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs128second # [ 0.000646] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT129second # [ 0.002345] found SMP MP-table at [mem 0x000f5450-0x000f545f]130second # [ 0.002357] Using GB pages for direct mapping131second # [ 0.002439] RAMDISK: [mem 0x3e366000-0x3ffcffff]132second # [ 0.002443] ACPI: Early table checksum verification disabled133test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 21 13:06:06 UTC 2026134second # [ 0.002445] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )135second # [ 0.002448] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)136second # [ 0.002450] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)137second # [ 0.002454] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)138test # [ 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/vawn80lfqpms55k1cxl6glk2410a7x5h-nixos-system-test-test/init regInfo=/nix/.ro-store/xknspkrxsd09pwfpsxhcbs1qs4r2jdy6-closure-info/registration console=ttyS0,115200n8 console=tty0139second # [ 0.002456] ACPI: FACS 0x000000003FFE0000 000040140test # [ 0.000000] BIOS-provided physical RAM map:141second # [ 0.002457] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)142test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable143second # [ 0.002458] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)144test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved145second # [ 0.002459] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)146test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved147test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable148second # [ 0.002461] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)149second # [ 0.002462] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]150test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved151second # [ 0.002462] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]152test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved153test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved154second # [ 0.002463] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]155second # [ 0.002463] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]156test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved157second # [ 0.002464] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]158test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved159second # [ 0.002464] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]160test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved161test # [ 0.000000] NX (Execute Disable) protection: active162second # [ 0.002464] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]163test # [ 0.000000] APIC: Static calls initialized164second # [ 0.002817] No NUMA configuration found165test # [ 0.000000] SMBIOS 2.8 present.166second # [ 0.002818] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]167test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014168second # [ 0.002821] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]169second # [ 0.002886] Zone ranges:170test # [ 0.000000] DMI: Memory slots populated: 1/1171test # [ 0.000000] Hypervisor detected: KVM172second # [ 0.002886] DMA [mem 0x0000000000001000-0x0000000000ffffff]173test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000174second # [ 0.002887] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]175test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00176second # [ 0.002888] Normal empty177second # [ 0.002889] Device empty178test # [ 0.000000] kvm-clock: using sched offset of 436500558 cycles179second # [ 0.002889] Movable zone start for each node180second # [ 0.002890] Early memory node ranges181test # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns182second # [ 0.002890] node 0: [mem 0x0000000000001000-0x000000000009efff]183test # [ 0.000004] tsc: Detected 4192.120 MHz processor184second # [ 0.002891] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]185test # [ 0.000672] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000186second # [ 0.002892] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]187test # [ 0.000704] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs188second # [ 0.002909] On node 0, zone DMA: 1 pages in unavailable ranges189test # [ 0.000707] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT190second # [ 0.003098] On node 0, zone DMA: 97 pages in unavailable ranges191test # [ 0.002386] found SMP MP-table at [mem 0x000f5450-0x000f545f]192second # [ 0.016216] On node 0, zone DMA32: 40 pages in unavailable ranges193test # [ 0.002411] Using GB pages for direct mapping194second # [ 0.017028] ACPI: PM-Timer IO Port: 0x608195test # [ 0.002506] RAMDISK: [mem 0x3e369000-0x3ffcffff]196second # [ 0.017040] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])197test # [ 0.002514] ACPI: Early table checksum verification disabled198test # [ 0.002517] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )199second # [ 0.017065] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23200second # [ 0.017067] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)201test # [ 0.002521] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)202second # [ 0.017069] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)203test # [ 0.002525] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)204second # [ 0.017069] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)205test # [ 0.002530] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)206second # [ 0.017070] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)207test # [ 0.002532] ACPI: FACS 0x000000003FFE0000 000040208second # [ 0.017071] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)209test # [ 0.002533] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)210second # [ 0.017073] ACPI: Using ACPI (MADT) for SMP configuration information211second # [ 0.017074] ACPI: HPET id: 0x8086a201 base: 0xfed00000212test # [ 0.002535] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)213second # [ 0.017078] TSC deadline timer available214second # [ 0.017082] CPU topo: Max. logical packages: 1215test # [ 0.002536] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)216second # [ 0.017082] CPU topo: Max. logical dies: 1217second # [ 0.017083] CPU topo: Max. dies per package: 1218test # [ 0.002537] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)219second # [ 0.017086] CPU topo: Max. threads per core: 1220test # [ 0.002538] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]221second # [ 0.017086] CPU topo: Num. cores per package: 1222test # [ 0.002539] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]223second # [ 0.017087] CPU topo: Num. threads per package: 1224second # [ 0.017087] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs225test # [ 0.002539] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]226second # [ 0.017106] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()227test # [ 0.002540] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]228test # [ 0.002540] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]229second # [ 0.017134] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]230test # [ 0.002541] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]231second # [ 0.017136] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]232second # [ 0.017137] [mem 0x40000000-0xafffffff] available for PCI devices233test # [ 0.002541] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]234test # [ 0.002926] No NUMA configuration found235second # [ 0.017144] Booting paravirtualized kernel on KVM236test # [ 0.002927] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]237second # [ 0.017147] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns238test # [ 0.002929] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]239test # [ 0.003000] Zone ranges:240second # [ 0.020504] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1241test # [ 0.003001] DMA [mem 0x0000000000001000-0x0000000000ffffff]242second # [ 0.022389] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152243test # [ 0.003002] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]244test # [ 0.003003] Normal empty245second # [ 0.022439] kvm-guest: PV spinlocks disabled, single CPU246test # [ 0.003004] Device empty247test # [ 0.003004] Movable zone start for each node248test # [ 0.003004] Early memory node ranges249test # [ 0.003005] node 0: [mem 0x0000000000001000-0x000000000009efff]250test # [ 0.003006] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]251test # [ 0.003007] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]252second # [ 0.022442] 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/x24yqk1728id105545lbpijkfj6nkzrp-nixos-system-second-test/init regInfo=/nix/.ro-store/ikl8if3hjr0wnbjrf5zrqpf3fbvjmqdn-closure-info/registration console=ttyS0,115200n8 console=tty0253test # [ 0.003023] On node 0, zone DMA: 1 pages in unavailable ranges254test # [ 0.003211] On node 0, zone DMA: 97 pages in unavailable ranges255second # [ 0.022523] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ikl8if3hjr0wnbjrf5zrqpf3fbvjmqdn-closure-info/registration", will be passed to user space.256test # [ 0.016070] On node 0, zone DMA32: 40 pages in unavailable ranges257second # [ 0.022717] random: crng init done258test # [ 0.016890] ACPI: PM-Timer IO Port: 0x608259test # [ 0.016904] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])260second # [ 0.022718] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes261test # [ 0.016931] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23262second # [ 0.023557] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)263test # [ 0.016933] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)264second # [ 0.023837] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)265test # [ 0.016935] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)266second # [ 0.023863] Fallback order for Node 0: 0267test # [ 0.016936] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)268second # [ 0.023866] Built 1 zonelists, mobility grouping on. Total pages: 262006269second # [ 0.023867] Policy zone: DMA32270test # [ 0.016937] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)271second # [ 0.025453] mem auto-init: stack:all(zero), heap alloc:on, heap free:off272test # [ 0.016937] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)273second # [ 0.028245] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1274test # [ 0.016939] ACPI: Using ACPI (MADT) for SMP configuration information275second # [ 0.029875] allocated 2097152 bytes of page_ext276test # [ 0.016940] ACPI: HPET id: 0x8086a201 base: 0xfed00000277second # [ 0.039211] ftrace: allocating 48798 entries in 192 pages278test # [ 0.016946] TSC deadline timer available279second # [ 0.039213] ftrace: allocated 192 pages with 2 groups280test # [ 0.016950] CPU topo: Max. logical packages: 1281second # [ 0.039948] Dynamic Preempt: lazy282test # [ 0.016950] CPU topo: Max. logical dies: 1283second # [ 0.040057] rcu: Preemptible hierarchical RCU implementation.284test # [ 0.016951] CPU topo: Max. dies per package: 1285second # [ 0.040057] rcu: RCU event tracing is enabled.286test # [ 0.016954] CPU topo: Max. threads per core: 1287second # [ 0.040058] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.288test # [ 0.016954] CPU topo: Num. cores per package: 1289second # [ 0.040059] Trampoline variant of Tasks RCU enabled.290test # [ 0.016954] CPU topo: Num. threads per package: 1291second # [ 0.040059] Rude variant of Tasks RCU enabled.292test # [ 0.016955] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs293second # [ 0.040059] Tracing variant of Tasks RCU enabled.294test # [ 0.016976] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()295second # [ 0.040061] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.296test # [ 0.017004] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]297second # [ 0.040062] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1298test # [ 0.017005] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]299second # [ 0.040081] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.300test # [ 0.017007] [mem 0x40000000-0xafffffff] available for PCI devices301test # [ 0.017008] Booting paravirtualized kernel on KVM302second # [ 0.040082] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.303second # [ 0.040083] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.304test # [ 0.017011] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns305second # [ 0.043445] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16306test # [ 0.020356] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1307second # [ 0.043737] rcu: srcu_init: Setting srcu_struct sizes based on contention.308test # [ 0.021979] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152309test # [ 0.022023] kvm-guest: PV spinlocks disabled, single CPU310second # [ 0.043745] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns311second # [ 0.043914] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)312second # [ 0.049865] Console: colour VGA+ 80x25313second # [ 0.049869] printk: legacy console [tty0] enabled314second # [ 0.081835] printk: legacy console [ttyS0] enabled315second # [ 0.221354] ACPI: Core revision 20250807316test # [ 0.022024] 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/vawn80lfqpms55k1cxl6glk2410a7x5h-nixos-system-test-test/init regInfo=/nix/.ro-store/xknspkrxsd09pwfpsxhcbs1qs4r2jdy6-closure-info/registration console=ttyS0,115200n8 console=tty0317second # [ 0.222446] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns318test # [ 0.022093] Unknown kernel command line parameters "regInfo=/nix/.ro-store/xknspkrxsd09pwfpsxhcbs1qs4r2jdy6-closure-info/registration", will be passed to user space.319second # [ 0.224441] APIC: Switch to symmetric I/O mode setup320test # [ 0.022285] random: crng init done321second # [ 0.225661] x2apic enabled322test # [ 0.022285] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes323second # [ 0.226503] APIC: Switched APIC routing to: physical x2apic324test # [ 0.023191] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)325test # [ 0.023207] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)326second # [ 0.228540] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1327test # [ 0.023237] Fallback order for Node 0: 0328test # [ 0.023239] Built 1 zonelists, mobility grouping on. Total pages: 262006329test # [ 0.023240] Policy zone: DMA32330second # [ 0.229800] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns331test # [ 0.025071] mem auto-init: stack:all(zero), heap alloc:on, heap free:off332second # [ 0.231939] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)333test # [ 0.027431] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1334test # [ 0.029105] allocated 2097152 bytes of page_ext335second # [ 0.233027] x86/cpu: User Mode Instruction Prevention (UMIP) activated336test # [ 0.038795] ftrace: allocating 48798 entries in 192 pages337test # [ 0.038799] ftrace: allocated 192 pages with 2 groups338second # [ 0.234061] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127339test # [ 0.039533] Dynamic Preempt: lazy340second # [ 0.235937] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0341test # [ 0.039634] rcu: Preemptible hierarchical RCU implementation.342test # [ 0.039634] rcu: RCU event tracing is enabled.343test # [ 0.039635] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.344second # [ 0.236941] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto345test # [ 0.039636] Trampoline variant of Tasks RCU enabled.346test # [ 0.039637] Rude variant of Tasks RCU enabled.347second # [ 0.237938] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl348test # [ 0.039637] Tracing variant of Tasks RCU enabled.349second # [ 0.238938] Spectre V2 : Mitigation: Enhanced / Automatic IBRS350test # [ 0.039638] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.351second # [ 0.239937] Speculative Return Stack Overflow: Mitigation: Safe RET352test # [ 0.039638] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1353second # [ 0.240937] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization354test # [ 0.039647] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.355test # [ 0.039648] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.356test # [ 0.039649] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.357test # [ 0.042991] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16358second # [ 0.242943] Spectre V2 : Enabling IBPB for BPF359test # [ 0.043258] rcu: srcu_init: Setting srcu_struct sizes based on contention.360second # [ 0.244939] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier361test # [ 0.043266] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns362second # [ 0.245938] active return thunk: srso_alias_return_thunk363test # [ 0.043428] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)364test # [ 0.048866] Console: colour VGA+ 80x25365second # [ 0.247959] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'366test # [ 0.048870] printk: legacy console [tty0] enabled367second # [ 0.248937] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'368test # [ 0.081106] printk: legacy console [ttyS0] enabled369test # [ 0.220991] ACPI: Core revision 20250807370second # [ 0.249937] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'371second # [ 0.251937] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'372test # [ 0.222049] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns373second # [ 0.252937] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'374test # [ 0.224012] APIC: Switch to symmetric I/O mode setup375test # [ 0.225195] x2apic enabled376second # [ 0.253937] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'377test # [ 0.226018] APIC: Switched APIC routing to: physical x2apic378second # [ 0.254937] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'379second # [ 0.255937] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'380test # [ 0.228009] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1381second # [ 0.256937] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'382test # [ 0.229255] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns383second # [ 0.257938] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256384test # [ 0.231369] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)385second # [ 0.259937] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64386second # [ 0.260937] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512387test # [ 0.232454] x86/cpu: User Mode Instruction Prevention (UMIP) activated388second # [ 0.261937] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024389test # [ 0.233513] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127390second # [ 0.262937] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8391test # [ 0.234368] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0392second # [ 0.264937] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16393test # [ 0.236371] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto394second # [ 0.265937] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24395test # [ 0.237368] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl396second # [ 0.266937] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.397test # [ 0.238368] Spectre V2 : Mitigation: Enhanced / Automatic IBRS398test # [ 0.239368] Speculative Return Stack Overflow: Mitigation: Safe RET399test # [ 0.240367] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization400test # [ 0.241373] Spectre V2 : Enabling IBPB for BPF401test # [ 0.243100] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier402test # [ 0.244369] active return thunk: srso_alias_return_thunk403test # [ 0.245389] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'404test # [ 0.247367] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'405test # [ 0.248367] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'406test # [ 0.249367] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'407test # [ 0.251367] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'408test # [ 0.252367] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'409test # [ 0.253367] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'410test # [ 0.255367] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'411test # [ 0.256367] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'412test # [ 0.258368] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256413test # [ 0.259370] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64414second # [ 0.294755] Freeing SMP alternatives memory: 44K415second # [ 0.295687] pid_max: default: 32768 minimum: 301416test # [ 0.260368] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512417second # [ 0.296744] LSM: initializing lsm=capability,landlock,yama,bpf,ima418test # [ 0.261368] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024419second # [ 0.298026] landlock: Up and running.420test # [ 0.262368] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8421second # [ 0.298825] Yama: becoming mindful.422test # [ 0.264368] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16423second # [ 0.299711] LSM support for eBPF active424test # [ 0.265368] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24425second # [ 0.300647] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)426test # [ 0.266368] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.427second # [ 0.301955] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)428second # [ 0.303709] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)429second # [ 0.304348] Performance Events: Fam17h+ core perfctr, AMD PMU driver.430second # [ 0.304941] ... version: 2431second # [ 0.305850] ... bit width: 48432second # [ 0.306663] ... generic counters: 6433second # [ 0.306951] ... generic bitmap: 000000000000003f434second # [ 0.307939] ... fixed-purpose counters: 0435second # [ 0.308843] ... fixed-purpose bitmap: 0000000000000000436second # [ 0.309861] ... value mask: 0000ffffffffffff437second # [ 0.310858] ... max period: 00007fffffffffff438second # [ 0.311851] ... global_ctrl mask: 000000000000003f439second # [ 0.312942] signal: max sigframe size: 3376440second # [ 0.313887] rcu: Hierarchical SRCU implementation.441second # [ 0.314723] rcu: Max phase no-delay instances is 400.442second # [ 0.318066] smp: Bringing up secondary CPUs ...443second # [ 0.318951] smp: Brought up 1 node, 1 CPU444second # [ 0.319796] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)445second # [ 0.321077] Memory: 943000K/1048024K available (17259K kernel code, 2728K rwdata, 13652K rodata, 3656K init, 2968K bss, 97600K reserved, 0K cma-reserved)446second # [ 0.322107] devtmpfs: initialized447test # [ 0.296035] Freeing SMP alternatives memory: 44K448second # [ 0.322997] x86/mm: Memory block size: 128MB449test # [ 0.296371] pid_max: default: 32768 minimum: 301450second # [ 0.324628] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)451test # [ 0.297434] LSM: initializing lsm=capability,landlock,yama,bpf,ima452test # [ 0.299436] landlock: Up and running.453test # [ 0.300226] Yama: becoming mindful.454second # [ 0.324960] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).455test # [ 0.301142] LSM support for eBPF active456second # [ 0.326015] pinctrl core: initialized pinctrl subsystem457second # [ 0.327210] PM: RTC time: 20:02:03, date: 2026-09-22458test # [ 0.302085] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)459test # [ 0.303388] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)460second # [ 0.330005] NET: Registered PF_NETLINK/PF_ROUTE protocol family461test # [ 0.305994] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)462second # [ 0.331292] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations463test # [ 0.306789] Performance Events: Fam17h+ core perfctr, AMD PMU driver.464second # [ 0.331955] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations465test # [ 0.307372] ... version: 2466test # [ 0.308278] ... bit width: 48467second # [ 0.333048] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations468test # [ 0.309090] ... generic counters: 6469second # [ 0.333948] audit: initializing netlink subsys (disabled)470test # [ 0.309384] ... generic bitmap: 000000000000003f471second # [ 0.335135] thermal_sys: Registered thermal governor 'fair_share'472test # [ 0.310369] ... fixed-purpose counters: 0473second # [ 0.335137] thermal_sys: Registered thermal governor 'bang_bang'474test # [ 0.311281] ... fixed-purpose bitmap: 0000000000000000475second # [ 0.335939] thermal_sys: Registered thermal governor 'step_wise'476test # [ 0.312278] ... value mask: 0000ffffffffffff477test # [ 0.313278] ... max period: 00007fffffffffff478second # [ 0.336942] audit: type=2000 audit(1790107324.244:1): state=initialized audit_enabled=0 res=1479test # [ 0.314270] ... global_ctrl mask: 000000000000003f480second # [ 0.338940] thermal_sys: Registered thermal governor 'user_space'481test # [ 0.315425] signal: max sigframe size: 3376482second # [ 0.338942] thermal_sys: Registered thermal governor 'power_allocator'483test # [ 0.316411] rcu: Hierarchical SRCU implementation.484second # [ 0.339962] cpuidle: using governor menu485test # [ 0.317374] rcu: Max phase no-delay instances is 400.486second # [ 0.342614] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5487second # [ 0.343157] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]488test # [ 0.321513] smp: Bringing up secondary CPUs ...489second # [ 0.343941] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry490test # [ 0.322382] smp: Brought up 1 node, 1 CPU491second # [ 0.344949] PCI: Using configuration type 1 for base access492test # [ 0.323235] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)493second # [ 0.346095] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.494test # [ 0.324476] Memory: 943240K/1048024K available (17259K kernel code, 2728K rwdata, 13652K rodata, 3656K init, 2968K bss, 97588K reserved, 0K cma-reserved)495test # [ 0.325548] devtmpfs: initialized496test # [ 0.326528] x86/mm: Memory block size: 128MB497test # [ 0.328065] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)498test # [ 0.328394] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).499second # [ 0.353120] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages500test # [ 0.329455] pinctrl core: initialized pinctrl subsystem501second # [ 0.353939] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page502test # [ 0.330607] PM: RTC time: 20:02:03, date: 2026-09-22503test # [ 0.333453] NET: Registered PF_NETLINK/PF_ROUTE protocol family504second # [ 0.358939] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages505test # [ 0.334654] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations506second # [ 0.359940] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page507test # [ 0.335384] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations508test # [ 0.336477] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations509test # [ 0.337378] audit: initializing netlink subsys (disabled)510test # [ 0.338581] thermal_sys: Registered thermal governor 'fair_share'511test # [ 0.338583] thermal_sys: Registered thermal governor 'bang_bang'512test # [ 0.339370] thermal_sys: Registered thermal governor 'step_wise'513second # [ 0.367241] ACPI: Added _OSI(Module Device)514second # [ 0.367939] ACPI: Added _OSI(Processor Device)515test # [ 0.340374] audit: type=2000 audit(1790107324.284:1): state=initialized audit_enabled=0 res=1516second # [ 0.368853] ACPI: Added _OSI(Processor Aggregator Device)517test # [ 0.342371] thermal_sys: Registered thermal governor 'user_space'518test # [ 0.342373] thermal_sys: Registered thermal governor 'power_allocator'519test # [ 0.343386] cpuidle: using governor menu520test # [ 0.346061] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5521second # [ 0.373832] ACPI: 1 ACPI AML tables successfully acquired and loaded522test # [ 0.346667] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]523test # [ 0.347372] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry524test # [ 0.348383] PCI: Using configuration type 1 for base access525second # [ 0.379801] ACPI: Interpreter enabled526test # [ 0.349567] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.527second # [ 0.380557] ACPI: PM: (supports S0 S3 S4 S5)528second # [ 0.380939] ACPI: Using IOAPIC for interrupt routing529second # [ 0.383162] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug530second # [ 0.383948] PCI: Using E820 reservations for host bridge windows531second # [ 0.385059] ACPI: Enabled 2 GPEs in block 00 to 3F532test # [ 0.356585] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages533test # [ 0.357369] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page534second # [ 0.389445] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])535second # [ 0.389945] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]536second # [ 0.391011] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]537test # [ 0.362369] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages538second # [ 0.392040] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]539test # [ 0.363372] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page540second # [ 0.393382] PCI host bridge to bus 0000:00541second # [ 0.393945] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]542second # [ 0.394940] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]543second # [ 0.395940] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]544second # [ 0.396940] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]545test # [ 0.370800] ACPI: Added _OSI(Module Device)546second # [ 0.397940] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]547test # [ 0.371380] ACPI: Added _OSI(Processor Device)548second # [ 0.398940] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]549test # [ 0.372315] ACPI: Added _OSI(Processor Aggregator Device)550second # [ 0.399940] pci_bus 0000:00: root bus resource [bus 00-ff]551second # [ 0.401081] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint552second # [ 0.402596] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint553test # [ 0.377243] ACPI: 1 ACPI AML tables successfully acquired and loaded554second # [ 0.404985] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]555test # [ 0.383347] ACPI: Interpreter enabled556second # [ 0.405960] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]557test # [ 0.384053] ACPI: PM: (supports S0 S3 S4 S5)558second # [ 0.406982] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]559test # [ 0.384370] ACPI: Using IOAPIC for interrupt routing560second # [ 0.408118] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]561second # [ 0.409722] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint562test # [ 0.387414] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug563test # [ 0.388371] PCI: Using E820 reservations for host bridge windows564test # [ 0.390183] ACPI: Enabled 2 GPEs in block 00 to 3F565second # [ 0.412852] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]566second # [ 0.413883] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]567second # [ 0.414939] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]568second # [ 0.415950] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]569test # [ 0.394466] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])570test # [ 0.395376] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]571second # [ 0.418284] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint572test # [ 0.396457] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]573test # [ 0.397469] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]574second # [ 0.420951] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]575test # [ 0.398830] PCI host bridge to bus 0000:00576second # [ 0.421950] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]577test # [ 0.399374] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]578second # [ 0.422979] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]579test # [ 0.400372] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]580second # [ 0.424889] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint581test # [ 0.401370] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]582test # [ 0.402370] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]583test # [ 0.403370] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]584second # [ 0.427950] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]585test # [ 0.404374] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]586second # [ 0.428952] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]587test # [ 0.405371] pci_bus 0000:00: root bus resource [bus 00-ff]588second # [ 0.429984] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]589test # [ 0.406559] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint590second # [ 0.431895] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint591test # [ 0.408104] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint592second # [ 0.433956] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]593second # [ 0.434950] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]594second # [ 0.435983] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]595test # [ 0.411496] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]596second # [ 0.436952] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]597test # [ 0.412395] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]598test # [ 0.413414] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]599second # [ 0.438924] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint600test # [ 0.414702] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]601second # [ 0.440961] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]602second # [ 0.441983] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]603test # [ 0.416233] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint604second # [ 0.443875] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint605test # [ 0.419394] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]606second # [ 0.445879] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]607test # [ 0.420382] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]608second # [ 0.446972] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]609test # [ 0.421409] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]610test # [ 0.422380] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]611second # [ 0.448916] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint612test # [ 0.424405] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint613second # [ 0.450962] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]614second # [ 0.451985] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]615test # [ 0.426384] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]616test # [ 0.427381] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]617test # [ 0.428414] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]618second # [ 0.454457] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint619second # [ 0.455961] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]620test # [ 0.430338] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint621second # [ 0.456979] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]622test # [ 0.433744] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]623second # [ 0.458867] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint624test # [ 0.434379] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]625test # [ 0.435408] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]626second # [ 0.461952] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]627test # [ 0.437304] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint628second # [ 0.462952] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]629test # [ 0.439380] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]630second # [ 0.463985] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]631test # [ 0.440380] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]632second # [ 0.465960] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint633test # [ 0.441409] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]634test # [ 0.442380] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]635second # [ 0.468812] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]636test # [ 0.444265] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint637second # [ 0.469837] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]638second # [ 0.470979] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]639test # [ 0.446282] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]640test # [ 0.447388] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]641test # [ 0.449268] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint642second # [ 0.472952] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint643second # [ 0.474932] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]644test # [ 0.451295] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]645test # [ 0.452409] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]646test # [ 0.454340] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint647test # [ 0.456390] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]648test # [ 0.457409] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]649second # [ 0.476403] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint650test # [ 0.459272] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint651second # [ 0.479545] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]652test # [ 0.461253] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]653test # [ 0.462388] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]654second # [ 0.480214] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint655second # [ 0.481989] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]656test # [ 0.464271] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint657second # [ 0.483264] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint658test # [ 0.466380] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]659test # [ 0.467380] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]660second # [ 0.484950] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]661test # [ 0.468409] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]662second # [ 0.486325] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint663test # [ 0.470278] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint664second # [ 0.487471] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO665test # [ 0.473758] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]666second # [ 0.488376] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint667test # [ 0.474384] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]668second # [ 0.489990] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]669test # [ 0.475417] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]670second # [ 0.490951] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]671test # [ 0.477506] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint672second # [ 0.492477] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint673second # [ 0.493704] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]674test # [ 0.479370] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]675second # [ 0.498760] ACPI: PCI: Interrupt link LNKA configured for IRQ 10676second # [ 0.500085] ACPI: PCI: Interrupt link LNKB configured for IRQ 10677second # [ 0.501061] ACPI: PCI: Interrupt link LNKC configured for IRQ 11678second # [ 0.502058] ACPI: PCI: Interrupt link LNKD configured for IRQ 11679test # [ 0.481234] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint680second # [ 0.503057] ACPI: PCI: Interrupt link LNKE configured for IRQ 10681second # [ 0.504060] ACPI: PCI: Interrupt link LNKF configured for IRQ 10682test # [ 0.483190] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]683second # [ 0.505065] ACPI: PCI: Interrupt link LNKG configured for IRQ 11684test # [ 0.484636] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint685second # [ 0.506058] ACPI: PCI: Interrupt link LNKH configured for IRQ 11686second # [ 0.506993] ACPI: PCI: Interrupt link GSIA configured for IRQ 16687test # [ 0.486215] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]688second # [ 0.507961] ACPI: PCI: Interrupt link GSIB configured for IRQ 17689second # [ 0.508957] ACPI: PCI: Interrupt link GSIC configured for IRQ 18690test # [ 0.487635] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint691second # [ 0.509957] ACPI: PCI: Interrupt link GSID configured for IRQ 19692test # [ 0.489152] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]693second # [ 0.510955] ACPI: PCI: Interrupt link GSIE configured for IRQ 20694second # [ 0.511955] ACPI: PCI: Interrupt link GSIF configured for IRQ 21695test # [ 0.490771] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint696second # [ 0.512953] ACPI: PCI: Interrupt link GSIG configured for IRQ 22697second # [ 0.513963] ACPI: PCI: Interrupt link GSIH configured for IRQ 23698test # [ 0.491900] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO699second # [ 0.515893] iommu: Default domain type: Translated700test # [ 0.492744] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint701second # [ 0.516754] iommu: DMA domain TLB invalidation policy: lazy mode702second # [ 0.518205] ACPI: bus type USB registered703test # [ 0.494419] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]704second # [ 0.519004] usbcore: registered new interface driver usbfs705test # [ 0.495381] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]706second # [ 0.519959] usbcore: registered new interface driver hub707second # [ 0.520951] usbcore: registered new device driver usb708test # [ 0.496896] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint709second # [ 0.522621] NetLabel: Initializing710second # [ 0.522944] NetLabel: domain hash size = 128711test # [ 0.498206] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]712second # [ 0.523888] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO713second # [ 0.524930] NetLabel: unlabeled traffic allowed by default714second # [ 0.525895] PCI: Using ACPI for IRQ routing715test # [ 0.504953] ACPI: PCI: Interrupt link LNKA configured for IRQ 10716test # [ 0.505596] ACPI: PCI: Interrupt link LNKB configured for IRQ 10717test # [ 0.506560] ACPI: PCI: Interrupt link LNKC configured for IRQ 11718test # [ 0.507568] ACPI: PCI: Interrupt link LNKD configured for IRQ 11719test # [ 0.508555] ACPI: PCI: Interrupt link LNKE configured for IRQ 10720test # [ 0.509560] ACPI: PCI: Interrupt link LNKF configured for IRQ 10721test # [ 0.510568] ACPI: PCI: Interrupt link LNKG configured for IRQ 11722test # [ 0.511565] ACPI: PCI: Interrupt link LNKH configured for IRQ 11723test # [ 0.512428] ACPI: PCI: Interrupt link GSIA configured for IRQ 16724test # [ 0.513440] ACPI: PCI: Interrupt link GSIB configured for IRQ 17725test # [ 0.514450] ACPI: PCI: Interrupt link GSIC configured for IRQ 18726test # [ 0.515435] ACPI: PCI: Interrupt link GSID configured for IRQ 19727test # [ 0.516428] ACPI: PCI: Interrupt link GSIE configured for IRQ 20728test # [ 0.517387] ACPI: PCI: Interrupt link GSIF configured for IRQ 21729test # [ 0.518394] ACPI: PCI: Interrupt link GSIG configured for IRQ 22730test # [ 0.519387] ACPI: PCI: Interrupt link GSIH configured for IRQ 23731test # [ 0.521693] iommu: Default domain type: Translated732test # [ 0.522379] iommu: DMA domain TLB invalidation policy: lazy mode733test # [ 0.523598] ACPI: bus type USB registered734test # [ 0.524456] usbcore: registered new interface driver usbfs735test # [ 0.525390] usbcore: registered new interface driver hub736test # [ 0.526385] usbcore: registered new device driver usb737test # [ 0.528182] NetLabel: Initializing738test # [ 0.528996] NetLabel: domain hash size = 128739test # [ 0.529370] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO740test # [ 0.530441] NetLabel: unlabeled traffic allowed by default741test # [ 0.531385] PCI: Using ACPI for IRQ routing742second # [ 0.607416] pci 0000:00:01.0: vgaarb: setting as boot VGA device743second # [ 0.607935] pci 0000:00:01.0: vgaarb: bridge control possible744second # [ 0.607935] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none745second # [ 0.607945] vgaarb: loaded746second # [ 0.608776] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0747second # [ 0.609747] hpet0: 3 comparators, 64-bit 100.000000 MHz counter748second # [ 0.614028] clocksource: Switched to clocksource kvm-clock749second # [ 0.615984] VFS: Disk quotas dquot_6.6.0750second # [ 0.618597] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)751second # [ 0.620268] pnp: PnP ACPI init752second # [ 0.621178] ACPI: IRQ 4 override to edge(!), high(!)753second # [ 0.622339] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved754second # [ 0.624205] pnp: PnP ACPI: found 5 devices755second # [ 0.631423] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns756second # [ 0.633223] clocksource: Switched to clocksource acpi_pm757second # [ 0.634429] NET: Registered PF_INET protocol family758second # [ 0.635623] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)759second # [ 0.648976] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)760second # [ 0.651026] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)761second # [ 0.652802] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)762second # [ 0.654539] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)763second # [ 0.656182] TCP: Hash tables configured (established 8192 bind 8192)764test # [ 0.615310] pci 0000:00:01.0: vgaarb: setting as boot VGA device765second # [ 0.657668] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)766test # [ 0.615365] pci 0000:00:01.0: vgaarb: bridge control possible767second # [ 0.659392] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)768test # [ 0.615365] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none769second # [ 0.660840] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)770test # [ 0.615386] vgaarb: loaded771second # [ 0.662358] NET: Registered PF_UNIX/PF_LOCAL protocol family772test # [ 0.616219] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0773second # [ 0.663592] NET: Registered PF_XDP protocol family774test # [ 0.617176] hpet0: 3 comparators, 64-bit 100.000000 MHz counter775second # [ 0.664653] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]776second # [ 0.665953] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]777second # [ 0.667238] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]778second # [ 0.668653] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]779second # [ 0.670053] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]780test # [ 0.624478] clocksource: Switched to clocksource kvm-clock781second # [ 0.671515] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]782second # [ 0.673542] ACPI: \_SB_.GSIA: Enabled at IRQ 16783test # [ 0.627555] VFS: Disk quotas dquot_6.6.0784second # [ 0.675541] ACPI: \_SB_.GSIB: Enabled at IRQ 17785test # [ 0.628452] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)786test # [ 0.630091] pnp: PnP ACPI init787second # [ 0.677447] ACPI: \_SB_.GSIC: Enabled at IRQ 18788test # [ 0.630995] ACPI: IRQ 4 override to edge(!), high(!)789second # [ 0.679337] ACPI: \_SB_.GSID: Enabled at IRQ 19790test # [ 0.632175] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved791test # [ 0.634012] pnp: PnP ACPI: found 5 devices792second # [ 0.681015] PCI: CLS 0 bytes, default 64793second # [ 0.682065] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns794second # [ 0.684226] Trying to unpack rootfs image as initramfs...795test # [ 0.641238] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns796test # [ 0.643043] clocksource: Switched to clocksource acpi_pm797test # [ 0.644271] NET: Registered PF_INET protocol family798test # [ 0.645477] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)799test # [ 0.658950] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)800test # [ 0.660845] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)801test # [ 0.662486] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)802test # [ 0.664157] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)803test # [ 0.665685] TCP: Hash tables configured (established 8192 bind 8192)804test # [ 0.667092] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)805test # [ 0.668700] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)806test # [ 0.670171] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)807test # [ 0.671691] NET: Registered PF_UNIX/PF_LOCAL protocol family808second # [ 0.719565] Initialise system trusted keyrings809test # [ 0.672961] NET: Registered PF_XDP protocol family810test # [ 0.674066] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]811test # [ 0.675387] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]812second # [ 0.723268] workingset: timestamp_bits=40 max_order=18 bucket_order=0813test # [ 0.676673] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]814test # [ 0.678085] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]815test # [ 0.679507] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]816test # [ 0.680908] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]817test # [ 0.682937] ACPI: \_SB_.GSIA: Enabled at IRQ 16818test # [ 0.684995] ACPI: \_SB_.GSIB: Enabled at IRQ 17819test # [ 0.686965] ACPI: \_SB_.GSIC: Enabled at IRQ 18820test # [ 0.688902] ACPI: \_SB_.GSID: Enabled at IRQ 19821test # [ 0.690665] PCI: CLS 0 bytes, default 64822second # [ 0.738274] Key type asymmetric registered823test # [ 0.691740] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns824test # [ 0.693849] Trying to unpack rootfs image as initramfs...825second # [ 0.741244] Asymmetric key parser 'x509' registered826second # [ 0.742466] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)827second # [ 0.749364] io scheduler mq-deadline registered828second # [ 0.750466] io scheduler kyber registered829second # [ 0.753755] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled830second # [ 0.757392] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A831second # [ 0.763160] Linux agpgart interface v0.103832second # [ 0.764148] ACPI: bus type drm_connector registered833second # [ 0.767647] usbcore: registered new interface driver usbserial_generic834second # [ 0.769011] usbserial: USB Serial support registered for generic835second # [ 0.772262] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.836second # [ 0.772262] Please enable it if your BIOS has the CPPC option.837second # [ 0.775001] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled838test # [ 0.732271] Initialise system trusted keyrings839second # [ 0.781370] drop_monitor: Initializing network drop monitor service840test # [ 0.735293] workingset: timestamp_bits=40 max_order=18 bucket_order=0841second # [ 0.782807] NET: Registered PF_INET6 protocol family842second # [ 0.786681] Segment Routing with IPv6843second # [ 0.790248] In-situ OAM (IOAM) with IPv6844second # [ 0.791489] IPI shorthand broadcast: enabled845second # [ 0.796910] sched_clock: Marking stable (613021220, 183191834)->(893045132, -96832078)846test # [ 0.751874] Key type asymmetric registered847second # [ 0.803395] registered taskstats version 1848test # [ 0.757147] Asymmetric key parser 'x509' registered849second # [ 0.804497] Loading compiled-in X.509 certificates850test # [ 0.758334] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)851test # [ 0.764245] io scheduler mq-deadline registered852test # [ 0.765246] io scheduler kyber registered853test # [ 0.768626] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled854second # [ 0.818025] Demotion targets for Node 0: null855test # [ 0.772148] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A856second # [ 0.821266] Key type .fscrypt registered857second # [ 0.822111] Key type fscrypt-provisioning registered858test # [ 0.777278] Linux agpgart interface v0.103859test # [ 0.778241] ACPI: bus type drm_connector registered860second # [ 0.825324] ima: No TPM chip found, activating TPM-bypass!861second # [ 0.826479] ima: Allocated hash algorithm: sha1862test # [ 0.781480] usbcore: registered new interface driver usbserial_generic863second # [ 0.829263] ima: No architecture policies found864test # [ 0.782841] usbserial: USB Serial support registered for generic865second # [ 0.832237] PM: Magic number: 10:755:43866test # [ 0.786149] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.867second # [ 0.833958] RAS: Correctable Errors collector initialized.868test # [ 0.786149] Please enable it if your BIOS has the CPPC option.869test # [ 0.788965] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled870second # [ 0.842082] clk: Disabling unused clocks871test # [ 0.795280] drop_monitor: Initializing network drop monitor service872test # [ 0.796775] NET: Registered PF_INET6 protocol family873second # [ 0.844228] PM: genpd: Disabling unused power domains874test # [ 0.800539] Segment Routing with IPv6875test # [ 0.804149] In-situ OAM (IOAM) with IPv6876test # [ 0.805373] IPI shorthand broadcast: enabled877test # [ 0.810809] sched_clock: Marking stable (627021064, 183100412)->(918151316, -108029840)878test # [ 0.817300] registered taskstats version 1879test # [ 0.818398] Loading compiled-in X.509 certificates880test # [ 0.832149] Demotion targets for Node 0: null881test # [ 0.835187] Key type .fscrypt registered882test # [ 0.836045] Key type fscrypt-provisioning registered883test # [ 0.839254] ima: No TPM chip found, activating TPM-bypass!884test # [ 0.840406] ima: Allocated hash algorithm: sha1885test # [ 0.843163] ima: No architecture policies found886test # [ 0.846142] PM: Magic number: 10:755:43887test # [ 0.847896] RAS: Correctable Errors collector initialized.888test # [ 0.855983] clk: Disabling unused clocks889test # [ 0.859152] PM: genpd: Disabling unused power domains890second # [ 0.960782] Freeing initrd memory: 29096K891second # [ 0.963584] Freeing unused decrypted memory: 2028K892second # [ 0.966063] Freeing unused kernel image (initmem) memory: 3656K893second # [ 0.967406] Write protecting the kernel read-only data: 32768k894second # [ 0.969334] Freeing unused kernel image (text/rodata gap) memory: 1172K895second # [ 0.971007] Freeing unused kernel image (rodata/data gap) memory: 684K896second # [ 1.003847] x86/mm: Checked W+X mappings: passed, no W+X pages found.897second # [ 1.005180] Run /init as init process898second # [ 1.014075] systemd[1]: Inserted module 'autofs4'899second # [ 1.029564] fuse: init (API version 7.45)900test # [ 0.984621] Freeing initrd memory: 29084K901test # [ 0.987655] Freeing unused decrypted memory: 2028K902second # [ 1.035797] ACPI: \_SB_.GSIG: Enabled at IRQ 22903test # [ 0.990361] Freeing unused kernel image (initmem) memory: 3656K904second # [ 1.038410] ACPI: \_SB_.GSIH: Enabled at IRQ 23905test # [ 0.991774] Write protecting the kernel read-only data: 32768k906second # [ 1.041851] ACPI: \_SB_.GSIE: Enabled at IRQ 20907test # [ 0.993880] Freeing unused kernel image (text/rodata gap) memory: 1172K908test # [ 0.995647] Freeing unused kernel image (rodata/data gap) memory: 684K909second # [ 1.044719] ACPI: \_SB_.GSIF: Enabled at IRQ 21910second # [ 1.050177] virtiofs virtio5: discovered new tag: nix-store911second # [ 1.052320] virtiofs virtio5: virtio_fs_setup_dax: No cache capability912second # [ 1.059457] virtiofs virtio6: discovered new tag: shared913second # [ 1.061463] virtiofs virtio6: virtio_fs_setup_dax: No cache capability914second # [ 1.064881] virtiofs virtio7: discovered new tag: xchg915second # [ 1.066892] virtiofs virtio7: virtio_fs_setup_dax: No cache capability916test # [ 1.028501] x86/mm: Checked W+X mappings: passed, no W+X pages found.917test # [ 1.029940] Run /init as init process918test # [ 1.038814] systemd[1]: Inserted module 'autofs4'919second # [ 1.085815] systemd[1]: Successfully made /usr/ read-only.920test # [ 1.054281] fuse: init (API version 7.45)921test # [ 1.060299] ACPI: \_SB_.GSIG: Enabled at IRQ 22922test # [ 1.062967] ACPI: \_SB_.GSIH: Enabled at IRQ 23923test # [ 1.066380] ACPI: \_SB_.GSIE: Enabled at IRQ 20924test # [ 1.068978] ACPI: \_SB_.GSIF: Enabled at IRQ 21925test # [ 1.074641] virtiofs virtio5: discovered new tag: nix-store926test # [ 1.076835] virtiofs virtio5: virtio_fs_setup_dax: No cache capability927test # [ 1.084278] virtiofs virtio6: discovered new tag: shared928test # [ 1.086281] virtiofs virtio6: virtio_fs_setup_dax: No cache capability929test # [ 1.089627] virtiofs virtio7: discovered new tag: xchg930test # [ 1.091606] virtiofs virtio7: virtio_fs_setup_dax: No cache capability931test # [ 1.109493] systemd[1]: Successfully made /usr/ read-only.932second # [ 1.422037] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)933second # [ 1.427958] systemd[1]: Detected virtualization kvm.934second # [ 1.429115] systemd[1]: Detected architecture x86-64.935second # [ 1.430288] systemd[1]: Running in initrd.936second # [ 1.431505] systemd[1]: Initializing machine ID from random generator.937second # [ 1.433007] systemd[1]: Hostname set to <second>.938test # [ 1.445423] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)939test # [ 1.451421] systemd[1]: Detected virtualization kvm.940test # [ 1.452519] systemd[1]: Detected architecture x86-64.941test # [ 1.453601] systemd[1]: Running in initrd.942test # [ 1.454767] systemd[1]: Initializing machine ID from random generator.943test # [ 1.456202] systemd[1]: Hostname set to <test>.944second # [ 1.604705] systemd[1]: bpf-restrict-fs: LSM BPF program attached945second # [ 1.634424] systemd[1]: Queued start job for default target Initrd Default Target.946second # [ 1.638449] systemd[1]: Created slice Slice /system/modprobe.947second # [ 1.639889] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.948second # [ 1.641630] systemd[1]: Expecting device /dev/disk/by-label/nixos...949second # [ 1.643012] systemd[1]: Reached target Path Units.950second # [ 1.644117] systemd[1]: Reached target Slice Units.951second # [ 1.645264] systemd[1]: Reached target Swaps.952second # [ 1.646288] systemd[1]: Reached target Timer Units.953second # [ 1.647502] systemd[1]: Listening on D-Bus System Message Bus Socket.954second # [ 1.649001] systemd[1]: Listening on Journal Socket (/dev/log).955second # [ 1.650467] systemd[1]: Listening on Journal Sockets.956second # [ 1.651701] systemd[1]: Listening on udev Control Socket.957second # [ 1.661629] systemd[1]: Listening on udev Kernel Socket.958second # [ 1.662868] systemd[1]: Reached target Socket Units.959second # [ 1.665116] systemd[1]: Starting Create List of Static Device Nodes...960second # [ 1.671313] systemd[1]: Starting Load Kernel Module configfs...961test # [ 1.630063] systemd[1]: bpf-restrict-fs: LSM BPF program attached962second # [ 1.679691] systemd[1]: Starting Journal Service...963second # [ 1.688282] systemd[1]: Starting Load Kernel Modules...964second # [ 1.691587] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os965second # [ 1.696790] systemd[1]: Starting Coldplug All udev Devices...966test # [ 1.661548] systemd[1]: Queued start job for default target Initrd Default Target.967test # [ 1.666332] systemd[1]: Created slice Slice /system/modprobe.968second # [ 1.713684] systemd[1]: Finished Create List of Static Device Nodes.969test # [ 1.667840] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.970test # [ 1.669669] systemd[1]: Expecting device /dev/disk/by-label/nixos...971test # [ 1.671120] systemd[1]: Reached target Path Units.972test # [ 1.672234] systemd[1]: Reached target Slice Units.973test # [ 1.673361] systemd[1]: Reached target Swaps.974test # [ 1.674392] systemd[1]: Reached target Timer Units.975second # [ 1.720844] systemd[1]: modprobe@configfs.service: Deactivated successfully.976test # [ 1.675614] systemd[1]: Listening on D-Bus System Message Bus Socket.977second # [ 1.722625] systemd-journald[65]: Collecting audit messages is disabled.978test # [ 1.677169] systemd[1]: Listening on Journal Socket (/dev/log).979test # [ 1.678625] systemd[1]: Listening on Journal Sockets.980second # [ 1.728703] systemd[1]: Finished Load Kernel Module configfs.981test # [ 1.679857] systemd[1]: Listening on udev Control Socket.982test # [ 1.689573] systemd[1]: Listening on udev Kernel Socket.983second # [ 1.735714] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config984test # [ 1.690780] systemd[1]: Reached target Socket Units.985test # [ 1.692771] systemd[1]: Starting Create List of Static Device Nodes...986second # [ 1.740243] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.987test # [ 1.696846] systemd[1]: Starting Load Kernel Module configfs...988second # [ 1.746969] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...989second # [ 1.751346] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev990test # [ 1.706435] systemd[1]: Starting Journal Service...991test # [ 1.714006] systemd[1]: Starting Load Kernel Modules...992test # [ 1.717225] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993test # [ 1.721652] systemd[1]: Starting Coldplug All udev Devices...994second # [ 1.782866] systemd[1]: Finished Load Kernel Modules.995test # [ 1.739190] systemd[1]: Finished Create List of Static Device Nodes.996second # [ 1.787939] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.997test # [ 1.744718] systemd[1]: modprobe@configfs.service: Deactivated successfully.998test # [ 1.748561] systemd-journald[65]: Collecting audit messages is disabled.999second # [ 1.796389] systemd[1]: Starting Apply Kernel Variables...1000test # [ 1.754190] systemd[1]: Finished Load Kernel Module configfs.1001second # [ 1.807368] systemd[1]: Starting Create Static Device Nodes in /dev...1002test # [ 1.761630] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1003test # [ 1.765718] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1004test # [ 1.773302] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1005test # [ 1.776242] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1006second # [ 1.835099] systemd[1]: Finished Apply Kernel Variables.1007second # [ 1.840888] systemd[1]: Finished Create Static Device Nodes in /dev.1008second # [ 1.846468] systemd[1]: Reached target Preparation for Local File Systems.1009second # [ 1.850287] systemd[1]: Reached target Local File Systems.1010test # [ 1.806724] systemd[1]: Finished Load Kernel Modules.1011second # [ 1.856373] systemd[1]: Starting Rule-based Manager for Device Events and Files...1012test # [ 1.811225] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1013second # [ 1.676724] systemd-modules-load[66]: Inserted module 'dm_mod'1014second # [ 1.680151] systemd-modules-load[66]: Inserted module 'virtio_balloon'1015second # [ 1.681416] systemd-modules-load[66]: Inserted module 'virtio_gpu'1016test # [ 1.819277] systemd[1]: Starting Apply Kernel Variables...1017second # [ 1.869390] systemd[1]: Started Journal Service.1018test # [ 1.831671] systemd[1]: Starting Create Static Device Nodes in /dev...1019second # [ 1.702088] systemd[1]: Starting Create System Files and Directories...1020test # [ 1.849266] systemd[1]: Finished Apply Kernel Variables.1021second # [ 1.720481] systemd[1]: Finished Create System Files and Directories.1022test # [ 1.860745] systemd[1]: Finished Create Static Device Nodes in /dev.1023second # [ 1.726376] systemd-udevd[73]: Using default interface naming scheme 'v261'.1024test # [ 1.864360] systemd[1]: Reached target Preparation for Local File Systems.1025test # [ 1.870199] systemd[1]: Reached target Local File Systems.1026test # [ 1.876273] systemd[1]: Starting Rule-based Manager for Device Events and Files...1027second # [ 1.748711] systemd[1]: Started Rule-based Manager for Device Events and Files.1028test # [ 1.887276] systemd[1]: Started Journal Service.1029test # [ 1.701984] systemd-modules-load[66]: Inserted module 'dm_mod'1030test # [ 1.706217] systemd-modules-load[66]: Inserted module 'virtio_balloon'1031test # [ 1.707500] systemd-modules-load[66]: Inserted module 'virtio_gpu'1032second # [ 1.754737] systemd[1]: Finished Coldplug All udev Devices.1033second # [ 1.755967] systemd[1]: Reached target System Initialization.1034second # [ 1.757140] systemd[1]: Reached target Basic System.1035test # [ 1.717155] systemd[1]: Starting Create System Files and Directories...1036test # [ 1.743615] systemd[1]: Finished Create System Files and Directories.1037test # [ 1.749244] systemd-udevd[73]: Using default interface naming scheme 'v261'.1038test # [ 1.769810] systemd[1]: Started Rule-based Manager for Device Events and Files.1039test # [ 1.780140] systemd[1]: Finished Coldplug All udev Devices.1040test # [ 1.782111] systemd[1]: Reached target System Initialization.1041test # [ 1.784475] systemd[1]: Reached target Basic System.1042second # [ 2.145308] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121043second # [ 2.147477] virtio_blk virtio2: 1/0/0 default/read/poll queues1044second # [ 2.157486] ehci-pci 0000:00:1d.7: EHCI Host Controller1045second # [ 2.158350] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11046second # [ 2.159746] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001047second # [ 2.162796] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1048second # [ 2.167226] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001049second # [ 2.169220] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181050second # [ 2.170480] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11051second # [ 2.171613] serio: i8042 KBD port at 0x60,0x64 irq 11052second # [ 2.172411] serio: i8042 AUX port at 0x60,0x64 irq 121053second # [ 2.176216] usb usb1: Product: EHCI Host Controller1054second # [ 2.176985] usb usb1: Manufacturer: Linux 6.18.53 ehci_hcd1055second # [ 2.178077] usb usb1: SerialNumber: 0000:00:1d.71056second # [ 2.179305] hub 1-0:1.0: USB hub found1057second # [ 2.180127] hub 1-0:1.0: 6 ports detected1058test # [ 2.140037] virtio_blk virtio2: 1/0/0 default/read/poll queues1059second # [ 2.188878] uhci_hcd 0000:00:1d.0: UHCI Host Controller1060second # [ 2.189743] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21061second # [ 2.199790] uhci_hcd 0000:00:1d.0: detected 2 ports1062test # [ 2.156989] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1063second # [ 2.207067] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801064test # [ 2.161569] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121065second # [ 2.214581] SCSI subsystem initialized1066second # [ 2.216756] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181067second # [ 2.218027] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11068test # [ 2.176470] serio: i8042 KBD port at 0x60,0x64 irq 11069test # [ 2.184582] serio: i8042 AUX port at 0x60,0x64 irq 121070second # [ 2.234952] usb usb2: Product: UHCI Host Controller1071test # [ 2.188900] ehci-pci 0000:00:1d.7: EHCI Host Controller1072test # [ 2.189764] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11073test # [ 2.191612] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001074second # [ 2.242409] usb usb2: Manufacturer: Linux 6.18.53 uhci_hcd1075test # [ 2.198484] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001076second # [ 2.247411] usb usb2: SerialNumber: 0000:00:1d.01077test # [ 2.200390] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181078test # [ 2.201651] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11079test # [ 2.205388] usb usb1: Product: EHCI Host Controller1080second # [ 2.070290] systemd[1]: Starting Virtual Console Setup...1081test # [ 2.207125] usb usb1: Manufacturer: Linux 6.18.53 ehci_hcd1082test # [ 2.207970] usb usb1: SerialNumber: 0000:00:1d.71083test # [ 2.210217] hub 1-0:1.0: USB hub found1084test # [ 2.211743] hub 1-0:1.0: 6 ports detected1085second # [ 2.075764] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1086test # [ 2.216961] uhci_hcd 0000:00:1d.0: UHCI Host Controller1087test # [ 2.217813] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21088second # [ 2.266588] hub 2-0:1.0: USB hub found1089second # [ 2.270223] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01090second # [ 2.275500] hub 2-0:1.0: 2 ports detected1091test # [ 2.230746] uhci_hcd 0000:00:1d.0: detected 2 ports1092second # [ 2.098852] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1093second # [ 2.102198] systemd[1]: Finished Virtual Console Setup.1094test # [ 2.238890] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801095second # [ 2.105945] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1096test # [ 2.244250] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181097test # [ 2.245553] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11098second # [ 2.295927] uhci_hcd 0000:00:1d.1: UHCI Host Controller1099second # [ 2.296798] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31100test # [ 2.080287] systemd[1]: Starting Virtual Console Setup...1101test # [ 2.266597] usb usb2: Product: UHCI Host Controller1102second # [ 2.132358] systemd[1]: Found device /dev/disk/by-label/nixos.1103second # [ 2.133577] systemd[1]: Reached target Initrd Root Device.1104second # [ 2.137071] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1105second # [ 2.322238] uhci_hcd 0000:00:1d.1: detected 2 ports1106second # [ 2.323129] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01107test # [ 2.097909] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line.1108test # [ 2.283251] usb usb2: Manufacturer: Linux 6.18.53 uhci_hcd1109second # [ 2.331344] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181110second # [ 2.335002] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11111second # [ 2.337398] usb usb3: Product: UHCI Host Controller1112test # [ 2.106780] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1113second # [ 2.339256] usb usb3: Manufacturer: Linux 6.18.53 uhci_hcd1114second # [ 2.340123] usb usb3: SerialNumber: 0000:00:1d.11115test # [ 2.111135] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1116test # [ 2.297134] usb usb2: SerialNumber: 0000:00:1d.01117second # [ 2.162271] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks1118test # [ 2.299646] SCSI subsystem initialized1119test # [ 2.117685] systemd[1]: Finished Virtual Console Setup.1120second # [ 2.166928] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1121test # [ 2.304993] hub 2-0:1.0: USB hub found1122second # [ 2.354052] hub 3-0:1.0: USB hub found1123second # [ 2.355060] hub 3-0:1.0: 2 ports detected1124second # [ 2.359677] uhci_hcd 0000:00:1d.2: UHCI Host Controller1125test # [ 2.315129] hub 2-0:1.0: 2 ports detected1126second # [ 2.362255] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41127second # [ 2.365274] uhci_hcd 0000:00:1d.2: detected 2 ports1128test # [ 2.318885] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01129second # [ 2.366163] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01130second # [ 2.370575] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1131second # [ 2.371838] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1132test # [ 2.326280] uhci_hcd 0000:00:1d.1: UHCI Host Controller1133second # [ 2.373528] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181134second # [ 2.374833] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11135second # [ 2.376280] ahci 0000:00:1f.2: flags: 64bit ncq only1136second # [ 2.377465] usb usb4: Product: UHCI Host Controller1137second # [ 2.378433] usb usb4: Manufacturer: Linux 6.18.53 uhci_hcd1138test # [ 2.151346] systemd[1]: Found device /dev/disk/by-label/nixos.1139second # [ 2.382257] usb usb4: SerialNumber: 0000:00:1d.21140test # [ 2.152856] systemd[1]: Reached target Initrd Root Device.1141second # [ 2.383468] scsi host0: ahci1142test # [ 2.154182] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1143second # [ 2.388268] hub 4-0:1.0: USB hub found1144test # [ 2.341204] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31145second # [ 2.390633] scsi host1: ahci1146second # [ 2.391359] hub 4-0:1.0: 2 ports detected1147test # [ 2.345172] uhci_hcd 0000:00:1d.1: detected 2 ports1148second # [ 2.392805] scsi host2: ahci1149second # [ 2.397169] scsi host3: ahci1150test # [ 2.351410] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01151second # [ 2.399089] scsi host4: ahci1152second # [ 2.400369] scsi host5: ahci1153second # [ 2.400982] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11154test # [ 2.356780] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181155test # [ 2.358083] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11156test # [ 2.361157] usb usb3: Product: UHCI Host Controller1157test # [ 2.361968] usb usb3: Manufacturer: Linux 6.18.53 uhci_hcd1158test # [ 2.364159] usb usb3: SerialNumber: 0000:00:1d.11159second # [ 2.411223] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11160test # [ 2.368217] hub 3-0:1.0: USB hub found1161test # [ 2.370956] hub 3-0:1.0: 2 ports detected1162second # [ 2.417223] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11163second # [ 2.419220] usb 1-1: new high-speed USB device number 2 using ehci-pci1164test # [ 2.191368] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1165second # [ 2.422573] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11166second # [ 2.424427] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11167second # [ 2.425788] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11168test # [ 2.196490] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1169test # [ 2.381391] uhci_hcd 0000:00:1d.2: UHCI Host Controller1170test # [ 2.382248] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41171test # [ 2.389838] uhci_hcd 0000:00:1d.2: detected 2 ports1172test # [ 2.393777] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01173test # [ 2.397467] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181174test # [ 2.400326] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11175test # [ 2.402350] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1176test # [ 2.403681] usb usb4: Product: UHCI Host Controller1177test # [ 2.404939] usb usb4: Manufacturer: Linux 6.18.53 uhci_hcd1178test # [ 2.405999] usb usb4: SerialNumber: 0000:00:1d.21179test # [ 2.410160] hub 4-0:1.0: USB hub found1180test # [ 2.410944] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1181test # [ 2.412420] ahci 0000:00:1f.2: flags: 64bit ncq only1182test # [ 2.415417] hub 4-0:1.0: 2 ports detected1183test # [ 2.423159] scsi host0: ahci1184test # [ 2.423893] scsi host1: ahci1185test # [ 2.425720] scsi host2: ahci1186test # [ 2.430577] scsi host3: ahci1187test # [ 2.434233] scsi host4: ahci1188test # [ 2.438774] scsi host5: ahci1189test # [ 2.441211] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11190test # [ 2.446887] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11191test # [ 2.448296] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11192test # [ 2.449648] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11193test # [ 2.450994] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11194test # [ 2.452250] usb 1-1: new high-speed USB device number 2 using ehci-pci1195test # [ 2.453543] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11196second # [ 2.550162] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001197second # [ 2.551466] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101198second # [ 2.552920] usb 1-1: Product: QEMU USB Tablet1199second # [ 2.553768] usb 1-1: Manufacturer: QEMU1200second # [ 2.554522] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11201second # [ 2.569034] hid: raw HID events driver (C) Jiri Kosina1202test # [ 2.581981] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001203test # [ 2.583501] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101204test # [ 2.585215] usb 1-1: Product: QEMU USB Tablet1205test # [ 2.586057] usb 1-1: Manufacturer: QEMU1206test # [ 2.587059] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11207test # [ 2.602951] hid: raw HID events driver (C) Jiri Kosina1208second # [ 2.527968] systemd[1]: Mounting /sysroot...1209second # [ 2.738765] ata5: SATA link down (SStatus 0 SControl 300)1210second # [ 2.739916] ata4: SATA link down (SStatus 0 SControl 300)1211second # [ 2.741112] ata2: SATA link down (SStatus 0 SControl 300)1212second # [ 2.742162] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1213second # [ 2.743252] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001214second # [ 2.744127] ata3.00: applying bridge limits1215second # [ 2.745280] ata1: SATA link down (SStatus 0 SControl 300)1216second # [ 2.746454] ata6: SATA link down (SStatus 0 SControl 300)1217second # [ 2.747495] ata3.00: configured for UDMA/1001218second # [ 2.748711] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51219test # [ 2.553895] systemd[1]: Mounting /sysroot...1220second # [ 2.801150] usbcore: registered new interface driver usbhid1221second # [ 2.802044] usbhid: USB HID core driver1222test # [ 2.762650] ata4: SATA link down (SStatus 0 SControl 300)1223test # [ 2.763935] ata6: SATA link down (SStatus 0 SControl 300)1224test # [ 2.765152] ata2: SATA link down (SStatus 0 SControl 300)1225test # [ 2.766263] ata5: SATA link down (SStatus 0 SControl 300)1226test # [ 2.767309] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1227test # [ 2.768531] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001228test # [ 2.769515] ata3.00: applying bridge limits1229test # [ 2.770446] ata1: SATA link down (SStatus 0 SControl 300)1230test # [ 2.771524] ata3.00: configured for UDMA/1001231test # [ 2.772653] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51232second # [ 2.821565] 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/input21233second # [ 2.825536] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01234second # [ 2.828548] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1235second # [ 2.832258] EXT4-fs (vda): mounted filesystem 831114fe-aedd-4a43-897d-1e8d04335f74 r/w with ordered data mode. Quota mode: none.1236second # [ 2.654745] systemd[1]: Mounted /sysroot.1237second # [ 2.656828] systemd[1]: Reached target Initrd Root File System.1238second # [ 2.841076] cdrom: Uniform CD-ROM driver Revision: 3.201239second # [ 2.660229] systemd[1]: Starting Mountpoints Configured in the Real Root...1240second # [ 2.676210] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.1241second # [ 2.681034] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...1242second # [ 2.682846] systemd[1]: Reloading...1243test # [ 2.821064] usbcore: registered new interface driver usbhid1244test # [ 2.826114] usbhid: USB HID core driver1245test # [ 2.842912] 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/input21246test # [ 2.849299] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01247test # [ 2.854690] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1248test # [ 2.857646] EXT4-fs (vda): mounted filesystem a7e28ca7-0dfd-44d9-89a9-7ddf859c10a9 r/w with ordered data mode. Quota mode: none.1249test # [ 2.679657] systemd[1]: Mounted /sysroot.1250test # [ 2.682081] systemd[1]: Reached target Initrd Root File System.1251test # [ 2.686070] systemd[1]: Starting Mountpoints Configured in the Real Root...1252test # [ 2.872119] cdrom: Uniform CD-ROM driver Revision: 3.201253second # [ 2.744914] systemd[1]: Reloading finished in 64 ms.1254test # [ 2.703102] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1255test # [ 2.706829] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1256second # [ 2.754614] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...1257test # [ 2.708616] systemd[1]: Reloading...1258second # [ 2.758168] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...1259second # [ 2.763828] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1260second # [ 2.765602] systemd[1]: Finished Mountpoints Configured in the Real Root.1261second # [ 2.766855] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1262test # [ 2.768498] systemd[1]: Reloading finished in 62 ms.1263test # [ 2.777873] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1264test # [ 2.782294] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1265test # [ 2.787250] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1266test # [ 2.791320] systemd[1]: Finished Mountpoints Configured in the Real Root.1267test # [ 2.792498] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1268second # [ 3.529071] systemd[1]: Mounting /sysroot/nix/.ro-store...1269second # [ 3.532145] systemd[1]: Mounting /sysroot/nix/.rw-store...1270second # [ 3.534135] systemd[1]: Mounting /sysroot/run...1271second # [ 3.539270] systemd[1]: Mounting /sysroot/tmp/shared...1272second # [ 3.544404] systemd[1]: Mounting /sysroot/tmp/xchg...1273second # [ 3.565797] systemd[1]: Mounted /sysroot/nix/.rw-store.1274second # [ 3.567199] systemd[1]: Mounted /sysroot/nix/.ro-store.1275second # [ 3.570099] systemd[1]: Mounted /sysroot/run.1276second # [ 3.570945] systemd[1]: Mounted /sysroot/tmp/shared.1277second # [ 3.572951] systemd[1]: Mounted /sysroot/tmp/xchg.1278second # [ 3.576084] systemd[1]: Starting rw-sysroot-nix-store.service...1279second # [ 3.584923] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1280second # [ 3.587199] systemd[1]: Finished rw-sysroot-nix-store.service.1281second # [ 3.588767] systemd[1]: Mounting /sysroot/nix/store...1282test # [ 3.554944] systemd[1]: Mounting /sysroot/nix/.ro-store...1283test # [ 3.558166] systemd[1]: Mounting /sysroot/nix/.rw-store...1284second # [ 3.606165] systemd[1]: Mounted /sysroot/nix/store.1285second # [ 3.607450] systemd[1]: Reached target Initrd File Systems.1286test # [ 3.561136] systemd[1]: Mounting /sysroot/run...1287second # [ 3.609298] systemd[1]: Starting Find NixOS closure...1288test # [ 3.566134] systemd[1]: Mounting /sysroot/tmp/shared...1289second # [ 3.613135] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1290test # [ 3.569442] systemd[1]: Mounting /sysroot/tmp/xchg...1291second # [ 3.627125] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1292second # [ 3.633957] systemd[1]: Finished Find NixOS closure.1293second # [ 3.635491] systemd[1]: Reached target Initrd Default Target.1294second # [ 3.637451] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1295test # [ 3.592892] systemd[1]: Mounted /sysroot/nix/.ro-store.1296test # [ 3.595726] systemd[1]: Mounted /sysroot/nix/.rw-store.1297test # [ 3.596899] systemd[1]: Mounted /sysroot/run.1298test # [ 3.598185] systemd[1]: Mounted /sysroot/tmp/shared.1299test # [ 3.599129] systemd[1]: Mounted /sysroot/tmp/xchg.1300second # [ 3.648686] systemd[1]: Stopped target Initrd Default Target.1301test # [ 3.602894] systemd[1]: Starting rw-sysroot-nix-store.service...1302second # [ 3.650225] systemd[1]: Stopped target Basic System.1303second # [ 3.651404] systemd[1]: Stopped target Initrd Root Device.1304second # [ 3.653137] systemd[1]: Stopped target Path Units.1305second # [ 3.654005] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1306second # [ 3.655514] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1307second # [ 3.657251] systemd[1]: Stopped target Slice Units.1308test # [ 3.611060] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1309second # [ 3.658444] systemd[1]: Stopped target Socket Units.1310test # [ 3.612781] systemd[1]: Finished rw-sysroot-nix-store.service.1311second # [ 3.659740] systemd[1]: Stopped target System Initialization.1312second # [ 3.661608] systemd[1]: Stopped target Swaps.1313test # [ 3.614848] systemd[1]: Mounting /sysroot/nix/store...1314second # [ 3.662444] systemd[1]: Stopped target Timer Units.1315second # [ 3.663353] systemd[1]: dbus.socket: Deactivated successfully.1316second # [ 3.665151] systemd[1]: Closed D-Bus System Message Bus Socket.1317second # [ 3.666189] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1318second # [ 3.667539] systemd[1]: Stopped Find NixOS closure.1319second # [ 3.668424] systemd[1]: Starting rw-sysroot-nix-store.service...1320second # [ 3.670156] systemd[1]: systemd-sysctl.service: Deactivated successfully.1321second # [ 3.671324] systemd[1]: Stopped Apply Kernel Variables.1322second # [ 3.672276] systemd[1]: systemd-modules-load.service: Deactivated successfully.1323second # [ 3.673697] systemd[1]: Stopped Load Kernel Modules.1324second # [ 3.675170] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1325second # [ 3.676425] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1326test # [ 3.631167] systemd[1]: Mounted /sysroot/nix/store.1327second # [ 3.677760] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1328test # [ 3.632507] systemd[1]: Reached target Initrd File Systems.1329second # [ 3.679890] systemd[1]: Stopped Create System Files and Directories.1330test # [ 3.634296] systemd[1]: Starting Find NixOS closure...1331second # [ 3.682159] systemd[1]: Stopped target Local File Systems.1332second # [ 3.683431] systemd[1]: Stopped target Preparation for Local File Systems.1333test # [ 3.637131] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1334second # [ 3.684764] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1335second # [ 3.685984] systemd[1]: Stopped Coldplug All udev Devices.1336second # [ 3.687513] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1337second # [ 3.689396] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1338second # [ 3.690845] systemd[1]: Stopped Virtual Console Setup.1339second # [ 3.696377] systemd[1]: initrd-cleanup.service: Deactivated successfully.1340test # [ 3.649684] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1341second # [ 3.700150] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1342second # [ 3.702126] systemd[1]: systemd-udevd.service: Deactivated successfully.1343test # [ 3.655903] systemd[1]: Finished Find NixOS closure.1344test # [ 3.657444] systemd[1]: Reached target Initrd Default Target.1345second # [ 3.705750] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1346test # [ 3.659465] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1347second # [ 3.707672] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1348second # [ 3.709451] systemd[1]: Finished rw-sysroot-nix-store.service.1349second # [ 3.712326] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1350second # [ 3.714185] systemd[1]: Closed udev Control Socket.1351second # [ 3.715441] systemd[1]: Starting Cleanup udev Database...1352second # [ 3.717104] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1353test # [ 3.670923] systemd[1]: Stopped target Initrd Default Target.1354second # [ 3.718410] systemd[1]: Stopped Create Static Device Nodes in /dev.1355test # [ 3.672309] systemd[1]: Stopped target Basic System.1356second # [ 3.719522] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1357test # [ 3.674154] systemd[1]: Stopped target Initrd Root Device.1358second # [ 3.721159] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1359test # [ 3.675140] systemd[1]: Stopped target Path Units.1360test # [ 3.676047] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1361second # [ 3.723144] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1362test # [ 3.677313] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1363second # [ 3.724320] systemd[1]: Stopped Create List of Static Device Nodes.1364test # [ 3.678684] systemd[1]: Stopped target Slice Units.1365test # [ 3.680357] systemd[1]: Stopped target Socket Units.1366test # [ 3.682164] systemd[1]: Stopped target System Initialization.1367test # [ 3.683250] systemd[1]: Stopped target Swaps.1368test # [ 3.684083] systemd[1]: Stopped target Timer Units.1369test # [ 3.684961] systemd[1]: dbus.socket: Deactivated successfully.1370test # [ 3.685977] systemd[1]: Closed D-Bus System Message Bus Socket.1371test # [ 3.688155] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1372second # [ 3.735193] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1373test # [ 3.689437] systemd[1]: Stopped Find NixOS closure.1374test # [ 3.690345] systemd[1]: Starting rw-sysroot-nix-store.service...1375second # [ 3.738086] systemd[1]: Finished Cleanup udev Database.1376test # [ 3.691401] systemd[1]: systemd-sysctl.service: Deactivated successfully.1377second # [ 3.739078] systemd[1]: Reached target Switch Root.1378test # [ 3.692988] systemd[1]: Stopped Apply Kernel Variables.1379second # [ 3.740429] systemd[1]: Starting NixOS Activation...1380test # [ 3.694389] systemd[1]: systemd-modules-load.service: Deactivated successfully.1381test # [ 3.696149] systemd[1]: Stopped Load Kernel Modules.1382test # [ 3.697182] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1383test # [ 3.699698] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1384test # [ 3.701043] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1385test # [ 3.702289] systemd[1]: Stopped Create System Files and Directories.1386test # [ 3.703358] systemd[1]: Stopped target Local File Systems.1387test # [ 3.704421] systemd[1]: Stopped target Preparation for Local File Systems.1388test # [ 3.705694] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1389test # [ 3.709272] systemd[1]: Stopped Coldplug All udev Devices.1390test # [ 3.711217] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1391test # [ 3.714349] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1392test # [ 3.715637] systemd[1]: Stopped Virtual Console Setup.1393test # [ 3.721756] systemd[1]: initrd-cleanup.service: Deactivated successfully.1394test # [ 3.724907] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1395test # [ 3.727400] systemd[1]: systemd-udevd.service: Deactivated successfully.1396test # [ 3.730090] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1397test # [ 3.731367] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1398test # [ 3.732745] systemd[1]: Finished rw-sysroot-nix-store.service.1399test # [ 3.736043] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1400test # [ 3.737629] systemd[1]: Closed udev Control Socket.1401test # [ 3.739353] systemd[1]: Starting Cleanup udev Database...1402test # [ 3.740463] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1403second # [ 3.786625] initrd-nixos-activation-start[190]: booting system configuration /nix/store/x24yqk1728id105545lbpijkfj6nkzrp-nixos-system-second-test1404test # [ 3.742077] systemd[1]: Stopped Create Static Device Nodes in /dev.1405test # [ 3.743205] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1406test # [ 3.745164] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1407test # [ 3.746404] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1408test # [ 3.747691] systemd[1]: Stopped Create List of Static Device Nodes.1409second # [ 3.807241] initrd-nixos-activation-start[190]: running activation script...1410test # [ 3.763567] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1411test # [ 3.766073] systemd[1]: Finished Cleanup udev Database.1412test # [ 3.767119] systemd[1]: Reached target Switch Root.1413test # [ 3.768753] systemd[1]: Starting NixOS Activation...1414test # [ 3.815936] initrd-nixos-activation-start[188]: booting system configuration /nix/store/vawn80lfqpms55k1cxl6glk2410a7x5h-nixos-system-test-test1415test # [ 3.836085] initrd-nixos-activation-start[188]: running activation script...1416second # [ 3.958130] initrd-nixos-activation-start[213]: setting up /etc...1417second # [ 4.026555] initrd-nixos-activation-start[213]: setting up age secrets...1418test # [ 3.981832] initrd-nixos-activation-start[211]: setting up /etc...1419second # [ 4.097193] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1420second # [ 4.099164] systemd[1]: Finished NixOS Activation.1421second # [ 4.100830] systemd[1]: Starting Switch Root...1422test # [ 4.054426] initrd-nixos-activation-start[211]: setting up age secrets...1423second # [ 4.112650] systemd[1]: Switching root.1424test # [ 4.149693] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1425test # [ 4.151234] systemd[1]: Finished NixOS Activation.1426test # [ 4.153259] systemd[1]: Starting Switch Root...1427test # [ 4.163452] systemd[1]: Switching root.1428second # [ 4.422470] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1429second # [ 4.503265] NET: Registered PF_VSOCK protocol family1430test # [ 4.471187] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1431test # [ 4.539191] NET: Registered PF_VSOCK protocol family1432second # [ 4.854752] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1433second # [ 4.859044] systemd[1]: Detected virtualization kvm.1434second # [ 4.859879] systemd[1]: Detected architecture x86-64.1435second # [ 4.860760] systemd[1]: Detected first boot.1436second # [ 4.862246] systemd[1]: Initializing machine ID from random generator.1437test # [ 4.889874] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1438test # [ 4.894332] systemd[1]: Detected virtualization kvm.1439test # [ 4.895153] systemd[1]: Detected architecture x86-64.1440test # [ 4.896006] systemd[1]: Detected first boot.1441test # [ 4.897523] systemd[1]: Initializing machine ID from random generator.1442test # [ 4.967624] systemd[1]: bpf-restrict-fs: LSM BPF program attached1443second # [ 5.043212] systemd[1]: bpf-restrict-fs: LSM BPF program attached1444test # [ 5.020177] systemd[1]: Applying preset policy.1445second # [ 5.094932] systemd[1]: Applying preset policy.1446test # [ 5.167490] systemd[1]: Populated /etc with preset unit settings.1447second # [ 5.244296] systemd[1]: Populated /etc with preset unit settings.1448test # [ 5.338248] systemd[1]: initrd-switch-root.service: Deactivated successfully.1449test # [ 5.339910] systemd[1]: Stopped initrd-switch-root.service.1450test # [ 5.342439] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1451test # [ 5.344718] systemd[1]: Created slice Slice /system/getty.1452test # [ 5.346273] systemd[1]: Created slice User and Session Slice.1453test # [ 5.347408] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1454test # [ 5.348889] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1455test # [ 5.350276] systemd[1]: Expecting device /dev/hvc0...1456test # [ 5.351213] systemd[1]: Expecting device /dev/ttyS0...1457test # [ 5.352189] systemd[1]: Reached target Local Encrypted Volumes.1458test # [ 5.353245] systemd[1]: Stopped target initrd-fs.target.1459second # [ 5.408116] systemd[1]: initrd-switch-root.service: Deactivated successfully.1460test # [ 5.354205] systemd[1]: Stopped target initrd-root-fs.target.1461second # [ 5.409778] systemd[1]: Stopped initrd-switch-root.service.1462test # [ 5.363421] systemd[1]: Stopped target initrd-switch-root.target.1463test # [ 5.364541] systemd[1]: Reached target Virtual Machines and Containers.1464test # [ 5.365729] systemd[1]: Reached target Path Units.1465second # [ 5.412115] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1466test # [ 5.366683] systemd[1]: Reached target Remote File Systems.1467test # [ 5.367696] systemd[1]: Reached target Slice Units.1468second # [ 5.414492] systemd[1]: Created slice Slice /system/getty.1469test # [ 5.368634] systemd[1]: Reached target Swaps.1470second # [ 5.415836] systemd[1]: Created slice User and Session Slice.1471second # [ 5.416918] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1472test # [ 5.370373] systemd[1]: Listening on Query the User Interactively for a Password.1473second # [ 5.418331] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1474second # [ 5.419542] systemd[1]: Expecting device /dev/hvc0...1475test # [ 5.372799] systemd[1]: Listening on Process Core Dump Socket.1476second # [ 5.420405] systemd[1]: Expecting device /dev/ttyS0...1477second # [ 5.421291] systemd[1]: Reached target Local Encrypted Volumes.1478test # [ 5.374730] systemd[1]: Listening on Credential Encryption/Decryption.1479second # [ 5.422281] systemd[1]: Stopped target initrd-fs.target.1480test # [ 5.376631] systemd[1]: Listening on Factory Reset Management.1481test # [ 5.377678] systemd[1]: Listening on Hostname Service Socket.1482test # [ 5.380515] systemd[1]: Starting Journal Log Access Socket...1483test # [ 5.381824] systemd[1]: Listening on Journal Audit Socket.1484second # [ 5.423146] systemd[1]: Stopped target initrd-root-fs.target.1485test # [ 5.384344] systemd[1]: Listening on Console Output Muting Service Socket.1486second # [ 5.432195] systemd[1]: Stopped target initrd-switch-root.target.1487test # [ 5.385575] systemd[1]: Listening on Network Management Metrics Varlink Socket.1488second # [ 5.433213] systemd[1]: Reached target Virtual Machines and Containers.1489test # [ 5.386925] systemd[1]: Listening on Network Management Varlink Socket.1490second # [ 5.434307] systemd[1]: Reached target Path Units.1491test # [ 5.388239] systemd[1]: Listening on Network Management Netlink Socket.1492second # [ 5.435231] systemd[1]: Reached target Remote File Systems.1493second # [ 5.436262] systemd[1]: Reached target Slice Units.1494test # [ 5.389596] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1495second # [ 5.437099] systemd[1]: Reached target Swaps.1496test # [ 5.390928] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1497second # [ 5.438827] systemd[1]: Listening on Query the User Interactively for a Password.1498test # [ 5.392464] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1499second # [ 5.441139] systemd[1]: Listening on Process Core Dump Socket.1500second # [ 5.442876] systemd[1]: Listening on Credential Encryption/Decryption.1501test # [ 5.396410] systemd[1]: Listening on Disk Repartitioning Service Socket.1502test # [ 5.397678] systemd[1]: Listening on Resolve Monitor Varlink Socket.1503second # [ 5.444690] systemd[1]: Listening on Factory Reset Management.1504second # [ 5.445743] systemd[1]: Listening on Hostname Service Socket.1505test # [ 5.398878] systemd[1]: Listening on Resolve Service Varlink Socket.1506test # [ 5.400127] systemd[1]: Listening on udev Control Socket.1507test # [ 5.401137] systemd[1]: Listening on udev Varlink Socket.1508second # [ 5.448460] systemd[1]: Starting Journal Log Access Socket...1509second # [ 5.449649] systemd[1]: Listening on Journal Audit Socket.1510test # [ 5.403313] systemd[1]: Mounting Huge Pages File System...1511second # [ 5.452049] systemd[1]: Listening on Console Output Muting Service Socket.1512test # [ 5.406608] systemd[1]: Mounting POSIX Message Queue File System...1513second # [ 5.453339] systemd[1]: Listening on Network Management Metrics Varlink Socket.1514second # [ 5.454688] systemd[1]: Listening on Network Management Varlink Socket.1515second # [ 5.455859] systemd[1]: Listening on Network Management Netlink Socket.1516second # [ 5.457052] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1517second # [ 5.458319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1518test # [ 5.412916] systemd[1]: Mounting Kernel Debug File System...1519second # [ 5.459798] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1520second # [ 5.463449] systemd[1]: Listening on Disk Repartitioning Service Socket.1521second # [ 5.464608] systemd[1]: Listening on Resolve Monitor Varlink Socket.1522second # [ 5.465722] systemd[1]: Listening on Resolve Service Varlink Socket.1523second # [ 5.466851] systemd[1]: Listening on udev Control Socket.1524test # [ 5.420183] systemd[1]: Mounting Kernel Trace File System...1525second # [ 5.467867] systemd[1]: Listening on udev Varlink Socket.1526second # [ 5.469970] systemd[1]: Mounting Huge Pages File System...1527second # [ 5.473507] systemd[1]: Mounting POSIX Message Queue File System...1528test # [ 5.433157] systemd[1]: Starting Create List of Static Device Nodes...1529second # [ 5.481199] systemd[1]: Mounting Kernel Debug File System...1530second # [ 5.488239] systemd[1]: Mounting Kernel Trace File System...1531test # [ 5.443745] systemd[1]: Starting Load Kernel Module configfs...1532second # [ 5.499203] systemd[1]: Starting Create List of Static Device Nodes...1533test # [ 5.452754] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1534test # [ 5.460711] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1535test # [ 5.462625] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1536second # [ 5.510499] systemd[1]: Starting Load Kernel Module configfs...1537test # [ 5.465711] systemd[1]: Mounting FUSE Control File System...1538test # [ 5.470160] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671539second # [ 5.520820] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1540test # [ 5.479380] systemd[1]: Starting Journal Service...1541second # [ 5.526488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1542second # [ 5.531709] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1543test # [ 5.486624] systemd[1]: Starting Load Kernel Modules...1544second # [ 5.534495] systemd[1]: Mounting FUSE Control File System...1545second # [ 5.537266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671546test # [ 5.498286] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1547second # [ 5.545489] systemd[1]: Starting Journal Service...1548second # [ 5.551378] systemd[1]: Starting Load Kernel Modules...1549test # [ 5.504951] systemd[1]: Starting Remount Root and Kernel File Systems...1550test # [ 5.508233] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1551second # [ 5.560251] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1552test # [ 5.521481] systemd-journald[335]: Collecting audit messages is enabled.1553test # [ 5.522643] systemd[1]: Starting Coldplug All udev Devices...1554second # [ 5.573138] systemd[1]: Starting Remount Root and Kernel File Systems...1555second # [ 5.579500] systemd-journald[316]: Collecting audit messages is enabled.1556second # [ 5.580624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1557second # [ 5.587859] systemd[1]: Starting Coldplug All udev Devices...1558test # [ 5.543383] systemd[1]: Listening on Journal Log Access Socket.1559test # [ 5.368173] systemd[1]: Queued start job for default target Multi-User System.1560second # [ 5.601150] systemd[1]: Listening on Journal Log Access Socket.1561test # [ 5.371456] systemd[1]: systemd-journald.service: Deactivated successfully.1562test # [ 5.556992] systemd[1]: Started Journal Service.1563second # [ 5.605334] systemd[1]: Started Journal Service.1564test # [ 5.375393] systemd-modules-load[336]: Module 'ctr' is built in1565second # [ 5.420987] systemd[1]: Queued start job for default target Multi-User System.1566second # [ 5.425942] systemd[1]: systemd-journald.service: Deactivated successfully.1567test # [ 5.380483] systemd[1]: Mounted Huge Pages File System.1568test # [ 5.381698] systemd[1]: Mounted POSIX Message Queue File System.1569test # [ 5.566572] loop: module loaded1570second # [ 5.433170] systemd[1]: Mounted Huge Pages File System.1571test # [ 5.387355] systemd[1]: Mounted Kernel Debug File System.1572second # [ 5.434258] systemd[1]: Mounted POSIX Message Queue File System.1573test # [ 5.391161] systemd[1]: Mounted Kernel Trace File System.1574second # [ 5.438109] systemd[1]: Mounted Kernel Debug File System.1575second # [ 5.439116] systemd[1]: Mounted Kernel Trace File System.1576test # [ 5.393698] systemd-modules-load[336]: Inserted module 'loop'1577second # [ 5.443724] systemd[1]: Finished Create List of Static Device Nodes.1578test # [ 5.397955] systemd[1]: Finished Create List of Static Device Nodes.1579second # [ 5.445268] systemd[1]: modprobe@configfs.service: Deactivated successfully.1580test # [ 5.399895] systemd[1]: modprobe@configfs.service: Deactivated successfully.1581second # [ 5.449867] systemd-modules-load[317]: Module 'ctr' is built in1582test # [ 5.403342] systemd[1]: Finished Load Kernel Module configfs.1583test # [ 5.591118] EXT4-fs (vda): re-mounted a7e28ca7-0dfd-44d9-89a9-7ddf859c10a9.1584second # [ 5.456751] systemd[1]: Finished Load Kernel Module configfs.1585test # [ 5.411285] systemd[1]: Finished Load Kernel Modules.1586second # [ 5.648365] EXT4-fs (vda): re-mounted 831114fe-aedd-4a43-897d-1e8d04335f74.1587test # [ 5.419204] systemd[1]: Mounted FUSE Control File System.1588second # [ 5.649822] loop: module loaded1589test # [ 5.423823] systemd[1]: Finished Remount Root and Kernel File Systems.1590second # [ 5.470878] systemd[1]: Mounted FUSE Control File System.1591second # [ 5.472772] systemd-modules-load[317]: Inserted module 'loop'1592test # [ 5.428116] systemd[1]: Listening on Disk Image Download Service Socket.1593second # [ 5.476147] systemd[1]: Finished Load Kernel Modules.1594second # [ 5.479158] systemd[1]: Finished Remount Root and Kernel File Systems.1595test # [ 5.435784] systemd[1]: Mounting Kernel Configuration File System...1596test # [ 5.440088] systemd[1]: Starting Firewall...1597second # [ 5.488161] systemd[1]: Listening on Disk Image Download Service Socket.1598test # [ 5.443098] systemd[1]: Starting Flush Journal to Persistent Storage...1599test # [ 5.444247] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1600second # [ 5.494108] systemd[1]: Mounting Kernel Configuration File System...1601second # [ 5.497134] systemd[1]: Starting Firewall...1602second # [ 5.500209] systemd[1]: Starting Flush Journal to Persistent Storage...1603test # [ 5.454984] systemd[1]: Starting Load/Save OS Random Seed...1604second # [ 5.501789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1605test # [ 5.459175] systemd-oomd[338]: No swap; memory pressure usage will be degraded1606second # [ 5.510171] systemd-oomd[319]: No swap; memory pressure usage will be degraded1607second # [ 5.514143] systemd[1]: Starting Load/Save OS Random Seed...1608test # [ 5.470947] systemd[1]: Starting Apply Kernel Variables...1609second # [ 5.526213] systemd[1]: Starting Apply Kernel Variables...1610test # [ 5.482118] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1611test # [ 5.483429] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1612test # [ 5.485163] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1613second # [ 5.545285] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1614second # [ 5.547654] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1615second # [ 5.549603] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1616test # [ 5.707349] systemd-journald[335]: Received client request to flush runtime journal.1617second # [ 5.764772] systemd-journald[316]: Received client request to flush runtime journal.1618test # [ 5.710775] systemd[1]: Finished Load/Save OS Random Seed.1619test # [ 5.713732] systemd[1]: Reached target First Boot Complete.1620test # [ 5.716289] systemd[1]: Mounted Kernel Configuration File System.1621test # [ 5.718170] systemd[1]: Finished Apply Kernel Variables.1622test # [ 5.720400] systemd[1]: Starting Network Name Resolution...1623test # [ 5.721496] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1624second # [ 5.769901] systemd[1]: Finished Load/Save OS Random Seed.1625test # [ 5.724179] systemd[1]: Starting Create Static Device Nodes in /dev...1626second # [ 5.772718] systemd[1]: Reached target First Boot Complete.1627test # [ 5.727207] systemd[1]: Finished Flush Journal to Persistent Storage.1628second # [ 5.776433] systemd[1]: Mounted Kernel Configuration File System.1629second # [ 5.778928] systemd[1]: Finished Apply Kernel Variables.1630second # [ 5.783181] systemd[1]: Starting Network Name Resolution...1631second # [ 5.784248] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1632second # [ 5.785541] systemd[1]: Starting Create Static Device Nodes in /dev...1633second # [ 5.786715] systemd[1]: Finished Flush Journal to Persistent Storage.1634test # [ 5.755620] systemd-resolved[364]: Positive Trust Anchors:1635test # [ 5.756842] systemd-resolved[364]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1636test # [ 5.759244] systemd-resolved[364]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161637second # [ 5.807297] systemd-resolved[346]: Positive Trust Anchors:1638second # [ 5.809304] systemd-resolved[346]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1639second # [ 5.813204] systemd-resolved[346]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161640test # [ 5.761121] systemd-resolved[364]: 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 test1641second # [ 5.814940] systemd-resolved[346]: 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 test1642test # [ 5.788338] systemd[1]: Finished Create Static Device Nodes in /dev.1643test # [ 5.791426] systemd[1]: Finished Coldplug All udev Devices.1644test # [ 5.794373] systemd[1]: Reached target Preparation for Local File Systems.1645second # [ 5.841344] systemd[1]: Finished Create Static Device Nodes in /dev.1646second # [ 5.844164] systemd[1]: Reached target Preparation for Local File Systems.1647test # [ 5.797986] systemd[1]: Starting Rule-based Manager for Device Events and Files...1648second # [ 5.849071] systemd[1]: Starting Rule-based Manager for Device Events and Files...1649second # [ 5.864562] systemd[1]: Finished Coldplug All udev Devices.1650test # [ 5.831365] systemd-resolved[364]: Using system hostname 'test'.1651test # [ 5.835279] systemd[1]: Started Network Name Resolution.1652second # [ 5.890662] systemd-resolved[346]: Using system hostname 'second'.1653second # [ 5.894936] systemd[1]: Started Network Name Resolution.1654test # [ 5.855223] systemd-udevd[380]: Using default interface naming scheme 'v261'.1655second # [ 5.909976] systemd-udevd[362]: Using default interface naming scheme 'v261'.1656test # [ 5.917228] systemd[1]: Started Rule-based Manager for Device Events and Files.1657second # [ 5.972124] systemd[1]: Started Rule-based Manager for Device Events and Files.1658second # [ 6.091126] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1659test # [ 6.045578] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1660test # [ 6.125118] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1661second # [ 6.178904] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1662test # [ 6.141982] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1663test # [ 6.161561] systemd[1]: Mounting /run/wrappers...1664second # [ 6.220488] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1665second # [ 6.229378] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line.1666test # [ 6.183174] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line.1667test # [ 6.185592] (udev-worker)[408]: Network interface NamePolicy= disabled on kernel command line.1668second # [ 6.232898] systemd[1]: Mounting /run/wrappers...1669second # [ 6.249405] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line.1670test # [ 6.204460] systemd[1]: Mounted /run/wrappers.1671test # [ 6.207067] systemd[1]: Reached target Local File Systems.1672test # [ 6.211195] systemd[1]: Listening on Boot Loader Control Service Socket.1673test # [ 6.216170] systemd[1]: Starting register-nix-paths.service...1674test # [ 6.220257] systemd[1]: Starting Create SUID/SGID Wrappers...1675second # [ 6.267715] systemd[1]: Mounted /run/wrappers.1676test # [ 6.221392] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1677second # [ 6.269596] systemd[1]: Reached target Local File Systems.1678test # [ 6.225833] systemd[1]: Starting Save Transient machine-id to Disk...1679second # [ 6.275853] systemd[1]: Listening on Boot Loader Control Service Socket.1680test # [ 6.234429] systemd[1]: Starting Create System Files and Directories...1681second # [ 6.284087] systemd[1]: Starting register-nix-paths.service...1682second # [ 6.293102] systemd[1]: Starting Create SUID/SGID Wrappers...1683second # [ 6.294232] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1684second # [ 6.303583] systemd[1]: Starting Save Transient machine-id to Disk...1685second # [ 6.316258] systemd[1]: Starting Create System Files and Directories...1686test # [ 6.327352] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1687test # [ 6.336113] systemd[1]: Finished Save Transient machine-id to Disk.1688second # [ 6.392512] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1689second # [ 6.399653] systemd[1]: Finished Save Transient machine-id to Disk.1690test # [ 6.379230] systemd[1]: Finished Create System Files and Directories.1691test # [ 6.384354] systemd[1]: Starting Rebuild Journal Catalog...1692test # [ 6.392233] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1693second # [ 6.445704] systemd[1]: Finished Create System Files and Directories.1694second # [ 6.455449] systemd[1]: Starting Rebuild Journal Catalog...1695second # [ 6.460912] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1696test # [ 6.519312] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1697second # [ 6.573185] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1698test # [ 6.549151] systemd[1]: Finished Rebuild Journal Catalog.1699test # [ 6.558464] systemd[1]: Starting Update is Completed...1700second # [ 6.612104] systemd[1]: Finished Rebuild Journal Catalog.1701second # [ 6.620660] systemd[1]: Starting Update is Completed...1702test # [ 6.636384] systemd[1]: Finished Update is Completed.1703second # [ 6.684932] systemd[1]: Finished Update is Completed.1704test # [ 6.892567] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31705second # [ 6.778250] systemd[1]: Finished Firewall.1706second # [ 6.779227] systemd[1]: Reached target Preparation for Network.1707test # [ 6.735127] systemd[1]: Finished Firewall.1708second # [ 6.781773] systemd[1]: Listening on Network Management Resolve Hook Socket.1709test # [ 6.736199] systemd[1]: Reached target Preparation for Network.1710test # [ 6.738138] systemd[1]: Listening on Network Management Resolve Hook Socket.1711second # [ 6.790561] systemd[1]: Starting Network Management...1712test # [ 6.746512] systemd[1]: Starting Network Management...1713second # [ 6.989391] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1714second # [ 7.001320] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31715test # [ 6.959568] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1716test # [ 6.854263] systemd[1]: Finished register-nix-paths.service.1717second # [ 6.901711] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1718second # [ 6.905708] systemd[1]: Finished Create SUID/SGID Wrappers.1719test # [ 6.860523] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1720test # [ 6.863306] systemd[1]: Finished Create SUID/SGID Wrappers.1721test # [ 6.865221] systemd[1]: Reached target System Initialization.1722test # [ 6.870092] systemd[1]: Started Discard unused filesystem blocks once a week.1723test # [ 6.871385] systemd[1]: Started Daily Cleanup of Temporary Directories.1724test # [ 6.873891] systemd[1]: Reached target Timer Units.1725test # [ 6.875507] systemd[1]: Listening on D-Bus System Message Bus Socket.1726test # [ 6.876682] systemd[1]: Listening on Nix Daemon Socket.1727second # [ 6.924732] systemd[1]: Finished register-nix-paths.service.1728second # [ 6.925835] systemd[1]: Reached target System Initialization.1729test # [ 6.880207] systemd[1]: Listening on Authorization Manager Agent Helper.1730test # [ 6.881402] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1731second # [ 6.929051] systemd[1]: Started Discard unused filesystem blocks once a week.1732test # [ 6.882849] systemd[1]: Reached target Socket Units.1733second # [ 6.930448] systemd[1]: Started Daily Cleanup of Temporary Directories.1734second # [ 6.932897] systemd[1]: Reached target Timer Units.1735test # [ 6.886507] systemd[1]: Starting D-Bus System Message Bus...1736second # [ 6.936171] systemd[1]: Listening on D-Bus System Message Bus Socket.1737second # [ 6.938206] systemd[1]: Listening on Nix Daemon Socket.1738second # [ 6.947527] systemd[1]: Listening on Authorization Manager Agent Helper.1739second # [ 6.948723] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1740second # [ 6.950177] systemd[1]: Reached target Socket Units.1741second # [ 6.952854] systemd[1]: Starting D-Bus System Message Bus...1742second # [ 7.067811] mousedev: PS/2 mouse device common for all mice1743test # [ 7.001858] systemd-resolved[364]: Clock change detected. Flushing caches.1744second # [ 7.056214] systemd-resolved[346]: Clock change detected. Flushing caches.1745second # [ 7.083096] ACPI: button: Power Button [PWRF]1746second # [ 7.213758] cfg80211: Loading compiled-in X.509 certificates for regulatory database1747test # [ 6.989109] ACPI: button: Power Button [PWRF]1748second # [ 7.213934] rtc_cmos PNP0B00:00: RTC can wake from S41749test # [ 7.023564] mousedev: PS/2 mouse device common for all mice1750test # [ 7.124582] rtc_cmos PNP0B00:00: RTC can wake from S41751test # [ 7.168895] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41752second # [ 7.220880] rtc_cmos PNP0B00:00: registered as rtc01753second # [ 7.220977] rtc_cmos PNP0B00:00: setting system clock to 2026-09-22T20:02:10 UTC (1790107330)1754test # [ 7.169668] cfg80211: Loading compiled-in X.509 certificates for regulatory database1755second # [ 7.221060] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1756second # [ 7.091904] systemd-networkd[532]: /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.1757test # [ 7.046623] systemd-networkd[548]: /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.1758second # [ 7.096590] systemd-networkd[532]: /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.1759test # [ 7.051395] systemd-networkd[548]: /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.1760second # [ 7.101072] systemd-networkd[532]: lo: Link UP1761second # [ 7.102604] systemd-networkd[532]: lo: Gained carrier1762test # [ 7.056106] systemd-networkd[548]: lo: Link UP1763test # [ 7.057259] systemd-networkd[548]: lo: Gained carrier1764second # [ 7.104362] dbus-broker-launch[544]: Looking up NSS user entry for 'systemd-timesync'...1765test # [ 7.064083] systemd[1]: Started Network Management.1766second # [ 7.112234] systemd[1]: Started Network Management.1767second # [ 7.113613] dbus-broker-launch[544]: NSS returned no entry for 'systemd-timesync'1768second # [ 7.115330] dbus-broker-launch[544]: Invalid user-name in /nix/store/nizpdw05vqv7gssybrdr45l0i6d31b0c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1769test # [ 7.068612] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1770test # [ 7.071390] dbus-broker-launch[562]: Looking up NSS user entry for 'systemd-timesync'...1771second # [ 7.121594] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1772test # [ 7.074993] systemd-networkd[548]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1773second # [ 7.124415] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1774test # [ 7.078820] systemd-networkd[548]: eth1: Link UP1775second # [ 7.127301] systemd-networkd[532]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1776test # [ 7.081897] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1777test # [ 7.085933] dbus-broker-launch[562]: NSS returned no entry for 'systemd-timesync'1778second # [ 7.135095] systemd-networkd[532]: eth1: Link UP1779second # [ 7.136182] systemd-networkd[532]: eth1: Gained carrier1780test # [ 7.089365] dbus-broker-launch[562]: Invalid user-name in /nix/store/nizpdw05vqv7gssybrdr45l0i6d31b0c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1781second # [ 7.137953] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1782test # [ 7.093163] systemd-networkd[548]: eth1: Gained carrier1783test # [ 7.095880] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1784test # [ 7.170780] rtc_cmos PNP0B00:00: registered as rtc01785test # [ 7.170879] rtc_cmos PNP0B00:00: setting system clock to 2026-09-22T20:02:10 UTC (1790107330)1786second # [ 7.221690] systemd-journald[316]: Time jumped backwards, rotating.1787second # [ 7.222989] Console: switching to colour dummy device 80x251788second # [ 7.166841] dbus-broker-launch[544]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1789second # [ 7.170908] dbus-broker-launch[544]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1790test # [ 7.125276] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1791second # [ 7.175165] dbus-broker-launch[544]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1792test # [ 7.128828] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1793test # [ 7.133770] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1794second # [ 7.180926] dbus-broker-launch[544]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1795second # [ 7.184237] systemd[1]: Started D-Bus System Message Bus.1796second # [ 7.186256] systemd[1]: Reached target Basic System.1797test # [ 7.141618] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1798test # [ 7.144729] systemd[1]: Started D-Bus System Message Bus.1799second # [ 7.191752] systemd[1]: Starting Network Manager Script Dispatcher Service...1800test # [ 7.145767] systemd[1]: Reached target Basic System.1801second # [ 7.198139] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1802test # [ 7.151470] systemd[1]: Starting Network Manager Script Dispatcher Service...1803test # [ 7.155086] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1804second # [ 7.204070] systemd[1]: Starting Network Manager...1805test # [ 7.159075] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1806second # [ 7.238582] parport_pc 00:02: reported by Plug and Play ACPI1807test # [ 7.170968] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1808test # [ 7.171736] systemd-journald[335]: Time jumped backwards, rotating.1809second # [ 7.222609] dbus-broker-launch[544]: Ready1810second # [ 7.238675] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1811test # [ 7.177184] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1812second # [ 7.251228] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41813second # [ 7.228370] systemd[1]: Started backdoor.service.1814test # [ 7.186279] dbus-broker-launch[562]: Ready1815second # [ 7.237092] systemd[1]: Starting Import lastlog data into lastlog2 database...1816test # [ 7.194140] systemd[1]: Starting Network Manager...1817second # [ 7.256455] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1818test # [ 7.210986] systemd[1]: Started backdoor.service.1819test # [ 7.197538] Console: switching to colour dummy device 80x251820test # [ 7.208638] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1821test # [ 7.208730] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1822second # [ 7.271631] systemd[1]: Starting Post-Boot Actions...1823test # [ 7.225968] systemd[1]: Starting Import lastlog data into lastlog2 database...1824test # [ 7.242471] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1825second # [ 7.293422] systemd[1]: Started Reset console on configuration changes.1826second # [ 7.302472] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[557]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1827test # [ 7.272987] systemd[1]: Starting Post-Boot Actions...1828second # [ 7.256463] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1829second # [ 7.256553] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1830second # [ 7.291655] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1831second # [ 7.326208] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1832test # [ 7.280989] vb8pc9wcqy39qa3q5alv51h0jms1a1wl-wifi-secrets[575]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1833test # [ 7.283495] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[574]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1834second # [ 7.342099] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1835test # [ 7.297530] systemd[1]: Started Reset console on configuration changes.1836test # [ 7.304940] 7x3chz0b0917ic6jha19q7m5hcdq301r-wifi-secrets[576]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1837second # [ 7.355239] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1838second # connecting to host...1839test # [ 7.211109] parport_pc 00:02: reported by Plug and Play ACPI1840test # [ 7.211201] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1841test # [ 7.218515] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1842test # [ 7.344114] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1843test # [ 7.345545] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1844test # [ 7.358699] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1845test # [ 7.360696] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1846second # [ 7.413469] systemd[1]: Finished Post-Boot Actions.1847test # [ 7.377761] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1848test # [ 7.385382] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1849second # [ 7.441736] systemd[1]: Started Network Manager Script Dispatcher Service.1850test # [ 7.395226] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1851second # [ 7.450774] nsncd[562]: Sep 22 20:02:10.912 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1852second # [ 7.453895] systemd[1]: Started Name Service Cache Daemon (nsncd).1853second # [ 7.456467] systemd[1]: Reached target Host and Network Name Lookups.1854second # [ 7.459357] systemd[1]: Reached target User and Group Name Lookups.1855test # connecting to host...1856second # [ 7.340829] NET: Registered PF_PACKET protocol family1857second # [ 7.471104] systemd[1]: Starting User Login Management...1858second # [ 7.476546] systemd[1]: Finished Import lastlog data into lastlog2 database.1859second # [ 7.666353] [drm] Found bochs VGA, ID 0xb0c5.1860second # [ 7.666897] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1861test # [ 7.441116] systemd[1]: Finished Post-Boot Actions.1862second # [ 7.671781] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1863second # [ 7.672791] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1864test # [ 7.445383] nsncd[581]: Sep 22 20:02:10.955 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1865test # [ 7.452601] systemd[1]: Started Name Service Cache Daemon (nsncd).1866test: Guest shell says: b'Spawning backdoor root shell...\n'1867test # [ 7.294958] NET: Registered PF_PACKET protocol family1868test # [ 7.615321] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1869test # [ 7.615436] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1870second # [ 7.519071] systemd[1]: Starting Hostname Service...1871second # [ 7.712372] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1872test: connected to guest root shell1873test: (connecting took 8.21 seconds)1874test: (finished: waiting for the VM to finish booting, in 8.21 seconds)1875test # [ 7.489463] systemd[1]: Reached target Host and Network Name Lookups.1876test # [ 7.497845] systemd[1]: Reached target User and Group Name Lookups.1877second # [ 7.730291] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61878second # [ 7.732700] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51879second # [ 7.740202] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01880test # [ 7.513475] systemd[1]: Starting User Login Management...1881test # [ 7.516443] systemd[1]: Started Network Manager Script Dispatcher Service.1882test # [ 7.677706] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61883test # [ 7.530400] systemd[1]: Finished Import lastlog data into lastlog2 database.1884second # [ 7.587136] systemd-logind[594]: New seat seat0.1885second # [ 7.591297] systemd[1]: Started User Login Management.1886test # [ 7.678400] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51887test # [ 7.734686] [drm] Found bochs VGA, ID 0xb0c5.1888second # [ 7.598918] systemd[1]: Starting linger-users.service...1889test # [ 7.734689] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1890test # [ 7.560330] systemd[1]: Starting Hostname Service...1891test # [ 7.774402] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1892second # [ 7.656845] systemd[1]: Started Hostname Service.1893second # [ 7.669542] systemd[1]: linger-users.service: Deactivated successfully.1894second # [ 7.673748] systemd[1]: Finished linger-users.service.1895test # [ 7.813925] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01896test # [ 7.672594] systemd-logind[629]: New seat seat0.1897test # [ 7.676168] systemd[1]: Started User Login Management.1898second # [ 7.722656] systemd-logind[594]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1899test # [ 7.684041] systemd[1]: Starting linger-users.service...1900second # [ 7.737658] systemd-networkd[532]: eth0: Link UP1901second # [ 7.738703] systemd-networkd[532]: eth0: Gained carrier1902test # [ 7.693686] systemd[1]: Starting Virtual Console Setup...1903second # [ 7.744221] systemd[1]: Starting Virtual Console Setup...1904second # [ 7.932583] Console: switching to colour frame buffer device 160x501905test # [ 7.714635] systemd-logind[629]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1906second # [ 7.767758] systemd-logind[594]: Watching system buttons on /dev/input/event2 (Power Button)1907test # [ 7.721687] systemd[1]: Started Hostname Service.1908second # [ 7.787800] systemd[1]: Started Network Manager.1909second # [ 7.788802] systemd[1]: Reached target Network.1910second # [ 7.789772] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1911test # [ 7.747104] systemd[1]: linger-users.service: Deactivated successfully.1912test # [ 7.749304] systemd[1]: Finished linger-users.service.1913second # [ 7.798182] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1914test # [ 7.758166] systemd-logind[629]: Watching system buttons on /dev/input/event2 (Power Button)1915second # [ 7.808504] systemd[1]: Starting Permit User Sessions...1916second # [ 8.000843] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1917second # [ 7.838122] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1918second # [ 7.842548] systemd[1]: Stopped Virtual Console Setup.1919second # [ 7.868770] systemd[1]: Starting Virtual Console Setup...1920second # [ 7.891281] systemd[1]: Finished Permit User Sessions.1921second # [ 8.113752] ppdev: user-space parallel port driver1922test # [ 8.077277] Console: switching to colour frame buffer device 160x501923test # [ 8.078658] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1924test # [ 7.789740] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1925test # [ 7.900775] systemd-networkd[548]: eth0: Link UP1926test # [ 7.902604] systemd-networkd[548]: eth0: Gained carrier1927test # [ 7.906782] systemd[1]: Started Network Manager.1928test # [ 7.908566] systemd[1]: Reached target Network.1929second # [ 7.956265] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1930test # [ 7.912218] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1931second # [ 7.959504] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1932test # [ 7.913914] systemd[1]: Starting Permit User Sessions...1933test # [ 7.915172] systemd[1]: Finished Permit User Sessions.1934test # [ 7.916466] systemd[1]: Started Getty on tty1.1935test # [ 7.917445] systemd[1]: Reached target Login Prompts.1936second # [ 7.975683] systemd[1]: Started Getty on tty1.1937second # [ 7.980229] systemd[1]: Reached target Login Prompts.1938second # [ 7.981242] systemd[1]: Reached target Multi-User System.1939test # [ 7.939966] systemd-logind[629]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1940test # [ 8.145611] ppdev: user-space parallel port driver1941second # [ 8.010379] systemd-logind[594]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1942test # [ 7.976144] NetworkManager[577]: <warn> [1790107331.4877] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1943test # [ 7.979537] NetworkManager[577]: <warn> [1790107331.4878] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1944second # [ 8.028298] systemd-resolved[346]: eth0: Bus client set default route setting: yes1945second # [ 8.034137] systemd-resolved[346]: eth0: Bus client set DNS server list to: 10.0.2.31946second # [ 8.224383] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1947test # [ 7.997702] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1948test # [ 8.000088] systemd[1]: Stopped Virtual Console Setup.1949test # [ 8.014713] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1950test # [ 8.201644] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1951test # [ 8.022485] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1952second # [ 8.274996] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1953test # [ 8.229771] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1954test # [ 8.059321] systemd-resolved[364]: eth0: Bus client set default route setting: yes1955test # [ 8.064335] systemd-resolved[364]: eth0: Bus client set DNS server list to: 10.0.2.31956second # [ 8.369376] kvm_amd: TSC scaling supported1957second # [ 8.369915] kvm_amd: Nested Virtualization enabled1958second # [ 8.370851] kvm_amd: Nested Paging enabled1959second # [ 8.371585] kvm_amd: LBR virtualization supported1960second # [ 8.372398] kvm_amd: Virtual GIF supported1961second # [ 8.372921] kvm_amd: Virtual NMI enabled1962test # [ 8.336446] kvm_amd: TSC scaling supported1963test # [ 8.336987] kvm_amd: Nested Virtualization enabled1964test # [ 8.337949] kvm_amd: Nested Paging enabled1965test # [ 8.338705] kvm_amd: LBR virtualization supported1966second # [ 8.202136] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1967test # [ 8.339571] kvm_amd: Virtual GIF supported1968test # [ 8.340317] kvm_amd: Virtual NMI enabled1969second # [ 8.209175] systemd[1]: Stopped Virtual Console Setup.1970second # [ 8.220588] systemd[1]: Starting Virtual Console Setup...1971test # [ 8.383932] EDAC MC: Ver: 3.0.01972test # [ 8.204603] systemd-networkd[548]: eth1: Gained IPv6LL1973second # [ 8.438806] EDAC MC: Ver: 3.0.01974test # [ 8.234137] systemd[1]: Reached target Multi-User System.1975test # [ 8.237707] systemd[1]: Starting Virtual Console Setup...1976second # [ 8.331913] systemd-vconsole-setup[649]: Configuration of first virtual console was skipped, ignoring remaining ones.1977second # [ 8.336350] systemd-networkd[532]: eth1: Gained IPv6LL1978second # [ 8.341191] systemd[1]: Finished Virtual Console Setup.1979second # [ 8.345153] systemd[1]: Startup finished in 825ms (kernel) + 3.453s (initrd) + 4.065s (userspace) = 8.344s.1980test # [ 8.331647] systemd-vconsole-setup[685]: Configuration of first virtual console was skipped, ignoring remaining ones.1981test # [ 8.335812] systemd[1]: Finished Virtual Console Setup.1982test # [ 8.340160] systemd[1]: Startup finished in 850ms (kernel) + 3.466s (initrd) + 4.022s (userspace) = 8.339s.1983test: (finished: waiting for unit NetworkManager.service, in 9.36 seconds)1984test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1985test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1986test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1987test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1988test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1989test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1990(finished: run the VM test script, in 9.51 seconds)1991test script finished in 9.53s1992cleanup1993kill QemuMachine (pid 48)1994second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)1995second # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down1996second # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down1997second # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down1998kill QemuMachine (pid 47)1999test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)2000test # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down2001test # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down2002test # [2026-09-22T20:02:13Z INFO virtiofsd] Client disconnected, shutting down2003(finished: cleanup, in 0.20 seconds)