nixbot

builds

succeeded vm-test-run-wifi checks.x86_64-linux.wifi · build #117 · raw

1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13second # Disk image does not exist, creating the virtualisation disk image...14second # Formatting '/build/vm-state-second/tmp.9cJDLGZ4F6', fmt=raw size=107374182415second # mke2fs 1.47.4 (6-Mar-2025)16second # Discarding device blocks: 0/262144 done17second # Creating filesystem with 262144 4k blocks and 65536 inodes18second # Filesystem UUID: 01dc2460-4b22-41a0-836d-98f1595799c719second # Superblock backups stored on blocks:20second # 32768, 98304, 163840, 22937621second # 22second # Allocating group tables: 0/8 done23second # Writing inode tables: 0/8 done24second # Creating journal (8192 blocks): done25second # Writing superblocks and filesystem accounting information: 0/8 done26second # 27second # Virtualisation disk image created.28second: QEMU running (pid 46)29test # Disk image does not exist, creating the virtualisation disk image...30test # Formatting '/build/vm-state-test/tmp.c8SVEw18r8', fmt=raw size=107374182431test # mke2fs 1.47.4 (6-Mar-2025)32test # Discarding device blocks: 0/262144 done33test # Creating filesystem with 262144 4k blocks and 65536 inodes34test # Filesystem UUID: ea20a194-1d29-49e3-ae13-cdf52772d9f735test # Superblock backups stored on blocks:36test # 32768, 98304, 163840, 22937637test # 38test # Allocating group tables: 0/8 done39test # Writing inode tables: 0/8 done40test # Creating journal (8192 blocks): done41test # Writing superblocks and filesystem accounting information: 0/8 done42test # 43test # Virtualisation disk image created.44test: QEMU running (pid 48)45(finished: start all VMs, in 0.56 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)49test # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)50second # 51second # 52second # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0053second # Press Ctrl-B to configure iPXE (PCI 00:02.0)...54second # 55second # 56second # 57second # 58second # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0059second # Press Ctrl-B to configure iPXE (PCI 00:08.0)...60second # 61second # 62second # Booting from ROM...63second # Probing EDD (edd=off to disable)... ok64test # 65test # 66test # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFD15C0+3EF315C0 CA0067test # Press Ctrl-B to configure iPXE (PCI 00:02.0)...68test # 69test # 70test # 71test # 72test # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFD15C0 3EF315C0 CB0073test # Press Ctrl-B to configure iPXE (PCI 00:08.0)...74test # 75test # 76test # Booting from ROM...77second # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 202678second # [ 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/41grk726jb1nqr68nw7vkjsf12lbnw7r-nixos-system-second-test/init regInfo=/nix/store/7h6vr552qvrsg66hhmv9f619mb9h95d8-closure-info/registration console=ttyS0,115200n8 console=tty079second # [ 0.000000] BIOS-provided physical RAM map:80second # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable81second # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved82second # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved83second # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable84second # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved85second # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved86second # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved87second # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved88second # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved89second # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved90second # [ 0.000000] NX (Execute Disable) protection: active91second # [ 0.000000] APIC: Static calls initialized92second # [ 0.000000] SMBIOS 2.8 present.93second # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201494second # [ 0.000000] DMI: Memory slots populated: 1/195second # [ 0.000000] Hypervisor detected: KVM96second # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x40000000097second # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0098second # [ 0.000001] kvm-clock: using sched offset of 580311855 cycles99second # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns100second # [ 0.000008] tsc: Detected 4192.120 MHz processor101second # [ 0.000652] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000102second # [ 0.000683] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs103second # [ 0.000686] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT104second # [ 0.002456] found SMP MP-table at [mem 0x000f5450-0x000f545f]105second # [ 0.002473] Using GB pages for direct mapping106second # [ 0.002550] RAMDISK: [mem 0x3e36b000-0x3ffcffff]107second # [ 0.002557] ACPI: Early table checksum verification disabled108second # [ 0.002561] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )109second # [ 0.002565] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)110second # [ 0.002571] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)111second # [ 0.002576] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)112second # [ 0.002579] ACPI: FACS 0x000000003FFE0000 000040113second # [ 0.002580] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)114second # [ 0.002581] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)115second # [ 0.002582] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)116second # [ 0.002584] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)117second # [ 0.002585] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]118second # [ 0.002585] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]119second # [ 0.002586] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]120second # [ 0.002586] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]121second # [ 0.002587] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]122second # [ 0.002587] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]123second # [ 0.002588] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]124second # [ 0.002975] No NUMA configuration found125second # [ 0.002977] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]126second # [ 0.002980] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]127second # [ 0.003060] Zone ranges:128second # [ 0.003061] DMA [mem 0x0000000000001000-0x0000000000ffffff]129second # [ 0.003062] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]130second # [ 0.003063] Normal empty131second # [ 0.003064] Device empty132second # [ 0.003064] Movable zone start for each node133second # [ 0.003065] Early memory node ranges134second # [ 0.003065] node 0: [mem 0x0000000000001000-0x000000000009efff]135test # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 2026136second # [ 0.003066] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]137second # [ 0.003067] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]138second # [ 0.003086] On node 0, zone DMA: 1 pages in unavailable ranges139second # [ 0.003308] On node 0, zone DMA: 97 pages in unavailable ranges140second # [ 0.017493] On node 0, zone DMA32: 40 pages in unavailable ranges141test # [ 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/swxa86y3wmqx1dr86miw20bagz8rxc7l-nixos-system-test-test/init regInfo=/nix/store/xdi2dl0yv3lc6ql6cj4x29pb15jsldpa-closure-info/registration console=ttyS0,115200n8 console=tty0142second # [ 0.018358] ACPI: PM-Timer IO Port: 0x608143test # [ 0.000000] BIOS-provided physical RAM map:144second # [ 0.018373] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])145test # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable146second # [ 0.018399] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23147test # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved148second # [ 0.018401] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)149test # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved150second # [ 0.018402] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)151test # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable152test # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved153second # [ 0.018403] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)154test # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved155second # [ 0.018404] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)156test # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved157test # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved158second # [ 0.018404] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)159test # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved160second # [ 0.018406] ACPI: Using ACPI (MADT) for SMP configuration information161test # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved162second # [ 0.018407] ACPI: HPET id: 0x8086a201 base: 0xfed00000163test # [ 0.000000] NX (Execute Disable) protection: active164test # [ 0.000000] APIC: Static calls initialized165second # [ 0.018413] TSC deadline timer available166test # [ 0.000000] SMBIOS 2.8 present.167second # [ 0.018416] CPU topo: Max. logical packages: 1168second # [ 0.018417] CPU topo: Max. logical dies: 1169test # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014170second # [ 0.018417] CPU topo: Max. dies per package: 1171test # [ 0.000000] DMI: Memory slots populated: 1/1172second # [ 0.018421] CPU topo: Max. threads per core: 1173test # [ 0.000000] Hypervisor detected: KVM174second # [ 0.018421] CPU topo: Num. cores per package: 1175test # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000176second # [ 0.018421] CPU topo: Num. threads per package: 1177test # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00178second # [ 0.018422] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs179test # [ 0.000000] kvm-clock: using sched offset of 574445067 cycles180second # [ 0.018442] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()181test # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns182second # [ 0.018475] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]183test # [ 0.000006] tsc: Detected 4192.120 MHz processor184second # [ 0.018476] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]185test # [ 0.000631] last_pfn = 0x3ffd8 max_arch_pfn = 0x400000000186second # [ 0.018477] [mem 0x40000000-0xafffffff] available for PCI devices187test # [ 0.000663] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs188second # [ 0.018479] Booting paravirtualized kernel on KVM189test # [ 0.000666] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT190second # [ 0.018483] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns191test # [ 0.002402] found SMP MP-table at [mem 0x000f5450-0x000f545f]192test # [ 0.002422] Using GB pages for direct mapping193second # [ 0.021981] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1194test # [ 0.002517] RAMDISK: [mem 0x3e36a000-0x3ffcffff]195second # [ 0.024063] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152196test # [ 0.002524] ACPI: Early table checksum verification disabled197second # [ 0.024110] kvm-guest: PV spinlocks disabled, single CPU198test # [ 0.002529] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )199test # [ 0.002535] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)200test # [ 0.002541] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)201test # [ 0.002547] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)202second # [ 0.024111] 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/41grk726jb1nqr68nw7vkjsf12lbnw7r-nixos-system-second-test/init regInfo=/nix/store/7h6vr552qvrsg66hhmv9f619mb9h95d8-closure-info/registration console=ttyS0,115200n8 console=tty0203test # [ 0.002549] ACPI: FACS 0x000000003FFE0000 000040204test # [ 0.002551] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)205second # [ 0.024192] Unknown kernel command line parameters "regInfo=/nix/store/7h6vr552qvrsg66hhmv9f619mb9h95d8-closure-info/registration", will be passed to user space.206test # [ 0.002552] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)207second # [ 0.024384] random: crng init done208second # [ 0.024385] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes209test # [ 0.002554] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)210second # [ 0.025238] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)211test # [ 0.002555] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)212second # [ 0.025263] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)213test # [ 0.002556] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]214second # [ 0.025297] Fallback order for Node 0: 0215test # [ 0.002557] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]216second # [ 0.025300] Built 1 zonelists, mobility grouping on. Total pages: 262006217second # [ 0.025301] Policy zone: DMA32218test # [ 0.002557] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]219second # [ 0.027929] mem auto-init: stack:all(zero), heap alloc:on, heap free:off220test # [ 0.002558] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]221second # [ 0.030640] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1222test # [ 0.002558] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]223second # [ 0.032445] allocated 2097152 bytes of page_ext224test # [ 0.002558] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]225second # [ 0.042452] ftrace: allocating 48732 entries in 192 pages226second # [ 0.042456] ftrace: allocated 192 pages with 2 groups227test # [ 0.002559] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]228second # [ 0.043297] Dynamic Preempt: lazy229test # [ 0.002936] No NUMA configuration found230second # [ 0.043452] rcu: Preemptible hierarchical RCU implementation.231test # [ 0.002937] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]232second # [ 0.043452] rcu: RCU event tracing is enabled.233test # [ 0.002940] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]234test # [ 0.003017] Zone ranges:235second # [ 0.043453] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.236second # [ 0.043455] Trampoline variant of Tasks RCU enabled.237test # [ 0.003017] DMA [mem 0x0000000000001000-0x0000000000ffffff]238second # [ 0.043455] Rude variant of Tasks RCU enabled.239test # [ 0.003018] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]240second # [ 0.043455] Tracing variant of Tasks RCU enabled.241test # [ 0.003019] Normal empty242test # [ 0.003020] Device empty243second # [ 0.043456] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.244test # [ 0.003020] Movable zone start for each node245test # [ 0.003021] Early memory node ranges246second # [ 0.043457] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1247test # [ 0.003021] node 0: [mem 0x0000000000001000-0x000000000009efff]248second # [ 0.043478] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.249test # [ 0.003022] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]250test # [ 0.003023] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]251second # [ 0.043479] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.252test # [ 0.003041] On node 0, zone DMA: 1 pages in unavailable ranges253second # [ 0.043480] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.254test # [ 0.003259] On node 0, zone DMA: 97 pages in unavailable ranges255second # [ 0.047170] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16256test # [ 0.017100] On node 0, zone DMA32: 40 pages in unavailable ranges257test # [ 0.017955] ACPI: PM-Timer IO Port: 0x608258second # [ 0.047498] rcu: srcu_init: Setting srcu_struct sizes based on contention.259test # [ 0.017970] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])260second # [ 0.047512] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns261test # [ 0.017994] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23262test # [ 0.017996] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)263second # [ 0.047708] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)264second # [ 0.053293] Console: colour VGA+ 80x25265test # [ 0.017998] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)266second # [ 0.053302] printk: legacy console [tty0] enabled267test # [ 0.017999] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)268second # [ 0.085312] printk: legacy console [ttyS0] enabled269test # [ 0.018001] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)270second # [ 0.228319] ACPI: Core revision 20250807271test # [ 0.018001] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)272test # [ 0.018003] ACPI: Using ACPI (MADT) for SMP configuration information273second # [ 0.229465] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns274test # [ 0.018004] ACPI: HPET id: 0x8086a201 base: 0xfed00000275second # [ 0.231464] APIC: Switch to symmetric I/O mode setup276test # [ 0.018009] TSC deadline timer available277second # [ 0.232687] x2apic enabled278test # [ 0.018013] CPU topo: Max. logical packages: 1279test # [ 0.018013] CPU topo: Max. logical dies: 1280second # [ 0.233548] APIC: Switched APIC routing to: physical x2apic281test # [ 0.018014] CPU topo: Max. dies per package: 1282test # [ 0.018019] CPU topo: Max. threads per core: 1283test # [ 0.018019] CPU topo: Num. cores per package: 1284second # [ 0.235599] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1285test # [ 0.018020] CPU topo: Num. threads per package: 1286test # [ 0.018020] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs287second # [ 0.236860] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns288test # [ 0.018040] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()289second # [ 0.239012] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)290test # [ 0.018075] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]291second # [ 0.240114] x86/cpu: User Mode Instruction Prevention (UMIP) activated292test # [ 0.018076] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]293test # [ 0.018077] [mem 0x40000000-0xafffffff] available for PCI devices294second # [ 0.241144] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127295test # [ 0.018078] Booting paravirtualized kernel on KVM296second # [ 0.243010] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0297test # [ 0.018081] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns298second # [ 0.244015] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto299test # [ 0.021550] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1300test # [ 0.023305] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152301second # [ 0.245010] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl302test # [ 0.023347] kvm-guest: PV spinlocks disabled, single CPU303second # [ 0.246011] Spectre V2 : Mitigation: Enhanced / Automatic IBRS304second # [ 0.247010] Speculative Return Stack Overflow: Mitigation: Safe RET305second # [ 0.248010] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization306second # [ 0.250019] Spectre V2 : Enabling IBPB for BPF307test # [ 0.023349] 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/swxa86y3wmqx1dr86miw20bagz8rxc7l-nixos-system-test-test/init regInfo=/nix/store/xdi2dl0yv3lc6ql6cj4x29pb15jsldpa-closure-info/registration console=ttyS0,115200n8 console=tty0308second # [ 0.252012] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier309test # [ 0.023428] Unknown kernel command line parameters "regInfo=/nix/store/xdi2dl0yv3lc6ql6cj4x29pb15jsldpa-closure-info/registration", will be passed to user space.310test # [ 0.023626] random: crng init done311second # [ 0.253011] active return thunk: srso_alias_return_thunk312test # [ 0.023627] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes313second # [ 0.254039] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'314test # [ 0.024498] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)315second # [ 0.255010] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'316test # [ 0.024530] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)317second # [ 0.256010] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'318test # [ 0.024571] Fallback order for Node 0: 0319test # [ 0.024574] Built 1 zonelists, mobility grouping on. Total pages: 262006320test # [ 0.024575] Policy zone: DMA32321test # [ 0.026614] mem auto-init: stack:all(zero), heap alloc:on, heap free:off322second # [ 0.257010] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'323second # [ 0.258011] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'324second # [ 0.259008] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'325test # [ 0.029410] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1326test # [ 0.031247] allocated 2097152 bytes of page_ext327test # [ 0.041068] ftrace: allocating 48732 entries in 192 pages328second # [ 0.259011] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'329test # [ 0.041071] ftrace: allocated 192 pages with 2 groups330test # [ 0.041867] Dynamic Preempt: lazy331second # [ 0.260011] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'332test # [ 0.041984] rcu: Preemptible hierarchical RCU implementation.333test # [ 0.041985] rcu: RCU event tracing is enabled.334second # [ 0.262011] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'335test # [ 0.041986] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.336second # [ 0.263012] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256337test # [ 0.041987] Trampoline variant of Tasks RCU enabled.338test # [ 0.041987] Rude variant of Tasks RCU enabled.339second # [ 0.264011] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64340test # [ 0.041988] Tracing variant of Tasks RCU enabled.341second # [ 0.266011] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512342test # [ 0.041988] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.343second # [ 0.267011] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024344test # [ 0.041989] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1345second # [ 0.268011] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8346test # [ 0.042035] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.347second # [ 0.270011] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16348test # [ 0.042036] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.349second # [ 0.271011] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24350test # [ 0.042037] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.351test # [ 0.045500] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16352second # [ 0.272011] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.353test # [ 0.045772] rcu: srcu_init: Setting srcu_struct sizes based on contention.354test # [ 0.045781] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns355test # [ 0.045947] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)356test # [ 0.051371] Console: colour VGA+ 80x25357test # [ 0.051375] printk: legacy console [tty0] enabled358test # [ 0.083010] printk: legacy console [ttyS0] enabled359test # [ 0.225568] ACPI: Core revision 20250807360test # [ 0.226734] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns361test # [ 0.228750] APIC: Switch to symmetric I/O mode setup362test # [ 0.229975] x2apic enabled363test # [ 0.230839] APIC: Switched APIC routing to: physical x2apic364test # [ 0.232915] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1365test # [ 0.234199] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns366test # [ 0.236416] Calibrating delay loop (skipped) preset value.. 8384.24 BogoMIPS (lpj=4192120)367test # [ 0.238507] x86/cpu: User Mode Instruction Prevention (UMIP) activated368test # [ 0.240514] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127369test # [ 0.241415] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0370test # [ 0.242417] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto371test # [ 0.244415] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl372test # [ 0.245416] Spectre V2 : Mitigation: Enhanced / Automatic IBRS373second # [ 0.303057] Freeing SMP alternatives memory: 44K374test # [ 0.247416] Speculative Return Stack Overflow: Mitigation: Safe RET375second # [ 0.304015] pid_max: default: 32768 minimum: 301376test # [ 0.248420] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization377second # [ 0.305096] LSM: initializing lsm=capability,landlock,yama,bpf,ima378second # [ 0.306145] landlock: Up and running.379second # [ 0.307724] Yama: becoming mindful.380second # [ 0.309000] LSM support for eBPF active381second # [ 0.309008] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)382test # [ 0.250423] Spectre V2 : Enabling IBPB for BPF383second # [ 0.309053] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)384test # [ 0.252417] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier385test # [ 0.253417] active return thunk: srso_alias_return_thunk386test # [ 0.254412] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'387second # [ 0.313008] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)388test # [ 0.254412] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'389second # [ 0.313704] Performance Events: Fam17h+ core perfctr, AMD PMU driver.390second # [ 0.315017] ... version: 2391second # [ 0.316037] ... bit width: 48392test # [ 0.255416] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'393test # [ 0.257416] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'394second # [ 0.317013] ... generic counters: 6395second # [ 0.318014] ... generic bitmap: 000000000000003f396test # [ 0.258415] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'397test # [ 0.259415] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'398second # [ 0.319013] ... fixed-purpose counters: 0399second # [ 0.320013] ... fixed-purpose bitmap: 0000000000000000400second # [ 0.321013] ... value mask: 0000ffffffffffff401second # [ 0.322014] ... max period: 00007fffffffffff402test # [ 0.260415] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'403test # [ 0.262412] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'404second # [ 0.323013] ... global_ctrl mask: 000000000000003f405second # [ 0.324318] signal: max sigframe size: 3376406second # [ 0.325267] rcu: Hierarchical SRCU implementation.407test # [ 0.263415] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'408second # [ 0.326021] rcu: Max phase no-delay instances is 400.409test # [ 0.264417] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256410test # [ 0.265415] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64411test # [ 0.266416] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512412test # [ 0.267415] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024413test # [ 0.269412] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8414test # [ 0.269416] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16415second # [ 0.332106] smp: Bringing up secondary CPUs ...416second # [ 0.333027] smp: Brought up 1 node, 1 CPU417test # [ 0.270416] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24418second # [ 0.334024] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)419second # [ 0.335277] Memory: 943008K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 97580K reserved, 0K cma-reserved)420second # [ 0.336386] devtmpfs: initialized421test # [ 0.271415] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.422second # [ 0.337265] x86/mm: Memory block size: 128MB423second # [ 0.339214] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)424second # [ 0.340056] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).425second # [ 0.341176] pinctrl core: initialized pinctrl subsystem426second # [ 0.342426] PM: RTC time: 05:10:20, date: 2026-09-06427second # [ 0.346329] NET: Registered PF_NETLINK/PF_ROUTE protocol family428second # [ 0.347458] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations429second # [ 0.348055] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations430second # [ 0.349179] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations431second # [ 0.350040] audit: initializing netlink subsys (disabled)432second # [ 0.351461] thermal_sys: Registered thermal governor 'fair_share'433second # [ 0.351464] thermal_sys: Registered thermal governor 'bang_bang'434second # [ 0.352020] audit: type=2000 audit(1788671420.863:1): state=initialized audit_enabled=0 res=1435second # [ 0.354018] thermal_sys: Registered thermal governor 'step_wise'436second # [ 0.354020] thermal_sys: Registered thermal governor 'user_space'437second # [ 0.355016] thermal_sys: Registered thermal governor 'power_allocator'438second # [ 0.356053] cpuidle: using governor menu439second # [ 0.359120] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5440second # [ 0.360383] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]441second # [ 0.361017] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry442second # [ 0.362034] PCI: Using configuration type 1 for base access443second # [ 0.363320] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.444test # [ 0.302191] Freeing SMP alternatives memory: 44K445test # [ 0.303331] pid_max: default: 32768 minimum: 301446test # [ 0.304509] LSM: initializing lsm=capability,landlock,yama,bpf,ima447test # [ 0.305412] landlock: Up and running.448test # [ 0.305416] Yama: becoming mindful.449second # [ 0.372209] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages450second # [ 0.373016] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page451test # [ 0.306767] LSM support for eBPF active452test # [ 0.307412] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)453test # [ 0.308412] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)454second # [ 0.378019] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages455second # [ 0.379015] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page456test # [ 0.309412] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)457test # [ 0.310636] Performance Events: Fam17h+ core perfctr, AMD PMU driver.458test # [ 0.311421] ... version: 2459second # [ 0.386468] ACPI: Added _OSI(Module Device)460test # [ 0.312433] ... bit width: 48461test # [ 0.313417] ... generic counters: 6462test # [ 0.314417] ... generic bitmap: 000000000000003f463second # [ 0.387015] ACPI: Added _OSI(Processor Device)464test # [ 0.315417] ... fixed-purpose counters: 0465test # [ 0.316417] ... fixed-purpose bitmap: 0000000000000000466test # [ 0.317417] ... value mask: 0000ffffffffffff467second # [ 0.392017] ACPI: Added _OSI(Processor Aggregator Device)468test # [ 0.318417] ... max period: 00007fffffffffff469test # [ 0.319417] ... global_ctrl mask: 000000000000003f470test # [ 0.320538] signal: max sigframe size: 3376471test # [ 0.321530] rcu: Hierarchical SRCU implementation.472second # [ 0.399986] ACPI: 1 ACPI AML tables successfully acquired and loaded473test # [ 0.322523] rcu: Max phase no-delay instances is 400.474second # [ 0.406442] ACPI: Interpreter enabled475second # [ 0.407040] ACPI: PM: (supports S0 S3 S4 S5)476test # [ 0.327732] smp: Bringing up secondary CPUs ...477test # [ 0.328437] smp: Brought up 1 node, 1 CPU478test # [ 0.329335] smpboot: Total of 1 processors activated (8384.24 BogoMIPS)479second # [ 0.410016] ACPI: Using IOAPIC for interrupt routing480second # [ 0.411132] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug481test # [ 0.330628] Memory: 943020K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 97584K reserved, 0K cma-reserved)482test # [ 0.331730] devtmpfs: initialized483second # [ 0.414015] PCI: Using E820 reservations for host bridge windows484second # [ 0.415242] ACPI: Enabled 2 GPEs in block 00 to 3F485test # [ 0.332664] x86/mm: Memory block size: 128MB486test # [ 0.334357] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)487test # [ 0.335455] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).488test # [ 0.336534] pinctrl core: initialized pinctrl subsystem489test # [ 0.338581] PM: RTC time: 05:10:21, date: 2026-09-06490second # [ 0.422454] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])491second # [ 0.423023] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]492test # [ 0.342501] NET: Registered PF_NETLINK/PF_ROUTE protocol family493second # [ 0.424104] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]494test # [ 0.343774] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations495second # [ 0.426153] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]496test # [ 0.344442] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations497second # [ 0.427586] PCI host bridge to bus 0000:00498second # [ 0.428021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]499test # [ 0.345542] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations500test # [ 0.346432] audit: initializing netlink subsys (disabled)501second # [ 0.429015] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]502test # [ 0.347712] thermal_sys: Registered thermal governor 'fair_share'503second # [ 0.430014] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]504second # [ 0.431015] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]505second # [ 0.432014] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]506test # [ 0.347715] thermal_sys: Registered thermal governor 'bang_bang'507test # [ 0.348418] thermal_sys: Registered thermal governor 'step_wise'508second # [ 0.433014] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]509test # [ 0.349424] audit: type=2000 audit(1788671420.928:1): state=initialized audit_enabled=0 res=1510test # [ 0.351421] thermal_sys: Registered thermal governor 'user_space'511second # [ 0.434015] pci_bus 0000:00: root bus resource [bus 00-ff]512test # [ 0.351423] thermal_sys: Registered thermal governor 'power_allocator'513test # [ 0.352443] cpuidle: using governor menu514second # [ 0.435241] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint515second # [ 0.436899] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint516test # [ 0.355437] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5517test # [ 0.356779] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]518test # [ 0.357422] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry519test # [ 0.358436] PCI: Using configuration type 1 for base access520second # [ 0.440099] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]521test # [ 0.359671] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.522second # [ 0.441040] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]523second # [ 0.442061] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]524second # [ 0.443274] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]525test # [ 0.368506] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages526test # [ 0.369418] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page527second # [ 0.445130] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint528second # [ 0.448041] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]529test # [ 0.374419] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages530test # [ 0.375417] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page531second # [ 0.449033] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]532second # [ 0.450063] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]533second # [ 0.451029] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]534second # [ 0.453199] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint535second # [ 0.456028] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]536test # [ 0.385829] ACPI: Added _OSI(Module Device)537second # [ 0.457026] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]538test # [ 0.386418] ACPI: Added _OSI(Processor Device)539second # [ 0.458063] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]540test # [ 0.390760] ACPI: Added _OSI(Processor Aggregator Device)541second # [ 0.460211] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint542second # [ 0.463028] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]543test # [ 0.397856] ACPI: 1 ACPI AML tables successfully acquired and loaded544test # [ 0.399771] ACPI: Interpreter enabled545second # [ 0.464034] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]546second # [ 0.465064] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]547test # [ 0.400434] ACPI: PM: (supports S0 S3 S4 S5)548test # [ 0.401384] ACPI: Using IOAPIC for interrupt routing549second # [ 0.467406] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint550test # [ 0.405549] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug551test # [ 0.406418] PCI: Using E820 reservations for host bridge windows552second # [ 0.470028] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]553second # [ 0.471028] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]554test # [ 0.407590] ACPI: Enabled 2 GPEs in block 00 to 3F555second # [ 0.472061] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]556test # [ 0.412885] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])557test # [ 0.413423] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]558second # [ 0.474186] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint559test # [ 0.414499] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]560test # [ 0.415557] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]561second # [ 0.477029] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]562test # [ 0.416882] PCI host bridge to bus 0000:00563test # [ 0.417464] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]564second # [ 0.478028] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]565second # [ 0.479062] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]566test # [ 0.418418] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]567test # [ 0.419419] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]568second # [ 0.481148] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint569test # [ 0.420424] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]570test # [ 0.421418] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]571second # [ 0.484026] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]572test # [ 0.422418] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]573second # [ 0.485028] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]574test # [ 0.423419] pci_bus 0000:00: root bus resource [bus 00-ff]575second # [ 0.486060] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]576test # [ 0.424617] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint577test # [ 0.426199] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint578second # [ 0.488278] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint579second # [ 0.490926] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]580test # [ 0.429490] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]581second # [ 0.492027] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]582test # [ 0.430442] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]583second # [ 0.493060] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]584test # [ 0.431465] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]585second # [ 0.494028] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]586test # [ 0.432607] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]587test # [ 0.434446] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint588second # [ 0.496163] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint589second # [ 0.499039] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]590test # [ 0.437431] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]591second # [ 0.500061] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]592second # [ 0.502288] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint593test # [ 0.438434] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]594test # [ 0.439466] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]595test # [ 0.440430] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]596second # [ 0.505034] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]597test # [ 0.442402] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint598second # [ 0.506027] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]599test # [ 0.445178] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]600second # [ 0.507067] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]601test # [ 0.445428] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]602test # [ 0.446458] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]603second # [ 0.509147] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint604test # [ 0.448382] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint605second # [ 0.512014] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]606second # [ 0.513028] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]607test # [ 0.450427] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]608test # [ 0.451429] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]609second # [ 0.514061] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]610test # [ 0.452465] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]611test # [ 0.454417] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint612test # [ 0.457087] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]613test # [ 0.457431] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]614test # [ 0.458468] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]615test # [ 0.461037] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint616second # [ 0.516180] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint617test # [ 0.462429] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]618second # [ 0.519078] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]619test # [ 0.463431] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]620test # [ 0.464466] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]621second # [ 0.520688] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint622test # [ 0.466969] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint623second # [ 0.524039] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]624second # [ 0.525658] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint625test # [ 0.469432] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]626second # [ 0.528074] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]627second # [ 0.529502] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint628test # [ 0.470432] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]629second # [ 0.531579] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]630second # [ 0.532550] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint631test # [ 0.471468] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]632second # [ 0.533606] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO633second # [ 0.534496] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint634test # [ 0.473574] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint635second # [ 0.538072] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]636second # [ 0.539029] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]637second # [ 0.540899] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint638second # [ 0.543689] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]639test # [ 0.478381] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]640test # [ 0.479444] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]641test # [ 0.480474] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]642second # [ 0.550336] ACPI: PCI: Interrupt link LNKA configured for IRQ 10643second # [ 0.551193] ACPI: PCI: Interrupt link LNKB configured for IRQ 10644test # [ 0.481437] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]645second # [ 0.552167] ACPI: PCI: Interrupt link LNKC configured for IRQ 11646second # [ 0.553160] ACPI: PCI: Interrupt link LNKD configured for IRQ 11647second # [ 0.554158] ACPI: PCI: Interrupt link LNKE configured for IRQ 10648second # [ 0.555172] ACPI: PCI: Interrupt link LNKF configured for IRQ 10649second # [ 0.556323] ACPI: PCI: Interrupt link LNKG configured for IRQ 11650second # [ 0.557174] ACPI: PCI: Interrupt link LNKH configured for IRQ 11651test # [ 0.483615] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint652second # [ 0.558083] ACPI: PCI: Interrupt link GSIA configured for IRQ 16653test # [ 0.486452] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]654test # [ 0.487469] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]655second # [ 0.559041] ACPI: PCI: Interrupt link GSIB configured for IRQ 17656second # [ 0.560063] ACPI: PCI: Interrupt link GSIC configured for IRQ 18657test # [ 0.489627] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint658second # [ 0.561044] ACPI: PCI: Interrupt link GSID configured for IRQ 19659second # [ 0.562043] ACPI: PCI: Interrupt link GSIE configured for IRQ 20660test # [ 0.493437] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]661second # [ 0.563046] ACPI: PCI: Interrupt link GSIF configured for IRQ 21662second # [ 0.564046] ACPI: PCI: Interrupt link GSIG configured for IRQ 22663second # [ 0.565069] ACPI: PCI: Interrupt link GSIH configured for IRQ 23664test # [ 0.494433] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]665test # [ 0.496467] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]666second # [ 0.568384] iommu: Default domain type: Translated667second # [ 0.569029] iommu: DMA domain TLB invalidation policy: lazy mode668test # [ 0.498690] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint669second # [ 0.570406] ACPI: bus type USB registered670second # [ 0.571120] usbcore: registered new interface driver usbfs671second # [ 0.572043] usbcore: registered new interface driver hub672second # [ 0.573050] usbcore: registered new device driver usb673test # [ 0.501432] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]674test # [ 0.502437] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]675second # [ 0.575260] NetLabel: Initializing676second # [ 0.576013] NetLabel: domain hash size = 128677test # [ 0.503469] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]678second # [ 0.577014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO679second # [ 0.578068] NetLabel: unlabeled traffic allowed by default680second # [ 0.579032] PCI: Using ACPI for IRQ routing681test # [ 0.505671] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint682test # [ 0.508991] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]683test # [ 0.509928] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint684test # [ 0.511479] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]685test # [ 0.513301] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint686test # [ 0.515479] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]687test # [ 0.516871] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint688test # [ 0.518433] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]689test # [ 0.520030] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint690test # [ 0.522305] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO691test # [ 0.524910] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint692test # [ 0.527478] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]693test # [ 0.528430] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]694test # [ 0.530160] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint695test # [ 0.532470] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]696test # [ 0.539362] ACPI: PCI: Interrupt link LNKA configured for IRQ 10697test # [ 0.540571] ACPI: PCI: Interrupt link LNKB configured for IRQ 10698test # [ 0.541568] ACPI: PCI: Interrupt link LNKC configured for IRQ 11699test # [ 0.542567] ACPI: PCI: Interrupt link LNKD configured for IRQ 11700test # [ 0.543561] ACPI: PCI: Interrupt link LNKE configured for IRQ 10701test # [ 0.544577] ACPI: PCI: Interrupt link LNKF configured for IRQ 10702test # [ 0.545566] ACPI: PCI: Interrupt link LNKG configured for IRQ 11703test # [ 0.546566] ACPI: PCI: Interrupt link LNKH configured for IRQ 11704test # [ 0.547486] ACPI: PCI: Interrupt link GSIA configured for IRQ 16705test # [ 0.548440] ACPI: PCI: Interrupt link GSIB configured for IRQ 17706test # [ 0.549445] ACPI: PCI: Interrupt link GSIC configured for IRQ 18707test # [ 0.550438] ACPI: PCI: Interrupt link GSID configured for IRQ 19708test # [ 0.551444] ACPI: PCI: Interrupt link GSIE configured for IRQ 20709test # [ 0.552447] ACPI: PCI: Interrupt link GSIF configured for IRQ 21710test # [ 0.553440] ACPI: PCI: Interrupt link GSIG configured for IRQ 22711test # [ 0.554437] ACPI: PCI: Interrupt link GSIH configured for IRQ 23712test # [ 0.556890] iommu: Default domain type: Translated713test # [ 0.557432] iommu: DMA domain TLB invalidation policy: lazy mode714test # [ 0.558780] ACPI: bus type USB registered715test # [ 0.559507] usbcore: registered new interface driver usbfs716second # [ 0.673701] pci 0000:00:01.0: vgaarb: setting as boot VGA device717second # [ 0.674008] pci 0000:00:01.0: vgaarb: bridge control possible718test # [ 0.560445] usbcore: registered new interface driver hub719test # [ 0.561454] usbcore: registered new device driver usb720second # [ 0.674008] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none721test # [ 0.563569] NetLabel: Initializing722test # [ 0.564417] NetLabel: domain hash size = 128723second # [ 0.674024] vgaarb: loaded724test # [ 0.565417] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO725test # [ 0.566514] NetLabel: unlabeled traffic allowed by default726test # [ 0.567436] PCI: Using ACPI for IRQ routing727second # [ 0.675040] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0728second # [ 0.676017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter729second # [ 0.679154] clocksource: Switched to clocksource kvm-clock730second # [ 0.683747] VFS: Disk quotas dquot_6.6.0731second # [ 0.684822] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)732second # [ 0.686923] pnp: PnP ACPI init733second # [ 0.688253] ACPI: IRQ 4 override to edge(!), high(!)734second # [ 0.689704] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved735second # [ 0.692082] pnp: PnP ACPI: found 6 devices736second # [ 0.700132] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns737second # [ 0.702260] clocksource: Switched to clocksource acpi_pm738second # [ 0.703915] NET: Registered PF_INET protocol family739second # [ 0.705411] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)740second # [ 0.726082] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)741second # [ 0.728437] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)742second # [ 0.730725] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)743second # [ 0.732768] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)744second # [ 0.734708] TCP: Hash tables configured (established 8192 bind 8192)745second # [ 0.736435] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)746second # [ 0.738619] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)747second # [ 0.740307] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)748second # [ 0.742358] NET: Registered PF_UNIX/PF_LOCAL protocol family749second # [ 0.743860] NET: Registered PF_XDP protocol family750second # [ 0.745299] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]751second # [ 0.746861] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]752second # [ 0.748499] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]753second # [ 0.750307] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]754second # [ 0.752020] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]755second # [ 0.753825] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]756second # [ 0.756456] ACPI: \_SB_.GSIA: Enabled at IRQ 16757second # [ 0.759411] ACPI: \_SB_.GSIB: Enabled at IRQ 17758second # [ 0.761950] ACPI: \_SB_.GSIC: Enabled at IRQ 18759second # [ 0.764616] ACPI: \_SB_.GSID: Enabled at IRQ 19760second # [ 0.766977] PCI: CLS 0 bytes, default 64761second # [ 0.768297] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns762second # [ 0.771008] Trying to unpack rootfs image as initramfs...763test # [ 0.662403] pci 0000:00:01.0: vgaarb: setting as boot VGA device764test # [ 0.662412] pci 0000:00:01.0: vgaarb: bridge control possible765test # [ 0.662412] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none766test # [ 0.662429] vgaarb: loaded767test # [ 0.663477] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0768test # [ 0.664423] hpet0: 3 comparators, 64-bit 100.000000 MHz counter769test # [ 0.668574] clocksource: Switched to clocksource kvm-clock770test # [ 0.673451] VFS: Disk quotas dquot_6.6.0771test # [ 0.674524] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)772test # [ 0.676689] pnp: PnP ACPI init773test # [ 0.677882] ACPI: IRQ 4 override to edge(!), high(!)774test # [ 0.679762] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved775test # [ 0.682267] pnp: PnP ACPI: found 6 devices776test # [ 0.690557] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns777test # [ 0.692702] clocksource: Switched to clocksource acpi_pm778test # [ 0.694193] NET: Registered PF_INET protocol family779test # [ 0.696337] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)780test # [ 0.719870] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)781test # [ 0.721740] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)782test # [ 0.723816] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)783test # [ 0.725737] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)784test # [ 0.727722] TCP: Hash tables configured (established 8192 bind 8192)785test # [ 0.729558] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)786test # [ 0.731580] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)787test # [ 0.733331] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)788test # [ 0.735149] NET: Registered PF_UNIX/PF_LOCAL protocol family789test # [ 0.736612] NET: Registered PF_XDP protocol family790test # [ 0.737852] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]791test # [ 0.739391] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]792test # [ 0.741069] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]793test # [ 0.743074] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]794test # [ 0.744734] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]795test # [ 0.746539] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]796test # [ 0.749293] ACPI: \_SB_.GSIA: Enabled at IRQ 16797test # [ 0.751992] ACPI: \_SB_.GSIB: Enabled at IRQ 17798test # [ 0.754537] ACPI: \_SB_.GSIC: Enabled at IRQ 18799test # [ 0.756946] ACPI: \_SB_.GSID: Enabled at IRQ 19800test # [ 0.759050] PCI: CLS 0 bytes, default 64801test # [ 0.760323] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d4d0b6d3, max_idle_ns: 440795255641 ns802test # [ 0.762775] Trying to unpack rootfs image as initramfs...803second # [ 0.932031] Initialise system trusted keyrings804second # [ 0.936618] workingset: timestamp_bits=40 max_order=18 bucket_order=0805test # [ 0.821088] Initialise system trusted keyrings806test # [ 0.822533] workingset: timestamp_bits=40 max_order=18 bucket_order=0807second # [ 0.955879] Key type asymmetric registered808second # [ 0.956816] Asymmetric key parser 'x509' registered809second # [ 0.960620] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)810second # [ 0.965576] io scheduler mq-deadline registered811second # [ 0.968551] io scheduler kyber registered812second # [ 0.970255] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled813test # [ 0.847914] Key type asymmetric registered814second # [ 0.973839] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A815test # [ 0.849199] Asymmetric key parser 'x509' registered816second # [ 0.981059] Linux agpgart interface v0.103817second # [ 0.982200] ACPI: bus type drm_connector registered818test # [ 0.852751] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)819test # [ 0.857371] io scheduler mq-deadline registered820test # [ 0.858579] io scheduler kyber registered821second # [ 0.987034] usbcore: registered new interface driver usbserial_generic822second # [ 0.988647] usbserial: USB Serial support registered for generic823test # [ 0.862622] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled824second # [ 0.991543] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.825second # [ 0.991543] Please enable it if your BIOS has the CPPC option.826test # [ 0.864624] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A827second # [ 0.994870] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled828test # [ 0.874083] Linux agpgart interface v0.103829test # [ 0.875268] ACPI: bus type drm_connector registered830second # [ 1.001714] drop_monitor: Initializing network drop monitor service831test # [ 0.880218] usbcore: registered new interface driver usbserial_generic832test # [ 0.881832] usbserial: USB Serial support registered for generic833second # [ 1.007635] NET: Registered PF_INET6 protocol family834test # [ 0.886689] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.835test # [ 0.886689] Please enable it if your BIOS has the CPPC option.836test # [ 0.890070] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled837second # [ 1.017898] Segment Routing with IPv6838second # [ 1.020558] In-situ OAM (IOAM) with IPv6839test # [ 0.895908] drop_monitor: Initializing network drop monitor service840second # [ 1.023873] IPI shorthand broadcast: enabled841test # [ 0.901753] NET: Registered PF_INET6 protocol family842test # [ 0.903771] Segment Routing with IPv6843second # [ 1.030853] sched_clock: Marking stable (844027328, 186498017)->(1205561403, -175036058)844test # [ 0.906694] In-situ OAM (IOAM) with IPv6845second # [ 1.037851] registered taskstats version 1846second # [ 1.039197] Loading compiled-in X.509 certificates847test # [ 0.911021] IPI shorthand broadcast: enabled848test # [ 0.918207] sched_clock: Marking stable (732026731, 185631531)->(1152079251, -234420989)849test # [ 0.925932] registered taskstats version 1850test # [ 0.927390] Loading compiled-in X.509 certificates851second # [ 1.061067] Demotion targets for Node 0: null852second # [ 1.064601] Key type .fscrypt registered853second # [ 1.065647] Key type fscrypt-provisioning registered854second # [ 1.069652] ima: No TPM chip found, activating TPM-bypass!855second # [ 1.070910] ima: Allocated hash algorithm: sha1856test # [ 0.945681] Demotion targets for Node 0: null857second # [ 1.073571] ima: No architecture policies found858test # [ 0.948722] Key type .fscrypt registered859second # [ 1.074781] PM: Magic number: 10:612:162860test # [ 0.949691] Key type fscrypt-provisioning registered861second # [ 1.078771] RAS: Correctable Errors collector initialized.862test # [ 0.952789] ima: No TPM chip found, activating TPM-bypass!863test # [ 0.954034] ima: Allocated hash algorithm: sha1864test # [ 0.957697] ima: No architecture policies found865second # [ 1.086939] clk: Disabling unused clocks866test # [ 0.960673] PM: Magic number: 10:612:162867second # [ 1.089541] PM: genpd: Disabling unused power domains868test # [ 0.964905] RAS: Correctable Errors collector initialized.869test # [ 0.973323] clk: Disabling unused clocks870test # [ 0.974375] PM: genpd: Disabling unused power domains871second # [ 1.208229] Freeing initrd memory: 29076K872second # [ 1.211224] Freeing unused decrypted memory: 2028K873second # [ 1.213897] Freeing unused kernel image (initmem) memory: 3644K874second # [ 1.215245] Write protecting the kernel read-only data: 32768k875second # [ 1.217264] Freeing unused kernel image (text/rodata gap) memory: 1216K876second # [ 1.219031] Freeing unused kernel image (rodata/data gap) memory: 752K877test # [ 1.128513] Freeing initrd memory: 29080K878second # [ 1.254763] x86/mm: Checked W+X mappings: passed, no W+X pages found.879second # [ 1.256777] Run /init as init process880test # [ 1.131453] Freeing unused decrypted memory: 2028K881test # [ 1.134154] Freeing unused kernel image (initmem) memory: 3644K882test # [ 1.135666] Write protecting the kernel read-only data: 32768k883test # [ 1.137811] Freeing unused kernel image (text/rodata gap) memory: 1216K884second # [ 1.265796] systemd[1]: Inserted module 'autofs4'885test # [ 1.139704] Freeing unused kernel image (rodata/data gap) memory: 752K886second # [ 1.278697] fuse: init (API version 7.45)887second # [ 1.283550] ACPI: \_SB_.GSIG: Enabled at IRQ 22888second # [ 1.286156] ACPI: \_SB_.GSIH: Enabled at IRQ 23889second # [ 1.289407] ACPI: \_SB_.GSIE: Enabled at IRQ 20890second # [ 1.291994] ACPI: \_SB_.GSIF: Enabled at IRQ 21891test # [ 1.173283] x86/mm: Checked W+X mappings: passed, no W+X pages found.892test # [ 1.174782] Run /init as init process893test # [ 1.183800] systemd[1]: Inserted module 'autofs4'894second # [ 1.316983] systemd[1]: Successfully made /usr/ read-only.895test # [ 1.197393] fuse: init (API version 7.45)896test # [ 1.203434] ACPI: \_SB_.GSIG: Enabled at IRQ 22897test # [ 1.206197] ACPI: \_SB_.GSIH: Enabled at IRQ 23898test # [ 1.209602] ACPI: \_SB_.GSIE: Enabled at IRQ 20899test # [ 1.212238] ACPI: \_SB_.GSIF: Enabled at IRQ 21900test # [ 1.245947] systemd[1]: Successfully made /usr/ read-only.901second # [ 1.653344] 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)902second # [ 1.660746] systemd[1]: Detected virtualization kvm.903second # [ 1.662084] systemd[1]: Detected architecture x86-64.904second # [ 1.663426] systemd[1]: Running in initrd.905second # [ 1.665084] systemd[1]: Initializing machine ID from random generator.906second # [ 1.666932] systemd[1]: Hostname set to <second>.907test # [ 1.586006] 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)908test # [ 1.592580] systemd[1]: Detected virtualization kvm.909test # [ 1.593760] systemd[1]: Detected architecture x86-64.910test # [ 1.594887] systemd[1]: Running in initrd.911test # [ 1.596272] systemd[1]: Initializing machine ID from random generator.912test # [ 1.597907] systemd[1]: Hostname set to <test>.913test # [ 1.676673] systemd[1]: bpf-restrict-fs: LSM BPF program attached914test # [ 1.713985] systemd[1]: Queued start job for default target Initrd Default Target.915test # [ 1.718191] systemd[1]: Created slice Slice /system/modprobe.916test # [ 1.719915] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.917test # [ 1.722006] systemd[1]: Expecting device /dev/disk/by-label/nixos...918test # [ 1.723576] systemd[1]: Reached target Path Units.919test # [ 1.724931] systemd[1]: Reached target Slice Units.920test # [ 1.726266] systemd[1]: Reached target Swaps.921test # [ 1.727404] systemd[1]: Reached target Timer Units.922test # [ 1.728772] systemd[1]: Listening on D-Bus System Message Bus Socket.923test # [ 1.730526] systemd[1]: Listening on Journal Socket (/dev/log).924second # [ 1.860485] systemd[1]: bpf-restrict-fs: LSM BPF program attached925test # [ 1.732403] systemd[1]: Listening on Journal Sockets.926test # [ 1.734057] systemd[1]: Listening on udev Control Socket.927test # [ 1.735674] systemd[1]: Listening on udev Kernel Socket.928test # [ 1.737282] systemd[1]: Reached target Socket Units.929test # [ 1.740056] systemd[1]: Starting Create List of Static Device Nodes...930test # [ 1.757177] systemd[1]: Starting Load Kernel Module 9pnet_virtio...931test # [ 1.766154] systemd[1]: Starting Load Kernel Module configfs...932second # [ 1.897393] systemd[1]: Queued start job for default target Initrd Default Target.933second # [ 1.902342] systemd[1]: Created slice Slice /system/modprobe.934test # [ 1.774796] systemd[1]: Starting Journal Service...935second # [ 1.903882] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.936second # [ 1.905672] systemd[1]: Expecting device /dev/disk/by-label/nixos...937second # [ 1.907157] systemd[1]: Reached target Path Units.938second # [ 1.908385] systemd[1]: Reached target Slice Units.939second # [ 1.909712] systemd[1]: Reached target Swaps.940second # [ 1.911027] systemd[1]: Reached target Timer Units.941second # [ 1.912601] systemd[1]: Listening on D-Bus System Message Bus Socket.942test # [ 1.786928] systemd[1]: Starting Load Kernel Modules...943second # [ 1.914456] systemd[1]: Listening on Journal Socket (/dev/log).944second # [ 1.916291] systemd[1]: Listening on Journal Sockets.945second # [ 1.917869] systemd[1]: Listening on udev Control Socket.946second # [ 1.919450] systemd[1]: Listening on udev Kernel Socket.947second # [ 1.920934] systemd[1]: Reached target Socket Units.948test # [ 1.793434] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os949test # [ 1.804127] netfs: FS-Cache loaded950test # [ 1.805345] systemd[1]: Starting Coldplug All udev Devices...951second # [ 1.923770] systemd[1]: Starting Create List of Static Device Nodes...952second # [ 1.942208] systemd[1]: Starting Load Kernel Module 9pnet_virtio...953test # [ 1.821333] 9pnet: Installing 9P2000 support954second # [ 1.950190] systemd[1]: Starting Load Kernel Module configfs...955test # [ 1.830785] systemd[1]: Finished Create List of Static Device Nodes.956second # [ 1.961720] systemd[1]: Starting Journal Service...957test # [ 1.836571] systemd[1]: modprobe@configfs.service: Deactivated successfully.958test # [ 1.841328] systemd-journald[67]: Collecting audit messages is disabled.959second # [ 1.978704] systemd[1]: Starting Load Kernel Modules...960test # [ 1.851762] systemd[1]: Finished Load Kernel Module configfs.961test # [ 1.855080] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.962second # [ 1.984624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os963test # [ 1.860352] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.964second # [ 1.988481] netfs: FS-Cache loaded965test # [ 1.867350] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev966test # [ 1.869516] systemd[1]: Finished Load Kernel Module 9pnet_virtio.967second # [ 1.997324] systemd[1]: Starting Coldplug All udev Devices...968test # [ 1.875442] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config969second # [ 2.010072] 9pnet: Installing 9P2000 support970test # [ 1.894919] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...971second # [ 2.022984] systemd[1]: Finished Create List of Static Device Nodes.972second # [ 2.029350] systemd-journald[67]: Collecting audit messages is disabled.973second # [ 2.033304] systemd[1]: modprobe@configfs.service: Deactivated successfully.974test # [ 1.911750] systemd[1]: Finished Load Kernel Modules.975second # [ 2.044132] systemd[1]: Finished Load Kernel Module configfs.976test # [ 1.920937] systemd[1]: Starting Apply Kernel Variables...977second # [ 2.048220] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.978second # [ 2.054246] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.979second # [ 2.060675] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev980second # [ 2.063309] systemd[1]: Finished Load Kernel Module 9pnet_virtio.981second # [ 2.069217] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config982test # [ 1.944860] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.983test # [ 1.956052] systemd[1]: Starting Create Static Device Nodes in /dev...984second # [ 2.085794] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...985test # [ 1.974829] systemd[1]: Finished Apply Kernel Variables.986second # [ 2.104624] systemd[1]: Finished Load Kernel Modules.987second # [ 2.112775] systemd[1]: Starting Apply Kernel Variables...988test # [ 2.001486] systemd[1]: Finished Create Static Device Nodes in /dev.989test # [ 2.006918] systemd[1]: Started Journal Service.990test # [ 1.820612] systemd-modules-load[68]: Inserted module 'dm_mod'991test # [ 1.824383] systemd-modules-load[68]: Inserted module 'virtio_balloon'992second # [ 2.137622] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.993test # [ 1.825790] systemd-modules-load[68]: Inserted module 'virtio_gpu'994test # [ 1.829378] systemd[1]: Reached target Preparation for Local File Systems.995test # [ 1.830970] systemd[1]: Reached target Local File Systems.996second # [ 2.148933] systemd[1]: Starting Create Static Device Nodes in /dev...997test # [ 1.837096] systemd[1]: Starting Create System Files and Directories...998test # [ 1.842066] systemd[1]: Starting Rule-based Manager for Device Events and Files...999second # [ 2.166714] systemd[1]: Finished Apply Kernel Variables.1000second # [ 2.185276] systemd[1]: Finished Create Static Device Nodes in /dev.1001test # [ 1.873250] systemd[1]: Finished Create System Files and Directories.1002second # [ 2.190835] systemd[1]: Started Journal Service.1003second # [ 2.001715] systemd-modules-load[68]: Inserted module 'dm_mod'1004second # [ 2.006686] systemd-modules-load[68]: Inserted module 'virtio_balloon'1005second # [ 2.008244] systemd-modules-load[68]: Inserted module 'virtio_gpu'1006second # [ 2.012343] systemd[1]: Reached target Preparation for Local File Systems.1007second # [ 2.015069] systemd[1]: Reached target Local File Systems.1008second # [ 2.020089] systemd[1]: Starting Create System Files and Directories...1009test # [ 1.898495] systemd-udevd[78]: Using default interface naming scheme 'v261'.1010second # [ 2.028071] systemd[1]: Starting Rule-based Manager for Device Events and Files...1011test # [ 1.911569] systemd[1]: Finished Coldplug All udev Devices.1012test # [ 1.921706] systemd[1]: Started Rule-based Manager for Device Events and Files.1013test # [ 1.923180] systemd[1]: Reached target System Initialization.1014test # [ 1.925255] systemd[1]: Reached target Basic System.1015second # [ 2.059372] systemd[1]: Finished Create System Files and Directories.1016second # [ 2.081636] systemd-udevd[76]: Using default interface naming scheme 'v261'.1017second # [ 2.094834] systemd[1]: Finished Coldplug All udev Devices.1018second # [ 2.106426] systemd[1]: Started Rule-based Manager for Device Events and Files.1019second # [ 2.109122] systemd[1]: Reached target System Initialization.1020second # [ 2.110483] systemd[1]: Reached target Basic System.1021test # [ 2.328375] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022test # [ 2.346455] virtio_blk virtio5: 1/0/0 default/read/poll queues1023test # [ 2.355525] serio: i8042 KBD port at 0x60,0x64 irq 11024test # [ 2.363476] serio: i8042 AUX port at 0x60,0x64 irq 121025test # [ 2.372097] ehci-pci 0000:00:1d.7: EHCI Host Controller1026test # [ 2.373093] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11027second # [ 2.502030] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121028test # [ 2.375884] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001029test # [ 2.377343] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1030test # [ 2.384674] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001031test # [ 2.386376] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181032test # [ 2.389649] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11033test # [ 2.392464] usb usb1: Product: EHCI Host Controller1034second # [ 2.519952] virtio_blk virtio5: 1/0/0 default/read/poll queues1035test # [ 2.394124] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd1036test # [ 2.396092] usb usb1: SerialNumber: 0000:00:1d.71037test # [ 2.397913] hub 1-0:1.0: USB hub found1038test # [ 2.399990] hub 1-0:1.0: 6 ports detected1039test # [ 2.404193] uhci_hcd 0000:00:1d.0: UHCI Host Controller1040test # [ 2.405164] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21041second # [ 2.533551] serio: i8042 KBD port at 0x60,0x64 irq 11042second # [ 2.534388] serio: i8042 AUX port at 0x60,0x64 irq 121043test # [ 2.419306] uhci_hcd 0000:00:1d.0: detected 2 ports1044second # [ 2.553710] ehci-pci 0000:00:1d.7: EHCI Host Controller1045second # [ 2.554651] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11046test # [ 2.428790] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001047second # [ 2.556745] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001048second # [ 2.559792] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1049second # [ 2.564019] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001050test # [ 2.437138] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181051test # [ 2.438609] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11052second # [ 2.566603] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181053second # [ 2.568193] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11054test # [ 2.442976] SCSI subsystem initialized1055second # [ 2.572529] usb usb1: Product: EHCI Host Controller1056second # [ 2.573381] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd1057second # [ 2.576541] usb usb1: SerialNumber: 0000:00:1d.71058second # [ 2.577916] hub 1-0:1.0: USB hub found1059second # [ 2.579736] hub 1-0:1.0: 6 ports detected1060second # [ 2.582668] uhci_hcd 0000:00:1d.0: UHCI Host Controller1061second # [ 2.583582] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21062test # [ 2.461945] usb usb2: Product: UHCI Host Controller1063test # [ 2.278255] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1064second # [ 2.596553] uhci_hcd 0000:00:1d.0: detected 2 ports1065test # [ 2.283774] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1066test # [ 2.286352] systemd[1]: Starting Virtual Console Setup...1067test # [ 2.474678] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01068second # [ 2.603461] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001069second # [ 2.612320] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181070test # [ 2.486082] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd1071second # [ 2.613710] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11072second # [ 2.625650] SCSI subsystem initialized1073test # [ 2.501726] usb usb2: SerialNumber: 0000:00:1d.01074second # [ 2.631528] usb usb2: Product: UHCI Host Controller1075test # [ 2.317840] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1076second # [ 2.632360] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd1077test # [ 2.323508] systemd[1]: Finished Virtual Console Setup.1078second # [ 2.641667] usb usb2: SerialNumber: 0000:00:1d.01079test # [ 2.518032] hub 2-0:1.0: USB hub found1080second # [ 2.460327] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1081test # [ 2.525662] hub 2-0:1.0: 2 ports detected1082second # [ 2.652972] hub 2-0:1.0: USB hub found1083second # [ 2.657931] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01084test # [ 2.531951] uhci_hcd 0000:00:1d.1: UHCI Host Controller1085second # [ 2.473453] systemd[1]: Starting Virtual Console Setup...1086test # [ 2.539383] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31087second # [ 2.668023] hub 2-0:1.0: 2 ports detected1088test # [ 2.357048] systemd[1]: Found device /dev/disk/by-label/nixos.1089test # [ 2.360882] systemd[1]: Reached target Initrd Root Device.1090test # [ 2.548679] uhci_hcd 0000:00:1d.1: detected 2 ports1091test # [ 2.365303] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1092test # [ 2.555820] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201093second # [ 2.683579] uhci_hcd 0000:00:1d.1: UHCI Host Controller1094test # [ 2.557068] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181095second # [ 2.684458] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31096test # [ 2.559909] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11097second # [ 2.503717] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1098test # [ 2.571667] usb usb3: Product: UHCI Host Controller1099test # [ 2.572573] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd1100second # [ 2.515088] systemd[1]: Finished Virtual Console Setup.1101second # [ 2.517468] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1102test # [ 2.578831] usb usb3: SerialNumber: 0000:00:1d.11103test # [ 2.396427] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1104test # [ 2.583800] hub 3-0:1.0: USB hub found1105test # [ 2.585773] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1106test # [ 2.587218] hub 3-0:1.0: 2 ports detected1107test # [ 2.589736] uhci_hcd 0000:00:1d.2: UHCI Host Controller1108second # [ 2.716189] uhci_hcd 0000:00:1d.1: detected 2 ports1109test # [ 2.591300] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1110test # [ 2.592434] ahci 0000:00:1f.2: flags: 64bit ncq only1111test # [ 2.594103] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41112test # [ 2.595685] uhci_hcd 0000:00:1d.2: detected 2 ports1113second # [ 2.538112] systemd[1]: Found device /dev/disk/by-label/nixos.1114second # [ 2.539291] systemd[1]: Reached target Initrd Root Device.1115test # [ 2.599761] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401116second # [ 2.727286] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201117test # [ 2.601906] scsi host0: ahci1118second # [ 2.543333] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1119test # [ 2.603729] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181120test # [ 2.605172] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11121test # [ 2.606887] scsi host1: ahci1122test # [ 2.608024] scsi host2: ahci1123test # [ 2.610068] scsi host3: ahci1124second # [ 2.737517] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181125test # [ 2.612211] scsi host4: ahci1126second # [ 2.738827] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11127test # [ 2.613723] usb usb4: Product: UHCI Host Controller1128test # [ 2.614549] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd1129test # [ 2.616350] scsi host5: ahci1130test # [ 2.617672] usb usb4: SerialNumber: 0000:00:1d.21131test # [ 2.618980] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11132second # [ 2.746765] usb usb3: Product: UHCI Host Controller1133test # [ 2.620782] hub 4-0:1.0: USB hub found1134second # [ 2.748561] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd1135test # [ 2.621584] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11136second # [ 2.749426] usb usb3: SerialNumber: 0000:00:1d.11137test # [ 2.623300] hub 4-0:1.0: 2 ports detected1138test # [ 2.630671] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11139second # [ 2.758696] hub 3-0:1.0: USB hub found1140second # [ 2.575415] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1141test # [ 2.635729] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11142second # [ 2.763767] hub 3-0:1.0: 2 ports detected1143test # [ 2.639662] usb 1-1: new high-speed USB device number 2 using ehci-pci1144second # [ 2.768863] uhci_hcd 0000:00:1d.2: UHCI Host Controller1145second # [ 2.769720] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41146test # [ 2.642660] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11147second # [ 2.771601] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1148second # [ 2.772891] uhci_hcd 0000:00:1d.2: detected 2 ports1149second # [ 2.774103] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1150test # [ 2.647420] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11151second # [ 2.775412] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401152second # [ 2.776695] ahci 0000:00:1f.2: flags: 64bit ncq only1153second # [ 2.777867] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181154second # [ 2.781513] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11155second # [ 2.783965] scsi host0: ahci1156second # [ 2.784674] usb usb4: Product: UHCI Host Controller1157second # [ 2.785450] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd1158second # [ 2.787390] scsi host1: ahci1159second # [ 2.789359] scsi host2: ahci1160second # [ 2.790462] scsi host3: ahci1161second # [ 2.792187] usb usb4: SerialNumber: 0000:00:1d.21162second # [ 2.793668] scsi host4: ahci1163second # [ 2.795007] scsi host5: ahci1164second # [ 2.796696] hub 4-0:1.0: USB hub found1165second # [ 2.797477] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11166second # [ 2.799590] hub 4-0:1.0: 2 ports detected1167second # [ 2.804103] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11168second # [ 2.810308] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11169second # [ 2.816279] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11170second # [ 2.819531] usb 1-1: new high-speed USB device number 2 using ehci-pci1171second # [ 2.821694] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11172second # [ 2.824763] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11173test # [ 2.769834] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001174test # [ 2.771114] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101175test # [ 2.772593] usb 1-1: Product: QEMU USB Tablet1176test # [ 2.773500] usb 1-1: Manufacturer: QEMU1177test # [ 2.774288] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11178test # [ 2.787740] hid: raw HID events driver (C) Jiri Kosina1179second # [ 2.949623] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001180second # [ 2.951087] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101181second # [ 2.952706] usb 1-1: Product: QEMU USB Tablet1182second # [ 2.953836] usb 1-1: Manufacturer: QEMU1183second # [ 2.954712] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11184second # [ 2.967186] hid: raw HID events driver (C) Jiri Kosina1185second # [ 2.846634] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1186test # [ 2.720978] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1187test # [ 2.726260] systemd[1]: Mounting /sysroot...1188second # [ 2.855311] systemd[1]: Mounting /sysroot...1189test # [ 2.957292] ata5: SATA link down (SStatus 0 SControl 300)1190test # [ 2.961416] ata2: SATA link down (SStatus 0 SControl 300)1191test # [ 2.962940] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1192test # [ 2.964076] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001193test # [ 2.965172] ata3.00: applying bridge limits1194test # [ 2.966165] ata1: SATA link down (SStatus 0 SControl 300)1195test # [ 2.967342] ata6: SATA link down (SStatus 0 SControl 300)1196test # [ 2.968544] ata4: SATA link down (SStatus 0 SControl 300)1197test # [ 2.969689] ata3.00: configured for UDMA/1001198test # [ 2.970813] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51199second # [ 3.137410] ata1: SATA link down (SStatus 0 SControl 300)1200second # [ 3.138778] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1201second # [ 3.140439] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001202second # [ 3.141916] ata3.00: applying bridge limits1203second # [ 3.142958] ata2: SATA link down (SStatus 0 SControl 300)1204second # [ 3.144192] ata6: SATA link down (SStatus 0 SControl 300)1205second # [ 3.145350] ata4: SATA link down (SStatus 0 SControl 300)1206second # [ 3.146550] ata5: SATA link down (SStatus 0 SControl 300)1207second # [ 3.147676] ata3.00: configured for UDMA/1001208second # [ 3.149476] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51209test # [ 3.022844] usbcore: registered new interface driver usbhid1210test # [ 3.026552] usbhid: USB HID core driver1211test # [ 3.038972] 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/input21212test # [ 3.045434] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01213test # [ 3.050265] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1214test # [ 3.052413] EXT4-fs (vda): mounted filesystem ea20a194-1d29-49e3-ae13-cdf52772d9f7 r/w with ordered data mode. Quota mode: none.1215test # [ 2.871405] systemd[1]: Mounted /sysroot.1216test # [ 2.873619] systemd[1]: Reached target Initrd Root File System.1217test # [ 2.876942] systemd[1]: Starting Mountpoints Configured in the Real Root...1218test # [ 3.069509] cdrom: Uniform CD-ROM driver Revision: 3.201219second # [ 3.199722] usbcore: registered new interface driver usbhid1220second # [ 3.200664] usbhid: USB HID core driver1221test # [ 2.894569] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload.1222test # [ 2.900056] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)...1223test # [ 2.901965] systemd[1]: Reloading...1224second # [ 3.217825] 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/input21225second # [ 3.219779] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01226second # [ 3.234780] EXT4-fs (vda): mounted filesystem 01dc2460-4b22-41a0-836d-98f1595799c7 r/w with ordered data mode. Quota mode: none.1227second # [ 3.237692] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1228second # [ 3.055500] systemd[1]: Mounted /sysroot.1229second # [ 3.058373] systemd[1]: Reached target Initrd Root File System.1230second # [ 3.062079] systemd[1]: Mounting /sysroot/nix/.ro-store...1231second # [ 3.251126] cdrom: Uniform CD-ROM driver Revision: 3.201232second # [ 3.067086] systemd[1]: Mounting /sysroot/nix/.rw-store...1233second # [ 3.074146] systemd[1]: Mounting /sysroot/run...1234second # [ 3.083768] systemd[1]: Mounting /sysroot/tmp/shared...1235second # [ 3.094573] systemd[1]: Mounting /sysroot/tmp/xchg...1236test # [ 2.970816] systemd[1]: Reloading finished in 71 ms.1237second # [ 3.097144] systemd[1]: Starting Mountpoints Configured in the Real Root...1238test # [ 2.979352] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace...1239test # [ 2.982214] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace...1240test # [ 2.990173] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1241test # [ 2.991991] systemd[1]: Finished Mountpoints Configured in the Real Root.1242test # [ 2.994243] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1243test # [ 2.997841] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1244second # [ 3.128120] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload.1245second # [ 3.318847] 9p: Installing v9fs 9p2000 file system support1246second # [ 3.148397] systemd[1]: Mounted /sysroot/nix/.ro-store.1247second # [ 3.151563] systemd[1]: Mounted /sysroot/nix/.rw-store.1248second # [ 3.152693] systemd[1]: Mounted /sysroot/run.1249second # [ 3.155164] systemd[1]: Mounted /sysroot/tmp/shared.1250second # [ 3.156158] systemd[1]: Mounted /sysroot/tmp/xchg.1251second # [ 3.160402] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)...1252second # [ 3.162414] systemd[1]: Reloading...1253second # [ 3.227846] systemd[1]: Reloading finished in 64 ms.1254second # [ 3.236700] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace...1255second # [ 3.242177] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace...1256second # [ 3.244294] systemd[1]: Starting rw-sysroot-nix-store.service...1257second # [ 3.248677] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1258second # [ 3.252078] systemd[1]: Finished Mountpoints Configured in the Real Root.1259second # [ 3.253435] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1260second # [ 3.265313] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1261second # [ 3.267481] systemd[1]: Finished rw-sysroot-nix-store.service.1262test # [ 3.637108] systemd[1]: Mounting /sysroot/nix/.ro-store...1263test # [ 3.640093] systemd[1]: Mounting /sysroot/nix/.rw-store...1264test # [ 3.644091] systemd[1]: Mounting /sysroot/run...1265test # [ 3.649461] systemd[1]: Mounting /sysroot/tmp/shared...1266test # [ 3.656392] systemd[1]: Mounting /sysroot/tmp/xchg...1267test # [ 3.861991] 9p: Installing v9fs 9p2000 file system support1268test # [ 3.680641] systemd[1]: Mounted /sysroot/nix/.rw-store.1269test # [ 3.688182] systemd[1]: Mounted /sysroot/nix/.ro-store.1270test # [ 3.689768] systemd[1]: Mounted /sysroot/run.1271test # [ 3.691174] systemd[1]: Mounted /sysroot/tmp/shared.1272test # [ 3.692160] systemd[1]: Mounted /sysroot/tmp/xchg.1273test # [ 3.697311] systemd[1]: Starting rw-sysroot-nix-store.service...1274second # [ 3.829187] systemd[1]: Mounting /sysroot/nix/store...1275test # [ 3.707053] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1276test # [ 3.709086] systemd[1]: Finished rw-sysroot-nix-store.service.1277second # [ 3.846038] systemd[1]: Mounted /sysroot/nix/store.1278second # [ 3.847624] systemd[1]: Reached target Initrd File Systems.1279second # [ 3.849524] systemd[1]: Starting Find NixOS closure...1280second # [ 3.853135] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1281second # [ 3.869883] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1282second # [ 3.872206] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1283second # [ 3.879704] systemd[1]: Finished Find NixOS closure.1284second # [ 3.881844] systemd[1]: Reached target Initrd Default Target.1285second # [ 3.883293] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1286second # [ 3.895231] systemd[1]: Stopped target Initrd Default Target.1287second # [ 3.896651] systemd[1]: Stopped target Basic System.1288second # [ 3.899319] systemd[1]: Stopped target Initrd Root Device.1289second # [ 3.900377] systemd[1]: Stopped target Path Units.1290second # [ 3.901315] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1291second # [ 3.902649] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1292second # [ 3.903992] systemd[1]: Stopped target Slice Units.1293second # [ 3.904947] systemd[1]: Stopped target Socket Units.1294second # [ 3.905914] systemd[1]: Stopped target System Initialization.1295second # [ 3.907608] systemd[1]: Stopped target Swaps.1296second # [ 3.908885] systemd[1]: Stopped target Timer Units.1297second # [ 3.910171] systemd[1]: dbus.socket: Deactivated successfully.1298second # [ 3.911704] systemd[1]: Closed D-Bus System Message Bus Socket.1299second # [ 3.913175] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1300second # [ 3.914984] systemd[1]: Stopped Find NixOS closure.1301second # [ 3.915937] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1302second # [ 3.919191] systemd[1]: Starting rw-sysroot-nix-store.service...1303second # [ 3.920303] systemd[1]: systemd-sysctl.service: Deactivated successfully.1304second # [ 3.921503] systemd[1]: Stopped Apply Kernel Variables.1305second # [ 3.922469] systemd[1]: systemd-modules-load.service: Deactivated successfully.1306second # [ 3.923770] systemd[1]: Stopped Load Kernel Modules.1307second # [ 3.925168] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1308second # [ 3.926540] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1309second # [ 3.929134] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1310second # [ 3.930417] systemd[1]: Stopped Create System Files and Directories.1311second # [ 3.931544] systemd[1]: Stopped target Local File Systems.1312second # [ 3.932578] systemd[1]: Stopped target Preparation for Local File Systems.1313second # [ 3.934069] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1314second # [ 3.935582] systemd[1]: Stopped Coldplug All udev Devices.1315second # [ 3.938073] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1316second # [ 3.939393] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1317second # [ 3.941600] systemd[1]: Stopped Virtual Console Setup.1318second # [ 3.949093] systemd[1]: initrd-cleanup.service: Deactivated successfully.1319second # [ 3.953103] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1320second # [ 3.958153] systemd[1]: systemd-udevd.service: Deactivated successfully.1321second # [ 3.960051] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1322second # [ 3.962310] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1323second # [ 3.963745] systemd[1]: Finished rw-sysroot-nix-store.service.1324second # [ 3.966423] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1325second # [ 3.967794] systemd[1]: Closed udev Control Socket.1326second # [ 3.969615] systemd[1]: Starting Cleanup udev Database...1327second # [ 3.971073] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1328second # [ 3.972443] systemd[1]: Stopped Create Static Device Nodes in /dev.1329second # [ 3.973597] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1330second # [ 3.976165] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1331second # [ 3.977460] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1332second # [ 3.978689] systemd[1]: Stopped Create List of Static Device Nodes.1333second # [ 3.991872] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1334second # [ 3.993494] systemd[1]: Finished Cleanup udev Database.1335second # [ 3.995397] systemd[1]: Reached target Switch Root.1336second # [ 3.997211] systemd[1]: Starting NixOS Activation...1337second # [ 4.091076] initrd-nixos-activation-start[192]: booting system configuration /nix/store/41grk726jb1nqr68nw7vkjsf12lbnw7r-nixos-system-second-test1338second # [ 4.128480] initrd-nixos-activation-start[192]: running activation script...1339second # [ 4.414609] initrd-nixos-activation-start[215]: setting up /etc...1340second # [ 4.710195] initrd-nixos-activation-start[215]: setting up age secrets...1341test # [ 4.636538] systemd[1]: Mounting /sysroot/nix/store...1342test # [ 4.653309] systemd[1]: Mounted /sysroot/nix/store.1343test # [ 4.654947] systemd[1]: Reached target Initrd File Systems.1344test # [ 4.657170] systemd[1]: Starting Find NixOS closure...1345test # [ 4.660423] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1346test # [ 4.678186] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1347test # [ 4.682072] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1348test # [ 4.688162] systemd[1]: Finished Find NixOS closure.1349test # [ 4.690213] systemd[1]: Reached target Initrd Default Target.1350test # [ 4.691471] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1351test # [ 4.703486] systemd[1]: Stopped target Initrd Default Target.1352test # [ 4.705031] systemd[1]: Stopped target Basic System.1353test # [ 4.707162] systemd[1]: Stopped target Initrd Root Device.1354test # [ 4.708331] systemd[1]: Stopped target Path Units.1355test # [ 4.709251] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1356test # [ 4.710570] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1357test # [ 4.712443] systemd[1]: Stopped target Slice Units.1358second # [ 4.838287] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1359test # [ 4.713669] systemd[1]: Stopped target Socket Units.1360second # [ 4.841210] systemd[1]: Finished NixOS Activation.1361test # [ 4.715320] systemd[1]: Stopped target System Initialization.1362second # [ 4.842665] systemd[1]: Starting Switch Root...1363test # [ 4.716735] systemd[1]: Stopped target Swaps.1364test # [ 4.717952] systemd[1]: Stopped target Timer Units.1365test # [ 4.719167] systemd[1]: dbus.socket: Deactivated successfully.1366test # [ 4.720860] systemd[1]: Closed D-Bus System Message Bus Socket.1367test # [ 4.721973] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1368test # [ 4.723511] systemd[1]: Stopped Find NixOS closure.1369test # [ 4.725147] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1370test # [ 4.727119] systemd[1]: Starting rw-sysroot-nix-store.service...1371second # [ 4.854448] systemd[1]: Switching root.1372test # [ 4.728222] systemd[1]: systemd-sysctl.service: Deactivated successfully.1373test # [ 4.730146] systemd[1]: Stopped Apply Kernel Variables.1374test # [ 4.731155] systemd[1]: systemd-modules-load.service: Deactivated successfully.1375test # [ 4.732462] systemd[1]: Stopped Load Kernel Modules.1376test # [ 4.733656] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1377test # [ 4.735381] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1378test # [ 4.737160] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1379test # [ 4.738772] systemd[1]: Stopped Create System Files and Directories.1380test # [ 4.741182] systemd[1]: Stopped target Local File Systems.1381test # [ 4.743164] systemd[1]: Stopped target Preparation for Local File Systems.1382test # [ 4.744643] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1383test # [ 4.746649] systemd[1]: Stopped Coldplug All udev Devices.1384test # [ 4.748280] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1385test # [ 4.749744] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1386test # [ 4.752170] systemd[1]: Stopped Virtual Console Setup.1387test # [ 4.759451] systemd[1]: initrd-cleanup.service: Deactivated successfully.1388test # [ 4.765212] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1389test # [ 4.766512] systemd[1]: systemd-udevd.service: Deactivated successfully.1390test # [ 4.769710] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1391test # [ 4.778842] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1392test # [ 4.780560] systemd[1]: Finished rw-sysroot-nix-store.service.1393test # [ 4.782979] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1394test # [ 4.785199] systemd[1]: Closed udev Control Socket.1395test # [ 4.788090] systemd[1]: Starting Cleanup udev Database...1396test # [ 4.789319] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1397test # [ 4.790979] systemd[1]: Stopped Create Static Device Nodes in /dev.1398test # [ 4.793389] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1399test # [ 4.795086] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1400test # [ 4.796656] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1401test # [ 4.798111] systemd[1]: Stopped Create List of Static Device Nodes.1402test # [ 4.815308] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1403test # [ 4.817840] systemd[1]: Finished Cleanup udev Database.1404test # [ 4.819771] systemd[1]: Reached target Switch Root.1405test # [ 4.822203] systemd[1]: Starting NixOS Activation...1406second # [ 5.167237] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1407test # [ 4.918438] initrd-nixos-activation-start[194]: booting system configuration /nix/store/swxa86y3wmqx1dr86miw20bagz8rxc7l-nixos-system-test-test1408test # [ 4.949331] initrd-nixos-activation-start[194]: running activation script...1409second # [ 5.430552] NET: Registered PF_VSOCK protocol family1410test # [ 5.408796] initrd-nixos-activation-start[217]: setting up /etc...1411second # [ 5.844279] 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)1412second # [ 5.849570] systemd[1]: Detected virtualization kvm.1413second # [ 5.850754] systemd[1]: Detected architecture x86-64.1414second # [ 5.851873] systemd[1]: Detected first boot.1415second # [ 5.854814] systemd[1]: Initializing machine ID from random generator.1416test # [ 5.680712] initrd-nixos-activation-start[217]: setting up age secrets...1417second # [ 6.919110] systemd[1]: bpf-restrict-fs: LSM BPF program attached1418second # [ 8.463439] systemd[1]: Applying preset policy.1419test # [ 8.426353] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1420test # [ 8.432163] systemd[1]: Finished NixOS Activation.1421test # [ 8.437732] systemd[1]: Starting Switch Root...1422test # [ 8.461882] systemd[1]: Switching root.1423test # [ 8.815999] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1424test # [ 9.203238] NET: Registered PF_VSOCK protocol family1425second # [ 9.631139] systemd[1]: Populated /etc with preset unit settings.1426test # [ 9.630816] 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)1427test # [ 9.635295] systemd[1]: Detected virtualization kvm.1428test # [ 9.636157] systemd[1]: Detected architecture x86-64.1429test # [ 9.637069] systemd[1]: Detected first boot.1430test # [ 9.639511] systemd[1]: Initializing machine ID from random generator.1431test # [ 9.864345] systemd[1]: bpf-restrict-fs: LSM BPF program attached1432second # [ 9.997922] systemd[1]: initrd-switch-root.service: Deactivated successfully.1433second # [ 9.999798] systemd[1]: Stopped initrd-switch-root.service.1434second # [ 10.002779] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1435second # [ 10.005269] systemd[1]: Created slice Slice /system/getty.1436second # [ 10.006877] systemd[1]: Created slice User and Session Slice.1437second # [ 10.008083] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1438second # [ 10.009631] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1439second # [ 10.011075] systemd[1]: Expecting device /dev/hvc0...1440second # [ 10.012075] systemd[1]: Expecting device /dev/ttyS0...1441second # [ 10.013102] systemd[1]: Reached target Local Encrypted Volumes.1442second # [ 10.014238] systemd[1]: Stopped target initrd-fs.target.1443second # [ 10.015265] systemd[1]: Stopped target initrd-root-fs.target.1444second # [ 10.024633] systemd[1]: Stopped target initrd-switch-root.target.1445second # [ 10.025718] systemd[1]: Reached target Virtual Machines and Containers.1446second # [ 10.026927] systemd[1]: Reached target Path Units.1447second # [ 10.027847] systemd[1]: Reached target Remote File Systems.1448second # [ 10.028842] systemd[1]: Reached target Slice Units.1449second # [ 10.029754] systemd[1]: Reached target Swaps.1450second # [ 10.033675] systemd[1]: Listening on Query the User Interactively for a Password.1451second # [ 10.041666] systemd[1]: Listening on Process Core Dump Socket.1452second # [ 10.043990] systemd[1]: Listening on Credential Encryption/Decryption.1453second # [ 10.046268] systemd[1]: Listening on Factory Reset Management.1454second # [ 10.047410] systemd[1]: Listening on Hostname Service Socket.1455second # [ 10.050885] systemd[1]: Starting Journal Log Access Socket...1456second # [ 10.052357] systemd[1]: Listening on Journal Audit Socket.1457second # [ 10.055663] systemd[1]: Listening on Console Output Muting Service Socket.1458second # [ 10.057003] systemd[1]: Listening on Network Management Metrics Varlink Socket.1459second # [ 10.058419] systemd[1]: Listening on Network Management Varlink Socket.1460second # [ 10.059719] systemd[1]: Listening on Network Management Netlink Socket.1461second # [ 10.061038] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1462second # [ 10.062594] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1463second # [ 10.064208] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1464second # [ 10.070914] systemd[1]: Listening on Disk Repartitioning Service Socket.1465second # [ 10.072355] systemd[1]: Listening on Resolve Monitor Varlink Socket.1466second # [ 10.073664] systemd[1]: Listening on Resolve Service Varlink Socket.1467second # [ 10.074914] systemd[1]: Listening on udev Control Socket.1468second # [ 10.076006] systemd[1]: Listening on udev Varlink Socket.1469second # [ 10.078950] systemd[1]: Mounting Huge Pages File System...1470second # [ 10.082544] systemd[1]: Mounting POSIX Message Queue File System...1471test # [ 9.959436] systemd[1]: Applying preset policy.1472second # [ 10.088234] systemd[1]: Mounting Kernel Debug File System...1473second # [ 10.093540] systemd[1]: Mounting Kernel Trace File System...1474second # [ 10.099035] systemd[1]: Starting Create List of Static Device Nodes...1475second # [ 10.104670] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1476second # [ 10.113783] systemd[1]: Starting Load Kernel Module configfs...1477second # [ 10.120909] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1478second # [ 10.132760] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1479second # [ 10.138292] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1480second # [ 10.148380] systemd[1]: Mounting FUSE Control File System...1481second # [ 10.152229] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671482second # [ 10.164060] systemd[1]: Starting Journal Service...1483second # [ 10.170270] systemd[1]: Starting Load Kernel Modules...1484second # [ 10.180228] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1485second # [ 10.200071] systemd[1]: Starting Remount Root and Kernel File Systems...1486second # [ 10.201559] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1487second # [ 10.208414] systemd[1]: Starting Coldplug All udev Devices...1488second # [ 10.213591] systemd[1]: Listening on Journal Log Access Socket.1489second # [ 10.215425] systemd[1]: Mounted Huge Pages File System.1490second # [ 10.216766] systemd[1]: Mounted POSIX Message Queue File System.1491second # [ 10.219021] systemd[1]: Mounted Kernel Debug File System.1492second # [ 10.220618] systemd[1]: Mounted Kernel Trace File System.1493second # [ 10.223586] systemd[1]: Finished Create List of Static Device Nodes.1494second # [ 10.225234] systemd[1]: modprobe@configfs.service: Deactivated successfully.1495second # [ 10.230317] systemd[1]: Finished Load Kernel Module configfs.1496second # [ 10.252669] systemd[1]: Mounting Kernel Configuration File System...1497second # [ 10.279173] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1498second # [ 10.291175] systemd[1]: Mounted FUSE Control File System.1499second # [ 10.319540] systemd-journald[318]: Collecting audit messages is enabled.1500second # [ 10.339788] EXT4-fs (vda): re-mounted 01dc2460-4b22-41a0-836d-98f1595799c7.1501second # [ 10.366648] systemd[1]: Finished Remount Root and Kernel File Systems.1502second # [ 10.380024] systemd[1]: Listening on Disk Image Download Service Socket.1503second # [ 10.386542] loop: module loaded1504second # [ 10.201146] systemd[1]: Queued start job for default target Multi-User System.1505second # [ 10.204791] systemd[1]: systemd-journald.service: Deactivated successfully.[ 10.393605] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1506second # 1507second # [ 10.211762] systemd-modules-load[319]: Module 'ctr' is built in1508second # [ 10.216593] systemd-modules-load[319]: Inserted module 'loop'1509second # [ 10.420097] systemd[1]: Starting Load/Save OS Random Seed...1510second # [ 10.427603] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1511second # [ 10.249511] systemd-oomd[320]: No swap; memory pressure usage will be degraded1512second # [ 10.450145] systemd[1]: Started Journal Service.1513second # [ 10.272148] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1514second # [ 10.277884] systemd[1]: Finished Load Kernel Modules.1515second # [ 10.284299] systemd[1]: Mounted Kernel Configuration File System.1516second # [ 10.295223] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1517second # [ 10.318092] systemd[1]: Starting Firewall...1518second # [ 10.327094] systemd[1]: Starting Flush Journal to Persistent Storage...1519second # [ 10.330667] systemd[1]: Starting Apply Kernel Variables...1520second # [ 10.345083] systemd[1]: Starting Create Static Device Nodes in /dev...1521second # [ 10.370058] systemd[1]: Finished Load/Save OS Random Seed.1522second # [ 10.371384] systemd[1]: Reached target First Boot Complete.1523second # [ 10.582668] systemd-journald[318]: Received client request to flush runtime journal.1524test # [ 10.515106] systemd[1]: Populated /etc with preset unit settings.1525second # [ 10.664985] systemd[1]: Finished Apply Kernel Variables.1526second # [ 10.671782] systemd[1]: Finished Create Static Device Nodes in /dev.1527second # [ 10.676228] systemd[1]: Reached target Preparation for Local File Systems.1528second # [ 10.679351] systemd[1]: Starting Network Name Resolution...1529second # [ 10.681156] systemd[1]: Starting Rule-based Manager for Device Events and Files...1530second # [ 10.683794] systemd-udevd[352]: Using default interface naming scheme 'v261'.1531second # [ 10.686212] systemd[1]: Finished Coldplug All udev Devices.1532second # [ 10.689302] systemd-resolved[351]: Positive Trust Anchors:1533second # [ 10.691787] systemd-resolved[351]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1534second # [ 10.695104] systemd-resolved[351]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161535second # [ 10.697438] systemd-resolved[351]: 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 test1536second # [ 10.712387] systemd[1]: Finished Flush Journal to Persistent Storage.1537second # [ 10.765811] systemd-resolved[351]: Using system hostname 'second'.1538second # [ 10.772076] systemd[1]: Started Network Name Resolution.1539second # [ 10.782443] systemd[1]: Started Rule-based Manager for Device Events and Files.1540test # [ 10.853289] systemd[1]: initrd-switch-root.service: Deactivated successfully.1541test # [ 10.854976] systemd[1]: Stopped initrd-switch-root.service.1542test # [ 10.857712] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1543test # [ 10.859981] systemd[1]: Created slice Slice /system/getty.1544test # [ 10.861410] systemd[1]: Created slice User and Session Slice.1545test # [ 10.862483] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1546test # [ 10.863910] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1547test # [ 10.865174] systemd[1]: Expecting device /dev/hvc0...1548test # [ 10.866053] systemd[1]: Expecting device /dev/ttyS0...1549test # [ 10.866985] systemd[1]: Reached target Local Encrypted Volumes.1550test # [ 10.867993] systemd[1]: Stopped target initrd-fs.target.1551second # [ 10.816475] systemd[1]: Mounting /run/wrappers...1552test # [ 10.868893] systemd[1]: Stopped target initrd-root-fs.target.1553test # [ 10.877920] systemd[1]: Stopped target initrd-switch-root.target.1554test # [ 10.878964] systemd[1]: Reached target Virtual Machines and Containers.1555test # [ 10.880065] systemd[1]: Reached target Path Units.1556test # [ 10.880936] systemd[1]: Reached target Remote File Systems.1557test # [ 10.881865] systemd[1]: Reached target Slice Units.1558test # [ 10.882776] systemd[1]: Reached target Swaps.1559test # [ 10.885119] systemd[1]: Listening on Query the User Interactively for a Password.1560test # [ 10.887956] systemd[1]: Listening on Process Core Dump Socket.1561test # [ 10.890038] systemd[1]: Listening on Credential Encryption/Decryption.1562test # [ 10.892174] systemd[1]: Listening on Factory Reset Management.1563test # [ 10.893281] systemd[1]: Listening on Hostname Service Socket.1564test # [ 10.896310] systemd[1]: Starting Journal Log Access Socket...1565test # [ 10.897893] systemd[1]: Listening on Journal Audit Socket.1566test # [ 10.900620] systemd[1]: Listening on Console Output Muting Service Socket.1567test # [ 10.901906] systemd[1]: Listening on Network Management Metrics Varlink Socket.1568test # [ 10.903340] systemd[1]: Listening on Network Management Varlink Socket.1569test # [ 10.904615] systemd[1]: Listening on Network Management Netlink Socket.1570test # [ 10.905872] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1571test # [ 10.907305] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1572test # [ 10.908868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1573second # [ 10.852601] systemd[1]: Mounted /run/wrappers.1574second # [ 10.854199] systemd[1]: Reached target Local File Systems.1575test # [ 10.914293] systemd[1]: Listening on Disk Repartitioning Service Socket.1576test # [ 10.915527] systemd[1]: Listening on Resolve Monitor Varlink Socket.1577test # [ 10.916736] systemd[1]: Listening on Resolve Service Varlink Socket.1578second # [ 10.857327] systemd[1]: Listening on Boot Loader Control Service Socket.1579test # [ 10.917903] systemd[1]: Listening on udev Control Socket.1580test # [ 10.918958] systemd[1]: Listening on udev Varlink Socket.1581test # [ 10.921855] systemd[1]: Mounting Huge Pages File System...1582second # [ 10.862877] systemd[1]: Starting register-nix-paths.service...1583second # [ 10.866700] systemd[1]: Starting Create SUID/SGID Wrappers...1584test # [ 10.926151] systemd[1]: Mounting POSIX Message Queue File System...1585second # [ 10.867792] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1586test # [ 10.930728] systemd[1]: Mounting Kernel Debug File System...1587test # [ 10.936336] systemd[1]: Mounting Kernel Trace File System...1588second # [ 10.879669] systemd[1]: Starting Save Transient machine-id to Disk...1589test # [ 10.944200] systemd[1]: Starting Create List of Static Device Nodes...1590test # [ 10.950130] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1591second # [ 10.900464] systemd[1]: Starting Create System Files and Directories...1592test # [ 10.961422] systemd[1]: Starting Load Kernel Module configfs...1593test # [ 10.964171] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1594test # [ 10.970719] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1595test # [ 10.987590] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1596test # [ 11.003396] systemd[1]: Mounting FUSE Control File System...1597test # [ 11.004692] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671598test # [ 11.015681] systemd[1]: Starting Journal Service...1599test # [ 11.021348] systemd[1]: Starting Load Kernel Modules...1600test # [ 11.035056] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1601second # [ 10.987118] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1602test # [ 11.050414] systemd[1]: Starting Remount Root and Kernel File Systems...1603test # [ 11.055311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604second # [ 10.997503] systemd[1]: Finished Save Transient machine-id to Disk.1605test # [ 11.071797] systemd-journald[341]: Collecting audit messages is enabled.1606test # [ 11.075229] systemd[1]: Starting Coldplug All udev Devices...1607test # [ 11.084679] loop: module loaded1608test # [ 11.099199] systemd[1]: Listening on Journal Log Access Socket.1609test # [ 11.105892] systemd[1]: Mounted Huge Pages File System.1610test # [ 11.111545] systemd[1]: Mounted POSIX Message Queue File System.1611second # [ 11.053829] systemd[1]: Finished Create System Files and Directories.1612test # [ 10.929899] systemd[1]: Queued start job for default target Multi-User System.1613test # [ 11.118277] systemd[1]: Started Journal Service.1614test # [ 10.933760] systemd[1]: systemd-journald.service: Deactivated successfully.1615test # [ 10.936659] systemd-modules-load[342]: Module 'ctr' is built in1616second # [ 11.066314] systemd[1]: Starting Rebuild Journal Catalog...1617test # [ 10.942598] systemd-modules-load[342]: Inserted module 'loop'1618test # [ 10.943996] systemd[1]: Mounted Kernel Debug File System.1619test # [ 11.131681] EXT4-fs (vda): re-mounted ea20a194-1d29-49e3-ae13-cdf52772d9f7.1620test # [ 10.948812] systemd[1]: Mounted Kernel Trace File System.1621test # [ 10.954074] systemd[1]: Finished Create List of Static Device Nodes.1622test # [ 10.955456] systemd[1]: modprobe@configfs.service: Deactivated successfully.1623second # [ 11.082737] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1624test # [ 10.961415] systemd[1]: Finished Load Kernel Module configfs.1625test # [ 10.963791] systemd[1]: Mounted FUSE Control File System.1626test # [ 10.969067] systemd[1]: Finished Load Kernel Modules.1627test # [ 10.973112] systemd[1]: Finished Remount Root and Kernel File Systems.1628test # [ 10.987334] systemd[1]: Listening on Disk Image Download Service Socket.1629test # [ 10.989812] systemd-oomd[344]: No swap; memory pressure usage will be degraded1630test # [ 10.996079] systemd[1]: Mounting Kernel Configuration File System...1631test # [ 10.999116] systemd[1]: Starting Firewall...1632test # [ 11.007074] systemd[1]: Starting Flush Journal to Persistent Storage...1633test # [ 11.008322] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1634test # [ 11.021684] systemd[1]: Starting Load/Save OS Random Seed...1635test # [ 11.034197] systemd[1]: Starting Apply Kernel Variables...1636test # [ 11.045623] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1637second # [ 11.172117] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1638test # [ 11.047884] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1639test # [ 11.055575] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1640test # [ 11.248823] systemd-journald[341]: Received client request to flush runtime journal.1641second # [ 11.201395] systemd[1]: Finished Rebuild Journal Catalog.1642second # [ 11.210437] systemd[1]: Starting Update is Completed...1643second # [ 11.214497] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1644second # [ 11.266185] systemd[1]: Finished Update is Completed.1645second # [ 11.392973] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1646second # [ 11.397359] systemd[1]: Finished Create SUID/SGID Wrappers.1647second # [ 11.412941] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1648test # [ 11.333730] systemd[1]: Mounted Kernel Configuration File System.1649test # [ 11.336680] systemd[1]: Finished Load/Save OS Random Seed.1650second # [ 11.469102] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1651test # [ 11.344095] systemd[1]: Reached target First Boot Complete.1652test # [ 11.345377] systemd[1]: Finished Apply Kernel Variables.1653test # [ 11.348287] systemd[1]: Starting Network Name Resolution...1654test # [ 11.353711] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1655test # [ 11.358219] systemd[1]: Starting Create Static Device Nodes in /dev...1656test # [ 11.362166] systemd[1]: Finished Create Static Device Nodes in /dev.1657test # [ 11.365117] systemd[1]: Reached target Preparation for Local File Systems.1658test # [ 11.367425] systemd[1]: Starting Rule-based Manager for Device Events and Files...1659test # [ 11.369802] systemd-resolved[369]: Positive Trust Anchors:1660test # [ 11.373231] systemd-resolved[369]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1661test # [ 11.375951] systemd-resolved[369]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161662test # [ 11.380058] systemd-resolved[369]: 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 test1663test # [ 11.397804] systemd[1]: Finished Flush Journal to Persistent Storage.1664test # [ 11.407486] systemd-udevd[379]: Using default interface naming scheme 'v261'.1665second # [ 11.537311] (udev-worker)[412]: Network interface NamePolicy= disabled on kernel command line.1666second # [ 11.541239] (udev-worker)[419]: Network interface NamePolicy= disabled on kernel command line.1667second # [ 11.552160] systemd[1]: Finished Firewall.1668second # [ 11.553141] systemd[1]: Reached target Preparation for Network.1669test # [ 11.427397] systemd[1]: Finished Coldplug All udev Devices.1670second # [ 11.554284] systemd[1]: Listening on Network Management Resolve Hook Socket.1671second # [ 11.562160] systemd[1]: Starting Network Management...1672test # [ 11.449130] systemd-resolved[369]: Using system hostname 'test'.1673test # [ 11.456751] systemd[1]: Started Network Name Resolution.1674second # [ 11.610766] systemd[1]: Finished register-nix-paths.service.1675second # [ 11.611908] systemd[1]: Reached target System Initialization.1676second # [ 11.615081] systemd[1]: Started Discard unused filesystem blocks once a week.1677second # [ 11.616352] systemd[1]: Started Daily Cleanup of Temporary Directories.1678second # [ 11.618350] systemd[1]: Reached target Timer Units.1679second # [ 11.619962] systemd[1]: Listening on D-Bus System Message Bus Socket.1680second # [ 11.622565] systemd[1]: Listening on Nix Daemon Socket.1681second # [ 11.628449] systemd[1]: Listening on Authorization Manager Agent Helper.1682second # [ 11.629645] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1683second # [ 11.631099] systemd[1]: Reached target Socket Units.1684second # [ 11.636069] systemd[1]: Starting D-Bus System Message Bus...1685test # [ 11.513096] systemd[1]: Started Rule-based Manager for Device Events and Files.1686second # [ 11.715347] dbus-broker-launch[546]: Looking up NSS user entry for 'systemd-timesync'...1687second # [ 11.725915] dbus-broker-launch[546]: NSS returned no entry for 'systemd-timesync'1688second # [ 11.727383] dbus-broker-launch[546]: Invalid user-name in /nix/store/52kvjg19h04x096xdxhxzszgvqskmsc2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1689second # [ 11.755883] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1690second # [ 11.760501] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1691second # [ 11.767797] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nhsrpbakhmswx0ykmkxj8q0ykm2ifjlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1692second # [ 11.773040] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1693second # [ 11.777033] systemd[1]: Started D-Bus System Message Bus.1694second # [ 11.778691] systemd[1]: Reached target Basic System.1695test # [ 11.672671] systemd[1]: Mounting /run/wrappers...1696second # [ 11.799347] systemd[1]: Starting Network Manager Script Dispatcher Service...1697second # [ 11.988985] cfg80211: Loading compiled-in X.509 certificates for regulatory database1698second # [ 11.808801] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1699second # [ 11.810341] dbus-broker-launch[546]: Ready1700test # [ 11.695533] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1701second # [ 11.824422] systemd[1]: Starting Network Manager...1702second # [ 12.017345] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1703second # [ 12.018354] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1704test # [ 11.707616] systemd[1]: Mounted /run/wrappers.1705test # [ 11.711273] systemd[1]: Reached target Local File Systems.1706test # [ 11.715541] systemd[1]: Listening on Boot Loader Control Service Socket.1707test # [ 11.719341] systemd[1]: Starting register-nix-paths.service...1708second # [ 11.847209] systemd[1]: Started backdoor.service.1709test # [ 11.726915] systemd[1]: Starting Create SUID/SGID Wrappers...1710test # [ 11.728295] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1711second # [ 11.866428] systemd[1]: Starting Import lastlog data into lastlog2 database...1712test # [ 11.741311] systemd[1]: Starting Save Transient machine-id to Disk...1713test # [ 11.752481] systemd[1]: Starting Create System Files and Directories...1714second # [ 11.882390] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[550]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1715second # [ 11.893079] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1716second # [ 11.911226] systemd-networkd[541]: /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.1717second # [ 11.916511] systemd-networkd[541]: /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.1718second # [ 11.920990] systemd-networkd[541]: lo: Link UP1719second # [ 11.923925] systemd-networkd[541]: lo: Gained carrier1720second # [ 11.926235] systemd[1]: Starting Post-Boot Actions...1721second # [ 11.940940] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1722second # [ 11.943670] systemd-networkd[541]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1723second # [ 11.965415] systemd[1]: Started Reset console on configuration changes.1724test # [ 11.841419] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1725second # [ 11.968207] systemd-networkd[541]: eth1: Link UP1726second # [ 11.975665] systemd-networkd[541]: eth1: Gained carrier1727test # [ 11.849427] systemd[1]: Finished Save Transient machine-id to Disk.1728second # [ 11.979428] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1729second # [ 12.187802] NET: Registered PF_PACKET protocol family1730test # [ 11.878112] systemd[1]: Finished Create System Files and Directories.1731second # [ 12.005296] systemd[1]: Started Network Management.1732test # [ 11.890174] systemd[1]: Starting Rebuild Journal Catalog...1733second # [ 12.022842] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1734second # [ 12.040666] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1735test # [ 11.916340] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1736second # connecting to host...1737test # [ 11.929547] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1738second # [ 12.080904] nsncd[560]: Sep 06 05:10:32.777 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1739second # [ 12.085423] systemd[1]: Started Name Service Cache Daemon (nsncd).1740second # [ 12.105245] systemd[1]: Finished Post-Boot Actions.1741second # [ 12.117610] systemd[1]: Reached target Host and Network Name Lookups.1742second # [ 12.121483] systemd[1]: Reached target User and Group Name Lookups.1743test # [ 11.997338] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1744second # [ 12.132146] systemd[1]: Starting User Login Management...1745second # [ 12.322858] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31746test # [ 12.011510] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1747second # [ 12.138635] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1748second # [ 12.142087] systemd[1]: Finished Import lastlog data into lastlog2 database.1749test # [ 12.022206] systemd[1]: Finished Rebuild Journal Catalog.1750second # [ 12.341128] mousedev: PS/2 mouse device common for all mice1751test # [ 12.029151] systemd[1]: Starting Update is Completed...1752second # [ 12.157741] systemd[1]: Started Network Manager Script Dispatcher Service.1753second # [ 12.179217] systemd[1]: Starting Hostname Service...1754test # [ 12.059163] systemd[1]: Finished Firewall.1755test # [ 12.061884] systemd[1]: Reached target Preparation for Network.1756test # [ 12.064330] systemd[1]: Listening on Network Management Resolve Hook Socket.1757test # [ 12.072756] systemd[1]: Starting Network Management...1758test # [ 12.084529] systemd[1]: Finished Update is Completed.1759test # [ 12.088879] (udev-worker)[440]: Network interface NamePolicy= disabled on kernel command line.1760test # [ 12.092919] (udev-worker)[439]: Network interface NamePolicy= disabled on kernel command line.1761second # [ 12.228557] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1762second # [ 12.421617] ACPI: button: Power Button [PWRF]1763second # [ 12.261199] systemd-logind[594]: New seat seat0.1764second # [ 12.263967] systemd[1]: Started User Login Management.1765second # [ 12.271296] systemd[1]: Starting linger-users.service...1766second # [ 12.307620] systemd[1]: Started Hostname Service.1767second # [ 12.312132] systemd[1]: linger-users.service: Deactivated successfully.1768second # [ 12.316140] systemd[1]: Finished linger-users.service.1769second # [ 12.516361] rtc_cmos 00:04: RTC can wake from S41770second # [ 12.531608] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1771second # [ 12.552104] rtc_cmos 00:04: registered as rtc01772second # [ 12.554944] parport_pc 00:02: reported by Plug and Play ACPI1773test # [ 12.255150] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1774second # [ 12.386444] systemd-networkd[541]: eth0: Link UP1775test # [ 12.260822] systemd[1]: Finished Create SUID/SGID Wrappers.1776second # [ 12.387767] systemd-networkd[541]: eth0: Gained carrier1777second # [ 12.394877] systemd-resolved[351]: Clock change detected. Flushing caches.1778second # [ 12.408382] systemd[1]: Started Network Manager.1779second # [ 12.410186] systemd[1]: Reached target Network.1780second # [ 12.416988] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1781second # [ 12.425521] systemd[1]: Starting Permit User Sessions...1782test # [ 12.509874] cfg80211: Loading compiled-in X.509 certificates for regulatory database1783test # [ 12.526347] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1784test # [ 12.527365] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1785second # [ 12.492132] systemd[1]: Finished Permit User Sessions.1786test # [ 12.382784] systemd-networkd[535]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1787test # [ 12.386745] systemd-networkd[535]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1788test # [ 12.392194] systemd-networkd[535]: lo: Link UP1789test # [ 12.393606] systemd-networkd[535]: lo: Gained carrier1790test # [ 12.404988] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1791second # [ 12.568405] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41792test # [ 12.407496] systemd-networkd[535]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1793test # [ 12.409031] systemd[1]: Started Network Management.1794test # [ 12.417640] systemd-networkd[535]: eth1: Link UP1795test # [ 12.421649] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1796test # [ 12.422952] systemd-networkd[535]: eth1: Gained carrier1797test # [ 12.423924] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1798second # [ 12.578090] rtc_cmos 00:04: setting system clock to 2026-09-06T05:10:33 UTC (1788671433)1799second # [ 12.578192] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1800test # [ 12.630047] NET: Registered PF_PACKET protocol family1801second # [ 12.592849] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1802second # [ 12.598600] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1803second # [ 12.719807] Console: switching to colour dummy device 80x251804second # [ 12.758575] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1805second # [ 12.758681] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1806test # [ 12.471928] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1807second # [ 12.787248] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61808second # [ 12.787552] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51809test # [ 12.490263] systemd[1]: Finished register-nix-paths.service.1810test # [ 12.491692] systemd[1]: Reached target System Initialization.1811test # [ 12.493128] systemd[1]: Started Discard unused filesystem blocks once a week.1812test # [ 12.495173] systemd[1]: Started Daily Cleanup of Temporary Directories.1813second # [ 12.808115] [drm] Found bochs VGA, ID 0xb0c5.1814second # [ 12.808117] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1815test # [ 12.497222] systemd[1]: Reached target Timer Units.1816second # [ 12.624765] systemd[1]: Started Getty on tty1.1817test # [ 12.498924] systemd[1]: Listening on D-Bus System Message Bus Socket.1818test # [ 12.500592] systemd[1]: Listening on Nix Daemon Socket.1819second # [ 12.627166] systemd[1]: Reached target Login Prompts.1820second # [ 12.816510] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1821second # [ 12.817359] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01822second # [ 12.631837] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1823test # [ 12.506125] systemd[1]: Listening on Authorization Manager Agent Helper.1824test # [ 12.507355] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1825test # [ 12.508810] systemd[1]: Reached target Socket Units.1826second # [ 12.634972] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1827test # [ 12.512285] systemd[1]: Starting D-Bus System Message Bus...1828second # [ 12.648435] systemd-resolved[351]: eth0: Bus client set default route setting: yes1829second # [ 12.652632] systemd-resolved[351]: eth0: Bus client set DNS server list to: 10.0.2.31830test # [ 12.720669] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1831test # [ 12.723900] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31832second # [ 12.695867] systemd[1]: Reached target Multi-User System.1833second # [ 12.702589] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1834second # [ 12.703934] systemd[1]: Startup finished in 1.073s (kernel) + 4.050s (initrd) + 7.574s (userspace) = 12.699s.1835test # [ 12.580327] dbus-broker-launch[577]: Looking up NSS user entry for 'systemd-timesync'...1836test # [ 12.585099] dbus-broker-launch[577]: NSS returned no entry for 'systemd-timesync'1837test # [ 12.586725] dbus-broker-launch[577]: Invalid user-name in /nix/store/52kvjg19h04x096xdxhxzszgvqskmsc2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1838test # [ 12.606844] dbus-broker-launch[577]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1839test # [ 12.611058] dbus-broker-launch[577]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1840test # [ 12.615668] dbus-broker-launch[577]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nhsrpbakhmswx0ykmkxj8q0ykm2ifjlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1841test # [ 12.619894] dbus-broker-launch[577]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1842second # [ 12.748262] systemd[1]: Starting Virtual Console Setup...1843test # [ 12.623823] systemd[1]: Started D-Bus System Message Bus.1844test # [ 12.626630] systemd[1]: Reached target Basic System.1845test # [ 12.629126] systemd[1]: Starting Network Manager Script Dispatcher Service...1846test # [ 12.637651] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1847test # [ 12.654676] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1848test # [ 12.662513] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1849test # [ 12.666404] dbus-broker-launch[577]: Ready1850test # [ 12.684504] systemd[1]: Starting Network Manager...1851test # [ 12.705373] systemd[1]: Started backdoor.service.1852test # [ 12.715510] fwqmh4fc3j6in9rflv5cf5kgmc9k4ybb-wifi-secrets[580]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1853test # [ 12.720721] systemd[1]: Starting Import lastlog data into lastlog2 database...1854second # [ 13.029080] Console: switching to colour frame buffer device 160x501855second # [ 13.047375] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1856second # [ 12.780628] systemd-logind[594]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1857test # [ 12.736939] systemd-resolved[369]: Clock change detected. Flushing caches.1858second # [ 12.863968] systemd-logind[594]: Watching system buttons on /dev/input/event2 (Power Button)1859test # [ 12.746456] mousedev: PS/2 mouse device common for all mice1860test # [ 12.749830] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1861test # [ 12.749852] ACPI: button: Power Button [PWRF]1862test # [ 12.882195] rtc_cmos 00:04: RTC can wake from S41863test # [ 12.886753] parport_pc 00:02: reported by Plug and Play ACPI1864test # [ 12.886839] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1865second # [ 12.895502] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1866second # [ 12.898934] systemd[1]: Stopped Virtual Console Setup.1867test # [ 12.778778] d1nj6zvw29gdp15fx855q5n4s3rj0h43-wifi-secrets[582]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1868second # [ 12.906393] systemd[1]: Starting Virtual Console Setup...1869test # [ 12.784175] systemd[1]: Starting Post-Boot Actions...1870test # [ 12.787838] iif2wwqra6cyixya934jn1gzixwi7l6v-wifi-secrets[581]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1871second # [ 13.102678] ppdev: user-space parallel port driver1872test # [ 12.807222] systemd[1]: Started Reset console on configuration changes.1873second # [ 12.941986] systemd-logind[594]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1874test # [ 12.920869] rtc_cmos 00:04: registered as rtc01875test # [ 12.920976] rtc_cmos 00:04: setting system clock to 2026-09-06T05:10:33 UTC (1788671433)1876second # [ 13.134821] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1877test # [ 12.841594] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1878second # [ 13.158028] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1879test # [ 12.855515] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1880test # [ 12.862842] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1881test # [ 12.871686] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1882second # [ 12.998707] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1883second # [ 13.000845] systemd[1]: Stopped Virtual Console Setup.1884test # [ 12.875231] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1885second # [ 13.007419] systemd[1]: Starting Virtual Console Setup...1886test # [ 12.884058] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1887second # [ 13.011239] systemd-networkd[541]: eth1: Gained IPv6LL1888test # [ 12.895708] systemd[1]: Finished Post-Boot Actions.1889test # connecting to host...1890test # [ 12.913697] systemd[1]: Started Name Service Cache Daemon (nsncd).1891test # [ 12.916544] nsncd[590]: Sep 06 05:10:33.674 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1892test: Guest shell says: b'Spawning backdoor root shell...\n'1893second # [ 13.254277] kvm_amd: TSC scaling supported1894test: connected to guest root shell1895second # [ 13.254863] kvm_amd: Nested Virtualization enabled1896test: (connecting took 13.92 seconds)1897test # [ 12.921068] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1898second # [ 13.255715] kvm_amd: Nested Paging enabled1899test: (finished: waiting for the VM to finish booting, in 13.92 seconds)1900second # [ 13.256195] kvm_amd: LBR virtualization supported1901test # [ 12.925017] Console: switching to colour dummy device 80x251902second # [ 13.257061] kvm_amd: Virtual GIF supported1903test # [ 12.941294] systemd[1]: Reached target Host and Network Name Lookups.1904test # [ 12.943275] systemd[1]: Reached target User and Group Name Lookups.1905second # [ 13.257760] kvm_amd: Virtual NMI enabled1906test # [ 12.956146] systemd[1]: Starting User Login Management...1907second # [ 13.290666] EDAC MC: Ver: 3.0.01908test # [ 12.979233] systemd[1]: Finished Import lastlog data into lastlog2 database.1909test # [ 13.115066] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1910test # [ 13.143324] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41911test # [ 12.992957] systemd[1]: Started Network Manager Script Dispatcher Service.1912test # [ 13.009905] systemd[1]: Starting Hostname Service...1913test # [ 13.214385] [drm] Found bochs VGA, ID 0xb0c5.1914test # [ 13.214390] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1915test # [ 13.224468] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1916test # [ 13.256729] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01917test # [ 13.085540] systemd-logind[634]: New seat seat0.1918test # [ 13.088337] systemd[1]: Started User Login Management.1919second # [ 13.216172] systemd-vconsole-setup[652]: Configuration of first virtual console was skipped, ignoring remaining ones.1920test # [ 13.093762] systemd[1]: Starting linger-users.service...1921second # [ 13.219964] systemd[1]: Finished Virtual Console Setup.1922test # [ 13.298032] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1923test # [ 13.298833] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1924test # [ 13.138798] systemd[1]: Started Hostname Service.1925test # [ 13.147692] systemd[1]: linger-users.service: Deactivated successfully.1926test # [ 13.152142] systemd[1]: Finished linger-users.service.1927test # [ 13.209104] systemd-networkd[535]: eth0: Link UP1928test # [ 13.210616] systemd-networkd[535]: eth0: Gained carrier1929test # [ 13.380337] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61930test # [ 13.234079] systemd[1]: Started Network Manager.1931test # [ 13.234983] systemd[1]: Reached target Network.1932test # [ 13.239131] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1933test # [ 13.249705] systemd[1]: Starting Permit User Sessions...1934test # [ 13.380653] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51935test # [ 13.306676] systemd[1]: Finished Permit User Sessions.1936test # [ 13.397843] Console: switching to colour frame buffer device 160x501937test # [ 13.519433] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1938test # [ 13.337800] systemd[1]: Started Getty on tty1.1939test # [ 13.338706] systemd[1]: Reached target Login Prompts.1940test # [ 13.383853] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1941test # [ 13.394610] NetworkManager[583]: <warn> [1788671434.1574] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1942test # [ 13.400994] systemd[1]: Starting Virtual Console Setup...1943test # [ 13.443961] systemd-logind[634]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1944test # [ 13.450879] systemd-logind[634]: Watching system buttons on /dev/input/event2 (Power Button)1945second # [ 13.585117] systemd-networkd[541]: eth0: Gained IPv6LL1946test # [ 13.464577] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1947test # [ 13.468591] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1948test # [ 13.478557] systemd-resolved[369]: eth0: Bus client set default route setting: yes1949test # [ 13.486161] systemd[1]: Reached target Multi-User System.1950test # [ 13.488494] systemd-resolved[369]: eth0: Bus client set DNS server list to: 10.0.2.31951test # [ 13.503443] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1952test # [ 13.507702] systemd[1]: Stopped Virtual Console Setup.1953test # [ 13.517969] systemd[1]: Starting Virtual Console Setup...1954test # [ 13.748966] ppdev: user-space parallel port driver1955test # [ 13.802370] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1956test # [ 13.645267] systemd-logind[634]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1957test # [ 13.834027] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1958test # [ 13.705094] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1959test # [ 13.707932] systemd[1]: Stopped Virtual Console Setup.1960test # [ 13.716157] systemd[1]: Starting Virtual Console Setup...1961test # [ 13.953011] kvm_amd: TSC scaling supported1962test # [ 13.953509] kvm_amd: Nested Virtualization enabled1963test # [ 13.954411] kvm_amd: Nested Paging enabled1964test # [ 13.955171] kvm_amd: LBR virtualization supported1965test # [ 13.955976] kvm_amd: Virtual GIF supported1966test # [ 13.956469] kvm_amd: Virtual NMI enabled1967test # [ 13.991731] EDAC MC: Ver: 3.0.01968test # [ 13.892958] systemd-vconsole-setup[697]: Configuration of first virtual console was skipped, ignoring remaining ones.1969test # [ 13.896929] systemd[1]: Finished Virtual Console Setup.1970test # [ 13.902171] systemd[1]: Startup finished in 992ms (kernel) + 7.963s (initrd) + 4.946s (userspace) = 13.902s.1971test # [ 14.031624] systemd-networkd[535]: eth1: Gained IPv6LL1972test: (finished: waiting for unit NetworkManager.service, in 15.06 seconds)1973test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1974test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.01 seconds)1975test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1976test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.01 seconds)1977test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1978test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.01 seconds)1979(finished: run the VM test script, in 15.65 seconds)1980test script finished in 15.71s1981cleanup1982kill QemuMachine (pid 46)1983second # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1984kill QemuMachine (pid 48)1985test # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1986(finished: cleanup, in 0.20 seconds)