vm-test-run-wifi
checks.x86_64-linux.wifi
· build #232
· raw
1gi-build-x86-02: building 2azmpm41k10fl74c137ydl0qxlj40dgz-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 # Formatting '/build/vm-state-test/tmp.2bBJ8ScK9r', fmt=raw size=107374182416test # mke2fs 1.47.4 (6-Mar-2025)17test # Discarding device blocks: 0/262144 done18test # Creating filesystem with 262144 4k blocks and 65536 inodes19test # Filesystem UUID: edcc8fbb-44e5-4a4a-8f28-86588b580e9820test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29test # Starting virtiofs daemons...30test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34test # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...35test # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...36test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37test # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether38test # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...39test # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests40test # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests41test # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests42test: QEMU running (pid 48)43second # Disk image does not exist, creating the virtualisation disk image...44second # Formatting '/build/vm-state-second/tmp.A2eXKO9Q3b', fmt=raw size=107374182445second # mke2fs 1.47.4 (6-Mar-2025)46second # Discarding device blocks: 0/262144 done47second # Creating filesystem with 262144 4k blocks and 65536 inodes48second # Filesystem UUID: ba96a6b4-f834-4b12-8396-2550faf150ab49second # Superblock backups stored on blocks:50second # 32768, 98304, 163840, 22937651second # 52second # Allocating group tables: 0/8 done53second # Writing inode tables: 0/8 done54second # Creating journal (8192 blocks): done55second # Writing superblocks and filesystem accounting information: 0/8 done56second # 57second # Virtualisation disk image created.58second # Starting virtiofs daemons...59second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)60second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether61second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)62second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether63second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)64second # [2026-10-06T00:09:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether65second # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...66second # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...67second # [2026-10-06T00:09:31Z INFO virtiofsd] Waiting for vhost-user socket connection...68second # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests69second # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests70second # [2026-10-06T00:09:31Z INFO virtiofsd] Client connected, servicing requests71second: QEMU running (pid 47)72(finished: start all VMs, in 0.73 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)77second # 78second # 79test # 80test # 81second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0082test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0083second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...84second # 85second # 86second # 87second # 88test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...89test # 90test # 91test # 92test # 93second # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0094test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0095test # Press Ctrl-B to configure iPXE (PCI 00:05.0)...96test # 97test # 98second # Press Ctrl-B to configure iPXE (PCI 00:05.0)...99second # 100second # 101test # Booting from ROM...102second # 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 2026104test # 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 2026105second # [ 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/0l1qpij3z4s5isdrdf49vcs4j4lr9zf4-nixos-system-second-test/init regInfo=/nix/.ro-store/4jjypkkba961iv1haf7vysq8jwczd6h4-closure-info/registration console=ttyS0,115200n8 console=tty0106test # [ 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/waww6jdj07q1nj13pp56h32sb9rb3834-nixos-system-test-test/init regInfo=/nix/.ro-store/pxq40fc0anjnlc7b1jsv9y25r91jmac1-closure-info/registration console=ttyS0,115200n8 console=tty0107second # [ 0.000000] BIOS-provided physical RAM map:108test # [ 0.000000] BIOS-provided physical RAM map:109second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable110test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable111second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved112test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved113second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved114test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved115second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable116test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable117second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved118test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved119second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved120test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved121second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved122test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved123second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved124test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved125second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved126test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved127second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved128test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved129second # [ 0.000000] NX (Execute Disable) protection: active130test # [ 0.000000] NX (Execute Disable) protection: active131second # [ 0.000000] APIC: Static calls initialized132test # [ 0.000000] APIC: Static calls initialized133second # [ 0.000000] SMBIOS 2.8 present.134test # [ 0.000000] SMBIOS 2.8 present.135second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014136test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014137second # [ 0.000000] DMI: Memory slots populated: 1/1138test # [ 0.000000] DMI: Memory slots populated: 1/1139second # [ 0.000000] Hypervisor detected: KVM140test # [ 0.000000] Hypervisor detected: KVM141second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000142test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000143second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00144test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00145second # [ 0.000000] kvm-clock: using sched offset of 397723550 cycles146test # [ 0.000000] kvm-clock: using sched offset of 398021681 cycles147second # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns148test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns149second # [ 0.000005] tsc: Detected 4192.088 MHz processor150test # [ 0.000004] tsc: Detected 4192.088 MHz processor151second # [ 0.000573] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000152test # [ 0.000572] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000153second # [ 0.000602] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs154test # [ 0.000601] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs155second # [ 0.000604] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT156test # [ 0.000604] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT157second # [ 0.002291] found SMP MP-table at [mem 0x000f5450-0x000f545f]158test # [ 0.002273] found SMP MP-table at [mem 0x000f5450-0x000f545f]159second # [ 0.002306] Using GB pages for direct mapping160test # [ 0.002287] Using GB pages for direct mapping161second # [ 0.002379] RAMDISK: [mem 0x3e2e6000-0x3ffcffff]162test # [ 0.002344] RAMDISK: [mem 0x3e2e6000-0x3ffcffff]163second # [ 0.002384] ACPI: Early table checksum verification disabled164test # [ 0.002349] ACPI: Early table checksum verification disabled165second # [ 0.002387] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )166test # [ 0.002352] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )167second # [ 0.002390] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)168test # [ 0.002355] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)169second # [ 0.002394] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)170test # [ 0.002358] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)171second # [ 0.002398] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)172test # [ 0.002364] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)173second # [ 0.002400] ACPI: FACS 0x000000003FFE0000 000040174test # [ 0.002365] ACPI: FACS 0x000000003FFE0000 000040175second # [ 0.002401] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)176test # [ 0.002367] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)177second # [ 0.002403] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)178test # [ 0.002368] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)179second # [ 0.002404] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)180test # [ 0.002369] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)181second # [ 0.002405] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)182test # [ 0.002371] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)183second # [ 0.002406] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]184test # [ 0.002372] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]185second # [ 0.002407] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]186test # [ 0.002372] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]187second # [ 0.002407] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]188test # [ 0.002373] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]189second # [ 0.002408] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]190test # [ 0.002373] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]191second # [ 0.002408] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]192test # [ 0.002374] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]193second # [ 0.002409] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]194test # [ 0.002374] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]195second # [ 0.002409] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]196test # [ 0.002374] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]197second # [ 0.002763] No NUMA configuration found198test # [ 0.002725] No NUMA configuration found199second # [ 0.002764] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]200test # [ 0.002726] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]201second # [ 0.002767] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]202test # [ 0.002729] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]203second # [ 0.002836] Zone ranges:204test # [ 0.002797] Zone ranges:205second # [ 0.002836] DMA [mem 0x0000000000001000-0x0000000000ffffff]206test # [ 0.002797] DMA [mem 0x0000000000001000-0x0000000000ffffff]207second # [ 0.002837] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]208test # [ 0.002798] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]209second # [ 0.002838] Normal empty210test # [ 0.002799] Normal empty211second # [ 0.002839] Device empty212test # [ 0.002800] Device empty213second # [ 0.002839] Movable zone start for each node214test # [ 0.002800] Movable zone start for each node215second # [ 0.002840] Early memory node ranges216test # [ 0.002801] Early memory node ranges217second # [ 0.002840] node 0: [mem 0x0000000000001000-0x000000000009efff]218test # [ 0.002801] node 0: [mem 0x0000000000001000-0x000000000009efff]219second # [ 0.002841] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]220test # [ 0.002802] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]221second # [ 0.002842] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]222test # [ 0.002803] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]223second # [ 0.002857] On node 0, zone DMA: 1 pages in unavailable ranges224test # [ 0.002819] On node 0, zone DMA: 1 pages in unavailable ranges225second # [ 0.003042] On node 0, zone DMA: 97 pages in unavailable ranges226test # [ 0.003003] On node 0, zone DMA: 97 pages in unavailable ranges227second # [ 0.015447] On node 0, zone DMA32: 40 pages in unavailable ranges228test # [ 0.015470] On node 0, zone DMA32: 40 pages in unavailable ranges229second # [ 0.016255] ACPI: PM-Timer IO Port: 0x608230test # [ 0.016280] ACPI: PM-Timer IO Port: 0x608231second # [ 0.016268] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])232test # [ 0.016293] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])233second # [ 0.016290] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23234test # [ 0.016316] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23235second # [ 0.016292] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)236test # [ 0.016318] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)237second # [ 0.016293] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)238test # [ 0.016320] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)239second # [ 0.016294] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)240test # [ 0.016321] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)241second # [ 0.016295] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)242test # [ 0.016321] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)243second # [ 0.016295] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)244test # [ 0.016322] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)245second # [ 0.016297] ACPI: Using ACPI (MADT) for SMP configuration information246test # [ 0.016324] ACPI: Using ACPI (MADT) for SMP configuration information247second # [ 0.016298] ACPI: HPET id: 0x8086a201 base: 0xfed00000248test # [ 0.016325] ACPI: HPET id: 0x8086a201 base: 0xfed00000249second # [ 0.016304] TSC deadline timer available250test # [ 0.016329] TSC deadline timer available251second # [ 0.016307] CPU topo: Max. logical packages: 1252test # [ 0.016333] CPU topo: Max. logical packages: 1253second # [ 0.016308] CPU topo: Max. logical dies: 1254test # [ 0.016333] CPU topo: Max. logical dies: 1255second # [ 0.016308] CPU topo: Max. dies per package: 1256test # [ 0.016334] CPU topo: Max. dies per package: 1257second # [ 0.016311] CPU topo: Max. threads per core: 1258test # [ 0.016337] CPU topo: Max. threads per core: 1259second # [ 0.016311] CPU topo: Num. cores per package: 1260test # [ 0.016337] CPU topo: Num. cores per package: 1261second # [ 0.016312] CPU topo: Num. threads per package: 1262test # [ 0.016337] CPU topo: Num. threads per package: 1263second # [ 0.016312] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs264test # [ 0.016338] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs265second # [ 0.016329] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()266test # [ 0.016354] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()267second # [ 0.016358] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]268test # [ 0.016385] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]269second # [ 0.016360] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]270test # [ 0.016386] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]271second # [ 0.016361] [mem 0x40000000-0xafffffff] available for PCI devices272test # [ 0.016388] [mem 0x40000000-0xafffffff] available for PCI devices273second # [ 0.016362] Booting paravirtualized kernel on KVM274test # [ 0.016389] Booting paravirtualized kernel on KVM275second # [ 0.016366] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns276test # [ 0.016392] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns277second # [ 0.019866] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1278test # [ 0.019852] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1279second # [ 0.021432] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152280test # [ 0.021426] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152281second # [ 0.021462] kvm-guest: PV spinlocks disabled, single CPU282test # [ 0.021459] kvm-guest: PV spinlocks disabled, single CPU283second # [ 0.021464] 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/0l1qpij3z4s5isdrdf49vcs4j4lr9zf4-nixos-system-second-test/init regInfo=/nix/.ro-store/4jjypkkba961iv1haf7vysq8jwczd6h4-closure-info/registration console=ttyS0,115200n8 console=tty0284test # [ 0.021461] 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/waww6jdj07q1nj13pp56h32sb9rb3834-nixos-system-test-test/init regInfo=/nix/.ro-store/pxq40fc0anjnlc7b1jsv9y25r91jmac1-closure-info/registration console=ttyS0,115200n8 console=tty0285second # [ 0.021535] Unknown kernel command line parameters "regInfo=/nix/.ro-store/4jjypkkba961iv1haf7vysq8jwczd6h4-closure-info/registration", will be passed to user space.286second # [ 0.021832] random: crng init done287test # [ 0.021530] Unknown kernel command line parameters "regInfo=/nix/.ro-store/pxq40fc0anjnlc7b1jsv9y25r91jmac1-closure-info/registration", will be passed to user space.288test # [ 0.021819] random: crng init done289second # [ 0.021832] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes290test # [ 0.021820] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes291second # [ 0.022485] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)292test # [ 0.021837] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)293second # [ 0.022500] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)294second # [ 0.022523] Fallback order for Node 0: 0295test # [ 0.022232] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)296test # [ 0.022259] Fallback order for Node 0: 0297second # [ 0.022525] Built 1 zonelists, mobility grouping on. Total pages: 262006298second # [ 0.022526] Policy zone: DMA32299test # [ 0.022262] Built 1 zonelists, mobility grouping on. Total pages: 262006300test # [ 0.022263] Policy zone: DMA32301second # [ 0.024082] mem auto-init: stack:all(zero), heap alloc:on, heap free:off302test # [ 0.024035] mem auto-init: stack:all(zero), heap alloc:on, heap free:off303second # [ 0.026636] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1304test # [ 0.026691] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1305second # [ 0.028322] allocated 2097152 bytes of page_ext306test # [ 0.028310] allocated 2097152 bytes of page_ext307second # [ 0.036971] ftrace: allocating 48837 entries in 192 pages308test # [ 0.036946] ftrace: allocating 48837 entries in 192 pages309second # [ 0.036972] ftrace: allocated 192 pages with 2 groups310second # [ 0.037646] Dynamic Preempt: lazy311test # [ 0.036948] ftrace: allocated 192 pages with 2 groups312test # [ 0.037629] Dynamic Preempt: lazy313second # [ 0.037768] rcu: Preemptible hierarchical RCU implementation.314second # [ 0.037768] rcu: RCU event tracing is enabled.315test # [ 0.037757] rcu: Preemptible hierarchical RCU implementation.316test # [ 0.037758] rcu: RCU event tracing is enabled.317second # [ 0.037769] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.318test # [ 0.037758] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.319second # [ 0.037770] Trampoline variant of Tasks RCU enabled.320second # [ 0.037770] Rude variant of Tasks RCU enabled.321test # [ 0.037759] Trampoline variant of Tasks RCU enabled.322second # [ 0.037770] Tracing variant of Tasks RCU enabled.323test # [ 0.037760] Rude variant of Tasks RCU enabled.324test # [ 0.037760] Tracing variant of Tasks RCU enabled.325second # [ 0.037771] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.326test # [ 0.037761] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.327second # [ 0.037771] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1328test # [ 0.037761] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1329second # [ 0.037788] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.330test # [ 0.037773] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.331second # [ 0.037789] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.332test # [ 0.037775] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.333second # [ 0.037790] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.334test # [ 0.037775] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.335second # [ 0.040978] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16336test # [ 0.040987] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16337second # [ 0.041216] rcu: srcu_init: Setting srcu_struct sizes based on contention.338test # [ 0.041232] rcu: srcu_init: Setting srcu_struct sizes based on contention.339second # [ 0.041221] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns340test # [ 0.041238] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns341second # [ 0.041381] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)342second # [ 0.046659] Console: colour VGA+ 80x25343test # [ 0.041397] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)344second # [ 0.046662] printk: legacy console [tty0] enabled345test # [ 0.046694] Console: colour VGA+ 80x25346second # [ 0.077644] printk: legacy console [ttyS0] enabled347test # [ 0.046697] printk: legacy console [tty0] enabled348second # [ 0.213583] ACPI: Core revision 20250807349test # [ 0.077769] printk: legacy console [ttyS0] enabled350test # [ 0.214658] ACPI: Core revision 20250807351second # [ 0.214667] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns352test # [ 0.215719] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns353second # [ 0.216637] APIC: Switch to symmetric I/O mode setup354second # [ 0.217878] x2apic enabled355test # [ 0.217687] APIC: Switch to symmetric I/O mode setup356test # [ 0.218923] x2apic enabled357second # [ 0.218704] APIC: Switched APIC routing to: physical x2apic358test # [ 0.219771] APIC: Switched APIC routing to: physical x2apic359second # [ 0.220702] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1360test # [ 0.221784] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1361second # [ 0.221954] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns362test # [ 0.223053] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns363second # [ 0.224064] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)364test # [ 0.225183] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)365second # [ 0.225150] x86/cpu: User Mode Instruction Prevention (UMIP) activated366test # [ 0.226271] x86/cpu: User Mode Instruction Prevention (UMIP) activated367second # [ 0.226173] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127368test # [ 0.227304] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127369second # [ 0.227063] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0370test # [ 0.229181] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0371second # [ 0.229066] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto372test # [ 0.230185] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto373second # [ 0.230063] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl374test # [ 0.231182] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl375second # [ 0.231063] Spectre V2 : Mitigation: Enhanced / Automatic IBRS376test # [ 0.232182] Spectre V2 : Mitigation: Enhanced / Automatic IBRS377second # [ 0.232063] Speculative Return Stack Overflow: Mitigation: Safe RET378test # [ 0.233181] Speculative Return Stack Overflow: Mitigation: Safe RET379second # [ 0.233062] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization380test # [ 0.234181] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization381second # [ 0.234069] Spectre V2 : Enabling IBPB for BPF382test # [ 0.236189] Spectre V2 : Enabling IBPB for BPF383second # [ 0.236064] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier384second # [ 0.237063] active return thunk: srso_alias_return_thunk385test # [ 0.238183] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier386test # [ 0.239182] active return thunk: srso_alias_return_thunk387second # [ 0.238957] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'388test # [ 0.240204] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'389second # [ 0.240062] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'390second # [ 0.241062] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'391test # [ 0.241181] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'392test # [ 0.242181] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'393second # [ 0.242062] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'394second # [ 0.243062] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'395test # [ 0.243181] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'396test # [ 0.244181] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'397second # [ 0.244062] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'398test # [ 0.245181] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'399second # [ 0.245062] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'400test # [ 0.247182] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'401second # [ 0.247062] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'402test # [ 0.248181] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'403second # [ 0.248062] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'404second # [ 0.249063] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256405test # [ 0.250181] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'406second # [ 0.251062] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64407test # [ 0.251182] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256408second # [ 0.252062] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512409test # [ 0.252181] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64410second # [ 0.253062] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024411test # [ 0.253181] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512412second # [ 0.254062] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8413test # [ 0.254181] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024414second # [ 0.256062] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16415test # [ 0.256181] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8416second # [ 0.257062] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24417test # [ 0.257181] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16418test # [ 0.258181] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24419second # [ 0.258062] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.420test # [ 0.259181] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.421second # [ 0.284238] Freeing SMP alternatives memory: 48K422second # [ 0.285064] pid_max: default: 32768 minimum: 301423test # [ 0.286910] Freeing SMP alternatives memory: 48K424second # [ 0.286119] LSM: initializing lsm=capability,landlock,yama,bpf,ima425test # [ 0.287184] pid_max: default: 32768 minimum: 301426second # [ 0.287151] landlock: Up and running.427test # [ 0.288242] LSM: initializing lsm=capability,landlock,yama,bpf,ima428second # [ 0.288063] Yama: becoming mindful.429test # [ 0.290258] landlock: Up and running.430second # [ 0.289237] LSM support for eBPF active431test # [ 0.291043] Yama: becoming mindful.432second # [ 0.290128] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)433test # [ 0.291934] LSM support for eBPF active434second # [ 0.291080] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)435test # [ 0.292902] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)436test # [ 0.294201] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)437second # [ 0.293777] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)438second # [ 0.294421] Performance Events: Fam17h+ core perfctr, AMD PMU driver.439test # [ 0.296905] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)440second # [ 0.295066] ... version: 2441test # [ 0.297579] Performance Events: Fam17h+ core perfctr, AMD PMU driver.442second # [ 0.295972] ... bit width: 48443test # [ 0.298186] ... version: 2444second # [ 0.296781] ... generic counters: 6445test # [ 0.299100] ... bit width: 48446second # [ 0.297101] ... generic bitmap: 000000000000003f447test # [ 0.299906] ... generic counters: 6448second # [ 0.298064] ... fixed-purpose counters: 0449test # [ 0.300224] ... generic bitmap: 000000000000003f450second # [ 0.298971] ... fixed-purpose bitmap: 0000000000000000451test # [ 0.301182] ... fixed-purpose counters: 0452second # [ 0.299974] ... value mask: 0000ffffffffffff453test # [ 0.302092] ... fixed-purpose bitmap: 0000000000000000454second # [ 0.300973] ... max period: 00007fffffffffff455test # [ 0.303092] ... value mask: 0000ffffffffffff456second # [ 0.301971] ... global_ctrl mask: 000000000000003f457test # [ 0.304099] ... max period: 00007fffffffffff458second # [ 0.303051] signal: max sigframe size: 3376459test # [ 0.305102] ... global_ctrl mask: 000000000000003f460second # [ 0.303814] rcu: Hierarchical SRCU implementation.461test # [ 0.306185] signal: max sigframe size: 3376462second # [ 0.304067] rcu: Max phase no-delay instances is 400.463test # [ 0.307140] rcu: Hierarchical SRCU implementation.464test # [ 0.307965] rcu: Max phase no-delay instances is 400.465second # [ 0.308124] smp: Bringing up secondary CPUs ...466second # [ 0.309076] smp: Brought up 1 node, 1 CPU467test # [ 0.312106] smp: Bringing up secondary CPUs ...468second # [ 0.309929] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)469test # [ 0.312943] smp: Brought up 1 node, 1 CPU470test # [ 0.313185] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)471second # [ 0.311226] Memory: 942480K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 98108K reserved, 0K cma-reserved)472second # [ 0.312267] devtmpfs: initialized473test # [ 0.314321] Memory: 942500K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 98108K reserved, 0K cma-reserved)474second # [ 0.313119] x86/mm: Memory block size: 128MB475test # [ 0.315372] devtmpfs: initialized476test # [ 0.316295] x86/mm: Memory block size: 128MB477second # [ 0.314727] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)478second # [ 0.315090] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).479test # [ 0.317908] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)480second # [ 0.316131] pinctrl core: initialized pinctrl subsystem481test # [ 0.319208] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).482second # [ 0.317277] PM: RTC time: 00:09:31, date: 2026-10-06483test # [ 0.320261] pinctrl core: initialized pinctrl subsystem484test # [ 0.321430] PM: RTC time: 00:09:31, date: 2026-10-06485second # [ 0.320084] NET: Registered PF_NETLINK/PF_ROUTE protocol family486second # [ 0.321320] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations487test # [ 0.324265] NET: Registered PF_NETLINK/PF_ROUTE protocol family488second # [ 0.322092] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations489test # [ 0.325470] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations490second # [ 0.323169] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations491test # [ 0.326204] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations492second # [ 0.324072] audit: initializing netlink subsys (disabled)493test # [ 0.327286] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations494second # [ 0.325281] thermal_sys: Registered thermal governor 'fair_share'495test # [ 0.328191] audit: initializing netlink subsys (disabled)496second # [ 0.325283] thermal_sys: Registered thermal governor 'bang_bang'497test # [ 0.329394] thermal_sys: Registered thermal governor 'fair_share'498second # [ 0.326067] audit: type=2000 audit(1791245372.016:1): state=initialized audit_enabled=0 res=1499test # [ 0.329396] thermal_sys: Registered thermal governor 'bang_bang'500second # [ 0.328065] thermal_sys: Registered thermal governor 'step_wise'501test # [ 0.330186] audit: type=2000 audit(1791245372.020:1): state=initialized audit_enabled=0 res=1502second # [ 0.328067] thermal_sys: Registered thermal governor 'user_space'503test # [ 0.332184] thermal_sys: Registered thermal governor 'step_wise'504second # [ 0.329064] thermal_sys: Registered thermal governor 'power_allocator'505test # [ 0.332186] thermal_sys: Registered thermal governor 'user_space'506second # [ 0.330090] cpuidle: using governor menu507test # [ 0.333182] thermal_sys: Registered thermal governor 'power_allocator'508test # [ 0.334200] cpuidle: using governor menu509second # [ 0.332774] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5510second # [ 0.333315] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]511test # [ 0.336876] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5512second # [ 0.334066] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry513test # [ 0.337418] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]514second # [ 0.335075] PCI: Using configuration type 1 for base access515test # [ 0.338185] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry516second # [ 0.336229] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.517test # [ 0.339193] PCI: Using configuration type 1 for base access518test # [ 0.340370] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.519second # [ 0.343155] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages520second # [ 0.344064] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page521test # [ 0.347208] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages522test # [ 0.348182] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page523second # [ 0.349064] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages524second # [ 0.350065] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page525test # [ 0.353182] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages526test # [ 0.354183] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page527second # [ 0.356934] ACPI: Added _OSI(Module Device)528second # [ 0.357759] ACPI: Added _OSI(Processor Device)529second # [ 0.358064] ACPI: Added _OSI(Processor Aggregator Device)530test # [ 0.361135] ACPI: Added _OSI(Module Device)531test # [ 0.361881] ACPI: Added _OSI(Processor Device)532test # [ 0.362183] ACPI: Added _OSI(Processor Aggregator Device)533second # [ 0.364927] ACPI: 1 ACPI AML tables successfully acquired and loaded534test # [ 0.369089] ACPI: 1 ACPI AML tables successfully acquired and loaded535second # [ 0.368964] ACPI: Interpreter enabled536second # [ 0.369692] ACPI: PM: (supports S0 S3 S4 S5)537test # [ 0.373098] ACPI: Interpreter enabled538second # [ 0.371139] ACPI: Using IOAPIC for interrupt routing539test # [ 0.373799] ACPI: PM: (supports S0 S3 S4 S5)540second # [ 0.372107] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug541test # [ 0.375420] ACPI: Using IOAPIC for interrupt routing542second # [ 0.373064] PCI: Using E820 reservations for host bridge windows543second # [ 0.374184] ACPI: Enabled 2 GPEs in block 00 to 3F544test # [ 0.376235] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug545test # [ 0.377184] PCI: Using E820 reservations for host bridge windows546test # [ 0.378310] ACPI: Enabled 2 GPEs in block 00 to 3F547second # [ 0.378301] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])548second # [ 0.379069] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]549test # [ 0.382499] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])550second # [ 0.380125] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]551test # [ 0.383188] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]552second # [ 0.381160] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]553test # [ 0.384258] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]554second # [ 0.382495] PCI host bridge to bus 0000:00555test # [ 0.385280] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]556second # [ 0.383069] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]557test # [ 0.386588] PCI host bridge to bus 0000:00558second # [ 0.384064] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]559test # [ 0.387187] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]560second # [ 0.385064] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]561test # [ 0.388183] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]562second # [ 0.386065] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]563test # [ 0.389183] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]564second # [ 0.387064] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]565test # [ 0.390183] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]566second # [ 0.388064] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]567test # [ 0.391183] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]568second # [ 0.389065] pci_bus 0000:00: root bus resource [bus 00-ff]569test # [ 0.392183] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]570second # [ 0.390201] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint571test # [ 0.393183] pci_bus 0000:00: root bus resource [bus 00-ff]572test # [ 0.394285] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint573second # [ 0.391794] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint574test # [ 0.395849] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint575second # [ 0.395026] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]576second # [ 0.396084] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]577test # [ 0.398142] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]578second # [ 0.397107] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]579test # [ 0.399205] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]580test # [ 0.400223] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]581second # [ 0.398257] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]582test # [ 0.401356] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]583second # [ 0.399879] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint584test # [ 0.402933] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint585second # [ 0.402075] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]586second # [ 0.403080] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]587test # [ 0.405194] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]588test # [ 0.406241] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]589second # [ 0.404164] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]590test # [ 0.407223] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]591second # [ 0.405116] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]592test # [ 0.408194] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]593second # [ 0.407161] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint594test # [ 0.410221] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint595second # [ 0.409712] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]596test # [ 0.412193] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]597second # [ 0.410077] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]598test # [ 0.413195] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]599second # [ 0.411111] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]600test # [ 0.414223] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]601second # [ 0.412995] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint602test # [ 0.416079] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint603second # [ 0.415863] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]604test # [ 0.419150] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]605second # [ 0.416990] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]606test # [ 0.420193] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]607second # [ 0.418108] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]608test # [ 0.421222] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]609second # [ 0.419998] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint610test # [ 0.423080] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint611test # [ 0.425193] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]612second # [ 0.422075] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]613test # [ 0.426194] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]614second # [ 0.423079] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]615test # [ 0.427221] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]616second # [ 0.424105] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]617test # [ 0.428193] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]618second # [ 0.425077] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]619test # [ 0.430068] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint620second # [ 0.426956] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint621test # [ 0.432093] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]622second # [ 0.429084] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]623test # [ 0.433192] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]624second # [ 0.430106] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]625test # [ 0.435089] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint626second # [ 0.431953] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint627test # [ 0.437041] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]628test # [ 0.438171] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]629second # [ 0.434117] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]630second # [ 0.435103] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]631test # [ 0.440125] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint632second # [ 0.436993] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint633test # [ 0.442202] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]634test # [ 0.443221] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]635second # [ 0.439084] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]636second # [ 0.440103] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]637test # [ 0.445063] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint638second # [ 0.441943] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint639test # [ 0.447068] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]640test # [ 0.448182] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]641second # [ 0.444053] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]642second # [ 0.445063] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]643test # [ 0.450061] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint644second # [ 0.447209] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint645test # [ 0.452464] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]646test # [ 0.453193] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]647second # [ 0.449082] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]648test # [ 0.454222] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]649second # [ 0.450075] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]650second # [ 0.451103] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]651test # [ 0.456083] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint652second # [ 0.452951] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint653test # [ 0.458193] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]654test # [ 0.459194] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]655second # [ 0.455755] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]656test # [ 0.460221] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]657second # [ 0.456075] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]658second # [ 0.457103] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]659test # [ 0.462108] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint660test # [ 0.463845] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]661second # [ 0.458976] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint662second # [ 0.460782] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]663test # [ 0.464447] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint664test # [ 0.466864] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]665second # [ 0.461316] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint666test # [ 0.467461] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint667second # [ 0.463828] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]668test # [ 0.468865] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]669second # [ 0.464360] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint670test # [ 0.469492] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint671second # [ 0.465756] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]672test # [ 0.470795] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]673second # [ 0.466371] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint674test # [ 0.471528] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint675second # [ 0.467753] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]676test # [ 0.472659] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO677second # [ 0.468399] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint678test # [ 0.473530] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint679second # [ 0.469554] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO680test # [ 0.475060] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]681test # [ 0.476053] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]682second # [ 0.470410] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint683test # [ 0.477628] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint684second # [ 0.471977] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]685second # [ 0.473005] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]686test # [ 0.478902] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]687second # [ 0.474543] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint688second # [ 0.475710] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]689test # [ 0.484040] ACPI: PCI: Interrupt link LNKA configured for IRQ 10690test # [ 0.485314] ACPI: PCI: Interrupt link LNKB configured for IRQ 10691test # [ 0.486299] ACPI: PCI: Interrupt link LNKC configured for IRQ 11692second # [ 0.480729] ACPI: PCI: Interrupt link LNKA configured for IRQ 10693test # [ 0.487300] ACPI: PCI: Interrupt link LNKD configured for IRQ 11694second # [ 0.481182] ACPI: PCI: Interrupt link LNKB configured for IRQ 10695test # [ 0.488304] ACPI: PCI: Interrupt link LNKE configured for IRQ 10696second # [ 0.482184] ACPI: PCI: Interrupt link LNKC configured for IRQ 11697test # [ 0.489297] ACPI: PCI: Interrupt link LNKF configured for IRQ 10698second # [ 0.483178] ACPI: PCI: Interrupt link LNKD configured for IRQ 11699test # [ 0.490370] ACPI: PCI: Interrupt link LNKG configured for IRQ 11700second # [ 0.484180] ACPI: PCI: Interrupt link LNKE configured for IRQ 10701test # [ 0.491301] ACPI: PCI: Interrupt link LNKH configured for IRQ 11702second # [ 0.485178] ACPI: PCI: Interrupt link LNKF configured for IRQ 10703test # [ 0.492228] ACPI: PCI: Interrupt link GSIA configured for IRQ 16704second # [ 0.486180] ACPI: PCI: Interrupt link LNKG configured for IRQ 11705test # [ 0.493200] ACPI: PCI: Interrupt link GSIB configured for IRQ 17706test # [ 0.494199] ACPI: PCI: Interrupt link GSIC configured for IRQ 18707second # [ 0.487178] ACPI: PCI: Interrupt link LNKH configured for IRQ 11708test # [ 0.495199] ACPI: PCI: Interrupt link GSID configured for IRQ 19709second # [ 0.488112] ACPI: PCI: Interrupt link GSIA configured for IRQ 16710test # [ 0.496197] ACPI: PCI: Interrupt link GSIE configured for IRQ 20711second # [ 0.489080] ACPI: PCI: Interrupt link GSIB configured for IRQ 17712test # [ 0.497196] ACPI: PCI: Interrupt link GSIF configured for IRQ 21713second # [ 0.490080] ACPI: PCI: Interrupt link GSIC configured for IRQ 18714test # [ 0.498196] ACPI: PCI: Interrupt link GSIG configured for IRQ 22715second # [ 0.491077] ACPI: PCI: Interrupt link GSID configured for IRQ 19716test # [ 0.499201] ACPI: PCI: Interrupt link GSIH configured for IRQ 23717second # [ 0.492080] ACPI: PCI: Interrupt link GSIE configured for IRQ 20718second # [ 0.493077] ACPI: PCI: Interrupt link GSIF configured for IRQ 21719test # [ 0.501039] iommu: Default domain type: Translated720second # [ 0.494077] ACPI: PCI: Interrupt link GSIG configured for IRQ 22721test # [ 0.501987] iommu: DMA domain TLB invalidation policy: lazy mode722second # [ 0.495081] ACPI: PCI: Interrupt link GSIH configured for IRQ 23723test # [ 0.503410] ACPI: bus type USB registered724test # [ 0.504238] usbcore: registered new interface driver usbfs725second # [ 0.496974] iommu: Default domain type: Translated726test # [ 0.505199] usbcore: registered new interface driver hub727second # [ 0.497894] iommu: DMA domain TLB invalidation policy: lazy mode728test # [ 0.506195] usbcore: registered new device driver usb729second # [ 0.499307] ACPI: bus type USB registered730test # [ 0.507886] NetLabel: Initializing731second # [ 0.500121] usbcore: registered new interface driver usbfs732test # [ 0.508195] NetLabel: domain hash size = 128733second # [ 0.501082] usbcore: registered new interface driver hub734test # [ 0.509128] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO735second # [ 0.502077] usbcore: registered new device driver usb736test # [ 0.510157] NetLabel: unlabeled traffic allowed by default737second # [ 0.503766] NetLabel: Initializing738test # [ 0.511114] PCI: Using ACPI for IRQ routing739second # [ 0.504069] NetLabel: domain hash size = 128740second # [ 0.505002] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO741second # [ 0.506047] NetLabel: unlabeled traffic allowed by default742second # [ 0.506999] PCI: Using ACPI for IRQ routing743test # [ 0.588502] pci 0000:00:01.0: vgaarb: setting as boot VGA device744test # [ 0.589179] pci 0000:00:01.0: vgaarb: bridge control possible745test # [ 0.589179] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none746test # [ 0.589188] vgaarb: loaded747test # [ 0.589991] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0748second # [ 0.585555] pci 0000:00:01.0: vgaarb: setting as boot VGA device749test # [ 0.590990] hpet0: 3 comparators, 64-bit 100.000000 MHz counter750second # [ 0.586060] pci 0000:00:01.0: vgaarb: bridge control possible751second # [ 0.586060] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none752second # [ 0.586070] vgaarb: loaded753second # [ 0.586885] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0754second # [ 0.587877] hpet0: 3 comparators, 64-bit 100.000000 MHz counter755test # [ 0.596260] clocksource: Switched to clocksource kvm-clock756test # [ 0.599399] VFS: Disk quotas dquot_6.6.0757test # [ 0.600295] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)758test # [ 0.601876] pnp: PnP ACPI init759second # [ 0.594144] clocksource: Switched to clocksource kvm-clock760test # [ 0.602778] ACPI: IRQ 4 override to edge(!), high(!)761second # [ 0.595838] VFS: Disk quotas dquot_6.6.0762test # [ 0.603927] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved763test # [ 0.605775] pnp: PnP ACPI: found 5 devices764second # [ 0.598115] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)765second # [ 0.599742] pnp: PnP ACPI init766second # [ 0.600636] ACPI: IRQ 4 override to edge(!), high(!)767second # [ 0.601799] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved768second # [ 0.603642] pnp: PnP ACPI: found 5 devices769test # [ 0.612966] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns770test # [ 0.614759] clocksource: Switched to clocksource acpi_pm771test # [ 0.615993] NET: Registered PF_INET protocol family772test # [ 0.617187] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)773second # [ 0.610816] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns774second # [ 0.612643] clocksource: Switched to clocksource acpi_pm775second # [ 0.613923] NET: Registered PF_INET protocol family776second # [ 0.615123] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)777test # [ 0.630560] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)778test # [ 0.632397] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)779test # [ 0.634011] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)780test # [ 0.635624] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)781second # [ 0.628696] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)782test # [ 0.637147] TCP: Hash tables configured (established 8192 bind 8192)783second # [ 0.630575] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)784test # [ 0.638517] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)785second # [ 0.632214] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)786test # [ 0.640110] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)787second # [ 0.633876] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)788test # [ 0.641488] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)789test # [ 0.643010] NET: Registered PF_UNIX/PF_LOCAL protocol family790second # [ 0.635387] TCP: Hash tables configured (established 8192 bind 8192)791test # [ 0.644220] NET: Registered PF_XDP protocol family792second # [ 0.636779] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)793test # [ 0.645281] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]794second # [ 0.638400] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)795test # [ 0.646558] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]796second # [ 0.639801] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)797test # [ 0.647826] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]798second # [ 0.641320] NET: Registered PF_UNIX/PF_LOCAL protocol family799test # [ 0.649243] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]800second # [ 0.642575] NET: Registered PF_XDP protocol family801test # [ 0.650636] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]802second # [ 0.643637] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]803test # [ 0.652041] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]804second # [ 0.644936] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]805test # [ 0.654014] ACPI: \_SB_.GSIA: Enabled at IRQ 16806second # [ 0.646213] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]807second # [ 0.647638] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]808test # [ 0.656038] ACPI: \_SB_.GSIB: Enabled at IRQ 17809second # [ 0.649060] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]810test # [ 0.657892] ACPI: \_SB_.GSIC: Enabled at IRQ 18811second # [ 0.650457] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]812test # [ 0.659784] ACPI: \_SB_.GSID: Enabled at IRQ 19813second # [ 0.652422] ACPI: \_SB_.GSIA: Enabled at IRQ 16814test # [ 0.661477] PCI: CLS 0 bytes, default 64815second # [ 0.654441] ACPI: \_SB_.GSIB: Enabled at IRQ 17816test # [ 0.662522] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns817second # [ 0.656357] ACPI: \_SB_.GSIC: Enabled at IRQ 18818test # [ 0.664600] Trying to unpack rootfs image as initramfs...819second # [ 0.658264] ACPI: \_SB_.GSID: Enabled at IRQ 19820second # [ 0.659987] PCI: CLS 0 bytes, default 64821second # [ 0.661043] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns822second # [ 0.663150] Trying to unpack rootfs image as initramfs...823test # [ 0.702886] Initialise system trusted keyrings824test # [ 0.706028] workingset: timestamp_bits=40 max_order=18 bucket_order=0825second # [ 0.701771] Initialise system trusted keyrings826second # [ 0.702949] workingset: timestamp_bits=40 max_order=18 bucket_order=0827test # [ 0.720839] Key type asymmetric registered828test # [ 0.721777] Asymmetric key parser 'x509' registered829test # [ 0.727024] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)830second # [ 0.721368] Key type asymmetric registered831test # [ 0.730021] io scheduler mq-deadline registered832test # [ 0.731005] io scheduler kyber registered833second # [ 0.723883] Asymmetric key parser 'x509' registered834second # [ 0.724985] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)835test # [ 0.734398] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled836second # [ 0.730989] io scheduler mq-deadline registered837test # [ 0.737989] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A838second # [ 0.732001] io scheduler kyber registered839second # [ 0.735347] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled840test # [ 0.743399] Linux agpgart interface v0.103841test # [ 0.744371] ACPI: bus type drm_connector registered842second # [ 0.738885] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A843test # [ 0.747347] usbcore: registered new interface driver usbserial_generic844test # [ 0.748700] usbserial: USB Serial support registered for generic845second # [ 0.744310] Linux agpgart interface v0.103846test # [ 0.751985] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.847second # [ 0.745290] ACPI: bus type drm_connector registered848test # [ 0.751985] Please enable it if your BIOS has the CPPC option.849test # [ 0.754728] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled850second # [ 0.748246] usbcore: registered new interface driver usbserial_generic851second # [ 0.749625] usbserial: USB Serial support registered for generic852second # [ 0.752881] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.853test # [ 0.761113] drop_monitor: Initializing network drop monitor service854second # [ 0.752881] Please enable it if your BIOS has the CPPC option.855test # [ 0.762546] NET: Registered PF_INET6 protocol family856second # [ 0.755649] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled857test # [ 0.766364] Segment Routing with IPv6858second # [ 0.762014] drop_monitor: Initializing network drop monitor service859test # [ 0.769987] In-situ OAM (IOAM) with IPv6860second # [ 0.763442] NET: Registered PF_INET6 protocol family861test # [ 0.771171] IPI shorthand broadcast: enabled862second # [ 0.767300] Segment Routing with IPv6863second # [ 0.768156] In-situ OAM (IOAM) with IPv6864test # [ 0.776562] sched_clock: Marking stable (597032885, 178941277)->(862622181, -86648019)865second # [ 0.771164] IPI shorthand broadcast: enabled866test # [ 0.782152] registered taskstats version 1867test # [ 0.783247] Loading compiled-in X.509 certificates868second # [ 0.776606] sched_clock: Marking stable (597021357, 178839942)->(869951366, -94090067)869second # [ 0.783040] registered taskstats version 1870second # [ 0.784134] Loading compiled-in X.509 certificates871test # [ 0.798976] Demotion targets for Node 0: null872test # [ 0.802028] Key type .fscrypt registered873test # [ 0.802867] Key type fscrypt-provisioning registered874second # [ 0.797877] Demotion targets for Node 0: null875test # [ 0.806061] ima: No TPM chip found, activating TPM-bypass!876test # [ 0.807218] ima: Allocated hash algorithm: sha1877second # [ 0.800928] Key type .fscrypt registered878second # [ 0.801789] Key type fscrypt-provisioning registered879test # [ 0.810004] ima: No architecture policies found880test # [ 0.811146] PM: Magic number: 14:88:152881second # [ 0.804971] ima: No TPM chip found, activating TPM-bypass!882test # [ 0.812776] RAS: Correctable Errors collector initialized.883second # [ 0.806169] ima: Allocated hash algorithm: sha1884second # [ 0.808899] ima: No architecture policies found885second # [ 0.811876] PM: Magic number: 14:88:152886second # [ 0.813626] RAS: Correctable Errors collector initialized.887test # [ 0.823079] clk: Disabling unused clocks888test # [ 0.825982] PM: genpd: Disabling unused power domains889second # [ 0.822042] clk: Disabling unused clocks890second # [ 0.824874] PM: genpd: Disabling unused power domains891test # [ 0.933874] Freeing initrd memory: 29608K892test # [ 0.936703] Freeing unused decrypted memory: 2028K893test # [ 0.939269] Freeing unused kernel image (initmem) memory: 3656K894test # [ 0.940588] Write protecting the kernel read-only data: 32768k895test # [ 0.942099] Freeing unused kernel image (text/rodata gap) memory: 304K896test # [ 0.943758] Freeing unused kernel image (rodata/data gap) memory: 692K897second # [ 0.948171] Freeing initrd memory: 29608K898second # [ 0.950944] Freeing unused decrypted memory: 2028K899second # [ 0.953456] Freeing unused kernel image (initmem) memory: 3656K900second # [ 0.954764] Write protecting the kernel read-only data: 32768k901second # [ 0.956240] Freeing unused kernel image (text/rodata gap) memory: 304K902second # [ 0.957927] Freeing unused kernel image (rodata/data gap) memory: 692K903test # [ 0.977107] x86/mm: Checked W+X mappings: passed, no W+X pages found.904test # [ 0.978446] Run /init as init process905test # [ 0.987008] systemd[1]: Inserted module 'autofs4'906second # [ 0.990969] x86/mm: Checked W+X mappings: passed, no W+X pages found.907second # [ 0.992296] Run /init as init process908test # [ 1.002248] fuse: init (API version 7.45)909test # [ 1.008107] ACPI: \_SB_.GSIG: Enabled at IRQ 22910second # [ 1.001064] systemd[1]: Inserted module 'autofs4'911test # [ 1.010638] ACPI: \_SB_.GSIH: Enabled at IRQ 23912test # [ 1.013855] ACPI: \_SB_.GSIE: Enabled at IRQ 20913test # [ 1.016159] ACPI: \_SB_.GSIF: Enabled at IRQ 21914test # [ 1.021567] virtiofs virtio5: discovered new tag: nix-store915test # [ 1.023655] virtiofs virtio5: virtio_fs_setup_dax: No cache capability916second # [ 1.016654] fuse: init (API version 7.45)917second # [ 1.022715] ACPI: \_SB_.GSIG: Enabled at IRQ 22918test # [ 1.031266] virtiofs virtio6: discovered new tag: shared919second # [ 1.025311] ACPI: \_SB_.GSIH: Enabled at IRQ 23920test # [ 1.033342] virtiofs virtio6: virtio_fs_setup_dax: No cache capability921second # [ 1.028588] ACPI: \_SB_.GSIE: Enabled at IRQ 20922test # [ 1.037318] virtiofs virtio7: discovered new tag: xchg923second # [ 1.030967] ACPI: \_SB_.GSIF: Enabled at IRQ 21924test # [ 1.039384] virtiofs virtio7: virtio_fs_setup_dax: No cache capability925second # [ 1.036456] virtiofs virtio5: discovered new tag: nix-store926second # [ 1.038583] virtiofs virtio5: virtio_fs_setup_dax: No cache capability927second # [ 1.046064] virtiofs virtio6: discovered new tag: shared928second # [ 1.048131] virtiofs virtio6: virtio_fs_setup_dax: No cache capability929test # [ 1.058416] systemd[1]: Successfully made /usr/ read-only.930second # [ 1.051649] virtiofs virtio7: discovered new tag: xchg931second # [ 1.053683] virtiofs virtio7: virtio_fs_setup_dax: No cache capability932second # [ 1.072244] systemd[1]: Successfully made /usr/ read-only.933test # [ 1.394394] 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)934test # [ 1.400409] systemd[1]: Detected virtualization kvm.935test # [ 1.401521] systemd[1]: Detected architecture x86-64.936test # [ 1.402639] systemd[1]: Running in initrd.937test # [ 1.403821] systemd[1]: Initializing machine ID from random generator.938test # [ 1.405311] systemd[1]: Hostname set to <test>.939second # [ 1.408399] 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)940second # [ 1.415083] systemd[1]: Detected virtualization kvm.941second # [ 1.416184] systemd[1]: Detected architecture x86-64.942second # [ 1.417294] systemd[1]: Running in initrd.943second # [ 1.418476] systemd[1]: Initializing machine ID from random generator.944second # [ 1.419945] systemd[1]: Hostname set to <second>.945test # [ 1.461421] systemd[1]: bpf-restrict-fs: LSM BPF program attached946second # [ 1.476282] systemd[1]: bpf-restrict-fs: LSM BPF program attached947test # [ 1.490850] systemd[1]: Queued start job for default target Initrd Default Target.948test # [ 1.495149] systemd[1]: Created slice Slice /system/modprobe.949test # [ 1.496587] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.950test # [ 1.498314] systemd[1]: Expecting device /dev/disk/by-label/nixos...951test # [ 1.499699] systemd[1]: Reached target Path Units.952test # [ 1.500813] systemd[1]: Reached target Slice Units.953test # [ 1.501971] systemd[1]: Reached target Swaps.954test # [ 1.502991] systemd[1]: Reached target Timer Units.955test # [ 1.504210] systemd[1]: Listening on D-Bus System Message Bus Socket.956test # [ 1.505697] systemd[1]: Listening on Journal Socket (/dev/log).957test # [ 1.507171] systemd[1]: Listening on Journal Sockets.958second # [ 1.505428] systemd[1]: Queued start job for default target Initrd Default Target.959test # [ 1.508420] systemd[1]: Listening on udev Control Socket.960second # [ 1.510004] systemd[1]: Created slice Slice /system/modprobe.961test # [ 1.517967] systemd[1]: Listening on udev Kernel Socket.962test # [ 1.519177] systemd[1]: Reached target Socket Units.963second # [ 1.511445] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.964second # [ 1.513160] systemd[1]: Expecting device /dev/disk/by-label/nixos...965test # [ 1.521187] systemd[1]: Starting Create List of Static Device Nodes...966second # [ 1.514541] systemd[1]: Reached target Path Units.967second # [ 1.515649] systemd[1]: Reached target Slice Units.968second # [ 1.516761] systemd[1]: Reached target Swaps.969second # [ 1.517782] systemd[1]: Reached target Timer Units.970test # [ 1.525727] systemd[1]: Starting Load Kernel Module configfs...971second # [ 1.519030] systemd[1]: Listening on D-Bus System Message Bus Socket.972second # [ 1.520517] systemd[1]: Listening on Journal Socket (/dev/log).973second # [ 1.521960] systemd[1]: Listening on Journal Sockets.974test # [ 1.533271] systemd[1]: Starting Journal Service...975second # [ 1.523186] systemd[1]: Listening on udev Control Socket.976second # [ 1.532614] systemd[1]: Listening on udev Kernel Socket.977test # [ 1.541016] systemd[1]: Starting Load Kernel Modules...978second # [ 1.533801] systemd[1]: Reached target Socket Units.979second # [ 1.535875] systemd[1]: Starting Create List of Static Device Nodes...980test # [ 1.543848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os981second # [ 1.540423] systemd[1]: Starting Load Kernel Module configfs...982test # [ 1.549653] systemd[1]: Starting Coldplug All udev Devices...983second # [ 1.550377] systemd[1]: Starting Journal Service...984test # [ 1.563274] systemd[1]: Finished Create List of Static Device Nodes.985second # [ 1.558924] systemd[1]: Starting Load Kernel Modules...986second # [ 1.560976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os987test # [ 1.572682] systemd[1]: modprobe@configfs.service: Deactivated successfully.988second # [ 1.566907] systemd[1]: Starting Coldplug All udev Devices...989test # [ 1.575738] systemd-journald[65]: Collecting audit messages is disabled.990test # [ 1.580413] systemd[1]: Finished Load Kernel Module configfs.991test # [ 1.586512] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config992second # [ 1.583997] systemd[1]: Finished Create List of Static Device Nodes.993test # [ 1.591856] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.994test # [ 1.600018] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...995second # [ 1.594058] systemd[1]: modprobe@configfs.service: Deactivated successfully.996test # [ 1.603077] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev997second # [ 1.597544] systemd-journald[65]: Collecting audit messages is disabled.998second # [ 1.601330] systemd[1]: Finished Load Kernel Module configfs.999second # [ 1.607430] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1000second # [ 1.610689] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1001second # [ 1.619678] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1002second # [ 1.623974] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1003test # [ 1.632587] systemd[1]: Finished Load Kernel Modules.1004test # [ 1.640142] systemd[1]: Starting Apply Kernel Variables...1005test # [ 1.650704] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1006test # [ 1.661493] systemd[1]: Starting Create Static Device Nodes in /dev...1007second # [ 1.655520] systemd[1]: Finished Load Kernel Modules.1008second # [ 1.663029] systemd[1]: Starting Apply Kernel Variables...1009test # [ 1.681371] systemd[1]: Finished Apply Kernel Variables.1010second # [ 1.673971] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1011second # [ 1.684020] systemd[1]: Starting Create Static Device Nodes in /dev...1012test # [ 1.694630] systemd[1]: Finished Create Static Device Nodes in /dev.1013test # [ 1.699211] systemd[1]: Reached target Preparation for Local File Systems.1014test # [ 1.704042] systemd[1]: Reached target Local File Systems.1015second # [ 1.700968] systemd[1]: Finished Apply Kernel Variables.1016test # [ 1.711158] systemd[1]: Starting Rule-based Manager for Device Events and Files...1017test # [ 1.541280] systemd-modules-load[66]: Inserted module 'dm_mod'1018test # [ 1.542843] systemd-modules-load[66]: Inserted module 'virtio_balloon'1019test # [ 1.723043] systemd[1]: Started Journal Service.1020test # [ 1.546420] systemd-modules-load[66]: Inserted module 'virtio_gpu'1021second # [ 1.718556] systemd[1]: Finished Create Static Device Nodes in /dev.1022second # [ 1.723102] systemd[1]: Reached target Preparation for Local File Systems.1023second # [ 1.728935] systemd[1]: Reached target Local File Systems.1024test # [ 1.563567] systemd[1]: Starting Create System Files and Directories...1025second # [ 1.735042] systemd[1]: Starting Rule-based Manager for Device Events and Files...1026second # [ 1.561201] systemd-modules-load[66]: Inserted module 'dm_mod'1027second # [ 1.563371] systemd-modules-load[66]: Inserted module 'virtio_balloon'1028second # [ 1.565369] systemd-modules-load[66]: Inserted module 'virtio_gpu'1029second # [ 1.749197] systemd[1]: Started Journal Service.1030test # [ 1.590330] systemd[1]: Finished Create System Files and Directories.1031test # [ 1.593245] systemd-udevd[73]: Using default interface naming scheme 'v261'.1032second # [ 1.589094] systemd[1]: Starting Create System Files and Directories...1033test # [ 1.617094] systemd[1]: Started Rule-based Manager for Device Events and Files.1034second # [ 1.614804] systemd-udevd[72]: Using default interface naming scheme 'v261'.1035second # [ 1.616222] systemd[1]: Finished Create System Files and Directories.1036test # [ 1.626959] systemd[1]: Finished Coldplug All udev Devices.1037test # [ 1.628153] systemd[1]: Reached target System Initialization.1038test # [ 1.629244] systemd[1]: Reached target Basic System.1039second # [ 1.639126] systemd[1]: Started Rule-based Manager for Device Events and Files.1040second # [ 1.643754] systemd[1]: Finished Coldplug All udev Devices.1041second # [ 1.644856] systemd[1]: Reached target System Initialization.1042second # [ 1.646092] systemd[1]: Reached target Basic System.1043test # [ 2.014563] virtio_blk virtio2: 1/0/0 default/read/poll queues1044test # [ 2.020593] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121045test # [ 2.023031] serio: i8042 KBD port at 0x60,0x64 irq 11046test # [ 2.023834] serio: i8042 AUX port at 0x60,0x64 irq 121047test # [ 2.026154] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1048test # [ 2.031701] ehci-pci 0000:00:1d.7: EHCI Host Controller1049test # [ 2.032578] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11050test # [ 2.036177] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001051second # [ 2.029101] virtio_blk virtio2: 1/0/0 default/read/poll queues1052test # [ 2.043978] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001053test # [ 2.045290] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181054test # [ 2.046604] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11055second # [ 2.039501] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1056test # [ 2.048033] usb usb1: Product: EHCI Host Controller1057test # [ 2.048848] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd1058test # [ 2.049979] usb usb1: SerialNumber: 0000:00:1d.71059test # [ 2.051209] hub 1-0:1.0: USB hub found1060test # [ 2.052326] hub 1-0:1.0: 6 ports detected1061test # [ 2.055944] uhci_hcd 0000:00:1d.0: UHCI Host Controller1062test # [ 2.056778] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21063second # [ 2.051755] uhci_hcd 0000:00:1d.0: UHCI Host Controller1064second # [ 2.052642] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11065second # [ 2.054587] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121066second # [ 2.060361] serio: i8042 KBD port at 0x60,0x64 irq 11067second # [ 2.061191] serio: i8042 AUX port at 0x60,0x64 irq 121068test # [ 2.070191] uhci_hcd 0000:00:1d.0: detected 2 ports1069second # [ 2.067941] uhci_hcd 0000:00:1d.0: detected 2 ports1070second # [ 2.069628] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801071test # [ 2.078731] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801072second # [ 2.071973] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181073second # [ 2.074835] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11074test # [ 2.083025] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181075second # [ 2.076553] SCSI subsystem initialized1076test # [ 2.084329] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11077second # [ 2.077475] usb usb1: Product: UHCI Host Controller1078second # [ 2.078586] usb usb1: Manufacturer: Linux 6.18.55 uhci_hcd1079second # [ 2.079597] usb usb1: SerialNumber: 0000:00:1d.01080second # [ 2.080788] hub 1-0:1.0: USB hub found1081second # [ 2.081927] hub 1-0:1.0: 2 ports detected1082second # [ 2.084226] ehci-pci 0000:00:1d.7: EHCI Host Controller1083second # [ 2.085103] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 21084second # [ 2.086954] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001085test # [ 2.100364] usb usb2: Product: UHCI Host Controller1086second # [ 2.093889] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001087second # [ 2.095010] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181088second # [ 2.096647] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11089second # [ 2.097950] usb usb2: Product: EHCI Host Controller1090second # [ 2.098742] usb usb2: Manufacturer: Linux 6.18.55 ehci_hcd1091second # [ 2.099839] usb usb2: SerialNumber: 0000:00:1d.71092second # [ 2.101076] hub 2-0:1.0: USB hub found1093test # [ 2.108959] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd1094second # [ 2.102161] hub 2-0:1.0: 6 ports detected1095test # [ 2.109866] usb usb2: SerialNumber: 0000:00:1d.01096test # [ 1.938251] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1097test # [ 1.942483] systemd[1]: Starting Virtual Console Setup...1098test # [ 2.125163] hub 2-0:1.0: USB hub found1099test # [ 2.129528] SCSI subsystem initialized1100second # [ 2.124164] hub 1-0:1.0: USB hub found1101second # [ 2.125218] hub 1-0:1.0: 2 ports detected1102second # [ 2.128299] uhci_hcd 0000:00:1d.1: UHCI Host Controller1103test # [ 2.135989] hub 2-0:1.0: 2 ports detected1104second # [ 2.129186] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31105test # [ 1.959563] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line.1106second # [ 2.141926] uhci_hcd 0000:00:1d.1: detected 2 ports1107test # [ 1.975759] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1108test # [ 1.977784] systemd[1]: Finished Virtual Console Setup.1109second # [ 2.150701] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01110test # [ 2.158817] uhci_hcd 0000:00:1d.1: UHCI Host Controller1111second # [ 2.160411] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181112test # [ 2.168029] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31113second # [ 2.161735] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11114test # [ 2.173800] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01115test # [ 2.181710] uhci_hcd 0000:00:1d.1: detected 2 ports1116test # [ 2.182894] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01117second # [ 2.176140] usb usb3: Product: UHCI Host Controller1118test # [ 2.009612] systemd[1]: Found device /dev/disk/by-label/nixos.1119test # [ 2.189635] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181120test # [ 2.012333] systemd[1]: Reached target Initrd Root Device.1121second # [ 2.183988] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd1122test # [ 2.014239] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1123second # [ 2.013150] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line.1124second # [ 2.015043] systemd[1]: Starting Virtual Console Setup...1125test # [ 2.201085] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11126second # [ 2.195944] usb usb3: SerialNumber: 0000:00:1d.11127test # [ 2.207220] usb usb3: Product: UHCI Host Controller1128second # [ 2.022959] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1129test # [ 2.209953] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd1130test # [ 2.210885] usb usb3: SerialNumber: 0000:00:1d.11131test # [ 2.216543] hub 3-0:1.0: USB hub found1132test # [ 2.218688] hub 3-0:1.0: 2 ports detected1133test # [ 2.045739] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1134test # [ 2.226680] uhci_hcd 0000:00:1d.2: UHCI Host Controller1135test # [ 2.227634] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41136second # [ 2.043165] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1137test # [ 2.231946] uhci_hcd 0000:00:1d.2: detected 2 ports1138second # [ 2.226009] hub 3-0:1.0: USB hub found1139test # [ 2.235498] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01140second # [ 2.049493] systemd[1]: Finished Virtual Console Setup.1141second # [ 2.231838] hub 3-0:1.0: 2 ports detected1142test # [ 2.241022] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181143test # [ 2.242656] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11144test # [ 2.244173] usb usb4: Product: UHCI Host Controller1145test # [ 2.068525] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1146test # [ 2.251583] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd1147second # [ 2.245140] uhci_hcd 0000:00:1d.2: UHCI Host Controller1148second # [ 2.246030] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41149test # [ 2.253984] usb usb4: SerialNumber: 0000:00:1d.21150test # [ 2.256324] hub 4-0:1.0: USB hub found1151test # [ 2.258051] hub 4-0:1.0: 2 ports detected1152test # [ 2.258863] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1153second # [ 2.075090] systemd[1]: Found device /dev/disk/by-label/nixos.1154second # [ 2.076299] systemd[1]: Reached target Initrd Root Device.1155second # [ 2.077588] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1156second # [ 2.258363] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01157test # [ 2.271721] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1158test # [ 2.273153] ahci 0000:00:1f.2: flags: 64bit ncq only1159second # [ 2.268855] uhci_hcd 0000:00:1d.2: detected 2 ports1160second # [ 2.276735] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01161test # [ 2.290306] scsi host0: ahci1162second # [ 2.282644] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181163test # [ 2.292665] scsi host1: ahci1164test # [ 2.293387] usb 1-1: new high-speed USB device number 2 using ehci-pci1165test # [ 2.296018] scsi host2: ahci1166second # [ 2.288414] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11167test # [ 2.298075] scsi host3: ahci1168second # [ 2.292955] usb usb4: Product: UHCI Host Controller1169test # [ 2.301311] scsi host4: ahci1170second # [ 2.115590] systemd-fsck[105]: nixos: clean, 12/65536 files, 13019/262144 blocks1171second # [ 2.297193] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1172second # [ 2.298613] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd1173second # [ 2.299608] usb usb4: SerialNumber: 0000:00:1d.21174test # [ 2.309319] scsi host5: ahci1175test # [ 2.310964] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11176second # [ 2.124734] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1177test # [ 2.312524] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11178second # [ 2.305938] hub 4-0:1.0: USB hub found1179test # [ 2.314012] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11180second # [ 2.307664] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1181test # [ 2.315414] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11182second # [ 2.309061] hub 4-0:1.0: 2 ports detected1183test # [ 2.316820] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11184second # [ 2.309782] ahci 0000:00:1f.2: flags: 64bit ncq only1185test # [ 2.318250] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11186second # [ 2.317073] scsi host0: ahci1187second # [ 2.319155] scsi host1: ahci1188second # [ 2.321954] scsi host2: ahci1189second # [ 2.324249] scsi host3: ahci1190second # [ 2.328425] scsi host4: ahci1191second # [ 2.330893] scsi host5: ahci1192second # [ 2.331556] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11193second # [ 2.340847] usb 2-1: new high-speed USB device number 2 using ehci-pci1194second # [ 2.346440] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11195second # [ 2.354335] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11196second # [ 2.359846] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11197second # [ 2.363313] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11198second # [ 2.364874] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11199test # [ 2.423991] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001200test # [ 2.425290] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101201test # [ 2.426752] usb 1-1: Product: QEMU USB Tablet1202test # [ 2.427619] usb 1-1: Manufacturer: QEMU1203test # [ 2.428409] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11204test # [ 2.443236] hid: raw HID events driver (C) Jiri Kosina1205second # [ 2.470896] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001206second # [ 2.472221] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101207second # [ 2.473719] usb 2-1: Product: QEMU USB Tablet1208second # [ 2.474594] usb 2-1: Manufacturer: QEMU1209second # [ 2.475367] usb 2-1: SerialNumber: 28754-0000:00:1d.7-11210second # [ 2.494476] hid: raw HID events driver (C) Jiri Kosina1211test # [ 2.383134] systemd[1]: Mounting /sysroot...1212second # [ 2.398845] systemd[1]: Mounting /sysroot...1213test # [ 2.628228] ata1: SATA link down (SStatus 0 SControl 300)1214test # [ 2.630192] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1215test # [ 2.631403] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001216test # [ 2.632712] ata3.00: applying bridge limits1217test # [ 2.633720] ata3.00: configured for UDMA/1001218test # [ 2.634829] ata2: SATA link down (SStatus 0 SControl 300)1219test # [ 2.636133] ata4: SATA link down (SStatus 0 SControl 300)1220test # [ 2.637335] ata6: SATA link down (SStatus 0 SControl 300)1221test # [ 2.638723] ata5: SATA link down (SStatus 0 SControl 300)1222test # [ 2.640312] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51223second # [ 2.676072] ata6: SATA link down (SStatus 0 SControl 300)1224second # [ 2.677635] ata5: SATA link down (SStatus 0 SControl 300)1225second # [ 2.678837] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1226second # [ 2.679993] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001227second # [ 2.681348] ata3.00: applying bridge limits1228second # [ 2.682310] ata3.00: configured for UDMA/1001229second # [ 2.683354] ata4: SATA link down (SStatus 0 SControl 300)1230second # [ 2.684562] ata1: SATA link down (SStatus 0 SControl 300)1231second # [ 2.685762] ata2: SATA link down (SStatus 0 SControl 300)1232second # [ 2.687207] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51233test # [ 2.697037] usbcore: registered new interface driver usbhid1234test # [ 2.703577] usbhid: USB HID core driver1235test # [ 2.719479] 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/input21236test # [ 2.722728] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1237test # [ 2.724266] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01238test # [ 2.735070] cdrom: Uniform CD-ROM driver Revision: 3.201239test # [ 2.737834] EXT4-fs (vda): mounted filesystem edcc8fbb-44e5-4a4a-8f28-86588b580e98 r/w with ordered data mode. Quota mode: none.1240second # [ 2.733680] usbcore: registered new interface driver usbhid1241test # [ 2.564599] systemd[1]: Mounted /sysroot.1242second # [ 2.736123] usbhid: USB HID core driver1243test # [ 2.567122] systemd[1]: Reached target Initrd Root File System.1244test # [ 2.569954] systemd[1]: Starting Mountpoints Configured in the Real Root...1245test # [ 2.583158] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1246second # [ 2.757011] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input21247test # [ 2.586132] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1248test # [ 2.588812] systemd[1]: Reloading...1249second # [ 2.764773] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01250second # [ 2.771334] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1251second # [ 2.773271] EXT4-fs (vda): mounted filesystem ba96a6b4-f834-4b12-8396-2550faf150ab r/w with ordered data mode. Quota mode: none.1252second # [ 2.599037] systemd[1]: Mounted /sysroot.1253second # [ 2.602976] systemd[1]: Reached target Initrd Root File System.1254second # [ 2.606078] systemd[1]: Starting Mountpoints Configured in the Real Root...1255second # [ 2.786165] cdrom: Uniform CD-ROM driver Revision: 3.201256second # [ 2.621221] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.1257second # [ 2.625055] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...1258second # [ 2.626934] systemd[1]: Reloading...1259test # [ 2.659136] systemd[1]: Reloading finished in 70 ms.1260test # [ 2.667515] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1261test # [ 2.671174] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1262test # [ 2.675407] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1263test # [ 2.677208] systemd[1]: Finished Mountpoints Configured in the Real Root.1264test # [ 2.679217] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1265second # [ 2.689433] systemd[1]: Reloading finished in 65 ms.1266second # [ 2.701173] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...1267second # [ 2.706625] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...1268second # [ 2.710819] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1269second # [ 2.713316] systemd[1]: Finished Mountpoints Configured in the Real Root.1270second # [ 2.715236] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1271test # [ 3.383883] systemd[1]: Mounting /sysroot/nix/.ro-store...1272test # [ 3.387157] systemd[1]: Mounting /sysroot/nix/.rw-store...1273test # [ 3.389145] systemd[1]: Mounting /sysroot/run...1274test # [ 3.395151] systemd[1]: Mounting /sysroot/tmp/shared...1275test # [ 3.398367] systemd[1]: Mounting /sysroot/tmp/xchg...1276second # [ 3.400096] systemd[1]: Mounting /sysroot/nix/.ro-store...1277second # [ 3.403734] systemd[1]: Mounting /sysroot/nix/.rw-store...1278second # [ 3.406707] systemd[1]: Mounting /sysroot/run...1279test # [ 3.418634] systemd[1]: Mounted /sysroot/nix/.rw-store.1280second # [ 3.411759] systemd[1]: Mounting /sysroot/tmp/shared...1281second # [ 3.414326] systemd[1]: Mounting /sysroot/tmp/xchg...1282test # [ 3.423279] systemd[1]: Mounted /sysroot/nix/.ro-store.1283test # [ 3.425093] systemd[1]: Mounted /sysroot/run.1284test # [ 3.426790] systemd[1]: Mounted /sysroot/tmp/shared.1285test # [ 3.427964] systemd[1]: Mounted /sysroot/tmp/xchg.1286test # [ 3.433168] systemd[1]: Starting rw-sysroot-nix-store.service...1287test # [ 3.441631] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1288test # [ 3.443553] systemd[1]: Finished rw-sysroot-nix-store.service.1289second # [ 3.437089] systemd[1]: Mounted /sysroot/nix/.rw-store.1290second # [ 3.438666] systemd[1]: Mounted /sysroot/nix/.ro-store.1291second # [ 3.441079] systemd[1]: Mounted /sysroot/run.1292second # [ 3.442848] systemd[1]: Mounted /sysroot/tmp/shared.1293second # [ 3.444167] systemd[1]: Mounted /sysroot/tmp/xchg.1294second # [ 3.449440] systemd[1]: Starting rw-sysroot-nix-store.service...1295second # [ 3.457448] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1296second # [ 3.459805] systemd[1]: Finished rw-sysroot-nix-store.service.1297test # [ 4.383679] systemd[1]: Mounting /sysroot/nix/store...1298test # [ 4.404105] systemd[1]: Mounted /sysroot/nix/store.1299test # [ 4.405704] systemd[1]: Reached target Initrd File Systems.1300test # [ 4.408306] systemd[1]: Starting Find NixOS closure...1301second # [ 4.401093] systemd[1]: Mounting /sysroot/nix/store...1302test # [ 4.412421] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1303test # [ 4.428302] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1304second # [ 4.422541] systemd[1]: Mounted /sysroot/nix/store.1305second # [ 4.424504] systemd[1]: Reached target Initrd File Systems.1306test # [ 4.430575] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1307second # [ 4.426840] systemd[1]: Starting Find NixOS closure...1308second # [ 4.429759] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1309test # [ 4.448867] systemd[1]: Finished Find NixOS closure.1310test # [ 4.452122] systemd[1]: Reached target Initrd Default Target.1311second # [ 4.451060] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1312second # [ 4.453979] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1313test # [ 4.458077] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1314second # [ 4.461082] systemd[1]: Finished Find NixOS closure.1315second # [ 4.462869] systemd[1]: Reached target Initrd Default Target.1316second # [ 4.465059] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1317test # [ 4.477425] systemd[1]: Stopped target Initrd Default Target.1318test # [ 4.479002] systemd[1]: Stopped target Basic System.1319test # [ 4.481349] systemd[1]: Stopped target Initrd Root Device.1320test # [ 4.482529] systemd[1]: Stopped target Path Units.1321test # [ 4.483711] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1322test # [ 4.485329] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1323test # [ 4.487189] systemd[1]: Stopped target Slice Units.1324second # [ 4.479719] systemd[1]: initrd-cleanup.service: Deactivated successfully.1325test # [ 4.488853] systemd[1]: Stopped target Socket Units.1326second # [ 4.481756] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1327test # [ 4.490415] systemd[1]: Stopped target System Initialization.1328test # [ 4.491835] systemd[1]: Stopped target Swaps.1329second # [ 4.484894] systemd[1]: Stopped target Initrd Default Target.1330test # [ 4.493221] systemd[1]: Stopped target Timer Units.1331second # [ 4.486316] systemd[1]: Stopped target Basic System.1332second # [ 4.488209] systemd[1]: Stopped target Initrd Root Device.1333test # [ 4.495258] systemd[1]: dbus.socket: Deactivated successfully.1334test # [ 4.496513] systemd[1]: Closed D-Bus System Message Bus Socket.1335second # [ 4.489397] systemd[1]: Stopped target Path Units.1336test # [ 4.497774] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1337second # [ 4.490538] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1338test # [ 4.499744] systemd[1]: Stopped Find NixOS closure.1339test # [ 4.501345] systemd[1]: Starting rw-sysroot-nix-store.service...1340second # [ 4.493203] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1341second # [ 4.494730] systemd[1]: Stopped target Slice Units.1342second # [ 4.495820] systemd[1]: Stopped target Socket Units.1343test # [ 4.502725] systemd[1]: systemd-sysctl.service: Deactivated successfully.1344second # [ 4.497320] systemd[1]: Stopped target System Initialization.1345test # [ 4.505168] systemd[1]: Stopped Apply Kernel Variables.1346second # [ 4.498626] systemd[1]: Stopped target Swaps.1347test # [ 4.506420] systemd[1]: systemd-modules-load.service: Deactivated successfully.1348second # [ 4.500174] systemd[1]: Stopped target Timer Units.1349test # [ 4.507934] systemd[1]: Stopped Load Kernel Modules.1350second # [ 4.501150] systemd[1]: dbus.socket: Deactivated successfully.1351test # [ 4.509270] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1352second # [ 4.503158] systemd[1]: Closed D-Bus System Message Bus Socket.1353test # [ 4.510920] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1354second # [ 4.504277] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1355second # [ 4.505626] systemd[1]: Stopped Find NixOS closure.1356test # [ 4.512980] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1357second # [ 4.506564] systemd[1]: Starting rw-sysroot-nix-store.service...1358test # [ 4.514434] systemd[1]: Stopped Create System Files and Directories.1359second # [ 4.507693] systemd[1]: systemd-sysctl.service: Deactivated successfully.1360test # [ 4.516148] systemd[1]: Stopped target Local File Systems.1361second # [ 4.509135] systemd[1]: Stopped Apply Kernel Variables.1362second # [ 4.510584] systemd[1]: systemd-modules-load.service: Deactivated successfully.1363test # [ 4.518493] systemd[1]: Stopped target Preparation for Local File Systems.1364test # [ 4.519722] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1365second # [ 4.513442] systemd[1]: Stopped Load Kernel Modules.1366test # [ 4.521557] systemd[1]: Stopped Coldplug All udev Devices.1367second # [ 4.514456] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1368test # [ 4.523222] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1369second # [ 4.515859] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1370second # [ 4.517693] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1371test # [ 4.525202] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1372test # [ 4.526811] systemd[1]: Stopped Virtual Console Setup.1373second # [ 4.520250] systemd[1]: Stopped Create System Files and Directories.1374second # [ 4.521425] systemd[1]: Stopped target Local File Systems.1375second # [ 4.522634] systemd[1]: Stopped target Preparation for Local File Systems.1376second # [ 4.525166] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1377second # [ 4.527307] systemd[1]: Stopped Coldplug All udev Devices.1378test # [ 4.535412] systemd[1]: systemd-udevd.service: Deactivated successfully.1379second # [ 4.528488] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1380second # [ 4.530628] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1381test # [ 4.539290] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1382second # [ 4.533413] systemd[1]: Stopped Virtual Console Setup.1383test # [ 4.540685] systemd[1]: initrd-cleanup.service: Deactivated successfully.1384test # [ 4.544084] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1385second # [ 4.537408] systemd[1]: systemd-udevd.service: Deactivated successfully.1386second # [ 4.539265] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1387test # [ 4.548136] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1388second # [ 4.541498] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1389test # [ 4.549474] systemd[1]: Closed udev Control Socket.1390second # [ 4.542889] systemd[1]: Finished rw-sysroot-nix-store.service.1391test # [ 4.551207] systemd[1]: Starting Cleanup udev Database...1392second # [ 4.544588] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1393test # [ 4.553126] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1394second # [ 4.546681] systemd[1]: Closed udev Control Socket.1395test # [ 4.554587] systemd[1]: Stopped Create Static Device Nodes in /dev.1396second # [ 4.548921] systemd[1]: Starting Cleanup udev Database...1397test # [ 4.556178] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1398second # [ 4.550122] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1399test # [ 4.557731] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1400second # [ 4.551549] systemd[1]: Stopped Create Static Device Nodes in /dev.1401test # [ 4.560057] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1402second # [ 4.552739] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1403test # [ 4.561324] systemd[1]: Stopped Create List of Static Device Nodes.1404second # [ 4.555209] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1405test # [ 4.562544] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1406second # [ 4.556543] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1407test # [ 4.565222] systemd[1]: Finished rw-sysroot-nix-store.service.1408second # [ 4.558284] systemd[1]: Stopped Create List of Static Device Nodes.1409second # [ 4.570577] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1410test # [ 4.578577] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1411second # [ 4.573144] systemd[1]: Finished Cleanup udev Database.1412test # [ 4.581259] systemd[1]: Finished Cleanup udev Database.1413second # [ 4.574463] systemd[1]: Reached target Switch Root.1414test # [ 4.582733] systemd[1]: Reached target Switch Root.1415second # [ 4.576298] systemd[1]: Starting NixOS Activation...1416test # [ 4.585121] systemd[1]: Starting NixOS Activation...1417second # [ 4.639185] initrd-nixos-activation-start[189]: booting system configuration /nix/store/0l1qpij3z4s5isdrdf49vcs4j4lr9zf4-nixos-system-second-test1418test # [ 4.647980] initrd-nixos-activation-start[188]: booting system configuration /nix/store/waww6jdj07q1nj13pp56h32sb9rb3834-nixos-system-test-test1419test # [ 4.672339] initrd-nixos-activation-start[188]: running activation script...1420second # [ 4.665307] initrd-nixos-activation-start[189]: running activation script...1421test # [ 4.842795] initrd-nixos-activation-start[211]: setting up /etc...1422second # [ 4.838528] initrd-nixos-activation-start[212]: setting up /etc...1423test # [ 4.917675] initrd-nixos-activation-start[211]: setting up age secrets...1424second # [ 4.913919] initrd-nixos-activation-start[212]: setting up age secrets...1425second # [ 4.997319] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1426second # [ 5.000098] systemd[1]: Finished NixOS Activation.1427second # [ 5.001764] systemd[1]: Starting Switch Root...1428second # [ 5.013779] systemd[1]: Switching root.1429test # [ 5.036430] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1430test # [ 5.038380] systemd[1]: Finished NixOS Activation.1431test # [ 5.040510] systemd[1]: Starting Switch Root...1432test # [ 5.051257] systemd[1]: Switching root.1433second # [ 5.319918] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1434test # [ 5.351946] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1435second # [ 5.457157] NET: Registered PF_VSOCK protocol family1436test # [ 5.468299] NET: Registered PF_VSOCK protocol family1437test # [ 5.824439] 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)1438second # [ 5.817063] 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)1439test # [ 5.829034] systemd[1]: Detected virtualization kvm.1440second # [ 5.821610] systemd[1]: Detected virtualization kvm.1441second # [ 5.822461] systemd[1]: Detected architecture x86-64.1442test # [ 5.829934] systemd[1]: Detected architecture x86-64.1443test # [ 5.830960] systemd[1]: Detected first boot.1444second # [ 5.823371] systemd[1]: Detected first boot.1445test # [ 5.833004] systemd[1]: Initializing machine ID from random generator.1446second # [ 5.825477] systemd[1]: Initializing machine ID from random generator.1447test # [ 5.911891] systemd[1]: bpf-restrict-fs: LSM BPF program attached1448second # [ 5.905456] systemd[1]: bpf-restrict-fs: LSM BPF program attached1449test # [ 5.981618] systemd[1]: Applying preset policy.1450second # [ 5.974266] systemd[1]: Applying preset policy.1451second # [ 6.134552] systemd[1]: Populated /etc with preset unit settings.1452test # [ 6.152275] systemd[1]: Populated /etc with preset unit settings.1453test # [ 6.342198] systemd[1]: initrd-switch-root.service: Deactivated successfully.1454second # [ 6.334650] systemd[1]: initrd-switch-root.service: Deactivated successfully.1455test # [ 6.343916] systemd[1]: Stopped initrd-switch-root.service.1456second # [ 6.337316] systemd[1]: Stopped initrd-switch-root.service.1457test # [ 6.346384] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1458second # [ 6.340032] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1459test # [ 6.348574] systemd[1]: Created slice Slice /system/getty.1460second # [ 6.342328] systemd[1]: Created slice Slice /system/getty.1461test # [ 6.350117] systemd[1]: Created slice User and Session Slice.1462second # [ 6.343834] systemd[1]: Created slice User and Session Slice.1463test # [ 6.351227] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1464second # [ 6.344937] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1465test # [ 6.352677] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1466test # [ 6.354010] systemd[1]: Expecting device /dev/hvc0...1467second # [ 6.346386] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1468test # [ 6.354949] systemd[1]: Expecting device /dev/ttyS0...1469second # [ 6.347723] systemd[1]: Expecting device /dev/hvc0...1470test # [ 6.355911] systemd[1]: Reached target Local Encrypted Volumes.1471second # [ 6.348599] systemd[1]: Expecting device /dev/ttyS0...1472test # [ 6.356969] systemd[1]: Stopped target initrd-fs.target.1473second # [ 6.349564] systemd[1]: Reached target Local Encrypted Volumes.1474second # [ 6.359083] systemd[1]: Stopped target initrd-fs.target.1475second # [ 6.360030] systemd[1]: Stopped target initrd-root-fs.target.1476test # [ 6.357933] systemd[1]: Stopped target initrd-root-fs.target.1477second # [ 6.361032] systemd[1]: Stopped target initrd-switch-root.target.1478test # [ 6.369145] systemd[1]: Stopped target initrd-switch-root.target.1479second # [ 6.362102] systemd[1]: Reached target Virtual Machines and Containers.1480test # [ 6.370214] systemd[1]: Reached target Virtual Machines and Containers.1481second # [ 6.363246] systemd[1]: Reached target Path Units.1482test # [ 6.371351] systemd[1]: Reached target Path Units.1483second # [ 6.364137] systemd[1]: Reached target Remote File Systems.1484test # [ 6.372245] systemd[1]: Reached target Remote File Systems.1485second # [ 6.365140] systemd[1]: Reached target Slice Units.1486test # [ 6.373235] systemd[1]: Reached target Slice Units.1487second # [ 6.366049] systemd[1]: Reached target Swaps.1488test # [ 6.374138] systemd[1]: Reached target Swaps.1489second # [ 6.368205] systemd[1]: Listening on Query the User Interactively for a Password.1490test # [ 6.375929] systemd[1]: Listening on Query the User Interactively for a Password.1491second # [ 6.370841] systemd[1]: Listening on Process Core Dump Socket.1492test # [ 6.378664] systemd[1]: Listening on Process Core Dump Socket.1493second # [ 6.372801] systemd[1]: Listening on Credential Encryption/Decryption.1494test # [ 6.380586] systemd[1]: Listening on Credential Encryption/Decryption.1495second # [ 6.374825] systemd[1]: Listening on Factory Reset Management.1496test # [ 6.382538] systemd[1]: Listening on Factory Reset Management.1497second # [ 6.375942] systemd[1]: Listening on Hostname Service Socket.1498test # [ 6.383659] systemd[1]: Listening on Hostname Service Socket.1499second # [ 6.378898] systemd[1]: Starting Journal Log Access Socket...1500test # [ 6.386458] systemd[1]: Starting Journal Log Access Socket...1501second # [ 6.380173] systemd[1]: Listening on Journal Audit Socket.1502test # [ 6.388113] systemd[1]: Listening on Journal Audit Socket.1503second # [ 6.382799] systemd[1]: Listening on Console Output Muting Service Socket.1504test # [ 6.390645] systemd[1]: Listening on Console Output Muting Service Socket.1505second # [ 6.384081] systemd[1]: Listening on Network Management Metrics Varlink Socket.1506test # [ 6.391973] systemd[1]: Listening on Network Management Metrics Varlink Socket.1507second # [ 6.385487] systemd[1]: Listening on Network Management Varlink Socket.1508test # [ 6.393372] systemd[1]: Listening on Network Management Varlink Socket.1509second # [ 6.386759] systemd[1]: Listening on Network Management Netlink Socket.1510test # [ 6.394619] systemd[1]: Listening on Network Management Netlink Socket.1511second # [ 6.387999] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1512test # [ 6.395908] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1513second # [ 6.389293] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1514test # [ 6.397296] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1515second # [ 6.390821] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1516test # [ 6.398848] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1517second # [ 6.394646] systemd[1]: Listening on Disk Repartitioning Service Socket.1518test # [ 6.402692] systemd[1]: Listening on Disk Repartitioning Service Socket.1519second # [ 6.395901] systemd[1]: Listening on Resolve Monitor Varlink Socket.1520test # [ 6.403945] systemd[1]: Listening on Resolve Monitor Varlink Socket.1521second # [ 6.397152] systemd[1]: Listening on Resolve Service Varlink Socket.1522test # [ 6.405094] systemd[1]: Listening on Resolve Service Varlink Socket.1523second # [ 6.398318] systemd[1]: Listening on udev Control Socket.1524test # [ 6.406258] systemd[1]: Listening on udev Control Socket.1525second # [ 6.399367] systemd[1]: Listening on udev Varlink Socket.1526test # [ 6.407301] systemd[1]: Listening on udev Varlink Socket.1527second # [ 6.402264] systemd[1]: Mounting Huge Pages File System...1528test # [ 6.409850] systemd[1]: Mounting Huge Pages File System...1529second # [ 6.406064] systemd[1]: Mounting POSIX Message Queue File System...1530test # [ 6.413679] systemd[1]: Mounting POSIX Message Queue File System...1531test # [ 6.420060] systemd[1]: Mounting Kernel Debug File System...1532second # [ 6.412841] systemd[1]: Mounting Kernel Debug File System...1533second # [ 6.419282] systemd[1]: Mounting Kernel Trace File System...1534test # [ 6.428464] systemd[1]: Mounting Kernel Trace File System...1535test # [ 6.435883] systemd[1]: Starting Create List of Static Device Nodes...1536second # [ 6.428943] systemd[1]: Starting Create List of Static Device Nodes...1537test # [ 6.448954] systemd[1]: Starting Load Kernel Module configfs...1538second # [ 6.443149] systemd[1]: Starting Load Kernel Module configfs...1539second # [ 6.451101] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1540test # [ 6.459165] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1541second # [ 6.458405] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1542second # [ 6.460339] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1543second # [ 6.465492] systemd[1]: Mounting FUSE Control File System...1544test # [ 6.472728] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1545second # [ 6.468987] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671546test # [ 6.477427] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1547test # [ 6.480429] systemd[1]: Mounting FUSE Control File System...1548test # [ 6.482131] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671549second # [ 6.478572] systemd[1]: Starting Journal Service...1550test # [ 6.493833] systemd[1]: Starting Journal Service...1551second # [ 6.486782] systemd[1]: Starting Load Kernel Modules...1552test # [ 6.498976] systemd[1]: Starting Load Kernel Modules...1553second # [ 6.496177] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1554second # [ 6.505056] systemd[1]: Starting Remount Root and Kernel File Systems...1555test # [ 6.512957] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1556test # [ 6.518649] systemd[1]: Starting Remount Root and Kernel File Systems...1557second # [ 6.511846] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1558test # [ 6.520740] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1559test # [ 6.531048] systemd-journald[336]: Collecting audit messages is enabled.1560second # [ 6.525403] systemd[1]: Starting Coldplug All udev Devices...1561test # [ 6.533939] systemd[1]: Starting Coldplug All udev Devices...1562second # [ 6.528412] systemd-journald[315]: Collecting audit messages is enabled.1563second # [ 6.536642] systemd[1]: Listening on Journal Log Access Socket.1564test # [ 6.547509] systemd[1]: Listening on Journal Log Access Socket.1565test # [ 6.553170] systemd[1]: Mounted Huge Pages File System.1566test # [ 6.555195] loop: module loaded1567second # [ 6.550403] systemd[1]: Mounted Huge Pages File System.1568test # [ 6.379361] systemd[1]: Queued start job for default target Multi-User System.1569test # [ 6.380899] systemd[1]: systemd-journald.service: Deactivated successfully.1570second # [ 6.553030] loop: module loaded1571test # [ 6.562580] systemd[1]: Started Journal Service.1572test # [ 6.385191] systemd-modules-load[337]: Module 'ctr' is built in1573test # [ 6.386738] systemd-modules-load[337]: Inserted module 'loop'1574second # [ 6.557976] systemd[1]: Mounted POSIX Message Queue File System.1575second # [ 6.564126] systemd[1]: Mounted Kernel Debug File System.1576second # [ 6.387426] systemd[1]: Queued start job for default target Multi-User System.1577test # [ 6.398211] systemd[1]: Mounted POSIX Message Queue File System.1578second # [ 6.569937] systemd[1]: Started Journal Service.1579second # [ 6.388996] systemd[1]: systemd-journald.service: Deactivated successfully.1580test # [ 6.401392] systemd[1]: Mounted Kernel Debug File System.1581second # [ 6.394925] systemd-modules-load[316]: Module 'ctr' is built in1582test # [ 6.402468] systemd[1]: Mounted Kernel Trace File System.1583test # [ 6.582381] EXT4-fs (vda): re-mounted edcc8fbb-44e5-4a4a-8f28-86588b580e98.1584test # [ 6.406075] systemd[1]: Finished Create List of Static Device Nodes.1585second # [ 6.399469] systemd-modules-load[316]: Inserted module 'loop'1586test # [ 6.408140] systemd[1]: modprobe@configfs.service: Deactivated successfully.1587second # [ 6.402560] systemd[1]: Mounted Kernel Trace File System.1588test # [ 6.412118] systemd[1]: Finished Load Kernel Module configfs.1589test # [ 6.413180] systemd[1]: Mounted FUSE Control File System.1590second # [ 6.408923] systemd[1]: Finished Create List of Static Device Nodes.1591second # [ 6.588759] EXT4-fs (vda): re-mounted ba96a6b4-f834-4b12-8396-2550faf150ab.1592test # [ 6.418222] systemd[1]: Finished Load Kernel Modules.1593second # [ 6.414360] systemd[1]: modprobe@configfs.service: Deactivated successfully.1594second # [ 6.416289] systemd[1]: Finished Load Kernel Module configfs.1595test # [ 6.424057] systemd[1]: Finished Remount Root and Kernel File Systems.1596second # [ 6.417432] systemd[1]: Mounted FUSE Control File System.1597second # [ 6.419161] systemd[1]: Finished Load Kernel Modules.1598second # [ 6.427504] systemd[1]: Finished Remount Root and Kernel File Systems.1599test # [ 6.435584] systemd[1]: Listening on Disk Image Download Service Socket.1600test # [ 6.441077] systemd[1]: Mounting Kernel Configuration File System...1601second # [ 6.434096] systemd[1]: Listening on Disk Image Download Service Socket.1602test # [ 6.444082] systemd[1]: Starting Firewall...1603second # [ 6.439101] systemd[1]: Mounting Kernel Configuration File System...1604test # [ 6.447808] systemd[1]: Starting Flush Journal to Persistent Storage...1605second # [ 6.442527] systemd[1]: Starting Firewall...1606test # [ 6.449071] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1607second # [ 6.447079] systemd[1]: Starting Flush Journal to Persistent Storage...1608test # [ 6.456439] systemd[1]: Starting Load/Save OS Random Seed...1609second # [ 6.448282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1610second # [ 6.452329] systemd-oomd[317]: No swap; memory pressure usage will be degraded1611test # [ 6.466134] systemd[1]: Starting Apply Kernel Variables...1612second # [ 6.462639] systemd[1]: Starting Load/Save OS Random Seed...1613test # [ 6.476388] systemd-oomd[339]: No swap; memory pressure usage will be degraded1614second # [ 6.480036] systemd[1]: Starting Apply Kernel Variables...1615test # [ 6.489142] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1616test # [ 6.490508] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1617test # [ 6.492166] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1618second # [ 6.488955] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1619second # [ 6.490490] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1620second # [ 6.494221] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1621second # [ 6.705881] systemd-journald[315]: Received client request to flush runtime journal.1622test # [ 6.715314] systemd-journald[336]: Received client request to flush runtime journal.1623second # [ 6.709385] systemd[1]: Mounted Kernel Configuration File System.1624second # [ 6.712625] systemd[1]: Finished Load/Save OS Random Seed.1625second # [ 6.716625] systemd[1]: Reached target First Boot Complete.1626second # [ 6.719179] systemd[1]: Finished Apply Kernel Variables.1627second # [ 6.720205] systemd[1]: Starting Network Name Resolution...1628second # [ 6.723204] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1629second # [ 6.724501] systemd[1]: Starting Create Static Device Nodes in /dev...1630second # [ 6.729216] systemd[1]: Finished Flush Journal to Persistent Storage.1631test # [ 6.737440] systemd[1]: Mounted Kernel Configuration File System.1632test # [ 6.739038] systemd[1]: Finished Load/Save OS Random Seed.1633test # [ 6.744704] systemd[1]: Reached target First Boot Complete.1634test # [ 6.745869] systemd[1]: Finished Apply Kernel Variables.1635test # [ 6.748231] systemd[1]: Starting Network Name Resolution...1636test # [ 6.749270] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1637test # [ 6.752223] systemd[1]: Starting Create Static Device Nodes in /dev...1638test # [ 6.756684] systemd[1]: Finished Flush Journal to Persistent Storage.1639test # [ 6.759057] systemd-resolved[366]: Positive Trust Anchors:1640second # [ 6.752710] systemd-resolved[345]: Positive Trust Anchors:1641test # [ 6.760198] systemd-resolved[366]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1642second # [ 6.754365] systemd-resolved[345]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1643test # [ 6.762186] systemd-resolved[366]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161644second # [ 6.757461] systemd-resolved[345]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161645test # [ 6.763859] systemd-resolved[366]: 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 test1646second # [ 6.759349] systemd-resolved[345]: 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 test1647second # [ 6.784540] systemd[1]: Finished Coldplug All udev Devices.1648test # [ 6.800633] systemd[1]: Finished Coldplug All udev Devices.1649test # [ 6.805135] systemd[1]: Finished Create Static Device Nodes in /dev.1650test # [ 6.808294] systemd[1]: Reached target Preparation for Local File Systems.1651test # [ 6.810571] systemd[1]: Starting Rule-based Manager for Device Events and Files...1652second # [ 6.807243] systemd[1]: Finished Create Static Device Nodes in /dev.1653second # [ 6.809078] systemd[1]: Reached target Preparation for Local File Systems.1654second # [ 6.813132] systemd[1]: Starting Rule-based Manager for Device Events and Files...1655second # [ 6.827550] systemd-resolved[345]: Using system hostname 'second'.1656second # [ 6.831955] systemd[1]: Started Network Name Resolution.1657test # [ 6.841249] systemd-resolved[366]: Using system hostname 'test'.1658test # [ 6.845809] systemd[1]: Started Network Name Resolution.1659second # [ 6.858488] systemd-udevd[361]: Using default interface naming scheme 'v261'.1660test # [ 6.866329] systemd-udevd[381]: Using default interface naming scheme 'v261'.1661second # [ 6.917472] systemd[1]: Started Rule-based Manager for Device Events and Files.1662test # [ 6.931289] systemd[1]: Started Rule-based Manager for Device Events and Files.1663second # [ 7.042576] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1664test # [ 7.057429] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1665second # [ 7.117047] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1666test # [ 7.138903] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1667second # [ 7.144782] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1668second # [ 7.161410] systemd[1]: Mounting /run/wrappers...1669test # [ 7.169614] systemd[1]: Mounting /run/wrappers...1670test # [ 7.184975] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1671second # [ 7.186361] (udev-worker)[392]: Network interface NamePolicy= disabled on kernel command line.1672test # [ 7.196366] (udev-worker)[412]: Network interface NamePolicy= disabled on kernel command line.1673test # [ 7.202268] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line.1674second # [ 7.195571] systemd[1]: Mounted /run/wrappers.1675second # [ 7.196742] systemd[1]: Reached target Local File Systems.1676second # [ 7.200503] systemd[1]: Listening on Boot Loader Control Service Socket.1677test # [ 7.208706] systemd[1]: Mounted /run/wrappers.1678test # [ 7.209641] systemd[1]: Reached target Local File Systems.1679second # [ 7.202281] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line.1680second # [ 7.205215] systemd[1]: Starting register-nix-paths.service...1681test # [ 7.213582] systemd[1]: Listening on Boot Loader Control Service Socket.1682test # [ 7.216154] systemd[1]: Starting register-nix-paths.service...1683second # [ 7.210350] systemd[1]: Starting Create SUID/SGID Wrappers...1684second # [ 7.211444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1685test # [ 7.221120] systemd[1]: Starting Create SUID/SGID Wrappers...1686test # [ 7.222189] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1687second # [ 7.217325] systemd[1]: Starting Save Transient machine-id to Disk...1688test # [ 7.229527] systemd[1]: Starting Save Transient machine-id to Disk...1689second # [ 7.231357] systemd[1]: Starting Create System Files and Directories...1690test # [ 7.239955] systemd[1]: Starting Create System Files and Directories...1691test # [ 7.363775] systemd[1]: Finished Create System Files and Directories.1692second # [ 7.364054] systemd[1]: Finished Create System Files and Directories.1693test # [ 7.373247] systemd[1]: Starting Rebuild Journal Catalog...1694second # [ 7.373155] systemd[1]: Starting Rebuild Journal Catalog...1695second # [ 7.376767] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1696test # [ 7.399805] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1697second # [ 7.474094] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1698test # [ 7.483695] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1699second # [ 7.513494] systemd[1]: Finished Rebuild Journal Catalog.1700test # [ 7.524677] systemd[1]: Finished Rebuild Journal Catalog.1701second # [ 7.520131] systemd[1]: Starting Update is Completed...1702test # [ 7.533623] systemd[1]: Starting Update is Completed...1703second # [ 7.567976] systemd[1]: Finished Update is Completed.1704test # [ 7.591267] systemd[1]: Finished Update is Completed.1705test # [ 7.641367] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1706second # [ 7.634477] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1707second # [ 7.640200] systemd[1]: Finished Save Transient machine-id to Disk.1708test # [ 7.647909] systemd[1]: Finished Save Transient machine-id to Disk.1709second # [ 7.836481] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31710second # [ 7.839830] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1711test # [ 7.852398] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1712test # [ 7.865487] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31713second # [ 7.881489] ACPI: button: Power Button [PWRF]1714test # [ 7.750457] systemd[1]: Finished Firewall.1715test # [ 7.753141] systemd[1]: Reached target Preparation for Network.1716test # [ 7.754339] systemd[1]: Listening on Network Management Resolve Hook Socket.1717test # [ 7.761239] systemd[1]: Starting Network Management...1718second # [ 7.764687] systemd[1]: Finished Firewall.1719second # [ 7.767619] systemd[1]: Reached target Preparation for Network.1720second # [ 7.770136] systemd[1]: Listening on Network Management Resolve Hook Socket.1721second # [ 7.776542] systemd[1]: Starting Network Management...1722second # [ 7.807158] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1723second # [ 7.813491] systemd[1]: Finished Create SUID/SGID Wrappers.1724test # [ 7.839782] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1725test # [ 7.845130] systemd[1]: Finished Create SUID/SGID Wrappers.1726test # [ 7.921863] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41727second # [ 7.897187] mousedev: PS/2 mouse device common for all mice1728second # [ 7.860979] systemd-resolved[345]: Clock change detected. Flushing caches.1729test # [ 7.878253] systemd[1]: Finished register-nix-paths.service.1730test # [ 7.879764] systemd[1]: Reached target System Initialization.1731test # [ 7.882549] systemd[1]: Started Discard unused filesystem blocks once a week.1732test # [ 7.883836] systemd[1]: Started Daily Cleanup of Temporary Directories.1733test # [ 7.886193] systemd[1]: Reached target Timer Units.1734test # [ 7.887666] systemd[1]: Listening on D-Bus System Message Bus Socket.1735test # [ 7.889293] systemd[1]: Listening on Nix Daemon Socket.1736test # [ 7.894659] systemd[1]: Listening on Authorization Manager Agent Helper.1737second # [ 7.888274] systemd[1]: Finished register-nix-paths.service.1738test # [ 7.895913] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1739second # [ 7.889545] systemd[1]: Reached target System Initialization.1740test # [ 7.898171] systemd[1]: Reached target Socket Units.1741second # [ 7.892448] systemd[1]: Started Discard unused filesystem blocks once a week.1742test # [ 7.902116] systemd[1]: Starting D-Bus System Message Bus...1743second # [ 7.897203] systemd[1]: Started Daily Cleanup of Temporary Directories.1744test # [ 7.904884] systemd-resolved[366]: Clock change detected. Flushing caches.1745second # [ 7.898434] systemd[1]: Reached target Timer Units.1746second # [ 7.899416] systemd[1]: Listening on D-Bus System Message Bus Socket.1747second # [ 7.902292] systemd[1]: Listening on Nix Daemon Socket.1748second # [ 7.903798] systemd[1]: Listening on Authorization Manager Agent Helper.1749second # [ 7.906176] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1750second # [ 7.908739] systemd[1]: Reached target Socket Units.1751second # [ 7.909761] systemd[1]: Starting D-Bus System Message Bus...1752test # [ 7.947814] mousedev: PS/2 mouse device common for all mice1753test # [ 7.961840] ACPI: button: Power Button [PWRF]1754second # [ 8.011109] rtc_cmos PNP0B00:00: RTC can wake from S41755test # [ 8.034045] Console: switching to colour dummy device 80x251756second # [ 8.034196] Console: switching to colour dummy device 80x251757test # [ 8.043383] rtc_cmos PNP0B00:00: RTC can wake from S41758second # [ 8.038593] rtc_cmos PNP0B00:00: registered as rtc01759second # [ 8.039156] rtc_cmos PNP0B00:00: setting system clock to 2026-10-06T00:09:39 UTC (1791245379)1760test # [ 8.082817] rtc_cmos PNP0B00:00: registered as rtc01761test # [ 8.082914] rtc_cmos PNP0B00:00: setting system clock to 2026-10-06T00:09:39 UTC (1791245379)1762test # [ 8.083006] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1763second # [ 8.039261] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1764second # [ 8.040804] systemd-journald[315]: Time jumped backwards, rotating.1765second # [ 8.105788] parport_pc 00:02: reported by Plug and Play ACPI1766test # [ 8.084773] systemd-journald[336]: Time jumped backwards, rotating.1767test # [ 8.098252] parport_pc 00:02: reported by Plug and Play ACPI1768test # [ 8.098343] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1769second # [ 8.105881] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1770second # [ 8.114753] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41771second # [ 8.122790] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1772test # [ 8.197039] cfg80211: Loading compiled-in X.509 certificates for regulatory database1773test # [ 8.201041] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1774second # [ 8.193086] cfg80211: Loading compiled-in X.509 certificates for regulatory database1775second # [ 8.215866] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1776second # [ 8.215957] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1777test # [ 8.062648] dbus-broker-launch[564]: Looking up NSS user entry for 'systemd-timesync'...1778second # [ 8.055774] dbus-broker-launch[544]: Looking up NSS user entry for 'systemd-timesync'...1779test # [ 8.222966] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1780test # [ 8.223054] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1781second # [ 8.062177] dbus-broker-launch[544]: NSS returned no entry for 'systemd-timesync'1782test # [ 8.069754] dbus-broker-launch[564]: NSS returned no entry for 'systemd-timesync'1783second # [ 8.063663] dbus-broker-launch[544]: Invalid user-name in /nix/store/3liy0y9brnsp4nnmhcack0lswq5a9zs0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1784test # [ 8.073189] dbus-broker-launch[564]: Invalid user-name in /nix/store/3liy0y9brnsp4nnmhcack0lswq5a9zs0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1785second # [ 8.067469] systemd-networkd[536]: /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.1786test # [ 8.076824] systemd-networkd[553]: /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.1787second # [ 8.072289] systemd-networkd[536]: /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.1788test # [ 8.080861] systemd-networkd[553]: /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.1789second # [ 8.076152] systemd-networkd[536]: lo: Link UP1790second # [ 8.077646] systemd-networkd[536]: lo: Gained carrier1791test # [ 8.086074] systemd-networkd[553]: lo: Link UP1792test # [ 8.086955] systemd-networkd[553]: lo: Gained carrier1793test # [ 8.092079] systemd[1]: Started Network Management.1794second # [ 8.086076] systemd[1]: Started Network Management.1795test # [ 8.097324] systemd-networkd[553]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1796second # [ 8.090278] systemd-networkd[536]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1797second # [ 8.092986] systemd-networkd[536]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1798test # [ 8.103097] systemd-networkd[553]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1799second # [ 8.096384] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1800test # [ 8.104922] systemd-networkd[553]: eth1: Link UP1801test # [ 8.107454] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1802second # [ 8.101091] systemd-networkd[536]: eth1: Link UP1803test # [ 8.109775] systemd-networkd[553]: eth1: Gained carrier1804second # [ 8.104950] systemd-networkd[536]: eth1: Gained carrier1805test # [ 8.112886] systemd-networkd[553]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1806second # [ 8.106413] systemd-networkd[536]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1807test # [ 8.281595] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1808second # [ 8.260497] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1809second # [ 8.260610] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1810test # [ 8.134848] 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'1811second # [ 8.129044] dbus-broker-launch[544]: 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'1812second # [ 8.133154] dbus-broker-launch[544]: 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'1813test # [ 8.141218] 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'1814test # [ 8.281700] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1815second # [ 8.137382] dbus-broker-launch[544]: 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'1816test # [ 8.147129] 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'1817test # [ 8.151385] 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'1818second # [ 8.144799] dbus-broker-launch[544]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/d527hwwggm2wz18p4v8cr39amcpx3g4c-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1819test # [ 8.156130] systemd[1]: Started D-Bus System Message Bus.1820second # [ 8.149145] systemd[1]: Started D-Bus System Message Bus.1821test # [ 8.158200] systemd[1]: Reached target Basic System.1822second # [ 8.152252] systemd[1]: Reached target Basic System.1823test # [ 8.164966] systemd[1]: Starting Network Manager Script Dispatcher Service...1824second # [ 8.159127] systemd[1]: Starting Network Manager Script Dispatcher Service...1825test # [ 8.169101] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1826second # [ 8.164161] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1827test # [ 8.173922] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1828second # [ 8.173086] systemd[1]: Starting Network Manager...1829test # [ 8.187089] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1830test # [ 8.307850] NET: Registered PF_PACKET protocol family1831test # [ 8.368436] [drm] Found bochs VGA, ID 0xb0c5.1832test # [ 8.368438] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1833second # [ 8.305293] NET: Registered PF_PACKET protocol family1834second # [ 8.361869] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61835second # [ 8.189086] systemd[1]: Started backdoor.service.1836second # [ 8.190870] dbus-broker-launch[544]: Ready1837test # [ 8.198700] dbus-broker-launch[564]: Ready1838test # [ 8.386902] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1839test # [ 8.387758] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01840test # [ 8.210087] systemd[1]: Starting Network Manager...1841second # [ 8.210125] systemd[1]: Starting Import lastlog data into lastlog2 database...1842test # [ 8.398588] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61843test # [ 8.399974] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51844second # [ 8.362187] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51845test # [ 8.226680] systemd[1]: Started backdoor.service.1846second # [ 8.228354] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1847test # [ 8.246622] systemd[1]: Starting Import lastlog data into lastlog2 database...1848second # [ 8.243121] systemd[1]: Starting Post-Boot Actions...1849second # [ 8.257091] systemd[1]: Started Reset console on configuration changes.1850second # [ 8.438705] [drm] Found bochs VGA, ID 0xb0c5.1851second # [ 8.439229] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1852test # [ 8.275524] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1853second # [ 8.273744] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1854test # [ 8.289970] systemd[1]: Starting Post-Boot Actions...1855second # [ 8.283196] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[556]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1856test # [ 8.301850] systemd[1]: Started Reset console on configuration changes.1857test # [ 8.306278] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[576]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1858test # [ 8.310400] bjn7ymirp1h8ai1aki9b9jfc6bwb1c5s-wifi-secrets[578]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1859test # [ 8.318674] 2fzr21av002hkddm9grsnsbb2wa3c1bn-wifi-secrets[577]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1860second # [ 8.318481] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1861second # connecting to host...1862second # [ 8.327348] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1863test # [ 8.358301] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1864test # [ 8.359694] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1865second # [ 8.533390] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1866second # [ 8.534259] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01867test # [ 8.371845] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1868test # [ 8.373396] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1869test # [ 8.382241] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1870test # [ 8.384731] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1871second # [ 8.383855] nsncd[560]: Oct 06 00:09:40.022 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1872test # [ 8.393958] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1873second # [ 8.389364] systemd[1]: Started Name Service Cache Daemon (nsncd).1874second # [ 8.393193] systemd[1]: Reached target Host and Network Name Lookups.1875second # [ 8.394976] systemd[1]: Reached target User and Group Name Lookups.1876test # connecting to host...1877second # [ 8.407953] systemd[1]: Starting User Login Management...1878second # [ 8.415118] systemd[1]: Finished Post-Boot Actions.1879test: Guest shell says: b'Spawning backdoor root shell...\n'1880second # [ 8.434105] systemd[1]: Started Network Manager Script Dispatcher Service.1881test: connected to guest root shell1882test: (connecting took 9.11 seconds)1883test: (finished: waiting for the VM to finish booting, in 9.11 seconds)1884second # [ 8.444145] systemd[1]: Finished Import lastlog data into lastlog2 database.1885test # [ 8.443184] systemd[1]: Finished Post-Boot Actions.1886test # [ 8.469266] systemd[1]: Started Network Manager Script Dispatcher Service.1887test # [ 8.480922] nsncd[583]: Oct 06 00:09:40.076 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1888test # [ 8.485610] systemd[1]: Started Name Service Cache Daemon (nsncd).1889test # [ 8.488657] systemd[1]: Reached target Host and Network Name Lookups.1890test # [ 8.491887] systemd[1]: Reached target User and Group Name Lookups.1891second # [ 8.490195] systemd[1]: Starting Virtual Console Setup...1892test # [ 8.502155] systemd[1]: Starting User Login Management...1893test # [ 8.517373] systemd[1]: Finished Import lastlog data into lastlog2 database.1894second # [ 8.522509] systemd[1]: Starting Hostname Service...1895second # [ 8.525375] systemd-logind[589]: New seat seat0.1896test # [ 8.538078] systemd[1]: Starting Virtual Console Setup...1897second # [ 8.531287] systemd-logind[589]: Watching system buttons on /dev/input/event2 (Power Button)1898second # [ 8.536609] systemd[1]: Started User Login Management.1899second # [ 8.543926] systemd-logind[589]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1900second # [ 8.549398] systemd[1]: Starting linger-users.service...1901test # [ 8.604153] systemd[1]: Starting Hostname Service...1902test # [ 8.799579] Console: switching to colour frame buffer device 160x501903test # [ 8.805508] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1904test # [ 8.620466] systemd-logind[633]: Watching system buttons on /dev/input/event3 (Power Button)1905test # [ 8.629364] systemd-logind[633]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1906test # [ 8.633425] systemd-logind[633]: New seat seat0.1907test # [ 8.635502] systemd[1]: Started User Login Management.1908test # [ 8.637566] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1909test # [ 8.641079] systemd[1]: Stopped Virtual Console Setup.1910second # [ 8.768511] Console: switching to colour frame buffer device 160x501911test # [ 8.649357] systemd-logind[633]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)1912test # [ 8.653987] systemd[1]: Starting linger-users.service...1913test # [ 8.659456] systemd[1]: Starting Virtual Console Setup...1914second # [ 8.833582] ppdev: user-space parallel port driver1915second # [ 8.842683] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1916second # [ 8.607582] systemd[1]: linger-users.service: Deactivated successfully.1917second # [ 8.668666] systemd[1]: Finished linger-users.service.1918second # [ 8.669878] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1919second # [ 8.671818] systemd[1]: Started Hostname Service.1920second # [ 8.674675] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1921second # [ 8.677468] systemd[1]: Stopped Virtual Console Setup.1922second # [ 8.683189] systemd[1]: Starting Virtual Console Setup...1923test # [ 8.719183] systemd[1]: linger-users.service: Deactivated successfully.1924second # [ 8.713287] systemd-logind[589]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1925test # [ 8.724681] systemd[1]: Finished linger-users.service.1926test # [ 8.725683] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1927second # [ 8.903133] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1928second # [ 8.729404] systemd-networkd[536]: eth0: Link UP1929second # [ 8.730344] systemd-networkd[536]: eth0: Gained carrier1930test # [ 8.749802] systemd[1]: Started Hostname Service.1931second # [ 8.753151] systemd[1]: Started Network Manager.1932test # [ 8.940927] ppdev: user-space parallel port driver1933second # [ 8.755243] systemd[1]: Reached target Network.1934second # [ 8.762115] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1935second # [ 8.770231] systemd[1]: Starting Permit User Sessions...1936second # [ 8.963140] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1937test # [ 8.807320] systemd-networkd[553]: eth0: Link UP1938test # [ 8.808372] systemd-networkd[553]: eth0: Gained carrier1939test # [ 9.006429] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1940test # [ 8.833092] systemd[1]: Started Network Manager.1941test # [ 8.836099] systemd[1]: Reached target Network.1942second # [ 8.836117] systemd[1]: Finished Permit User Sessions.1943test # [ 8.843416] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1944test # [ 8.847977] systemd[1]: Starting Permit User Sessions...1945test # [ 9.080576] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1946second # [ 8.896950] systemd[1]: Started Getty on tty1.1947second # [ 8.897914] systemd[1]: Reached target Login Prompts.1948test # [ 8.912920] systemd[1]: Finished Permit User Sessions.1949test # [ 8.922752] systemd[1]: Started Getty on tty1.1950test # [ 8.926658] systemd[1]: Reached target Login Prompts.1951test # [ 8.943800] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1952test # [ 8.948798] systemd[1]: Stopped Virtual Console Setup.1953second # [ 8.974809] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1954second # [ 8.981586] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1955second # [ 8.988888] systemd[1]: Reached target Multi-User System.1956second # [ 8.996862] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1957second # [ 9.001614] systemd[1]: Stopped Virtual Console Setup.1958second # [ 9.009196] systemd-resolved[345]: eth0: Bus client set default route setting: yes1959second # [ 9.018651] systemd[1]: Starting Virtual Console Setup...1960second # [ 9.019681] systemd-resolved[345]: eth0: Bus client set DNS server list to: 10.0.2.31961test # [ 9.207678] kvm_amd: TSC scaling supported1962test # [ 9.208230] kvm_amd: Nested Virtualization enabled1963second # [ 9.201299] kvm_amd: TSC scaling supported1964test # [ 9.209181] kvm_amd: Nested Paging enabled1965test # [ 9.209688] kvm_amd: LBR virtualization supported1966test # [ 9.210530] kvm_amd: Virtual GIF supported1967test # [ 9.211277] kvm_amd: Virtual NMI enabled1968second # [ 9.208132] kvm_amd: Nested Virtualization enabled1969second # [ 9.211703] kvm_amd: Nested Paging enabled1970second # [ 9.212203] kvm_amd: LBR virtualization supported1971second # [ 9.217083] kvm_amd: Virtual GIF supported1972second # [ 9.217623] kvm_amd: Virtual NMI enabled1973test # [ 9.047530] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1974test # [ 9.050115] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1975test # [ 9.243592] EDAC MC: Ver: 3.0.01976test # [ 9.068388] systemd[1]: Reached target Multi-User System.1977test # [ 9.073168] systemd[1]: Starting Virtual Console Setup...1978second # [ 9.267239] EDAC MC: Ver: 3.0.01979test # [ 9.119269] systemd-resolved[366]: eth0: Bus client set default route setting: yes1980test # [ 9.123939] systemd-resolved[366]: eth0: Bus client set DNS server list to: 10.0.2.31981second # [ 9.154631] systemd-vconsole-setup[641]: Configuration of first virtual console was skipped, ignoring remaining ones.1982second # [ 9.158481] systemd[1]: Finished Virtual Console Setup.1983second # [ 9.162651] systemd[1]: Startup finished in 816ms (kernel) + 4.421s (initrd) + 3.923s (userspace) = 9.162s.1984test # [ 9.214255] systemd-vconsole-setup[682]: Configuration of first virtual console was skipped, ignoring remaining ones.1985test # [ 9.217987] systemd[1]: Finished Virtual Console Setup.1986test # [ 9.221581] systemd[1]: Startup finished in 802ms (kernel) + 4.443s (initrd) + 3.975s (userspace) = 9.221s.1987second # [ 9.483899] systemd-networkd[536]: eth1: Gained IPv6LL1988test: (finished: waiting for unit NetworkManager.service, in 10.28 seconds)1989test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1990test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1991test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1992test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1993test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1994test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1995(finished: run the VM test script, in 11.04 seconds)1996test # [ 9.804322] systemd-networkd[553]: eth1: Gained IPv6LL1997test script finished in 11.74s1998cleanup1999kill QemuMachine (pid 47)2000second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)2001second # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2002second # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2003second # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2004kill QemuMachine (pid 48)2005test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)2006test # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2007test # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2008test # [2026-10-06T00:09:42Z INFO virtiofsd] Client disconnected, shutting down2009(finished: cleanup, in 0.19 seconds)