vm-test-run-wifi
checks.x86_64-linux.wifi
· build #214
· raw
1gi-build-x86-02: building bqh9z8w4ks4hm3lzb4gihsvmjvfd7jvj-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 vm14second # Disk image does not exist, creating the virtualisation disk image...15second # Formatting '/build/vm-state-second/tmp.rMIpdahwT2', fmt=raw size=107374182416second # mke2fs 1.47.4 (6-Mar-2025)17second # Discarding device blocks: 0/262144 done18second # Creating filesystem with 262144 4k blocks and 65536 inodes19second # Filesystem UUID: ad6f6042-5dbd-4efa-bd27-c356b63507d920second # Superblock backups stored on blocks:21second # 32768, 98304, 163840, 22937622second # 23second # Allocating group tables: 0/8 done24second # Writing inode tables: 0/8 done25second # Creating journal (8192 blocks): done26second # Writing superblocks and filesystem accounting information: 0/8 done27second # 28second # Virtualisation disk image created.29second # Starting virtiofs daemons...30second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31second: QEMU running (pid 48)32second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33test # Disk image does not exist, creating the virtualisation disk image...34test: QEMU running (pid 47)35test # Formatting '/build/vm-state-test/tmp.um7ia46Rkh', fmt=raw size=107374182436second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37test # mke2fs 1.47.4 (6-Mar-2025)38second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether39(finished: start all VMs, in 0.09 seconds)40second # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...41test: waiting for unit NetworkManager.service42second # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...43test: waiting for the VM to finish booting44second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)45test # Discarding device blocks: 0/262144 done46second # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether47test # Creating filesystem with 262144 4k blocks and 65536 inodes48second # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...49test # Filesystem UUID: 698a4e17-b7e9-4ecb-8f18-4641194b253f50second # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests51test # Superblock backups stored on blocks:52second # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests53test # 32768, 98304, 163840, 22937654second # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests55test # 56test # Allocating group tables: 0/8 done57test # Writing inode tables: 0/8 done58test # Creating journal (8192 blocks): done59test # Writing superblocks and filesystem accounting information: 0/8 done60test # 61test # Virtualisation disk image created.62test # Starting virtiofs daemons...63test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)64test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether65test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)66test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether67test # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...68test # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...69test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)70test # [2026-10-03T00:02:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether71test # [2026-10-03T00:02:49Z INFO virtiofsd] Waiting for vhost-user socket connection...72test # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests73test # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests74test # [2026-10-03T00:02:49Z INFO virtiofsd] Client connected, servicing requests75test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)76second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)77test # 78test # 79second # 80second # 81test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0082second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0083test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...84test # 85test # 86test # 87test # 88second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...89second # 90second # 91second # 92second # 93test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0094second # 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 # 101second # Booting from ROM...102test # Booting from ROM...103test # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 2026104second # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 2026105test # [ 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/qbfd7pvaa5mdbvvvdp1ngcmdj6b7krs6-nixos-system-test-test/init regInfo=/nix/.ro-store/f2fz96022k6yw2bj1yvml18a5f1kd3kr-closure-info/registration console=ttyS0,115200n8 console=tty0106second # [ 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/5ckvj43jlchxdwzgdri797g5hvbd2irc-nixos-system-second-test/init regInfo=/nix/.ro-store/8w2w7zrxpn3mlm034pbfjjmsj2ls2ig2-closure-info/registration console=ttyS0,115200n8 console=tty0107test # [ 0.000000] BIOS-provided physical RAM map:108second # [ 0.000000] BIOS-provided physical RAM map:109test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable110second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable111test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved112second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved113test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved114second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved115test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable116second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable117test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved118second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved119test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved120second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved121test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved122second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved123test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved124second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved125test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved126second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved127test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved128second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved129test # [ 0.000000] NX (Execute Disable) protection: active130second # [ 0.000000] NX (Execute Disable) protection: active131test # [ 0.000000] APIC: Static calls initialized132second # [ 0.000000] APIC: Static calls initialized133test # [ 0.000000] SMBIOS 2.8 present.134second # [ 0.000000] SMBIOS 2.8 present.135test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014136second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014137test # [ 0.000000] DMI: Memory slots populated: 1/1138second # [ 0.000000] DMI: Memory slots populated: 1/1139test # [ 0.000000] Hypervisor detected: KVM140second # [ 0.000000] Hypervisor detected: KVM141test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000142second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000143test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00144second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00145test # [ 0.000000] kvm-clock: using sched offset of 388168312 cycles146second # [ 0.000000] kvm-clock: using sched offset of 388857060 cycles147test # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns148second # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns149test # [ 0.000004] tsc: Detected 4192.088 MHz processor150second # [ 0.000010] tsc: Detected 4192.088 MHz processor151test # [ 0.000556] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000152second # [ 0.000556] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000153second # [ 0.000583] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs154test # [ 0.000584] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs155second # [ 0.000586] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT156test # [ 0.000586] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT157second # [ 0.002202] found SMP MP-table at [mem 0x000f5450-0x000f545f]158test # [ 0.002209] found SMP MP-table at [mem 0x000f5450-0x000f545f]159second # [ 0.002213] Using GB pages for direct mapping160test # [ 0.002220] Using GB pages for direct mapping161second # [ 0.002303] RAMDISK: [mem 0x3e250000-0x3ffcffff]162test # [ 0.002314] RAMDISK: [mem 0x3e24f000-0x3ffcffff]163second # [ 0.002307] ACPI: Early table checksum verification disabled164test # [ 0.002318] ACPI: Early table checksum verification disabled165second # [ 0.002309] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )166test # [ 0.002320] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )167second # [ 0.002312] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)168test # [ 0.002323] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)169second # [ 0.002316] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)170test # [ 0.002327] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)171second # [ 0.002320] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)172test # [ 0.002332] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)173second # [ 0.002321] ACPI: FACS 0x000000003FFE0000 000040174test # [ 0.002333] ACPI: FACS 0x000000003FFE0000 000040175second # [ 0.002323] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)176test # [ 0.002334] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)177second # [ 0.002324] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)178test # [ 0.002336] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)179second # [ 0.002325] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)180test # [ 0.002337] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)181second # [ 0.002326] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)182test # [ 0.002338] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)183second # [ 0.002327] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]184test # [ 0.002339] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]185second # [ 0.002328] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]186test # [ 0.002340] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]187second # [ 0.002328] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]188test # [ 0.002340] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]189second # [ 0.002328] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]190test # [ 0.002340] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]191second # [ 0.002329] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]192test # [ 0.002341] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]193second # [ 0.002329] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]194test # [ 0.002341] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]195second # [ 0.002330] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]196test # [ 0.002341] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]197second # [ 0.002667] No NUMA configuration found198test # [ 0.002678] No NUMA configuration found199second # [ 0.002668] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]200test # [ 0.002679] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]201second # [ 0.002671] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]202test # [ 0.002682] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]203second # [ 0.002734] Zone ranges:204test # [ 0.002747] Zone ranges:205second # [ 0.002734] DMA [mem 0x0000000000001000-0x0000000000ffffff]206test # [ 0.002747] DMA [mem 0x0000000000001000-0x0000000000ffffff]207second # [ 0.002736] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]208test # [ 0.002748] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]209second # [ 0.002736] Normal empty210test # [ 0.002749] Normal empty211second # [ 0.002737] Device empty212test # [ 0.002749] Device empty213second # [ 0.002737] Movable zone start for each node214test # [ 0.002750] Movable zone start for each node215second # [ 0.002738] Early memory node ranges216test # [ 0.002751] Early memory node ranges217second # [ 0.002738] node 0: [mem 0x0000000000001000-0x000000000009efff]218test # [ 0.002751] node 0: [mem 0x0000000000001000-0x000000000009efff]219second # [ 0.002739] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]220test # [ 0.002752] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]221second # [ 0.002740] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]222test # [ 0.002752] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]223second # [ 0.002755] On node 0, zone DMA: 1 pages in unavailable ranges224test # [ 0.002767] On node 0, zone DMA: 1 pages in unavailable ranges225second # [ 0.003028] On node 0, zone DMA: 97 pages in unavailable ranges226test # [ 0.002950] On node 0, zone DMA: 97 pages in unavailable ranges227second # [ 0.015341] On node 0, zone DMA32: 40 pages in unavailable ranges228test # [ 0.015323] On node 0, zone DMA32: 40 pages in unavailable ranges229second # [ 0.016118] ACPI: PM-Timer IO Port: 0x608230test # [ 0.016099] ACPI: PM-Timer IO Port: 0x608231second # [ 0.016127] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])232test # [ 0.016108] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])233second # [ 0.016146] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23234test # [ 0.016128] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23235second # [ 0.016148] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)236test # [ 0.016130] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)237second # [ 0.016149] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)238test # [ 0.016131] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)239second # [ 0.016150] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)240test # [ 0.016132] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)241second # [ 0.016151] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)242test # [ 0.016133] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)243second # [ 0.016151] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)244test # [ 0.016133] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)245second # [ 0.016153] ACPI: Using ACPI (MADT) for SMP configuration information246test # [ 0.016135] ACPI: Using ACPI (MADT) for SMP configuration information247second # [ 0.016154] ACPI: HPET id: 0x8086a201 base: 0xfed00000248test # [ 0.016136] ACPI: HPET id: 0x8086a201 base: 0xfed00000249second # [ 0.016156] TSC deadline timer available250test # [ 0.016138] TSC deadline timer available251second # [ 0.016159] CPU topo: Max. logical packages: 1252test # [ 0.016141] CPU topo: Max. logical packages: 1253second # [ 0.016159] CPU topo: Max. logical dies: 1254test # [ 0.016142] CPU topo: Max. logical dies: 1255second # [ 0.016160] CPU topo: Max. dies per package: 1256test # [ 0.016142] CPU topo: Max. dies per package: 1257second # [ 0.016163] CPU topo: Max. threads per core: 1258test # [ 0.016145] CPU topo: Max. threads per core: 1259second # [ 0.016163] CPU topo: Num. cores per package: 1260test # [ 0.016145] CPU topo: Num. cores per package: 1261second # [ 0.016163] CPU topo: Num. threads per package: 1262test # [ 0.016146] CPU topo: Num. threads per package: 1263second # [ 0.016163] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs264test # [ 0.016146] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs265second # [ 0.016174] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()266test # [ 0.016156] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()267second # [ 0.016198] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]268test # [ 0.016179] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]269second # [ 0.016200] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]270test # [ 0.016181] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]271second # [ 0.016201] [mem 0x40000000-0xafffffff] available for PCI devices272test # [ 0.016182] [mem 0x40000000-0xafffffff] available for PCI devices273second # [ 0.016202] Booting paravirtualized kernel on KVM274test # [ 0.016183] Booting paravirtualized kernel on KVM275second # [ 0.016204] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns276test # [ 0.016185] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns277second # [ 0.019539] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1278test # [ 0.019520] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1279second # [ 0.021098] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152280test # [ 0.021077] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152281second # [ 0.021127] kvm-guest: PV spinlocks disabled, single CPU282test # [ 0.021108] kvm-guest: PV spinlocks disabled, single CPU283second # [ 0.021128] 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/5ckvj43jlchxdwzgdri797g5hvbd2irc-nixos-system-second-test/init regInfo=/nix/.ro-store/8w2w7zrxpn3mlm034pbfjjmsj2ls2ig2-closure-info/registration console=ttyS0,115200n8 console=tty0284test # [ 0.021110] 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/qbfd7pvaa5mdbvvvdp1ngcmdj6b7krs6-nixos-system-test-test/init regInfo=/nix/.ro-store/f2fz96022k6yw2bj1yvml18a5f1kd3kr-closure-info/registration console=ttyS0,115200n8 console=tty0285second # [ 0.021192] Unknown kernel command line parameters "regInfo=/nix/.ro-store/8w2w7zrxpn3mlm034pbfjjmsj2ls2ig2-closure-info/registration", will be passed to user space.286test # [ 0.021175] Unknown kernel command line parameters "regInfo=/nix/.ro-store/f2fz96022k6yw2bj1yvml18a5f1kd3kr-closure-info/registration", will be passed to user space.287second # [ 0.021487] random: crng init done288test # [ 0.021462] random: crng init done289second # [ 0.021487] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes290test # [ 0.021462] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes291second # [ 0.021503] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)292test # [ 0.021478] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)293second # [ 0.021511] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)294test # [ 0.021487] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)295second # [ 0.021534] Fallback order for Node 0: 0296test # [ 0.021509] Fallback order for Node 0: 0297second # [ 0.021536] Built 1 zonelists, mobility grouping on. Total pages: 262006298test # [ 0.021511] Built 1 zonelists, mobility grouping on. Total pages: 262006299second # [ 0.021536] Policy zone: DMA32300test # [ 0.021512] Policy zone: DMA32301second # [ 0.023272] mem auto-init: stack:all(zero), heap alloc:on, heap free:off302test # [ 0.023269] mem auto-init: stack:all(zero), heap alloc:on, heap free:off303second # [ 0.025641] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1304test # [ 0.025597] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1305second # [ 0.027219] allocated 2097152 bytes of page_ext306test # [ 0.027275] allocated 2097152 bytes of page_ext307second # [ 0.035671] ftrace: allocating 48820 entries in 192 pages308test # [ 0.035750] ftrace: allocating 48820 entries in 192 pages309second # [ 0.035673] ftrace: allocated 192 pages with 2 groups310test # [ 0.035751] ftrace: allocated 192 pages with 2 groups311second # [ 0.036415] Dynamic Preempt: lazy312test # [ 0.036385] Dynamic Preempt: lazy313second # [ 0.036541] rcu: Preemptible hierarchical RCU implementation.314test # [ 0.036482] rcu: Preemptible hierarchical RCU implementation.315second # [ 0.036541] rcu: RCU event tracing is enabled.316test # [ 0.036482] rcu: RCU event tracing is enabled.317second # [ 0.036542] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.318test # [ 0.036482] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.319second # [ 0.036543] Trampoline variant of Tasks RCU enabled.320test # [ 0.036484] Trampoline variant of Tasks RCU enabled.321second # [ 0.036543] Rude variant of Tasks RCU enabled.322test # [ 0.036484] Rude variant of Tasks RCU enabled.323second # [ 0.036543] Tracing variant of Tasks RCU enabled.324test # [ 0.036484] Tracing variant of Tasks RCU enabled.325second # [ 0.036544] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.326test # [ 0.036485] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.327second # [ 0.036544] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1328test # [ 0.036486] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1329second # [ 0.036556] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.330test # [ 0.036526] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.331second # [ 0.036557] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.332test # [ 0.036527] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.333second # [ 0.036558] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.334test # [ 0.036528] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.335second # [ 0.039685] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16336test # [ 0.039673] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16337second # [ 0.039925] rcu: srcu_init: Setting srcu_struct sizes based on contention.338test # [ 0.039893] rcu: srcu_init: Setting srcu_struct sizes based on contention.339second # [ 0.039930] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns340test # [ 0.039899] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns341second # [ 0.040089] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)342test # [ 0.040056] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)343second # [ 0.045214] Console: colour VGA+ 80x25344test # [ 0.045211] Console: colour VGA+ 80x25345second # [ 0.045216] printk: legacy console [tty0] enabled346test # [ 0.045213] printk: legacy console [tty0] enabled347second # [ 0.075253] printk: legacy console [ttyS0] enabled348test # [ 0.075278] printk: legacy console [ttyS0] enabled349second # [ 0.207451] ACPI: Core revision 20250807350test # [ 0.207673] ACPI: Core revision 20250807351second # [ 0.208476] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns352test # [ 0.208697] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns353second # [ 0.210374] APIC: Switch to symmetric I/O mode setup354test # [ 0.210630] APIC: Switch to symmetric I/O mode setup355second # [ 0.211548] x2apic enabled356test # [ 0.211791] x2apic enabled357second # [ 0.212349] APIC: Switched APIC routing to: physical x2apic358test # [ 0.212588] APIC: Switched APIC routing to: physical x2apic359second # [ 0.214297] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1360test # [ 0.214524] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1361second # [ 0.215514] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns362test # [ 0.215816] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns363second # [ 0.217569] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)364test # [ 0.217973] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)365second # [ 0.218653] x86/cpu: User Mode Instruction Prevention (UMIP) activated366test # [ 0.219056] x86/cpu: User Mode Instruction Prevention (UMIP) activated367second # [ 0.220668] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127368test # [ 0.220087] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127369second # [ 0.221568] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0370test # [ 0.220973] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0371second # [ 0.222571] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto372test # [ 0.222975] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto373second # [ 0.224568] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl374test # [ 0.223973] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl375second # [ 0.226568] Spectre V2 : Mitigation: Enhanced / Automatic IBRS376test # [ 0.224973] Spectre V2 : Mitigation: Enhanced / Automatic IBRS377second # [ 0.227568] Speculative Return Stack Overflow: Mitigation: Safe RET378test # [ 0.226919] Speculative Return Stack Overflow: Mitigation: Safe RET379second # [ 0.229568] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization380test # [ 0.227973] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization381second # [ 0.230573] Spectre V2 : Enabling IBPB for BPF382test # [ 0.228978] Spectre V2 : Enabling IBPB for BPF383second # [ 0.232569] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier384test # [ 0.230974] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier385second # [ 0.233568] active return thunk: srso_alias_return_thunk386test # [ 0.231973] active return thunk: srso_alias_return_thunk387second # [ 0.235589] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'388test # [ 0.232993] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'389second # [ 0.236568] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'390test # [ 0.233973] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'391second # [ 0.237568] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'392test # [ 0.235973] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'393second # [ 0.239568] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'394test # [ 0.236973] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'395second # [ 0.240568] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'396test # [ 0.237973] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'397second # [ 0.241568] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'398test # [ 0.238973] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'399second # [ 0.242568] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'400test # [ 0.239973] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'401second # [ 0.244568] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'402test # [ 0.240973] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'403second # [ 0.245568] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'404test # [ 0.241973] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'405second # [ 0.247568] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256406test # [ 0.242973] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256407second # [ 0.248568] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64408test # [ 0.244973] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64409second # [ 0.250568] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512410test # [ 0.245973] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512411second # [ 0.251568] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024412test # [ 0.246973] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024413second # [ 0.252568] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8414test # [ 0.247973] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8415second # [ 0.253568] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16416test # [ 0.248973] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16417second # [ 0.255568] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24418test # [ 0.250973] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24419second # [ 0.256568] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.420test # [ 0.251973] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.421second # [ 0.281547] Freeing SMP alternatives memory: 48K422test # [ 0.276804] Freeing SMP alternatives memory: 48K423second # [ 0.282307] pid_max: default: 32768 minimum: 301424test # [ 0.277713] pid_max: default: 32768 minimum: 301425second # [ 0.283353] LSM: initializing lsm=capability,landlock,yama,bpf,ima426test # [ 0.278035] LSM: initializing lsm=capability,landlock,yama,bpf,ima427second # [ 0.284660] landlock: Up and running.428test # [ 0.280051] landlock: Up and running.429second # [ 0.285568] Yama: becoming mindful.430test # [ 0.280826] Yama: becoming mindful.431second # [ 0.286474] LSM support for eBPF active432test # [ 0.281689] LSM support for eBPF active433second # [ 0.287247] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)434test # [ 0.282043] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)435second # [ 0.288586] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)436test # [ 0.282990] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)437test # [ 0.285446] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)438second # [ 0.291269] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)439test # [ 0.286368] Performance Events: Fam17h+ core perfctr, AMD PMU driver.440second # [ 0.291978] Performance Events: Fam17h+ core perfctr, AMD PMU driver.441test # [ 0.286976] ... version: 2442second # [ 0.292572] ... version: 2443test # [ 0.287851] ... bit width: 48444second # [ 0.293522] ... bit width: 48445test # [ 0.288666] ... generic counters: 6446second # [ 0.294321] ... generic counters: 6447test # [ 0.288983] ... generic bitmap: 000000000000003f448second # [ 0.294607] ... generic bitmap: 000000000000003f449test # [ 0.289974] ... fixed-purpose counters: 0450second # [ 0.295570] ... fixed-purpose counters: 0451test # [ 0.290861] ... fixed-purpose bitmap: 0000000000000000452second # [ 0.296518] ... fixed-purpose bitmap: 0000000000000000453test # [ 0.291867] ... value mask: 0000ffffffffffff454second # [ 0.297522] ... value mask: 0000ffffffffffff455test # [ 0.292855] ... max period: 00007fffffffffff456second # [ 0.298513] ... max period: 00007fffffffffff457test # [ 0.293865] ... global_ctrl mask: 000000000000003f458second # [ 0.299530] ... global_ctrl mask: 000000000000003f459test # [ 0.294943] signal: max sigframe size: 3376460second # [ 0.300603] signal: max sigframe size: 3376461test # [ 0.295727] rcu: Hierarchical SRCU implementation.462test # [ 0.295977] rcu: Max phase no-delay instances is 400.463second # [ 0.301623] rcu: Hierarchical SRCU implementation.464second # [ 0.302573] rcu: Max phase no-delay instances is 400.465test # [ 0.299909] smp: Bringing up secondary CPUs ...466test # [ 0.300708] smp: Brought up 1 node, 1 CPU467second # [ 0.306734] smp: Bringing up secondary CPUs ...468test # [ 0.300975] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)469second # [ 0.307582] smp: Brought up 1 node, 1 CPU470second # [ 0.308491] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)471test # [ 0.302092] Memory: 941876K/1048024K available (18120K kernel code, 2728K rwdata, 13640K rodata, 3656K init, 3632K bss, 98712K reserved, 0K cma-reserved)472test # [ 0.303112] devtmpfs: initialized473second # [ 0.309695] Memory: 941880K/1048024K available (18120K kernel code, 2728K rwdata, 13640K rodata, 3656K init, 3632K bss, 98708K reserved, 0K cma-reserved)474test # [ 0.303988] x86/mm: Memory block size: 128MB475second # [ 0.310723] devtmpfs: initialized476second # [ 0.311632] x86/mm: Memory block size: 128MB477test # [ 0.305518] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)478test # [ 0.305994] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).479second # [ 0.313303] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)480test # [ 0.307048] pinctrl core: initialized pinctrl subsystem481test # [ 0.308226] PM: RTC time: 00:02:49, date: 2026-10-03482second # [ 0.314598] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).483second # [ 0.315634] pinctrl core: initialized pinctrl subsystem484second # [ 0.316825] PM: RTC time: 00:02:49, date: 2026-10-03485test # [ 0.310842] NET: Registered PF_NETLINK/PF_ROUTE protocol family486test # [ 0.312185] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations487second # [ 0.319608] NET: Registered PF_NETLINK/PF_ROUTE protocol family488test # [ 0.312989] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations489second # [ 0.320815] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations490test # [ 0.314075] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations491test # [ 0.314981] audit: initializing netlink subsys (disabled)492second # [ 0.321585] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations493test # [ 0.316184] thermal_sys: Registered thermal governor 'fair_share'494second # [ 0.322674] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations495test # [ 0.316186] thermal_sys: Registered thermal governor 'bang_bang'496second # [ 0.323576] audit: initializing netlink subsys (disabled)497test # [ 0.316975] thermal_sys: Registered thermal governor 'step_wise'498second # [ 0.324775] thermal_sys: Registered thermal governor 'fair_share'499test # [ 0.317977] audit: type=2000 audit(1790985770.191:1): state=initialized audit_enabled=0 res=1500second # [ 0.324776] thermal_sys: Registered thermal governor 'bang_bang'501test # [ 0.319976] thermal_sys: Registered thermal governor 'user_space'502second # [ 0.325572] audit: type=2000 audit(1790985770.200:1): state=initialized audit_enabled=0 res=1503test # [ 0.319977] thermal_sys: Registered thermal governor 'power_allocator'504second # [ 0.327571] thermal_sys: Registered thermal governor 'step_wise'505test # [ 0.320997] cpuidle: using governor menu506second # [ 0.327572] thermal_sys: Registered thermal governor 'user_space'507second # [ 0.328569] thermal_sys: Registered thermal governor 'power_allocator'508test # [ 0.323611] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5509second # [ 0.329597] cpuidle: using governor menu510test # [ 0.324269] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]511second # [ 0.332191] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5512test # [ 0.324977] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry513test # [ 0.325993] PCI: Using configuration type 1 for base access514second # [ 0.332808] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]515second # [ 0.333571] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry516test # [ 0.327118] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.517second # [ 0.334579] PCI: Using configuration type 1 for base access518second # [ 0.335707] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.519test # [ 0.334161] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages520test # [ 0.334974] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page521second # [ 0.342588] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages522second # [ 0.343569] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page523test # [ 0.339974] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages524test # [ 0.340975] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page525second # [ 0.348569] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages526second # [ 0.349570] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page527test # [ 0.348201] ACPI: Added _OSI(Module Device)528test # [ 0.348975] ACPI: Added _OSI(Processor Device)529test # [ 0.349887] ACPI: Added _OSI(Processor Aggregator Device)530second # [ 0.356195] ACPI: Added _OSI(Module Device)531second # [ 0.356570] ACPI: Added _OSI(Processor Device)532second # [ 0.357480] ACPI: Added _OSI(Processor Aggregator Device)533test # [ 0.354802] ACPI: 1 ACPI AML tables successfully acquired and loaded534second # [ 0.364248] ACPI: 1 ACPI AML tables successfully acquired and loaded535test # [ 0.360481] ACPI: Interpreter enabled536test # [ 0.360986] ACPI: PM: (supports S0 S3 S4 S5)537test # [ 0.361857] ACPI: Using IOAPIC for interrupt routing538second # [ 0.367334] ACPI: Interpreter enabled539second # [ 0.367581] ACPI: PM: (supports S0 S3 S4 S5)540test # [ 0.362799] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug541second # [ 0.368465] ACPI: Using IOAPIC for interrupt routing542test # [ 0.363975] PCI: Using E820 reservations for host bridge windows543second # [ 0.369421] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug544test # [ 0.365084] ACPI: Enabled 2 GPEs in block 00 to 3F545second # [ 0.371267] PCI: Using E820 reservations for host bridge windows546second # [ 0.371678] ACPI: Enabled 2 GPEs in block 00 to 3F547test # [ 0.369058] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])548test # [ 0.369978] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]549second # [ 0.375672] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])550test # [ 0.371032] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]551second # [ 0.376573] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]552test # [ 0.372067] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]553test # [ 0.373369] PCI host bridge to bus 0000:00554second # [ 0.377627] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]555test # [ 0.373978] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]556second # [ 0.378663] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]557test # [ 0.374975] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]558second # [ 0.379947] PCI host bridge to bus 0000:00559test # [ 0.375975] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]560second # [ 0.380575] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]561second # [ 0.381571] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]562test # [ 0.376975] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]563second # [ 0.382570] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]564test # [ 0.377975] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]565second # [ 0.383571] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]566test # [ 0.378975] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]567test # [ 0.379975] pci_bus 0000:00: root bus resource [bus 00-ff]568second # [ 0.384570] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]569test # [ 0.381081] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint570second # [ 0.385574] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]571second # [ 0.386570] pci_bus 0000:00: root bus resource [bus 00-ff]572test # [ 0.382599] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint573second # [ 0.387684] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint574second # [ 0.389195] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint575test # [ 0.384895] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]576test # [ 0.385994] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]577test # [ 0.387012] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]578second # [ 0.391508] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]579second # [ 0.392593] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]580test # [ 0.388131] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]581second # [ 0.393613] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]582test # [ 0.389661] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint583second # [ 0.394727] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]584test # [ 0.390984] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]585second # [ 0.396265] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint586test # [ 0.391984] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]587test # [ 0.393012] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]588second # [ 0.398580] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]589test # [ 0.393984] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]590second # [ 0.399585] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]591second # [ 0.400610] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]592test # [ 0.395813] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint593second # [ 0.401584] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]594test # [ 0.398598] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]595second # [ 0.403539] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint596test # [ 0.399017] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]597test # [ 0.400012] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]598second # [ 0.406294] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]599second # [ 0.406585] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]600test # [ 0.401961] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint601second # [ 0.407613] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]602test # [ 0.403984] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]603second # [ 0.409436] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint604test # [ 0.404985] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]605test # [ 0.406012] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]606second # [ 0.411580] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]607test # [ 0.407837] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint608second # [ 0.412583] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]609second # [ 0.413608] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]610test # [ 0.409984] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]611test # [ 0.410985] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]612second # [ 0.415433] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint613test # [ 0.412012] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]614test # [ 0.412984] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]615second # [ 0.417580] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]616second # [ 0.418584] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]617test # [ 0.414822] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint618second # [ 0.419612] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]619second # [ 0.420584] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]620test # [ 0.416788] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]621test # [ 0.417974] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]622second # [ 0.422428] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint623test # [ 0.419831] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint624second # [ 0.424511] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]625second # [ 0.425563] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]626test # [ 0.421868] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]627test # [ 0.423012] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]628second # [ 0.427424] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint629test # [ 0.424894] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint630second # [ 0.429965] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]631test # [ 0.426775] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]632second # [ 0.430612] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]633test # [ 0.427956] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]634second # [ 0.432481] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint635test # [ 0.429822] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint636second # [ 0.434528] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]637test # [ 0.431726] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]638second # [ 0.435569] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]639test # [ 0.432012] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]640second # [ 0.437425] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint641test # [ 0.433823] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint642second # [ 0.439494] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]643test # [ 0.435994] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]644second # [ 0.440569] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]645test # [ 0.436984] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]646test # [ 0.438012] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]647second # [ 0.442425] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint648test # [ 0.439815] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint649second # [ 0.444588] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]650second # [ 0.445584] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]651test # [ 0.441931] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]652test # [ 0.442815] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]653second # [ 0.446610] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]654test # [ 0.443957] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]655second # [ 0.448427] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint656test # [ 0.445856] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint657second # [ 0.450580] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]658test # [ 0.447590] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]659second # [ 0.451583] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]660second # [ 0.452609] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]661second # [ 0.454449] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint662second # [ 0.456182] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]663test # [ 0.448221] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint664test # [ 0.450633] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]665test # [ 0.451219] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint666test # [ 0.452603] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]667second # [ 0.456816] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint668test # [ 0.453262] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint669second # [ 0.459193] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]670test # [ 0.454601] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]671second # [ 0.459832] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint672test # [ 0.455312] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint673second # [ 0.461217] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]674test # [ 0.456447] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO675second # [ 0.461865] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint676test # [ 0.457312] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint677second # [ 0.463260] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]678test # [ 0.458763] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]679second # [ 0.463887] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint680test # [ 0.458985] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]681second # [ 0.465042] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO682test # [ 0.460435] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint683second # [ 0.465895] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint684test # [ 0.461594] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]685second # [ 0.467433] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]686second # [ 0.468413] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]687second # [ 0.470030] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint688test # [ 0.466483] ACPI: PCI: Interrupt link LNKA configured for IRQ 10689second # [ 0.471184] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]690test # [ 0.467091] ACPI: PCI: Interrupt link LNKB configured for IRQ 10691test # [ 0.468107] ACPI: PCI: Interrupt link LNKC configured for IRQ 11692test # [ 0.469097] ACPI: PCI: Interrupt link LNKD configured for IRQ 11693test # [ 0.470086] ACPI: PCI: Interrupt link LNKE configured for IRQ 10694second # [ 0.476063] ACPI: PCI: Interrupt link LNKA configured for IRQ 10695test # [ 0.471087] ACPI: PCI: Interrupt link LNKF configured for IRQ 10696second # [ 0.476688] ACPI: PCI: Interrupt link LNKB configured for IRQ 10697test # [ 0.472088] ACPI: PCI: Interrupt link LNKG configured for IRQ 11698second # [ 0.477680] ACPI: PCI: Interrupt link LNKC configured for IRQ 11699test # [ 0.473084] ACPI: PCI: Interrupt link LNKH configured for IRQ 11700second # [ 0.478682] ACPI: PCI: Interrupt link LNKD configured for IRQ 11701test # [ 0.474026] ACPI: PCI: Interrupt link GSIA configured for IRQ 16702second # [ 0.479686] ACPI: PCI: Interrupt link LNKE configured for IRQ 10703test # [ 0.474986] ACPI: PCI: Interrupt link GSIB configured for IRQ 17704second # [ 0.480689] ACPI: PCI: Interrupt link LNKF configured for IRQ 10705test # [ 0.475986] ACPI: PCI: Interrupt link GSIC configured for IRQ 18706test # [ 0.476987] ACPI: PCI: Interrupt link GSID configured for IRQ 19707second # [ 0.481683] ACPI: PCI: Interrupt link LNKG configured for IRQ 11708test # [ 0.477990] ACPI: PCI: Interrupt link GSIE configured for IRQ 20709second # [ 0.482691] ACPI: PCI: Interrupt link LNKH configured for IRQ 11710test # [ 0.478989] ACPI: PCI: Interrupt link GSIF configured for IRQ 21711second # [ 0.483617] ACPI: PCI: Interrupt link GSIA configured for IRQ 16712test # [ 0.479986] ACPI: PCI: Interrupt link GSIG configured for IRQ 22713second # [ 0.484588] ACPI: PCI: Interrupt link GSIB configured for IRQ 17714test # [ 0.480989] ACPI: PCI: Interrupt link GSIH configured for IRQ 23715second # [ 0.485586] ACPI: PCI: Interrupt link GSIC configured for IRQ 18716second # [ 0.486583] ACPI: PCI: Interrupt link GSID configured for IRQ 19717test # [ 0.482778] iommu: Default domain type: Translated718second # [ 0.487585] ACPI: PCI: Interrupt link GSIE configured for IRQ 20719test # [ 0.483753] iommu: DMA domain TLB invalidation policy: lazy mode720second # [ 0.488582] ACPI: PCI: Interrupt link GSIF configured for IRQ 21721test # [ 0.485199] ACPI: bus type USB registered722second # [ 0.489582] ACPI: PCI: Interrupt link GSIG configured for IRQ 22723test # [ 0.486027] usbcore: registered new interface driver usbfs724second # [ 0.490582] ACPI: PCI: Interrupt link GSIH configured for IRQ 23725test # [ 0.486990] usbcore: registered new interface driver hub726test # [ 0.487983] usbcore: registered new device driver usb727second # [ 0.492374] iommu: Default domain type: Translated728test # [ 0.489574] NetLabel: Initializing729second # [ 0.493508] iommu: DMA domain TLB invalidation policy: lazy mode730test # [ 0.489978] NetLabel: domain hash size = 128731second # [ 0.494774] ACPI: bus type USB registered732test # [ 0.490893] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO733second # [ 0.495621] usbcore: registered new interface driver usbfs734test # [ 0.491915] NetLabel: unlabeled traffic allowed by default735test # [ 0.492875] PCI: Using ACPI for IRQ routing736second # [ 0.496585] usbcore: registered new interface driver hub737second # [ 0.497579] usbcore: registered new device driver usb738second # [ 0.499205] NetLabel: Initializing739second # [ 0.499574] NetLabel: domain hash size = 128740second # [ 0.500477] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO741second # [ 0.501508] NetLabel: unlabeled traffic allowed by default742second # [ 0.502496] PCI: Using ACPI for IRQ routing743test # [ 0.568438] pci 0000:00:01.0: vgaarb: setting as boot VGA device744test # [ 0.568971] pci 0000:00:01.0: vgaarb: bridge control possible745test # [ 0.568971] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none746test # [ 0.568977] vgaarb: loaded747test # [ 0.569767] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0748test # [ 0.570760] hpet0: 3 comparators, 64-bit 100.000000 MHz counter749second # [ 0.577721] pci 0000:00:01.0: vgaarb: setting as boot VGA device750second # [ 0.578566] pci 0000:00:01.0: vgaarb: bridge control possible751second # [ 0.578566] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none752second # [ 0.578572] vgaarb: loaded753test # [ 0.574037] clocksource: Switched to clocksource kvm-clock754second # [ 0.579355] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0755test # [ 0.575678] VFS: Disk quotas dquot_6.6.0756second # [ 0.580351] hpet0: 3 comparators, 64-bit 100.000000 MHz counter757test # [ 0.577840] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)758test # [ 0.579409] pnp: PnP ACPI init759test # [ 0.580252] ACPI: IRQ 4 override to edge(!), high(!)760second # [ 0.584650] clocksource: Switched to clocksource kvm-clock761test # [ 0.581365] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved762test # [ 0.583147] pnp: PnP ACPI: found 5 devices763second # [ 0.586311] VFS: Disk quotas dquot_6.6.0764second # [ 0.588475] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)765second # [ 0.589987] pnp: PnP ACPI init766second # [ 0.590834] ACPI: IRQ 4 override to edge(!), high(!)767second # [ 0.591940] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved768second # [ 0.593727] pnp: PnP ACPI: found 5 devices769test # [ 0.590232] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns770test # [ 0.591965] clocksource: Switched to clocksource acpi_pm771test # [ 0.593145] NET: Registered PF_INET protocol family772test # [ 0.594302] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)773second # [ 0.600816] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns774second # [ 0.602559] clocksource: Switched to clocksource acpi_pm775second # [ 0.603734] NET: Registered PF_INET protocol family776second # [ 0.604902] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)777test # [ 0.607228] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)778test # [ 0.608982] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)779test # [ 0.610587] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)780test # [ 0.612149] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)781test # [ 0.613624] TCP: Hash tables configured (established 8192 bind 8192)782second # [ 0.617897] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)783test # [ 0.614951] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)784test # [ 0.616489] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)785second # [ 0.619694] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)786test # [ 0.617831] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)787second # [ 0.621243] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)788test # [ 0.619266] NET: Registered PF_UNIX/PF_LOCAL protocol family789second # [ 0.622801] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)790test # [ 0.620469] NET: Registered PF_XDP protocol family791second # [ 0.624280] TCP: Hash tables configured (established 8192 bind 8192)792test # [ 0.621487] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]793test # [ 0.622721] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]794second # [ 0.625594] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)795test # [ 0.623963] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]796second # [ 0.627161] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)797test # [ 0.625347] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]798second # [ 0.628508] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)799second # [ 0.629961] NET: Registered PF_UNIX/PF_LOCAL protocol family800test # [ 0.626697] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]801second # [ 0.631131] NET: Registered PF_XDP protocol family802test # [ 0.628053] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]803second # [ 0.632154] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]804test # [ 0.629961] ACPI: \_SB_.GSIA: Enabled at IRQ 16805second # [ 0.633392] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]806test # [ 0.631861] ACPI: \_SB_.GSIB: Enabled at IRQ 17807second # [ 0.634627] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]808second # [ 0.636016] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]809test # [ 0.633697] ACPI: \_SB_.GSIC: Enabled at IRQ 18810second # [ 0.637364] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]811test # [ 0.635522] ACPI: \_SB_.GSID: Enabled at IRQ 19812second # [ 0.638714] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]813test # [ 0.637166] PCI: CLS 0 bytes, default 64814second # [ 0.640572] ACPI: \_SB_.GSIA: Enabled at IRQ 16815test # [ 0.638194] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns816second # [ 0.642596] ACPI: \_SB_.GSIB: Enabled at IRQ 17817test # [ 0.640211] Trying to unpack rootfs image as initramfs...818second # [ 0.644551] ACPI: \_SB_.GSIC: Enabled at IRQ 18819second # [ 0.646467] ACPI: \_SB_.GSID: Enabled at IRQ 19820second # [ 0.648200] PCI: CLS 0 bytes, default 64821second # [ 0.649224] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns822second # [ 0.651238] Trying to unpack rootfs image as initramfs...823test # [ 0.676417] Initialise system trusted keyrings824test # [ 0.680149] workingset: timestamp_bits=40 max_order=18 bucket_order=0825second # [ 0.685972] Initialise system trusted keyrings826second # [ 0.689772] workingset: timestamp_bits=40 max_order=18 bucket_order=0827test # [ 0.694630] Key type asymmetric registered828test # [ 0.695544] Asymmetric key parser 'x509' registered829test # [ 0.700151] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)830second # [ 0.704171] Key type asymmetric registered831test # [ 0.701754] io scheduler mq-deadline registered832second # [ 0.705070] Asymmetric key parser 'x509' registered833test # [ 0.705110] io scheduler kyber registered834test # [ 0.706427] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled835second # [ 0.709732] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)836test # [ 0.707963] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A837second # [ 0.712706] io scheduler mq-deadline registered838second # [ 0.713637] io scheduler kyber registered839second # [ 0.717151] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled840test # [ 0.714504] Linux agpgart interface v0.103841test # [ 0.715430] ACPI: bus type drm_connector registered842second # [ 0.718716] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A843test # [ 0.718444] usbcore: registered new interface driver usbserial_generic844test # [ 0.719763] usbserial: USB Serial support registered for generic845second # [ 0.724304] Linux agpgart interface v0.103846second # [ 0.725242] ACPI: bus type drm_connector registered847test # [ 0.724113] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.848second # [ 0.728035] usbcore: registered new interface driver usbserial_generic849test # [ 0.724113] Please enable it if your BIOS has the CPPC option.850second # [ 0.729346] usbserial: USB Serial support registered for generic851test # [ 0.726773] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled852test # [ 0.730206] drop_monitor: Initializing network drop monitor service853second # [ 0.733678] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.854test # [ 0.731595] NET: Registered PF_INET6 protocol family855second # [ 0.733678] Please enable it if your BIOS has the CPPC option.856second # [ 0.736351] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled857test # [ 0.735485] Segment Routing with IPv6858second # [ 0.739784] drop_monitor: Initializing network drop monitor service859second # [ 0.741270] NET: Registered PF_INET6 protocol family860test # [ 0.739127] In-situ OAM (IOAM) with IPv6861test # [ 0.740289] IPI shorthand broadcast: enabled862second # [ 0.745061] Segment Routing with IPv6863second # [ 0.748678] In-situ OAM (IOAM) with IPv6864test # [ 0.745642] sched_clock: Marking stable (572020916, 173072362)->(828237875, -83144597)865second # [ 0.749825] IPI shorthand broadcast: enabled866test # [ 0.751336] registered taskstats version 1867test # [ 0.752374] Loading compiled-in X.509 certificates868second # [ 0.755160] sched_clock: Marking stable (582021197, 172637063)->(834644452, -79986192)869second # [ 0.761939] registered taskstats version 1870second # [ 0.762979] Loading compiled-in X.509 certificates871test # [ 0.766840] Demotion targets for Node 0: null872test # [ 0.770137] Key type .fscrypt registered873test # [ 0.770986] Key type fscrypt-provisioning registered874test # [ 0.774181] ima: No TPM chip found, activating TPM-bypass!875test # [ 0.775329] ima: Allocated hash algorithm: sha1876second # [ 0.778668] Demotion targets for Node 0: null877second # [ 0.779749] Key type .fscrypt registered878second # [ 0.780601] Key type fscrypt-provisioning registered879test # [ 0.778157] ima: No architecture policies found880second # [ 0.783770] ima: No TPM chip found, activating TPM-bypass!881test # [ 0.781106] PM: Magic number: 14:207:0882second # [ 0.784914] ima: Allocated hash algorithm: sha1883test # [ 0.782650] RAS: Correctable Errors collector initialized.884second # [ 0.787696] ima: No architecture policies found885second # [ 0.790670] PM: Magic number: 14:207:0886second # [ 0.792209] RAS: Correctable Errors collector initialized.887test # [ 0.790890] clk: Disabling unused clocks888test # [ 0.793105] PM: genpd: Disabling unused power domains889second # [ 0.800483] clk: Disabling unused clocks890second # [ 0.803675] PM: genpd: Disabling unused power domains891test # [ 0.894629] Freeing initrd memory: 30212K892test # [ 0.897371] Freeing unused decrypted memory: 2028K893test # [ 0.899799] Freeing unused kernel image (initmem) memory: 3656K894test # [ 0.901220] Write protecting the kernel read-only data: 32768k895second # [ 0.905315] Freeing initrd memory: 30208K896test # [ 0.902667] Freeing unused kernel image (text/rodata gap) memory: 308K897test # [ 0.904314] Freeing unused kernel image (rodata/data gap) memory: 696K898second # [ 0.908014] Freeing unused decrypted memory: 2028K899second # [ 0.910450] Freeing unused kernel image (initmem) memory: 3656K900second # [ 0.911755] Write protecting the kernel read-only data: 32768k901second # [ 0.913189] Freeing unused kernel image (text/rodata gap) memory: 308K902second # [ 0.914834] Freeing unused kernel image (rodata/data gap) memory: 696K903test # [ 0.936779] x86/mm: Checked W+X mappings: passed, no W+X pages found.904test # [ 0.938122] Run /init as init process905second # [ 0.947263] x86/mm: Checked W+X mappings: passed, no W+X pages found.906second # [ 0.948567] Run /init as init process907test # [ 0.946261] systemd[1]: Inserted module 'autofs4'908second # [ 0.956828] systemd[1]: Inserted module 'autofs4'909test # [ 0.961103] fuse: init (API version 7.45)910test # [ 0.966773] ACPI: \_SB_.GSIG: Enabled at IRQ 22911second # [ 0.971573] fuse: init (API version 7.45)912test # [ 0.969351] ACPI: \_SB_.GSIH: Enabled at IRQ 23913test # [ 0.972498] ACPI: \_SB_.GSIE: Enabled at IRQ 20914second # [ 0.977289] ACPI: \_SB_.GSIG: Enabled at IRQ 22915test # [ 0.974688] ACPI: \_SB_.GSIF: Enabled at IRQ 21916second # [ 0.979831] ACPI: \_SB_.GSIH: Enabled at IRQ 23917second # [ 0.982913] ACPI: \_SB_.GSIE: Enabled at IRQ 20918test # [ 0.979992] virtiofs virtio5: discovered new tag: nix-store919second # [ 0.985346] ACPI: \_SB_.GSIF: Enabled at IRQ 21920test # [ 0.982031] virtiofs virtio5: virtio_fs_setup_dax: No cache capability921second # [ 0.990620] virtiofs virtio5: discovered new tag: nix-store922test # [ 0.989314] virtiofs virtio6: discovered new tag: shared923second # [ 0.992689] virtiofs virtio5: virtio_fs_setup_dax: No cache capability924test # [ 0.991372] virtiofs virtio6: virtio_fs_setup_dax: No cache capability925test # [ 0.994904] virtiofs virtio7: discovered new tag: xchg926second # [ 0.999945] virtiofs virtio6: discovered new tag: shared927test # [ 0.996962] virtiofs virtio7: virtio_fs_setup_dax: No cache capability928second # [ 1.001965] virtiofs virtio6: virtio_fs_setup_dax: No cache capability929second # [ 1.005310] virtiofs virtio7: discovered new tag: xchg930second # [ 1.007293] virtiofs virtio7: virtio_fs_setup_dax: No cache capability931test # [ 1.015410] systemd[1]: Successfully made /usr/ read-only.932second # [ 1.025972] systemd[1]: Successfully made /usr/ read-only.933test # [ 1.351304] 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.357207] systemd[1]: Detected virtualization kvm.935test # [ 1.358271] systemd[1]: Detected architecture x86-64.936test # [ 1.359354] systemd[1]: Running in initrd.937test # [ 1.360483] systemd[1]: Initializing machine ID from random generator.938test # [ 1.361898] systemd[1]: Hostname set to <test>.939second # [ 1.362014] 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.368961] systemd[1]: Detected virtualization kvm.941second # [ 1.370206] systemd[1]: Detected architecture x86-64.942second # [ 1.371258] systemd[1]: Running in initrd.943second # [ 1.372379] systemd[1]: Initializing machine ID from random generator.944second # [ 1.373771] systemd[1]: Hostname set to <second>.945test # [ 1.413664] systemd[1]: bpf-restrict-fs: LSM BPF program attached946second # [ 1.426467] systemd[1]: bpf-restrict-fs: LSM BPF program attached947test # [ 1.442431] systemd[1]: Queued start job for default target Initrd Default Target.948test # [ 1.446224] systemd[1]: Created slice Slice /system/modprobe.949test # [ 1.447624] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.950test # [ 1.449315] systemd[1]: Expecting device /dev/disk/by-label/nixos...951test # [ 1.450668] systemd[1]: Reached target Path Units.952test # [ 1.451759] systemd[1]: Reached target Slice Units.953second # [ 1.454716] systemd[1]: Queued start job for default target Initrd Default Target.954test # [ 1.452849] systemd[1]: Reached target Swaps.955test # [ 1.453849] systemd[1]: Reached target Timer Units.956test # [ 1.455027] systemd[1]: Listening on D-Bus System Message Bus Socket.957second # [ 1.458790] systemd[1]: Created slice Slice /system/modprobe.958test # [ 1.456519] systemd[1]: Listening on Journal Socket (/dev/log).959second # [ 1.460198] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.960test # [ 1.457924] systemd[1]: Listening on Journal Sockets.961second # [ 1.461871] systemd[1]: Expecting device /dev/disk/by-label/nixos...962second # [ 1.463237] systemd[1]: Reached target Path Units.963second # [ 1.464318] systemd[1]: Reached target Slice Units.964second # [ 1.465429] systemd[1]: Reached target Swaps.965second # [ 1.466448] systemd[1]: Reached target Timer Units.966second # [ 1.467670] systemd[1]: Listening on D-Bus System Message Bus Socket.967second # [ 1.469141] systemd[1]: Listening on Journal Socket (/dev/log).968test # [ 1.459175] systemd[1]: Listening on udev Control Socket.969second # [ 1.470566] systemd[1]: Listening on Journal Sockets.970test # [ 1.468552] systemd[1]: Listening on udev Kernel Socket.971test # [ 1.469738] systemd[1]: Reached target Socket Units.972test # [ 1.471751] systemd[1]: Starting Create List of Static Device Nodes...973second # [ 1.471805] systemd[1]: Listening on udev Control Socket.974test # [ 1.477172] systemd[1]: Starting Load Kernel Module configfs...975second # [ 1.481691] systemd[1]: Listening on udev Kernel Socket.976second # [ 1.482877] systemd[1]: Reached target Socket Units.977second # [ 1.484930] systemd[1]: Starting Create List of Static Device Nodes...978second # [ 1.489486] systemd[1]: Starting Load Kernel Module configfs...979test # [ 1.488490] systemd[1]: Starting Journal Service...980second # [ 1.496957] systemd[1]: Starting Journal Service...981test # [ 1.495143] systemd[1]: Starting Load Kernel Modules...982test # [ 1.497872] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os983second # [ 1.503706] systemd[1]: Starting Load Kernel Modules...984second # [ 1.507153] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os985test # [ 1.504747] systemd[1]: Starting Coldplug All udev Devices...986second # [ 1.512775] systemd[1]: Starting Coldplug All udev Devices...987test # [ 1.519427] systemd[1]: Finished Create List of Static Device Nodes.988second # [ 1.525728] systemd[1]: Finished Create List of Static Device Nodes.989test # [ 1.525678] systemd[1]: modprobe@configfs.service: Deactivated successfully.990second # [ 1.531190] systemd[1]: modprobe@configfs.service: Deactivated successfully.991test # [ 1.528537] systemd-journald[65]: Collecting audit messages is disabled.992test # [ 1.533612] systemd[1]: Finished Load Kernel Module configfs.993second # [ 1.539722] systemd[1]: Finished Load Kernel Module configfs.994test # [ 1.539548] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.995second # [ 1.544117] systemd-journald[65]: Collecting audit messages is disabled.996test # [ 1.542582] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config997second # [ 1.547245] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config998second # [ 1.551175] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.999test # [ 1.551196] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1000test # [ 1.555243] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1001second # [ 1.559723] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1002second # [ 1.561664] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1003test # [ 1.580617] systemd[1]: Finished Load Kernel Modules.1004second # [ 1.589257] systemd[1]: Finished Load Kernel Modules.1005test # [ 1.588792] systemd[1]: Starting Apply Kernel Variables...1006second # [ 1.596706] systemd[1]: Starting Apply Kernel Variables...1007test # [ 1.598215] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1008second # [ 1.607042] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1009test # [ 1.610203] systemd[1]: Starting Create Static Device Nodes in /dev...1010second # [ 1.618490] systemd[1]: Starting Create Static Device Nodes in /dev...1011test # [ 1.621193] systemd[1]: Finished Apply Kernel Variables.1012second # [ 1.629037] systemd[1]: Finished Apply Kernel Variables.1013test # [ 1.631687] systemd[1]: Finished Create Static Device Nodes in /dev.1014test # [ 1.637332] systemd[1]: Reached target Preparation for Local File Systems.1015second # [ 1.640707] systemd[1]: Finished Create Static Device Nodes in /dev.1016test # [ 1.641145] systemd[1]: Reached target Local File Systems.1017second # [ 1.645896] systemd[1]: Reached target Preparation for Local File Systems.1018test # [ 1.647129] systemd[1]: Starting Rule-based Manager for Device Events and Files...1019second # [ 1.650722] systemd[1]: Reached target Local File Systems.1020second # [ 1.657701] systemd[1]: Starting Rule-based Manager for Device Events and Files...1021test # [ 1.489557] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.665162] systemd[1]: Started Journal Service.1022test # 1023test # [ 1.494401] systemd-modules-load[66]: Inserted module 'virtio_balloon'1024test # [ 1.495688] systemd-modules-load[66]: Inserted module 'virtio_gpu'1025second # [ 1.676728] systemd[1]: Started Journal Service.1026second # [ 1.506205] systemd-modules-load[66]: Inserted module 'dm_mod'1027test # [ 1.503205] systemd[1]: Starting Create System Files and Directories...1028second # [ 1.511047] systemd-modules-load[66]: Inserted module 'virtio_balloon'1029second # [ 1.512366] systemd-modules-load[66]: Inserted module 'virtio_gpu'1030second # [ 1.523219] systemd[1]: Starting Create System Files and Directories...1031test # [ 1.527189] systemd-udevd[73]: Using default interface naming scheme 'v261'.1032test # [ 1.531168] systemd[1]: Finished Create System Files and Directories.1033second # [ 1.538203] systemd-udevd[73]: Using default interface naming scheme 'v261'.1034second # [ 1.547178] systemd[1]: Finished Create System Files and Directories.1035test # [ 1.552071] systemd[1]: Started Rule-based Manager for Device Events and Files.1036second # [ 1.566074] systemd[1]: Started Rule-based Manager for Device Events and Files.1037test # [ 1.565146] systemd[1]: Finished Coldplug All udev Devices.1038test # [ 1.566527] systemd[1]: Reached target System Initialization.1039test # [ 1.568292] systemd[1]: Reached target Basic System.1040second # [ 1.576074] systemd[1]: Finished Coldplug All udev Devices.1041second # [ 1.578628] systemd[1]: Reached target System Initialization.1042second # [ 1.579685] systemd[1]: Reached target Basic System.1043second # [ 1.944295] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121044test # [ 1.948290] virtio_blk virtio2: 1/0/0 default/read/poll queues1045second # [ 1.953463] virtio_blk virtio2: 1/0/0 default/read/poll queues1046second # [ 1.955286] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1047test # [ 1.953125] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1048test # [ 1.958915] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121049second # [ 1.962825] ehci-pci 0000:00:1d.7: EHCI Host Controller1050second # [ 1.963828] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11051second # [ 1.965282] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001052test # [ 1.967649] serio: i8042 KBD port at 0x60,0x64 irq 11053test # [ 1.968494] serio: i8042 AUX port at 0x60,0x64 irq 121054second # [ 1.971844] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001055second # [ 1.973130] serio: i8042 KBD port at 0x60,0x64 irq 11056test # [ 1.970361] ehci-pci 0000:00:1d.7: EHCI Host Controller1057test # [ 1.971244] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11058second # [ 1.974116] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181059second # [ 1.975547] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11060test # [ 1.973263] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001061second # [ 1.979493] serio: i8042 AUX port at 0x60,0x64 irq 121062second # [ 1.980503] usb usb1: Product: EHCI Host Controller1063second # [ 1.981583] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd1064second # [ 1.982839] usb usb1: SerialNumber: 0000:00:1d.71065test # [ 1.980309] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001066second # [ 1.984670] hub 1-0:1.0: USB hub found1067second # [ 1.985495] hub 1-0:1.0: 6 ports detected1068test # [ 1.982772] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181069test # [ 1.985569] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11070second # [ 1.990653] uhci_hcd 0000:00:1d.0: UHCI Host Controller1071second # [ 1.991487] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21072test # [ 1.989067] usb usb1: Product: EHCI Host Controller1073test # [ 1.989839] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd1074test # [ 1.990990] usb usb1: SerialNumber: 0000:00:1d.71075test # [ 1.992140] hub 1-0:1.0: USB hub found1076test # [ 1.993829] hub 1-0:1.0: 6 ports detected1077test # [ 1.996580] uhci_hcd 0000:00:1d.0: UHCI Host Controller1078test # [ 1.997425] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21079second # [ 2.002672] uhci_hcd 0000:00:1d.0: detected 2 ports1080second # [ 2.003575] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801081test # [ 2.011534] uhci_hcd 0000:00:1d.0: detected 2 ports1082second # [ 2.014365] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181083test # [ 2.015417] SCSI subsystem initialized1084test # [ 2.017950] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801085second # [ 2.024693] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11086test # [ 2.021498] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181087test # [ 2.022839] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11088second # [ 2.031935] usb usb2: Product: UHCI Host Controller1089second # [ 2.036848] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd1090test # [ 1.865264] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line.1091test # [ 2.042277] usb usb2: Product: UHCI Host Controller1092second # [ 2.045589] SCSI subsystem initialized1093second # [ 1.875621] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1094second # [ 2.049876] usb usb2: SerialNumber: 0000:00:1d.01095test # [ 1.873733] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1096second # [ 1.879144] systemd[1]: Starting Virtual Console Setup...1097second # [ 1.882634] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1098test # [ 1.880288] systemd[1]: Starting Virtual Console Setup...1099test # [ 2.061185] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd1100second # [ 2.065921] hub 2-0:1.0: USB hub found1101second # [ 2.071947] hub 2-0:1.0: 2 ports detected1102second # [ 2.075753] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01103test # [ 2.075253] usb usb2: SerialNumber: 0000:00:1d.01104second # [ 1.908865] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1105test # [ 1.905918] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.1106second # [ 1.912482] systemd[1]: Finished Virtual Console Setup.1107test # [ 1.909656] systemd[1]: Finished Virtual Console Setup.1108test # [ 2.089685] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01109test # [ 2.091685] hub 2-0:1.0: USB hub found1110test # [ 2.093881] hub 2-0:1.0: 2 ports detected1111second # [ 2.098667] uhci_hcd 0000:00:1d.1: UHCI Host Controller1112second # [ 2.099491] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31113second # [ 2.112114] uhci_hcd 0000:00:1d.1: detected 2 ports1114test # [ 2.109083] uhci_hcd 0000:00:1d.1: UHCI Host Controller1115test # [ 2.109960] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31116second # [ 2.113973] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01117test # [ 1.943327] systemd[1]: Found device /dev/disk/by-label/nixos.1118second # [ 1.947137] systemd[1]: Found device /dev/disk/by-label/nixos.1119test # [ 1.944591] systemd[1]: Reached target Initrd Root Device.1120second # [ 1.948226] systemd[1]: Reached target Initrd Root Device.1121second # [ 1.950068] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1122test # [ 1.947127] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1123test # [ 2.122085] uhci_hcd 0000:00:1d.1: detected 2 ports1124test # [ 2.122970] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01125second # [ 2.125797] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181126second # [ 2.129626] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11127test # [ 2.127187] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181128second # [ 2.132703] usb usb3: Product: UHCI Host Controller1129second # [ 2.133472] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd1130test # [ 2.134083] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11131second # [ 2.138139] usb usb3: SerialNumber: 0000:00:1d.11132test # [ 2.136551] usb usb3: Product: UHCI Host Controller1133second # [ 2.142818] hub 3-0:1.0: USB hub found1134second # [ 2.144364] hub 3-0:1.0: 2 ports detected1135test # [ 2.143270] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd1136second # [ 1.975874] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1137test # [ 2.146777] usb usb3: SerialNumber: 0000:00:1d.11138second # [ 2.151200] uhci_hcd 0000:00:1d.2: UHCI Host Controller1139test # [ 1.975398] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks1140test # [ 1.979438] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1141second # [ 1.983339] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1142test # [ 2.154168] hub 3-0:1.0: USB hub found1143second # [ 2.157175] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41144test # [ 2.157070] hub 3-0:1.0: 2 ports detected1145test # [ 2.159876] uhci_hcd 0000:00:1d.2: UHCI Host Controller1146second # [ 2.163411] uhci_hcd 0000:00:1d.2: detected 2 ports1147test # [ 2.162128] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41148second # [ 2.166199] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01149test # [ 2.164455] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1150test # [ 2.165864] uhci_hcd 0000:00:1d.2: detected 2 ports1151test # [ 2.167209] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01152second # [ 2.170047] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181153test # [ 2.169015] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1154test # [ 2.170791] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181155second # [ 2.174766] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11156test # [ 2.172407] ahci 0000:00:1f.2: flags: 64bit ncq only1157second # [ 2.176187] usb usb4: Product: UHCI Host Controller1158test # [ 2.173635] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11159second # [ 2.178460] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1160second # [ 2.179785] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd1161second # [ 2.181015] usb usb4: SerialNumber: 0000:00:1d.21162second # [ 2.182316] hub 4-0:1.0: USB hub found1163test # [ 2.179300] usb usb4: Product: UHCI Host Controller1164second # [ 2.183410] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1165test # [ 2.181085] scsi host0: ahci1166second # [ 2.184728] ahci 0000:00:1f.2: flags: 64bit ncq only1167test # [ 2.182338] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd1168second # [ 2.185899] hub 4-0:1.0: 2 ports detected1169test # [ 2.183884] scsi host1: ahci1170test # [ 2.184885] scsi host2: ahci1171test # [ 2.188527] usb usb4: SerialNumber: 0000:00:1d.21172test # [ 2.189483] scsi host3: ahci1173test # [ 2.192514] scsi host4: ahci1174second # [ 2.195704] scsi host0: ahci1175test # [ 2.193184] hub 4-0:1.0: USB hub found1176second # [ 2.197069] scsi host1: ahci1177test # [ 2.196099] hub 4-0:1.0: 2 ports detected1178test # [ 2.197367] scsi host5: ahci1179test # [ 2.197982] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11180second # [ 2.202651] scsi host2: ahci1181second # [ 2.205686] scsi host3: ahci1182second # [ 2.208463] scsi host4: ahci1183test # [ 2.208072] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11184second # [ 2.212998] scsi host5: ahci1185second # [ 2.214207] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11186second # [ 2.215478] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11187test # [ 2.213960] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11188second # [ 2.220637] usb 1-1: new high-speed USB device number 2 using ehci-pci1189test # [ 2.218684] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11190second # [ 2.223739] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11191second # [ 2.225097] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11192test # [ 2.222368] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11193second # [ 2.226447] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11194test # [ 2.223744] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11195second # [ 2.227819] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11196test # [ 2.229070] usb 1-1: new high-speed USB device number 2 using ehci-pci1197second # [ 2.350475] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001198second # [ 2.352011] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101199second # [ 2.353738] usb 1-1: Product: QEMU USB Tablet1200second # [ 2.354505] usb 1-1: Manufacturer: QEMU1201second # [ 2.355356] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11202test # [ 2.358965] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001203test # [ 2.360273] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101204test # [ 2.361734] usb 1-1: Product: QEMU USB Tablet1205test # [ 2.362604] usb 1-1: Manufacturer: QEMU1206test # [ 2.363369] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11207second # [ 2.371092] hid: raw HID events driver (C) Jiri Kosina1208test # [ 2.377777] hid: raw HID events driver (C) Jiri Kosina1209test # [ 2.341636] systemd[1]: Mounting /sysroot...1210second # [ 2.350504] systemd[1]: Mounting /sysroot...1211test # [ 2.532285] ata2: SATA link down (SStatus 0 SControl 300)1212test # [ 2.533327] ata4: SATA link down (SStatus 0 SControl 300)1213test # [ 2.534533] ata1: SATA link down (SStatus 0 SControl 300)1214test # [ 2.535643] ata6: SATA link down (SStatus 0 SControl 300)1215test # [ 2.536742] ata5: SATA link down (SStatus 0 SControl 300)1216second # [ 2.540829] ata6: SATA link down (SStatus 0 SControl 300)1217test # [ 2.537866] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1218second # [ 2.541875] ata5: SATA link down (SStatus 0 SControl 300)1219test # [ 2.538975] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001220test # [ 2.539939] ata3.00: applying bridge limits1221second # [ 2.543061] ata1: SATA link down (SStatus 0 SControl 300)1222test # [ 2.540805] ata3.00: configured for UDMA/1001223second # [ 2.544200] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1224second # [ 2.545294] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001225test # [ 2.541918] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51226second # [ 2.546250] ata3.00: applying bridge limits1227second # [ 2.547182] ata2: SATA link down (SStatus 0 SControl 300)1228second # [ 2.548274] ata4: SATA link down (SStatus 0 SControl 300)1229second # [ 2.549335] ata3.00: configured for UDMA/1001230second # [ 2.550430] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51231test # [ 2.585647] usbcore: registered new interface driver usbhid1232test # [ 2.593386] usbhid: USB HID core driver1233second # [ 2.603703] usbcore: registered new interface driver usbhid1234second # [ 2.604556] usbhid: USB HID core driver1235test # [ 2.607948] 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.614274] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01237test # [ 2.619275] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1238second # [ 2.621968] 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/input21239second # [ 2.624116] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1240test # [ 2.622381] EXT4-fs (vda): mounted filesystem 698a4e17-b7e9-4ecb-8f18-4641194b253f r/w with ordered data mode. Quota mode: none.1241second # [ 2.625443] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01242test # [ 2.455450] systemd[1]: Mounted /sysroot.1243second # [ 2.632242] EXT4-fs (vda): mounted filesystem ad6f6042-5dbd-4efa-bd27-c356b63507d9 r/w with ordered data mode. Quota mode: none.1244test # [ 2.457413] systemd[1]: Reached target Initrd Root File System.1245second # [ 2.464617] systemd[1]: Mounted /sysroot.1246test # [ 2.461076] systemd[1]: Starting Mountpoints Configured in the Real Root...1247second # [ 2.638537] cdrom: Uniform CD-ROM driver Revision: 3.201248second # [ 2.466925] systemd[1]: Reached target Initrd Root File System.1249test # [ 2.638952] cdrom: Uniform CD-ROM driver Revision: 3.201250second # [ 2.471177] systemd[1]: Starting Mountpoints Configured in the Real Root...1251test # [ 2.472991] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1252test # [ 2.478587] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1253test # [ 2.480404] systemd[1]: Reloading...1254second # [ 2.483992] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.1255second # [ 2.489299] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...1256second # [ 2.491115] systemd[1]: Reloading...1257test # [ 2.536955] systemd[1]: Reloading finished in 59 ms.1258second # [ 2.552645] systemd[1]: Reloading finished in 63 ms.1259test # [ 2.549308] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1260test # [ 2.551572] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1261second # [ 2.560147] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...1262test # [ 2.558760] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1263test # [ 2.560458] systemd[1]: Finished Mountpoints Configured in the Real Root.1264second # [ 2.565160] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...1265test # [ 2.561667] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1266second # [ 2.567771] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1267second # [ 2.569484] systemd[1]: Finished Mountpoints Configured in the Real Root.1268second # [ 2.571257] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1269test # [ 3.342101] systemd[1]: Mounting /sysroot/nix/.ro-store...1270test # [ 3.345103] systemd[1]: Mounting /sysroot/nix/.rw-store...1271second # [ 3.351103] systemd[1]: Mounting /sysroot/nix/.ro-store...1272test # [ 3.349136] systemd[1]: Mounting /sysroot/run...1273second # [ 3.353936] systemd[1]: Mounting /sysroot/nix/.rw-store...1274test # [ 3.351868] systemd[1]: Mounting /sysroot/tmp/shared...1275second # [ 3.358626] systemd[1]: Mounting /sysroot/run...1276second # [ 3.359696] systemd[1]: Mounting /sysroot/tmp/shared...1277test # [ 3.356151] systemd[1]: Mounting /sysroot/tmp/xchg...1278second # [ 3.363361] systemd[1]: Mounting /sysroot/tmp/xchg...1279test # [ 3.373565] systemd[1]: Mounted /sysroot/nix/.rw-store.1280test # [ 3.377983] systemd[1]: Mounted /sysroot/nix/.ro-store.1281second # [ 3.383674] systemd[1]: Mounted /sysroot/nix/.ro-store.1282test # [ 3.381424] systemd[1]: Mounted /sysroot/run.1283test # [ 3.382466] systemd[1]: Mounted /sysroot/tmp/shared.1284test # [ 3.383586] systemd[1]: Mounted /sysroot/tmp/xchg.1285second # [ 3.388056] systemd[1]: Mounted /sysroot/nix/.rw-store.1286second # [ 3.390117] systemd[1]: Mounted /sysroot/run.1287test # [ 3.387209] systemd[1]: Starting rw-sysroot-nix-store.service...1288second # [ 3.390916] systemd[1]: Mounted /sysroot/tmp/shared.1289second # [ 3.391844] systemd[1]: Mounted /sysroot/tmp/xchg.1290second # [ 3.395243] systemd[1]: Starting rw-sysroot-nix-store.service...1291test # [ 3.396071] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1292test # [ 3.397840] systemd[1]: Finished rw-sysroot-nix-store.service.1293test # [ 3.399894] systemd[1]: Mounting /sysroot/nix/store...1294second # [ 3.403954] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1295second # [ 3.405721] systemd[1]: Finished rw-sysroot-nix-store.service.1296test # [ 3.417074] systemd[1]: Mounted /sysroot/nix/store.1297test # [ 3.417959] systemd[1]: Reached target Initrd File Systems.1298test # [ 3.419850] systemd[1]: Starting Find NixOS closure...1299test # [ 3.423128] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1300test # [ 3.435199] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1301test # [ 3.441410] systemd[1]: Finished Find NixOS closure.1302test # [ 3.442766] systemd[1]: Reached target Initrd Default Target.1303test # [ 3.444939] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1304test # [ 3.454883] systemd[1]: Stopped target Initrd Default Target.1305test # [ 3.456510] systemd[1]: Stopped target Basic System.1306test # [ 3.457668] systemd[1]: Stopped target Initrd Root Device.1307test # [ 3.460151] systemd[1]: Stopped target Path Units.1308test # [ 3.461051] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1309test # [ 3.462326] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1310test # [ 3.463750] systemd[1]: Stopped target Slice Units.1311test # [ 3.464691] systemd[1]: Stopped target Socket Units.1312test # [ 3.465611] systemd[1]: Stopped target System Initialization.1313test # [ 3.466615] systemd[1]: Stopped target Swaps.1314test # [ 3.467887] systemd[1]: Stopped target Timer Units.1315test # [ 3.468802] systemd[1]: dbus.socket: Deactivated successfully.1316test # [ 3.470242] systemd[1]: Closed D-Bus System Message Bus Socket.1317test # [ 3.472142] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1318test # [ 3.473398] systemd[1]: Stopped Find NixOS closure.1319test # [ 3.474295] systemd[1]: Starting rw-sysroot-nix-store.service...1320test # [ 3.475349] systemd[1]: systemd-sysctl.service: Deactivated successfully.1321test # [ 3.476660] systemd[1]: Stopped Apply Kernel Variables.1322test # [ 3.478282] systemd[1]: systemd-modules-load.service: Deactivated successfully.1323test # [ 3.479668] systemd[1]: Stopped Load Kernel Modules.1324test # [ 3.481165] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1325test # [ 3.482479] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1326test # [ 3.484121] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1327test # [ 3.486137] systemd[1]: Stopped Create System Files and Directories.1328test # [ 3.487591] systemd[1]: Stopped target Local File Systems.1329test # [ 3.488832] systemd[1]: Stopped target Preparation for Local File Systems.1330test # [ 3.490374] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1331test # [ 3.492133] systemd[1]: Stopped Coldplug All udev Devices.1332test # [ 3.493295] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1333test # [ 3.495173] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1334test # [ 3.498148] systemd[1]: Stopped Virtual Console Setup.1335test # [ 3.503859] systemd[1]: initrd-cleanup.service: Deactivated successfully.1336test # [ 3.507255] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1337test # [ 3.508484] systemd[1]: systemd-udevd.service: Deactivated successfully.1338test # [ 3.510081] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1339test # [ 3.511504] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1340test # [ 3.513256] systemd[1]: Finished rw-sysroot-nix-store.service.1341test # [ 3.516532] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1342test # [ 3.518203] systemd[1]: Closed udev Control Socket.1343test # [ 3.519483] systemd[1]: Starting Cleanup udev Database...1344test # [ 3.520911] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1345test # [ 3.522236] systemd[1]: Stopped Create Static Device Nodes in /dev.1346test # [ 3.524161] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1347test # [ 3.525543] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1348test # [ 3.526772] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1349test # [ 3.527959] systemd[1]: Stopped Create List of Static Device Nodes.1350test # [ 3.537249] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1351test # [ 3.540087] systemd[1]: Finished Cleanup udev Database.1352test # [ 3.541058] systemd[1]: Reached target Switch Root.1353test # [ 3.542340] systemd[1]: Starting NixOS Activation...1354test # [ 3.613786] initrd-nixos-activation-start[189]: booting system configuration /nix/store/qbfd7pvaa5mdbvvvdp1ngcmdj6b7krs6-nixos-system-test-test1355test # [ 3.637383] initrd-nixos-activation-start[189]: running activation script...1356test # [ 3.812236] initrd-nixos-activation-start[212]: setting up /etc...1357test # [ 3.905185] initrd-nixos-activation-start[212]: setting up age secrets...1358test # [ 4.042874] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1359test # [ 4.045095] systemd[1]: Finished NixOS Activation.1360test # [ 4.047560] systemd[1]: Starting Switch Root...1361test # [ 4.066354] systemd[1]: Switching root.1362test # [ 4.368719] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1363test # [ 4.443508] NET: Registered PF_VSOCK protocol family1364second # [ 4.353532] systemd[1]: Mounting /sysroot/nix/store...1365second # [ 4.375493] systemd[1]: Mounted /sysroot/nix/store.1366second # [ 4.376923] systemd[1]: Reached target Initrd File Systems.1367second # [ 4.378779] systemd[1]: Starting Find NixOS closure...1368second # [ 4.381302] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1369second # [ 4.399337] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1370second # [ 4.402234] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1371second # [ 4.406522] systemd[1]: Finished Find NixOS closure.1372second # [ 4.408185] systemd[1]: Reached target Initrd Default Target.1373second # [ 4.409624] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1374second # [ 4.421402] systemd[1]: initrd-cleanup.service: Deactivated successfully.1375second # [ 4.423046] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1376second # [ 4.425544] systemd[1]: Stopped target Initrd Default Target.1377second # [ 4.426658] systemd[1]: Stopped target Basic System.1378second # [ 4.427668] systemd[1]: Stopped target Initrd Root Device.1379second # [ 4.429164] systemd[1]: Stopped target Path Units.1380second # [ 4.430087] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1381second # [ 4.432165] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1382second # [ 4.433491] systemd[1]: Stopped target Slice Units.1383second # [ 4.434424] systemd[1]: Stopped target Socket Units.1384second # [ 4.435406] systemd[1]: Stopped target System Initialization.1385second # [ 4.436630] systemd[1]: Stopped target Swaps.1386second # [ 4.438157] systemd[1]: Stopped target Timer Units.1387second # [ 4.439088] systemd[1]: dbus.socket: Deactivated successfully.1388second # [ 4.440159] systemd[1]: Closed D-Bus System Message Bus Socket.1389second # [ 4.442152] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1390second # [ 4.443411] systemd[1]: Stopped Find NixOS closure.1391second # [ 4.444305] systemd[1]: Starting rw-sysroot-nix-store.service...1392second # [ 4.445366] systemd[1]: systemd-sysctl.service: Deactivated successfully.1393second # [ 4.447098] systemd[1]: Stopped Apply Kernel Variables.1394second # [ 4.448606] systemd[1]: systemd-modules-load.service: Deactivated successfully.1395second # [ 4.449841] systemd[1]: Stopped Load Kernel Modules.1396second # [ 4.451177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1397second # [ 4.452768] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1398second # [ 4.454820] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1399second # [ 4.456387] systemd[1]: Stopped Create System Files and Directories.1400second # [ 4.457545] systemd[1]: Stopped target Local File Systems.1401second # [ 4.458803] systemd[1]: Stopped target Preparation for Local File Systems.1402second # [ 4.461162] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1403second # [ 4.462682] systemd[1]: Stopped Coldplug All udev Devices.1404second # [ 4.465613] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1405second # [ 4.467165] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1406second # [ 4.468427] systemd[1]: Stopped Virtual Console Setup.1407second # [ 4.473146] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1408second # [ 4.474566] systemd[1]: Finished rw-sysroot-nix-store.service.1409second # [ 4.476183] systemd[1]: systemd-udevd.service: Deactivated successfully.1410second # [ 4.477728] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1411second # [ 4.479662] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1412second # [ 4.481179] systemd[1]: Closed udev Control Socket.1413second # [ 4.482776] systemd[1]: Starting Cleanup udev Database...1414second # [ 4.484174] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1415second # [ 4.485477] systemd[1]: Stopped Create Static Device Nodes in /dev.1416second # [ 4.487165] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1417second # [ 4.488515] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1418second # [ 4.489756] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1419second # [ 4.491206] systemd[1]: Stopped Create List of Static Device Nodes.1420second # [ 4.502745] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1421second # [ 4.504294] systemd[1]: Finished Cleanup udev Database.1422second # [ 4.505689] systemd[1]: Reached target Switch Root.1423second # [ 4.507389] systemd[1]: Starting NixOS Activation...1424second # [ 4.553936] initrd-nixos-activation-start[189]: booting system configuration /nix/store/5ckvj43jlchxdwzgdri797g5hvbd2irc-nixos-system-second-test1425second # [ 4.574320] initrd-nixos-activation-start[189]: running activation script...1426test # [ 4.802285] 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)1427test # [ 4.806979] systemd[1]: Detected virtualization kvm.1428test # [ 4.807786] systemd[1]: Detected architecture x86-64.1429test # [ 4.808663] systemd[1]: Detected first boot.1430test # [ 4.810985] systemd[1]: Initializing machine ID from random generator.1431test # [ 4.878252] systemd[1]: bpf-restrict-fs: LSM BPF program attached1432second # [ 4.727638] initrd-nixos-activation-start[212]: setting up /etc...1433test # [ 4.938868] systemd[1]: Applying preset policy.1434second # [ 4.795990] initrd-nixos-activation-start[212]: setting up age secrets...1435second # [ 4.862060] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1436second # [ 4.864084] systemd[1]: Finished NixOS Activation.1437second # [ 4.865749] systemd[1]: Starting Switch Root...1438second # [ 4.876071] systemd[1]: Switching root.1439test # [ 5.077530] systemd[1]: Populated /etc with preset unit settings.1440second # [ 5.175442] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1441second # [ 5.225405] NET: Registered PF_VSOCK protocol family1442test # [ 5.257021] systemd[1]: initrd-switch-root.service: Deactivated successfully.1443test # [ 5.258557] systemd[1]: Stopped initrd-switch-root.service.1444test # [ 5.260834] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1445test # [ 5.263114] systemd[1]: Created slice Slice /system/getty.1446test # [ 5.264464] systemd[1]: Created slice User and Session Slice.1447test # [ 5.265521] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1448test # [ 5.266895] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1449test # [ 5.268138] systemd[1]: Expecting device /dev/hvc0...1450test # [ 5.269007] systemd[1]: Expecting device /dev/ttyS0...1451test # [ 5.269856] systemd[1]: Reached target Local Encrypted Volumes.1452test # [ 5.270839] systemd[1]: Stopped target initrd-fs.target.1453test # [ 5.271722] systemd[1]: Stopped target initrd-root-fs.target.1454test # [ 5.280572] systemd[1]: Stopped target initrd-switch-root.target.1455test # [ 5.281579] systemd[1]: Reached target Virtual Machines and Containers.1456test # [ 5.282645] systemd[1]: Reached target Path Units.1457test # [ 5.283487] systemd[1]: Reached target Remote File Systems.1458test # [ 5.284411] systemd[1]: Reached target Slice Units.1459test # [ 5.285282] systemd[1]: Reached target Swaps.1460test # [ 5.286988] systemd[1]: Listening on Query the User Interactively for a Password.1461test # [ 5.289279] systemd[1]: Listening on Process Core Dump Socket.1462test # [ 5.291096] systemd[1]: Listening on Credential Encryption/Decryption.1463test # [ 5.293003] systemd[1]: Listening on Factory Reset Management.1464test # [ 5.294060] systemd[1]: Listening on Hostname Service Socket.1465test # [ 5.296453] systemd[1]: Starting Journal Log Access Socket...1466test # [ 5.297771] systemd[1]: Listening on Journal Audit Socket.1467test # [ 5.300118] systemd[1]: Listening on Console Output Muting Service Socket.1468test # [ 5.301333] systemd[1]: Listening on Network Management Metrics Varlink Socket.1469test # [ 5.302670] systemd[1]: Listening on Network Management Varlink Socket.1470test # [ 5.303854] systemd[1]: Listening on Network Management Netlink Socket.1471test # [ 5.305077] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1472test # [ 5.306296] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1473test # [ 5.307758] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1474test # [ 5.311438] systemd[1]: Listening on Disk Repartitioning Service Socket.1475test # [ 5.312619] systemd[1]: Listening on Resolve Monitor Varlink Socket.1476test # [ 5.313752] systemd[1]: Listening on Resolve Service Varlink Socket.1477test # [ 5.314878] systemd[1]: Listening on udev Control Socket.1478test # [ 5.315891] systemd[1]: Listening on udev Varlink Socket.1479test # [ 5.318503] systemd[1]: Mounting Huge Pages File System...1480test # [ 5.321256] systemd[1]: Mounting POSIX Message Queue File System...1481test # [ 5.327069] systemd[1]: Mounting Kernel Debug File System...1482test # [ 5.334541] systemd[1]: Mounting Kernel Trace File System...1483test # [ 5.339241] systemd[1]: Starting Create List of Static Device Nodes...1484test # [ 5.349888] systemd[1]: Starting Load Kernel Module configfs...1485test # [ 5.359882] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1486test # [ 5.371045] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1487test # [ 5.375394] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1488test # [ 5.377931] systemd[1]: Mounting FUSE Control File System...1489test # [ 5.379365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671490test # [ 5.389498] systemd[1]: Starting Journal Service...1491test # [ 5.396526] systemd[1]: Starting Load Kernel Modules...1492test # [ 5.404579] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1493test # [ 5.417042] systemd[1]: Starting Remount Root and Kernel File Systems...1494test # [ 5.419326] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1495test # [ 5.423137] systemd[1]: Starting Coldplug All udev Devices...1496test # [ 5.429343] systemd-journald[336]: Collecting audit messages is enabled.1497test # [ 5.442222] systemd[1]: Listening on Journal Log Access Socket.1498test # [ 5.448824] loop: module loaded1499test # [ 5.449929] systemd[1]: Mounted Huge Pages File System.1500test # [ 5.456903] systemd[1]: Mounted POSIX Message Queue File System.1501test # [ 5.460591] systemd[1]: Mounted Kernel Debug File System.1502test # [ 5.289731] systemd[1]: Queued start job for default target Multi-User System.1503test # [ 5.291381] systemd[1]: systemd-journald.service: Deactivated successfully.1504test # [ 5.293623] systemd-modules-load[337]: Module 'ctr' is built in1505test # [ 5.468113] systemd[1]: Started Journal Service.1506test # [ 5.296470] systemd-modules-load[337]: Inserted module 'loop'1507test # [ 5.300436] systemd[1]: Mounted Kernel Trace File System.1508test # [ 5.305554] systemd[1]: Finished Create List of Static Device Nodes.1509test # [ 5.306907] systemd[1]: modprobe@configfs.service: Deactivated successfully.1510test # [ 5.311150] systemd[1]: Finished Load Kernel Module configfs.1511test # [ 5.312231] systemd[1]: Mounted FUSE Control File System.1512test # [ 5.317092] systemd[1]: Finished Load Kernel Modules.1513test # [ 5.328959] systemd[1]: Mounting Kernel Configuration File System...1514test # [ 5.503105] EXT4-fs (vda): re-mounted 698a4e17-b7e9-4ecb-8f18-4641194b253f.1515test # [ 5.334061] systemd[1]: Starting Firewall...1516test # [ 5.335623] systemd[1]: Starting Apply Kernel Variables...1517test # [ 5.343093] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1518test # [ 5.351105] systemd[1]: Finished Remount Root and Kernel File Systems.1519test # [ 5.352956] systemd-oomd[339]: No swap; memory pressure usage will be degraded1520test # [ 5.359962] systemd[1]: Listening on Disk Image Download Service Socket.1521test # [ 5.367908] systemd[1]: Starting Flush Journal to Persistent Storage...1522test # [ 5.369074] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1523test # [ 5.378172] systemd[1]: Starting Load/Save OS Random Seed...1524test # [ 5.380069] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1525test # [ 5.381505] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1526second # [ 5.577199] 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)1527second # [ 5.581467] systemd[1]: Detected virtualization kvm.1528second # [ 5.582285] systemd[1]: Detected architecture x86-64.1529second # [ 5.583148] systemd[1]: Detected first boot.1530second # [ 5.584730] systemd[1]: Initializing machine ID from random generator.1531test # [ 5.601892] systemd-journald[336]: Received client request to flush runtime journal.1532second # [ 5.647795] systemd[1]: bpf-restrict-fs: LSM BPF program attached1533second # [ 5.700834] systemd[1]: Applying preset policy.1534test # [ 5.601543] systemd[1]: Mounted Kernel Configuration File System.1535test # [ 5.606138] systemd[1]: Finished Load/Save OS Random Seed.1536test # [ 5.608234] systemd[1]: Reached target First Boot Complete.1537test # [ 5.610251] systemd[1]: Finished Apply Kernel Variables.1538test # [ 5.611802] systemd[1]: Starting Network Name Resolution...1539test # [ 5.612821] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1540test # [ 5.615158] systemd[1]: Starting Create Static Device Nodes in /dev...1541test # [ 5.616408] systemd-resolved[365]: Positive Trust Anchors:1542test # [ 5.617489] systemd-resolved[365]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1543test # [ 5.621081] systemd-resolved[365]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161544test # [ 5.622719] systemd-resolved[365]: 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 test1545test # [ 5.637313] systemd[1]: Finished Flush Journal to Persistent Storage.1546test # [ 5.652149] systemd[1]: Finished Create Static Device Nodes in /dev.1547test # [ 5.653249] systemd[1]: Reached target Preparation for Local File Systems.1548test # [ 5.657396] systemd[1]: Starting Rule-based Manager for Device Events and Files...1549test # [ 5.660151] systemd[1]: Finished Coldplug All udev Devices.1550second # [ 5.841683] systemd[1]: Populated /etc with preset unit settings.1551test # [ 5.692728] systemd-resolved[365]: Using system hostname 'test'.1552test # [ 5.697076] systemd[1]: Started Network Name Resolution.1553test # [ 5.708641] systemd-udevd[380]: Using default interface naming scheme 'v261'.1554test # [ 5.766086] systemd[1]: Started Rule-based Manager for Device Events and Files.1555second # [ 6.011239] systemd[1]: initrd-switch-root.service: Deactivated successfully.1556second # [ 6.012831] systemd[1]: Stopped initrd-switch-root.service.1557second # [ 6.015206] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1558second # [ 6.017427] systemd[1]: Created slice Slice /system/getty.1559second # [ 6.018875] systemd[1]: Created slice User and Session Slice.1560second # [ 6.019925] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1561second # [ 6.021256] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1562second # [ 6.022461] systemd[1]: Expecting device /dev/hvc0...1563second # [ 6.023319] systemd[1]: Expecting device /dev/ttyS0...1564second # [ 6.024194] systemd[1]: Reached target Local Encrypted Volumes.1565second # [ 6.025155] systemd[1]: Stopped target initrd-fs.target.1566second # [ 6.026047] systemd[1]: Stopped target initrd-root-fs.target.1567second # [ 6.034886] systemd[1]: Stopped target initrd-switch-root.target.1568second # [ 6.035902] systemd[1]: Reached target Virtual Machines and Containers.1569second # [ 6.036962] systemd[1]: Reached target Path Units.1570second # [ 6.037798] systemd[1]: Reached target Remote File Systems.1571second # [ 6.038735] systemd[1]: Reached target Slice Units.1572second # [ 6.039585] systemd[1]: Reached target Swaps.1573second # [ 6.041201] systemd[1]: Listening on Query the User Interactively for a Password.1574second # [ 6.043466] systemd[1]: Listening on Process Core Dump Socket.1575second # [ 6.045211] systemd[1]: Listening on Credential Encryption/Decryption.1576second # [ 6.047052] systemd[1]: Listening on Factory Reset Management.1577second # [ 6.048106] systemd[1]: Listening on Hostname Service Socket.1578second # [ 6.050690] systemd[1]: Starting Journal Log Access Socket...1579second # [ 6.051876] systemd[1]: Listening on Journal Audit Socket.1580second # [ 6.054106] systemd[1]: Listening on Console Output Muting Service Socket.1581second # [ 6.055327] systemd[1]: Listening on Network Management Metrics Varlink Socket.1582second # [ 6.056697] systemd[1]: Listening on Network Management Varlink Socket.1583second # [ 6.057881] systemd[1]: Listening on Network Management Netlink Socket.1584second # [ 6.059071] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1585second # [ 6.060289] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1586second # [ 6.061761] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1587test # [ 5.888087] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1588second # [ 6.065458] systemd[1]: Listening on Disk Repartitioning Service Socket.1589second # [ 6.066663] systemd[1]: Listening on Resolve Monitor Varlink Socket.1590second # [ 6.067781] systemd[1]: Listening on Resolve Service Varlink Socket.1591second # [ 6.068913] systemd[1]: Listening on udev Control Socket.1592second # [ 6.069929] systemd[1]: Listening on udev Varlink Socket.1593second # [ 6.071843] systemd[1]: Mounting Huge Pages File System...1594second # [ 6.074559] systemd[1]: Mounting POSIX Message Queue File System...1595second # [ 6.081443] systemd[1]: Mounting Kernel Debug File System...1596second # [ 6.087281] systemd[1]: Mounting Kernel Trace File System...1597second # [ 6.095003] systemd[1]: Starting Create List of Static Device Nodes...1598second # [ 6.105930] systemd[1]: Starting Load Kernel Module configfs...1599second # [ 6.113711] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1600second # [ 6.119186] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1601second # [ 6.124099] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1602second # [ 6.133282] systemd[1]: Mounting FUSE Control File System...1603second # [ 6.136631] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671604test # [ 5.966135] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1605second # [ 6.144099] systemd[1]: Starting Journal Service...1606second # [ 6.152347] systemd[1]: Starting Load Kernel Modules...1607second # [ 6.158344] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1608test # [ 5.986303] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1609second # [ 6.170276] systemd[1]: Starting Remount Root and Kernel File Systems...1610second # [ 6.172663] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1611test # [ 6.003662] (udev-worker)[409]: Network interface NamePolicy= disabled on kernel command line.1612second # [ 6.182403] systemd-journald[315]: Collecting audit messages is enabled.1613test # [ 6.007347] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line.1614second # [ 6.184222] systemd[1]: Starting Coldplug All udev Devices...1615second # [ 6.192262] systemd[1]: Listening on Journal Log Access Socket.1616second # [ 6.196775] systemd[1]: Mounted Huge Pages File System.1617second # [ 6.201638] systemd[1]: Mounted POSIX Message Queue File System.1618second # [ 6.206032] systemd[1]: Mounted Kernel Debug File System.1619second # [ 6.036648] systemd[1]: Queued start job for default target Multi-User System.1620second # [ 6.211057] systemd[1]: Started Journal Service.1621second # [ 6.040512] systemd[1]: systemd-journald.service: Deactivated successfully.1622second # [ 6.042735] systemd-modules-load[316]: Module 'ctr' is built in1623second # [ 6.052494] systemd[1]: Mounted Kernel Trace File System.1624second # [ 6.228616] loop: module loaded1625second # [ 6.056906] systemd[1]: Finished Create List of Static Device Nodes.1626second # [ 6.058350] systemd[1]: modprobe@configfs.service: Deactivated successfully.1627second # [ 6.059679] systemd-modules-load[316]: Inserted module 'loop'1628second # [ 6.066470] systemd[1]: Finished Load Kernel Module configfs.1629second # [ 6.067570] systemd[1]: Mounted FUSE Control File System.1630second # [ 6.244000] EXT4-fs (vda): re-mounted ad6f6042-5dbd-4efa-bd27-c356b63507d9.1631second # [ 6.073206] systemd[1]: Finished Load Kernel Modules.1632second # [ 6.082815] systemd[1]: Finished Remount Root and Kernel File Systems.1633second # [ 6.086869] systemd[1]: Listening on Disk Image Download Service Socket.1634second # [ 6.090075] systemd[1]: Mounting Kernel Configuration File System...1635test # [ 6.088341] systemd[1]: Mounting /run/wrappers...1636second # [ 6.093631] systemd-oomd[318]: No swap; memory pressure usage will be degraded1637second # [ 6.097127] systemd[1]: Starting Firewall...1638second # [ 6.104073] systemd[1]: Starting Flush Journal to Persistent Storage...1639second # [ 6.105253] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1640second # [ 6.115048] systemd[1]: Starting Load/Save OS Random Seed...1641test # [ 6.115264] systemd[1]: Mounted /run/wrappers.1642test # [ 6.116195] systemd[1]: Reached target Local File Systems.1643second # [ 6.122106] systemd[1]: Starting Apply Kernel Variables...1644test # [ 6.118762] systemd[1]: Listening on Boot Loader Control Service Socket.1645test # [ 6.120576] systemd[1]: Starting register-nix-paths.service...1646test # [ 6.125643] systemd[1]: Starting Create SUID/SGID Wrappers...1647test # [ 6.126743] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1648second # [ 6.131745] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1649second # [ 6.133060] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1650test # [ 6.130071] systemd[1]: Starting Save Transient machine-id to Disk...1651second # [ 6.134510] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1652test # [ 6.138550] systemd[1]: Starting Create System Files and Directories...1653second # [ 6.331778] systemd-journald[315]: Received client request to flush runtime journal.1654test # [ 6.200979] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1655test # [ 6.208200] systemd[1]: Finished Save Transient machine-id to Disk.1656test # [ 6.256115] systemd[1]: Finished Create System Files and Directories.1657test # [ 6.264341] systemd[1]: Starting Rebuild Journal Catalog...1658test # [ 6.270133] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1659second # [ 6.328753] systemd[1]: Mounted Kernel Configuration File System.1660second # [ 6.332770] systemd[1]: Finished Load/Save OS Random Seed.1661second # [ 6.335403] systemd[1]: Reached target First Boot Complete.1662test # [ 6.505404] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1663second # [ 6.337859] systemd[1]: Finished Apply Kernel Variables.1664second # [ 6.338962] systemd[1]: Starting Network Name Resolution...1665second # [ 6.341159] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1666second # [ 6.342388] systemd[1]: Starting Create Static Device Nodes in /dev...1667second # [ 6.346928] systemd[1]: Finished Flush Journal to Persistent Storage.1668test # [ 6.344402] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1669test # [ 6.526931] mousedev: PS/2 mouse device common for all mice1670test # [ 6.532421] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31671second # [ 6.378759] systemd-resolved[344]: Positive Trust Anchors:1672test # [ 6.376215] systemd[1]: Finished Rebuild Journal Catalog.1673second # [ 6.381266] systemd-resolved[344]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1674test # [ 6.379823] systemd[1]: Starting Update is Completed...1675second # [ 6.383422] systemd-resolved[344]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161676second # [ 6.386895] systemd-resolved[344]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1677second # [ 6.410418] systemd[1]: Finished Create Static Device Nodes in /dev.1678second # [ 6.414117] systemd[1]: Reached target Preparation for Local File Systems.1679second # [ 6.418530] systemd[1]: Starting Rule-based Manager for Device Events and Files...1680test # [ 6.423323] systemd[1]: Finished Update is Completed.1681second # [ 6.437605] systemd[1]: Finished Coldplug All udev Devices.1682second # [ 6.457079] systemd-resolved[344]: Using system hostname 'second'.1683second # [ 6.460178] systemd[1]: Started Network Name Resolution.1684test # [ 6.458197] systemd[1]: Finished Firewall.1685test # [ 6.459149] systemd[1]: Reached target Preparation for Network.1686test # [ 6.461533] systemd[1]: Listening on Network Management Resolve Hook Socket.1687test # [ 6.469060] systemd[1]: Starting Network Management...1688second # [ 6.472651] systemd-udevd[360]: Using default interface naming scheme 'v261'.1689second # [ 6.523885] systemd[1]: Started Rule-based Manager for Device Events and Files.1690test # [ 6.539634] systemd-resolved[365]: Clock change detected. Flushing caches.1691test # [ 6.594939] ACPI: button: Power Button [PWRF]1692test # [ 6.676829] rtc_cmos PNP0B00:00: RTC can wake from S41693test # [ 6.712021] rtc_cmos PNP0B00:00: registered as rtc01694test # [ 6.712116] rtc_cmos PNP0B00:00: setting system clock to 2026-10-03T00:02:56 UTC (1790985776)1695test # [ 6.712239] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1696test # [ 6.713651] systemd-journald[336]: Time jumped backwards, rotating.1697test # [ 6.736292] parport_pc 00:02: reported by Plug and Play ACPI1698second # [ 6.644151] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1699test # [ 6.736379] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1700test # [ 6.751946] Console: switching to colour dummy device 80x251701test # [ 6.756633] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41702test # [ 6.783212] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1703test # [ 6.866850] [drm] Found bochs VGA, ID 0xb0c5.1704test # [ 6.866855] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1705second # [ 6.717184] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1706test # [ 6.899151] cfg80211: Loading compiled-in X.509 certificates for regulatory database1707second # [ 6.730912] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1708test # [ 6.930535] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1709test # [ 6.931398] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01710test # [ 6.933067] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1711second # [ 6.763373] (udev-worker)[392]: Network interface NamePolicy= disabled on kernel command line.1712test # [ 6.933827] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1713second # [ 6.766846] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line.1714test # [ 6.773261] systemd[1]: Finished register-nix-paths.service.1715test # [ 6.953722] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1716test # [ 6.954530] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1717test # [ 6.784528] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1718test # [ 6.788229] systemd[1]: Finished Create SUID/SGID Wrappers.1719test # [ 6.790771] systemd[1]: Reached target System Initialization.1720test # [ 6.792154] systemd[1]: Started Discard unused filesystem blocks once a week.1721test # [ 6.794180] systemd[1]: Started Daily Cleanup of Temporary Directories.1722test # [ 6.796236] systemd[1]: Reached target Timer Units.1723test # [ 6.797771] systemd[1]: Listening on D-Bus System Message Bus Socket.1724test # [ 6.799412] systemd[1]: Listening on Nix Daemon Socket.1725test # [ 6.804172] systemd[1]: Listening on Authorization Manager Agent Helper.1726test # [ 6.806679] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1727test # [ 6.808127] systemd[1]: Reached target Socket Units.1728test # [ 6.810213] systemd-networkd[533]: /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.1729test # [ 6.814783] systemd-networkd[533]: /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.1730test # [ 6.819233] systemd-networkd[533]: lo: Link UP1731test # [ 6.821131] systemd-networkd[533]: lo: Gained carrier1732test # [ 6.822770] systemd[1]: Starting D-Bus System Message Bus...1733test # [ 6.826356] systemd[1]: Started Network Management.1734test # [ 6.831356] systemd-networkd[533]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1735test # [ 6.836587] systemd-networkd[533]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1736second # [ 6.842845] systemd[1]: Mounting /run/wrappers...1737test # [ 6.840386] systemd-networkd[533]: eth1: Link UP1738test # [ 6.843179] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1739test # [ 6.845938] systemd-networkd[533]: eth1: Gained carrier1740test # [ 6.846996] systemd-networkd[533]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1741second # [ 6.872655] systemd[1]: Mounted /run/wrappers.1742second # [ 6.873601] systemd[1]: Reached target Local File Systems.1743second # [ 6.876150] systemd[1]: Listening on Boot Loader Control Service Socket.1744second # [ 6.881065] systemd[1]: Starting register-nix-paths.service...1745second # [ 6.884074] systemd[1]: Starting Create SUID/SGID Wrappers...1746second # [ 6.885102] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1747test # [ 7.054975] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61748test # [ 7.056230] NET: Registered PF_PACKET protocol family1749test # [ 7.058460] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51750second # [ 6.890486] systemd[1]: Starting Save Transient machine-id to Disk...1751second # [ 6.897227] systemd[1]: Starting Create System Files and Directories...1752test # [ 6.899809] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1753test # [ 6.935434] systemd[1]: Starting Virtual Console Setup...1754test # [ 7.096729] Console: switching to colour frame buffer device 160x501755test # [ 7.127561] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1756test # [ 6.966156] dbus-broker-launch[571]: Looking up NSS user entry for 'systemd-timesync'...1757second # [ 6.970808] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1758test # [ 6.971570] dbus-broker-launch[571]: NSS returned no entry for 'systemd-timesync'1759test # [ 6.972913] dbus-broker-launch[571]: Invalid user-name in /nix/store/nph6ql5mkwhfxxh3p5ahbh7jq01m1n7l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1760second # [ 6.978552] systemd[1]: Finished Save Transient machine-id to Disk.1761test # [ 6.986976] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1762test # [ 6.989550] systemd[1]: Stopped Virtual Console Setup.1763test # [ 6.996299] systemd[1]: Starting Virtual Console Setup...1764test # [ 7.011248] dbus-broker-launch[571]: 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'1765test # [ 7.014780] dbus-broker-launch[571]: 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'1766second # [ 7.022365] systemd[1]: Finished Create System Files and Directories.1767test # [ 7.019234] dbus-broker-launch[571]: 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'1768test # [ 7.024797] dbus-broker-launch[571]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/d527hwwggm2wz18p4v8cr39amcpx3g4c-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1769second # [ 7.032125] systemd[1]: Starting Rebuild Journal Catalog...1770test # [ 7.029185] systemd[1]: Started D-Bus System Message Bus.1771test # [ 7.031413] systemd[1]: Reached target Basic System.1772test # [ 7.036706] systemd[1]: Starting Network Manager Script Dispatcher Service...1773test # [ 7.042127] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1774second # [ 7.046161] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1775test # [ 7.052390] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1776test # [ 7.063162] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1777test # [ 7.071936] dbus-broker-launch[571]: Ready1778test # [ 7.079298] systemd[1]: Starting Network Manager...1779test # [ 7.088646] systemd[1]: Started backdoor.service.1780test # [ 7.268951] ppdev: user-space parallel port driver1781test # [ 7.114225] systemd[1]: Starting Import lastlog data into lastlog2 database...1782second # [ 7.295518] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31783second # [ 7.125398] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1784test # [ 7.127955] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1785second # [ 7.151847] systemd[1]: Finished Rebuild Journal Catalog.1786test # [ 7.148748] systemd[1]: Starting Post-Boot Actions...1787second # [ 7.160148] systemd[1]: Starting Update is Completed...1788test # [ 7.156248] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[584]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1789test # [ 7.181181] systemd[1]: Started Reset console on configuration changes.1790second # [ 7.359781] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1791second # [ 7.192168] systemd[1]: Finished Firewall.1792second # [ 7.193088] systemd[1]: Reached target Preparation for Network.1793second # [ 7.195153] systemd[1]: Listening on Network Management Resolve Hook Socket.1794second # [ 7.204277] systemd[1]: Starting Network Management...1795second # [ 7.209603] systemd[1]: Finished Update is Completed.1796test # [ 7.209629] 2fzr21av002hkddm9grsnsbb2wa3c1bn-wifi-secrets[585]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1797second # [ 7.397536] ACPI: button: Power Button [PWRF]1798test # [ 7.224374] bjn7ymirp1h8ai1aki9b9jfc6bwb1c5s-wifi-secrets[586]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1799test # connecting to host...1800test # [ 7.239428] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1801test # [ 7.246683] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1802test # [ 7.257492] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1803test # [ 7.259910] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1804test # [ 7.263620] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1805test # [ 7.267434] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1806test: Guest shell says: b'Spawning backdoor root shell...\n'1807test: connected to guest root shell1808test: (connecting took 7.94 seconds)1809test # [ 7.297813] systemd[1]: Finished Post-Boot Actions.1810test: (finished: waiting for the VM to finish booting, in 7.94 seconds)1811test # [ 7.310396] nsncd[592]: Oct 03 00:02:57.270 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1812test # [ 7.318408] systemd[1]: Started Name Service Cache Daemon (nsncd).1813test # [ 7.326100] systemd[1]: Started Network Manager Script Dispatcher Service.1814test # [ 7.329268] systemd[1]: Reached target Host and Network Name Lookups.1815test # [ 7.330363] systemd[1]: Reached target User and Group Name Lookups.1816test # [ 7.331442] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1817test # [ 7.346612] systemd[1]: Starting User Login Management...1818test # [ 7.354356] systemd[1]: Finished Import lastlog data into lastlog2 database.1819test # [ 7.540714] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1820second # [ 7.382838] systemd-resolved[344]: Clock change detected. Flushing caches.1821test # [ 7.560042] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1822second # [ 7.423680] mousedev: PS/2 mouse device common for all mice1823test # [ 7.399708] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1824test # [ 7.405524] systemd[1]: Stopped Virtual Console Setup.1825test # [ 7.416849] systemd[1]: Starting Virtual Console Setup...1826second # [ 7.535901] rtc_cmos PNP0B00:00: RTC can wake from S41827second # [ 7.554563] rtc_cmos PNP0B00:00: registered as rtc01828second # [ 7.554657] rtc_cmos PNP0B00:00: setting system clock to 2026-10-03T00:02:57 UTC (1790985777)1829test # [ 7.440785] systemd[1]: Starting Hostname Service...1830second # [ 7.464090] systemd[1]: Finished register-nix-paths.service.1831second # [ 7.554752] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1832second # [ 7.575914] Console: switching to colour dummy device 80x251833second # [ 7.620249] cfg80211: Loading compiled-in X.509 certificates for regulatory database1834second # [ 7.482546] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1835second # [ 7.485236] systemd[1]: Finished Create SUID/SGID Wrappers.1836second # [ 7.486418] systemd[1]: Reached target System Initialization.1837second # [ 7.488614] systemd[1]: Started Discard unused filesystem blocks once a week.1838second # [ 7.489819] systemd[1]: Started Daily Cleanup of Temporary Directories.1839second # [ 7.491972] systemd[1]: Reached target Timer Units.1840second # [ 7.492974] systemd[1]: Listening on D-Bus System Message Bus Socket.1841second # [ 7.496128] systemd[1]: Listening on Nix Daemon Socket.1842second # [ 7.498074] systemd[1]: Listening on Authorization Manager Agent Helper.1843second # [ 7.499250] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1844second # [ 7.502149] systemd[1]: Reached target Socket Units.1845test # [ 7.497253] systemd-logind[638]: New seat seat0.1846test # [ 7.500351] systemd-logind[638]: Watching system buttons on /dev/input/event2 (Power Button)1847second # [ 7.505209] systemd[1]: Starting D-Bus System Message Bus...1848test # [ 7.501772] systemd-logind[638]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1849test # [ 7.503236] systemd-logind[638]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1850test # [ 7.507687] systemd[1]: Started User Login Management.1851test # [ 7.509758] systemd[1]: Starting linger-users.service...1852second # [ 7.512942] systemd-networkd[510]: /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.1853second # [ 7.518895] systemd-networkd[510]: /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.1854second # [ 7.522284] systemd-networkd[510]: lo: Link UP1855second # [ 7.524951] systemd-networkd[510]: lo: Gained carrier1856second # [ 7.531689] systemd[1]: Started Network Management.1857second # [ 7.534979] systemd-networkd[510]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1858second # [ 7.538080] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1859second # [ 7.541338] systemd-networkd[510]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1860second # [ 7.545249] systemd-networkd[510]: eth1: Link UP1861second # [ 7.547897] systemd-networkd[510]: eth1: Gained carrier1862second # [ 7.550169] systemd-networkd[510]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1863test # [ 7.559162] systemd[1]: Started Hostname Service.1864test # [ 7.562081] systemd[1]: linger-users.service: Deactivated successfully.1865second # [ 7.625621] parport_pc 00:02: reported by Plug and Play ACPI1866second # [ 7.625706] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1867second # [ 7.640729] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1868test # [ 7.567881] systemd[1]: Finished linger-users.service.1869test # [ 7.749072] kvm_amd: TSC scaling supported1870test # [ 7.749600] kvm_amd: Nested Virtualization enabled1871test # [ 7.751683] kvm_amd: Nested Paging enabled1872test # [ 7.752989] kvm_amd: LBR virtualization supported1873test # [ 7.753545] kvm_amd: Virtual GIF supported1874test # [ 7.755423] kvm_amd: Virtual NMI enabled1875second # [ 7.589569] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1876second # [ 7.644195] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1877second # [ 7.644278] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1878test # [ 7.787817] EDAC MC: Ver: 3.0.01879second # [ 7.650215] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41880test # [ 7.620083] systemd-networkd[533]: eth0: Link UP1881second # [ 7.745084] NET: Registered PF_PACKET protocol family1882test # [ 7.621786] systemd-networkd[533]: eth0: Gained carrier1883second # [ 7.635206] dbus-broker-launch[550]: Looking up NSS user entry for 'systemd-timesync'...1884second # [ 7.810618] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1885second # [ 7.811405] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1886second # [ 7.814863] [drm] Found bochs VGA, ID 0xb0c5.1887second # [ 7.815378] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1888test # [ 7.639918] systemd[1]: Started Network Manager.1889second # [ 7.643958] dbus-broker-launch[550]: NSS returned no entry for 'systemd-timesync'1890test # [ 7.641317] systemd[1]: Reached target Network.1891second # [ 7.645336] dbus-broker-launch[550]: Invalid user-name in /nix/store/nph6ql5mkwhfxxh3p5ahbh7jq01m1n7l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1892test # [ 7.646075] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1893test # [ 7.650938] systemd[1]: Starting Permit User Sessions...1894second # [ 7.837543] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1895second # [ 7.838376] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01896second # [ 7.845020] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61897second # [ 7.846359] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51898second # [ 7.678916] dbus-broker-launch[550]: 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'1899second # [ 7.682484] dbus-broker-launch[550]: 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'1900second # [ 7.689434] dbus-broker-launch[550]: 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'1901second # [ 7.693344] dbus-broker-launch[550]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/d527hwwggm2wz18p4v8cr39amcpx3g4c-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1902test # [ 7.693822] systemd[1]: Finished Permit User Sessions.1903second # [ 7.698073] systemd[1]: Started D-Bus System Message Bus.1904second # [ 7.699091] systemd[1]: Reached target Basic System.1905second # [ 7.703078] systemd[1]: Starting Network Manager Script Dispatcher Service...1906second # [ 7.707654] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1907second # [ 7.722219] systemd[1]: Starting Network Manager...1908test # [ 7.727729] systemd[1]: Started Getty on tty1.1909second # [ 7.732771] dbus-broker-launch[550]: Ready1910test # [ 7.729645] systemd[1]: Reached target Login Prompts.1911second # [ 7.738485] systemd[1]: Started backdoor.service.1912second # [ 7.747818] systemd[1]: Starting Import lastlog data into lastlog2 database...1913second # [ 7.766409] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1914test # [ 7.765573] NetworkManager[588]: <warn> [1790985777.7249] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1915second # [ 7.783129] systemd[1]: Starting Post-Boot Actions...1916test # [ 7.785836] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1917test # [ 7.787995] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1918test # [ 7.791144] systemd[1]: Reached target Multi-User System.1919second # [ 7.795691] systemd[1]: Started Reset console on configuration changes.1920test # [ 7.806782] systemd-vconsole-setup[650]: Configuration of first virtual console was skipped, ignoring remaining ones.1921test # [ 7.810129] systemd[1]: Finished Virtual Console Setup.1922test # [ 7.814258] systemd[1]: Startup finished in 767ms (kernel) + 3.471s (initrd) + 3.574s (userspace) = 7.813s.1923second # [ 7.818433] 5y3ssc77g9a48j0jag4pj6wrwmh8mnj4-wifi-secrets[558]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1924test # [ 7.831374] systemd-resolved[365]: eth0: Bus client set default route setting: yes1925test # [ 7.835146] systemd-resolved[365]: eth0: Bus client set DNS server list to: 10.0.2.31926second # [ 7.854159] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1927second # connecting to host...1928second # [ 7.861762] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1929second # [ 7.903592] nsncd[563]: Oct 03 00:02:58.020 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1930second # [ 7.907210] systemd[1]: Started Name Service Cache Daemon (nsncd).1931second # [ 7.924080] systemd[1]: Finished Post-Boot Actions.1932second # [ 7.935614] systemd[1]: Reached target Host and Network Name Lookups.1933second # [ 7.940285] systemd[1]: Reached target User and Group Name Lookups.1934second # [ 7.944541] systemd[1]: Starting User Login Management...1935second # [ 7.954083] systemd[1]: Finished Import lastlog data into lastlog2 database.1936second # [ 7.957293] systemd[1]: Started Network Manager Script Dispatcher Service.1937second # [ 7.969541] systemd[1]: Starting Virtual Console Setup...1938second # [ 7.993444] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1939second # [ 8.014220] systemd[1]: Starting Hostname Service...1940second # [ 8.031271] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1941second # [ 8.035229] systemd[1]: Stopped Virtual Console Setup.1942second # [ 8.045504] systemd[1]: Starting Virtual Console Setup...1943second # [ 8.152217] Console: switching to colour frame buffer device 160x501944second # [ 8.073607] systemd-logind[597]: Watching system buttons on /dev/input/event2 (Power Button)1945second # [ 8.259745] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1946second # [ 8.075748] systemd-logind[597]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1947second # [ 8.092878] systemd-logind[597]: New seat seat0.1948second # [ 8.097158] systemd[1]: Started User Login Management.1949second # [ 8.103935] systemd[1]: Starting linger-users.service...1950second # [ 8.286660] ppdev: user-space parallel port driver1951second # [ 8.149937] systemd[1]: Started Hostname Service.1952second # [ 8.153744] systemd[1]: linger-users.service: Deactivated successfully.1953second # [ 8.328514] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1954second # [ 8.158086] systemd[1]: Finished linger-users.service.1955second # [ 8.180105] systemd-logind[597]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1956second # [ 8.361914] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1957second # [ 8.212402] systemd-networkd[510]: eth0: Link UP1958second # [ 8.213315] systemd-networkd[510]: eth0: Gained carrier1959second # [ 8.238664] systemd[1]: Started Network Manager.1960second # [ 8.239590] systemd[1]: Reached target Network.1961second # [ 8.245541] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1962second # [ 8.249901] systemd[1]: Starting Permit User Sessions...1963second # [ 8.276498] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1964second # [ 8.282234] systemd[1]: Stopped Virtual Console Setup.1965second # [ 8.294448] systemd[1]: Starting Virtual Console Setup...1966second # [ 8.328369] systemd[1]: Finished Permit User Sessions.1967second # [ 8.331908] systemd[1]: Started Getty on tty1.1968second # [ 8.332782] systemd[1]: Reached target Login Prompts.1969second # [ 8.587374] kvm_amd: TSC scaling supported1970second # [ 8.588317] kvm_amd: Nested Virtualization enabled1971second # [ 8.589306] kvm_amd: Nested Paging enabled1972second # [ 8.590210] kvm_amd: LBR virtualization supported1973second # [ 8.420927] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1974test: (finished: waiting for unit NetworkManager.service, in 9.06 seconds)1975test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1976second # [ 8.424193] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1977second # [ 8.597969] kvm_amd: Virtual GIF supported1978second # [ 8.599515] kvm_amd: Virtual NMI enabled1979second # [ 8.428876] systemd[1]: Reached target Multi-User System.1980test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1981test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1982test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1983test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1984test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1985(finished: run the VM test script, in 9.18 seconds)1986test script finished in 9.21s1987cleanup1988kill QemuMachine (pid 48)1989second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)1990second # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1991second # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1992second # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1993test # [ 8.522614] systemd-networkd[533]: eth1: Gained IPv6LL1994kill QemuMachine (pid 47)1995test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)1996test # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1997test # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1998test # [2026-10-03T00:02:58Z INFO virtiofsd] Client disconnected, shutting down1999(finished: cleanup, in 0.19 seconds)