vm-test-run-wifi
checks.x86_64-linux.wifi
· build #197
· raw
1gi-build-x86-02: building 1225y7gfizag604b3j5nqmrsqbyww1w7-vm-test-run-wifi.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 second, test,9 vlan1,10 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh11start all VMs12second: starting vm13test: starting vm14test # Disk image does not exist, creating the virtualisation disk image...15test # Formatting '/build/vm-state-test/tmp.OXxQavoIrr', fmt=raw size=107374182416test # mke2fs 1.47.4 (6-Mar-2025)17test # Discarding device blocks: 0/262144 done18test # Creating filesystem with 262144 4k blocks and 65536 inodes19test # Filesystem UUID: 65d29526-ceda-4a8b-a90d-8863d10ed0ae20test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29test # Starting virtiofs daemons...30test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32test # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...33test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35test # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...36test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37test # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether38test # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...39test # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests40test # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests41test # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests42test: QEMU running (pid 48)43second # Disk image does not exist, creating the virtualisation disk image...44second # Formatting '/build/vm-state-second/tmp.mOdxXMS8ND', fmt=raw size=107374182445second # mke2fs 1.47.4 (6-Mar-2025)46second # Discarding device blocks: 0/262144 done47second # Creating filesystem with 262144 4k blocks and 65536 inodes48second # Filesystem UUID: 1b633b03-9926-440a-9af0-dac8625cb34149second # Superblock backups stored on blocks:50second # 32768, 98304, 163840, 22937651second # 52second # Allocating group tables: 0/8 done53second # Writing inode tables: 0/8 done54second # Creating journal (8192 blocks): done55second # Writing superblocks and filesystem accounting information: 0/8 done56second # 57second # Virtualisation disk image created.58second # Starting virtiofs daemons...59second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)60second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether61second # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...62second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)63second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether64second # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...65second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)66second # [2026-09-29T15:02:56Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether67second # [2026-09-29T15:02:56Z INFO virtiofsd] Waiting for vhost-user socket connection...68second # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests69second # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests70second # [2026-09-29T15:02:56Z INFO virtiofsd] Client connected, servicing requests71second: QEMU running (pid 47)72(finished: start all VMs, in 0.11 seconds)73test: waiting for unit NetworkManager.service74test: waiting for the VM to finish booting75test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)76second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)77test # 78test # 79test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0080second # 81second # 82second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0083test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...84test # 85test # 86test # 87test # 88test # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0089second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...90second # 91second # 92second # 93second # 94second # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0095test # Press Ctrl-B to configure iPXE (PCI 00:05.0)...96test # 97test # 98second # Press Ctrl-B to configure iPXE (PCI 00:05.0)...99second # 100second # 101test # Booting from ROM...102second # Booting from ROM...103test # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.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)... ok[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.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/l08mvpqi10lpz6qy242s0g2i9c1xra9j-nixos-system-test-test/init regInfo=/nix/.ro-store/l7w8gd50ylngxn1wb3h3dxm41ypd34gj-closure-info/registration console=ttyS0,115200n8 console=tty0106test # [ 0.000000] BIOS-provided physical RAM map:107test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable108test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved109test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved110second # [ 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/mihiadsc8lrwkw79anr4imajnfv2aj29-nixos-system-second-test/init regInfo=/nix/.ro-store/g1v56b6a75w0v7n44hgqvf6c0bkrbja3-closure-info/registration console=ttyS0,115200n8 console=tty0111second # [ 0.000000] BIOS-provided physical RAM map:112test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable113second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable114test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved115second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved116test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved117second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved118test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved119second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable120test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved121second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved122test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved123second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved124test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved125test # [ 0.000000] NX (Execute Disable) protection: active126second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved127test # [ 0.000000] APIC: Static calls initialized128test # [ 0.000000] SMBIOS 2.8 present.129second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved130second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved131test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014132test # [ 0.000000] DMI: Memory slots populated: 1/1133second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved134test # [ 0.000000] Hypervisor detected: KVM135second # [ 0.000000] NX (Execute Disable) protection: active136test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000137second # [ 0.000000] APIC: Static calls initialized138second # [ 0.000000] SMBIOS 2.8 present.139test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00140test # [ 0.000000] kvm-clock: using sched offset of 385312975 cycles141second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014142second # [ 0.000000] DMI: Memory slots populated: 1/1143test # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns144second # [ 0.000000] Hypervisor detected: KVM145test # [ 0.000003] tsc: Detected 4192.088 MHz processor146second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000147test # [ 0.000598] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000148second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00149second # [ 0.000000] kvm-clock: using sched offset of 389275598 cycles150test # [ 0.000627] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs151test # [ 0.000629] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT152second # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns153test # [ 0.002304] found SMP MP-table at [mem 0x000f5450-0x000f545f]154second # [ 0.000004] tsc: Detected 4192.088 MHz processor155test # [ 0.002315] Using GB pages for direct mapping156second # [ 0.000596] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000157test # [ 0.002403] RAMDISK: [mem 0x3e36c000-0x3ffcffff]158test # [ 0.002408] ACPI: Early table checksum verification disabled159second # [ 0.000624] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs160test # [ 0.002410] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )161second # [ 0.000626] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT162second # [ 0.002291] found SMP MP-table at [mem 0x000f5450-0x000f545f]163test # [ 0.002413] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)164second # [ 0.002303] Using GB pages for direct mapping165second # [ 0.002352] RAMDISK: [mem 0x3e36d000-0x3ffcffff]166test # [ 0.002417] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)167second # [ 0.002356] ACPI: Early table checksum verification disabled168test # [ 0.002421] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)169second # [ 0.002358] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )170test # [ 0.002423] ACPI: FACS 0x000000003FFE0000 000040171second # [ 0.002361] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)172test # [ 0.002424] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)173second # [ 0.002365] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)174test # [ 0.002425] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)175second # [ 0.002369] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)176test # [ 0.002426] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)177second # [ 0.002371] ACPI: FACS 0x000000003FFE0000 000040178test # [ 0.002427] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)179second # [ 0.002372] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)180test # [ 0.002428] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]181second # [ 0.002373] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)182second # [ 0.002375] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)183test # [ 0.002429] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]184test # [ 0.002430] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]185test # [ 0.002430] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]186second # [ 0.002376] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)187test # [ 0.002430] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]188second # [ 0.002377] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]189test # [ 0.002431] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]190second # [ 0.002378] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]191test # [ 0.002431] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]192second # [ 0.002378] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]193test # [ 0.002781] No NUMA configuration found194second # [ 0.002378] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]195test # [ 0.002782] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]196second # [ 0.002379] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]197test # [ 0.002785] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]198test # [ 0.002852] Zone ranges:199second # [ 0.002379] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]200test # [ 0.002853] DMA [mem 0x0000000000001000-0x0000000000ffffff]201second # [ 0.002380] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]202test # [ 0.002854] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]203second # [ 0.002722] No NUMA configuration found204test # [ 0.002855] Normal empty205test # [ 0.002855] Device empty206second # [ 0.002724] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]207test # [ 0.002856] Movable zone start for each node208test # [ 0.002856] Early memory node ranges209second # [ 0.002726] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]210second # [ 0.002791] Zone ranges:211test # [ 0.002856] node 0: [mem 0x0000000000001000-0x000000000009efff]212second # [ 0.002791] DMA [mem 0x0000000000001000-0x0000000000ffffff]213test # [ 0.002857] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]214second # [ 0.002793] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]215second # [ 0.002793] Normal empty216test # [ 0.002858] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]217second # [ 0.002794] Device empty218test # [ 0.002872] On node 0, zone DMA: 1 pages in unavailable ranges219second # [ 0.002794] Movable zone start for each node220second # [ 0.002795] Early memory node ranges221test # [ 0.003059] On node 0, zone DMA: 97 pages in unavailable ranges222second # [ 0.002795] node 0: [mem 0x0000000000001000-0x000000000009efff]223test # [ 0.015623] On node 0, zone DMA32: 40 pages in unavailable ranges224test # [ 0.016415] ACPI: PM-Timer IO Port: 0x608225second # [ 0.002796] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]226test # [ 0.016424] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])227second # [ 0.002797] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]228test # [ 0.016444] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23229second # [ 0.002811] On node 0, zone DMA: 1 pages in unavailable ranges230test # [ 0.016445] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)231second # [ 0.003008] On node 0, zone DMA: 97 pages in unavailable ranges232second # [ 0.015537] On node 0, zone DMA32: 40 pages in unavailable ranges233test # [ 0.016447] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)234second # [ 0.016332] ACPI: PM-Timer IO Port: 0x608235test # [ 0.016448] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)236second # [ 0.016341] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])237test # [ 0.016448] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)238second # [ 0.016359] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23239test # [ 0.016449] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)240second # [ 0.016361] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)241test # [ 0.016451] ACPI: Using ACPI (MADT) for SMP configuration information242second # [ 0.016362] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)243test # [ 0.016452] ACPI: HPET id: 0x8086a201 base: 0xfed00000244test # [ 0.016454] TSC deadline timer available245second # [ 0.016363] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)246test # [ 0.016457] CPU topo: Max. logical packages: 1247second # [ 0.016364] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)248test # [ 0.016457] CPU topo: Max. logical dies: 1249second # [ 0.016364] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)250test # [ 0.016457] CPU topo: Max. dies per package: 1251test # [ 0.016460] CPU topo: Max. threads per core: 1252second # [ 0.016366] ACPI: Using ACPI (MADT) for SMP configuration information253test # [ 0.016461] CPU topo: Num. cores per package: 1254second # [ 0.016367] ACPI: HPET id: 0x8086a201 base: 0xfed00000255test # [ 0.016461] CPU topo: Num. threads per package: 1256second # [ 0.016369] TSC deadline timer available257second # [ 0.016373] CPU topo: Max. logical packages: 1258test # [ 0.016461] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs259second # [ 0.016373] CPU topo: Max. logical dies: 1260test # [ 0.016472] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()261second # [ 0.016373] CPU topo: Max. dies per package: 1262second # [ 0.016376] CPU topo: Max. threads per core: 1263test # [ 0.016496] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]264second # [ 0.016376] CPU topo: Num. cores per package: 1265test # [ 0.016497] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]266second # [ 0.016377] CPU topo: Num. threads per package: 1267test # [ 0.016498] [mem 0x40000000-0xafffffff] available for PCI devices268second # [ 0.016377] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs269test # [ 0.016499] Booting paravirtualized kernel on KVM270second # [ 0.016388] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()271test # [ 0.016502] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns272second # [ 0.016412] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]273test # [ 0.019796] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1274second # [ 0.016414] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]275test # [ 0.021359] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152276second # [ 0.016415] [mem 0x40000000-0xafffffff] available for PCI devices277second # [ 0.016416] Booting paravirtualized kernel on KVM278test # [ 0.021390] kvm-guest: PV spinlocks disabled, single CPU279second # [ 0.016418] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns280second # [ 0.019732] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1281second # [ 0.021337] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152282second # [ 0.021368] kvm-guest: PV spinlocks disabled, single CPU283test # [ 0.021391] 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/l08mvpqi10lpz6qy242s0g2i9c1xra9j-nixos-system-test-test/init regInfo=/nix/.ro-store/l7w8gd50ylngxn1wb3h3dxm41ypd34gj-closure-info/registration console=ttyS0,115200n8 console=tty0284test # [ 0.021457] Unknown kernel command line parameters "regInfo=/nix/.ro-store/l7w8gd50ylngxn1wb3h3dxm41ypd34gj-closure-info/registration", will be passed to user space.285test # [ 0.021647] random: crng init done286test # [ 0.021647] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes287second # [ 0.021369] 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/mihiadsc8lrwkw79anr4imajnfv2aj29-nixos-system-second-test/init regInfo=/nix/.ro-store/g1v56b6a75w0v7n44hgqvf6c0bkrbja3-closure-info/registration console=ttyS0,115200n8 console=tty0288test # [ 0.022498] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)289test # [ 0.022512] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)290second # [ 0.021435] Unknown kernel command line parameters "regInfo=/nix/.ro-store/g1v56b6a75w0v7n44hgqvf6c0bkrbja3-closure-info/registration", will be passed to user space.291test # [ 0.022534] Fallback order for Node 0: 0292second # [ 0.021627] random: crng init done293test # [ 0.022536] Built 1 zonelists, mobility grouping on. Total pages: 262006294test # [ 0.022537] Policy zone: DMA32295second # [ 0.021628] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes296test # [ 0.024289] mem auto-init: stack:all(zero), heap alloc:on, heap free:off297second # [ 0.022489] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)298test # [ 0.026491] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1299second # [ 0.022499] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)300test # [ 0.028096] allocated 2097152 bytes of page_ext301second # [ 0.022522] Fallback order for Node 0: 0302test # [ 0.036925] ftrace: allocating 48804 entries in 192 pages303second # [ 0.022524] Built 1 zonelists, mobility grouping on. Total pages: 262006304test # [ 0.036927] ftrace: allocated 192 pages with 2 groups305second # [ 0.022525] Policy zone: DMA32306test # [ 0.037553] Dynamic Preempt: lazy307second # [ 0.024286] mem auto-init: stack:all(zero), heap alloc:on, heap free:off308test # [ 0.037693] rcu: Preemptible hierarchical RCU implementation.309test # [ 0.037694] rcu: RCU event tracing is enabled.310second # [ 0.026529] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1311second # [ 0.028136] allocated 2097152 bytes of page_ext312test # [ 0.037694] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.313second # [ 0.036609] ftrace: allocating 48804 entries in 192 pages314test # [ 0.037695] Trampoline variant of Tasks RCU enabled.315second # [ 0.036610] ftrace: allocated 192 pages with 2 groups316test # [ 0.037695] Rude variant of Tasks RCU enabled.317second # [ 0.037245] Dynamic Preempt: lazy318test # [ 0.037695] Tracing variant of Tasks RCU enabled.319second # [ 0.037380] rcu: Preemptible hierarchical RCU implementation.320test # [ 0.037696] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.321second # [ 0.037381] rcu: RCU event tracing is enabled.322test # [ 0.037697] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1323second # [ 0.037382] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.324second # [ 0.037383] Trampoline variant of Tasks RCU enabled.325test # [ 0.037712] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.326second # [ 0.037383] Rude variant of Tasks RCU enabled.327second # [ 0.037383] Tracing variant of Tasks RCU enabled.328test # [ 0.037713] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.329second # [ 0.037384] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.330test # [ 0.037714] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.331second # [ 0.037384] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1332test # [ 0.040881] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16333second # [ 0.037395] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.334test # [ 0.041120] rcu: srcu_init: Setting srcu_struct sizes based on contention.335second # [ 0.037396] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.336test # [ 0.041125] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns337second # [ 0.037397] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.338test # [ 0.041275] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)339second # [ 0.040580] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16340test # [ 0.046434] Console: colour VGA+ 80x25341test # [ 0.046436] printk: legacy console [tty0] enabled342second # [ 0.040812] rcu: srcu_init: Setting srcu_struct sizes based on contention.343test # [ 0.076629] printk: legacy console [ttyS0] enabled344test # [ 0.210911] ACPI: Core revision 20250807345second # [ 0.040816] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns346second # [ 0.040964] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)347test # [ 0.211978] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns348second # [ 0.046110] Console: colour VGA+ 80x25349second # [ 0.046112] printk: legacy console [tty0] enabled350test # [ 0.213912] APIC: Switch to symmetric I/O mode setup351second # [ 0.076274] printk: legacy console [ttyS0] enabled352test # [ 0.215098] x2apic enabled353second # [ 0.211054] ACPI: Core revision 20250807354test # [ 0.215925] APIC: Switched APIC routing to: physical x2apic355second # [ 0.212121] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns356test # [ 0.217889] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1357second # [ 0.214055] APIC: Switch to symmetric I/O mode setup358second # [ 0.215239] x2apic enabled359test # [ 0.219122] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns360second # [ 0.216061] APIC: Switched APIC routing to: physical x2apic361test # [ 0.221197] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)362second # [ 0.218015] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1363test # [ 0.223272] x86/cpu: User Mode Instruction Prevention (UMIP) activated364test # [ 0.224309] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127365second # [ 0.219253] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns366test # [ 0.225196] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0367second # [ 0.221320] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)368test # [ 0.226199] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto369second # [ 0.223353] x86/cpu: User Mode Instruction Prevention (UMIP) activated370second # [ 0.224420] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127371test # [ 0.228196] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl372second # [ 0.225319] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0373test # [ 0.229196] Spectre V2 : Mitigation: Enhanced / Automatic IBRS374test # [ 0.231136] Speculative Return Stack Overflow: Mitigation: Safe RET375second # [ 0.226321] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto376test # [ 0.232196] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization377second # [ 0.228319] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl378second # [ 0.229319] Spectre V2 : Mitigation: Enhanced / Automatic IBRS379second # [ 0.230319] Speculative Return Stack Overflow: Mitigation: Safe RET380test # [ 0.233201] Spectre V2 : Enabling IBPB for BPF381second # [ 0.232319] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization382test # [ 0.235197] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier383test # [ 0.236196] active return thunk: srso_alias_return_thunk384test # [ 0.237216] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'385second # [ 0.233324] Spectre V2 : Enabling IBPB for BPF386test # [ 0.238196] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'387second # [ 0.235320] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier388test # [ 0.240196] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'389second # [ 0.236326] active return thunk: srso_alias_return_thunk390test # [ 0.241196] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'391second # [ 0.237341] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'392test # [ 0.242196] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'393second # [ 0.238319] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'394test # [ 0.243196] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'395second # [ 0.239319] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'396test # [ 0.245196] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'397second # [ 0.240319] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'398test # [ 0.246196] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'399second # [ 0.241319] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'400test # [ 0.248196] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'401second # [ 0.243319] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'402test # [ 0.249196] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256403second # [ 0.244319] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'404test # [ 0.250196] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64405second # [ 0.245319] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'406test # [ 0.251196] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512407test # [ 0.252196] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024408second # [ 0.246319] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'409test # [ 0.253196] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8410second # [ 0.247319] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256411test # [ 0.255196] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16412second # [ 0.248319] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64413test # [ 0.256196] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24414second # [ 0.249319] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512415second # [ 0.251319] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024416test # [ 0.257196] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.417second # [ 0.252320] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8418second # [ 0.253319] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16419second # [ 0.254319] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24420second # [ 0.256319] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.421test # [ 0.285116] Freeing SMP alternatives memory: 44K422test # [ 0.285959] pid_max: default: 32768 minimum: 301423test # [ 0.287018] LSM: initializing lsm=capability,landlock,yama,bpf,ima424test # [ 0.288282] landlock: Up and running.425test # [ 0.289196] Yama: becoming mindful.426test # [ 0.290257] LSM support for eBPF active427second # [ 0.283808] Freeing SMP alternatives memory: 44K428second # [ 0.284320] pid_max: default: 32768 minimum: 301429test # [ 0.291199] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)430second # [ 0.285380] LSM: initializing lsm=capability,landlock,yama,bpf,ima431test # [ 0.292215] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)432second # [ 0.286410] landlock: Up and running.433second # [ 0.287914] Yama: becoming mindful.434second # [ 0.288501] LSM support for eBPF active435test # [ 0.293935] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)436second # [ 0.289392] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)437test # [ 0.294607] Performance Events: Fam17h+ core perfctr, AMD PMU driver.438second # [ 0.290336] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)439test # [ 0.295200] ... version: 2440test # [ 0.296074] ... bit width: 48441test # [ 0.296902] ... generic counters: 6442second # [ 0.292763] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)443test # [ 0.297202] ... generic bitmap: 000000000000003f444test # [ 0.298197] ... fixed-purpose counters: 0445second # [ 0.293706] Performance Events: Fam17h+ core perfctr, AMD PMU driver.446test # [ 0.299097] ... fixed-purpose bitmap: 0000000000000000447second # [ 0.294322] ... version: 2448test # [ 0.300123] ... value mask: 0000ffffffffffff449second # [ 0.295215] ... bit width: 48450second # [ 0.296024] ... generic counters: 6451test # [ 0.301107] ... max period: 00007fffffffffff452second # [ 0.296329] ... generic bitmap: 000000000000003f453test # [ 0.302099] ... global_ctrl mask: 000000000000003f454second # [ 0.297320] ... fixed-purpose counters: 0455test # [ 0.303189] signal: max sigframe size: 3376456second # [ 0.298215] ... fixed-purpose bitmap: 0000000000000000457test # [ 0.303955] rcu: Hierarchical SRCU implementation.458second # [ 0.299226] ... value mask: 0000ffffffffffff459test # [ 0.304201] rcu: Max phase no-delay instances is 400.460second # [ 0.300237] ... max period: 00007fffffffffff461second # [ 0.301235] ... global_ctrl mask: 000000000000003f462second # [ 0.302327] signal: max sigframe size: 3376463test # [ 0.308258] smp: Bringing up secondary CPUs ...464second # [ 0.303283] rcu: Hierarchical SRCU implementation.465test # [ 0.309208] smp: Brought up 1 node, 1 CPU466second # [ 0.304118] rcu: Max phase no-delay instances is 400.467test # [ 0.310063] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)468test # [ 0.311345] Memory: 943000K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 97576K reserved, 0K cma-reserved)469second # [ 0.308185] smp: Bringing up secondary CPUs ...470test # [ 0.312369] devtmpfs: initialized471second # [ 0.309084] smp: Brought up 1 node, 1 CPU472test # [ 0.313259] x86/mm: Memory block size: 128MB473second # [ 0.309321] smpboot: Total of 1 processors activated (8384.17 BogoMIPS)474test # [ 0.314888] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)475second # [ 0.310459] Memory: 943008K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 97572K reserved, 0K cma-reserved)476test # [ 0.315219] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).477second # [ 0.311487] devtmpfs: initialized478test # [ 0.316260] pinctrl core: initialized pinctrl subsystem479second # [ 0.312343] x86/mm: Memory block size: 128MB480test # [ 0.317445] PM: RTC time: 15:02:56, date: 2026-09-29481second # [ 0.313948] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)482second # [ 0.314342] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).483test # [ 0.320158] NET: Registered PF_NETLINK/PF_ROUTE protocol family484second # [ 0.315388] pinctrl core: initialized pinctrl subsystem485test # [ 0.321461] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations486second # [ 0.316572] PM: RTC time: 15:02:56, date: 2026-09-29487test # [ 0.322212] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations488test # [ 0.323312] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations489second # [ 0.319267] NET: Registered PF_NETLINK/PF_ROUTE protocol family490test # [ 0.324204] audit: initializing netlink subsys (disabled)491second # [ 0.320576] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations492test # [ 0.325404] thermal_sys: Registered thermal governor 'fair_share'493second # [ 0.321336] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations494test # [ 0.325406] thermal_sys: Registered thermal governor 'bang_bang'495test # [ 0.326198] thermal_sys: Registered thermal governor 'step_wise'496second # [ 0.322428] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations497second # [ 0.323327] audit: initializing netlink subsys (disabled)498test # [ 0.327200] audit: type=2000 audit(1790694177.398:1): state=initialized audit_enabled=0 res=1499second # [ 0.324524] thermal_sys: Registered thermal governor 'fair_share'500test # [ 0.329199] thermal_sys: Registered thermal governor 'user_space'501second # [ 0.324526] thermal_sys: Registered thermal governor 'bang_bang'502test # [ 0.329200] thermal_sys: Registered thermal governor 'power_allocator'503test # [ 0.330224] cpuidle: using governor menu504second # [ 0.325321] thermal_sys: Registered thermal governor 'step_wise'505second # [ 0.326323] audit: type=2000 audit(1790694177.402:1): state=initialized audit_enabled=0 res=1506test # [ 0.332881] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5507second # [ 0.328322] thermal_sys: Registered thermal governor 'user_space'508test # [ 0.333456] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]509second # [ 0.328323] thermal_sys: Registered thermal governor 'power_allocator'510second # [ 0.329333] cpuidle: using governor menu511test # [ 0.334199] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry512test # [ 0.335206] PCI: Using configuration type 1 for base access513second # [ 0.331987] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5514test # [ 0.336344] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.515second # [ 0.332556] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]516second # [ 0.333323] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry517second # [ 0.334330] PCI: Using configuration type 1 for base access518second # [ 0.335466] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.519test # [ 0.341366] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages520test # [ 0.342197] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page521second # [ 0.340513] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages522second # [ 0.341320] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page523test # [ 0.347197] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages524test # [ 0.348197] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page525second # [ 0.346320] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages526second # [ 0.347320] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page527test # [ 0.357259] ACPI: Added _OSI(Module Device)528test # [ 0.358142] ACPI: Added _OSI(Processor Device)529test # [ 0.358919] ACPI: Added _OSI(Processor Aggregator Device)530second # [ 0.355629] ACPI: Added _OSI(Module Device)531second # [ 0.356321] ACPI: Added _OSI(Processor Device)532second # [ 0.357231] ACPI: Added _OSI(Processor Aggregator Device)533test # [ 0.363032] ACPI: 1 ACPI AML tables successfully acquired and loaded534test # [ 0.366961] ACPI: Interpreter enabled535test # [ 0.367210] ACPI: PM: (supports S0 S3 S4 S5)536test # [ 0.368091] ACPI: Using IOAPIC for interrupt routing537second # [ 0.364155] ACPI: 1 ACPI AML tables successfully acquired and loaded538test # [ 0.371249] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug539second # [ 0.368135] ACPI: Interpreter enabled540test # [ 0.372197] PCI: Using E820 reservations for host bridge windows541second # [ 0.368922] ACPI: PM: (supports S0 S3 S4 S5)542second # [ 0.369321] ACPI: Using IOAPIC for interrupt routing543test # [ 0.374361] ACPI: Enabled 2 GPEs in block 00 to 3F544second # [ 0.372300] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug545second # [ 0.373320] PCI: Using E820 reservations for host bridge windows546test # [ 0.378347] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])547second # [ 0.374442] ACPI: Enabled 2 GPEs in block 00 to 3F548test # [ 0.379202] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]549test # [ 0.380256] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]550test # [ 0.381293] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]551second # [ 0.378516] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])552test # [ 0.382586] PCI host bridge to bus 0000:00553second # [ 0.379325] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]554test # [ 0.383201] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]555second # [ 0.380380] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]556test # [ 0.384198] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]557second # [ 0.381415] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]558test # [ 0.385198] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]559second # [ 0.382707] PCI host bridge to bus 0000:00560test # [ 0.386198] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]561second # [ 0.383324] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]562test # [ 0.387198] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]563second # [ 0.384321] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]564test # [ 0.388198] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]565second # [ 0.385321] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]566test # [ 0.389198] pci_bus 0000:00: root bus resource [bus 00-ff]567second # [ 0.386321] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]568test # [ 0.390276] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint569second # [ 0.387321] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]570test # [ 0.391828] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint571second # [ 0.388321] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]572second # [ 0.389321] pci_bus 0000:00: root bus resource [bus 00-ff]573second # [ 0.390434] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint574test # [ 0.394142] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]575second # [ 0.391967] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint576test # [ 0.395217] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]577test # [ 0.396236] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]578test # [ 0.397355] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]579second # [ 0.394265] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]580second # [ 0.395340] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]581test # [ 0.398890] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint582second # [ 0.396358] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]583test # [ 0.401238] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]584second # [ 0.397487] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]585test # [ 0.402208] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]586test # [ 0.403236] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]587second # [ 0.399044] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint588test # [ 0.404208] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]589second # [ 0.401366] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]590test # [ 0.406198] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint591second # [ 0.402330] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]592second # [ 0.403358] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]593test # [ 0.408887] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]594second # [ 0.404330] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]595test # [ 0.409208] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]596test # [ 0.410235] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]597second # [ 0.406317] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint598test # [ 0.412050] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint599second # [ 0.408983] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]600second # [ 0.409331] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]601test # [ 0.414208] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]602second # [ 0.410361] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]603test # [ 0.415208] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]604test # [ 0.416240] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]605second # [ 0.412191] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint606test # [ 0.418068] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint607second # [ 0.414331] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]608second # [ 0.415330] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]609test # [ 0.420208] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]610second # [ 0.416359] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]611test # [ 0.421208] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]612test # [ 0.422235] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]613second # [ 0.418194] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint614test # [ 0.423208] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]615second # [ 0.420331] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]616test # [ 0.425047] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint617second # [ 0.421331] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]618second # [ 0.422358] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]619test # [ 0.427019] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]620second # [ 0.423331] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]621test # [ 0.428192] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]622second # [ 0.425176] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint623test # [ 0.430053] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint624second # [ 0.427138] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]625test # [ 0.432130] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]626second # [ 0.428305] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]627test # [ 0.433185] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]628second # [ 0.430227] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint629test # [ 0.435103] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint630second # [ 0.432625] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]631test # [ 0.436997] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]632second # [ 0.433357] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]633test # [ 0.438207] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]634second # [ 0.435303] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint635test # [ 0.440058] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint636second # [ 0.437243] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]637test # [ 0.442079] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]638second # [ 0.438320] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]639test # [ 0.443197] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]640test # [ 0.445093] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint641second # [ 0.440212] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint642second # [ 0.442214] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]643test # [ 0.447217] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]644second # [ 0.443320] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]645test # [ 0.448208] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]646test # [ 0.449240] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]647second # [ 0.445230] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint648test # [ 0.451112] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint649second # [ 0.447339] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]650second # [ 0.448331] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]651test # [ 0.453216] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]652second # [ 0.449360] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]653test # [ 0.454208] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]654test # [ 0.455237] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]655second # [ 0.451214] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint656test # [ 0.457420] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint657second # [ 0.453331] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]658second # [ 0.454331] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]659test # [ 0.458855] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]660second # [ 0.455359] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]661second # [ 0.457419] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint662second # [ 0.458973] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]663test # [ 0.459461] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint664test # [ 0.461949] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]665test # [ 0.463331] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint666second # [ 0.459571] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint667test # [ 0.464872] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]668second # [ 0.461962] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]669test # [ 0.465486] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint670second # [ 0.462581] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint671test # [ 0.466787] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]672second # [ 0.464012] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]673test # [ 0.467519] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint674second # [ 0.464609] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint675test # [ 0.468678] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO676second # [ 0.465923] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]677test # [ 0.469526] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint678second # [ 0.466650] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint679test # [ 0.471084] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]680second # [ 0.467796] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO681test # [ 0.472063] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]682second # [ 0.468664] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint683test # [ 0.473647] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint684test # [ 0.475020] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]685second # [ 0.470513] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]686second # [ 0.471333] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]687second # [ 0.472787] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint688second # [ 0.473985] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]689test # [ 0.480963] ACPI: PCI: Interrupt link LNKA configured for IRQ 10690test # [ 0.481312] ACPI: PCI: Interrupt link LNKB configured for IRQ 10691test # [ 0.482319] ACPI: PCI: Interrupt link LNKC configured for IRQ 11692test # [ 0.483309] ACPI: PCI: Interrupt link LNKD configured for IRQ 11693second # [ 0.478885] ACPI: PCI: Interrupt link LNKA configured for IRQ 10694test # [ 0.484310] ACPI: PCI: Interrupt link LNKE configured for IRQ 10695second # [ 0.479448] ACPI: PCI: Interrupt link LNKB configured for IRQ 10696test # [ 0.485307] ACPI: PCI: Interrupt link LNKF configured for IRQ 10697second # [ 0.480433] ACPI: PCI: Interrupt link LNKC configured for IRQ 11698test # [ 0.486309] ACPI: PCI: Interrupt link LNKG configured for IRQ 11699second # [ 0.481433] ACPI: PCI: Interrupt link LNKD configured for IRQ 11700test # [ 0.487354] ACPI: PCI: Interrupt link LNKH configured for IRQ 11701second # [ 0.482430] ACPI: PCI: Interrupt link LNKE configured for IRQ 10702test # [ 0.488247] ACPI: PCI: Interrupt link GSIA configured for IRQ 16703second # [ 0.483432] ACPI: PCI: Interrupt link LNKF configured for IRQ 10704test # [ 0.489214] ACPI: PCI: Interrupt link GSIB configured for IRQ 17705second # [ 0.484432] ACPI: PCI: Interrupt link LNKG configured for IRQ 11706test # [ 0.490213] ACPI: PCI: Interrupt link GSIC configured for IRQ 18707second # [ 0.485429] ACPI: PCI: Interrupt link LNKH configured for IRQ 11708test # [ 0.491213] ACPI: PCI: Interrupt link GSID configured for IRQ 19709second # [ 0.486366] ACPI: PCI: Interrupt link GSIA configured for IRQ 16710test # [ 0.492210] ACPI: PCI: Interrupt link GSIE configured for IRQ 20711second # [ 0.487333] ACPI: PCI: Interrupt link GSIB configured for IRQ 17712test # [ 0.493210] ACPI: PCI: Interrupt link GSIF configured for IRQ 21713second # [ 0.488335] ACPI: PCI: Interrupt link GSIC configured for IRQ 18714test # [ 0.494210] ACPI: PCI: Interrupt link GSIG configured for IRQ 22715second # [ 0.489335] ACPI: PCI: Interrupt link GSID configured for IRQ 19716test # [ 0.495210] ACPI: PCI: Interrupt link GSIH configured for IRQ 23717second # [ 0.490336] ACPI: PCI: Interrupt link GSIE configured for IRQ 20718test # [ 0.497001] iommu: Default domain type: Translated719second # [ 0.491336] ACPI: PCI: Interrupt link GSIF configured for IRQ 21720test # [ 0.497975] iommu: DMA domain TLB invalidation policy: lazy mode721second # [ 0.492332] ACPI: PCI: Interrupt link GSIG configured for IRQ 22722test # [ 0.499358] ACPI: bus type USB registered723second # [ 0.493333] ACPI: PCI: Interrupt link GSIH configured for IRQ 23724test # [ 0.500255] usbcore: registered new interface driver usbfs725test # [ 0.501211] usbcore: registered new interface driver hub726second # [ 0.495141] iommu: Default domain type: Translated727test # [ 0.502209] usbcore: registered new device driver usb728second # [ 0.496104] iommu: DMA domain TLB invalidation policy: lazy mode729test # [ 0.503843] NetLabel: Initializing730second # [ 0.497484] ACPI: bus type USB registered731test # [ 0.504209] NetLabel: domain hash size = 128732second # [ 0.498377] usbcore: registered new interface driver usbfs733test # [ 0.505117] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO734second # [ 0.499334] usbcore: registered new interface driver hub735test # [ 0.506151] NetLabel: unlabeled traffic allowed by default736second # [ 0.500332] usbcore: registered new device driver usb737test # [ 0.507105] PCI: Using ACPI for IRQ routing738second # [ 0.501964] NetLabel: Initializing739second # [ 0.502324] NetLabel: domain hash size = 128740second # [ 0.503229] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO741second # [ 0.504282] NetLabel: unlabeled traffic allowed by default742second # [ 0.505228] PCI: Using ACPI for IRQ routing743test # [ 0.582486] pci 0000:00:01.0: vgaarb: setting as boot VGA device744test # [ 0.583194] pci 0000:00:01.0: vgaarb: bridge control possible745test # [ 0.583194] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none746test # [ 0.583199] vgaarb: loaded747test # [ 0.583981] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0748second # [ 0.580767] pci 0000:00:01.0: vgaarb: setting as boot VGA device749test # [ 0.584975] hpet0: 3 comparators, 64-bit 100.000000 MHz counter750second # [ 0.581317] pci 0000:00:01.0: vgaarb: bridge control possible751second # [ 0.581317] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none752second # [ 0.581322] vgaarb: loaded753second # [ 0.582101] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0754second # [ 0.583092] hpet0: 3 comparators, 64-bit 100.000000 MHz counter755test # [ 0.590258] clocksource: Switched to clocksource kvm-clock756test # [ 0.591913] VFS: Disk quotas dquot_6.6.0757test # [ 0.594146] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)758test # [ 0.595670] pnp: PnP ACPI init759test # [ 0.596553] ACPI: IRQ 4 override to edge(!), high(!)760second # [ 0.590377] clocksource: Switched to clocksource kvm-clock761test # [ 0.597675] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved762second # [ 0.592059] VFS: Disk quotas dquot_6.6.0763test # [ 0.599454] pnp: PnP ACPI: found 5 devices764second # [ 0.594256] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)765second # [ 0.595793] pnp: PnP ACPI init766second # [ 0.596648] ACPI: IRQ 4 override to edge(!), high(!)767second # [ 0.597757] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved768second # [ 0.599523] pnp: PnP ACPI: found 5 devices769test # [ 0.606515] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns770test # [ 0.608259] clocksource: Switched to clocksource acpi_pm771test # [ 0.609444] NET: Registered PF_INET protocol family772test # [ 0.610664] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)773second # [ 0.606585] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns774second # [ 0.608333] clocksource: Switched to clocksource acpi_pm775second # [ 0.609488] NET: Registered PF_INET protocol family776second # [ 0.610692] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)777test # [ 0.623584] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)778test # [ 0.625362] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)779test # [ 0.626915] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)780test # [ 0.628513] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)781test # [ 0.629980] TCP: Hash tables configured (established 8192 bind 8192)782second # [ 0.623434] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)783test # [ 0.631325] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)784second # [ 0.625206] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)785test # [ 0.632842] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)786second # [ 0.626759] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)787test # [ 0.634220] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)788second # [ 0.628333] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)789test # [ 0.635649] NET: Registered PF_UNIX/PF_LOCAL protocol family790test # [ 0.636822] NET: Registered PF_XDP protocol family791second # [ 0.629827] TCP: Hash tables configured (established 8192 bind 8192)792test # [ 0.637855] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]793second # [ 0.631152] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)794test # [ 0.639114] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]795second # [ 0.632652] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)796test # [ 0.640350] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]797second # [ 0.633998] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)798test # [ 0.641704] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]799second # [ 0.635435] NET: Registered PF_UNIX/PF_LOCAL protocol family800test # [ 0.643065] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]801second # [ 0.636665] NET: Registered PF_XDP protocol family802second # [ 0.637741] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]803test # [ 0.644506] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]804second # [ 0.638983] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]805test # [ 0.646456] ACPI: \_SB_.GSIA: Enabled at IRQ 16806second # [ 0.640249] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]807test # [ 0.648525] ACPI: \_SB_.GSIB: Enabled at IRQ 17808second # [ 0.641714] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]809test # [ 0.650480] ACPI: \_SB_.GSIC: Enabled at IRQ 18810second # [ 0.643146] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]811second # [ 0.644633] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]812test # [ 0.652401] ACPI: \_SB_.GSID: Enabled at IRQ 19813second # [ 0.646714] ACPI: \_SB_.GSIA: Enabled at IRQ 16814test # [ 0.654117] PCI: CLS 0 bytes, default 64815test # [ 0.655190] Trying to unpack rootfs image as initramfs...816second # [ 0.648750] ACPI: \_SB_.GSIB: Enabled at IRQ 17817second # [ 0.650644] ACPI: \_SB_.GSIC: Enabled at IRQ 18818second # [ 0.652552] ACPI: \_SB_.GSID: Enabled at IRQ 19819test # [ 0.659237] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns820second # [ 0.654224] PCI: CLS 0 bytes, default 64821second # [ 0.655260] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns822second # [ 0.657351] Trying to unpack rootfs image as initramfs...823test # [ 0.691276] Initialise system trusted keyrings824test # [ 0.694154] workingset: timestamp_bits=40 max_order=18 bucket_order=0825second # [ 0.692847] Initialise system trusted keyrings826second # [ 0.696574] workingset: timestamp_bits=40 max_order=18 bucket_order=0827test # [ 0.709560] Key type asymmetric registered828test # [ 0.713119] Asymmetric key parser 'x509' registered829test # [ 0.714223] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)830second # [ 0.712139] Key type asymmetric registered831test # [ 0.720215] io scheduler mq-deadline registered832test # [ 0.721207] io scheduler kyber registered833second # [ 0.717543] Asymmetric key parser 'x509' registered834test # [ 0.724564] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled835second # [ 0.718632] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)836test # [ 0.728107] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A837second # [ 0.722644] io scheduler mq-deadline registered838second # [ 0.723631] io scheduler kyber registered839test # [ 0.733505] Linux agpgart interface v0.103840second # [ 0.727001] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled841test # [ 0.734429] ACPI: bus type drm_connector registered842test # [ 0.737554] usbcore: registered new interface driver usbserial_generic843second # [ 0.730544] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A844test # [ 0.738914] usbserial: USB Serial support registered for generic845test # [ 0.742105] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.846second # [ 0.736219] Linux agpgart interface v0.103847test # [ 0.742105] Please enable it if your BIOS has the CPPC option.848second # [ 0.737195] ACPI: bus type drm_connector registered849test # [ 0.744894] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled850second # [ 0.739912] usbcore: registered new interface driver usbserial_generic851second # [ 0.741274] usbserial: USB Serial support registered for generic852test # [ 0.749222] drop_monitor: Initializing network drop monitor service853test # [ 0.750678] NET: Registered PF_INET6 protocol family854second # [ 0.744537] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.855second # [ 0.744537] Please enable it if your BIOS has the CPPC option.856second # [ 0.747284] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled857test # [ 0.756382] Segment Routing with IPv6858test # [ 0.759119] In-situ OAM (IOAM) with IPv6859test # [ 0.760298] IPI shorthand broadcast: enabled860second # [ 0.753645] drop_monitor: Initializing network drop monitor service861second # [ 0.755035] NET: Registered PF_INET6 protocol family862second # [ 0.758930] Segment Routing with IPv6863test # [ 0.765740] sched_clock: Marking stable (590020773, 175069153)->(847858110, -82768184)864second # [ 0.762542] In-situ OAM (IOAM) with IPv6865second # [ 0.763688] IPI shorthand broadcast: enabled866test # [ 0.772243] registered taskstats version 1867test # [ 0.773319] Loading compiled-in X.509 certificates868second # [ 0.769057] sched_clock: Marking stable (593020948, 175501256)->(853476684, -84954480)869second # [ 0.774775] registered taskstats version 1870second # [ 0.775828] Loading compiled-in X.509 certificates871test # [ 0.788105] Demotion targets for Node 0: null872test # [ 0.789150] Key type .fscrypt registered873test # [ 0.789974] Key type fscrypt-provisioning registered874test # [ 0.793182] ima: No TPM chip found, activating TPM-bypass!875test # [ 0.794313] ima: Allocated hash algorithm: sha1876test # [ 0.797136] ima: No architecture policies found877second # [ 0.792537] Demotion targets for Node 0: null878test # [ 0.800102] PM: Magic number: 10:750:33879second # [ 0.793584] Key type .fscrypt registered880second # [ 0.794421] Key type fscrypt-provisioning registered881test # [ 0.801662] RAS: Correctable Errors collector initialized.882second # [ 0.797647] ima: No TPM chip found, activating TPM-bypass!883second # [ 0.798781] ima: Allocated hash algorithm: sha1884second # [ 0.801565] ima: No architecture policies found885second # [ 0.802664] PM: Magic number: 10:750:33886test # [ 0.809868] clk: Disabling unused clocks887second # [ 0.804202] RAS: Correctable Errors collector initialized.888test # [ 0.812108] PM: genpd: Disabling unused power domains889second # [ 0.814262] clk: Disabling unused clocks890second # [ 0.815166] PM: genpd: Disabling unused power domains891second # [ 0.913426] Freeing initrd memory: 29068K892test # [ 0.922705] Freeing initrd memory: 29072K893second # [ 0.916369] Freeing unused decrypted memory: 2028K894test # [ 0.925475] Freeing unused decrypted memory: 2028K895second # [ 0.918819] Freeing unused kernel image (initmem) memory: 3656K896second # [ 0.920091] Write protecting the kernel read-only data: 32768k897test # [ 0.927897] Freeing unused kernel image (initmem) memory: 3656K898second # [ 0.921952] Freeing unused kernel image (text/rodata gap) memory: 1168K899test # [ 0.929196] Write protecting the kernel read-only data: 32768k900second # [ 0.923592] Freeing unused kernel image (rodata/data gap) memory: 676K901test # [ 0.931044] Freeing unused kernel image (text/rodata gap) memory: 1168K902test # [ 0.932697] Freeing unused kernel image (rodata/data gap) memory: 676K903second # [ 0.955864] x86/mm: Checked W+X mappings: passed, no W+X pages found.904second # [ 0.957172] Run /init as init process905test # [ 0.964964] x86/mm: Checked W+X mappings: passed, no W+X pages found.906test # [ 0.966275] Run /init as init process907second # [ 0.965260] systemd[1]: Inserted module 'autofs4'908test # [ 0.974372] systemd[1]: Inserted module 'autofs4'909second # [ 0.979960] fuse: init (API version 7.45)910test # [ 0.989380] fuse: init (API version 7.45)911second # [ 0.985865] ACPI: \_SB_.GSIG: Enabled at IRQ 22912second # [ 0.988376] ACPI: \_SB_.GSIH: Enabled at IRQ 23913test # [ 0.995528] ACPI: \_SB_.GSIG: Enabled at IRQ 22914test # [ 0.998013] ACPI: \_SB_.GSIH: Enabled at IRQ 23915second # [ 0.991473] ACPI: \_SB_.GSIE: Enabled at IRQ 20916second # [ 0.993722] ACPI: \_SB_.GSIF: Enabled at IRQ 21917test # [ 1.001182] ACPI: \_SB_.GSIE: Enabled at IRQ 20918test # [ 1.003384] ACPI: \_SB_.GSIF: Enabled at IRQ 21919second # [ 0.998887] virtiofs virtio5: discovered new tag: nix-store920second # [ 1.000934] virtiofs virtio5: virtio_fs_setup_dax: No cache capability921test # [ 1.008841] virtiofs virtio5: discovered new tag: nix-store922test # [ 1.010910] virtiofs virtio5: virtio_fs_setup_dax: No cache capability923second # [ 1.007588] virtiofs virtio6: discovered new tag: shared924second # [ 1.009648] virtiofs virtio6: virtio_fs_setup_dax: No cache capability925test # [ 1.018356] virtiofs virtio6: discovered new tag: shared926second # [ 1.013014] virtiofs virtio7: discovered new tag: xchg927test # [ 1.020378] virtiofs virtio6: virtio_fs_setup_dax: No cache capability928second # [ 1.015007] virtiofs virtio7: virtio_fs_setup_dax: No cache capability929test # [ 1.024126] virtiofs virtio7: discovered new tag: xchg930test # [ 1.026385] virtiofs virtio7: virtio_fs_setup_dax: No cache capability931second # [ 1.033776] systemd[1]: Successfully made /usr/ read-only.932test # [ 1.045332] systemd[1]: Successfully made /usr/ read-only.933second # [ 1.369984] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)934second # [ 1.375851] systemd[1]: Detected virtualization kvm.935second # [ 1.376910] systemd[1]: Detected architecture x86-64.936second # [ 1.377969] systemd[1]: Running in initrd.937second # [ 1.379090] systemd[1]: Initializing machine ID from random generator.938test # [ 1.381273] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)939second # [ 1.380554] systemd[1]: Hostname set to <second>.940test # [ 1.387646] systemd[1]: Detected virtualization kvm.941test # [ 1.388786] systemd[1]: Detected architecture x86-64.942test # [ 1.389871] systemd[1]: Running in initrd.943test # [ 1.390989] systemd[1]: Initializing machine ID from random generator.944test # [ 1.392407] systemd[1]: Hostname set to <test>.945second # [ 1.552249] systemd[1]: bpf-restrict-fs: LSM BPF program attached946test # [ 1.560792] systemd[1]: bpf-restrict-fs: LSM BPF program attached947second # [ 1.581373] systemd[1]: Queued start job for default target Initrd Default Target.948test # [ 1.590430] systemd[1]: Queued start job for default target Initrd Default Target.949second # [ 1.585721] systemd[1]: Created slice Slice /system/modprobe.950test # [ 1.594303] systemd[1]: Created slice Slice /system/modprobe.951second # [ 1.587243] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.952second # [ 1.589012] systemd[1]: Expecting device /dev/disk/by-label/nixos...953test # [ 1.595874] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.954second # [ 1.590421] systemd[1]: Reached target Path Units.955test # [ 1.597722] systemd[1]: Expecting device /dev/disk/by-label/nixos...956second # [ 1.591590] systemd[1]: Reached target Slice Units.957test # [ 1.599225] systemd[1]: Reached target Path Units.958second # [ 1.592731] systemd[1]: Reached target Swaps.959test # [ 1.600406] systemd[1]: Reached target Slice Units.960second # [ 1.593782] systemd[1]: Reached target Timer Units.961test # [ 1.601601] systemd[1]: Reached target Swaps.962second # [ 1.595005] systemd[1]: Listening on D-Bus System Message Bus Socket.963test # [ 1.602683] systemd[1]: Reached target Timer Units.964second # [ 1.596596] systemd[1]: Listening on Journal Socket (/dev/log).965test # [ 1.603946] systemd[1]: Listening on D-Bus System Message Bus Socket.966second # [ 1.598051] systemd[1]: Listening on Journal Sockets.967test # [ 1.605626] systemd[1]: Listening on Journal Socket (/dev/log).968test # [ 1.607119] systemd[1]: Listening on Journal Sockets.969second # [ 1.599304] systemd[1]: Listening on udev Control Socket.970second # [ 1.608810] systemd[1]: Listening on udev Kernel Socket.971test # [ 1.608329] systemd[1]: Listening on udev Control Socket.972second # [ 1.610021] systemd[1]: Reached target Socket Units.973test # [ 1.618084] systemd[1]: Listening on udev Kernel Socket.974second # [ 1.611879] systemd[1]: Starting Create List of Static Device Nodes...975test # [ 1.619281] systemd[1]: Reached target Socket Units.976test # [ 1.622131] systemd[1]: Starting Create List of Static Device Nodes...977test # [ 1.625227] systemd[1]: Starting Load Kernel Module configfs...978second # [ 1.618663] systemd[1]: Starting Load Kernel Module configfs...979test # [ 1.632641] systemd[1]: Starting Journal Service...980second # [ 1.629016] systemd[1]: Starting Journal Service...981test # [ 1.639443] systemd[1]: Starting Load Kernel Modules...982test # [ 1.642165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os983second # [ 1.637634] systemd[1]: Starting Load Kernel Modules...984test # [ 1.647580] systemd[1]: Starting Coldplug All udev Devices...985second # [ 1.642140] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os986second # [ 1.649174] systemd[1]: Starting Coldplug All udev Devices...987second # [ 1.654732] systemd-journald[65]: Collecting audit messages is disabled.988test # [ 1.663173] systemd[1]: Finished Create List of Static Device Nodes.989test # [ 1.669663] systemd[1]: modprobe@configfs.service: Deactivated successfully.990second # [ 1.663874] systemd[1]: Finished Create List of Static Device Nodes.991test # [ 1.671863] systemd-journald[65]: Collecting audit messages is disabled.992test # [ 1.677544] systemd[1]: Finished Load Kernel Module configfs.993second # [ 1.672040] systemd[1]: modprobe@configfs.service: Deactivated successfully.994second # [ 1.678981] systemd[1]: Finished Load Kernel Module configfs.995test # [ 1.685556] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config996second # [ 1.682365] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.997test # [ 1.690279] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.998second # [ 1.687936] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config999test # [ 1.696255] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1000test # [ 1.700081] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1001second # [ 1.694610] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1002second # [ 1.697562] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1003second # [ 1.723572] systemd[1]: Finished Load Kernel Modules.1004test # [ 1.731704] systemd[1]: Finished Load Kernel Modules.1005test # [ 1.737196] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1006second # [ 1.732648] systemd[1]: Starting Apply Kernel Variables...1007test # [ 1.745222] systemd[1]: Starting Apply Kernel Variables...1008second # [ 1.745587] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1009test # [ 1.756581] systemd[1]: Starting Create Static Device Nodes in /dev...1010second # [ 1.754365] systemd[1]: Starting Create Static Device Nodes in /dev...1011test # [ 1.772719] systemd[1]: Finished Apply Kernel Variables.1012second # [ 1.767891] systemd[1]: Finished Apply Kernel Variables.1013test # [ 1.783685] systemd[1]: Finished Create Static Device Nodes in /dev.1014second # [ 1.781127] systemd[1]: Finished Create Static Device Nodes in /dev.1015test # [ 1.788296] systemd[1]: Reached target Preparation for Local File Systems.1016second # [ 1.784794] systemd[1]: Reached target Preparation for Local File Systems.1017test # [ 1.793139] systemd[1]: Reached target Local File Systems.1018second # [ 1.790579] systemd[1]: Reached target Local File Systems.1019test # [ 1.800125] systemd[1]: Starting Rule-based Manager for Device Events and Files...1020second # [ 1.617738] systemd-modules-load[67]: Inserted module 'dm_mod'1021second # [ 1.621228] systemd-modules-load[67]: Inserted module 'virtio_balloon'1022second # [ 1.622543] systemd-modules-load[67]: Inserted module 'virtio_gpu'1023second # [ 1.799132] systemd[1]: Starting Rule-based Manager for Device Events and Files...1024test # [ 1.810759] systemd[1]: Started Journal Service.1025test # [ 1.636910] systemd-modules-load[66]: Inserted module 'dm_mod'1026second # [ 1.806664] systemd[1]: Started Journal Service.1027test # [ 1.639557] systemd-modules-load[66]: Inserted module 'virtio_balloon'1028test # [ 1.644390] systemd-modules-load[66]: Inserted module 'virtio_gpu'1029second # [ 1.644828] systemd[1]: Starting Create System Files and Directories...1030test # [ 1.652958] systemd[1]: Starting Create System Files and Directories...1031test # [ 1.672080] systemd[1]: Finished Create System Files and Directories.1032second # [ 1.667357] systemd[1]: Finished Create System Files and Directories.1033test # [ 1.678386] systemd-udevd[73]: Using default interface naming scheme 'v261'.1034second # [ 1.671280] systemd-udevd[73]: Using default interface naming scheme 'v261'.1035second # [ 1.691671] systemd[1]: Started Rule-based Manager for Device Events and Files.1036test # [ 1.702069] systemd[1]: Started Rule-based Manager for Device Events and Files.1037test # [ 1.710736] systemd[1]: Finished Coldplug All udev Devices.1038second # [ 1.705092] systemd[1]: Finished Coldplug All udev Devices.1039second # [ 1.706173] systemd[1]: Reached target System Initialization.1040test # [ 1.713563] systemd[1]: Reached target System Initialization.1041test # [ 1.714812] systemd[1]: Reached target Basic System.1042second # [ 1.707536] systemd[1]: Reached target Basic System.1043test # [ 2.080799] virtio_blk virtio2: 1/0/0 default/read/poll queues1044second # [ 2.077880] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121045test # [ 2.086194] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121046second # [ 2.079724] virtio_blk virtio2: 1/0/0 default/read/poll queues1047test # [ 2.091564] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1048second # [ 2.085857] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1049second # [ 2.089598] serio: i8042 KBD port at 0x60,0x64 irq 11050test # [ 2.097003] serio: i8042 KBD port at 0x60,0x64 irq 11051second # [ 2.090417] serio: i8042 AUX port at 0x60,0x64 irq 121052test # [ 2.097938] serio: i8042 AUX port at 0x60,0x64 irq 121053test # [ 2.103798] ehci-pci 0000:00:1d.7: EHCI Host Controller1054test # [ 2.104679] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11055test # [ 2.106559] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001056second # [ 2.106638] uhci_hcd 0000:00:1d.0: UHCI Host Controller1057test # [ 2.116299] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001058test # [ 2.117339] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181059test # [ 2.119535] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11060test # [ 2.120807] usb usb1: Product: EHCI Host Controller1061test # [ 2.121719] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd1062test # [ 2.122700] usb usb1: SerialNumber: 0000:00:1d.71063second # [ 2.116512] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11064test # [ 2.123886] hub 1-0:1.0: USB hub found1065test # [ 2.125125] hub 1-0:1.0: 6 ports detected1066test # [ 2.130280] uhci_hcd 0000:00:1d.0: UHCI Host Controller1067second # [ 2.123973] uhci_hcd 0000:00:1d.0: detected 2 ports1068test # [ 2.131155] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21069second # [ 2.127721] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801070second # [ 2.134803] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181071second # [ 2.136111] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11072test # [ 2.144739] uhci_hcd 0000:00:1d.0: detected 2 ports1073second # [ 2.141441] SCSI subsystem initialized1074test # [ 2.152435] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801075second # [ 2.146876] usb usb1: Product: UHCI Host Controller1076second # [ 2.150380] usb usb1: Manufacturer: Linux 6.18.54 uhci_hcd1077second # [ 2.152013] usb usb1: SerialNumber: 0000:00:1d.01078test # [ 2.159631] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181079test # [ 2.160966] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11080second # [ 2.157866] hub 1-0:1.0: USB hub found1081second # [ 2.160022] hub 1-0:1.0: 2 ports detected1082second # [ 2.165945] ehci-pci 0000:00:1d.7: EHCI Host Controller1083second # [ 2.166806] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 21084second # [ 2.168728] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001085test # [ 2.179264] usb usb2: Product: UHCI Host Controller1086second # [ 1.999236] systemd[1]: Starting Virtual Console Setup...1087second # [ 2.175812] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001088test # [ 2.183981] SCSI subsystem initialized1089second # [ 2.179356] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181090test # [ 2.188746] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd1091second # [ 2.182641] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11092second # [ 2.186494] usb usb2: Product: EHCI Host Controller1093test # [ 2.018191] systemd[1]: Starting Virtual Console Setup...1094second # [ 2.187295] usb usb2: Manufacturer: Linux 6.18.54 ehci_hcd1095second # [ 2.191797] usb usb2: SerialNumber: 0000:00:1d.71096second # [ 2.194283] hub 2-0:1.0: USB hub found1097test # [ 2.201130] usb usb2: SerialNumber: 0000:00:1d.01098second # [ 2.195498] hub 2-0:1.0: 6 ports detected1099test # [ 2.027985] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1100test # [ 2.033627] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1101second # [ 2.035625] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1102second # [ 2.039074] systemd[1]: Found device /dev/disk/by-label/nixos.1103second # [ 2.040906] systemd[1]: Finished Virtual Console Setup.1104second # [ 2.042406] systemd[1]: Reached target Initrd Root Device.1105second # [ 2.044512] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1106test # [ 2.051412] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1107second # [ 2.222531] hub 1-0:1.0: USB hub found1108second # [ 2.223311] hub 1-0:1.0: 2 ports detected1109second # [ 2.225691] uhci_hcd 0000:00:1d.1: UHCI Host Controller1110second # [ 2.226555] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31111test # [ 2.240632] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01112test # [ 2.068092] systemd[1]: Finished Virtual Console Setup.1113test # [ 2.244924] hub 2-0:1.0: USB hub found1114test # [ 2.248271] hub 2-0:1.0: 2 ports detected1115second # [ 2.070593] systemd-fsck[102]: nixos: clean, 12/65536 files, 13019/262144 blocks1116second # [ 2.072638] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1117test # [ 2.080644] systemd[1]: Found device /dev/disk/by-label/nixos.1118test # [ 2.082483] systemd[1]: Reached target Initrd Root Device.1119second # [ 2.252530] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01120test # [ 2.084987] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1121second # [ 2.078722] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1122test # [ 2.262086] uhci_hcd 0000:00:1d.1: UHCI Host Controller1123test # [ 2.262921] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31124second # [ 2.257525] uhci_hcd 0000:00:1d.1: detected 2 ports1125second # [ 2.258401] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01126test # [ 2.269073] uhci_hcd 0000:00:1d.1: detected 2 ports1127second # [ 2.086718] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1128test # [ 2.269967] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01129test # [ 2.274320] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181130second # [ 2.268637] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181131second # [ 2.269907] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11132test # [ 2.279816] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11133test # [ 2.282095] usb usb3: Product: UHCI Host Controller1134test # [ 2.282906] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd1135test # [ 2.285093] usb usb3: SerialNumber: 0000:00:1d.11136test # [ 2.288449] hub 3-0:1.0: USB hub found1137second # [ 2.285962] usb usb3: Product: UHCI Host Controller1138test # [ 2.117898] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks1139second # [ 2.288520] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd1140second # [ 2.289399] usb usb3: SerialNumber: 0000:00:1d.11141test # [ 2.122602] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1142second # [ 2.291940] hub 3-0:1.0: USB hub found1143second # [ 2.293577] hub 3-0:1.0: 2 ports detected1144test # [ 2.301440] hub 3-0:1.0: 2 ports detected1145second # [ 2.296827] uhci_hcd 0000:00:1d.2: UHCI Host Controller1146test # [ 2.303777] uhci_hcd 0000:00:1d.2: UHCI Host Controller1147test # [ 2.304637] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41148second # [ 2.301824] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41149test # [ 2.310289] uhci_hcd 0000:00:1d.2: detected 2 ports1150test # [ 2.312196] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01151second # [ 2.306755] uhci_hcd 0000:00:1d.2: detected 2 ports1152test # [ 2.314432] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1153second # [ 2.308586] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01154test # [ 2.316277] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181155test # [ 2.317575] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11156second # [ 2.311104] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181157test # [ 2.318970] usb usb4: Product: UHCI Host Controller1158test # [ 2.319930] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1159test # [ 2.321228] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd1160test # [ 2.322552] ahci 0000:00:1f.2: flags: 64bit ncq only1161second # [ 2.315772] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11162second # [ 2.316940] usb usb4: Product: UHCI Host Controller1163test # [ 2.323802] usb usb4: SerialNumber: 0000:00:1d.21164second # [ 2.320492] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd1165test # [ 2.328106] hub 4-0:1.0: USB hub found1166second # [ 2.321350] usb usb4: SerialNumber: 0000:00:1d.21167test # [ 2.330066] hub 4-0:1.0: 2 ports detected1168second # [ 2.323730] hub 4-0:1.0: USB hub found1169second # [ 2.324767] hub 4-0:1.0: 2 ports detected1170second # [ 2.326222] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1171test # [ 2.335991] scsi host0: ahci1172test # [ 2.338930] scsi host1: ahci1173test # [ 2.340373] scsi host2: ahci1174second # [ 2.334490] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1175test # [ 2.343223] scsi host3: ahci1176test # [ 2.346869] scsi host4: ahci1177second # [ 2.340140] ahci 0000:00:1f.2: flags: 64bit ncq only1178test # [ 2.352691] scsi host5: ahci1179second # [ 2.348238] scsi host0: ahci1180test # [ 2.354915] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11181second # [ 2.349664] scsi host1: ahci1182second # [ 2.351542] scsi host2: ahci1183second # [ 2.354298] scsi host3: ahci1184test # [ 2.361076] usb 1-1: new high-speed USB device number 2 using ehci-pci1185second # [ 2.356350] scsi host4: ahci1186second # [ 2.358019] scsi host5: ahci1187test # [ 2.365081] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11188second # [ 2.360280] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11189test # [ 2.367514] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11190test # [ 2.369618] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11191second # [ 2.362852] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11192test # [ 2.370990] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11193second # [ 2.364243] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11194test # [ 2.372359] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11195second # [ 2.365620] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11196second # [ 2.366974] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11197second # [ 2.368325] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11198second # [ 2.440538] usb 2-1: new high-speed USB device number 2 using ehci-pci1199test # [ 2.490946] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001200test # [ 2.492242] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101201test # [ 2.493610] usb 1-1: Product: QEMU USB Tablet1202test # [ 2.494469] usb 1-1: Manufacturer: QEMU1203test # [ 2.495260] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11204test # [ 2.509569] hid: raw HID events driver (C) Jiri Kosina1205second # [ 2.570294] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001206second # [ 2.571605] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101207second # [ 2.573009] usb 2-1: Product: QEMU USB Tablet1208second # [ 2.573854] usb 2-1: Manufacturer: QEMU1209second # [ 2.574641] usb 2-1: SerialNumber: 28754-0000:00:1d.7-11210second # [ 2.589246] hid: raw HID events driver (C) Jiri Kosina1211test # [ 2.486684] systemd[1]: Mounting /sysroot...1212second # [ 2.484668] systemd[1]: Mounting /sysroot...1213test # [ 2.679254] ata1: SATA link down (SStatus 0 SControl 300)1214test # [ 2.680443] ata2: SATA link down (SStatus 0 SControl 300)1215test # [ 2.686850] ata5: SATA link down (SStatus 0 SControl 300)1216second # [ 2.680890] ata1: SATA link down (SStatus 0 SControl 300)1217test # [ 2.687960] ata6: SATA link down (SStatus 0 SControl 300)1218second # [ 2.682065] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1219test # [ 2.689335] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1220second # [ 2.683275] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001221test # [ 2.690565] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001222second # [ 2.684256] ata3.00: applying bridge limits1223test # [ 2.691731] ata3.00: applying bridge limits1224second # [ 2.685190] ata5: SATA link down (SStatus 0 SControl 300)1225test # [ 2.692700] ata3.00: configured for UDMA/1001226second # [ 2.686289] ata6: SATA link down (SStatus 0 SControl 300)1227test # [ 2.693787] ata4: SATA link down (SStatus 0 SControl 300)1228second # [ 2.687400] ata2: SATA link down (SStatus 0 SControl 300)1229second # [ 2.688563] ata4: SATA link down (SStatus 0 SControl 300)1230test # [ 2.695292] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51231second # [ 2.689609] ata3.00: configured for UDMA/1001232second # [ 2.690730] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51233test # [ 2.748141] usbcore: registered new interface driver usbhid1234test # [ 2.749004] usbhid: USB HID core driver1235second # [ 2.742564] usbcore: registered new interface driver usbhid1236second # [ 2.743469] usbhid: USB HID core driver1237test # [ 2.768009] 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/input21238second # [ 2.761629] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input21239test # [ 2.770391] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01240second # [ 2.765666] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01241test # [ 2.774622] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1242second # [ 2.768721] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1243second # [ 2.773000] EXT4-fs (vda): mounted filesystem 1b633b03-9926-440a-9af0-dac8625cb341 r/w with ordered data mode. Quota mode: none.1244test # [ 2.780200] EXT4-fs (vda): mounted filesystem 65d29526-ceda-4a8b-a90d-8863d10ed0ae r/w with ordered data mode. Quota mode: none.1245test # [ 2.611567] systemd[1]: Mounted /sysroot.1246second # [ 2.606092] systemd[1]: Mounted /sysroot.1247test # [ 2.613574] systemd[1]: Reached target Initrd Root File System.1248second # [ 2.606970] systemd[1]: Reached target Initrd Root File System.1249second # [ 2.783748] cdrom: Uniform CD-ROM driver Revision: 3.201250test # [ 2.791041] cdrom: Uniform CD-ROM driver Revision: 3.201251second # [ 2.609991] systemd[1]: Starting Mountpoints Configured in the Real Root...1252test # [ 2.618893] systemd[1]: Starting Mountpoints Configured in the Real Root...1253test # [ 2.633487] systemd-sysroot-fstab-check[135]: /sysroot should be mounted in the initrd, will request daemon-reload.1254second # [ 2.626750] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1255test # [ 2.638121] systemd[1]: Reload requested from client PID 135 ('systemd-sysroot') (unit initrd-parse-etc.service)...1256second # [ 2.631594] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1257test # [ 2.639996] systemd[1]: Reloading...1258second # [ 2.633419] systemd[1]: Reloading...1259test # [ 2.702911] systemd[1]: Reloading finished in 65 ms.1260second # [ 2.696943] systemd[1]: Reloading finished in 66 ms.1261test # [ 2.713359] systemd-sysroot-fstab-check[135]: Requesting initrd-fs.target/start/replace...1262second # [ 2.706539] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1263test # [ 2.716154] systemd-sysroot-fstab-check[135]: Requesting swap.target/start/replace...1264second # [ 2.710112] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1265second # [ 2.712792] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1266second # [ 2.714484] systemd[1]: Finished Mountpoints Configured in the Real Root.1267test # [ 2.721880] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1268second # [ 2.716145] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1269test # [ 2.723945] systemd[1]: Finished Mountpoints Configured in the Real Root.1270test # [ 2.725170] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1271test # [ 3.487111] systemd[1]: Mounting /sysroot/nix/.ro-store...1272test # [ 3.490071] systemd[1]: Mounting /sysroot/nix/.rw-store...1273second # [ 3.485896] systemd[1]: Mounting /sysroot/nix/.ro-store...1274test # [ 3.494134] systemd[1]: Mounting /sysroot/run...1275test # [ 3.495757] systemd[1]: Mounting /sysroot/tmp/shared...1276second # [ 3.489670] systemd[1]: Mounting /sysroot/nix/.rw-store...1277second # [ 3.492648] systemd[1]: Mounting /sysroot/run...1278test # [ 3.503392] systemd[1]: Mounting /sysroot/tmp/xchg...1279second # [ 3.496130] systemd[1]: Mounting /sysroot/tmp/shared...1280second # [ 3.500399] systemd[1]: Mounting /sysroot/tmp/xchg...1281test # [ 3.521724] systemd[1]: Mounted /sysroot/nix/.ro-store.1282test # [ 3.523260] systemd[1]: Mounted /sysroot/nix/.rw-store.1283test # [ 3.525952] systemd[1]: Mounted /sysroot/run.1284test # [ 3.527203] systemd[1]: Mounted /sysroot/tmp/shared.1285second # [ 3.522520] systemd[1]: Mounted /sysroot/nix/.ro-store.1286test # [ 3.531089] systemd[1]: Mounted /sysroot/tmp/xchg.1287second # [ 3.526373] systemd[1]: Mounted /sysroot/nix/.rw-store.1288test # [ 3.534461] systemd[1]: Starting rw-sysroot-nix-store.service...1289second # [ 3.527659] systemd[1]: Mounted /sysroot/run.1290second # [ 3.529181] systemd[1]: Mounted /sysroot/tmp/shared.1291second # [ 3.530182] systemd[1]: Mounted /sysroot/tmp/xchg.1292second # [ 3.534063] systemd[1]: Starting rw-sysroot-nix-store.service...1293test # [ 3.543254] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1294test # [ 3.545113] systemd[1]: Finished rw-sysroot-nix-store.service.1295second # [ 3.543411] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1296second # [ 3.546100] systemd[1]: Finished rw-sysroot-nix-store.service.1297second # [ 3.547557] systemd[1]: Mounting /sysroot/nix/store...1298second # [ 3.565085] systemd[1]: Mounted /sysroot/nix/store.1299second # [ 3.566646] systemd[1]: Reached target Initrd File Systems.1300second # [ 3.568537] systemd[1]: Starting Find NixOS closure...1301second # [ 3.572130] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1302second # [ 3.587150] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1303second # [ 3.592823] systemd[1]: Finished Find NixOS closure.1304second # [ 3.594967] systemd[1]: Reached target Initrd Default Target.1305second # [ 3.596329] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1306second # [ 3.612392] systemd[1]: Stopped target Initrd Default Target.1307second # [ 3.614282] systemd[1]: Stopped target Basic System.1308second # [ 3.615808] systemd[1]: Stopped target Initrd Root Device.1309second # [ 3.618169] systemd[1]: Stopped target Path Units.1310second # [ 3.619205] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1311second # [ 3.620717] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1312second # [ 3.622135] systemd[1]: Stopped target Slice Units.1313second # [ 3.623389] systemd[1]: Stopped target Socket Units.1314second # [ 3.624622] systemd[1]: Stopped target System Initialization.1315second # [ 3.626194] systemd[1]: Stopped target Swaps.1316second # [ 3.627313] systemd[1]: Stopped target Timer Units.1317second # [ 3.628669] systemd[1]: dbus.socket: Deactivated successfully.1318second # [ 3.630136] systemd[1]: Closed D-Bus System Message Bus Socket.1319second # [ 3.632067] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1320second # [ 3.633403] systemd[1]: Stopped Find NixOS closure.1321second # [ 3.634707] systemd[1]: Starting rw-sysroot-nix-store.service...1322second # [ 3.636158] systemd[1]: systemd-sysctl.service: Deactivated successfully.1323second # [ 3.637568] systemd[1]: Stopped Apply Kernel Variables.1324second # [ 3.639159] systemd[1]: systemd-modules-load.service: Deactivated successfully.1325second # [ 3.640543] systemd[1]: Stopped Load Kernel Modules.1326second # [ 3.642155] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1327second # [ 3.643528] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1328second # [ 3.644883] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1329second # [ 3.646337] systemd[1]: Stopped Create System Files and Directories.1330second # [ 3.648184] systemd[1]: Stopped target Local File Systems.1331second # [ 3.649466] systemd[1]: Stopped target Preparation for Local File Systems.1332second # [ 3.651192] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1333second # [ 3.653214] systemd[1]: Stopped Coldplug All udev Devices.1334second # [ 3.655072] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1335second # [ 3.656811] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1336second # [ 3.659396] systemd[1]: Stopped Virtual Console Setup.1337second # [ 3.670279] systemd[1]: initrd-cleanup.service: Deactivated successfully.1338second # [ 3.672222] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1339second # [ 3.674460] systemd[1]: systemd-udevd.service: Deactivated successfully.1340second # [ 3.675693] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1341second # [ 3.677564] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1342second # [ 3.680108] systemd[1]: Finished rw-sysroot-nix-store.service.1343second # [ 3.682475] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1344second # [ 3.684646] systemd[1]: Closed udev Control Socket.1345second # [ 3.685722] systemd[1]: Starting Cleanup udev Database...1346second # [ 3.686766] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1347second # [ 3.689181] systemd[1]: Stopped Create Static Device Nodes in /dev.1348second # [ 3.690362] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1349second # [ 3.691799] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1350second # [ 3.693131] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1351second # [ 3.694369] systemd[1]: Stopped Create List of Static Device Nodes.1352second # [ 3.707168] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1353second # [ 3.708998] systemd[1]: Finished Cleanup udev Database.1354second # [ 3.710480] systemd[1]: Reached target Switch Root.1355second # [ 3.712236] systemd[1]: Starting NixOS Activation...1356second # [ 3.786534] initrd-nixos-activation-start[188]: booting system configuration /nix/store/mihiadsc8lrwkw79anr4imajnfv2aj29-nixos-system-second-test1357second # [ 3.811939] initrd-nixos-activation-start[188]: running activation script...1358second # [ 3.976860] initrd-nixos-activation-start[211]: setting up /etc...1359second # [ 4.047361] initrd-nixos-activation-start[211]: setting up age secrets...1360second # [ 4.126364] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1361second # [ 4.128176] systemd[1]: Finished NixOS Activation.1362second # [ 4.130081] systemd[1]: Starting Switch Root...1363second # [ 4.139807] systemd[1]: Switching root.1364second # [ 4.435471] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1365second # [ 4.573734] NET: Registered PF_VSOCK protocol family1366test # [ 4.487214] systemd[1]: Mounting /sysroot/nix/store...1367test # [ 4.504680] systemd[1]: Mounted /sysroot/nix/store.1368test # [ 4.506217] systemd[1]: Reached target Initrd File Systems.1369test # [ 4.507904] systemd[1]: Starting Find NixOS closure...1370test # [ 4.510504] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1371test # [ 4.525239] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1372test # [ 4.527316] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1373test # [ 4.533654] systemd[1]: Finished Find NixOS closure.1374test # [ 4.535201] systemd[1]: Reached target Initrd Default Target.1375test # [ 4.536641] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1376test # [ 4.546818] systemd[1]: Stopped target Initrd Default Target.1377test # [ 4.548374] systemd[1]: Stopped target Basic System.1378test # [ 4.549555] systemd[1]: Stopped target Initrd Root Device.1379test # [ 4.550759] systemd[1]: Stopped target Path Units.1380test # [ 4.552132] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1381test # [ 4.553466] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1382test # [ 4.554888] systemd[1]: Stopped target Slice Units.1383test # [ 4.556179] systemd[1]: Stopped target Socket Units.1384test # [ 4.558149] systemd[1]: Stopped target System Initialization.1385test # [ 4.559160] systemd[1]: Stopped target Swaps.1386test # [ 4.560067] systemd[1]: Stopped target Timer Units.1387test # [ 4.560949] systemd[1]: dbus.socket: Deactivated successfully.1388test # [ 4.562130] systemd[1]: Closed D-Bus System Message Bus Socket.1389test # [ 4.563381] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1390test # [ 4.565161] systemd[1]: Stopped Find NixOS closure.1391test # [ 4.566212] systemd[1]: Starting rw-sysroot-nix-store.service...1392test # [ 4.567529] systemd[1]: systemd-sysctl.service: Deactivated successfully.1393test # [ 4.569153] systemd[1]: Stopped Apply Kernel Variables.1394test # [ 4.570100] systemd[1]: systemd-modules-load.service: Deactivated successfully.1395test # [ 4.571566] systemd[1]: Stopped Load Kernel Modules.1396test # [ 4.572863] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1397test # [ 4.574900] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1398test # [ 4.576846] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1399test # [ 4.578122] systemd[1]: Stopped Create System Files and Directories.1400test # [ 4.580126] systemd[1]: Stopped target Local File Systems.1401test # [ 4.581136] systemd[1]: Stopped target Preparation for Local File Systems.1402test # [ 4.583090] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1403test # [ 4.585524] systemd[1]: Stopped Coldplug All udev Devices.1404test # [ 4.586514] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1405test # [ 4.587811] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1406test # [ 4.589505] systemd[1]: Stopped Virtual Console Setup.1407test # [ 4.593129] systemd[1]: initrd-cleanup.service: Deactivated successfully.1408test # [ 4.598095] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1409test # [ 4.599930] systemd[1]: systemd-udevd.service: Deactivated successfully.1410test # [ 4.601802] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1411test # [ 4.603610] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1412test # [ 4.605331] systemd[1]: Finished rw-sysroot-nix-store.service.1413test # [ 4.609124] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1414test # [ 4.610369] systemd[1]: Closed udev Control Socket.1415test # [ 4.611688] systemd[1]: Starting Cleanup udev Database...1416test # [ 4.613146] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1417test # [ 4.614454] systemd[1]: Stopped Create Static Device Nodes in /dev.1418test # [ 4.615562] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1419test # [ 4.617148] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1420test # [ 4.619154] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1421test # [ 4.620339] systemd[1]: Stopped Create List of Static Device Nodes.1422test # [ 4.629691] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1423test # [ 4.631256] systemd[1]: Finished Cleanup udev Database.1424test # [ 4.633145] systemd[1]: Reached target Switch Root.1425test # [ 4.634626] systemd[1]: Starting NixOS Activation...1426test # [ 4.678918] initrd-nixos-activation-start[187]: booting system configuration /nix/store/l08mvpqi10lpz6qy242s0g2i9c1xra9j-nixos-system-test-test1427test # [ 4.698550] initrd-nixos-activation-start[187]: running activation script...1428second # [ 4.934020] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1429second # [ 4.938347] systemd[1]: Detected virtualization kvm.1430second # [ 4.939181] systemd[1]: Detected architecture x86-64.1431second # [ 4.940068] systemd[1]: Detected first boot.1432second # [ 4.941950] systemd[1]: Initializing machine ID from random generator.1433test # [ 4.829595] initrd-nixos-activation-start[210]: setting up /etc...1434second # [ 5.016949] systemd[1]: bpf-restrict-fs: LSM BPF program attached1435test # [ 4.897324] initrd-nixos-activation-start[210]: setting up age secrets...1436second # [ 5.078650] systemd[1]: Applying preset policy.1437test # [ 4.986937] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1438test # [ 4.989080] systemd[1]: Finished NixOS Activation.1439test # [ 4.990684] systemd[1]: Starting Switch Root...1440test # [ 5.000917] systemd[1]: Switching root.1441second # [ 5.218932] systemd[1]: Populated /etc with preset unit settings.1442test # [ 5.299755] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1443test # [ 5.357645] NET: Registered PF_VSOCK protocol family1444second # [ 5.403532] systemd[1]: initrd-switch-root.service: Deactivated successfully.1445second # [ 5.405128] systemd[1]: Stopped initrd-switch-root.service.1446second # [ 5.407651] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1447second # [ 5.409748] systemd[1]: Created slice Slice /system/getty.1448second # [ 5.411129] systemd[1]: Created slice User and Session Slice.1449second # [ 5.412164] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1450second # [ 5.413547] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1451second # [ 5.414773] systemd[1]: Expecting device /dev/hvc0...1452second # [ 5.415623] systemd[1]: Expecting device /dev/ttyS0...1453second # [ 5.416532] systemd[1]: Reached target Local Encrypted Volumes.1454second # [ 5.425483] systemd[1]: Stopped target initrd-fs.target.1455second # [ 5.426349] systemd[1]: Stopped target initrd-root-fs.target.1456second # [ 5.427314] systemd[1]: Stopped target initrd-switch-root.target.1457second # [ 5.428330] systemd[1]: Reached target Virtual Machines and Containers.1458second # [ 5.429434] systemd[1]: Reached target Path Units.1459second # [ 5.430259] systemd[1]: Reached target Remote File Systems.1460second # [ 5.431214] systemd[1]: Reached target Slice Units.1461second # [ 5.432081] systemd[1]: Reached target Swaps.1462second # [ 5.433725] systemd[1]: Listening on Query the User Interactively for a Password.1463second # [ 5.436067] systemd[1]: Listening on Process Core Dump Socket.1464second # [ 5.437895] systemd[1]: Listening on Credential Encryption/Decryption.1465second # [ 5.439808] systemd[1]: Listening on Factory Reset Management.1466second # [ 5.440867] systemd[1]: Listening on Hostname Service Socket.1467second # [ 5.443284] systemd[1]: Starting Journal Log Access Socket...1468second # [ 5.444645] systemd[1]: Listening on Journal Audit Socket.1469second # [ 5.447023] systemd[1]: Listening on Console Output Muting Service Socket.1470second # [ 5.448259] systemd[1]: Listening on Network Management Metrics Varlink Socket.1471second # [ 5.449645] systemd[1]: Listening on Network Management Varlink Socket.1472second # [ 5.450834] systemd[1]: Listening on Network Management Netlink Socket.1473second # [ 5.452028] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1474second # [ 5.453267] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1475second # [ 5.454765] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1476second # [ 5.458541] systemd[1]: Listening on Disk Repartitioning Service Socket.1477second # [ 5.459724] systemd[1]: Listening on Resolve Monitor Varlink Socket.1478second # [ 5.460857] systemd[1]: Listening on Resolve Service Varlink Socket.1479second # [ 5.461976] systemd[1]: Listening on udev Control Socket.1480second # [ 5.462986] systemd[1]: Listening on udev Varlink Socket.1481second # [ 5.464886] systemd[1]: Mounting Huge Pages File System...1482second # [ 5.467100] systemd[1]: Mounting POSIX Message Queue File System...1483second # [ 5.473905] systemd[1]: Mounting Kernel Debug File System...1484second # [ 5.479047] systemd[1]: Mounting Kernel Trace File System...1485second # [ 5.486576] systemd[1]: Starting Create List of Static Device Nodes...1486second # [ 5.498183] systemd[1]: Starting Load Kernel Module configfs...1487second # [ 5.506028] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1488second # [ 5.511871] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1489second # [ 5.519543] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1490second # [ 5.529126] systemd[1]: Mounting FUSE Control File System...1491second # [ 5.532449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671492second # [ 5.538746] systemd[1]: Starting Journal Service...1493second # [ 5.545787] systemd[1]: Starting Load Kernel Modules...1494second # [ 5.552875] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1495second # [ 5.560452] systemd[1]: Starting Remount Root and Kernel File Systems...1496second # [ 5.562527] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1497second # [ 5.571649] systemd[1]: Starting Coldplug All udev Devices...1498second # [ 5.577789] systemd-journald[314]: Collecting audit messages is enabled.1499second # [ 5.580069] systemd[1]: Listening on Journal Log Access Socket.1500second # [ 5.585130] systemd[1]: Mounted Huge Pages File System.1501second # [ 5.588969] systemd[1]: Mounted POSIX Message Queue File System.1502second # [ 5.598268] systemd[1]: Mounted Kernel Debug File System.1503second # [ 5.603722] systemd[1]: Mounted Kernel Trace File System.1504second # [ 5.606025] loop: module loaded1505second # [ 5.609617] systemd[1]: Started Journal Service.1506second # [ 5.435149] systemd[1]: Queued start job for default target Multi-User System.1507second # [ 5.436610] systemd[1]: systemd-journald.service: Deactivated successfully.1508second # [ 5.442364] systemd-modules-load[315]: Module 'ctr' is built in1509second # [ 5.618728] EXT4-fs (vda): re-mounted 1b633b03-9926-440a-9af0-dac8625cb341.1510second # [ 5.444876] systemd-modules-load[315]: Inserted module 'loop'1511second # [ 5.452423] systemd[1]: Finished Create List of Static Device Nodes.1512second # [ 5.453774] systemd[1]: modprobe@configfs.service: Deactivated successfully.1513second # [ 5.455465] systemd[1]: Finished Load Kernel Module configfs.1514second # [ 5.459167] systemd[1]: Mounted FUSE Control File System.1515second # [ 5.460375] systemd[1]: Finished Load Kernel Modules.1516second # [ 5.465202] systemd[1]: Finished Remount Root and Kernel File Systems.1517second # [ 5.473095] systemd[1]: Listening on Disk Image Download Service Socket.1518second # [ 5.477160] systemd[1]: Mounting Kernel Configuration File System...1519second # [ 5.480070] systemd[1]: Starting Firewall...1520second # [ 5.481628] systemd[1]: Starting Flush Journal to Persistent Storage...1521second # [ 5.483168] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1522second # [ 5.491075] systemd[1]: Starting Load/Save OS Random Seed...1523second # [ 5.495408] systemd-oomd[317]: No swap; memory pressure usage will be degraded1524second # [ 5.501229] systemd[1]: Starting Apply Kernel Variables...1525second # [ 5.513699] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1526second # [ 5.514975] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1527second # [ 5.516459] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1528test # [ 5.707568] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1529test # [ 5.711860] systemd[1]: Detected virtualization kvm.1530test # [ 5.712670] systemd[1]: Detected architecture x86-64.1531test # [ 5.713562] systemd[1]: Detected first boot.1532test # [ 5.715032] systemd[1]: Initializing machine ID from random generator.1533second # [ 5.725876] systemd-journald[314]: Received client request to flush runtime journal.1534test # [ 5.888673] systemd[1]: bpf-restrict-fs: LSM BPF program attached1535second # [ 5.713645] systemd[1]: Finished Load/Save OS Random Seed.1536second # [ 5.716833] systemd[1]: Reached target First Boot Complete.1537second # [ 5.721293] systemd[1]: Mounted Kernel Configuration File System.1538second # [ 5.723221] systemd[1]: Finished Apply Kernel Variables.1539second # [ 5.726173] systemd[1]: Starting Network Name Resolution...1540second # [ 5.727206] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1541second # [ 5.728483] systemd[1]: Starting Create Static Device Nodes in /dev...1542second # [ 5.730323] systemd[1]: Finished Flush Journal to Persistent Storage.1543second # [ 5.740158] systemd-resolved[343]: Positive Trust Anchors:1544second # [ 5.741439] systemd-resolved[343]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1545second # [ 5.744228] systemd-resolved[343]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161546second # [ 5.747311] systemd-resolved[343]: 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 test1547test # [ 5.940408] systemd[1]: Applying preset policy.1548second # [ 5.793378] systemd[1]: Finished Coldplug All udev Devices.1549second # [ 5.808198] systemd[1]: Finished Create Static Device Nodes in /dev.1550second # [ 5.809375] systemd[1]: Reached target Preparation for Local File Systems.1551second # [ 5.812574] systemd[1]: Starting Rule-based Manager for Device Events and Files...1552second # [ 5.823967] systemd-resolved[343]: Using system hostname 'second'.1553second # [ 5.828184] systemd[1]: Started Network Name Resolution.1554second # [ 5.853666] systemd-udevd[360]: Using default interface naming scheme 'v261'.1555test # [ 6.080711] systemd[1]: Populated /etc with preset unit settings.1556second # [ 5.916477] systemd[1]: Started Rule-based Manager for Device Events and Files.1557second # [ 6.035930] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1558test # [ 6.245332] systemd[1]: initrd-switch-root.service: Deactivated successfully.1559test # [ 6.246861] systemd[1]: Stopped initrd-switch-root.service.1560test # [ 6.249266] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1561test # [ 6.251340] systemd[1]: Created slice Slice /system/getty.1562test # [ 6.252688] systemd[1]: Created slice User and Session Slice.1563test # [ 6.253722] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1564test # [ 6.255090] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1565test # [ 6.256319] systemd[1]: Expecting device /dev/hvc0...1566test # [ 6.257186] systemd[1]: Expecting device /dev/ttyS0...1567test # [ 6.258090] systemd[1]: Reached target Local Encrypted Volumes.1568test # [ 6.259064] systemd[1]: Stopped target initrd-fs.target.1569test # [ 6.259956] systemd[1]: Stopped target initrd-root-fs.target.1570test # [ 6.269096] systemd[1]: Stopped target initrd-switch-root.target.1571test # [ 6.270136] systemd[1]: Reached target Virtual Machines and Containers.1572test # [ 6.271243] systemd[1]: Reached target Path Units.1573test # [ 6.272115] systemd[1]: Reached target Remote File Systems.1574test # [ 6.273077] systemd[1]: Reached target Slice Units.1575test # [ 6.273950] systemd[1]: Reached target Swaps.1576test # [ 6.275623] systemd[1]: Listening on Query the User Interactively for a Password.1577test # [ 6.277953] systemd[1]: Listening on Process Core Dump Socket.1578test # [ 6.279661] systemd[1]: Listening on Credential Encryption/Decryption.1579second # [ 6.098125] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1580test # [ 6.281533] systemd[1]: Listening on Factory Reset Management.1581test # [ 6.282624] systemd[1]: Listening on Hostname Service Socket.1582test # [ 6.285214] systemd[1]: Starting Journal Log Access Socket...1583test # [ 6.286548] systemd[1]: Listening on Journal Audit Socket.1584test # [ 6.289013] systemd[1]: Listening on Console Output Muting Service Socket.1585test # [ 6.290262] systemd[1]: Listening on Network Management Metrics Varlink Socket.1586test # [ 6.291622] systemd[1]: Listening on Network Management Varlink Socket.1587test # [ 6.292832] systemd[1]: Listening on Network Management Netlink Socket.1588test # [ 6.294073] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1589test # [ 6.295320] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1590test # [ 6.296812] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1591test # [ 6.300497] systemd[1]: Listening on Disk Repartitioning Service Socket.1592second # [ 6.118225] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1593test # [ 6.301685] systemd[1]: Listening on Resolve Monitor Varlink Socket.1594test # [ 6.302830] systemd[1]: Listening on Resolve Service Varlink Socket.1595test # [ 6.303999] systemd[1]: Listening on udev Control Socket.1596test # [ 6.305039] systemd[1]: Listening on udev Varlink Socket.1597test # [ 6.307044] systemd[1]: Mounting Huge Pages File System...1598test # [ 6.309999] systemd[1]: Mounting POSIX Message Queue File System...1599test # [ 6.316804] systemd[1]: Mounting Kernel Debug File System...1600test # [ 6.322826] systemd[1]: Mounting Kernel Trace File System...1601second # [ 6.149251] (udev-worker)[387]: Network interface NamePolicy= disabled on kernel command line.1602test # [ 6.334313] systemd[1]: Starting Create List of Static Device Nodes...1603second # [ 6.152793] (udev-worker)[392]: Network interface NamePolicy= disabled on kernel command line.1604test # [ 6.344209] systemd[1]: Starting Load Kernel Module configfs...1605test # [ 6.352486] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1606test # [ 6.360694] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1607test # [ 6.364273] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1608test # [ 6.367424] systemd[1]: Mounting FUSE Control File System...1609test # [ 6.371258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671610test # [ 6.376479] systemd[1]: Starting Journal Service...1611test # [ 6.380961] systemd[1]: Starting Load Kernel Modules...1612test # [ 6.390041] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1613test # [ 6.403293] systemd[1]: Starting Remount Root and Kernel File Systems...1614test # [ 6.406215] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1615second # [ 6.232765] systemd[1]: Mounting /run/wrappers...1616test # [ 6.418020] systemd[1]: Starting Coldplug All udev Devices...1617test # [ 6.424205] systemd-journald[334]: Collecting audit messages is enabled.1618test # [ 6.427386] systemd[1]: Listening on Journal Log Access Socket.1619test # [ 6.435341] systemd[1]: Mounted Huge Pages File System.1620second # [ 6.264133] systemd[1]: Mounted /run/wrappers.1621test # [ 6.446199] systemd[1]: Mounted POSIX Message Queue File System.1622second # [ 6.265627] systemd[1]: Reached target Local File Systems.1623second # [ 6.270441] systemd[1]: Listening on Boot Loader Control Service Socket.1624test # [ 6.453257] loop: module loaded1625test # [ 6.456170] systemd[1]: Mounted Kernel Debug File System.1626second # [ 6.274470] systemd[1]: Starting register-nix-paths.service...1627second # [ 6.278486] systemd[1]: Starting Create SUID/SGID Wrappers...1628test # [ 6.286091] systemd[1]: Queued start job for default target Multi-User System.1629second # [ 6.279565] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1630test # [ 6.287584] systemd[1]: systemd-journald.service: Deactivated successfully.1631second # [ 6.285264] systemd[1]: Starting Save Transient machine-id to Disk...1632test # [ 6.292698] systemd-modules-load[335]: Module 'ctr' is built in1633test # [ 6.468763] EXT4-fs (vda): re-mounted 65d29526-ceda-4a8b-a90d-8863d10ed0ae.1634test # [ 6.296385] systemd-modules-load[335]: Inserted module 'loop'1635test # [ 6.472726] systemd[1]: Started Journal Service.1636second # [ 6.297077] systemd[1]: Starting Create System Files and Directories...1637test # [ 6.305899] systemd[1]: Mounted Kernel Trace File System.1638test # [ 6.309086] systemd[1]: Finished Create List of Static Device Nodes.1639test # [ 6.310229] systemd[1]: modprobe@configfs.service: Deactivated successfully.1640test # [ 6.311439] systemd[1]: Finished Load Kernel Module configfs.1641test # [ 6.315129] systemd[1]: Finished Load Kernel Modules.1642test # [ 6.316158] systemd[1]: Mounted FUSE Control File System.1643test # [ 6.317171] systemd[1]: Finished Remount Root and Kernel File Systems.1644test # [ 6.329095] systemd[1]: Listening on Disk Image Download Service Socket.1645test # [ 6.332117] systemd[1]: Mounting Kernel Configuration File System...1646test # [ 6.336206] systemd-oomd[336]: No swap; memory pressure usage will be degraded1647test # [ 6.337847] systemd[1]: Starting Firewall...1648test # [ 6.342070] systemd[1]: Starting Flush Journal to Persistent Storage...1649test # [ 6.343229] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1650test # [ 6.357073] systemd[1]: Starting Load/Save OS Random Seed...1651test # [ 6.361893] systemd[1]: Starting Apply Kernel Variables...1652second # [ 6.363606] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1653test # [ 6.372071] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1654test # [ 6.373389] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1655test # [ 6.374872] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1656second # [ 6.370329] systemd[1]: Finished Save Transient machine-id to Disk.1657test # [ 6.568014] systemd-journald[334]: Received client request to flush runtime journal.1658second # [ 6.405120] systemd[1]: Finished Create System Files and Directories.1659second # [ 6.415313] systemd[1]: Starting Rebuild Journal Catalog...1660second # [ 6.420381] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1661second # [ 6.663557] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1662second # [ 6.494795] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1663second # [ 6.683690] mousedev: PS/2 mouse device common for all mice1664second # [ 6.689097] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31665second # [ 6.524779] systemd[1]: Finished Rebuild Journal Catalog.1666second # [ 6.530259] systemd[1]: Starting Update is Completed...1667second # [ 6.709034] ACPI: button: Power Button [PWRF]1668test # [ 6.584175] systemd[1]: Mounted Kernel Configuration File System.1669second # [ 6.577104] systemd[1]: Finished Update is Completed.1670test # [ 6.585730] systemd[1]: Finished Load/Save OS Random Seed.1671test # [ 6.589334] systemd[1]: Reached target First Boot Complete.1672test # [ 6.590611] systemd[1]: Finished Apply Kernel Variables.1673test # [ 6.593640] systemd[1]: Starting Network Name Resolution...1674test # [ 6.594692] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1675test # [ 6.596613] systemd[1]: Starting Create Static Device Nodes in /dev...1676second # [ 6.591173] systemd[1]: Finished Firewall.1677test # [ 6.599216] systemd[1]: Finished Flush Journal to Persistent Storage.1678second # [ 6.592035] systemd[1]: Reached target Preparation for Network.1679second # [ 6.593163] systemd[1]: Listening on Network Management Resolve Hook Socket.1680test # [ 6.606842] systemd-resolved[363]: Positive Trust Anchors:1681second # [ 6.600186] systemd[1]: Starting Network Management...1682test # [ 6.608835] systemd-resolved[363]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1683test # [ 6.611286] systemd-resolved[363]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161684test # [ 6.615143] systemd-resolved[363]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1685test # [ 6.640481] systemd[1]: Finished Create Static Device Nodes in /dev.1686test # [ 6.642282] systemd[1]: Reached target Preparation for Local File Systems.1687test # [ 6.648507] systemd[1]: Starting Rule-based Manager for Device Events and Files...1688test # [ 6.686903] systemd[1]: Finished Coldplug All udev Devices.1689test # [ 6.688890] systemd-resolved[363]: Using system hostname 'test'.1690test # [ 6.693178] systemd[1]: Started Network Name Resolution.1691test # [ 6.710991] systemd-udevd[376]: Using default interface naming scheme 'v261'.1692second # [ 6.707323] systemd-resolved[343]: Clock change detected. Flushing caches.1693second # [ 6.813564] rtc_cmos PNP0B00:00: RTC can wake from S41694second # [ 6.847018] rtc_cmos PNP0B00:00: registered as rtc01695second # [ 6.847119] rtc_cmos PNP0B00:00: setting system clock to 2026-09-29T15:03:03 UTC (1790694183)1696second # [ 6.847209] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1697second # [ 6.847764] systemd-journald[314]: Time jumped backwards, rotating.1698test # [ 6.761283] systemd[1]: Started Rule-based Manager for Device Events and Files.1699second # [ 6.892644] parport_pc 00:02: reported by Plug and Play ACPI1700second # [ 6.892723] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1701second # [ 6.901966] Console: switching to colour dummy device 80x251702second # [ 6.910214] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41703second # [ 6.913773] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1704second # [ 7.024022] cfg80211: Loading compiled-in X.509 certificates for regulatory database1705test # [ 6.877985] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1706second # [ 7.058544] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1707second # [ 7.059296] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1708second # [ 7.063446] [drm] Found bochs VGA, ID 0xb0c5.1709second # [ 7.063964] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1710second # [ 7.073112] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1711second # [ 7.073913] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1712second # [ 6.915973] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1713second # [ 6.921208] systemd[1]: Finished Create SUID/SGID Wrappers.1714second # [ 7.106012] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1715second # [ 6.939503] systemd-networkd[511]: /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.1716second # [ 6.944460] systemd-networkd[511]: /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.1717second # [ 6.947926] systemd-networkd[511]: lo: Link UP1718test # [ 6.955584] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1719second # [ 6.950220] systemd-networkd[511]: lo: Gained carrier1720second # [ 7.129578] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01721second # [ 6.957074] systemd[1]: Started Network Management.1722second # [ 6.961631] systemd-networkd[511]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1723second # [ 6.967484] systemd-networkd[511]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1724second # [ 6.969065] systemd-networkd[511]: eth1: Link UP1725second # [ 6.971311] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1726second # [ 7.150628] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61727second # [ 6.978099] systemd-networkd[511]: eth1: Gained carrier1728test # [ 6.986838] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1729second # [ 6.979083] systemd-networkd[511]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1730second # [ 7.157811] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51731test # [ 6.998254] (udev-worker)[402]: Network interface NamePolicy= disabled on kernel command line.1732second # [ 6.994148] systemd[1]: Finished register-nix-paths.service.1733test # [ 7.001261] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line.1734second # [ 6.998846] systemd[1]: Reached target System Initialization.1735second # [ 7.001326] systemd[1]: Started Discard unused filesystem blocks once a week.1736second # [ 7.002569] systemd[1]: Started Daily Cleanup of Temporary Directories.1737second # [ 7.004207] systemd[1]: Reached target Timer Units.1738second # [ 7.181279] NET: Registered PF_PACKET protocol family1739second # [ 7.007155] systemd[1]: Listening on D-Bus System Message Bus Socket.1740second # [ 7.009485] systemd[1]: Listening on Nix Daemon Socket.1741second # [ 7.013490] systemd[1]: Listening on Authorization Manager Agent Helper.1742second # [ 7.015431] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1743second # [ 7.016990] systemd[1]: Reached target Socket Units.1744second # [ 7.026182] systemd[1]: Starting D-Bus System Message Bus...1745second # [ 7.033474] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1746test # [ 7.074088] systemd[1]: Mounting /run/wrappers...1747second # [ 7.079888] systemd[1]: Starting Virtual Console Setup...1748test # [ 7.102306] systemd[1]: Mounted /run/wrappers.1749test # [ 7.103325] systemd[1]: Reached target Local File Systems.1750test # [ 7.106455] systemd[1]: Listening on Boot Loader Control Service Socket.1751test # [ 7.111129] systemd[1]: Starting register-nix-paths.service...1752test # [ 7.114974] systemd[1]: Starting Create SUID/SGID Wrappers...1753test # [ 7.116056] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1754test # [ 7.119802] systemd[1]: Starting Save Transient machine-id to Disk...1755second # [ 7.287731] Console: switching to colour frame buffer device 160x501756test # [ 7.126513] systemd[1]: Starting Create System Files and Directories...1757second # [ 7.306162] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1758second # [ 7.125482] dbus-broker-launch[552]: Looking up NSS user entry for 'systemd-timesync'...1759second # [ 7.133501] dbus-broker-launch[552]: NSS returned no entry for 'systemd-timesync'1760second # [ 7.134815] dbus-broker-launch[552]: Invalid user-name in /nix/store/yakhfj9kl3qk8kdjn8107g66fclcfh9m-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1761second # [ 7.141854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1762second # [ 7.144920] systemd[1]: Stopped Virtual Console Setup.1763second # [ 7.149634] systemd[1]: Starting Virtual Console Setup...1764second # [ 7.175536] dbus-broker-launch[552]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1765second # [ 7.179355] dbus-broker-launch[552]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1766second # [ 7.183142] dbus-broker-launch[552]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1767second # [ 7.189140] dbus-broker-launch[552]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1768second # [ 7.193345] systemd[1]: Started D-Bus System Message Bus.1769second # [ 7.196256] systemd[1]: Reached target Basic System.1770second # [ 7.201146] systemd[1]: Starting Network Manager Script Dispatcher Service...1771test # [ 7.211224] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1772second # [ 7.206254] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1773test # [ 7.217876] systemd[1]: Finished Save Transient machine-id to Disk.1774second # [ 7.391582] ppdev: user-space parallel port driver1775second # [ 7.218163] systemd[1]: Starting Network Manager...1776second # [ 7.228909] systemd[1]: Started backdoor.service.1777second # [ 7.240341] dbus-broker-launch[552]: Ready1778test # [ 7.251478] systemd[1]: Finished Create System Files and Directories.1779second # [ 7.249156] systemd[1]: Starting Import lastlog data into lastlog2 database...1780test # [ 7.261868] systemd[1]: Starting Rebuild Journal Catalog...1781second # [ 7.259546] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1782test # [ 7.267906] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1783second # [ 7.267450] systemd[1]: Starting Post-Boot Actions...1784second # [ 7.277160] systemd[1]: Started Reset console on configuration changes.1785test # [ 7.335726] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1786second # [ 7.341609] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[562]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1787second # [ 7.345275] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1788test # [ 7.367060] systemd[1]: Finished Rebuild Journal Catalog.1789test # [ 7.374312] systemd[1]: Starting Update is Completed...1790second # [ 7.384650] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1791second # connecting to host...1792second # [ 7.395316] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1793second # [ 7.583382] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1794second # [ 7.410394] systemd[1]: Finished Post-Boot Actions.1795second # [ 7.423177] nsncd[566]: Sep 29 15:03:04.250 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1796test # [ 7.432584] systemd[1]: Finished Update is Completed.1797second # [ 7.430381] systemd[1]: Started Name Service Cache Daemon (nsncd).1798second # [ 7.431490] systemd[1]: Reached target Host and Network Name Lookups.1799second # [ 7.432633] systemd[1]: Reached target User and Group Name Lookups.1800test # [ 7.441228] systemd[1]: Finished Firewall.1801test # [ 7.442169] systemd[1]: Reached target Preparation for Network.1802test # [ 7.443821] systemd[1]: Listening on Network Management Resolve Hook Socket.1803test # [ 7.452850] systemd[1]: Starting Network Management...1804second # [ 7.446061] systemd[1]: Starting User Login Management...1805test # [ 7.638304] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31806second # [ 7.464912] systemd[1]: Finished Import lastlog data into lastlog2 database.1807second # [ 7.478246] systemd[1]: Started Network Manager Script Dispatcher Service.1808second # [ 7.659103] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1809second # [ 7.493398] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1810second # [ 7.498368] systemd[1]: Stopped Virtual Console Setup.1811second # [ 7.504637] systemd[1]: Starting Virtual Console Setup...1812test # [ 7.706601] mousedev: PS/2 mouse device common for all mice1813test # [ 7.719991] ACPI: button: Power Button [PWRF]1814second # [ 7.554669] systemd[1]: Starting Hostname Service...1815test # [ 7.770212] rtc_cmos PNP0B00:00: RTC can wake from S41816second # [ 7.588985] systemd-logind[597]: New seat seat0.1817second # [ 7.594128] systemd-logind[597]: Watching system buttons on /dev/input/event2 (Power Button)1818second # [ 7.595561] systemd-logind[597]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1819second # [ 7.597064] systemd-logind[597]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1820second # [ 7.598574] systemd[1]: Started User Login Management.1821second # [ 7.603551] systemd[1]: Starting linger-users.service...1822test # [ 7.827435] rtc_cmos PNP0B00:00: registered as rtc01823second # [ 7.648964] systemd[1]: linger-users.service: Deactivated successfully.1824second # [ 7.654221] systemd[1]: Finished linger-users.service.1825second # [ 7.655861] systemd[1]: Started Hostname Service.1826test # [ 7.851545] parport_pc 00:02: reported by Plug and Play ACPI1827test # [ 7.852575] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1828second # [ 7.847166] kvm_amd: TSC scaling supported1829second # [ 7.848949] kvm_amd: Nested Virtualization enabled1830test # [ 7.855212] cfg80211: Loading compiled-in X.509 certificates for regulatory database1831second # [ 7.849545] kvm_amd: Nested Paging enabled1832second # [ 7.850050] kvm_amd: LBR virtualization supported1833test # [ 7.856667] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1834second # [ 7.850647] kvm_amd: Virtual GIF supported1835second # [ 7.851163] kvm_amd: Virtual NMI enabled1836test # [ 7.857837] rtc_cmos PNP0B00:00: setting system clock to 2026-09-29T15:03:04 UTC (1790694184)1837test # [ 7.859511] systemd-journald[334]: Time jumped backwards, rotating.1838test # [ 7.704279] systemd-resolved[363]: Clock change detected. Flushing caches.1839test # [ 7.713192] systemd[1]: Finished register-nix-paths.service.1840second # [ 7.881943] EDAC MC: Ver: 3.0.01841test # [ 7.724086] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1842test # [ 7.725765] systemd[1]: Finished Create SUID/SGID Wrappers.1843second # [ 7.718933] systemd-networkd[511]: eth0: Link UP1844second # [ 7.720613] systemd-networkd[511]: eth0: Gained carrier1845test # [ 7.728823] systemd[1]: Reached target System Initialization.1846test # [ 7.730965] systemd[1]: Started Discard unused filesystem blocks once a week.1847test # [ 7.733196] systemd[1]: Started Daily Cleanup of Temporary Directories.1848test # [ 7.734876] systemd[1]: Reached target Timer Units.1849test # [ 7.736364] systemd[1]: Listening on D-Bus System Message Bus Socket.1850test # [ 7.738211] systemd[1]: Listening on Nix Daemon Socket.1851second # [ 7.737180] systemd[1]: Started Network Manager.1852test # [ 7.745436] systemd[1]: Listening on Authorization Manager Agent Helper.1853second # [ 7.739824] systemd[1]: Reached target Network.1854test # [ 7.746628] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1855test # [ 7.748090] systemd[1]: Reached target Socket Units.1856second # [ 7.743749] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1857test # [ 7.752906] systemd[1]: Starting D-Bus System Message Bus...1858second # [ 7.747933] systemd[1]: Starting Permit User Sessions...1859test # [ 7.775375] 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.1860test # [ 7.782330] 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.1861test # [ 7.787121] systemd-networkd[533]: lo: Link UP1862test # [ 7.787996] systemd-networkd[533]: lo: Gained carrier1863test # [ 7.794553] systemd[1]: Started Network Management.1864test # [ 7.798205] systemd-networkd[533]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1865test # [ 7.800679] systemd-networkd[533]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1866second # [ 7.795251] systemd[1]: Finished Permit User Sessions.1867test # [ 7.804285] systemd-networkd[533]: eth1: Link UP1868test # [ 7.805474] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1869second # [ 7.801246] systemd[1]: Started Getty on tty1.1870second # [ 7.802139] systemd[1]: Reached target Login Prompts.1871test # [ 7.810163] systemd-networkd[533]: eth1: Gained carrier1872test # [ 7.811148] systemd-networkd[533]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1873test # [ 7.851570] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1874test # [ 7.902913] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1875test # [ 7.915123] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1876test # [ 7.873619] dbus-broker-launch[566]: Looking up NSS user entry for 'systemd-timesync'...1877second # [ 7.867781] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1878second # [ 7.871073] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1879test # [ 7.878825] dbus-broker-launch[566]: NSS returned no entry for 'systemd-timesync'1880test # [ 7.880287] dbus-broker-launch[566]: Invalid user-name in /nix/store/yakhfj9kl3qk8kdjn8107g66fclcfh9m-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1881second # [ 7.874837] systemd[1]: Reached target Multi-User System.1882test # [ 7.915209] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1883test # [ 7.916630] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1884second # [ 7.891197] systemd-vconsole-setup[609]: Configuration of first virtual console was skipped, ignoring remaining ones.1885second # [ 7.894548] systemd[1]: Finished Virtual Console Setup.1886second # [ 7.899083] systemd[1]: Startup finished in 784ms (kernel) + 3.563s (initrd) + 3.549s (userspace) = 7.898s.1887test # [ 7.918638] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input41888test # [ 8.003785] NET: Registered PF_PACKET protocol family1889test # [ 8.043016] Console: switching to colour dummy device 80x251890test # [ 7.914959] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1891test # [ 7.920105] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/80ww8vwb347f6hpxip20p9ns9qm2s2v8-networkmanager-1.58.1/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1892test # [ 7.924100] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/xw5lmid8j3918qh55xaw8jps6vbjq4cv-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1893test # [ 7.928198] dbus-broker-launch[566]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/zv9j8ckqlivmnmiwjspkn28jc5l3ls0m-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1894test # [ 7.932063] systemd[1]: Started D-Bus System Message Bus.1895test # [ 7.934426] systemd[1]: Reached target Basic System.1896test # [ 7.940145] systemd[1]: Starting Network Manager Script Dispatcher Service...1897test # [ 7.943481] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1898test # [ 7.946666] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1899second # [ 7.946266] systemd-resolved[343]: eth0: Bus client set default route setting: yes1900second # [ 7.949149] systemd-resolved[343]: eth0: Bus client set DNS server list to: 10.0.2.31901test # [ 7.964087] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1902test # [ 7.969844] dbus-broker-launch[566]: Ready1903test # [ 8.077131] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1904test # [ 7.983613] systemd[1]: Starting Network Manager...1905test # [ 8.077232] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1906test # [ 8.143183] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61907test # [ 8.009425] systemd[1]: Started backdoor.service.1908test # [ 8.028674] systemd[1]: Starting Import lastlog data into lastlog2 database...1909test # [ 8.040690] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1910test # [ 8.044868] csrsqhskch16fs3hk832ykw1r2z9maxh-wifi-secrets[575]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1911test # [ 8.048394] 7x3chz0b0917ic6jha19q7m5hcdq301r-wifi-secrets[577]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1912test # [ 8.054507] vb8pc9wcqy39qa3q5alv51h0jms1a1wl-wifi-secrets[576]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1913test # [ 8.078489] systemd[1]: Starting Post-Boot Actions...1914test # [ 8.143526] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51915test # [ 8.265372] [drm] Found bochs VGA, ID 0xb0c5.1916test # [ 8.265375] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1917test # [ 8.099262] systemd[1]: Started Reset console on configuration changes.1918test # [ 8.120174] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1919test # [ 8.129218] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1920test # connecting to host...1921test # [ 8.138371] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1922test # [ 8.145334] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1923test # [ 8.147560] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1924test # [ 8.156131] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1925test: Guest shell says: b'Spawning backdoor root shell...\n'1926test # [ 8.178286] nsncd[588]: Sep 29 15:03:04.994 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1927test # [ 8.181319] systemd[1]: Started Name Service Cache Daemon (nsncd).1928test: connected to guest root shell1929test: (connecting took 8.83 seconds)1930test: (finished: waiting for the VM to finish booting, in 8.83 seconds)1931test # [ 8.365552] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1932test # [ 8.366392] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01933test # [ 8.194429] systemd[1]: Finished Post-Boot Actions.1934test # [ 8.229700] systemd[1]: Started Network Manager Script Dispatcher Service.1935test # [ 8.235567] systemd[1]: Reached target Host and Network Name Lookups.1936test # [ 8.238188] systemd[1]: Reached target User and Group Name Lookups.1937test # [ 8.247241] systemd[1]: Starting User Login Management...1938test # [ 8.253407] systemd[1]: Starting Virtual Console Setup...1939test # [ 8.256177] systemd[1]: Finished Import lastlog data into lastlog2 database.1940test # [ 8.335429] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1941test # [ 8.342771] systemd[1]: Starting Hostname Service...1942test # [ 8.353205] systemd-logind[631]: Watching system buttons on /dev/input/event2 (Power Button)1943test # [ 8.586747] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1944test # [ 8.591539] Console: switching to colour frame buffer device 160x501945test # [ 8.596709] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1946second # [ 8.459065] systemd-networkd[511]: eth1: Gained IPv6LL1947test # [ 8.596798] ppdev: user-space parallel port driver1948test # [ 8.660170] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1949test # [ 8.356068] systemd-logind[631]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1950test # [ 8.490748] systemd[1]: Started Hostname Service.1951test # [ 8.491904] systemd-networkd[533]: eth0: Link UP1952test # [ 8.496698] systemd-networkd[533]: eth0: Gained carrier1953test # [ 8.500251] systemd-logind[631]: New seat seat0.1954test # [ 8.501206] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1955test # [ 8.504802] systemd-logind[631]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1956test # [ 8.507941] systemd[1]: Stopped Virtual Console Setup.1957test # [ 8.511668] systemd[1]: Started User Login Management.1958test # [ 8.520180] systemd[1]: Starting linger-users.service...1959test # [ 8.525075] systemd[1]: Starting Virtual Console Setup...1960test # [ 8.530415] systemd[1]: Started Network Manager.1961test # [ 8.551072] systemd[1]: Reached target Network.1962test # [ 8.561506] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1963test # [ 8.564186] systemd[1]: Starting Permit User Sessions...1964test # [ 8.665303] systemd[1]: linger-users.service: Deactivated successfully.1965test # [ 8.671288] systemd[1]: Finished linger-users.service.1966test # [ 8.679163] systemd[1]: Finished Permit User Sessions.1967test # [ 8.696652] systemd[1]: Started Getty on tty1.1968test # [ 8.697592] systemd[1]: Reached target Login Prompts.1969test # [ 8.883380] kvm_amd: TSC scaling supported1970test # [ 8.887912] kvm_amd: Nested Virtualization enabled1971test # [ 8.888466] kvm_amd: Nested Paging enabled1972test # [ 8.891963] kvm_amd: LBR virtualization supported1973test # [ 8.892510] kvm_amd: Virtual GIF supported1974test # [ 8.893969] kvm_amd: Virtual NMI enabled1975test # [ 8.741688] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1976test # [ 8.745504] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1977test # [ 8.753714] systemd-resolved[363]: eth0: Bus client set default route setting: yes1978test # [ 8.755936] systemd[1]: Reached target Multi-User System.1979test # [ 8.757787] systemd-resolved[363]: eth0: Bus client set DNS server list to: 10.0.2.31980test # [ 8.946512] EDAC MC: Ver: 3.0.01981test # [ 8.840185] systemd-vconsole-setup[650]: Configuration of first virtual console was skipped, ignoring remaining ones.1982test # [ 8.843831] systemd[1]: Finished Virtual Console Setup.1983test # [ 8.848244] systemd[1]: Startup finished in 794ms (kernel) + 4.357s (initrd) + 3.695s (userspace) = 8.847s.1984second # [ 9.035134] systemd-networkd[511]: eth0: Gained IPv6LL1985test # [ 9.229575] systemd-networkd[533]: eth1: Gained IPv6LL1986test: (finished: waiting for unit NetworkManager.service, in 10.00 seconds)1987test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1988test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1989test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1990test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1991test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1992test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1993(finished: run the VM test script, in 10.14 seconds)1994test script finished in 10.16s1995cleanup1996kill QemuMachine (pid 47)1997second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)1998second # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down1999second # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down2000second # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down2001kill QemuMachine (pid 48)2002test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)2003test # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down2004test # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down2005test # [2026-09-29T15:03:06Z INFO virtiofsd] Client disconnected, shutting down2006(finished: cleanup, in 0.17 seconds)