vm-test-run-wifi
checks.x86_64-linux.wifi
· build #261
· raw
1build-x86-01: building zbly0cwiqyzyn1739q4faixnah5906v8-vm-test-run-wifi.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 second, test,9 vlan1,10 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_ssh11start all VMs12second: starting vm13test: starting vm14test # Disk image does not exist, creating the virtualisation disk image...15test: QEMU running (pid 48)16test # Formatting '/build/vm-state-test/tmp.aSvOgTMwxM', fmt=raw size=107374182417test # mke2fs 1.47.4 (6-Mar-2025)18test # Discarding device blocks: 0/262144 done19test # Creating filesystem with 262144 4k blocks and 65536 inodes20test # Filesystem UUID: 75eebf4b-c4f1-4141-a5a0-d43d751cbbb521test # Superblock backups stored on blocks:22test # 32768, 98304, 163840, 22937623test # 24test # Allocating group tables: 0/8 done25test # Writing inode tables: 0/8 done26test # Creating journal (8192 blocks): done27test # Writing superblocks and filesystem accounting information: 0/8 done28test # 29test # Virtualisation disk image created.30test # Starting virtiofs daemons...31test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33test # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...34test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37test # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether38test # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...39test # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...40test # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests41test # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests42test # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests43second # Disk image does not exist, creating the virtualisation disk image...44second: QEMU running (pid 47)45second # Formatting '/build/vm-state-second/tmp.tFktc6HVYl', fmt=raw size=107374182446second # mke2fs 1.47.4 (6-Mar-2025)47second # Discarding device blocks: 0/262144 done48second # Creating filesystem with 262144 4k blocks and 65536 inodes49second # Filesystem UUID: b9b1e5b4-ffa2-42ce-8521-b9d3a4c6af4850second # Superblock backups stored on blocks:51second # 32768, 98304, 163840, 22937652second # 53second # Allocating group tables: 0/8 done54second # Writing inode tables: 0/8 done55second # Creating journal (8192 blocks): done56second # Writing superblocks and filesystem accounting information: 0/8 done57second # 58second # Virtualisation disk image created.59second # Starting virtiofs daemons...60second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)61second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether62second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)63second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether64second # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...65second # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...66second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)67second # [2026-10-14T00:04:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether68second # [2026-10-14T00:04:26Z INFO virtiofsd] Waiting for vhost-user socket connection...69second # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests70second # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests71second # [2026-10-14T00:04:26Z INFO virtiofsd] Client connected, servicing requests72(finished: start all VMs, in 0.08 seconds)73test: waiting for unit NetworkManager.service74test: waiting for the VM to finish booting75test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)76second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)77test # 78test # 79test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0080second # 81second # 82second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0083test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...84test # 85test # 86test # 87test # 88test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0089second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...90second # 91second # 92second # 93second # 94test # Press Ctrl-B to configure iPXE (PCI 00:05.0)...95test # 96test # 97second # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0098second # Press Ctrl-B to configure iPXE (PCI 00:05.0)...99second # 100second # 101second # Booting from ROM...102test # Booting from ROM...103second # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026104second # [ 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/9hff8ghkyy5byyvgsz0wsw6wcq8sn1lq-nixos-system-second-test/init regInfo=/nix/.ro-store/mh88vm2msc265za17a2vjqvllwws3y0d-closure-info/registration console=ttyS0,115200n8 console=tty0105second # [ 0.000000] BIOS-provided physical RAM map:106second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable107second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved108second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved109second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable110second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved111second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved112second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved113second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved114second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved115second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved116second # [ 0.000000] NX (Execute Disable) protection: active117second # [ 0.000000] APIC: Static calls initialized118second # [ 0.000000] SMBIOS 2.8 present.119second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014120second # [ 0.000000] DMI: Memory slots populated: 1/1121second # [ 0.000000] Hypervisor detected: KVM122second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000123second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00124second # [ 0.000000] kvm-clock: using sched offset of 392625165 cycles125second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns126second # [ 0.000005] tsc: Detected 4192.112 MHz processor127second # [ 0.000542] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000128second # [ 0.000578] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs129second # [ 0.000581] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT130second # [ 0.002187] found SMP MP-table at [mem 0x000f5450-0x000f545f]131test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026132second # [ 0.002199] Using GB pages for direct mapping133second # [ 0.002241] RAMDISK: [mem 0x3e2e6000-0x3ffcffff]134second # [ 0.002245] ACPI: Early table checksum verification disabled135second # [ 0.002248] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )136second # [ 0.002251] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)137test # [ 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/ij1m3q4jl87b32j7bz90pjcgbyj5jq5d-nixos-system-test-test/init regInfo=/nix/.ro-store/758zhcpiqiyhmlqixxq66vmknnjhymzv-closure-info/registration console=ttyS0,115200n8 console=tty0138second # [ 0.002254] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)139test # [ 0.000000] BIOS-provided physical RAM map:140test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable141second # [ 0.002259] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)142second # [ 0.002261] ACPI: FACS 0x000000003FFE0000 000040143test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved144second # [ 0.002262] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)145test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved146test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable147second # [ 0.002263] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)148test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved149second # [ 0.002264] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)150test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved151second # [ 0.002266] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)152test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved153second # [ 0.002267] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]154test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved155second # [ 0.002267] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]156test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved157second # [ 0.002268] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]158test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved159second # [ 0.002268] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]160test # [ 0.000000] NX (Execute Disable) protection: active161test # [ 0.000000] APIC: Static calls initialized162second # [ 0.002268] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]163test # [ 0.000000] SMBIOS 2.8 present.164second # [ 0.002269] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]165test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014166second # [ 0.002269] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]167test # [ 0.000000] DMI: Memory slots populated: 1/1168second # [ 0.002609] No NUMA configuration found169test # [ 0.000000] Hypervisor detected: KVM170test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000171second # [ 0.002610] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]172test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00173second # [ 0.002613] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]174second # [ 0.002681] Zone ranges:175test # [ 0.000000] kvm-clock: using sched offset of 426739923 cycles176second # [ 0.002682] DMA [mem 0x0000000000001000-0x0000000000ffffff]177second # [ 0.002683] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]178test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns179second # [ 0.002684] Normal empty180test # [ 0.000005] tsc: Detected 4192.112 MHz processor181second # [ 0.002684] Device empty182test # [ 0.000547] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000183second # [ 0.002685] Movable zone start for each node184second # [ 0.002685] Early memory node ranges185test # [ 0.000575] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs186second # [ 0.002686] node 0: [mem 0x0000000000001000-0x000000000009efff]187test # [ 0.000578] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT188second # [ 0.002687] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]189test # [ 0.002162] found SMP MP-table at [mem 0x000f5450-0x000f545f]190second # [ 0.002688] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]191test # [ 0.002180] Using GB pages for direct mapping192second # [ 0.002702] On node 0, zone DMA: 1 pages in unavailable ranges193test # [ 0.002279] RAMDISK: [mem 0x3e2e6000-0x3ffcffff]194second # [ 0.002888] On node 0, zone DMA: 97 pages in unavailable ranges195test # [ 0.002283] ACPI: Early table checksum verification disabled196second # [ 0.015747] On node 0, zone DMA32: 40 pages in unavailable ranges197test # [ 0.002286] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )198second # [ 0.016507] ACPI: PM-Timer IO Port: 0x608199test # [ 0.002288] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)200second # [ 0.016516] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])201second # [ 0.016536] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23202test # [ 0.002292] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)203second # [ 0.016538] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)204test # [ 0.002297] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)205second # [ 0.016539] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)206test # [ 0.002299] ACPI: FACS 0x000000003FFE0000 000040207second # [ 0.016540] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)208test # [ 0.002300] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)209second # [ 0.016541] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)210test # [ 0.002301] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)211second # [ 0.016541] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)212test # [ 0.002302] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)213second # [ 0.016543] ACPI: Using ACPI (MADT) for SMP configuration information214second # [ 0.016544] ACPI: HPET id: 0x8086a201 base: 0xfed00000215test # [ 0.002304] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)216second # [ 0.016547] TSC deadline timer available217second # [ 0.016550] CPU topo: Max. logical packages: 1218test # [ 0.002305] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]219second # [ 0.016551] CPU topo: Max. logical dies: 1220test # [ 0.002305] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]221second # [ 0.016551] CPU topo: Max. dies per package: 1222second # [ 0.016554] CPU topo: Max. threads per core: 1223test # [ 0.002306] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]224second # [ 0.016554] CPU topo: Num. cores per package: 1225test # [ 0.002306] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]226second # [ 0.016555] CPU topo: Num. threads per package: 1227test # [ 0.002306] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]228second # [ 0.016555] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs229test # [ 0.002307] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]230second # [ 0.016572] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()231test # [ 0.002307] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]232second # [ 0.016597] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]233test # [ 0.002641] No NUMA configuration found234second # [ 0.016598] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]235test # [ 0.002642] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]236second # [ 0.016599] [mem 0x40000000-0xafffffff] available for PCI devices237test # [ 0.002644] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]238test # [ 0.002711] Zone ranges:239second # [ 0.016600] Booting paravirtualized kernel on KVM240test # [ 0.002711] DMA [mem 0x0000000000001000-0x0000000000ffffff]241second # [ 0.016603] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns242test # [ 0.002712] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]243test # [ 0.002713] Normal empty244second # [ 0.020011] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1245test # [ 0.002713] Device empty246test # [ 0.002714] Movable zone start for each node247second # [ 0.021695] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152248test # [ 0.002715] Early memory node ranges249second # [ 0.021727] kvm-guest: PV spinlocks disabled, single CPU250test # [ 0.002715] node 0: [mem 0x0000000000001000-0x000000000009efff]251test # [ 0.002715] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]252test # [ 0.002716] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]253test # [ 0.002732] On node 0, zone DMA: 1 pages in unavailable ranges254test # [ 0.002918] On node 0, zone DMA: 97 pages in unavailable ranges255second # [ 0.021728] 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/9hff8ghkyy5byyvgsz0wsw6wcq8sn1lq-nixos-system-second-test/init regInfo=/nix/.ro-store/mh88vm2msc265za17a2vjqvllwws3y0d-closure-info/registration console=ttyS0,115200n8 console=tty0256test # [ 0.015828] On node 0, zone DMA32: 40 pages in unavailable ranges257test # [ 0.016585] ACPI: PM-Timer IO Port: 0x608258test # [ 0.016593] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])259second # [ 0.021795] Unknown kernel command line parameters "regInfo=/nix/.ro-store/mh88vm2msc265za17a2vjqvllwws3y0d-closure-info/registration", will be passed to user space.260second # [ 0.021988] random: crng init done261test # [ 0.016613] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23262test # [ 0.016615] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)263second # [ 0.021988] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes264test # [ 0.016617] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)265second # [ 0.022004] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)266test # [ 0.016617] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)267second # [ 0.022393] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)268second # [ 0.022417] Fallback order for Node 0: 0269test # [ 0.016618] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)270second # [ 0.022419] Built 1 zonelists, mobility grouping on. Total pages: 262006271test # [ 0.016618] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)272second # [ 0.022420] Policy zone: DMA32273test # [ 0.016621] ACPI: Using ACPI (MADT) for SMP configuration information274second # [ 0.024211] mem auto-init: stack:all(zero), heap alloc:on, heap free:off275test # [ 0.016621] ACPI: HPET id: 0x8086a201 base: 0xfed00000276test # [ 0.016624] TSC deadline timer available277second # [ 0.026718] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1278test # [ 0.016627] CPU topo: Max. logical packages: 1279second # [ 0.028321] allocated 2097152 bytes of page_ext280test # [ 0.016627] CPU topo: Max. logical dies: 1281second # [ 0.037307] ftrace: allocating 48837 entries in 192 pages282test # [ 0.016628] CPU topo: Max. dies per package: 1283second # [ 0.037309] ftrace: allocated 192 pages with 2 groups284test # [ 0.016631] CPU topo: Max. threads per core: 1285second # [ 0.037984] Dynamic Preempt: lazy286test # [ 0.016631] CPU topo: Num. cores per package: 1287second # [ 0.038097] rcu: Preemptible hierarchical RCU implementation.288test # [ 0.016631] CPU topo: Num. threads per package: 1289second # [ 0.038098] rcu: RCU event tracing is enabled.290test # [ 0.016631] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs291second # [ 0.038098] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.292second # [ 0.038100] Trampoline variant of Tasks RCU enabled.293test # [ 0.016643] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()294second # [ 0.038100] Rude variant of Tasks RCU enabled.295test # [ 0.016667] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]296second # [ 0.038100] Tracing variant of Tasks RCU enabled.297test # [ 0.016669] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]298second # [ 0.038101] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.299test # [ 0.016670] [mem 0x40000000-0xafffffff] available for PCI devices300second # [ 0.038101] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1301test # [ 0.016671] Booting paravirtualized kernel on KVM302second # [ 0.038142] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.303test # [ 0.016673] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns304second # [ 0.038144] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.305test # [ 0.019991] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1306second # [ 0.038144] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.307test # [ 0.021570] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152308test # [ 0.021598] kvm-guest: PV spinlocks disabled, single CPU309second # [ 0.041306] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16310second # [ 0.041541] rcu: srcu_init: Setting srcu_struct sizes based on contention.311second # [ 0.041546] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns312second # [ 0.041720] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)313second # [ 0.046740] Console: colour VGA+ 80x25314test # [ 0.021600] 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/ij1m3q4jl87b32j7bz90pjcgbyj5jq5d-nixos-system-test-test/init regInfo=/nix/.ro-store/758zhcpiqiyhmlqixxq66vmknnjhymzv-closure-info/registration console=ttyS0,115200n8 console=tty0315second # [ 0.046744] printk: legacy console [tty0] enabled316second # [ 0.076134] printk: legacy console [ttyS0] enabled317second # [ 0.206944] ACPI: Core revision 20250807318test # [ 0.021666] Unknown kernel command line parameters "regInfo=/nix/.ro-store/758zhcpiqiyhmlqixxq66vmknnjhymzv-closure-info/registration", will be passed to user space.319test # [ 0.021856] random: crng init done320test # [ 0.021857] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes321second # [ 0.207962] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns322test # [ 0.021872] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)323second # [ 0.209860] APIC: Switch to symmetric I/O mode setup324second # [ 0.211013] x2apic enabled325test # [ 0.022265] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)326test # [ 0.022288] Fallback order for Node 0: 0327second # [ 0.211813] APIC: Switched APIC routing to: physical x2apic328test # [ 0.022290] Built 1 zonelists, mobility grouping on. Total pages: 262006329test # [ 0.022291] Policy zone: DMA32330second # [ 0.213750] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1331test # [ 0.024303] mem auto-init: stack:all(zero), heap alloc:on, heap free:off332test # [ 0.026414] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1333test # [ 0.028012] allocated 2097152 bytes of page_ext334second # [ 0.214954] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4505823, max_idle_ns: 440795228884 ns335test # [ 0.036807] ftrace: allocating 48837 entries in 192 pages336second # [ 0.216978] Calibrating delay loop (skipped) preset value.. 8384.22 BogoMIPS (lpj=4192112)337test # [ 0.036808] ftrace: allocated 192 pages with 2 groups338test # [ 0.037455] Dynamic Preempt: lazy339second # [ 0.218064] x86/cpu: User Mode Instruction Prevention (UMIP) activated340test # [ 0.037581] rcu: Preemptible hierarchical RCU implementation.341test # [ 0.037582] rcu: RCU event tracing is enabled.342second # [ 0.220078] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127343test # [ 0.037582] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.344second # [ 0.220977] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0345test # [ 0.037583] Trampoline variant of Tasks RCU enabled.346test # [ 0.037584] Rude variant of Tasks RCU enabled.347test # [ 0.037584] Tracing variant of Tasks RCU enabled.348second # [ 0.221980] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto349test # [ 0.037584] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.350second # [ 0.223977] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl351test # [ 0.037585] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1352second # [ 0.225977] Spectre V2 : Mitigation: Enhanced / Automatic IBRS353test # [ 0.037591] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.354second # [ 0.226977] Speculative Return Stack Overflow: Mitigation: Safe RET355test # [ 0.037592] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.356second # [ 0.227977] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization357test # [ 0.037593] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.358test # [ 0.040707] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16359test # [ 0.040933] rcu: srcu_init: Setting srcu_struct sizes based on contention.360test # [ 0.040936] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns361second # [ 0.229984] Spectre V2 : Enabling IBPB for BPF362test # [ 0.041084] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)363test # [ 0.046109] Console: colour VGA+ 80x25364second # [ 0.231978] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier365second # [ 0.232978] active return thunk: srso_alias_return_thunk366test # [ 0.046111] printk: legacy console [tty0] enabled367test # [ 0.075772] printk: legacy console [ttyS0] enabled368test # [ 0.206889] ACPI: Core revision 20250807369second # [ 0.235000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'370second # [ 0.235977] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'371test # [ 0.207953] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns372second # [ 0.236977] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'373test # [ 0.209886] APIC: Switch to symmetric I/O mode setup374test # [ 0.211066] x2apic enabled375second # [ 0.238977] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'376test # [ 0.211886] APIC: Switched APIC routing to: physical x2apic377second # [ 0.239977] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'378second # [ 0.240977] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'379test # [ 0.213851] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1380second # [ 0.241977] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'381test # [ 0.215085] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4505823, max_idle_ns: 440795228884 ns382second # [ 0.243977] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'383test # [ 0.217138] Calibrating delay loop (skipped) preset value.. 8384.22 BogoMIPS (lpj=4192112)384second # [ 0.244977] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'385test # [ 0.219160] x86/cpu: User Mode Instruction Prevention (UMIP) activated386second # [ 0.246978] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256387test # [ 0.220273] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127388second # [ 0.247977] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64389second # [ 0.249977] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512390test # [ 0.221136] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0391second # [ 0.250977] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024392test # [ 0.222139] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto393second # [ 0.251977] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8394second # [ 0.252977] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16395test # [ 0.224136] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl396second # [ 0.253977] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24397test # [ 0.225137] Spectre V2 : Mitigation: Enhanced / Automatic IBRS398test # [ 0.226136] Speculative Return Stack Overflow: Mitigation: Safe RET399second # [ 0.255977] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.400test # [ 0.228136] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization401test # [ 0.229142] Spectre V2 : Enabling IBPB for BPF402test # [ 0.231137] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier403test # [ 0.232136] active return thunk: srso_alias_return_thunk404test # [ 0.233157] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'405test # [ 0.234136] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'406test # [ 0.235136] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'407test # [ 0.237136] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'408test # [ 0.238136] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'409test # [ 0.239136] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'410test # [ 0.240136] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'411test # [ 0.242136] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'412test # [ 0.243136] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'413test # [ 0.245136] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256414test # [ 0.246136] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64415test # [ 0.247136] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512416test # [ 0.249136] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024417second # [ 0.281791] Freeing SMP alternatives memory: 48K418second # [ 0.282702] pid_max: default: 32768 minimum: 301419test # [ 0.250136] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8420second # [ 0.283042] LSM: initializing lsm=capability,landlock,yama,bpf,ima421test # [ 0.251136] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16422second # [ 0.285034] landlock: Up and running.423test # [ 0.252136] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24424second # [ 0.285799] Yama: becoming mindful.425second # [ 0.286711] LSM support for eBPF active426test # [ 0.254136] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.427second # [ 0.287049] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)428second # [ 0.287999] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)429second # [ 0.290366] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)430second # [ 0.291376] Performance Events: Fam17h+ core perfctr, AMD PMU driver.431second # [ 0.291981] ... version: 2432second # [ 0.292841] ... bit width: 48433second # [ 0.293659] ... generic counters: 6434second # [ 0.294016] ... generic bitmap: 000000000000003f435second # [ 0.294978] ... fixed-purpose counters: 0436second # [ 0.295853] ... fixed-purpose bitmap: 0000000000000000437second # [ 0.296854] ... value mask: 0000ffffffffffff438second # [ 0.297852] ... max period: 00007fffffffffff439second # [ 0.298858] ... global_ctrl mask: 000000000000003f440second # [ 0.299937] signal: max sigframe size: 3376441second # [ 0.300706] rcu: Hierarchical SRCU implementation.442second # [ 0.300981] rcu: Max phase no-delay instances is 400.443second # [ 0.305000] smp: Bringing up secondary CPUs ...444second # [ 0.305911] smp: Brought up 1 node, 1 CPU445second # [ 0.306612] smpboot: Total of 1 processors activated (8384.22 BogoMIPS)446test # [ 0.280667] Freeing SMP alternatives memory: 48K447test # [ 0.281137] pid_max: default: 32768 minimum: 301448second # [ 0.307101] Memory: 942472K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 98108K reserved, 0K cma-reserved)449test # [ 0.282192] LSM: initializing lsm=capability,landlock,yama,bpf,ima450second # [ 0.308145] devtmpfs: initialized451test # [ 0.283221] landlock: Up and running.452second # [ 0.309030] x86/mm: Memory block size: 128MB453test # [ 0.284136] Yama: becoming mindful.454test # [ 0.285318] LSM support for eBPF active455second # [ 0.310598] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)456test # [ 0.286215] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)457second # [ 0.311005] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).458test # [ 0.287153] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)459second # [ 0.312043] pinctrl core: initialized pinctrl subsystem460second # [ 0.313234] PM: RTC time: 00:04:26, date: 2026-10-14461test # [ 0.290210] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)462test # [ 0.291573] Performance Events: Fam17h+ core perfctr, AMD PMU driver.463test # [ 0.292148] ... version: 2464second # [ 0.316214] NET: Registered PF_NETLINK/PF_ROUTE protocol family465test # [ 0.293019] ... bit width: 48466test # [ 0.293831] ... generic counters: 6467second # [ 0.317253] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations468test # [ 0.294137] ... generic bitmap: 000000000000003f469second # [ 0.318001] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations470test # [ 0.295137] ... fixed-purpose counters: 0471test # [ 0.296002] ... fixed-purpose bitmap: 0000000000000000472second # [ 0.319083] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations473test # [ 0.297010] ... value mask: 0000ffffffffffff474second # [ 0.319985] audit: initializing netlink subsys (disabled)475test # [ 0.298017] ... max period: 00007fffffffffff476second # [ 0.321164] thermal_sys: Registered thermal governor 'fair_share'477test # [ 0.299014] ... global_ctrl mask: 000000000000003f478second # [ 0.321165] thermal_sys: Registered thermal governor 'bang_bang'479test # [ 0.300098] signal: max sigframe size: 3376480test # [ 0.300880] rcu: Hierarchical SRCU implementation.481second # [ 0.321981] audit: type=2000 audit(1791936266.859:1): state=initialized audit_enabled=0 res=1482test # [ 0.301140] rcu: Max phase no-delay instances is 400.483second # [ 0.323980] thermal_sys: Registered thermal governor 'step_wise'484second # [ 0.323981] thermal_sys: Registered thermal governor 'user_space'485second # [ 0.324978] thermal_sys: Registered thermal governor 'power_allocator'486second # [ 0.326006] cpuidle: using governor menu487test # [ 0.305131] smp: Bringing up secondary CPUs ...488test # [ 0.305872] smp: Brought up 1 node, 1 CPU489second # [ 0.328628] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5490test # [ 0.306139] smpboot: Total of 1 processors activated (8384.22 BogoMIPS)491second # [ 0.329180] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]492test # [ 0.307254] Memory: 942504K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 98108K reserved, 0K cma-reserved)493second # [ 0.329981] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry494test # [ 0.308293] devtmpfs: initialized495second # [ 0.330988] PCI: Using configuration type 1 for base access496test # [ 0.309190] x86/mm: Memory block size: 128MB497second # [ 0.332133] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.498test # [ 0.310746] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)499test # [ 0.311158] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).500test # [ 0.312202] pinctrl core: initialized pinctrl subsystem501test # [ 0.313380] PM: RTC time: 00:04:26, date: 2026-10-14502second # [ 0.338999] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages503test # [ 0.316321] NET: Registered PF_NETLINK/PF_ROUTE protocol family504second # [ 0.339978] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page505test # [ 0.317396] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations506test # [ 0.318153] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations507test # [ 0.319243] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations508second # [ 0.344978] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages509test # [ 0.320144] audit: initializing netlink subsys (disabled)510second # [ 0.345979] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page511test # [ 0.321334] thermal_sys: Registered thermal governor 'fair_share'512test # [ 0.321336] thermal_sys: Registered thermal governor 'bang_bang'513test # [ 0.322138] thermal_sys: Registered thermal governor 'step_wise'514test # [ 0.323140] audit: type=2000 audit(1791936266.889:1): state=initialized audit_enabled=0 res=1515test # [ 0.325139] thermal_sys: Registered thermal governor 'user_space'516second # [ 0.352621] ACPI: Added _OSI(Module Device)517test # [ 0.325140] thermal_sys: Registered thermal governor 'power_allocator'518second # [ 0.352979] ACPI: Added _OSI(Processor Device)519test # [ 0.326150] cpuidle: using governor menu520second # [ 0.353879] ACPI: Added _OSI(Processor Aggregator Device)521test # [ 0.328745] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5522test # [ 0.329354] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]523test # [ 0.330139] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry524test # [ 0.331146] PCI: Using configuration type 1 for base access525second # [ 0.360633] ACPI: 1 ACPI AML tables successfully acquired and loaded526test # [ 0.332295] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.527second # [ 0.363745] ACPI: Interpreter enabled528second # [ 0.363990] ACPI: PM: (supports S0 S3 S4 S5)529second # [ 0.364857] ACPI: Using IOAPIC for interrupt routing530test # [ 0.337305] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages531test # [ 0.338137] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page532second # [ 0.365790] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug533second # [ 0.367573] PCI: Using E820 reservations for host bridge windows534second # [ 0.368086] ACPI: Enabled 2 GPEs in block 00 to 3F535test # [ 0.343137] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages536test # [ 0.344137] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page537second # [ 0.372129] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])538second # [ 0.372983] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]539second # [ 0.374036] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]540second # [ 0.375071] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]541second # [ 0.376361] PCI host bridge to bus 0000:00542second # [ 0.376982] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]543test # [ 0.353436] ACPI: Added _OSI(Module Device)544second # [ 0.377979] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]545test # [ 0.354138] ACPI: Added _OSI(Processor Device)546second # [ 0.378979] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]547test # [ 0.355041] ACPI: Added _OSI(Processor Aggregator Device)548second # [ 0.379979] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]549second # [ 0.380979] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]550second # [ 0.381979] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]551second # [ 0.382979] pci_bus 0000:00: root bus resource [bus 00-ff]552test # [ 0.359936] ACPI: 1 ACPI AML tables successfully acquired and loaded553second # [ 0.384065] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint554second # [ 0.385607] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint555test # [ 0.365603] ACPI: Interpreter enabled556test # [ 0.366150] ACPI: PM: (supports S0 S3 S4 S5)557test # [ 0.367026] ACPI: Using IOAPIC for interrupt routing558second # [ 0.387957] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]559test # [ 0.367946] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug560second # [ 0.388998] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]561test # [ 0.369137] PCI: Using E820 reservations for host bridge windows562second # [ 0.390016] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]563test # [ 0.370245] ACPI: Enabled 2 GPEs in block 00 to 3F564second # [ 0.391142] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]565second # [ 0.392693] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint566test # [ 0.374236] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])567test # [ 0.375142] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]568second # [ 0.394990] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]569test # [ 0.376195] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]570second # [ 0.396054] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]571test # [ 0.377230] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]572second # [ 0.397056] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]573test # [ 0.378523] PCI host bridge to bus 0000:00574second # [ 0.397988] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]575test # [ 0.379142] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]576test # [ 0.380138] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]577second # [ 0.399965] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint578test # [ 0.381138] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]579test # [ 0.382138] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]580second # [ 0.402698] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]581second # [ 0.402989] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]582test # [ 0.383139] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]583second # [ 0.404016] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]584test # [ 0.384138] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]585test # [ 0.385138] pci_bus 0000:00: root bus resource [bus 00-ff]586second # [ 0.405871] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint587test # [ 0.386267] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint588test # [ 0.387780] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint589second # [ 0.408732] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]590second # [ 0.408989] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]591second # [ 0.410016] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]592test # [ 0.390134] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]593second # [ 0.411891] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint594test # [ 0.391157] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]595test # [ 0.392175] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]596second # [ 0.413989] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]597test # [ 0.393304] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]598second # [ 0.414990] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]599second # [ 0.416017] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]600test # [ 0.394880] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint601second # [ 0.416991] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]602test # [ 0.397148] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]603second # [ 0.418837] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint604test # [ 0.398186] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]605test # [ 0.399175] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]606second # [ 0.420897] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]607test # [ 0.400147] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]608second # [ 0.422019] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]609test # [ 0.402111] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint610second # [ 0.423860] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint611second # [ 0.425810] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]612test # [ 0.404935] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]613second # [ 0.426952] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]614test # [ 0.405983] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]615test # [ 0.407109] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]616second # [ 0.428916] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint617test # [ 0.408987] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint618second # [ 0.430998] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]619second # [ 0.432016] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]620test # [ 0.411876] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]621test # [ 0.412148] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]622second # [ 0.433957] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint623test # [ 0.413177] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]624second # [ 0.435796] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]625second # [ 0.436952] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]626test # [ 0.414976] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint627second # [ 0.438839] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint628test # [ 0.417147] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]629test # [ 0.418148] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]630test # [ 0.419175] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]631second # [ 0.440990] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]632second # [ 0.441989] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]633test # [ 0.420147] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]634second # [ 0.443016] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]635test # [ 0.422078] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint636second # [ 0.444840] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint637test # [ 0.424147] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]638second # [ 0.447003] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]639test # [ 0.425175] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]640second # [ 0.447989] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]641second # [ 0.449016] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]642test # [ 0.427027] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint643second # [ 0.451114] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint644test # [ 0.429157] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]645second # [ 0.452652] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]646test # [ 0.430175] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]647test # [ 0.432045] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint648test # [ 0.434157] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]649test # [ 0.435175] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]650test # [ 0.437297] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint651second # [ 0.453262] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint652second # [ 0.455622] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]653test # [ 0.439147] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]654test # [ 0.440175] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]655second # [ 0.456244] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint656second # [ 0.457639] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]657test # [ 0.441988] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint658second # [ 0.458265] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint659test # [ 0.444148] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]660second # [ 0.459585] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]661test # [ 0.445148] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]662second # [ 0.460304] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint663test # [ 0.446175] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]664second # [ 0.461438] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO665test # [ 0.447985] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint666second # [ 0.462313] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint667test # [ 0.450147] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]668test # [ 0.451147] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]669second # [ 0.463936] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]670second # [ 0.464970] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]671test # [ 0.452175] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]672second # [ 0.466384] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint673test # [ 0.454023] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint674second # [ 0.467593] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]675test # [ 0.455851] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]676second # [ 0.472517] ACPI: PCI: Interrupt link LNKA configured for IRQ 10677second # [ 0.473093] ACPI: PCI: Interrupt link LNKB configured for IRQ 10678second # [ 0.474091] ACPI: PCI: Interrupt link LNKC configured for IRQ 11679second # [ 0.475095] ACPI: PCI: Interrupt link LNKD configured for IRQ 11680test # [ 0.456378] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint681second # [ 0.476098] ACPI: PCI: Interrupt link LNKE configured for IRQ 10682second # [ 0.477093] ACPI: PCI: Interrupt link LNKF configured for IRQ 10683test # [ 0.458854] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]684second # [ 0.478091] ACPI: PCI: Interrupt link LNKG configured for IRQ 11685test # [ 0.459406] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint686second # [ 0.479088] ACPI: PCI: Interrupt link LNKH configured for IRQ 11687test # [ 0.460798] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]688second # [ 0.480025] ACPI: PCI: Interrupt link GSIA configured for IRQ 16689second # [ 0.480991] ACPI: PCI: Interrupt link GSIB configured for IRQ 17690test # [ 0.461422] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint691second # [ 0.481994] ACPI: PCI: Interrupt link GSIC configured for IRQ 18692second # [ 0.482994] ACPI: PCI: Interrupt link GSID configured for IRQ 19693test # [ 0.462815] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]694second # [ 0.483994] ACPI: PCI: Interrupt link GSIE configured for IRQ 20695test # [ 0.463459] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint696second # [ 0.484991] ACPI: PCI: Interrupt link GSIF configured for IRQ 21697second # [ 0.485991] ACPI: PCI: Interrupt link GSIG configured for IRQ 22698test # [ 0.464606] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO699second # [ 0.486991] ACPI: PCI: Interrupt link GSIH configured for IRQ 23700test # [ 0.465466] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint701second # [ 0.488806] iommu: Default domain type: Translated702second # [ 0.489769] iommu: DMA domain TLB invalidation policy: lazy mode703test # [ 0.467111] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]704second # [ 0.491153] ACPI: bus type USB registered705test # [ 0.467965] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]706second # [ 0.492028] usbcore: registered new interface driver usbfs707second # [ 0.492995] usbcore: registered new interface driver hub708test # [ 0.469525] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint709second # [ 0.493990] usbcore: registered new device driver usb710test # [ 0.470842] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]711second # [ 0.495616] NetLabel: Initializing712second # [ 0.495983] NetLabel: domain hash size = 128713second # [ 0.496883] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO714second # [ 0.497931] NetLabel: unlabeled traffic allowed by default715second # [ 0.498879] PCI: Using ACPI for IRQ routing716test # [ 0.475625] ACPI: PCI: Interrupt link LNKA configured for IRQ 10717test # [ 0.476254] ACPI: PCI: Interrupt link LNKB configured for IRQ 10718test # [ 0.477247] ACPI: PCI: Interrupt link LNKC configured for IRQ 11719test # [ 0.478256] ACPI: PCI: Interrupt link LNKD configured for IRQ 11720test # [ 0.479246] ACPI: PCI: Interrupt link LNKE configured for IRQ 10721test # [ 0.480246] ACPI: PCI: Interrupt link LNKF configured for IRQ 10722test # [ 0.481249] ACPI: PCI: Interrupt link LNKG configured for IRQ 11723test # [ 0.482249] ACPI: PCI: Interrupt link LNKH configured for IRQ 11724test # [ 0.483183] ACPI: PCI: Interrupt link GSIA configured for IRQ 16725test # [ 0.484153] ACPI: PCI: Interrupt link GSIB configured for IRQ 17726test # [ 0.485150] ACPI: PCI: Interrupt link GSIC configured for IRQ 18727test # [ 0.486152] ACPI: PCI: Interrupt link GSID configured for IRQ 19728test # [ 0.487155] ACPI: PCI: Interrupt link GSIE configured for IRQ 20729test # [ 0.488150] ACPI: PCI: Interrupt link GSIF configured for IRQ 21730test # [ 0.489150] ACPI: PCI: Interrupt link GSIG configured for IRQ 22731test # [ 0.490153] ACPI: PCI: Interrupt link GSIH configured for IRQ 23732test # [ 0.491964] iommu: Default domain type: Translated733test # [ 0.492894] iommu: DMA domain TLB invalidation policy: lazy mode734test # [ 0.493367] ACPI: bus type USB registered735test # [ 0.494186] usbcore: registered new interface driver usbfs736test # [ 0.495159] usbcore: registered new interface driver hub737test # [ 0.496156] usbcore: registered new device driver usb738test # [ 0.497769] NetLabel: Initializing739test # [ 0.498141] NetLabel: domain hash size = 128740test # [ 0.499024] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO741test # [ 0.500051] NetLabel: unlabeled traffic allowed by default742test # [ 0.501021] PCI: Using ACPI for IRQ routing743second # [ 0.574329] pci 0000:00:01.0: vgaarb: setting as boot VGA device744second # [ 0.574975] pci 0000:00:01.0: vgaarb: bridge control possible745second # [ 0.574975] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none746second # [ 0.574981] vgaarb: loaded747second # [ 0.575767] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0748second # [ 0.576756] hpet0: 3 comparators, 64-bit 100.000000 MHz counter749second # [ 0.581044] clocksource: Switched to clocksource kvm-clock750second # [ 0.584064] VFS: Disk quotas dquot_6.6.0751second # [ 0.584900] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)752second # [ 0.586447] pnp: PnP ACPI init753second # [ 0.587269] ACPI: IRQ 4 override to edge(!), high(!)754second # [ 0.588370] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved755second # [ 0.590133] pnp: PnP ACPI: found 5 devices756second # [ 0.597249] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns757second # [ 0.598972] clocksource: Switched to clocksource acpi_pm758second # [ 0.600132] NET: Registered PF_INET protocol family759test # [ 0.574983] pci 0000:00:01.0: vgaarb: setting as boot VGA device760second # [ 0.601294] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)761test # [ 0.575134] pci 0000:00:01.0: vgaarb: bridge control possible762test # [ 0.575134] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none763test # [ 0.575139] vgaarb: loaded764test # [ 0.575920] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0765test # [ 0.576906] hpet0: 3 comparators, 64-bit 100.000000 MHz counter766test # [ 0.580200] clocksource: Switched to clocksource kvm-clock767test # [ 0.581823] VFS: Disk quotas dquot_6.6.0768second # [ 0.614408] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)769test # [ 0.583979] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)770test # [ 0.585495] pnp: PnP ACPI init771second # [ 0.616194] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)772test # [ 0.586330] ACPI: IRQ 4 override to edge(!), high(!)773second # [ 0.617772] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)774test # [ 0.587423] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved775second # [ 0.619333] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)776test # [ 0.589158] pnp: PnP ACPI: found 5 devices777second # [ 0.620820] TCP: Hash tables configured (established 8192 bind 8192)778second # [ 0.622121] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)779second # [ 0.623636] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)780second # [ 0.624973] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)781second # [ 0.626389] NET: Registered PF_UNIX/PF_LOCAL protocol family782second # [ 0.627585] NET: Registered PF_XDP protocol family783test # [ 0.596216] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns784test # [ 0.597930] clocksource: Switched to clocksource acpi_pm785second # [ 0.628603] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]786test # [ 0.599063] NET: Registered PF_INET protocol family787second # [ 0.629831] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]788second # [ 0.631064] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]789test # [ 0.600243] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)790second # [ 0.632398] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]791second # [ 0.633790] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]792second # [ 0.635156] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]793second # [ 0.637022] ACPI: \_SB_.GSIA: Enabled at IRQ 16794second # [ 0.638923] ACPI: \_SB_.GSIB: Enabled at IRQ 17795second # [ 0.640774] ACPI: \_SB_.GSIC: Enabled at IRQ 18796second # [ 0.642620] ACPI: \_SB_.GSID: Enabled at IRQ 19797second # [ 0.644283] PCI: CLS 0 bytes, default 64798test # [ 0.613366] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)799second # [ 0.645304] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4505823, max_idle_ns: 440795228884 ns800test # [ 0.615105] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)801second # [ 0.647366] Trying to unpack rootfs image as initramfs...802test # [ 0.616688] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)803test # [ 0.618246] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)804test # [ 0.619719] TCP: Hash tables configured (established 8192 bind 8192)805test # [ 0.621069] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)806test # [ 0.622649] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)807test # [ 0.624008] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)808test # [ 0.625521] NET: Registered PF_UNIX/PF_LOCAL protocol family809test # [ 0.626716] NET: Registered PF_XDP protocol family810test # [ 0.627766] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]811test # [ 0.629030] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]812test # [ 0.630312] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]813test # [ 0.631685] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]814test # [ 0.633053] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]815test # [ 0.634444] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]816test # [ 0.636439] ACPI: \_SB_.GSIA: Enabled at IRQ 16817test # [ 0.638428] ACPI: \_SB_.GSIB: Enabled at IRQ 17818test # [ 0.640364] ACPI: \_SB_.GSIC: Enabled at IRQ 18819test # [ 0.642241] ACPI: \_SB_.GSID: Enabled at IRQ 19820test # [ 0.643904] PCI: CLS 0 bytes, default 64821test # [ 0.644953] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4505823, max_idle_ns: 440795228884 ns822test # [ 0.647046] Trying to unpack rootfs image as initramfs...823second # [ 0.683081] Initialise system trusted keyrings824second # [ 0.686511] workingset: timestamp_bits=40 max_order=18 bucket_order=0825second # [ 0.701812] Key type asymmetric registered826second # [ 0.706474] Asymmetric key parser 'x509' registered827second # [ 0.707565] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)828second # [ 0.712582] io scheduler mq-deadline registered829second # [ 0.713567] io scheduler kyber registered830test # [ 0.683787] Initialise system trusted keyrings831test # [ 0.684937] workingset: timestamp_bits=40 max_order=18 bucket_order=0832second # [ 0.718600] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled833second # [ 0.720136] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A834second # [ 0.726323] Linux agpgart interface v0.103835second # [ 0.727251] ACPI: bus type drm_connector registered836second # [ 0.729814] usbcore: registered new interface driver usbserial_generic837second # [ 0.731119] usbserial: USB Serial support registered for generic838test # [ 0.701470] Key type asymmetric registered839test # [ 0.704252] Asymmetric key parser 'x509' registered840second # [ 0.734470] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.841second # [ 0.734470] Please enable it if your BIOS has the CPPC option.842test # [ 0.705301] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)843second # [ 0.737131] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled844test # [ 0.711336] io scheduler mq-deadline registered845test # [ 0.712306] io scheduler kyber registered846second # [ 0.743569] drop_monitor: Initializing network drop monitor service847second # [ 0.744965] NET: Registered PF_INET6 protocol family848test # [ 0.715648] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled849test # [ 0.717177] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A850second # [ 0.748876] Segment Routing with IPv6851second # [ 0.752472] In-situ OAM (IOAM) with IPv6852second # [ 0.753608] IPI shorthand broadcast: enabled853test # [ 0.723037] Linux agpgart interface v0.103854test # [ 0.723971] ACPI: bus type drm_connector registered855second # [ 0.758922] sched_clock: Marking stable (588020930, 170429598)->(838321008, -79870480)856test # [ 0.728526] usbcore: registered new interface driver usbserial_generic857test # [ 0.729843] usbserial: USB Serial support registered for generic858test # [ 0.733237] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.859second # [ 0.765716] registered taskstats version 1860test # [ 0.733237] Please enable it if your BIOS has the CPPC option.861second # [ 0.766763] Loading compiled-in X.509 certificates862test # [ 0.735878] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled863test # [ 0.742336] drop_monitor: Initializing network drop monitor service864test # [ 0.743666] NET: Registered PF_INET6 protocol family865test # [ 0.747622] Segment Routing with IPv6866test # [ 0.748428] In-situ OAM (IOAM) with IPv6867second # [ 0.781463] Demotion targets for Node 0: null868test # [ 0.751513] IPI shorthand broadcast: enabled869second # [ 0.782502] Key type .fscrypt registered870second # [ 0.783315] Key type fscrypt-provisioning registered871second # [ 0.784418] ima: No TPM chip found, activating TPM-bypass!872test # [ 0.756794] sched_clock: Marking stable (585029811, 171198402)->(835506554, -79278341)873second # [ 0.789580] ima: Allocated hash algorithm: sha1874second # [ 0.790557] ima: No architecture policies found875second # [ 0.793599] PM: Magic number: 14:585:51876test # [ 0.763505] registered taskstats version 1877second # [ 0.795151] RAS: Correctable Errors collector initialized.878test # [ 0.764554] Loading compiled-in X.509 certificates879second # [ 0.804169] clk: Disabling unused clocks880second # [ 0.805022] PM: genpd: Disabling unused power domains881test # [ 0.779234] Demotion targets for Node 0: null882test # [ 0.780272] Key type .fscrypt registered883test # [ 0.781084] Key type fscrypt-provisioning registered884test # [ 0.784241] ima: No TPM chip found, activating TPM-bypass!885test # [ 0.785356] ima: Allocated hash algorithm: sha1886test # [ 0.790261] ima: No architecture policies found887test # [ 0.791384] PM: Magic number: 14:585:51888test # [ 0.792956] RAS: Correctable Errors collector initialized.889test # [ 0.801029] clk: Disabling unused clocks890test # [ 0.804240] PM: genpd: Disabling unused power domains891second # [ 0.912751] Freeing initrd memory: 29608K892second # [ 0.915534] Freeing unused decrypted memory: 2028K893second # [ 0.918064] Freeing unused kernel image (initmem) memory: 3656K894second # [ 0.919323] Write protecting the kernel read-only data: 32768k895second # [ 0.920946] Freeing unused kernel image (text/rodata gap) memory: 304K896second # [ 0.922856] Freeing unused kernel image (rodata/data gap) memory: 692K897test # [ 0.909838] Freeing initrd memory: 29608K898test # [ 0.912637] Freeing unused decrypted memory: 2028K899test # [ 0.915194] Freeing unused kernel image (initmem) memory: 3656K900test # [ 0.916504] Write protecting the kernel read-only data: 32768k901test # [ 0.917957] Freeing unused kernel image (text/rodata gap) memory: 304K902test # [ 0.919584] Freeing unused kernel image (rodata/data gap) memory: 692K903second # [ 0.955195] x86/mm: Checked W+X mappings: passed, no W+X pages found.904second # [ 0.956495] Run /init as init process905second # [ 0.964932] systemd[1]: Inserted module 'autofs4'906second # [ 0.979742] fuse: init (API version 7.45)907test # [ 0.951750] x86/mm: Checked W+X mappings: passed, no W+X pages found.908test # [ 0.953047] Run /init as init process909second # [ 0.985328] ACPI: \_SB_.GSIG: Enabled at IRQ 22910second # [ 0.987835] ACPI: \_SB_.GSIH: Enabled at IRQ 23911second # [ 0.990923] ACPI: \_SB_.GSIE: Enabled at IRQ 20912test # [ 0.961845] systemd[1]: Inserted module 'autofs4'913second # [ 0.993090] ACPI: \_SB_.GSIF: Enabled at IRQ 21914second # [ 0.998300] virtiofs virtio5: discovered new tag: nix-store915second # [ 1.000311] virtiofs virtio5: virtio_fs_setup_dax: No cache capability916test # [ 0.976679] fuse: init (API version 7.45)917second # [ 1.007535] virtiofs virtio6: discovered new tag: shared918second # [ 1.009493] virtiofs virtio6: virtio_fs_setup_dax: No cache capability919second # [ 1.012742] virtiofs virtio7: discovered new tag: xchg920test # [ 0.982450] ACPI: \_SB_.GSIG: Enabled at IRQ 22921second # [ 1.014680] virtiofs virtio7: virtio_fs_setup_dax: No cache capability922test # [ 0.984924] ACPI: \_SB_.GSIH: Enabled at IRQ 23923test # [ 0.988159] ACPI: \_SB_.GSIE: Enabled at IRQ 20924test # [ 0.990394] ACPI: \_SB_.GSIF: Enabled at IRQ 21925test # [ 0.995785] virtiofs virtio5: discovered new tag: nix-store926test # [ 0.997855] virtiofs virtio5: virtio_fs_setup_dax: No cache capability927second # [ 1.032822] systemd[1]: Successfully made /usr/ read-only.928test # [ 1.004367] virtiofs virtio6: discovered new tag: shared929test # [ 1.006472] virtiofs virtio6: virtio_fs_setup_dax: No cache capability930test # [ 1.009929] virtiofs virtio7: discovered new tag: xchg931test # [ 1.011882] virtiofs virtio7: virtio_fs_setup_dax: No cache capability932test # [ 1.030593] systemd[1]: Successfully made /usr/ read-only.933second # [ 1.368738] systemd[1]: systemd 261.3 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)934second # [ 1.374610] systemd[1]: Detected virtualization kvm.935second # [ 1.375666] systemd[1]: Detected architecture x86-64.936second # [ 1.376726] systemd[1]: Running in initrd.937second # [ 1.377876] systemd[1]: Initializing machine ID from random generator.938second # [ 1.379263] systemd[1]: Hostname set to <second>.939test # [ 1.366804] systemd[1]: systemd 261.3 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)940test # [ 1.372652] systemd[1]: Detected virtualization kvm.941test # [ 1.373722] systemd[1]: Detected architecture x86-64.942test # [ 1.374788] systemd[1]: Running in initrd.943test # [ 1.375949] systemd[1]: Initializing machine ID from random generator.944test # [ 1.377340] systemd[1]: Hostname set to <test>.945second # [ 1.432797] systemd[1]: bpf-restrict-fs: LSM BPF program attached946second # [ 1.460617] systemd[1]: Queued start job for default target Initrd Default Target.947test # [ 1.431095] systemd[1]: bpf-restrict-fs: LSM BPF program attached948second # [ 1.464563] systemd[1]: Created slice Slice /system/modprobe.949second # [ 1.465934] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.950second # [ 1.467568] systemd[1]: Expecting device /dev/disk/by-label/nixos...951second # [ 1.468897] systemd[1]: Reached target Path Units.952second # [ 1.469949] systemd[1]: Reached target Slice Units.953second # [ 1.471016] systemd[1]: Reached target Swaps.954second # [ 1.471988] systemd[1]: Reached target Timer Units.955second # [ 1.473130] systemd[1]: Listening on D-Bus System Message Bus Socket.956second # [ 1.474581] systemd[1]: Listening on Journal Socket (/dev/log).957second # [ 1.475952] systemd[1]: Listening on Journal Sockets.958second # [ 1.477150] systemd[1]: Listening on udev Control Socket.959second # [ 1.486290] systemd[1]: Listening on udev Kernel Socket.960second # [ 1.487474] systemd[1]: Reached target Socket Units.961second # [ 1.489223] systemd[1]: Starting Create List of Static Device Nodes...962test # [ 1.459088] systemd[1]: Queued start job for default target Initrd Default Target.963test # [ 1.463323] systemd[1]: Created slice Slice /system/modprobe.964test # [ 1.464690] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.965second # [ 1.495970] systemd[1]: Starting Load Kernel Module configfs...966test # [ 1.466339] systemd[1]: Expecting device /dev/disk/by-label/nixos...967test # [ 1.467669] systemd[1]: Reached target Path Units.968test # [ 1.468722] systemd[1]: Reached target Slice Units.969test # [ 1.469793] systemd[1]: Reached target Swaps.970test # [ 1.470774] systemd[1]: Reached target Timer Units.971test # [ 1.471929] systemd[1]: Listening on D-Bus System Message Bus Socket.972test # [ 1.473368] systemd[1]: Listening on Journal Socket (/dev/log).973test # [ 1.474732] systemd[1]: Listening on Journal Sockets.974second # [ 1.505776] systemd[1]: Starting Journal Service...975second # [ 1.510509] systemd[1]: Starting Load Kernel Modules...976second # [ 1.512781] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os977test # [ 1.475921] systemd[1]: Listening on udev Control Socket.978test # [ 1.485064] systemd[1]: Listening on udev Kernel Socket.979test # [ 1.486248] systemd[1]: Reached target Socket Units.980second # [ 1.517532] systemd[1]: Starting Coldplug All udev Devices...981test # [ 1.488007] systemd[1]: Starting Create List of Static Device Nodes...982test # [ 1.494737] systemd[1]: Starting Load Kernel Module configfs...983second # [ 1.530531] systemd[1]: Finished Create List of Static Device Nodes.984test # [ 1.504617] systemd[1]: Starting Journal Service...985second # [ 1.538043] systemd[1]: modprobe@configfs.service: Deactivated successfully.986test # [ 1.508938] systemd[1]: Starting Load Kernel Modules...987second # [ 1.541611] systemd-journald[65]: Collecting audit messages is disabled.988test # [ 1.511563] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os989second # [ 1.544902] systemd[1]: Finished Load Kernel Module configfs.990test # [ 1.516729] systemd[1]: Starting Coldplug All udev Devices...991second # [ 1.550930] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config992second # [ 1.555545] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.993test # [ 1.532466] systemd[1]: Finished Create List of Static Device Nodes.994second # [ 1.563205] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...995second # [ 1.567575] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev996test # [ 1.538810] systemd[1]: modprobe@configfs.service: Deactivated successfully.997test # [ 1.540920] systemd-journald[65]: Collecting audit messages is disabled.998test # [ 1.546701] systemd[1]: Finished Load Kernel Module configfs.999test # [ 1.552680] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1000test # [ 1.558514] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1001test # [ 1.564282] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1002second # [ 1.596085] systemd[1]: Finished Load Kernel Modules.1003test # [ 1.569237] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1004second # [ 1.600557] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1005second # [ 1.608599] systemd[1]: Starting Apply Kernel Variables...1006second # [ 1.620589] systemd[1]: Starting Create Static Device Nodes in /dev...1007test # [ 1.595281] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1008test # [ 1.602295] systemd[1]: Finished Load Kernel Modules.1009second # [ 1.635543] systemd[1]: Finished Apply Kernel Variables.1010test # [ 1.608379] systemd[1]: Starting Apply Kernel Variables...1011second # [ 1.644059] systemd[1]: Finished Create Static Device Nodes in /dev.1012second # [ 1.648669] systemd[1]: Reached target Preparation for Local File Systems.1013test # [ 1.619368] systemd[1]: Starting Create Static Device Nodes in /dev...1014second # [ 1.653531] systemd[1]: Reached target Local File Systems.1015second # [ 1.658514] systemd[1]: Starting Rule-based Manager for Device Events and Files...1016test # [ 1.637300] systemd[1]: Finished Apply Kernel Variables.1017second # [ 1.674887] systemd[1]: Started Journal Service.1018test # [ 1.647321] systemd[1]: Finished Create Static Device Nodes in /dev.1019second # [ 1.505594] systemd-modules-load[66]: Inserted module 'dm_mod'1020second # [ 1.509412] systemd-modules-load[66]: Inserted module 'virtio_balloon'1021second # [ 1.510700] systemd-modules-load[66]: Inserted module 'virtio_gpu'1022test # [ 1.652441] systemd[1]: Reached target Preparation for Local File Systems.1023test # [ 1.656309] systemd[1]: Reached target Local File Systems.1024second # [ 1.518197] systemd[1]: Starting Create System Files and Directories...1025test # [ 1.663428] systemd[1]: Starting Rule-based Manager for Device Events and Files...1026test # [ 1.675565] systemd[1]: Started Journal Service.1027test # [ 1.503777] systemd-modules-load[66]: Inserted module 'dm_mod'1028test # [ 1.507301] systemd-modules-load[66]: Inserted module 'virtio_balloon'1029test # [ 1.511084] systemd-modules-load[66]: Inserted module 'virtio_gpu'1030second # [ 1.543231] systemd-udevd[73]: Using default interface naming scheme 'v261'.1031second # [ 1.549764] systemd[1]: Finished Create System Files and Directories.1032test # [ 1.527074] systemd[1]: Starting Create System Files and Directories...1033second # [ 1.568707] systemd[1]: Started Rule-based Manager for Device Events and Files.1034test # [ 1.550265] systemd-udevd[73]: Using default interface naming scheme 'v261'.1035second # [ 1.582728] systemd[1]: Finished Coldplug All udev Devices.1036second # [ 1.583809] systemd[1]: Reached target System Initialization.1037second # [ 1.584866] systemd[1]: Reached target Basic System.1038test # [ 1.554070] systemd[1]: Finished Create System Files and Directories.1039test # [ 1.574099] systemd[1]: Started Rule-based Manager for Device Events and Files.1040test # [ 1.583785] systemd[1]: Finished Coldplug All udev Devices.1041test # [ 1.586558] systemd[1]: Reached target System Initialization.1042test # [ 1.587727] systemd[1]: Reached target Basic System.1043second # [ 1.949684] virtio_blk virtio2: 1/0/0 default/read/poll queues1044second # [ 1.961136] ehci-pci 0000:00:1d.7: EHCI Host Controller1045second # [ 1.961988] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11046second # [ 1.963839] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001047second # [ 1.969522] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1048second # [ 1.971025] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001049second # [ 1.973185] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121050second # [ 1.974607] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181051second # [ 1.975869] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11052second # [ 1.979467] usb usb1: Product: EHCI Host Controller1053second # [ 1.980248] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd1054second # [ 1.981864] serio: i8042 KBD port at 0x60,0x64 irq 11055second # [ 1.982669] serio: i8042 AUX port at 0x60,0x64 irq 121056second # [ 1.983661] usb usb1: SerialNumber: 0000:00:1d.71057second # [ 1.985260] hub 1-0:1.0: USB hub found1058second # [ 1.986727] hub 1-0:1.0: 6 ports detected1059test # [ 1.960559] virtio_blk virtio2: 1/0/0 default/read/poll queues1060second # [ 1.991636] uhci_hcd 0000:00:1d.0: UHCI Host Controller1061second # [ 1.992556] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21062test # [ 1.965264] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121063test # [ 1.970433] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1064second # [ 2.003717] uhci_hcd 0000:00:1d.0: detected 2 ports1065test # [ 1.973357] serio: i8042 KBD port at 0x60,0x64 irq 11066test # [ 1.974182] serio: i8042 AUX port at 0x60,0x64 irq 121067second # [ 2.009892] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801068test # [ 1.982984] ehci-pci 0000:00:1d.7: EHCI Host Controller1069test # [ 1.983854] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11070test # [ 1.986035] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001071second # [ 2.018581] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181072test # [ 1.995241] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001073second # [ 2.027334] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11074test # [ 1.996517] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181075test # [ 1.997812] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11076test # [ 2.000549] usb usb1: Product: EHCI Host Controller1077test # [ 2.001471] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd1078second # [ 2.034883] SCSI subsystem initialized1079test # [ 2.004224] usb usb1: SerialNumber: 0000:00:1d.71080test # [ 2.005113] hub 1-0:1.0: USB hub found1081test # [ 2.006300] hub 1-0:1.0: 6 ports detected1082second # [ 2.038101] usb usb2: Product: UHCI Host Controller1083test # [ 2.009953] uhci_hcd 0000:00:1d.0: UHCI Host Controller1084test # [ 2.010812] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21085second # [ 2.042790] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd1086test # [ 2.014057] SCSI subsystem initialized1087test # [ 2.021061] uhci_hcd 0000:00:1d.0: detected 2 ports1088second # [ 2.052321] usb usb2: SerialNumber: 0000:00:1d.01089test # [ 2.022240] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801090second # [ 2.054997] hub 2-0:1.0: USB hub found1091second # [ 1.885397] systemd[1]: Starting Virtual Console Setup...1092second # [ 2.060285] hub 2-0:1.0: 2 ports detected1093test # [ 2.031403] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181094test # [ 2.032680] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11095second # [ 1.906132] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1096test # [ 2.047647] usb usb2: Product: UHCI Host Controller1097second # [ 1.913841] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1098second # [ 1.915894] systemd[1]: Finished Virtual Console Setup.1099test # [ 2.058471] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd1100second # [ 1.921208] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line.1101test # [ 2.062173] usb usb2: SerialNumber: 0000:00:1d.01102second # [ 2.095711] uhci_hcd 0000:00:1d.1: UHCI Host Controller1103test # [ 2.065395] hub 2-0:1.0: USB hub found1104second # [ 2.096559] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31105test # [ 2.069842] hub 2-0:1.0: 2 ports detected1106second # [ 2.105593] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01107test # [ 1.903989] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1108test # [ 1.909531] systemd[1]: Starting Virtual Console Setup...1109second # [ 2.117060] uhci_hcd 0000:00:1d.1: detected 2 ports1110test # [ 1.920617] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1111second # [ 1.954508] systemd[1]: Found device /dev/disk/by-label/nixos.1112second # [ 1.955592] systemd[1]: Reached target Initrd Root Device.1113second # [ 1.957241] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1114second # [ 2.129696] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01115second # [ 2.132715] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181116second # [ 2.135452] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11117test # [ 2.105253] uhci_hcd 0000:00:1d.1: UHCI Host Controller1118test # [ 2.106075] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31119second # [ 2.142524] usb usb3: Product: UHCI Host Controller1120second # [ 2.143307] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd1121test # [ 1.942713] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1122second # [ 2.148494] usb usb3: SerialNumber: 0000:00:1d.11123second # [ 2.151321] hub 3-0:1.0: USB hub found1124second # [ 2.153372] hub 3-0:1.0: 2 ports detected1125second # [ 1.986193] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1126test # [ 1.956093] systemd[1]: Finished Virtual Console Setup.1127test # [ 2.128326] uhci_hcd 0000:00:1d.1: detected 2 ports1128second # [ 2.161414] uhci_hcd 0000:00:1d.2: UHCI Host Controller1129second # [ 1.994936] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1130test # [ 2.134860] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01131second # [ 2.168522] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41132test # [ 2.138087] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01133second # [ 2.171538] uhci_hcd 0000:00:1d.2: detected 2 ports1134test # [ 1.972090] systemd[1]: Found device /dev/disk/by-label/nixos.1135second # [ 2.174509] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01136test # [ 1.973181] systemd[1]: Reached target Initrd Root Device.1137second # [ 2.176725] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181138test # [ 1.976068] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1139second # [ 2.179198] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1140test # [ 2.149379] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181141second # [ 2.180504] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11142test # [ 2.150637] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11143second # [ 2.182077] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1144second # [ 2.183500] usb usb4: Product: UHCI Host Controller1145second # [ 2.184286] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd1146second # [ 2.185543] ahci 0000:00:1f.2: flags: 64bit ncq only1147second # [ 2.187050] usb usb4: SerialNumber: 0000:00:1d.21148second # [ 2.191581] hub 4-0:1.0: USB hub found1149second # [ 2.193023] hub 4-0:1.0: 2 ports detected1150second # [ 2.195568] scsi host0: ahci1151second # [ 2.197572] scsi host1: ahci1152test # [ 2.167139] usb usb3: Product: UHCI Host Controller1153test # [ 2.168328] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd1154second # [ 2.199776] scsi host2: ahci1155test # [ 2.169166] usb usb3: SerialNumber: 0000:00:1d.11156second # [ 2.200963] scsi host3: ahci1157second # [ 2.204773] scsi host4: ahci1158test # [ 2.002376] systemd-fsck[105]: nixos: clean, 12/65536 files, 13019/262144 blocks1159test # [ 2.007446] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1160test # [ 2.180357] hub 3-0:1.0: USB hub found1161second # [ 2.211478] scsi host5: ahci1162second # [ 2.212131] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11163test # [ 2.181925] hub 3-0:1.0: 2 ports detected1164test # [ 2.186683] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1165test # [ 2.188221] uhci_hcd 0000:00:1d.2: UHCI Host Controller1166second # [ 2.219464] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11167test # [ 2.189044] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41168second # [ 2.220733] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11169test # [ 2.190859] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1170test # [ 2.192143] uhci_hcd 0000:00:1d.2: detected 2 ports1171test # [ 2.193539] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01172test # [ 2.194641] ahci 0000:00:1f.2: flags: 64bit ncq only1173test # [ 2.196596] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181174second # [ 2.228463] usb 1-1: new high-speed USB device number 2 using ehci-pci1175test # [ 2.198019] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11176test # [ 2.199352] usb usb4: Product: UHCI Host Controller1177test # [ 2.200135] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd1178second # [ 2.231460] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11179second # [ 2.234268] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11180test # [ 2.205246] scsi host0: ahci1181second # [ 2.235636] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11182test # [ 2.206471] usb usb4: SerialNumber: 0000:00:1d.21183test # [ 2.208179] scsi host1: ahci1184test # [ 2.211272] hub 4-0:1.0: USB hub found1185test # [ 2.212520] scsi host2: ahci1186test # [ 2.213855] hub 4-0:1.0: 2 ports detected1187test # [ 2.214755] scsi host3: ahci1188test # [ 2.221277] scsi host4: ahci1189test # [ 2.223247] scsi host5: ahci1190test # [ 2.223893] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11191test # [ 2.230650] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11192test # [ 2.239547] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11193test # [ 2.244233] usb 1-1: new high-speed USB device number 2 using ehci-pci1194test # [ 2.247393] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11195test # [ 2.250031] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11196test # [ 2.251429] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11197second # [ 2.357514] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001198second # [ 2.359083] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101199second # [ 2.360890] usb 1-1: Product: QEMU USB Tablet1200second # [ 2.361904] usb 1-1: Manufacturer: QEMU1201second # [ 2.362862] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11202second # [ 2.376887] hid: raw HID events driver (C) Jiri Kosina1203test # [ 2.374077] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001204test # [ 2.375365] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101205test # [ 2.376818] usb 1-1: Product: QEMU USB Tablet1206test # [ 2.377656] usb 1-1: Manufacturer: QEMU1207test # [ 2.378426] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11208test # [ 2.393011] hid: raw HID events driver (C) Jiri Kosina1209second # [ 2.356906] systemd[1]: Mounting /sysroot...1210second # [ 2.547789] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1211second # [ 2.548868] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001212second # [ 2.549997] ata3.00: applying bridge limits1213second # [ 2.550886] ata3.00: configured for UDMA/1001214second # [ 2.551873] ata5: SATA link down (SStatus 0 SControl 300)1215second # [ 2.553018] ata4: SATA link down (SStatus 0 SControl 300)1216second # [ 2.554150] ata2: SATA link down (SStatus 0 SControl 300)1217second # [ 2.555291] ata1: SATA link down (SStatus 0 SControl 300)1218second # [ 2.556421] ata6: SATA link down (SStatus 0 SControl 300)1219second # [ 2.557772] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51220test # [ 2.357766] systemd[1]: Mounting /sysroot...1221test # [ 2.563871] ata5: SATA link down (SStatus 0 SControl 300)1222test # [ 2.565228] ata1: SATA link down (SStatus 0 SControl 300)1223test # [ 2.566270] ata2: SATA link down (SStatus 0 SControl 300)1224test # [ 2.567338] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1225test # [ 2.568378] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001226test # [ 2.569667] ata3.00: applying bridge limits1227test # [ 2.570536] ata3.00: configured for UDMA/1001228test # [ 2.571523] ata4: SATA link down (SStatus 0 SControl 300)1229test # [ 2.572653] ata6: SATA link down (SStatus 0 SControl 300)1230second # [ 2.603383] usbcore: registered new interface driver usbhid1231test # [ 2.573919] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51232second # [ 2.606449] usbhid: USB HID core driver1233second # [ 2.628601] 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/input21234second # [ 2.636012] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01235second # [ 2.639992] EXT4-fs (vda): mounted filesystem b9b1e5b4-ffa2-42ce-8521-b9d3a4c6af48 r/w with ordered data mode. Quota mode: none.1236second # [ 2.644162] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1237second # [ 2.476450] systemd[1]: Mounted /sysroot.1238second # [ 2.478524] systemd[1]: Reached target Initrd Root File System.1239second # [ 2.483075] systemd[1]: Starting Mountpoints Configured in the Real Root...1240test # [ 2.623323] usbcore: registered new interface driver usbhid1241test # [ 2.624236] usbhid: USB HID core driver1242second # [ 2.662005] cdrom: Uniform CD-ROM driver Revision: 3.201243second # [ 2.496974] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1244second # [ 2.500536] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1245second # [ 2.503970] systemd[1]: Reloading...1246test # [ 2.645999] 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/input21247test # [ 2.650548] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01248test # [ 2.655761] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1249test # [ 2.658809] EXT4-fs (vda): mounted filesystem 75eebf4b-c4f1-4141-a5a0-d43d751cbbb5 r/w with ordered data mode. Quota mode: none.1250test # [ 2.493243] systemd[1]: Mounted /sysroot.1251test # [ 2.496075] systemd[1]: Reached target Initrd Root File System.1252test # [ 2.499263] systemd[1]: Starting Mountpoints Configured in the Real Root...1253test # [ 2.675227] cdrom: Uniform CD-ROM driver Revision: 3.201254test # [ 2.517539] systemd-sysroot-fstab-check[135]: /sysroot should be mounted in the initrd, will request daemon-reload.1255test # [ 2.521329] systemd[1]: Reload requested from client PID 135 ('systemd-sysroot') (unit initrd-parse-etc.service)...1256test # [ 2.524417] systemd[1]: Reloading...1257second # [ 2.572727] systemd[1]: Reloading finished in 69 ms.1258second # [ 2.582200] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1259second # [ 2.589482] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1260second # [ 2.592582] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1261second # [ 2.594329] systemd[1]: Finished Mountpoints Configured in the Real Root.1262second # [ 2.595622] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1263test # [ 2.583739] systemd[1]: Reloading finished in 60 ms.1264test # [ 2.597080] systemd-sysroot-fstab-check[135]: Requesting initrd-fs.target/start/replace...1265test # [ 2.599741] systemd-sysroot-fstab-check[135]: Requesting swap.target/start/replace...1266test # [ 2.603872] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1267test # [ 2.608175] systemd[1]: Finished Mountpoints Configured in the Real Root.1268test # [ 2.609388] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1269second # [ 3.357824] systemd[1]: Mounting /sysroot/nix/.ro-store...1270second # [ 3.361140] systemd[1]: Mounting /sysroot/nix/.rw-store...1271second # [ 3.363139] systemd[1]: Mounting /sysroot/run...1272second # [ 3.368135] systemd[1]: Mounting /sysroot/tmp/shared...1273second # [ 3.374146] systemd[1]: Mounting /sysroot/tmp/xchg...1274test # [ 3.359110] systemd[1]: Mounting /sysroot/nix/.ro-store...1275second # [ 3.391730] systemd[1]: Mounted /sysroot/nix/.rw-store.1276test # [ 3.361451] systemd[1]: Mounting /sysroot/nix/.rw-store...1277second # [ 3.394975] systemd[1]: Mounted /sysroot/nix/.ro-store.1278test # [ 3.365901] systemd[1]: Mounting /sysroot/run...1279second # [ 3.399408] systemd[1]: Mounted /sysroot/run.1280second # [ 3.401272] systemd[1]: Mounted /sysroot/tmp/shared.1281test # [ 3.370143] systemd[1]: Mounting /sysroot/tmp/shared...1282second # [ 3.403442] systemd[1]: Mounted /sysroot/tmp/xchg.1283test # [ 3.374496] systemd[1]: Mounting /sysroot/tmp/xchg...1284second # [ 3.406319] systemd[1]: Starting rw-sysroot-nix-store.service...1285second # [ 3.415320] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1286second # [ 3.417207] systemd[1]: Finished rw-sysroot-nix-store.service.1287test # [ 3.395461] systemd[1]: Mounted /sysroot/nix/.rw-store.1288test # [ 3.398439] systemd[1]: Mounted /sysroot/nix/.ro-store.1289test # [ 3.399471] systemd[1]: Mounted /sysroot/run.1290test # [ 3.403273] systemd[1]: Mounted /sysroot/tmp/shared.1291test # [ 3.405164] systemd[1]: Mounted /sysroot/tmp/xchg.1292test # [ 3.408490] systemd[1]: Starting rw-sysroot-nix-store.service...1293test # [ 3.417131] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1294test # [ 3.419180] systemd[1]: Finished rw-sysroot-nix-store.service.1295second # [ 4.357688] systemd[1]: Mounting /sysroot/nix/store...1296second # [ 4.375516] systemd[1]: Mounted /sysroot/nix/store.1297second # [ 4.377054] systemd[1]: Reached target Initrd File Systems.1298second # [ 4.379085] systemd[1]: Starting Find NixOS closure...1299second # [ 4.382135] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1300test # [ 4.358558] systemd[1]: Mounting /sysroot/nix/store...1301second # [ 4.402856] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1302second # [ 4.404379] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1303test # [ 4.375983] systemd[1]: Mounted /sysroot/nix/store.1304test # [ 4.377568] systemd[1]: Reached target Initrd File Systems.1305second # [ 4.409099] systemd[1]: Finished Find NixOS closure.1306test # [ 4.379566] systemd[1]: Starting Find NixOS closure...1307second # [ 4.412097] systemd[1]: Reached target Initrd Default Target.1308second # [ 4.413424] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1309test # [ 4.383136] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1310second # [ 4.426065] systemd[1]: Stopped target Initrd Default Target.1311second # [ 4.427758] systemd[1]: Stopped target Basic System.1312second # [ 4.429040] systemd[1]: Stopped target Initrd Root Device.1313second # [ 4.431137] systemd[1]: Stopped target Path Units.1314second # [ 4.432083] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1315test # [ 4.401861] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1316second # [ 4.433513] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1317second # [ 4.434876] systemd[1]: Stopped target Slice Units.1318second # [ 4.435831] systemd[1]: Stopped target Socket Units.1319test # [ 4.403912] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1320second # [ 4.436771] systemd[1]: Stopped target System Initialization.1321second # [ 4.438634] systemd[1]: Stopped target Swaps.1322second # [ 4.440171] systemd[1]: Stopped target Timer Units.1323second # [ 4.441147] systemd[1]: dbus.socket: Deactivated successfully.1324test # [ 4.409812] systemd[1]: Finished Find NixOS closure.1325second # [ 4.442409] systemd[1]: Closed D-Bus System Message Bus Socket.1326test # [ 4.411249] systemd[1]: Reached target Initrd Default Target.1327second # [ 4.443728] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1328test # [ 4.413161] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1329second # [ 4.445354] systemd[1]: Stopped Find NixOS closure.1330second # [ 4.447198] systemd[1]: Starting rw-sysroot-nix-store.service...1331second # [ 4.448367] systemd[1]: systemd-sysctl.service: Deactivated successfully.1332second # [ 4.449827] systemd[1]: Stopped Apply Kernel Variables.1333second # [ 4.451214] systemd[1]: systemd-modules-load.service: Deactivated successfully.1334second # [ 4.452759] systemd[1]: Stopped Load Kernel Modules.1335second # [ 4.454233] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1336test # [ 4.424369] systemd[1]: Stopped target Initrd Default Target.1337second # [ 4.456124] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1338test # [ 4.425688] systemd[1]: Stopped target Basic System.1339second # [ 4.457478] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1340second # [ 4.458763] systemd[1]: Stopped Create System Files and Directories.1341test # [ 4.428076] systemd[1]: Stopped target Initrd Root Device.1342second # [ 4.460180] systemd[1]: Stopped target Local File Systems.1343test # [ 4.429115] systemd[1]: Stopped target Path Units.1344test # [ 4.430178] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1345second # [ 4.462162] systemd[1]: Stopped target Preparation for Local File Systems.1346test # [ 4.431533] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1347second # [ 4.463706] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1348test # [ 4.432907] systemd[1]: Stopped target Slice Units.1349test # [ 4.433891] systemd[1]: Stopped target Socket Units.1350second # [ 4.466223] systemd[1]: Stopped Coldplug All udev Devices.1351test # [ 4.435313] systemd[1]: Stopped target System Initialization.1352second # [ 4.467413] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1353test # [ 4.436800] systemd[1]: Stopped target Swaps.1354test # [ 4.438214] systemd[1]: Stopped target Timer Units.1355second # [ 4.470199] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1356test # [ 4.439199] systemd[1]: dbus.socket: Deactivated successfully.1357test # [ 4.440488] systemd[1]: Closed D-Bus System Message Bus Socket.1358second # [ 4.472395] systemd[1]: Stopped Virtual Console Setup.1359test # [ 4.441926] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1360test # [ 4.443397] systemd[1]: Stopped Find NixOS closure.1361test # [ 4.444672] systemd[1]: Starting rw-sysroot-nix-store.service...1362test # [ 4.446171] systemd[1]: systemd-sysctl.service: Deactivated successfully.1363test # [ 4.447564] systemd[1]: Stopped Apply Kernel Variables.1364second # [ 4.480109] systemd[1]: initrd-cleanup.service: Deactivated successfully.1365test # [ 4.448854] systemd[1]: systemd-modules-load.service: Deactivated successfully.1366test # [ 4.451239] systemd[1]: Stopped Load Kernel Modules.1367test # [ 4.452236] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1368second # [ 4.484076] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1369test # [ 4.454120] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1370test # [ 4.455779] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1371second # [ 4.488604] systemd[1]: systemd-udevd.service: Deactivated successfully.1372test # [ 4.458867] systemd[1]: Stopped Create System Files and Directories.1373second # [ 4.490937] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1374test # [ 4.460037] systemd[1]: Stopped target Local File Systems.1375test # [ 4.461085] systemd[1]: Stopped target Preparation for Local File Systems.1376second # [ 4.493170] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1377test # [ 4.462280] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1378second # [ 4.495196] systemd[1]: Finished rw-sysroot-nix-store.service.1379test # [ 4.463847] systemd[1]: Stopped Coldplug All udev Devices.1380second # [ 4.496483] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1381second # [ 4.498070] systemd[1]: Closed udev Control Socket.1382test # [ 4.466172] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1383test # [ 4.467847] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1384second # [ 4.500089] systemd[1]: Starting Cleanup udev Database...1385test # [ 4.469631] systemd[1]: Stopped Virtual Console Setup.1386second # [ 4.501153] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1387second # [ 4.503166] systemd[1]: Stopped Create Static Device Nodes in /dev.1388second # [ 4.504330] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1389second # [ 4.505768] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1390second # [ 4.507491] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1391second # [ 4.508748] systemd[1]: Stopped Create List of Static Device Nodes.1392test # [ 4.477451] systemd[1]: systemd-udevd.service: Deactivated successfully.1393test # [ 4.480132] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1394test # [ 4.482201] systemd[1]: initrd-cleanup.service: Deactivated successfully.1395test # [ 4.486172] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1396test # [ 4.488957] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1397test # [ 4.490423] systemd[1]: Finished rw-sysroot-nix-store.service.1398second # [ 4.521798] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1399second # [ 4.523382] systemd[1]: Finished Cleanup udev Database.1400second # [ 4.525198] systemd[1]: Reached target Switch Root.1401test # [ 4.493579] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1402second # [ 4.526592] systemd[1]: Starting NixOS Activation...1403test # [ 4.495215] systemd[1]: Closed udev Control Socket.1404test # [ 4.497089] systemd[1]: Starting Cleanup udev Database...1405test # [ 4.498169] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1406test # [ 4.500177] systemd[1]: Stopped Create Static Device Nodes in /dev.1407test # [ 4.501396] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1408test # [ 4.503351] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1409test # [ 4.505184] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1410test # [ 4.506901] systemd[1]: Stopped Create List of Static Device Nodes.1411test # [ 4.523821] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1412test # [ 4.525878] systemd[1]: Finished Cleanup udev Database.1413test # [ 4.528221] systemd[1]: Reached target Switch Root.1414test # [ 4.530086] systemd[1]: Starting NixOS Activation...1415second # [ 4.579198] initrd-nixos-activation-start[188]: booting system configuration /nix/store/9hff8ghkyy5byyvgsz0wsw6wcq8sn1lq-nixos-system-second-test1416second # [ 4.602384] initrd-nixos-activation-start[188]: running activation script...1417test # [ 4.580916] initrd-nixos-activation-start[188]: booting system configuration /nix/store/ij1m3q4jl87b32j7bz90pjcgbyj5jq5d-nixos-system-test-test1418test # [ 4.601442] initrd-nixos-activation-start[188]: running activation script...1419second # [ 4.774409] initrd-nixos-activation-start[211]: setting up /etc...1420test # [ 4.761790] initrd-nixos-activation-start[211]: setting up /etc...1421second # [ 4.865995] initrd-nixos-activation-start[211]: setting up age secrets...1422test # [ 4.853114] initrd-nixos-activation-start[211]: setting up age secrets...1423second # [ 4.950519] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1424second # [ 4.953111] systemd[1]: Finished NixOS Activation.1425second # [ 4.955644] systemd[1]: Starting Switch Root...1426second # [ 4.970139] systemd[1]: Switching root.1427test # [ 4.968988] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1428test # [ 4.971095] systemd[1]: Finished NixOS Activation.1429test # [ 4.973297] systemd[1]: Starting Switch Root...1430test # [ 4.985091] systemd[1]: Switching root.1431second # [ 5.264229] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1432test # [ 5.279910] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1433second # [ 5.343252] NET: Registered PF_VSOCK protocol family1434test # [ 5.350098] NET: Registered PF_VSOCK protocol family1435second # [ 5.697306] systemd[1]: systemd 261.3 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)1436second # [ 5.702189] systemd[1]: Detected virtualization kvm.1437second # [ 5.703220] systemd[1]: Detected architecture x86-64.1438second # [ 5.704226] systemd[1]: Detected first boot.1439second # [ 5.706063] systemd[1]: Initializing machine ID from random generator.1440test # [ 5.701445] systemd[1]: systemd 261.3 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)1441test # [ 5.706118] systemd[1]: Detected virtualization kvm.1442test # [ 5.706998] systemd[1]: Detected architecture x86-64.1443test # [ 5.707945] systemd[1]: Detected first boot.1444test # [ 5.709519] systemd[1]: Initializing machine ID from random generator.1445second # [ 5.777493] systemd[1]: bpf-restrict-fs: LSM BPF program attached1446test # [ 5.776131] systemd[1]: bpf-restrict-fs: LSM BPF program attached1447second # [ 5.842602] systemd[1]: Applying preset policy.1448test # [ 5.836069] systemd[1]: Applying preset policy.1449second # [ 6.018525] systemd[1]: Populated /etc with preset unit settings.1450test # [ 6.008566] systemd[1]: Populated /etc with preset unit settings.1451second # [ 6.197980] systemd[1]: initrd-switch-root.service: Deactivated successfully.1452second # [ 6.199996] systemd[1]: Stopped initrd-switch-root.service.1453second # [ 6.203152] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1454second # [ 6.205719] systemd[1]: Created slice Slice /system/getty.1455second # [ 6.207523] systemd[1]: Created slice User and Session Slice.1456second # [ 6.208826] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1457second # [ 6.210533] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1458second # [ 6.212069] systemd[1]: Expecting device /dev/hvc0...1459second # [ 6.213114] systemd[1]: Expecting device /dev/ttyS0...1460second # [ 6.214206] systemd[1]: Reached target Local Encrypted Volumes.1461second # [ 6.215318] systemd[1]: Stopped target initrd-fs.target.1462test # [ 6.191825] systemd[1]: initrd-switch-root.service: Deactivated successfully.1463test # [ 6.193522] systemd[1]: Stopped initrd-switch-root.service.1464test # [ 6.196128] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1465second # [ 6.217573] systemd[1]: Stopped target initrd-root-fs.target.1466second # [ 6.228973] systemd[1]: Stopped target initrd-switch-root.target.1467test # [ 6.198648] systemd[1]: Created slice Slice /system/getty.1468second # [ 6.230036] systemd[1]: Reached target Virtual Machines and Containers.1469test # [ 6.200085] systemd[1]: Created slice User and Session Slice.1470second # [ 6.231176] systemd[1]: Reached target Path Units.1471second # [ 6.232086] systemd[1]: Reached target Remote File Systems.1472test # [ 6.201278] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1473second # [ 6.233090] systemd[1]: Reached target Slice Units.1474second # [ 6.233998] systemd[1]: Reached target Swaps.1475test # [ 6.202719] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1476test # [ 6.204045] systemd[1]: Expecting device /dev/hvc0...1477test # [ 6.204945] systemd[1]: Expecting device /dev/ttyS0...1478second # [ 6.235696] systemd[1]: Listening on Query the User Interactively for a Password.1479test # [ 6.205903] systemd[1]: Reached target Local Encrypted Volumes.1480test # [ 6.206960] systemd[1]: Stopped target initrd-fs.target.1481second # [ 6.238015] systemd[1]: Listening on Process Core Dump Socket.1482second # [ 6.239819] systemd[1]: Listening on Credential Encryption/Decryption.1483second # [ 6.241741] systemd[1]: Listening on Factory Reset Management.1484second # [ 6.242863] systemd[1]: Listening on Hostname Service Socket.1485second # [ 6.245717] systemd[1]: Starting Journal Log Access Socket...1486second # [ 6.247039] systemd[1]: Listening on Journal Audit Socket.1487test # [ 6.207917] systemd[1]: Stopped target initrd-root-fs.target.1488test # [ 6.217461] systemd[1]: Stopped target initrd-switch-root.target.1489test # [ 6.218513] systemd[1]: Reached target Virtual Machines and Containers.1490second # [ 6.249449] systemd[1]: Listening on Console Output Muting Service Socket.1491test # [ 6.219663] systemd[1]: Reached target Path Units.1492second # [ 6.250747] systemd[1]: Listening on Network Management Metrics Varlink Socket.1493test # [ 6.220588] systemd[1]: Reached target Remote File Systems.1494test # [ 6.221580] systemd[1]: Reached target Slice Units.1495second # [ 6.252151] systemd[1]: Listening on Network Management Varlink Socket.1496test # [ 6.222480] systemd[1]: Reached target Swaps.1497second # [ 6.253383] systemd[1]: Listening on Network Management Netlink Socket.1498second # [ 6.254692] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1499test # [ 6.224264] systemd[1]: Listening on Query the User Interactively for a Password.1500second # [ 6.255975] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1501test # [ 6.226670] systemd[1]: Listening on Process Core Dump Socket.1502second # [ 6.257503] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1503test # [ 6.228515] systemd[1]: Listening on Credential Encryption/Decryption.1504test # [ 6.230459] systemd[1]: Listening on Factory Reset Management.1505second # [ 6.261272] systemd[1]: Listening on Disk Repartitioning Service Socket.1506test # [ 6.231559] systemd[1]: Listening on Hostname Service Socket.1507second # [ 6.262535] systemd[1]: Listening on Resolve Monitor Varlink Socket.1508second # [ 6.263720] systemd[1]: Listening on Resolve Service Varlink Socket.1509second # [ 6.264891] systemd[1]: Listening on udev Control Socket.1510test # [ 6.234391] systemd[1]: Starting Journal Log Access Socket...1511second # [ 6.265954] systemd[1]: Listening on udev Varlink Socket.1512test # [ 6.235652] systemd[1]: Listening on Journal Audit Socket.1513second # [ 6.267933] systemd[1]: Mounting Huge Pages File System...1514test # [ 6.238210] systemd[1]: Listening on Console Output Muting Service Socket.1515test # [ 6.239482] systemd[1]: Listening on Network Management Metrics Varlink Socket.1516second # [ 6.270771] systemd[1]: Mounting POSIX Message Queue File System...1517test # [ 6.240903] systemd[1]: Listening on Network Management Varlink Socket.1518test # [ 6.242161] systemd[1]: Listening on Network Management Netlink Socket.1519test # [ 6.243456] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1520test # [ 6.244754] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1521second # [ 6.276729] systemd[1]: Mounting Kernel Debug File System...1522test # [ 6.246289] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1523test # [ 6.250241] systemd[1]: Listening on Disk Repartitioning Service Socket.1524test # [ 6.251484] systemd[1]: Listening on Resolve Monitor Varlink Socket.1525test # [ 6.252661] systemd[1]: Listening on Resolve Service Varlink Socket.1526second # [ 6.284251] systemd[1]: Mounting Kernel Trace File System...1527test # [ 6.253839] systemd[1]: Listening on udev Control Socket.1528test # [ 6.254903] systemd[1]: Listening on udev Varlink Socket.1529test # [ 6.257121] systemd[1]: Mounting Huge Pages File System...1530test # [ 6.260374] systemd[1]: Mounting POSIX Message Queue File System...1531second # [ 6.292489] systemd[1]: Starting Create List of Static Device Nodes...1532test # [ 6.267366] systemd[1]: Mounting Kernel Debug File System...1533test # [ 6.273980] systemd[1]: Mounting Kernel Trace File System...1534second # [ 6.305348] systemd[1]: Starting Load Kernel Module configfs...1535second # [ 6.312870] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1536test # [ 6.282584] systemd[1]: Starting Create List of Static Device Nodes...1537second # [ 6.320784] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1538second # [ 6.323134] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1539test # [ 6.294247] systemd[1]: Starting Load Kernel Module configfs...1540test # [ 6.297632] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1541second # [ 6.332594] systemd[1]: Mounting FUSE Control File System...1542test # [ 6.302733] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1543second # [ 6.334130] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671544test # [ 6.307935] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1545second # [ 6.343576] systemd[1]: Starting Journal Service...1546test # [ 6.318262] systemd[1]: Mounting FUSE Control File System...1547second # [ 6.350208] systemd[1]: Starting Load Kernel Modules...1548test # [ 6.325659] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671549second # [ 6.358659] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1550second # [ 6.367083] systemd[1]: Starting Remount Root and Kernel File Systems...1551test # [ 6.339134] systemd[1]: Starting Journal Service...1552second # [ 6.373504] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1553test # [ 6.345917] systemd[1]: Starting Load Kernel Modules...1554test # [ 6.352922] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1555second # [ 6.388718] systemd[1]: Starting Coldplug All udev Devices...1556second # [ 6.391289] systemd-journald[314]: Collecting audit messages is enabled.1557test # [ 6.364159] systemd[1]: Starting Remount Root and Kernel File Systems...1558test # [ 6.369065] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1559second # [ 6.403743] systemd[1]: Listening on Journal Log Access Socket.1560second # [ 6.407768] systemd[1]: Mounted Huge Pages File System.1561second # [ 6.410724] systemd[1]: Mounted POSIX Message Queue File System.1562test # [ 6.380746] systemd-journald[335]: Collecting audit messages is enabled.1563test # [ 6.382527] systemd[1]: Starting Coldplug All udev Devices...1564second # [ 6.414648] systemd[1]: Mounted Kernel Debug File System.1565test # [ 6.393343] systemd[1]: Listening on Journal Log Access Socket.1566second # [ 6.426708] systemd[1]: Mounted Kernel Trace File System.1567second # [ 6.260107] systemd[1]: Queued start job for default target Multi-User System.1568test # [ 6.400506] systemd[1]: Mounted Huge Pages File System.1569second # [ 6.261612] systemd[1]: systemd-journald.service: Deactivated successfully.1570second # [ 6.433387] loop: module loaded1571second # [ 6.264838] systemd-modules-load[315]: Module 'ctr' is built in1572test # [ 6.405391] systemd[1]: Mounted POSIX Message Queue File System.1573test # [ 6.406476] loop: module loaded1574second # [ 6.438132] systemd[1]: Started Journal Service.1575second # [ 6.269651] systemd-modules-load[315]: Inserted module 'loop'1576test # [ 6.409432] systemd[1]: Mounted Kernel Debug File System.1577second # [ 6.442468] EXT4-fs (vda): re-mounted b9b1e5b4-ffa2-42ce-8521-b9d3a4c6af48.1578test # [ 6.412409] systemd[1]: Mounted Kernel Trace File System.1579test # [ 6.242652] systemd[1]: Queued start job for default target Multi-User System.1580test # [ 6.245409] systemd[1]: systemd-journald.service: Deactivated successfully.1581test # [ 6.248605] systemd-modules-load[336]: Module 'ctr' is built in1582second # [ 6.280370] systemd[1]: Finished Create List of Static Device Nodes.1583second # [ 6.281561] systemd[1]: modprobe@configfs.service: Deactivated successfully.1584test # [ 6.252392] systemd-modules-load[336]: Inserted module 'loop'1585test # [ 6.424645] systemd[1]: Started Journal Service.1586second # [ 6.285320] systemd[1]: Finished Load Kernel Module configfs.1587second # [ 6.286397] systemd[1]: Mounted FUSE Control File System.1588second # [ 6.290151] systemd[1]: Finished Load Kernel Modules.1589second # [ 6.292134] systemd[1]: Finished Remount Root and Kernel File Systems.1590test # [ 6.435523] EXT4-fs (vda): re-mounted 75eebf4b-c4f1-4141-a5a0-d43d751cbbb5.1591test # [ 6.265550] systemd[1]: Finished Create List of Static Device Nodes.1592test # [ 6.266875] systemd[1]: modprobe@configfs.service: Deactivated successfully.1593test # [ 6.270182] systemd[1]: Finished Load Kernel Module configfs.1594test # [ 6.271682] systemd[1]: Mounted FUSE Control File System.1595second # [ 6.306443] systemd[1]: Listening on Disk Image Download Service Socket.1596test # [ 6.276150] systemd[1]: Finished Load Kernel Modules.1597second # [ 6.307953] systemd-oomd[317]: No swap; memory pressure usage will be degraded1598second # [ 6.312155] systemd[1]: Mounting Kernel Configuration File System...1599test # [ 6.282186] systemd[1]: Finished Remount Root and Kernel File Systems.1600second # [ 6.317075] systemd[1]: Starting Firewall...1601second # [ 6.322330] systemd[1]: Starting Flush Journal to Persistent Storage...1602test # [ 6.290770] systemd[1]: Listening on Disk Image Download Service Socket.1603second # [ 6.324515] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1604test # [ 6.294105] systemd[1]: Mounting Kernel Configuration File System...1605test # [ 6.297451] systemd[1]: Starting Firewall...1606test # [ 6.299821] systemd-oomd[338]: No swap; memory pressure usage will be degraded1607second # [ 6.334115] systemd[1]: Starting Load/Save OS Random Seed...1608test # [ 6.307083] systemd[1]: Starting Flush Journal to Persistent Storage...1609test # [ 6.308275] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1610second # [ 6.346795] systemd[1]: Starting Apply Kernel Variables...1611test # [ 6.321190] systemd[1]: Starting Load/Save OS Random Seed...1612second # [ 6.355426] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1613second # [ 6.357096] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1614test # [ 6.329076] systemd[1]: Starting Apply Kernel Variables...1615second # [ 6.361457] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1616test # [ 6.332129] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1617test # [ 6.333936] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1618test # [ 6.335419] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1619second # [ 6.564157] systemd-journald[314]: Received client request to flush runtime journal.1620test # [ 6.535756] systemd-journald[335]: Received client request to flush runtime journal.1621second # [ 6.571411] systemd[1]: Finished Load/Save OS Random Seed.1622test # [ 6.540935] systemd[1]: Finished Load/Save OS Random Seed.1623second # [ 6.572955] systemd[1]: Reached target First Boot Complete.1624second # [ 6.576502] systemd[1]: Mounted Kernel Configuration File System.1625test # [ 6.548145] systemd[1]: Reached target First Boot Complete.1626test # [ 6.549504] systemd[1]: Mounted Kernel Configuration File System.1627second # [ 6.581628] systemd[1]: Finished Apply Kernel Variables.1628second # [ 6.582715] systemd[1]: Starting Network Name Resolution...1629test # [ 6.552322] systemd[1]: Finished Apply Kernel Variables.1630second # [ 6.583991] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1631second # [ 6.585365] systemd[1]: Starting Create Static Device Nodes in /dev...1632test # [ 6.555221] systemd[1]: Starting Network Name Resolution...1633test # [ 6.556284] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1634test # [ 6.557556] systemd[1]: Starting Create Static Device Nodes in /dev...1635second # [ 6.590993] systemd[1]: Finished Flush Journal to Persistent Storage.1636test # [ 6.563309] systemd[1]: Finished Flush Journal to Persistent Storage.1637second # [ 6.608176] systemd-resolved[344]: Positive Trust Anchors:1638second # [ 6.610174] systemd-resolved[344]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1639second # [ 6.613499] systemd-resolved[344]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161640second # [ 6.616162] systemd-resolved[344]: 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 test1641test # [ 6.608423] systemd-resolved[363]: Positive Trust Anchors:1642test # [ 6.610347] systemd-resolved[363]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1643test # [ 6.613428] systemd-resolved[363]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161644test # [ 6.615178] systemd-resolved[363]: 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 test1645second # [ 6.664322] systemd[1]: Finished Create Static Device Nodes in /dev.1646second # [ 6.669134] systemd[1]: Finished Coldplug All udev Devices.1647second # [ 6.670196] systemd[1]: Reached target Preparation for Local File Systems.1648test # [ 6.642167] systemd[1]: Finished Create Static Device Nodes in /dev.1649test # [ 6.643363] systemd[1]: Reached target Preparation for Local File Systems.1650second # [ 6.676116] systemd[1]: Starting Rule-based Manager for Device Events and Files...1651test # [ 6.650142] systemd[1]: Starting Rule-based Manager for Device Events and Files...1652second # [ 6.682731] systemd-resolved[344]: Using system hostname 'second'.1653test # [ 6.654485] systemd[1]: Finished Coldplug All udev Devices.1654second # [ 6.688359] systemd[1]: Started Network Name Resolution.1655test # [ 6.680348] systemd-resolved[363]: Using system hostname 'test'.1656second # [ 6.714913] systemd-udevd[361]: Using default interface naming scheme 'v261'.1657test # [ 6.683921] systemd[1]: Started Network Name Resolution.1658test # [ 6.700234] systemd-udevd[381]: Using default interface naming scheme 'v261'.1659second # [ 6.770122] systemd[1]: Started Rule-based Manager for Device Events and Files.1660test # [ 6.751084] systemd[1]: Started Rule-based Manager for Device Events and Files.1661second # [ 6.893550] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1662test # [ 6.873464] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1663second # [ 6.968827] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1664test # [ 6.941987] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1665second # [ 6.990085] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1666test # [ 6.969323] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1667second # [ 7.013604] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line.1668second # [ 7.016798] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line.1669test # [ 6.993043] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line.1670test # [ 6.997762] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line.1671second # [ 7.030610] systemd[1]: Mounting /run/wrappers...1672test # [ 7.029517] systemd[1]: Mounting /run/wrappers...1673second # [ 7.070144] systemd[1]: Mounted /run/wrappers.1674second # [ 7.071402] systemd[1]: Reached target Local File Systems.1675second # [ 7.074510] systemd[1]: Listening on Boot Loader Control Service Socket.1676second # [ 7.079439] systemd[1]: Starting register-nix-paths.service...1677second # [ 7.083249] systemd[1]: Starting Create SUID/SGID Wrappers...1678second # [ 7.084312] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1679second # [ 7.091355] systemd[1]: Starting Save Transient machine-id to Disk...1680test # [ 7.061130] systemd[1]: Mounted /run/wrappers.1681test # [ 7.063049] systemd[1]: Reached target Local File Systems.1682test # [ 7.066479] systemd[1]: Listening on Boot Loader Control Service Socket.1683second # [ 7.101099] systemd[1]: Starting Create System Files and Directories...1684test # [ 7.071430] systemd[1]: Starting register-nix-paths.service...1685test # [ 7.075988] systemd[1]: Starting Create SUID/SGID Wrappers...1686test # [ 7.077086] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1687test # [ 7.085236] systemd[1]: Starting Save Transient machine-id to Disk...1688test # [ 7.093274] systemd[1]: Starting Create System Files and Directories...1689second # [ 7.153233] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1690second # [ 7.162712] systemd[1]: Finished Save Transient machine-id to Disk.1691test # [ 7.151110] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1692test # [ 7.158307] systemd[1]: Finished Save Transient machine-id to Disk.1693second # [ 7.225479] systemd[1]: Finished Create System Files and Directories.1694second # [ 7.234474] systemd[1]: Starting Rebuild Journal Catalog...1695second # [ 7.240315] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1696test # [ 7.212496] systemd[1]: Finished Create System Files and Directories.1697test # [ 7.236284] systemd[1]: Starting Rebuild Journal Catalog...1698test # [ 7.249610] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1699second # [ 7.343180] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1700second # [ 7.354306] systemd[1]: Finished Rebuild Journal Catalog.1701second # [ 7.361515] systemd[1]: Starting Update is Completed...1702test # [ 7.337937] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1703test # [ 7.354115] systemd[1]: Finished Rebuild Journal Catalog.1704test # [ 7.360913] systemd[1]: Starting Update is Completed...1705second # [ 7.418232] systemd[1]: Finished Update is Completed.1706test # [ 7.413615] systemd[1]: Finished Update is Completed.1707test # [ 7.437241] systemd[1]: Finished Firewall.1708test # [ 7.442091] systemd[1]: Reached target Preparation for Network.1709test # [ 7.443251] systemd[1]: Listening on Network Management Resolve Hook Socket.1710second # [ 7.475735] systemd[1]: Finished Firewall.1711second # [ 7.476674] systemd[1]: Reached target Preparation for Network.1712test # [ 7.616548] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31713second # [ 7.479143] systemd[1]: Listening on Network Management Resolve Hook Socket.1714test # [ 7.449420] systemd[1]: Starting Network Management...1715second # [ 7.487586] systemd[1]: Starting Network Management...1716second # [ 7.663556] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31717second # [ 7.692207] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1718test # [ 7.720616] ACPI: button: Power Button [PWRF]1719test # [ 7.735243] mousedev: PS/2 mouse device common for all mice1720second # [ 7.620085] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1721test # [ 7.765400] rtc_cmos PNP0B00:00: RTC can wake from S41722second # [ 7.627080] systemd[1]: Finished Create SUID/SGID Wrappers.1723second # [ 7.745702] ACPI: button: Power Button [PWRF]1724second # [ 7.748447] mousedev: PS/2 mouse device common for all mice1725test # [ 7.820549] rtc_cmos PNP0B00:00: registered as rtc01726test # [ 7.827353] parport_pc 00:02: reported by Plug and Play ACPI1727test # [ 7.828374] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1728test # [ 7.833450] rtc_cmos PNP0B00:00: setting system clock to 2026-10-14T00:04:34 UTC (1791936274)1729test # [ 7.666466] systemd-resolved[363]: Clock change detected. Flushing caches.1730test # [ 7.856120] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1731second # [ 7.749078] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41732second # [ 7.836670] Console: switching to colour dummy device 80x251733second # [ 7.725164] systemd[1]: Finished register-nix-paths.service.1734test # [ 7.693940] systemd[1]: Finished register-nix-paths.service.1735second # [ 7.726289] systemd[1]: Reached target System Initialization.1736second # [ 7.729563] systemd[1]: Started Discard unused filesystem blocks once a week.1737second # [ 7.731253] systemd[1]: Started Daily Cleanup of Temporary Directories.1738test # [ 7.700987] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1739second # [ 7.733219] systemd[1]: Reached target Timer Units.1740test # [ 7.702451] systemd[1]: Finished Create SUID/SGID Wrappers.1741second # [ 7.735155] systemd[1]: Listening on D-Bus System Message Bus Socket.1742test # [ 7.705110] systemd[1]: Reached target System Initialization.1743second # [ 7.737263] systemd[1]: Listening on Nix Daemon Socket.1744test # [ 7.707530] systemd[1]: Started Discard unused filesystem blocks once a week.1745second # [ 7.742089] systemd[1]: Listening on Authorization Manager Agent Helper.1746test # [ 7.711156] systemd[1]: Started Daily Cleanup of Temporary Directories.1747second # [ 7.743305] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1748test # [ 7.712360] systemd[1]: Reached target Timer Units.1749second # [ 7.744777] systemd[1]: Reached target Socket Units.1750test # [ 7.713377] systemd[1]: Listening on D-Bus System Message Bus Socket.1751test # [ 7.714735] systemd[1]: Listening on Nix Daemon Socket.1752second # [ 7.748646] systemd[1]: Starting D-Bus System Message Bus...1753test # [ 7.721140] systemd[1]: Listening on Authorization Manager Agent Helper.1754second # [ 7.752843] systemd-resolved[344]: Clock change detected. Flushing caches.1755test # [ 7.722407] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1756test # [ 7.723925] systemd[1]: Reached target Socket Units.1757test # [ 7.727971] systemd[1]: Starting D-Bus System Message Bus...1758second # [ 7.893794] rtc_cmos PNP0B00:00: RTC can wake from S41759second # [ 7.898456] cfg80211: Loading compiled-in X.509 certificates for regulatory database1760second # [ 7.922676] rtc_cmos PNP0B00:00: registered as rtc01761second # [ 7.922775] rtc_cmos PNP0B00:00: setting system clock to 2026-10-14T00:04:34 UTC (1791936274)1762second # [ 7.799603] systemd-networkd[524]: /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.1763test # [ 7.770474] systemd-networkd[535]: /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.1764second # [ 7.804487] systemd-networkd[524]: /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.1765second # [ 7.808738] systemd-networkd[524]: lo: Link UP1766test # [ 7.775685] systemd-networkd[535]: /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.1767second # [ 7.810182] systemd-networkd[524]: lo: Gained carrier1768test # [ 7.779242] systemd-networkd[535]: lo: Link UP1769test # [ 7.780162] systemd-networkd[535]: lo: Gained carrier1770second # [ 7.814856] systemd[1]: Started Network Management.1771test # [ 7.787837] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1772second # [ 7.819624] systemd-networkd[524]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1773test # [ 7.790352] systemd-networkd[535]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1774second # [ 7.823125] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1775test # [ 7.792394] systemd[1]: Started Network Management.1776second # [ 7.825351] systemd-networkd[524]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1777second # [ 7.829443] systemd-networkd[524]: eth1: Link UP1778test # [ 7.798154] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1779second # [ 7.922866] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1780second # [ 7.925636] parport_pc 00:02: reported by Plug and Play ACPI1781test # [ 7.801893] systemd-networkd[535]: eth1: Link UP1782second # [ 7.834105] systemd-networkd[524]: eth1: Gained carrier1783test # [ 7.802805] systemd-networkd[535]: eth1: Gained carrier1784second # [ 7.835136] systemd-networkd[524]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1785test # [ 7.804701] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1786second # [ 7.848199] dbus-broker-launch[543]: Looking up NSS user entry for 'systemd-timesync'...1787second # [ 7.856405] dbus-broker-launch[543]: NSS returned no entry for 'systemd-timesync'1788second # [ 7.858183] dbus-broker-launch[543]: Invalid user-name in /nix/store/1vz5dwzzyiqqxzz1f60ycc8r3nwc5inv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1789test # [ 7.839537] dbus-broker-launch[564]: Looking up NSS user entry for 'systemd-timesync'...1790test # [ 7.842808] dbus-broker-launch[564]: NSS returned no entry for 'systemd-timesync'1791second # [ 7.876282] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1792test # [ 7.844378] dbus-broker-launch[564]: Invalid user-name in /nix/store/1vz5dwzzyiqqxzz1f60ycc8r3nwc5inv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1793second # [ 7.925728] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1794test # [ 7.850366] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1795second # [ 7.929688] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1796second # [ 7.949763] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1797second # [ 7.895542] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/vxlcffmhw7wsis0ib871ppnb88l437is-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1798test # [ 7.859752] cfg80211: Loading compiled-in X.509 certificates for regulatory database1799second # [ 7.899106] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/vxlcffmhw7wsis0ib871ppnb88l437is-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1800second # [ 7.903205] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/4vj8rc4mpy3mjsnp8aajf0gycr1hfmlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1801test # [ 7.869076] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1802test # [ 7.899023] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41803second # [ 7.907775] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/d527hwwggm2wz18p4v8cr39amcpx3g4c-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1804second # [ 7.912070] systemd[1]: Started D-Bus System Message Bus.1805second # [ 7.913448] systemd[1]: Reached target Basic System.1806test # [ 7.886720] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/vxlcffmhw7wsis0ib871ppnb88l437is-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1807second # [ 7.920466] systemd[1]: Starting Network Manager Script Dispatcher Service...1808test # [ 7.890136] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/vxlcffmhw7wsis0ib871ppnb88l437is-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1809second # [ 7.949897] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1810second # [ 7.927066] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1811test # [ 7.893834] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/4vj8rc4mpy3mjsnp8aajf0gycr1hfmlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1812test # [ 7.897747] dbus-broker-launch[564]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/d527hwwggm2wz18p4v8cr39amcpx3g4c-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1813test # [ 7.902249] systemd[1]: Started D-Bus System Message Bus.1814test # [ 7.905606] systemd[1]: Reached target Basic System.1815second # [ 7.938954] systemd[1]: Starting Network Manager...1816test # [ 7.908885] systemd[1]: Starting Network Manager Script Dispatcher Service...1817second # [ 7.943528] dbus-broker-launch[543]: Ready1818test # [ 7.911866] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1819second # [ 7.949644] systemd[1]: Started backdoor.service.1820test # [ 7.926169] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1821test # [ 7.913399] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1822test # [ 7.913487] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1823second # [ 8.024961] NET: Registered PF_PACKET protocol family1824second # [ 8.089568] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1825second # [ 7.965754] systemd[1]: Starting Import lastlog data into lastlog2 database...1826test # [ 7.938249] dbus-broker-launch[564]: Ready1827test # [ 7.944832] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1828second # [ 7.987726] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1829test # [ 7.934454] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1830test # [ 7.996586] NET: Registered PF_PACKET protocol family1831test # [ 8.038090] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1832second # [ 7.995177] systemd[1]: Starting Post-Boot Actions...1833test # [ 7.965204] systemd[1]: Starting Network Manager...1834test # [ 7.973297] systemd[1]: Started backdoor.service.1835second # [ 8.089675] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1836test # [ 7.981635] systemd[1]: Starting Import lastlog data into lastlog2 database...1837second # [ 8.184154] [drm] Found bochs VGA, ID 0xb0c5.1838second # [ 8.184156] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1839second # [ 8.020294] systemd[1]: Started Reset console on configuration changes.1840second # [ 8.208829] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61841second # [ 8.041299] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[555]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1842second # [ 8.216096] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51843test # [ 8.015400] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1844test # [ 8.038235] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1845test # [ 8.040492] Console: switching to colour dummy device 80x251846test # [ 8.133391] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61847test # [ 8.025579] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[575]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1848test # [ 8.027663] 2fzr21av002hkddm9grsnsbb2wa3c1bn-wifi-secrets[576]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1849test # [ 8.033315] bjn7ymirp1h8ai1aki9b9jfc6bwb1c5s-wifi-secrets[577]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1850second # [ 8.236785] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1851second # [ 8.237635] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01852test # [ 8.048433] systemd[1]: Starting Post-Boot Actions...1853second # [ 8.080168] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1854second # connecting to host...1855test # [ 8.061619] systemd[1]: Started Reset console on configuration changes.1856second # [ 8.099831] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1857test # [ 8.088351] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1858second # [ 8.128484] systemd[1]: Finished Post-Boot Actions.1859test # [ 8.101862] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1860test # [ 8.103198] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1861test # [ 8.114234] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1862second # [ 8.146797] systemd[1]: Started Network Manager Script Dispatcher Service.1863second # [ 8.148584] nsncd[560]: Oct 14 00:04:34.895 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1864second # [ 8.152700] systemd[1]: Started Name Service Cache Daemon (nsncd).1865test # [ 8.125185] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1866second # [ 8.158522] systemd[1]: Reached target Host and Network Name Lookups.1867second # [ 8.159668] systemd[1]: Reached target User and Group Name Lookups.1868test # [ 8.129944] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1869test # connecting to host...1870second # [ 8.167735] systemd[1]: Starting User Login Management...1871second # [ 8.177969] systemd[1]: Finished Import lastlog data into lastlog2 database.1872test # [ 8.156855] nsncd[581]: Oct 14 00:04:34.993 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1873test: Guest shell says: b'Spawning backdoor root shell...\n'1874second # [ 8.206252] systemd[1]: Starting Hostname Service...1875test: connected to guest root shell1876test # [ 8.174354] systemd[1]: Started Name Service Cache Daemon (nsncd).1877test: (connecting took 8.86 seconds)1878test # [ 8.133678] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51879test: (finished: waiting for the VM to finish booting, in 8.86 seconds)1880test # [ 8.350390] [drm] Found bochs VGA, ID 0xb0c5.1881test # [ 8.350391] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1882test # [ 8.182067] systemd[1]: Finished Post-Boot Actions.1883test # [ 8.216428] systemd[1]: Started Network Manager Script Dispatcher Service.1884test # [ 8.226162] systemd[1]: Finished Import lastlog data into lastlog2 database.1885test # [ 8.398683] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1886test # [ 8.399562] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01887test # [ 8.234181] systemd[1]: Reached target Host and Network Name Lookups.1888test # [ 8.235711] systemd[1]: Reached target User and Group Name Lookups.1889test # [ 8.248295] systemd[1]: Starting User Login Management...1890test # [ 8.252113] systemd[1]: Starting Virtual Console Setup...1891test # [ 8.299733] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1892test # [ 8.311099] systemd[1]: Starting Hostname Service...1893second # [ 8.484114] Console: switching to colour frame buffer device 160x501894second # [ 8.533746] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1895second # [ 8.278148] systemd[1]: Starting Virtual Console Setup...1896second # [ 8.365483] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1897second # [ 8.366833] systemd[1]: Stopped Virtual Console Setup.1898second # [ 8.372230] systemd[1]: Started Hostname Service.1899second # [ 8.373366] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1900second # [ 8.376978] systemd[1]: Starting Virtual Console Setup...1901second # [ 8.380311] systemd-logind[595]: New seat seat0.1902second # [ 8.381290] systemd[1]: Started User Login Management.1903second # [ 8.382216] systemd-logind[595]: Watching system buttons on /dev/input/event2 (Power Button)1904second # [ 8.387229] systemd-logind[595]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1905second # [ 8.388814] systemd-logind[595]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1906second # [ 8.390218] systemd[1]: Starting linger-users.service...1907test # [ 8.368827] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1908test # [ 8.371837] systemd-logind[631]: Watching system buttons on /dev/input/event2 (Power Button)1909test # [ 8.377823] systemd-logind[631]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1910test # [ 8.380362] systemd[1]: Stopped Virtual Console Setup.1911test # [ 8.381319] systemd-logind[631]: New seat seat0.1912test # [ 8.386182] systemd[1]: Started User Login Management.1913test # [ 8.393120] systemd[1]: Starting linger-users.service...1914test # [ 8.402072] systemd[1]: Starting Virtual Console Setup...1915second # [ 8.434677] systemd[1]: linger-users.service: Deactivated successfully.1916second # [ 8.441330] systemd[1]: Finished linger-users.service.1917second # [ 8.442432] systemd-networkd[524]: eth0: Link UP1918second # [ 8.443313] systemd-networkd[524]: eth0: Gained carrier1919second # [ 8.467511] systemd[1]: Started Network Manager.1920second # [ 8.471202] systemd[1]: Reached target Network.1921second # [ 8.475454] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1922second # [ 8.482811] systemd[1]: Starting Permit User Sessions...1923second # [ 8.708472] ppdev: user-space parallel port driver1924second # [ 8.539054] systemd[1]: Finished Permit User Sessions.1925test # [ 8.593319] ppdev: user-space parallel port driver1926second # [ 8.549844] systemd[1]: Started Getty on tty1.1927second # [ 8.555219] systemd[1]: Reached target Login Prompts.1928test # [ 8.671688] Console: switching to colour frame buffer device 160x501929test # [ 8.708027] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1930test # [ 8.444371] systemd[1]: Started Hostname Service.1931test # [ 8.538931] systemd[1]: linger-users.service: Deactivated successfully.1932test # [ 8.540165] systemd[1]: Finished linger-users.service.1933test # [ 8.541319] systemd-logind[631]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1934test # [ 8.544687] systemd-networkd[535]: eth0: Link UP1935test # [ 8.545587] systemd-networkd[535]: eth0: Gained carrier1936test # [ 8.547449] systemd[1]: Started Network Manager.1937test # [ 8.549244] systemd[1]: Reached target Network.1938test # [ 8.554350] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1939test # [ 8.555728] systemd[1]: Starting Permit User Sessions...1940test # [ 8.739293] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1941second # [ 8.799588] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1942test # [ 8.604906] systemd[1]: Finished Permit User Sessions.1943second # [ 8.641329] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1944second # [ 8.644801] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1945second # [ 8.656655] systemd[1]: Reached target Multi-User System.1946test # [ 8.810851] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1947second # [ 8.674086] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1948second # [ 8.675939] systemd[1]: Stopped Virtual Console Setup.1949test # [ 8.645484] systemd[1]: Started Getty on tty1.1950test # [ 8.650251] systemd[1]: Reached target Login Prompts.1951second # [ 8.686355] systemd[1]: Starting Virtual Console Setup...1952second # [ 8.858496] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1953second # [ 8.704247] systemd-resolved[344]: eth0: Bus client set default route setting: yes1954second # [ 8.705663] systemd-resolved[344]: eth0: Bus client set DNS server list to: 10.0.2.31955test # [ 8.737123] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1956test # [ 8.738527] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1957test # [ 8.747509] systemd[1]: Reached target Multi-User System.1958test # [ 8.754112] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1959test # [ 8.756847] systemd[1]: Stopped Virtual Console Setup.1960second # [ 8.964713] kvm_amd: TSC scaling supported1961second # [ 8.965212] kvm_amd: Nested Virtualization enabled1962second # [ 8.966333] kvm_amd: Nested Paging enabled1963second # [ 8.967097] kvm_amd: LBR virtualization supported1964second # [ 8.968008] kvm_amd: Virtual GIF supported1965second # [ 8.968749] kvm_amd: Virtual NMI enabled1966test # [ 8.771612] systemd[1]: Starting Virtual Console Setup...1967test # [ 8.784342] systemd-resolved[363]: eth0: Bus client set default route setting: yes1968test # [ 8.787338] systemd-resolved[363]: eth0: Bus client set DNS server list to: 10.0.2.31969second # [ 9.006888] EDAC MC: Ver: 3.0.01970test # [ 8.986311] kvm_amd: TSC scaling supported1971test # [ 8.986802] kvm_amd: Nested Virtualization enabled1972test # [ 8.988870] kvm_amd: Nested Paging enabled1973test # [ 8.990961] kvm_amd: LBR virtualization supported1974test # [ 8.992321] kvm_amd: Virtual GIF supported1975test # [ 8.992797] kvm_amd: Virtual NMI enabled1976second # [ 8.877073] systemd-vconsole-setup[640]: Configuration of first virtual console was skipped, ignoring remaining ones.1977second # [ 8.880886] systemd[1]: Finished Virtual Console Setup.1978second # [ 8.884420] systemd[1]: Startup finished in 789ms (kernel) + 4.343s (initrd) + 3.751s (userspace) = 8.884s.1979test # [ 9.032251] EDAC MC: Ver: 3.0.01980test # [ 8.912194] systemd-vconsole-setup[681]: Configuration of first virtual console was skipped, ignoring remaining ones.1981test # [ 8.915727] systemd[1]: Finished Virtual Console Setup.1982test # [ 8.919459] systemd[1]: Startup finished in 784ms (kernel) + 4.359s (initrd) + 3.774s (userspace) = 8.919s.1983second # [ 8.972884] systemd-networkd[524]: eth1: Gained IPv6LL1984test # [ 9.161594] systemd-networkd[535]: eth1: Gained IPv6LL1985test: (finished: waiting for unit NetworkManager.service, in 10.00 seconds)1986test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1987test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1988test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1989test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1990test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1991test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1992(finished: run the VM test script, in 10.11 seconds)1993test script finished in 10.12s1994cleanup1995kill QemuMachine (pid 47)1996second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)1997second # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down1998second # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down1999second # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down2000kill QemuMachine (pid 48)2001test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)2002test # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down2003test # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down2004test # [2026-10-14T00:04:36Z INFO virtiofsd] Client disconnected, shutting down2005(finished: cleanup, in 0.28 seconds)