vm-test-run-effects
checks.x86_64-linux.effects
· build #69
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7start all VMs8node1: starting vm9node1: QEMU running (pid 46)10node1 # Disk image does not exist, creating the virtualisation disk image...11node1 # Formatting '/build/vm-state-node1/tmp.mEzZIyKtoP', fmt=raw size=107374182412(finished: start all VMs, in 0.41 seconds)13node1 # mke2fs 1.47.4 (6-Mar-2025)14node1: must succeed: buildbot-effects --help15node1 # Discarding device blocks: 0/262144 done16node1: waiting for the VM to finish booting17node1 # Creating filesystem with 262144 4k blocks and 65536 inodes18node1 # Filesystem UUID: d1cdc38b-ba76-4a3b-a028-f5eb3fa2f2a219node1 # Superblock backups stored on blocks:20node1 # 32768, 98304, 163840, 22937621node1 # 22node1 # Allocating group tables: 0/8 done23node1 # Writing inode tables: 0/8 done24node1 # Creating journal (8192 blocks): done25node1 # Writing superblocks and filesystem accounting information: 0/8 done26node1 # 27node1 # Virtualisation disk image created.28node1 # Starting virtiofs daemons...29node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Waiting for vhost-user socket connection...32node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Waiting for vhost-user socket connection...35node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)36node1 # [2026-09-27T07:28:35Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether37node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Waiting for vhost-user socket connection...38node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Client connected, servicing requests39node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Client connected, servicing requests40node1 # [2026-09-27T07:28:35Z INFO virtiofsd] Client connected, servicing requests41node1 # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)42node1 # 43node1 # 44node1 # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0045node1 # Press Ctrl-B to configure iPXE (PCI 00:02.0)...46node1 # 47node1 # 48node1 # 49node1 # 50node1 # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0051node1 # Press Ctrl-B to configure iPXE (PCI 00:05.0)...52node1 # 53node1 # 54node1 # Booting from ROM...55node1 # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 202656node1 # [ 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/zfn42jq0q2r06gignc2y6g2irpndiaxn-nixos-system-node1-test/init regInfo=/nix/.ro-store/rk56318g4iz1krivm1wqcpkzg65ficqp-closure-info/registration console=ttyS0,115200n8 console=tty057node1 # [ 0.000000] BIOS-provided physical RAM map:58node1 # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable59node1 # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved60node1 # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved61node1 # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable62node1 # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved63node1 # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved64node1 # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved65node1 # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved66node1 # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved67node1 # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved68node1 # [ 0.000000] NX (Execute Disable) protection: active69node1 # [ 0.000000] APIC: Static calls initialized70node1 # [ 0.000000] SMBIOS 2.8 present.71node1 # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201472node1 # [ 0.000000] DMI: Memory slots populated: 1/173node1 # [ 0.000000] Hypervisor detected: KVM74node1 # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000075node1 # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0076node1 # [ 0.000000] kvm-clock: using sched offset of 530471408 cycles77node1 # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns78node1 # [ 0.000005] tsc: Detected 2400.012 MHz processor79node1 # [ 0.000810] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000080node1 # [ 0.000838] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs81node1 # [ 0.000841] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT82node1 # [ 0.002732] found SMP MP-table at [mem 0x000f5450-0x000f545f]83node1 # [ 0.002743] Using GB pages for direct mapping84node1 # [ 0.002851] RAMDISK: [mem 0x3e368000-0x3ffcffff]85node1 # [ 0.002859] ACPI: Early table checksum verification disabled86node1 # [ 0.002861] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )87node1 # [ 0.002865] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)88node1 # [ 0.002869] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)89node1 # [ 0.002876] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)90node1 # [ 0.002878] ACPI: FACS 0x000000003FFE0000 00004091node1 # [ 0.002880] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)92node1 # [ 0.002881] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)93node1 # [ 0.002883] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)94node1 # [ 0.002884] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)95node1 # [ 0.002885] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]96node1 # [ 0.002887] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]97node1 # [ 0.002887] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]98node1 # [ 0.002888] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]99node1 # [ 0.002888] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]100node1 # [ 0.002889] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]101node1 # [ 0.002889] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]102node1 # [ 0.003124] No NUMA configuration found103node1 # [ 0.003125] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]104node1 # [ 0.003127] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]105node1 # [ 0.005253] Zone ranges:106node1 # [ 0.005253] DMA [mem 0x0000000000001000-0x0000000000ffffff]107node1 # [ 0.005255] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]108node1 # [ 0.005256] Normal empty109node1 # [ 0.005257] Device empty110node1 # [ 0.005257] Movable zone start for each node111node1 # [ 0.005258] Early memory node ranges112node1 # [ 0.005259] node 0: [mem 0x0000000000001000-0x000000000009efff]113node1 # [ 0.005260] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]114node1 # [ 0.005261] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]115node1 # [ 0.005279] On node 0, zone DMA: 1 pages in unavailable ranges116node1 # [ 0.005530] On node 0, zone DMA: 97 pages in unavailable ranges117node1 # [ 0.022195] On node 0, zone DMA32: 40 pages in unavailable ranges118node1 # [ 0.022650] ACPI: PM-Timer IO Port: 0x608119node1 # [ 0.022659] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])120node1 # [ 0.022686] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23121node1 # [ 0.022689] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)122node1 # [ 0.022690] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)123node1 # [ 0.022691] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)124node1 # [ 0.022692] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)125node1 # [ 0.022693] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)126node1 # [ 0.022695] ACPI: Using ACPI (MADT) for SMP configuration information127node1 # [ 0.022696] ACPI: HPET id: 0x8086a201 base: 0xfed00000128node1 # [ 0.022699] TSC deadline timer available129node1 # [ 0.022703] CPU topo: Max. logical packages: 1130node1 # [ 0.022704] CPU topo: Max. logical dies: 1131node1 # [ 0.022705] CPU topo: Max. dies per package: 1132node1 # [ 0.022716] CPU topo: Max. threads per core: 1133node1 # [ 0.022717] CPU topo: Num. cores per package: 1134node1 # [ 0.022717] CPU topo: Num. threads per package: 1135node1 # [ 0.022718] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs136node1 # [ 0.022734] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()137node1 # [ 0.022762] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]138node1 # [ 0.022763] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]139node1 # [ 0.022764] [mem 0x40000000-0xafffffff] available for PCI devices140node1 # [ 0.022765] Booting paravirtualized kernel on KVM141node1 # [ 0.022768] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns142node1 # [ 0.027210] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1143node1 # [ 0.029260] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152144node1 # [ 0.029302] kvm-guest: PV spinlocks disabled, single CPU145node1 # [ 0.029303] 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/zfn42jq0q2r06gignc2y6g2irpndiaxn-nixos-system-node1-test/init regInfo=/nix/.ro-store/rk56318g4iz1krivm1wqcpkzg65ficqp-closure-info/registration console=ttyS0,115200n8 console=tty0146node1 # [ 0.029393] Unknown kernel command line parameters "regInfo=/nix/.ro-store/rk56318g4iz1krivm1wqcpkzg65ficqp-closure-info/registration", will be passed to user space.147node1 # [ 0.029405] random: crng init done148node1 # [ 0.029406] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes149node1 # [ 0.030558] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)150node1 # [ 0.030571] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)151node1 # [ 0.030600] Fallback order for Node 0: 0152node1 # [ 0.030603] Built 1 zonelists, mobility grouping on. Total pages: 262006153node1 # [ 0.030604] Policy zone: DMA32154node1 # [ 0.032911] mem auto-init: stack:all(zero), heap alloc:on, heap free:off155node1 # [ 0.035188] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1156node1 # [ 0.037309] allocated 2097152 bytes of page_ext157node1 # [ 0.046670] ftrace: allocating 48804 entries in 192 pages158node1 # [ 0.046672] ftrace: allocated 192 pages with 2 groups159node1 # [ 0.047476] Dynamic Preempt: lazy160node1 # [ 0.047641] rcu: Preemptible hierarchical RCU implementation.161node1 # [ 0.047642] rcu: RCU event tracing is enabled.162node1 # [ 0.047642] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.163node1 # [ 0.047644] Trampoline variant of Tasks RCU enabled.164node1 # [ 0.047644] Rude variant of Tasks RCU enabled.165node1 # [ 0.047644] Tracing variant of Tasks RCU enabled.166node1 # [ 0.047645] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.167node1 # [ 0.047646] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1168node1 # [ 0.047665] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169node1 # [ 0.047666] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.170node1 # [ 0.047667] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.171node1 # [ 0.051996] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16172node1 # [ 0.052270] rcu: srcu_init: Setting srcu_struct sizes based on contention.173node1 # [ 0.052278] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns174node1 # [ 0.052378] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)175node1 # [ 0.055904] Console: colour VGA+ 80x25176node1 # [ 0.055907] printk: legacy console [tty0] enabled177node1 # [ 0.085356] printk: legacy console [ttyS0] enabled178node1 # [ 0.191503] ACPI: Core revision 20250807179node1 # [ 0.192413] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns180node1 # [ 0.194113] APIC: Switch to symmetric I/O mode setup181node1 # [ 0.195154] x2apic enabled182node1 # [ 0.195905] APIC: Switched APIC routing to: physical x2apic183node1 # [ 0.197819] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1184node1 # [ 0.198853] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns185node1 # [ 0.200593] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)186node1 # [ 0.202604] x86/cpu: User Mode Instruction Prevention (UMIP) activated187node1 # [ 0.203706] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127188node1 # [ 0.204591] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0189node1 # [ 0.205594] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto190node1 # [ 0.206591] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl191node1 # [ 0.207591] Transient Scheduler Attacks: Vulnerable: No microcode192node1 # [ 0.208590] Spectre V2 : Mitigation: Enhanced / Automatic IBRS193node1 # [ 0.209591] Speculative Return Stack Overflow: Mitigation: Safe RET194node1 # [ 0.210590] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization195node1 # [ 0.212598] Spectre V2 : Enabling IBPB for BPF196node1 # [ 0.214163] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier197node1 # [ 0.214591] active return thunk: srso_alias_return_thunk198node1 # [ 0.215612] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'199node1 # [ 0.216590] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'200node1 # [ 0.217590] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'201node1 # [ 0.218590] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'202node1 # [ 0.219590] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'203node1 # [ 0.220590] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'204node1 # [ 0.221590] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'205node1 # [ 0.223591] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256206node1 # [ 0.224591] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64207node1 # [ 0.225590] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512208node1 # [ 0.226590] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024209node1 # [ 0.227590] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8210node1 # [ 0.228590] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.211node1 # [ 0.262709] Freeing SMP alternatives memory: 44K212node1 # [ 0.263530] pid_max: default: 32768 minimum: 301213node1 # [ 0.264280] LSM: initializing lsm=capability,landlock,yama,bpf,ima214node1 # [ 0.265452] landlock: Up and running.215node1 # [ 0.266049] Yama: becoming mindful.216node1 # [ 0.266805] LSM support for eBPF active217node1 # [ 0.267673] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)218node1 # [ 0.268612] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)219node1 # [ 0.271641] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)220node1 # [ 0.273120] Performance Events: Fam17h+ core perfctr, AMD PMU driver.221node1 # [ 0.273600] ... version: 2222node1 # [ 0.274365] ... bit width: 48223node1 # [ 0.274593] ... generic counters: 6224node1 # [ 0.275352] ... generic bitmap: 000000000000003f225node1 # [ 0.275592] ... fixed-purpose counters: 0226node1 # [ 0.276366] ... fixed-purpose bitmap: 0000000000000000227node1 # [ 0.276593] ... value mask: 0000ffffffffffff228node1 # [ 0.277543] ... max period: 00007fffffffffff229node1 # [ 0.278337] ... global_ctrl mask: 000000000000003f230node1 # [ 0.278705] signal: max sigframe size: 3376231node1 # [ 0.279510] rcu: Hierarchical SRCU implementation.232node1 # [ 0.280204] rcu: Max phase no-delay instances is 400.233node1 # [ 0.285131] smp: Bringing up secondary CPUs ...234node1 # [ 0.285606] smp: Brought up 1 node, 1 CPU235node1 # [ 0.286303] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)236node1 # [ 0.286745] Memory: 941016K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 99612K reserved, 0K cma-reserved)237node1 # [ 0.287813] devtmpfs: initialized238node1 # [ 0.288707] x86/mm: Memory block size: 128MB239node1 # [ 0.290397] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)240node1 # [ 0.291579] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).241node1 # [ 0.292674] pinctrl core: initialized pinctrl subsystem242node1 # [ 0.293858] PM: RTC time: 07:28:35, date: 2026-09-27243node1 # [ 0.297180] NET: Registered PF_NETLINK/PF_ROUTE protocol family244node1 # [ 0.297926] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations245node1 # [ 0.298612] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations246node1 # [ 0.299774] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations247node1 # [ 0.300602] audit: initializing netlink subsys (disabled)248node1 # [ 0.301769] thermal_sys: Registered thermal governor 'fair_share'249node1 # [ 0.301771] thermal_sys: Registered thermal governor 'bang_bang'250node1 # [ 0.302594] thermal_sys: Registered thermal governor 'step_wise'251node1 # [ 0.303596] audit: type=2000 audit(1790494116.291:1): state=initialized audit_enabled=0 res=1252node1 # [ 0.305596] thermal_sys: Registered thermal governor 'user_space'253node1 # [ 0.305598] thermal_sys: Registered thermal governor 'power_allocator'254node1 # [ 0.306619] cpuidle: using governor menu255node1 # [ 0.308812] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5256node1 # [ 0.309830] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]257node1 # [ 0.310596] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry258node1 # [ 0.311604] PCI: Using configuration type 1 for base access259node1 # [ 0.312702] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.260node1 # [ 0.317878] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages261node1 # [ 0.318594] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page262node1 # [ 0.323593] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages263node1 # [ 0.324592] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page264node1 # [ 0.334966] ACPI: Added _OSI(Module Device)265node1 # [ 0.335595] ACPI: Added _OSI(Processor Device)266node1 # [ 0.336382] ACPI: Added _OSI(Processor Aggregator Device)267node1 # [ 0.345142] ACPI: 1 ACPI AML tables successfully acquired and loaded268node1 # [ 0.346527] ACPI: Interpreter enabled269node1 # [ 0.347108] ACPI: PM: (supports S0 S3 S4 S5)270node1 # [ 0.349594] ACPI: Using IOAPIC for interrupt routing271node1 # [ 0.350508] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug272node1 # [ 0.353594] PCI: Using E820 reservations for host bridge windows273node1 # [ 0.354736] ACPI: Enabled 2 GPEs in block 00 to 3F274node1 # [ 0.363384] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])275node1 # [ 0.365021] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]276node1 # [ 0.365672] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]277node1 # [ 0.366716] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]278node1 # [ 0.367945] PCI host bridge to bus 0000:00279node1 # [ 0.368597] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]280node1 # [ 0.369593] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]281node1 # [ 0.370593] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]282node1 # [ 0.371594] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]283node1 # [ 0.372593] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]284node1 # [ 0.373594] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]285node1 # [ 0.374593] pci_bus 0000:00: root bus resource [bus 00-ff]286node1 # [ 0.375570] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint287node1 # [ 0.377022] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint288node1 # [ 0.379709] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]289node1 # [ 0.380645] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]290node1 # [ 0.381645] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]291node1 # [ 0.382900] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]292node1 # [ 0.384561] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint293node1 # [ 0.387641] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]294node1 # [ 0.388552] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]295node1 # [ 0.389379] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]296node1 # [ 0.390503] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]297node1 # [ 0.391995] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298node1 # [ 0.394401] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]299node1 # [ 0.395275] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]300node1 # [ 0.395615] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]301node1 # [ 0.397169] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint302node1 # [ 0.399643] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]303node1 # [ 0.401304] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]304node1 # [ 0.401615] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]305node1 # [ 0.403133] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint306node1 # [ 0.404629] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]307node1 # [ 0.405552] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]308node1 # [ 0.406387] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]309node1 # [ 0.407512] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]310node1 # [ 0.409139] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint311node1 # [ 0.410637] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]312node1 # [ 0.411615] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]313node1 # [ 0.413156] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint314node1 # [ 0.414605] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]315node1 # [ 0.415617] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]316node1 # [ 0.417193] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint317node1 # [ 0.418611] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]318node1 # [ 0.419615] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]319node1 # [ 0.421183] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint320node1 # [ 0.422606] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]321node1 # [ 0.423615] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]322node1 # [ 0.425151] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint323node1 # [ 0.426637] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]324node1 # [ 0.427537] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]325node1 # [ 0.428403] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]326node1 # [ 0.430067] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint327node1 # [ 0.431632] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]328node1 # [ 0.432550] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]329node1 # [ 0.433390] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]330node1 # [ 0.435053] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint331node1 # [ 0.436324] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]332node1 # [ 0.436789] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint333node1 # [ 0.438993] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]334node1 # [ 0.439785] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint335node1 # [ 0.441253] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]336node1 # [ 0.441839] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint337node1 # [ 0.444274] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]338node1 # [ 0.444875] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint339node1 # [ 0.445891] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO340node1 # [ 0.446840] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint341node1 # [ 0.448622] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]342node1 # [ 0.449514] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]343node1 # [ 0.450698] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint344node1 # [ 0.452246] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]345node1 # [ 0.455710] ACPI: PCI: Interrupt link LNKA configured for IRQ 10346node1 # [ 0.456700] ACPI: PCI: Interrupt link LNKB configured for IRQ 10347node1 # [ 0.457693] ACPI: PCI: Interrupt link LNKC configured for IRQ 11348node1 # [ 0.458693] ACPI: PCI: Interrupt link LNKD configured for IRQ 11349node1 # [ 0.459732] ACPI: PCI: Interrupt link LNKE configured for IRQ 10350node1 # [ 0.460696] ACPI: PCI: Interrupt link LNKF configured for IRQ 10351node1 # [ 0.461735] ACPI: PCI: Interrupt link LNKG configured for IRQ 11352node1 # [ 0.462693] ACPI: PCI: Interrupt link LNKH configured for IRQ 11353node1 # [ 0.463632] ACPI: PCI: Interrupt link GSIA configured for IRQ 16354node1 # [ 0.464646] ACPI: PCI: Interrupt link GSIB configured for IRQ 17355node1 # [ 0.465609] ACPI: PCI: Interrupt link GSIC configured for IRQ 18356node1 # [ 0.466608] ACPI: PCI: Interrupt link GSID configured for IRQ 19357node1 # [ 0.467606] ACPI: PCI: Interrupt link GSIE configured for IRQ 20358node1 # [ 0.468606] ACPI: PCI: Interrupt link GSIF configured for IRQ 21359node1 # [ 0.469605] ACPI: PCI: Interrupt link GSIG configured for IRQ 22360node1 # [ 0.470606] ACPI: PCI: Interrupt link GSIH configured for IRQ 23361node1 # [ 0.472586] iommu: Default domain type: Translated362node1 # [ 0.473477] iommu: DMA domain TLB invalidation policy: lazy mode363node1 # [ 0.474636] ACPI: bus type USB registered364node1 # [ 0.475398] usbcore: registered new interface driver usbfs365node1 # [ 0.476359] usbcore: registered new interface driver hub366node1 # [ 0.476603] usbcore: registered new device driver usb367node1 # [ 0.478410] NetLabel: Initializing368node1 # [ 0.479060] NetLabel: domain hash size = 128369node1 # [ 0.479593] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO370node1 # [ 0.480609] NetLabel: unlabeled traffic allowed by default371node1 # [ 0.481606] PCI: Using ACPI for IRQ routing372node1 # [ 0.525465] pci 0000:00:01.0: vgaarb: setting as boot VGA device373node1 # [ 0.525589] pci 0000:00:01.0: vgaarb: bridge control possible374node1 # [ 0.525589] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none375node1 # [ 0.525598] vgaarb: loaded376node1 # [ 0.526348] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0377node1 # [ 0.526593] hpet0: 3 comparators, 64-bit 100.000000 MHz counter378node1 # [ 0.531680] clocksource: Switched to clocksource kvm-clock379node1 # [ 0.535095] VFS: Disk quotas dquot_6.6.0380node1 # [ 0.535844] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)381node1 # [ 0.537272] pnp: PnP ACPI init382node1 # [ 0.538094] ACPI: IRQ 4 override to edge(!), high(!)383node1 # [ 0.539061] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved384node1 # [ 0.540615] pnp: PnP ACPI: found 5 devices385node1 # [ 0.548577] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns386node1 # [ 0.550094] clocksource: Switched to clocksource acpi_pm387node1 # [ 0.551109] NET: Registered PF_INET protocol family388node1 # [ 0.552198] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)389node1 # [ 0.568766] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)390node1 # [ 0.570351] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)391node1 # [ 0.571713] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)392node1 # [ 0.573100] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)393node1 # [ 0.574393] TCP: Hash tables configured (established 8192 bind 8192)394node1 # [ 0.575580] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)395node1 # [ 0.576931] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)396node1 # [ 0.578091] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)397node1 # [ 0.579361] NET: Registered PF_UNIX/PF_LOCAL protocol family398node1 # [ 0.580306] NET: Registered PF_XDP protocol family399node1 # [ 0.581170] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]400node1 # [ 0.582183] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]401node1 # [ 0.583212] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]402node1 # [ 0.584386] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]403node1 # [ 0.585546] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]404node1 # [ 0.586710] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]405node1 # [ 0.588494] ACPI: \_SB_.GSIA: Enabled at IRQ 16406node1 # [ 0.590740] ACPI: \_SB_.GSIB: Enabled at IRQ 17407node1 # [ 0.592808] ACPI: \_SB_.GSIC: Enabled at IRQ 18408node1 # [ 0.594938] ACPI: \_SB_.GSID: Enabled at IRQ 19409node1 # [ 0.596777] PCI: CLS 0 bytes, default 64410node1 # [ 0.597789] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns411node1 # [ 0.599595] Trying to unpack rootfs image as initramfs...412node1 # [ 0.645399] Initialise system trusted keyrings413node1 # [ 0.648382] workingset: timestamp_bits=40 max_order=18 bucket_order=0414node1 # [ 0.667610] Key type asymmetric registered415node1 # [ 0.672363] Asymmetric key parser 'x509' registered416node1 # [ 0.673206] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)417node1 # [ 0.676449] io scheduler mq-deadline registered418node1 # [ 0.677221] io scheduler kyber registered419node1 # [ 0.680871] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled420node1 # [ 0.682197] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A421node1 # [ 0.686074] Linux agpgart interface v0.103422node1 # [ 0.686928] ACPI: bus type drm_connector registered423node1 # [ 0.689731] usbcore: registered new interface driver usbserial_generic424node1 # [ 0.690873] usbserial: USB Serial support registered for generic425node1 # [ 0.695351] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.426node1 # [ 0.695351] Please enable it if your BIOS has the CPPC option.427node1 # [ 0.697683] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled428node1 # [ 0.700463] drop_monitor: Initializing network drop monitor service429node1 # [ 0.701677] NET: Registered PF_INET6 protocol family430node1 # [ 0.704753] Segment Routing with IPv6431node1 # [ 0.707370] In-situ OAM (IOAM) with IPv6432node1 # [ 0.708417] IPI shorthand broadcast: enabled433node1 # [ 0.716625] sched_clock: Marking stable (573015819, 143312018)->(793114974, -76787137)434node1 # [ 0.721543] registered taskstats version 1435node1 # [ 0.722517] Loading compiled-in X.509 certificates436node1 # [ 0.741334] Demotion targets for Node 0: null437node1 # [ 0.742205] Key type .fscrypt registered438node1 # [ 0.745331] Key type fscrypt-provisioning registered439node1 # [ 0.746281] ima: No TPM chip found, activating TPM-bypass!440node1 # [ 0.747247] ima: Allocated hash algorithm: sha1441node1 # [ 0.749365] ima: No architecture policies found442node1 # [ 0.751347] PM: Magic number: 10:714:471443node1 # [ 0.752914] RAS: Correctable Errors collector initialized.444node1 # [ 0.762985] clk: Disabling unused clocks445node1 # [ 0.765339] PM: genpd: Disabling unused power domains446node1 # [ 0.920433] Freeing initrd memory: 29088K447node1 # [ 0.923669] Freeing unused decrypted memory: 2028K448node1 # [ 0.926291] Freeing unused kernel image (initmem) memory: 3656K449node1 # [ 0.927466] Write protecting the kernel read-only data: 32768k450node1 # [ 0.929307] Freeing unused kernel image (text/rodata gap) memory: 1168K451node1 # [ 0.930818] Freeing unused kernel image (rodata/data gap) memory: 676K452node1 # [ 0.981648] x86/mm: Checked W+X mappings: passed, no W+X pages found.453node1 # [ 0.982775] Run /init as init process454node1 # [ 0.993416] systemd[1]: Inserted module 'autofs4'455node1 # [ 1.013000] fuse: init (API version 7.45)456node1 # [ 1.020393] ACPI: \_SB_.GSIG: Enabled at IRQ 22457node1 # [ 1.022707] ACPI: \_SB_.GSIH: Enabled at IRQ 23458node1 # [ 1.025936] ACPI: \_SB_.GSIE: Enabled at IRQ 20459node1 # [ 1.027964] ACPI: \_SB_.GSIF: Enabled at IRQ 21460node1 # [ 1.033111] virtiofs virtio5: discovered new tag: nix-store461node1 # [ 1.034637] virtiofs virtio5: virtio_fs_setup_dax: No cache capability462node1 # [ 1.041640] virtiofs virtio6: discovered new tag: shared463node1 # [ 1.043399] virtiofs virtio6: virtio_fs_setup_dax: No cache capability464node1 # [ 1.046698] virtiofs virtio7: discovered new tag: xchg465node1 # [ 1.048156] virtiofs virtio7: virtio_fs_setup_dax: No cache capability466node1 # [ 1.070711] systemd[1]: Successfully made /usr/ read-only.467node1 # [ 1.407707] 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)468node1 # [ 1.419588] systemd[1]: Detected virtualization kvm.469node1 # [ 1.421720] systemd[1]: Detected architecture x86-64.470node1 # [ 1.423840] systemd[1]: Running in initrd.471node1 # [ 1.426390] systemd[1]: Initializing machine ID from random generator.472node1 # [ 1.429187] systemd[1]: Hostname set to <node1>.473node1 # [ 1.639755] systemd[1]: bpf-restrict-fs: LSM BPF program attached474node1 # [ 1.678626] systemd[1]: Queued start job for default target Initrd Default Target.475node1 # [ 1.682680] systemd[1]: Created slice Slice /system/modprobe.476node1 # [ 1.683894] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.477node1 # [ 1.685334] systemd[1]: Expecting device /dev/disk/by-label/nixos...478node1 # [ 1.686464] systemd[1]: Reached target Path Units.479node1 # [ 1.687371] systemd[1]: Reached target Slice Units.480node1 # [ 1.688232] systemd[1]: Reached target Swaps.481node1 # [ 1.689033] systemd[1]: Reached target Timer Units.482node1 # [ 1.690052] systemd[1]: Listening on D-Bus System Message Bus Socket.483node1 # [ 1.691338] systemd[1]: Listening on Journal Socket (/dev/log).484node1 # [ 1.692537] systemd[1]: Listening on Journal Sockets.485node1 # [ 1.693572] systemd[1]: Listening on udev Control Socket.486node1 # [ 1.694649] systemd[1]: Listening on udev Kernel Socket.487node1 # [ 1.695651] systemd[1]: Reached target Socket Units.488node1 # [ 1.697530] systemd[1]: Starting Create List of Static Device Nodes...489node1 # [ 1.701398] systemd[1]: Starting Load Kernel Module configfs...490node1 # [ 1.710522] systemd[1]: Starting Journal Service...491node1 # [ 1.737515] systemd[1]: Starting Load Kernel Modules...492node1 # [ 1.741425] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os493node1 # [ 1.748395] systemd[1]: Starting Coldplug All udev Devices...494node1 # [ 1.760942] systemd-journald[65]: Collecting audit messages is disabled.495node1 # [ 1.762105] systemd[1]: Finished Create List of Static Device Nodes.496node1 # [ 1.768254] systemd[1]: modprobe@configfs.service: Deactivated successfully.497node1 # [ 1.774576] systemd[1]: Finished Load Kernel Module configfs.498node1 # [ 1.778725] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config499node1 # [ 1.791417] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...500node1 # [ 1.804376] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.501node1 # [ 1.813476] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev502node1 # [ 1.831924] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.503node1 # [ 1.840598] systemd[1]: Starting Create Static Device Nodes in /dev...504node1 # [ 1.854387] systemd[1]: Finished Load Kernel Modules.505node1 # [ 1.863536] systemd[1]: Starting Apply Kernel Variables...506node1 # [ 1.882590] systemd[1]: Started Journal Service.507node1 # [ 1.738736] systemd-modules-load[67]: Inserted module 'dm_mod'508node1 # [ 1.740938] systemd-modules-load[67]: Inserted module 'virtio_balloon'509node1 # [ 1.744288] systemd-modules-load[67]: Inserted module 'virtio_gpu'510node1 # [ 1.749975] systemd[1]: Finished Create Static Device Nodes in /dev.511node1 # [ 1.757133] systemd[1]: Reached target Preparation for Local File Systems.512node1 # [ 1.758138] systemd[1]: Reached target Local File Systems.513node1 # [ 1.761063] systemd[1]: Starting Create System Files and Directories...514node1 # [ 1.766066] systemd[1]: Starting Rule-based Manager for Device Events and Files...515node1 # [ 1.773117] systemd[1]: Finished Apply Kernel Variables.516node1 # [ 1.795178] systemd[1]: Finished Create System Files and Directories.517node1 # [ 1.817902] systemd-udevd[80]: Using default interface naming scheme 'v261'.518node1 # [ 1.843352] systemd[1]: Started Rule-based Manager for Device Events and Files.519node1 # [ 1.896991] systemd[1]: Finished Coldplug All udev Devices.520node1 # [ 1.899597] systemd[1]: Reached target System Initialization.521node1 # [ 1.900461] systemd[1]: Reached target Basic System.522node1 # [ 2.230134] virtio_blk virtio2: 1/0/0 default/read/poll queues523node1 # [ 2.239833] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)524node1 # [ 2.241762] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12525node1 # [ 2.247669] serio: i8042 KBD port at 0x60,0x64 irq 1526node1 # [ 2.248405] serio: i8042 AUX port at 0x60,0x64 irq 12527node1 # [ 2.254215] uhci_hcd 0000:00:1d.0: UHCI Host Controller528node1 # [ 2.266348] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1529node1 # [ 2.276079] uhci_hcd 0000:00:1d.0: detected 2 ports530node1 # [ 2.279263] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180531node1 # [ 2.285498] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18532node1 # [ 2.286680] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1533node1 # [ 2.294971] usb usb1: Product: UHCI Host Controller534node1 # [ 2.299722] usb usb1: Manufacturer: Linux 6.18.54 uhci_hcd535node1 # [ 2.304215] SCSI subsystem initialized536node1 # [ 2.305181] usb usb1: SerialNumber: 0000:00:1d.0537node1 # [ 2.306387] hub 1-0:1.0: USB hub found538node1 # [ 2.308109] hub 1-0:1.0: 2 ports detected539node1 # [ 2.311748] ehci-pci 0000:00:1d.7: EHCI Host Controller540node1 # [ 2.312544] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2541node1 # [ 2.314237] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000542node1 # [ 2.320365] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00543node1 # [ 2.322381] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18544node1 # [ 2.323517] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1545node1 # [ 2.326955] usb usb2: Product: EHCI Host Controller546node1 # [ 2.329341] usb usb2: Manufacturer: Linux 6.18.54 ehci_hcd547node1 # [ 2.330094] usb usb2: SerialNumber: 0000:00:1d.7548node1 # [ 2.333090] hub 2-0:1.0: USB hub found549node1 # [ 2.193660] systemd[1]: Starting Virtual Console Setup...550node1 # [ 2.337844] hub 2-0:1.0: 6 ports detected551node1 # [ 2.364078] hub 1-0:1.0: USB hub found552node1 # [ 2.366350] hub 1-0:1.0: 2 ports detected553node1 # [ 2.225690] systemd[1]: Found device /dev/disk/by-label/nixos.554node1 # [ 2.226887] systemd[1]: Reached target Initrd Root Device.555node1 # [ 2.371904] uhci_hcd 0000:00:1d.1: UHCI Host Controller556node1 # [ 2.372692] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3557node1 # [ 2.231314] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...558node1 # [ 2.386568] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0559node1 # [ 2.247742] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.560node1 # [ 2.252912] systemd[1]: Finished Virtual Console Setup.561node1 # [ 2.267238] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.562node1 # [ 2.413817] uhci_hcd 0000:00:1d.1: detected 2 ports563node1 # [ 2.276598] systemd-fsck[101]: nixos: clean, 12/65536 files, 13019/262144 blocks564node1 # [ 2.279155] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.565node1 # [ 2.282174] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.566node1 # [ 2.428528] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0567node1 # [ 2.286935] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.568node1 # [ 2.437524] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18569node1 # [ 2.438758] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1570node1 # [ 2.453138] usb usb3: Product: UHCI Host Controller571node1 # [ 2.454198] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd572node1 # [ 2.455342] usb usb3: SerialNumber: 0000:00:1d.1573node1 # [ 2.460754] hub 3-0:1.0: USB hub found574node1 # [ 2.461547] hub 3-0:1.0: 2 ports detected575node1 # [ 2.467507] uhci_hcd 0000:00:1d.2: UHCI Host Controller576node1 # [ 2.468297] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4577node1 # [ 2.472371] uhci_hcd 0000:00:1d.2: detected 2 ports578node1 # [ 2.473294] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0579node1 # [ 2.476737] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18580node1 # [ 2.479483] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1581node1 # [ 2.486597] usb usb4: Product: UHCI Host Controller582node1 # [ 2.487292] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd583node1 # [ 2.490015] usb usb4: SerialNumber: 0000:00:1d.2584node1 # [ 2.494237] hub 4-0:1.0: USB hub found585node1 # [ 2.495258] hub 4-0:1.0: 2 ports detected586node1 # [ 2.521525] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode587node1 # [ 2.524342] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)588node1 # [ 2.525216] ahci 0000:00:1f.2: flags: 64bit ncq only589node1 # [ 2.530542] scsi host0: ahci590node1 # [ 2.531665] scsi host1: ahci591node1 # [ 2.533821] scsi host2: ahci592node1 # [ 2.535414] scsi host3: ahci593node1 # [ 2.537120] scsi host4: ahci594node1 # [ 2.538841] scsi host5: ahci595node1 # [ 2.540055] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1596node1 # [ 2.541443] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1597node1 # [ 2.542679] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1598node1 # [ 2.543874] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1599node1 # [ 2.545054] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1600node1 # [ 2.546227] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1601node1 # [ 2.581429] usb 2-1: new high-speed USB device number 2 using ehci-pci602node1 # [ 2.710946] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00603node1 # [ 2.713870] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10604node1 # [ 2.717099] usb 2-1: Product: QEMU USB Tablet605node1 # [ 2.718890] usb 2-1: Manufacturer: QEMU606node1 # [ 2.720586] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1607node1 # [ 2.755268] hid: raw HID events driver (C) Jiri Kosina608node1 # [ 2.618246] systemd[1]: Mounting /sysroot...609node1 # [ 2.861348] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)610node1 # [ 2.863811] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100611node1 # [ 2.866299] ata3.00: applying bridge limits612node1 # [ 2.868252] ata1: SATA link down (SStatus 0 SControl 300)613node1 # [ 2.870629] ata2: SATA link down (SStatus 0 SControl 300)614node1 # [ 2.872990] ata4: SATA link down (SStatus 0 SControl 300)615node1 # [ 2.875357] ata6: SATA link down (SStatus 0 SControl 300)616node1 # [ 2.877508] ata5: SATA link down (SStatus 0 SControl 300)617node1 # [ 2.879870] ata3.00: configured for UDMA/100618node1 # [ 2.883408] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5619node1 # [ 2.958459] usbcore: registered new interface driver usbhid620node1 # [ 2.959253] usbhid: USB HID core driver621node1 # [ 2.980588] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray622node1 # [ 2.988571] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input2623node1 # [ 2.993050] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0624node1 # [ 2.997530] cdrom: Uniform CD-ROM driver Revision: 3.20625node1 # [ 3.009517] EXT4-fs (vda): mounted filesystem d1cdc38b-ba76-4a3b-a028-f5eb3fa2f2a2 r/w with ordered data mode. Quota mode: none.626node1 # [ 2.872875] systemd[1]: Mounted /sysroot.627node1 # [ 2.874382] systemd[1]: Reached target Initrd Root File System.628node1 # [ 2.877454] systemd[1]: Starting Mountpoints Configured in the Real Root...629node1 # [ 2.893981] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.630node1 # [ 2.897107] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...631node1 # [ 2.898596] systemd[1]: Reloading...632node1 # [ 2.980163] systemd[1]: Reloading finished in 80 ms.633node1 # [ 2.988256] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...634node1 # [ 2.993159] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...635node1 # [ 2.997158] systemd[1]: initrd-parse-etc.service: Deactivated successfully.636node1 # [ 2.998504] systemd[1]: Finished Mountpoints Configured in the Real Root.637node1 # [ 2.999554] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.638node1 # [ 3.618323] systemd[1]: Mounting /sysroot/nix/.ro-store...639node1 # [ 3.626155] systemd[1]: Mounting /sysroot/nix/.rw-store...640node1 # [ 3.631290] systemd[1]: Mounting /sysroot/run...641node1 # [ 3.645163] systemd[1]: Mounting /sysroot/tmp/shared...642node1 # [ 3.657155] systemd[1]: Mounting /sysroot/tmp/xchg...643node1 # [ 3.691408] systemd[1]: Mounted /sysroot/nix/.rw-store.644node1 # [ 3.696485] systemd[1]: Mounted /sysroot/nix/.ro-store.645node1 # [ 3.700332] systemd[1]: Mounted /sysroot/run.646node1 # [ 3.702075] systemd[1]: Mounted /sysroot/tmp/shared.647node1 # [ 3.704088] systemd[1]: Mounted /sysroot/tmp/xchg.648node1 # [ 3.707788] systemd[1]: Starting rw-sysroot-nix-store.service...649node1 # [ 3.718392] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.650node1 # [ 3.719895] systemd[1]: Finished rw-sysroot-nix-store.service.651node1 # [ 3.722234] systemd[1]: Mounting /sysroot/nix/store...652node1 # [ 3.743882] systemd[1]: Mounted /sysroot/nix/store.653node1 # [ 3.744925] systemd[1]: Reached target Initrd File Systems.654node1 # [ 3.746561] systemd[1]: Starting Find NixOS closure...655node1 # [ 3.750135] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...656node1 # [ 3.767240] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.657node1 # [ 3.774262] systemd[1]: Finished Find NixOS closure.658node1 # [ 3.775522] systemd[1]: Reached target Initrd Default Target.659node1 # [ 3.777516] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...660node1 # [ 3.791579] systemd[1]: Stopped target Initrd Default Target.661node1 # [ 3.792829] systemd[1]: Stopped target Basic System.662node1 # [ 3.795059] systemd[1]: Stopped target Initrd Root Device.663node1 # [ 3.795798] systemd[1]: Stopped target Path Units.664node1 # [ 3.796517] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.665node1 # [ 3.797523] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.666node1 # [ 3.798541] systemd[1]: Stopped target Slice Units.667node1 # [ 3.799270] systemd[1]: Stopped target Socket Units.668node1 # [ 3.799939] systemd[1]: Stopped target System Initialization.669node1 # [ 3.800950] systemd[1]: Stopped target Swaps.670node1 # [ 3.801635] systemd[1]: Stopped target Timer Units.671node1 # [ 3.803115] systemd[1]: dbus.socket: Deactivated successfully.672node1 # [ 3.803897] systemd[1]: Closed D-Bus System Message Bus Socket.673node1 # [ 3.804762] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.674node1 # [ 3.805774] systemd[1]: Stopped Find NixOS closure.675node1 # [ 3.806970] systemd[1]: Starting rw-sysroot-nix-store.service...676node1 # [ 3.808142] systemd[1]: systemd-sysctl.service: Deactivated successfully.677node1 # [ 3.809335] systemd[1]: Stopped Apply Kernel Variables.678node1 # [ 3.810377] systemd[1]: systemd-modules-load.service: Deactivated successfully.679node1 # [ 3.812249] systemd[1]: Stopped Load Kernel Modules.680node1 # [ 3.813204] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.681node1 # [ 3.814449] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.682node1 # [ 3.815835] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.683node1 # [ 3.816989] systemd[1]: Stopped Create System Files and Directories.684node1 # [ 3.819152] systemd[1]: Stopped target Local File Systems.685node1 # [ 3.820154] systemd[1]: Stopped target Preparation for Local File Systems.686node1 # [ 3.821217] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.687node1 # [ 3.823123] systemd[1]: Stopped Coldplug All udev Devices.688node1 # [ 3.823844] systemd[1]: Stopping Rule-based Manager for Device Events and Files...689node1 # [ 3.825504] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.690node1 # [ 3.826882] systemd[1]: Stopped Virtual Console Setup.691node1 # [ 3.839088] systemd[1]: initrd-cleanup.service: Deactivated successfully.692node1 # [ 3.839987] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.693node1 # [ 3.844112] systemd[1]: systemd-udevd.service: Deactivated successfully.694node1 # [ 3.845473] systemd[1]: Stopped Rule-based Manager for Device Events and Files.695node1 # [ 3.849170] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.696node1 # [ 3.850168] systemd[1]: Closed udev Control Socket.697node1 # [ 3.852068] systemd[1]: Starting Cleanup udev Database...698node1 # [ 3.852822] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.699node1 # [ 3.853921] systemd[1]: Stopped Create Static Device Nodes in /dev.700node1 # [ 3.854823] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.701node1 # [ 3.856127] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.702node1 # [ 3.858081] systemd[1]: kmod-static-nodes.service: Deactivated successfully.703node1 # [ 3.858962] systemd[1]: Stopped Create List of Static Device Nodes.704node1 # [ 3.860310] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.705node1 # [ 3.861353] systemd[1]: Finished rw-sysroot-nix-store.service.706node1 # [ 3.875945] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.707node1 # [ 3.877542] systemd[1]: Finished Cleanup udev Database.708node1 # [ 3.879152] systemd[1]: Reached target Switch Root.709node1 # [ 3.880806] systemd[1]: Starting NixOS Activation...710node1 # [ 3.940982] initrd-nixos-activation-start[188]: booting system configuration /nix/store/zfn42jq0q2r06gignc2y6g2irpndiaxn-nixos-system-node1-test711node1 # [ 3.964692] initrd-nixos-activation-start[188]: running activation script...712node1 # [ 4.130952] initrd-nixos-activation-start[211]: setting up /etc...713node1 # [ 4.227482] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.714node1 # [ 4.229977] systemd[1]: Finished NixOS Activation.715node1 # [ 4.230884] systemd[1]: Starting Switch Root...716node1 # [ 4.243711] systemd[1]: Switching root.717node1 # [ 4.520437] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).718node1 # [ 4.629071] NET: Registered PF_VSOCK protocol family719node1 # [ 4.988692] 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)720node1 # [ 4.999018] systemd[1]: Detected virtualization kvm.721node1 # [ 5.000943] systemd[1]: Detected architecture x86-64.722node1 # [ 5.002989] systemd[1]: Detected first boot.723node1 # [ 5.007388] systemd[1]: Initializing machine ID from random generator.724node1 # [ 5.244797] systemd[1]: bpf-restrict-fs: LSM BPF program attached725node1 # [ 5.342622] systemd[1]: Applying preset policy.726node1 # [ 5.505838] systemd[1]: Populated /etc with preset unit settings.727node1 # [ 5.705153] systemd[1]: initrd-switch-root.service: Deactivated successfully.728node1 # [ 5.706464] systemd[1]: Stopped initrd-switch-root.service.729node1 # [ 5.708684] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.730node1 # [ 5.710678] systemd[1]: Created slice Slice /system/getty.731node1 # [ 5.712055] systemd[1]: Created slice User and Session Slice.732node1 # [ 5.712988] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.733node1 # [ 5.714158] systemd[1]: Started Forward Password Requests to Wall Directory Watch.734node1 # [ 5.715217] systemd[1]: Expecting device /dev/hvc0...735node1 # [ 5.715891] systemd[1]: Expecting device /dev/ttyS0...736node1 # [ 5.716685] systemd[1]: Reached target Local Encrypted Volumes.737node1 # [ 5.717512] systemd[1]: Stopped target initrd-fs.target.738node1 # [ 5.718203] systemd[1]: Stopped target initrd-root-fs.target.739node1 # [ 5.718959] systemd[1]: Stopped target initrd-switch-root.target.740node1 # [ 5.719798] systemd[1]: Reached target Virtual Machines and Containers.741node1 # [ 5.720712] systemd[1]: Reached target Path Units.742node1 # [ 5.721417] systemd[1]: Reached target Remote File Systems.743node1 # [ 5.722179] systemd[1]: Reached target Slice Units.744node1 # [ 5.722883] systemd[1]: Reached target Swaps.745node1 # [ 5.724788] systemd[1]: Listening on Query the User Interactively for a Password.746node1 # [ 5.727242] systemd[1]: Listening on Process Core Dump Socket.747node1 # [ 5.740760] systemd[1]: Listening on Credential Encryption/Decryption.748node1 # [ 5.742721] systemd[1]: Listening on Factory Reset Management.749node1 # [ 5.743648] systemd[1]: Listening on Hostname Service Socket.750node1 # [ 5.746553] systemd[1]: Starting Journal Log Access Socket...751node1 # [ 5.747743] systemd[1]: Listening on Journal Audit Socket.752node1 # [ 5.750285] systemd[1]: Listening on Console Output Muting Service Socket.753node1 # [ 5.751765] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.754node1 # [ 5.752863] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os755node1 # [ 5.754133] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki756node1 # [ 5.758282] systemd[1]: Listening on Disk Repartitioning Service Socket.757node1 # [ 5.759316] systemd[1]: Listening on udev Control Socket.758node1 # [ 5.760143] systemd[1]: Listening on udev Varlink Socket.759node1 # [ 5.762213] systemd[1]: Mounting Huge Pages File System...760node1 # [ 5.764617] systemd[1]: Mounting POSIX Message Queue File System...761node1 # [ 5.770555] systemd[1]: Mounting Kernel Debug File System...762node1 # [ 5.776470] systemd[1]: Mounting Kernel Trace File System...763node1 # [ 5.782997] systemd[1]: Starting Create List of Static Device Nodes...764node1 # [ 5.792863] systemd[1]: Starting Load Kernel Module configfs...765node1 # [ 5.798210] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm766node1 # [ 5.806262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore767node1 # [ 5.817581] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse768node1 # [ 5.833668] systemd[1]: Mounting FUSE Control File System...769node1 # [ 5.839137] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67770node1 # [ 5.854062] systemd[1]: Starting Journal Service...771node1 # [ 5.860714] systemd[1]: Starting Load Kernel Modules...772node1 # [ 5.869910] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...773node1 # [ 5.881961] systemd[1]: Starting Remount Root and Kernel File Systems...774node1 # [ 5.886405] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os775node1 # [ 5.891756] systemd[1]: Starting Coldplug All udev Devices...776node1 # [ 5.901227] systemd[1]: Listening on Journal Log Access Socket.777node1 # [ 5.907279] systemd[1]: Mounted Huge Pages File System.778node1 # [ 5.911674] systemd-journald[281]: Collecting audit messages is enabled.779node1 # [ 5.914358] systemd[1]: Mounted POSIX Message Queue File System.780node1 # [ 5.915250] systemd[1]: Mounted Kernel Debug File System.781node1 # [ 5.920435] systemd[1]: Mounted Kernel Trace File System.782node1 # [ 5.925986] systemd[1]: Finished Create List of Static Device Nodes.783node1 # [ 5.931735] systemd[1]: modprobe@configfs.service: Deactivated successfully.784node1 # [ 5.938719] systemd[1]: Finished Load Kernel Module configfs.785node1 # [ 5.942251] systemd[1]: Mounted FUSE Control File System.786node1 # [ 5.803269] systemd[1]: Queued start job for default target Multi-User System.787node1 # [ 5.948065] systemd[1]: Started Journal Service.788node1 # [ 5.806912] systemd[1]: systemd-journald.service: Deactivated successfully.789node1 # [ 5.953814] loop: module loaded790node1 # [ 5.814930] systemd-modules-load[282]: Inserted module 'loop'791node1 # [ 5.824850] systemd[1]: Finished Load Kernel Modules.792node1 # [ 5.834355] systemd[1]: Mounting Kernel Configuration File System...793node1 # [ 5.840058] systemd[1]: Starting Firewall...794node1 # [ 5.986385] EXT4-fs (vda): re-mounted d1cdc38b-ba76-4a3b-a028-f5eb3fa2f2a2.795node1 # [ 5.846170] systemd[1]: Starting Apply Kernel Variables...796node1 # [ 5.859087] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...797node1 # [ 5.866899] systemd[1]: Finished Remount Root and Kernel File Systems.798node1 # [ 5.871785] systemd[1]: Listening on Disk Image Download Service Socket.799node1 # [ 5.882551] systemd-oomd[284]: No swap; memory pressure usage will be degraded800node1 # [ 5.888849] systemd[1]: Starting Flush Journal to Persistent Storage...801node1 # [ 5.890216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore802node1 # [ 5.901105] systemd[1]: Starting Load/Save OS Random Seed...803node1 # [ 5.901856] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os804node1 # [ 5.910063] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.805node1 # [ 5.969517] systemd[1]: Mounted Kernel Configuration File System.806node1 # [ 6.118093] systemd-journald[281]: Received client request to flush runtime journal.807node1 # [ 6.062432] systemd[1]: Finished Load/Save OS Random Seed.808node1 # [ 6.064738] systemd[1]: Reached target First Boot Complete.809node1 # [ 6.065732] systemd[1]: Finished Apply Kernel Variables.810node1 # [ 6.069529] systemd[1]: Finished Flush Journal to Persistent Storage.811node1 # [ 6.077156] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.812node1 # [ 6.083453] systemd[1]: Starting Create Static Device Nodes in /dev...813node1 # [ 6.160382] systemd[1]: Finished Coldplug All udev Devices.814node1 # [ 6.179447] systemd[1]: Finished Create Static Device Nodes in /dev.815node1 # [ 6.180682] systemd[1]: Reached target Preparation for Local File Systems.816node1 # [ 6.184042] systemd[1]: Starting Rule-based Manager for Device Events and Files...817node1 # [ 6.228346] systemd-udevd[324]: Using default interface naming scheme 'v261'.818node1 # [ 6.280249] systemd[1]: Started Rule-based Manager for Device Events and Files.819node1 # [ 6.395089] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse820node1 # [ 6.473521] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.821node1 # [ 6.491765] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.822node1 # [ 6.526910] (udev-worker)[348]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.823node1 # [ 6.529169] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.824node1 # [ 6.531633] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line.825node1 # [ 6.566766] systemd[1]: Mounting /run/wrappers...826node1 # [ 6.606213] systemd[1]: Mounted /run/wrappers.827node1 # [ 6.606910] systemd[1]: Reached target Local File Systems.828node1 # [ 6.610211] systemd[1]: Listening on Boot Loader Control Service Socket.829node1 # [ 6.615126] systemd[1]: Starting register-nix-paths.service...830node1 # [ 6.623127] systemd[1]: Starting Create SUID/SGID Wrappers...831node1 # [ 6.623904] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.832node1 # [ 6.631660] systemd[1]: Starting Save Transient machine-id to Disk...833node1 # [ 6.644624] systemd[1]: Starting Create System Files and Directories...834node1 # [ 6.731954] systemd[1]: Condition check resulted in Virtio network device being skipped.835node1 # [ 6.736502] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.836node1 # [ 6.744691] systemd[1]: Finished Save Transient machine-id to Disk.837node1 # [ 6.745633] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore838node1 # [ 6.747728] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.839node1 # [ 6.749674] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67840node1 # [ 6.754207] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore841node1 # [ 6.756437] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os842node1 # [ 6.758242] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os843node1 # [ 6.795632] systemd[1]: Finished Create System Files and Directories.844node1 # [ 6.803171] systemd[1]: Starting Rebuild Journal Catalog...845node1 # [ 6.806971] systemd[1]: Starting Record System Boot/Shutdown in UTMP...846node1 # [ 6.903867] systemd[1]: Finished Record System Boot/Shutdown in UTMP.847node1 # [ 6.934086] systemd[1]: Finished Rebuild Journal Catalog.848node1 # [ 6.941070] systemd[1]: Starting Update is Completed...849node1 # [ 6.995579] systemd[1]: Finished Update is Completed.850node1 # [ 7.145947] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3851node1 # [ 7.180709] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console852node1 # [ 7.220156] mousedev: PS/2 mouse device common for all mice853node1 # [ 7.237429] ACPI: button: Power Button [PWRF]854node1 # [ 7.298072] rtc_cmos PNP0B00:00: RTC can wake from S4855node1 # [ 7.250851] systemd[1]: Finished Firewall.856node1 # [ 7.347212] rtc_cmos PNP0B00:00: registered as rtc0857node1 # [ 7.347274] rtc_cmos PNP0B00:00: setting system clock to 2026-09-27T07:28:42 UTC (1790494122)858node1 # [ 7.347564] systemd-journald[281]: Time jumped backwards, rotating.859node1 # [ 7.350120] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs860node1 # [ 7.375018] parport_pc 00:02: reported by Plug and Play ACPI861node1 # [ 7.375105] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]862node1 # [ 7.388887] Console: switching to colour dummy device 80x25863node1 # [ 7.395696] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4864node1 # [ 7.465243] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized865node1 # [ 7.493835] [drm] Found bochs VGA, ID 0xb0c5.866node1 # [ 7.493837] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.867node1 # [ 7.352403] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.868node1 # [ 7.354937] systemd[1]: Finished Create SUID/SGID Wrappers.869node1 # [ 7.366818] systemd[1]: Finished register-nix-paths.service.870node1 # [ 7.367726] systemd[1]: Reached target System Initialization.871node1 # [ 7.370068] systemd[1]: Started Discard unused filesystem blocks once a week.872node1 # [ 7.370993] systemd[1]: Started Daily Cleanup of Temporary Directories.873node1 # [ 7.371867] systemd[1]: Reached target Timer Units.874node1 # [ 7.372655] systemd[1]: Listening on D-Bus System Message Bus Socket.875node1 # [ 7.373496] systemd[1]: Listening on Nix Daemon Socket.876node1 # [ 7.374959] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.877node1 # [ 7.376039] systemd[1]: Reached target Socket Units.878node1 # [ 7.376692] systemd[1]: Reached target Basic System.879node1 # [ 7.380081] systemd[1]: Started backdoor.service.880node1 # [ 7.382054] systemd[1]: Starting Import lastlog data into lastlog2 database...881node1 # [ 7.533456] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic882node1 # [ 7.534093] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0883node1 # [ 7.392735] systemd[1]: Starting Name Service Cache Daemon (nsncd)...884node1 # [ 7.401894] systemd[1]: Starting Post-Boot Actions...885node1 # [ 7.411195] systemd[1]: Started Reset console on configuration changes.886node1 # [ 7.413777] systemd[1]: Starting resolvconf update...887node1 # [ 7.448824] systemd[1]: Starting D-Bus System Message Bus...888node1 # connecting to host...889node1 # [ 7.647565] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt890node1 # [ 7.648217] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD891node1 # [ 7.507346] systemd[1]: Finished Post-Boot Actions.892node1 # [ 7.510368] nsncd[508]: Sep 27 07:28:42.805 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"893node1 # [ 7.515277] systemd[1]: Started Name Service Cache Daemon (nsncd).894node1 # [ 7.519524] systemd[1]: Reached target Host and Network Name Lookups.895node1 # [ 7.520397] systemd[1]: Reached target User and Group Name Lookups.896node1: Guest shell says: b'Spawning backdoor root shell...\n'897node1 # [ 7.537901] systemd[1]: Starting User Login Management...898node1: connected to guest root shell899node1: (connecting took 8.27 seconds)900node1: (finished: waiting for the VM to finish booting, in 8.27 seconds)901node1 # [ 7.561666] systemd[1]: Finished Import lastlog data into lastlog2 database.902node1 # [ 7.642132] dbus-broker-launch[513]: Looking up NSS user entry for 'systemd-timesync'...903node1 # [ 7.651086] dbus-broker-launch[513]: NSS returned no entry for 'systemd-timesync'904node1 # [ 7.651981] dbus-broker-launch[513]: Invalid user-name in /nix/store/hb0f0mk2xfb4zfycqkygxi5lgxmr8pbx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"905node1 # [ 7.776976] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6906node1 # [ 7.779211] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5907node1 # [ 7.820842] Console: switching to colour frame buffer device 160x50908node1 # [ 7.918917] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device909node1 # [ 7.695056] systemd[1]: Started D-Bus System Message Bus.910node1 # [ 7.779349] systemd[1]: Stopped target Host and Network Name Lookups.911node1 # [ 7.781766] systemd[1]: Stopping Host and Network Name Lookups...912node1 # [ 7.783671] systemd[1]: Stopped target User and Group Name Lookups.913node1 # [ 7.786517] systemd[1]: Stopping User and Group Name Lookups...914node1 # [ 7.787287] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...915node1 # [ 7.788039] systemd[1]: nscd.service: Deactivated successfully.916node1 # [ 7.788741] systemd[1]: Stopped Name Service Cache Daemon (nsncd).917node1 # [ 7.789694] dbus-broker-launch[513]: Ready918node1 # [ 7.795770] systemd[1]: Starting Name Service Cache Daemon (nsncd)...919node1 # [ 7.798808] systemd[1]: Starting Virtual Console Setup...920node1 # [ 7.800567] systemd-logind[534]: New seat seat0.921node1 # [ 7.806481] systemd[1]: Started User Login Management.922node1 # [ 7.821066] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)923node1 # [ 7.823097] systemd[1]: Starting linger-users.service...924node1 # [ 7.853032] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button)925node1 # [ 7.863890] nsncd[588]: Sep 27 07:28:43.157 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"926node1 # [ 7.865709] systemd[1]: Started Name Service Cache Daemon (nsncd).927node1 # [ 7.866972] systemd[1]: Reached target Host and Network Name Lookups.928node1 # [ 7.868406] systemd[1]: Reached target User and Group Name Lookups.929node1 # [ 7.885384] systemd[1]: Finished resolvconf update.930node1 # [ 7.886115] systemd[1]: Reached target Preparation for Network.931node1 # [ 7.894459] systemd[1]: Starting DHCP Client...932node1 # [ 7.903541] systemd[1]: Starting Address configuration of eth1...933node1 # [ 7.912310] systemd[1]: Starting Extra networking commands....934node1 # [ 7.914268] systemd[1]: linger-users.service: Deactivated successfully.935node1 # [ 7.921980] systemd[1]: Finished linger-users.service.936node1 # [ 7.949060] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.937node1 # [ 7.952333] systemd[1]: Stopped Virtual Console Setup.938node1 # [ 7.976357] systemd[1]: Starting Virtual Console Setup...939node1 # [ 8.212097] ppdev: user-space parallel port driver940node1 # [ 8.072867] network-addresses-eth1-start[615]: adding address 192.168.1.1/24... done941node1 # [ 8.093165] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)942node1 # [ 8.100557] network-addresses-eth1-start[615]: adding address 2001:db8:1::1/64... done943node1 # [ 8.134812] systemd[1]: Finished Address configuration of eth1.944node1 # [ 8.388622] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)945node1 # [ 8.251718] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.946node1 # [ 8.253886] dhcpcd[631]: dhcpcd-10.3.2 starting947node1 # [ 8.255579] systemd[1]: Stopped Virtual Console Setup.948node1 # [ 8.268555] dhcpcd[686]: dev: loaded udev949node1 # [ 8.270208] systemd[1]: Starting Virtual Console Setup...950node1 # [ 8.277180] systemd[1]: Finished Extra networking commands..951node1 # [ 8.284392] systemd[1]: Reached target Network.952node1 # [ 8.428588] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)953node1 # [ 8.295072] systemd[1]: Starting Permit User Sessions...954node1 # [ 8.458083] 8021q: 802.1Q VLAN Support v1.8955node1 # [ 8.458566] 8021q: adding VLAN 0 to HW filter on device eth1956node1: (finished: must succeed: buildbot-effects --help, in 9.08 seconds)957(finished: run the VM test script, in 9.50 seconds)958node1 # [ 8.370313] systemd[1]: Finished Permit User Sessions.959node1 # [ 8.379348] systemd[1]: Started Getty on tty1.960node1 # [ 8.379970] systemd[1]: Reached target Login Prompts.961node1 # [ 8.423271] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.962node1 # [ 8.647050] kvm_amd: TSC scaling supported963node1 # [ 8.647528] kvm_amd: Nested Virtualization enabled964node1 # [ 8.647949] kvm_amd: Nested Paging enabled965node1 # [ 8.649374] kvm_amd: LBR virtualization supported966node1 # [ 8.649804] kvm_amd: Virtual VMLOAD VMSAVE supported967node1 # [ 8.650248] kvm_amd: Virtual GIF supported968node1 # [ 8.651374] cfg80211: Loading compiled-in X.509 certificates for regulatory database969node1 # [ 8.652768] kvm_amd: Virtual NMI enabled970node1 # [ 8.675526] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'971node1 # [ 8.676175] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'972node1 # [ 8.678093] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2973node1 # [ 8.678930] cfg80211: failed to load regulatory.db974node1 # [ 8.688200] EDAC MC: Ver: 3.0.0975node1 # [ 8.716045] 8021q: adding VLAN 0 to HW filter on device eth0976node1 # [ 8.573853] dhcpcd[686]: eth0: waiting for carrier977node1 # [ 8.574953] dhcpcd[686]: libudev: received NULL device978node1 # [ 8.575737] dhcpcd[686]: libudev: received NULL device979node1 # [ 8.576668] dhcpcd[686]: eth0: carrier acquired980node1 # [ 8.582083] dhcpcd[686]: DUID 00:01:00:01:32:4b:82:2b:52:54:00:12:34:56981node1 # [ 8.582940] dhcpcd[686]: eth0: IAID 00:12:34:56982node1 # [ 8.583857] dhcpcd[686]: eth0: adding address fe80::5054:ff:fe12:3456983test script finished in 9.73s984cleanup985kill QemuMachine (pid 46)986node1 # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)987node1 # [2026-09-27T07:28:44Z INFO virtiofsd] Client disconnected, shutting down988node1 # [2026-09-27T07:28:44Z INFO virtiofsd] Client disconnected, shutting down989node1 # [2026-09-27T07:28:44Z INFO virtiofsd] Client disconnected, shutting down990(finished: cleanup, in 0.18 seconds)991additionally exposed symbols:992 node1,993 vlan1,994 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_ssh