tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.87qDpQqerE', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: abeb34fd-9ed9-4fde-8234-2d6e9cca0802 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Formatting '/build/vm-state-machine/machine-esp.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=273695232 backing_file=/nix/store/hij4k3am2jgkml0vqf8ah3gix7kp41dg-machine-esp-image/esp.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16 machine # Formatting 'empty0.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=536870912 lazy_refcounts=off refcount_bits=16 machine # Starting virtiofs daemons... machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980) machine: Guest shell says: b'\x1b[2J\x1b[001;001H\x1b[=3h\x1b[2J\x1b[001;001H\x1b[2J\x1b[001;001H\x1b[8;042;160t\x1b[2J\x1b[001;001H' machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0) machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0)\r\n' machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0) machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0)\r\n' machine: Guest shell says: b'\r \r\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H\x1b[020;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m' machine: Guest shell says: b' NixOS (boot-luks) \x1b[021;063H\x1b[1m\x1b[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS \x1b[022;063H\x1b[1m\x1b[37' machine: Guest shell says: b'm\x1b[40m\x1b[0m\x1b[37m\x1b[40m Reboot Into Firmware Interface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m ' machine: Guest shell says: b' Boot in 5s. \x1b[0' machine: Guest shell says: b'23;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m------------------------------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------' machine: Guest shell says: b'---------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------' machine: Guest shell says: b'---------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m' machine: Guest shell says: b'\x1b[0m\x1b[37m\x1b[40m------------------------------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------' machine: Guest shell says: b'---------------------' machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H' machine # NixOS (boot-luks) NixOS Reboot Into Firmware Interface Boot in 5s. ------------------------------------------ Boot in 4s. ------------------------------------------ Boot in 3s. ------------------------------------------ Boot in 2s. ------------------------------------------ Boot in 1s. ------------------------------------------[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 14 11:36:19 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] efi: EFI v2.7 by EDK II machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fe0000 MEMATTR=0x45ac8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a65018 INITRD=0x45a76418 MEMRESERVE=0x45ac2218 machine # [ 0.000000] random: crng init done machine # [ 0.000000] ACPI: Early table checksum verification disabled machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS ) machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013) machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001822 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013) machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,9600 machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf2880-0x7fdf5fff] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045fcffff] machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff] machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff] machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff] machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff] machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff] machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff] machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff] machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from ACPI. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\qwk9l5xaljlwrnczkgkdw07y5k1hy7zm-initrd-linux-6.18.52-initrd.efi init=/nix/store/9g66rzbsim06c9hz73xcqpnvr1ihsfci-nixos-system-machine-test/init console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74950 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000040910000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000040920000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000044] arm-pv: using stolen time PV machine # [ 0.001125] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.001237] Console: colour dummy device 80x25 machine # [ 0.001242] printk: legacy console [tty0] enabled machine # [ 0.001470] ACPI: Core revision 20250807 machine # [ 0.001586] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.001594] pid_max: default: 32768 minimum: 301 machine # [ 0.001664] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001969] landlock: Up and running. machine # [ 0.001974] Yama: becoming mindful. machine # [ 0.003377] LSM support for eBPF active machine # [ 0.003571] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003579] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.004862] rcu: Hierarchical SRCU implementation. machine # [ 0.004868] rcu: Max phase no-delay instances is 1000. machine # [ 0.005607] fsl-mc MSI: ITS@0x8080000 domain created machine # [ 0.005635] Remapping and enabling EFI services. machine # [ 0.005833] smp: Bringing up secondary CPUs ... machine # [ 0.005843] smp: Brought up 1 node, 1 CPU machine # [ 0.005846] SMP: Total of 1 processors activated. machine # [ 0.005850] CPU: All CPU(s) started at EL1 machine # [ 0.005861] CPU features: detected: Branch Target Identification machine # [ 0.005867] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005870] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005873] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005877] CPU features: detected: Common not Private translations machine # [ 0.005880] CPU features: detected: CRC32 instructions machine # [ 0.005883] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005886] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005890] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005893] CPU features: detected: E0PD machine # [ 0.005896] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005899] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005903] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005905] CPU features: detected: Fine Grained Traps machine # [ 0.005909] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005914] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005917] CPU features: detected: LSE atomic instructions machine # [ 0.005920] CPU features: detected: Privileged Access Never machine # [ 0.005923] CPU features: detected: PMUv3 machine # [ 0.005925] CPU features: detected: RAS Extension Support machine # [ 0.005928] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005931] CPU features: detected: Random Number Generator machine # [ 0.005934] CPU features: detected: Speculation barrier (SB) machine # [ 0.005937] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005940] CPU features: detected: TLB range maintenance instructions machine # [ 0.005945] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005994] alternatives: applying system-wide alternatives machine # [ 0.009024] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009210] Memory: 886652K/1048576K available (24448K kernel code, 7094K rwdata, 26372K rodata, 4736K init, 1107K bss, 120372K reserved, 32768K cma-reserved) machine # [ 0.009606] devtmpfs: initialized machine # [ 0.010598] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010608] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010801] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010806] 0 pages in range for non-PLT usage machine # [ 0.010807] 508272 pages in range for PLT usage machine # [ 0.010898] pinctrl core: initialized pinctrl subsystem machine # [ 0.011550] SMBIOS 3.0.0 present. machine # [ 0.011556] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 machine # [ 0.011565] DMI: Memory slots populated: 1/1 machine # [ 0.014559] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.015271] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.015439] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.015628] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.015652] audit: initializing netlink subsys (disabled) machine # [ 0.016106] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.016108] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.016112] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.016115] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.016118] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.016146] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 machine # [ 0.016160] cpuidle: using governor ladder machine # [ 0.016169] cpuidle: using governor menu machine # [ 0.016342] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.016364] ASID allocator initialised with 65536 entries machine # [ 0.017309] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.017530] Serial: AMBA PL011 UART driver machine # [ 0.025362] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.025369] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.025372] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.025375] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.025378] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.025384] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.025387] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.025390] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.026343] fbcon: Taking over console machine # [ 0.026382] ACPI: Added _OSI(Module Device) machine # [ 0.026386] ACPI: Added _OSI(Processor Device) machine # [ 0.026388] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.027462] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.033205] ACPI: Interpreter enabled machine # [ 0.033211] ACPI: Using GIC for interrupt routing machine # [ 0.033245] ACPI: MCFG table detected, 1 entries machine # [ 0.037600] ACPI: CPU0 has been hot-added machine # [ 0.038042] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA machine # [ 0.038119] printk: console [ttyAMA0] enabled machine # [ 0.095361] ACPI: PCI: Interrupt link L000 configured for IRQ 35 machine # [ 0.095381] ACPI: PCI: Interrupt link L001 configured for IRQ 36 machine # [ 0.095395] ACPI: PCI: Interrupt link L002 configured for IRQ 37 machine # [ 0.095409] ACPI: PCI: Interrupt link L003 configured for IRQ 38 machine # [ 0.095431] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.095475] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.095575] acpi PNP0A08:00: _OSC: platform does not support [LTR] machine # [ 0.095679] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] machine # [ 0.095961] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 machine # [ 0.095984] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.096008] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] machine # [ 0.096395] PCI host bridge to bus 0000:00 machine # [ 0.096430] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] machine # [ 0.096435] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] machine # [ 0.096438] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] machine # [ 0.096449] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.096453] PCI: OF: of_root node is NULL, cannot create PCI host bridge node machine # [ 0.096514] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.097034] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.097226] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f] machine # [ 0.097239] pci 0000:00:01.0: BAR 1 [mem 0x1004d000-0x1004dfff] machine # [ 0.097265] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] machine # [ 0.097277] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref] machine # [ 0.097795] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.098831] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f] machine # [ 0.098846] pci 0000:00:02.0: BAR 1 [mem 0x1004c000-0x1004cfff] machine # [ 0.098876] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref] machine # [ 0.099444] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.231203] pci 0000:00:03.0: BAR 0 [io 0x0100-0x017f] machine # [ 0.232055] pci 0000:00:03.0: BAR 1 [mem 0x1004b000-0x1004bfff] machine # [ 0.232094] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref] machine # [ 0.232760] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.232959] pci 0000:00:04.0: BAR 0 [io 0x0080-0x00ff] machine # [ 0.232977] pci 0000:00:04.0: BAR 1 [mem 0x1004a000-0x1004afff] machine # [ 0.233008] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref] machine # [ 0.233533] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.234369] pci 0000:00:05.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.234392] pci 0000:00:05.0: BAR 1 [mem 0x10049000-0x10049fff] machine # [ 0.234425] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref] machine # [ 0.235092] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.235295] pci 0000:00:06.0: BAR 0 [io 0x01e0-0x01ff] machine # [ 0.235312] pci 0000:00:06.0: BAR 1 [mem 0x10048000-0x10048fff] machine # [ 0.246274] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref] machine # [ 0.246301] pci 0000:00:06.0: ROM [mem 0xfffc0000-0xffffffff pref] machine # [ 0.246847] pci 0000:00:07.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.251078] pci 0000:00:07.0: BAR 1 [mem 0x10047000-0x10047fff] machine # [ 0.251124] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref] machine # [ 0.251769] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.251965] pci 0000:00:08.0: BAR 1 [mem 0x10046000-0x10046fff] machine # [ 0.251996] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref] machine # [ 0.256909] pci 0000:00:09.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.258517] pci 0000:00:09.0: BAR 0 [mem 0x10045000-0x10045fff] machine # [ 0.258885] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.259089] pci 0000:00:0a.0: BAR 1 [mem 0x10044000-0x10044fff] machine # [ 0.259130] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref] machine # [ 0.259778] pci 0000:00:0b.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.259977] pci 0000:00:0b.0: BAR 1 [mem 0x10043000-0x10043fff] machine # [ 0.260009] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref] machine # [ 0.260541] pci 0000:00:0c.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.269147] pci 0000:00:0c.0: BAR 1 [mem 0x10042000-0x10042fff] machine # [ 0.269184] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref] machine # [ 0.271459] pci 0000:00:0d.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.273082] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x01bf] machine # [ 0.273107] pci 0000:00:0d.0: BAR 1 [mem 0x10041000-0x10041fff] machine # [ 0.273139] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref] machine # [ 0.277201] pci 0000:00:0e.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.279250] pci 0000:00:0e.0: BAR 0 [io 0x01c0-0x01df] machine # [ 0.279355] pci 0000:00:0e.0: BAR 1 [mem 0x10040000-0x10040fff] machine # [ 0.279388] pci 0000:00:0e.0: BAR 4 [mem 0x8000030000-0x8000033fff 64bit pref] machine # [ 0.280034] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.280048] pci 0000:00:06.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.280056] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.280110] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.280163] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.280212] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.280261] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.280310] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.280361] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.281592] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.294669] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.294727] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.294777] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.294827] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned machine # [ 0.294877] pci 0000:00:0e.0: BAR 4 [mem 0x8000030000-0x8000033fff 64bit pref]: assigned machine # [ 0.294927] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.294952] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.294976] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.295001] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.295025] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.295049] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.295072] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.295714] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.295744] pci 0000:00:09.0: BAR 0 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.296319] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.296348] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.296373] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.296398] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned machine # [ 0.296423] pci 0000:00:0e.0: BAR 1 [mem 0x1008d000-0x1008dfff]: assigned machine # [ 0.296447] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.297008] pci 0000:00:04.0: BAR 0 [io 0x1080-0x10ff]: assigned machine # [ 0.297035] pci 0000:00:05.0: BAR 0 [io 0x1100-0x117f]: assigned machine # [ 0.297609] pci 0000:00:0d.0: BAR 0 [io 0x1180-0x11bf]: assigned machine # [ 0.298199] pci 0000:00:01.0: BAR 0 [io 0x11c0-0x11df]: assigned machine # [ 0.298227] pci 0000:00:02.0: BAR 0 [io 0x11e0-0x11ff]: assigned machine # [ 0.321965] pci 0000:00:06.0: BAR 0 [io 0x1200-0x121f]: assigned machine # [ 0.322004] pci 0000:00:0e.0: BAR 0 [io 0x1220-0x123f]: assigned machine # [ 0.322636] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] machine # [ 0.322651] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] machine # [ 0.322657] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] machine # [ 0.330372] iommu: Default domain type: Translated machine # [ 0.330390] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.332064] SCSI subsystem initialized machine # [ 0.332861] ACPI: bus type USB registered machine # [ 0.332915] usbcore: registered new interface driver usbfs machine # [ 0.332944] usbcore: registered new interface driver hub machine # [ 0.332963] usbcore: registered new device driver usb machine # [ 0.333190] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.333197] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.333213] PTP clock support registered machine # [ 0.333261] EDAC MC: Ver: 3.0.0 machine # [ 0.338916] scmi_core: SCMI protocol bus registered machine # [ 0.339726] efivars: Registered efivars operations machine # [ 0.340833] FPGA manager framework machine # [ 0.341776] vgaarb: loaded machine # [ 0.342409] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.342739] VFS: Disk quotas dquot_6.6.0 machine # [ 0.342769] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.346893] netfs: FS-Cache loaded machine # [ 0.347034] pnp: PnP ACPI init machine # [ 0.347289] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved machine # [ 0.347359] pnp: PnP ACPI: found 1 devices machine # [ 0.353143] NET: Registered PF_INET protocol family machine # [ 0.353211] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.375302] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.375365] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.375395] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.375457] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.375557] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.375658] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.375697] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.375723] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.375819] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.375846] NET: Registered PF_XDP protocol family machine # [ 0.376679] PCI: CLS 0 bytes, default 64 machine # [ 0.376936] Trying to unpack rootfs image as initramfs... machine # [ 0.398477] kvm [1]: HYP mode not available machine # [ 0.555132] Initialise system trusted keyrings machine # [ 0.556009] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.557314] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.558158] 9p: Installing v9fs 9p2000 file system support machine # [ 0.579061] Key type asymmetric registered machine # [ 0.579095] Asymmetric key parser 'x509' registered machine # [ 0.579174] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.586508] io scheduler mq-deadline registered machine # [ 0.586540] io scheduler kyber registered machine # [ 0.598462] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.600837] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 machine # [ 0.600904] ACPI: button: Power Button [PWRB] machine # [ 0.630112] ACPI: \_SB_.L001: Enabled at IRQ 36 machine # [ 0.630181] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.632798] ACPI: \_SB_.L002: Enabled at IRQ 37 machine # [ 0.632851] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007) machine # [ 0.642986] ACPI: \_SB_.L003: Enabled at IRQ 38 machine # [ 0.643084] virtio-pci 0000:00:03.0: enabling device (0005 -> 0007) machine # [ 0.645408] ACPI: \_SB_.L000: Enabled at IRQ 35 machine # [ 0.645452] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.657469] virtio-pci 0000:00:05.0: enabling device (0005 -> 0007) machine # [ 0.660295] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.672567] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.675863] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.678160] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0002) machine # [ 0.688446] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0002) machine # [ 0.699508] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007) machine # [ 0.702353] virtio-pci 0000:00:0e.0: enabling device (0005 -> 0007) machine # [ 0.715973] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.718910] msm_serial: driver initialized machine # [ 0.719058] SuperH (H)SCI(F) driver initialized machine # [ 0.719102] STM32 USART driver initialized machine # [ 0.748769] ACPI: bus type drm_connector registered machine # [ 0.752224] loop: module loaded machine # [ 0.752420] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.753184] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.766739] virtio_blk virtio3: 1/0/0 default/read/poll queues machine # [ 0.767706] virtio_blk virtio3: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB) machine # [ 0.774700] virtio_blk virtio4: 1/0/0 default/read/poll queues machine # [ 0.775586] virtio_blk virtio4: [vdc] 534561 512-byte logical blocks (274 MB/261 MiB) machine # [ 0.818503] vdc: vdc1 machine # [ 0.819382] megasas: 07.734.00.00-rc1 machine # [ 0.821819] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.825085] thunder_xcv, ver 1.0 machine # [ 0.825133] thunder_bgx, ver 1.0 machine # [ 0.825172] nicpf, ver 1.0 machine # [ 0.825810] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.825823] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.825852] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.825859] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.825888] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.825899] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.825945] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.825956] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.826082] sky2: driver version 1.30 machine # [ 0.837893] usbcore: registered new interface driver usb-storage machine # [ 0.837991] usbcore: registered new interface driver usbserial_generic machine # [ 0.838008] usbserial: USB Serial support registered for generic machine # [ 0.839461] ehci-pci 0000:00:09.0: EHCI Host Controller machine # [ 0.839520] ehci-pci 0000:00:09.0: new USB bus registered, assigned bus number 1 machine # [ 0.839882] ehci-pci 0000:00:09.0: irq 45, io mem 0x10088000 machine # [ 0.844903] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.846426] rtc-efi rtc-efi.0: registered as rtc0 machine # [ 0.847065] rtc-efi rtc-efi.0: setting system clock to 2026-09-22T02:59:01 UTC (1790045941) machine # [ 0.847433] i2c_dev: i2c /dev entries driver machine # [ 0.852123] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.852139] sdhci: Copyright(c) Pierre Ossman machine # [ 0.852392] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.852750] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.857544] ehci-pci 0000:00:09.0: USB 2.0 started, EHCI 1.00 machine # [ 0.857939] hub 1-0:1.0: USB hub found machine # [ 0.857981] hub 1-0:1.0: 6 ports detected machine # [ 0.866525] pstore: Using crash dump compression: deflate machine # [ 0.866551] pstore: Registered efi_pstore as persistent store backend machine # [ 0.869208] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.869560] usbcore: registered new interface driver usbhid machine # [ 0.869571] usbhid: USB HID core driver machine # [ 0.879139] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available machine # [ 0.880919] drop_monitor: Initializing network drop monitor service machine # [ 0.881071] NET: Registered PF_INET6 protocol family machine # [ 0.884352] Segment Routing with IPv6 machine # [ 0.884401] In-situ OAM (IOAM) with IPv6 machine # [ 0.884435] NET: Registered PF_PACKET protocol family machine # [ 0.886165] 9pnet: Installing 9P2000 support machine # [ 0.886242] Key type dns_resolver registered machine # [ 0.902619] registered taskstats version 1 machine # [ 0.902841] Loading compiled-in X.509 certificates machine # [ 0.930444] Demotion targets for Node 0: null machine # [ 0.931434] Key type .fscrypt registered machine # [ 0.931450] Key type fscrypt-provisioning registered machine # [ 0.931616] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.931641] ima: Allocated hash algorithm: sha1 machine # [ 0.931667] ima: No architecture policies found machine # [ 0.972360] clk: Disabling unused clocks machine # [ 0.972405] PM: genpd: Disabling unused power domains machine # [ 1.110485] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.163540] Freeing initrd memory: 26380K machine # [ 1.167600] Freeing unused kernel memory: 4736K machine # [ 1.167894] Run /init as init process machine # [ 1.194838] fuse: init (API version 7.45) machine # [ 1.199462] virtiofs virtio8: discovered new tag: nix-store machine # [ 1.200359] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.217038] virtiofs virtio9: discovered new tag: shared machine # [ 1.217837] virtiofs virtio9: virtio_fs_setup_dax: No cache capability machine # [ 1.220870] virtiofs virtio10: discovered new tag: xchg machine # [ 1.221661] virtiofs virtio10: virtio_fs_setup_dax: No cache capability machine # [ 1.235850] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.260672] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:09.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.331040] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:09.0-1/input0 machine # [ 1.454518] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.570793] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 1.576025] systemd[1]: Detected virtualization kvm. machine # [ 1.577158] systemd[1]: Detected architecture arm64. machine # [ 1.577821] systemd[1]: Running in initrd. machine # [ 1.579129] systemd[1]: Initializing machine ID from random generator. machine # [ 1.580529] systemd[1]: Hostname set to . machine # [ 1.652728] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:09.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.652979] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:09.0-2/input0 machine # [ 1.719142] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.784873] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.792716] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.793827] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.794979] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.795872] systemd[1]: Expecting device /dev/tpm0... machine # [ 1.796574] systemd[1]: Expecting device /dev/tpmrm0... machine # [ 1.797301] systemd[1]: Reached target Path Units. machine # [ 1.797988] systemd[1]: Reached target Slice Units. machine # [ 1.798708] systemd[1]: Reached target Swaps. machine # [ 1.799310] systemd[1]: Reached target Timer Units. machine # [ 1.800121] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.801056] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.802012] systemd[1]: Listening on Journal Sockets. machine # [ 1.802824] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.803552] systemd[1]: Reached target Socket Units. machine # [ 1.805977] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.807031] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.818173] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.847053] systemd[1]: Starting Journal Service... machine # [ 1.849642] systemd[1]: Starting Load Kernel Modules... machine # [ 1.862043] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.882658] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.883955] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.891097] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.943250] systemd-journald[70]: Collecting audit messages is disabled. machine # [ 1.963243] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.965864] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.968156] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.976050] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.990017] [drm] pci: virtio-gpu-pci detected at 0000:00:07.0 machine # [ 1.990297] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.990309] [drm] features: -context_init machine # [ 2.007348] [drm] number of scanouts: 1 machine # [ 2.007388] [drm] number of cap sets: 0 machine # [ 2.010879] virtio-pci 0000:00:07.0: [drm] Registered 1 planes with drm panic machine # [ 2.010901] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:07.0 on minor 0 machine # [ 2.042794] Console: switching to colour frame buffer device 160x50 machine # [ 2.049969] virtio-pci 0000:00:07.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 2.063345] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 2.063695] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 2.063737] systemd[1]: Reached target Local File Systems. machine # [ 2.071018] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 2.096472] systemd[1]: Finished Load Kernel Modules. machine # [ 2.107074] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.170798] systemd[1]: Started Journal Service. machine # [ 2.153375] systemd-modules-load[71]: Inserted module 'dm_mod' machine # [ 2.154813] systemd-modules-load[71]: Module 'virtio_balloon' is built in machine # [ 2.164189] systemd-modules-load[71]: Module 'virtio_console' is built in machine # [ 2.167514] systemd-modules-load[71]: Inserted module 'virtio_gpu' machine # [ 2.170336] systemd-modules-load[71]: Module 'virtio_rng' is built in machine # [ 2.180571] systemd[1]: Starting Create System Files and Directories... machine # [ 2.184373] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.188805] systemd-udevd[76]: Using default interface naming scheme 'v261'. machine # [ 2.218754] systemd[1]: Finished Create System Files and Directories. machine # [ 2.243933] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.316566] systemd[1]: Starting Virtual Console Setup... machine # [ 2.384637] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.388948] systemd[1]: Finished Virtual Console Setup. machine # [ 3.093411] systemd[1]: Finished Coldplug All udev Devices. machine # [ 3.251868] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 3.300497] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.364453] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.368418] systemd[1]: Reached target Initrd Root Device. machine # [ 3.373052] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.437758] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.468289] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.470523] systemd[1]: Mounting /sysroot... machine # [ 3.582064] EXT4-fs (vda): mounted filesystem abeb34fd-9ed9-4fde-8234-2d6e9cca0802 r/w with ordered data mode. Quota mode: none. machine # [ 3.574722] systemd[1]: Mounted /sysroot. machine # [ 3.577677] systemd[1]: Reached target Initrd Root File System. machine # [ 3.585099] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.620367] systemd-sysroot-fstab-check[115]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.628886] systemd[1]: Reload requested from client PID 115 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.635846] systemd[1]: Reloading... machine # [ 3.909476] systemd[1]: Reloading finished in 278 ms. machine # [ 3.936257] systemd-sysroot-fstab-check[115]: Requesting initrd-fs.target/start/replace... machine # [ 3.938135] systemd-sysroot-fstab-check[115]: Requesting swap.target/start/replace... machine # [ 3.944828] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.965110] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.976723] systemd[1]: Mounting /sysroot/run... machine # [ 4.003150] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 4.036709] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 4.063282] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 4.116404] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 4.120191] systemd[1]: Mounted /sysroot/run. machine # [ 4.131978] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 4.133945] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 4.138029] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 4.142614] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 4.144824] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 4.160292] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.194317] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.195959] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.911636] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) machine # [ 4.944172] systemd[1]: Mounting /sysroot/nix/store... machine # [ 5.001427] systemd[1]: Mounted /sysroot/nix/store. machine # [ 5.003753] systemd[1]: Reached target Initrd File Systems. machine # [ 5.006446] systemd[1]: Starting Find NixOS closure... machine # [ 5.025649] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 5.068141] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 5.073770] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 5.094169] systemd[1]: Finished Find NixOS closure. machine # [ 5.168674] systemd[1]: Found device /dev/tpm0. machine # [ 5.173547] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 5.177185] systemd[1]: Stopped Virtual Console Setup. machine # [ 5.181235] systemd[1]: Stopping Virtual Console Setup... machine # [ 5.183286] systemd[1]: Starting Virtual Console Setup... machine # [ 5.221491] systemd[1]: Found device /dev/tpmrm0. machine # [ 5.231884] systemd[1]: Reached target Trusted Platform Module. machine # [ 5.237465] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.242744] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 5.244768] systemd[1]: Stopped Virtual Console Setup. machine # [ 5.252453] systemd[1]: Starting Virtual Console Setup... machine # [ 5.291998] systemd-vconsole-setup[163]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 5.298011] systemd[1]: Finished Virtual Console Setup. machine # [ 5.298958] systemd[1]: Reached target System Initialization. machine # [ 5.300667] systemd[1]: Reached target Basic System. machine # [ 5.304412] systemd[1]: Reached target Initrd Default Target. machine # [ 5.305395] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 5.330581] systemd[1]: Stopped target Initrd Default Target. machine # [ 5.332248] systemd[1]: Stopped target Basic System. machine # [ 5.336440] systemd[1]: Stopped target Initrd Root Device. machine # [ 5.337411] systemd[1]: Stopped target Path Units. machine # [ 5.338127] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 5.340150] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 5.342176] systemd[1]: Stopped target Slice Units. machine # [ 5.344188] systemd[1]: Stopped target Socket Units. machine # [ 5.345633] systemd[1]: Stopped target System Initialization. machine # [ 5.349328] systemd[1]: Stopped target Swaps. machine # [ 5.356211] systemd[1]: Stopped target Timer Units. machine # [ 5.359747] systemd[1]: Stopped target Trusted Platform Module. machine # [ 5.361293] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 5.362410] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 5.363274] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 5.367559] systemd[1]: Stopped Find NixOS closure. machine # [ 5.368579] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 5.376380] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 5.380358] systemd[1]: Stopped Apply Kernel Variables. machine # [ 5.385211] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 5.388532] systemd[1]: Stopped Load Kernel Modules. machine # [ 5.390565] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 5.396355] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 5.397744] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 5.400184] systemd[1]: Stopped Create System Files and Directories. machine # [ 5.402000] systemd[1]: Stopped target Local File Systems. machine # [ 5.404164] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 5.408180] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 5.409353] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 5.410649] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 5.412934] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 5.415252] systemd[1]: Stopped Virtual Console Setup. machine # [ 5.420303] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 5.421465] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 5.422493] systemd[1]: systemd-udevd.service: Consumed 1.804s CPU time over 3.338s wall clock time, 22.9M memory peak. machine # [ 5.425164] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 5.426319] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 5.427557] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 5.428786] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 5.429672] systemd[1]: Starting Cleanup udev Database... machine # [ 5.430482] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 5.431599] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 5.436308] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 5.437697] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 5.440314] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 5.444257] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 5.485628] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 5.488505] systemd[1]: Finished Cleanup udev Database. machine # [ 5.490565] systemd[1]: Reached target Switch Root. machine # [ 5.491904] systemd[1]: Starting NixOS Activation... machine # [ 5.596764] initrd-nixos-activation-start[175]: booting system configuration /nix/store/9g66rzbsim06c9hz73xcqpnvr1ihsfci-nixos-system-machine-test machine # [ 5.640193] initrd-nixos-activation-start[175]: running activation script... machine # [ 5.925087] initrd-nixos-activation-start[198]: setting up /etc... machine # [ 6.072825] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 6.076483] systemd[1]: Finished NixOS Activation. machine # [ 6.077790] systemd[1]: Starting Switch Root... machine # [ 6.103045] systemd[1]: Switching root. machine # [ 6.310657] systemd-journald[70]: Received SIGTERM from PID 1 (systemd). machine # [ 6.459252] NET: Registered PF_VSOCK protocol family machine # [ 6.835916] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 6.849902] systemd[1]: Detected virtualization kvm. machine # [ 6.853726] systemd[1]: Detected architecture arm64. machine # [ 6.857689] systemd[1]: Detected first boot. machine # [ 6.863926] systemd[1]: Initializing machine ID from random generator. machine # [ 7.075132] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 7.294901] systemd[1]: Applying preset policy. machine # [ 7.693063] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.965034] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.966701] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.970776] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.975169] systemd[1]: Created slice Slice /system/getty. machine # [ 7.977892] systemd[1]: Created slice Slice /system/systemd-fsck. machine # [ 7.981569] systemd[1]: Created slice User and Session Slice. machine # [ 7.983247] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.986313] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.987873] systemd[1]: Expecting device /dev/disk/by-label/ESP... machine # [ 7.989703] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.991753] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.993972] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.995319] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.997353] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.998656] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 8.000917] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 8.002278] systemd[1]: Reached target Path Units. machine # [ 8.003695] systemd[1]: Reached target Remote File Systems. machine # [ 8.005394] systemd[1]: Reached target Slice Units. machine # [ 8.007175] systemd[1]: Reached target Swaps. machine # [ 8.012640] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 8.016521] systemd[1]: Listening on Process Core Dump Socket. machine # [ 8.020238] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 8.023344] systemd[1]: Listening on Factory Reset Management. machine # [ 8.024872] systemd[1]: Listening on Hostname Service Socket. machine # [ 8.031706] systemd[1]: Starting Journal Log Access Socket... machine # [ 8.033966] systemd[1]: Listening on Journal Audit Socket. machine # [ 8.038741] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 8.042365] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 8.046485] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.049406] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 8.056455] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 8.058046] systemd[1]: Listening on udev Varlink Socket. machine # [ 8.062957] systemd[1]: Mounting Huge Pages File System... machine # [ 8.071898] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 8.084883] systemd[1]: Mounting Kernel Debug File System... machine # [ 8.098982] systemd[1]: Mounting Kernel Trace File System... machine # [ 8.118685] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 8.122387] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.138764] systemd[1]: Mounting Kernel Configuration File System... machine # [ 8.144151] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 8.156257] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 8.158725] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.188006] systemd[1]: Mounting FUSE Control File System... machine # [ 8.214988] systemd[1]: Starting seed-system-profile.service... machine # [ 8.218661] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 8.245450] systemd[1]: Starting Journal Service... machine # [ 8.272335] systemd[1]: Starting Load Kernel Modules... machine # [ 8.299942] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 8.342937] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 8.349432] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.373589] systemd[1]: Starting Coldplug All udev Devices... machine # [ 8.393074] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.399824] systemd[1]: Mounted Huge Pages File System. machine # [ 8.403203] systemd-journald[270]: Collecting audit messages is enabled. machine # [ 8.408481] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.415081] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.419399] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.398519] systemd[1]: Queued start job for default target Multi-User System. machine # [ 8.399952] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 8.441298] systemd[1]: Started Journal Service. machine # [ 8.417365] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.424780] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.437220] systemd[1]: Finished seed-system-profile.service. machine # [ 8.449663] systemd-modules-load[271]: Module 'atkbd' is built in machine # [ 8.457619] systemd-modules-load[271]: Module 'loop' is built in machine # [ 8.467389] systemd[1]: Finished Load Kernel Modules. machine # [ 8.482676] systemd-oomd[272]: No swap; memory pressure usage will be degraded machine # [ 8.490093] systemd[1]: Mounted FUSE Control File System. machine # [ 8.495470] systemd[1]: Starting Firewall... machine # [ 8.526770] EXT4-fs (vda): re-mounted abeb34fd-9ed9-4fde-8234-2d6e9cca0802. machine # [ 8.505930] systemd[1]: Starting Apply Kernel Variables... machine # [ 8.523529] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.528587] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.532546] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.543229] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.553703] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.554797] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.576707] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.584366] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.724652] systemd-journald[270]: Received client request to flush runtime journal. machine # [ 8.872873] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.873963] systemd[1]: Reached target First Boot Complete. machine # [ 8.874827] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.889172] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.939244] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.946208] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 9.140385] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 9.143128] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 9.154768] systemd[1]: Mounting /run/wrappers... machine # [ 9.163519] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 9.267498] systemd[1]: Mounted /run/wrappers. machine # [ 9.272582] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 9.337097] systemd-udevd[317]: Using default interface naming scheme 'v261'. machine # [ 9.470212] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 10.101931] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.168361] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 10.222431] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 10.365595] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 10.369559] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.524568] systemd[1]: Found device /dev/tpmrm0. machine # [ 10.525511] systemd[1]: Expecting device /dev/tpm0... machine # [ 10.532636] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 10.575499] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 10.586315] (udev-worker)[353]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.591325] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.795387] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.801657] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 10.807477] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 10.810376] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 10.820345] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 10.903095] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped. machine # [ 10.915473] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP... machine # [ 11.026446] systemd[1]: Finished Firewall. machine # [ 11.056486] systemd-fsck[489]: fsck.fat 4.2 (2021-01-31) machine # [ 11.057430] systemd-fsck[489]: /dev/vdc1: 20 files, 29075/66398 clusters machine # [ 11.066791] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP. machine # [ 11.077901] systemd[1]: Mounting /boot... machine # [ 11.194133] systemd[1]: Mounted /boot. machine # [ 11.194953] systemd[1]: Reached target Local File Systems. machine # [ 11.202156] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 11.208520] systemd[1]: Starting Update Boot Loader Random Seed... machine # [ 11.227054] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 11.234013] systemd[1]: Starting Create System Files and Directories... machine # [ 11.306925] bootctl[510]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! machine # [ 11.316690] bootctl[510]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole! machine # [ 11.331017] bootctl[510]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes). machine # [ 11.353301] bootctl[510]: Successfully initialized system token in EFI variable with 32 bytes. machine # [ 11.358538] systemd[1]: Finished Update Boot Loader Random Seed. machine # [ 11.479876] mousedev: PS/2 mouse device common for all mice machine # [ 11.453242] systemd[1]: Finished Create System Files and Directories. machine # [ 11.467129] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 11.472492] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 11.564503] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 11.604358] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 11.610863] systemd[1]: Starting Update is Completed... machine # [ 11.675793] systemd[1]: Finished Update is Completed. machine # [ 11.724094] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 11.727627] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 11.819732] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 11.946806] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 12.579160] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:08.0/virtio7/input/input3 machine # [ 12.631986] systemd[1]: Found device /dev/tpm0. machine # [ 12.636341] systemd[1]: Reached target Trusted Platform Module. machine # [ 12.643087] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.647632] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.652359] systemd[1]: Reached target System Initialization. machine # [ 12.654881] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 12.658962] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 12.661270] systemd[1]: Reached target Timer Units. machine # [ 12.668282] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 12.670318] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 12.672454] systemd[1]: Reached target Socket Units. machine # [ 12.674102] systemd[1]: Reached target Basic System. machine # [ 12.676695] systemd[1]: Started backdoor.service. machine # [ 12.680224] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 12.684218] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 12.686787] systemd[1]: Starting Post-Boot Actions... machine # [ 12.720661] systemd[1]: Started Reset console on configuration changes. machine # [ 12.735965] systemd[1]: Starting resolvconf update... machine # [ 12.822537] systemd[1]: Starting D-Bus System Message Bus... machine # [ 12.838288] systemd[1]: Finished Post-Boot Actions. machine # [ 12.868945] nsncd[570]: Sep 22 02:59:13.545 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 12.881635] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # connecting to host... machine # [ 12.904654] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 12.909374] systemd[1]: Reached target User and Group Name Lookups. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 12.949467] systemd[1]: Starting User Login Management... machine: connected to guest root shell machine: (connecting took 29.69 seconds) machine: (finished: waiting for the VM to finish booting, in 30.14 seconds) machine # [ 13.045058] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 13.071834] dbus-broker-launch[575]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 13.081594] dbus-broker-launch[575]: NSS returned no entry for 'systemd-timesync' machine # [ 13.082709] dbus-broker-launch[575]: Invalid user-name in /nix/store/2qvvx7cy6hkpkspdavny88d5pky4m9pm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 13.200539] systemd-logind[595]: New seat seat0. machine # [ 13.208098] systemd-logind[595]: Watching system buttons on /dev/input/event0 (Power Button) machine # [ 13.211103] systemd-logind[595]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 13.220463] dbus-broker-launch[575]: Ready machine # [ 13.296550] systemd-logind[595]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 13.313505] systemd[1]: Started D-Bus System Message Bus. machine # [ 13.317404] systemd[1]: Started User Login Management. machine # [ 13.372582] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 13.373706] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 13.374568] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 13.375423] systemd[1]: Stopping User and Group Name Lookups... machine # [ 13.384597] systemd[1]: Starting linger-users.service... machine # [ 13.392349] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 13.402148] systemd[1]: Starting Virtual Console Setup... machine # [ 13.410229] systemd[1]: nscd.service: Deactivated successfully. machine # [ 13.412555] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 13.473431] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 13.503682] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 13.510652] systemd[1]: Finished linger-users.service. machine # [ 13.529453] systemd[1]: Finished resolvconf update. machine # [ 13.532290] systemd[1]: Reached target Preparation for Network. machine # [ 13.546274] systemd[1]: Starting DHCP Client... machine # [ 13.554752] systemd[1]: Starting Address configuration of eth1... machine # [ 13.573483] nsncd[665]: Sep 22 02:59:14.255 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 13.585142] systemd[1]: Starting Extra networking commands.... machine # [ 13.588221] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 13.592850] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 13.593874] systemd[1]: Reached target User and Group Name Lookups. machine # [ 13.795054] network-addresses-eth1-start[674]: adding address 192.168.1.1/24... done machine # [ 13.825217] network-addresses-eth1-start[674]: adding address 2001:db8:1::1/64... done machine # [ 13.870978] systemd[1]: Finished Address configuration of eth1. machine # [ 13.901779] dhcpcd[692]: dhcpcd-10.3.2 starting machine # [ 13.910810] dhcpcd[738]: dev: loaded udev machine # [ 13.982115] 8021q: 802.1Q VLAN Support v1.8 machine # [ 13.985109] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 13.964191] systemd[1]: Finished Extra networking commands.. machine # [ 13.967398] systemd[1]: Reached target Network. machine # [ 13.975118] systemd[1]: Starting Permit User Sessions... machine # [ 14.014301] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.084061] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 14.065107] systemd[1]: Finished Permit User Sessions. machine # [ 14.073189] systemd[1]: Started Getty on tty1. machine # [ 14.075649] systemd[1]: Reached target Login Prompts. machine # [ 14.123354] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 14.123971] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 14.128680] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 14.129025] cfg80211: failed to load regulatory.db machine # [ 14.180082] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 14.151551] dhcpcd[738]: eth0: waiting for carrier machine # [ 14.153805] dhcpcd[738]: eth0: carrier acquired machine # [ 14.158095] systemd-vconsole-setup[654]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.164623] systemd[1]: Finished Virtual Console Setup. machine # [ 14.170990] dhcpcd[738]: DUID 00:01:00:01:32:44:ab:82:52:54:00:12:34:56 machine # [ 14.172614] dhcpcd[738]: eth0: IAID 00:12:34:56 machine # [ 14.173347] dhcpcd[738]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 14.204909] dhcpcd[738]: eth0: soliciting a DHCP lease machine # [ 14.208647] dhcpcd[738]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.212217] dhcpcd[738]: eth0: probing address 10.0.2.15/24 machine # [ 16.093531] dhcpcd[738]: eth0: soliciting an IPv6 router machine # [ 16.098888] dhcpcd[738]: eth0: Router Advertisement from fe80::2 machine # [ 16.101758] dhcpcd[738]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 16.104851] dhcpcd[738]: eth0: adding route to fec0::/64 machine # [ 16.107261] dhcpcd[738]: eth0: adding default route via fe80::2 machine # [ 19.018836] dhcpcd[738]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 19.030045] dhcpcd[738]: eth0: adding route to 10.0.2.0/24 machine # [ 19.040153] dhcpcd[738]: eth0: adding default route via 10.0.2.2 machine # [ 19.261995] systemd[1]: Started DHCP Client. machine # [ 19.264475] systemd[1]: Reached target Multi-User System. machine # [ 19.265880] systemd[1]: Startup finished in 9.164s (firmware) + 6.444s (loader) + 1.143s (kernel) + 5.255s (initrd) + 12.867s (userspace) = 34.874s. machine: (finished: waiting for unit multi-user.target, in 37.44 seconds) machine: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb - machine: (finished: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -, in 2.73 seconds) machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot machine # [ 23.610613] Key type trusted registered machine # [ 23.615813] Key type encrypted registered machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.64 seconds) machine: must succeed: mkfs.ext4 /dev/mapper/cryptroot machine # mke2fs 1.47.4 (6-Mar-2025) machine: (finished: must succeed: mkfs.ext4 /dev/mapper/cryptroot, in 0.08 seconds) machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat machine # [ 23.799911] cat[919]: Successfully called mlockall(). machine # [ 23.801110] cat[919]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory machine # [ 23.806575] cat[919]: Loaded shared library 'libcryptsetup.so.12' via dlopen(). machine # [ 23.808546] cat[919]: Allocating context for crypt device /dev/vdb. machine # [ 23.809511] cat[919]: Trying to open device /dev/vdb with direct-io. machine # [ 23.810392] cat[919]: Initialising device-mapper backend library. machine # [ 23.811240] cat[919]: Trying to load LUKS2 crypt type from device /dev/vdb. machine # [ 23.812913] cat[919]: Crypto backend (OpenSSL 3.6.4 25 Aug 2026 [default][legacy][threads][argon2]) initialized in cryptsetup library version 2.8.7. machine # [ 23.815212] cat[919]: Detected kernel Linux 6.18.52 aarch64. machine # [ 23.817694] cat[919]: Loading LUKS2 header (repair disabled). machine # [ 23.819191] cat[919]: Acquiring read lock for device /dev/vdb. machine # [ 23.821397] cat[919]: Opening lock resource file /run/cryptsetup/L_254:16 machine # [ 23.822404] cat[919]: Verifying lock handle for /dev/vdb. machine # [ 23.823164] cat[919]: Device /dev/vdb READ lock taken. machine # [ 23.823878] cat[919]: Trying to read primary LUKS2 header at offset 0x0. machine # [ 23.832132] cat[919]: Opening locked device /dev/vdb machine # [ 23.832981] cat[919]: Verifying locked device handle (bdev) machine # [ 23.833787] cat[919]: LUKS2 header version 2 of size 16384 bytes, checksum sha256. machine # [ 23.834902] cat[919]: Checksum:fd1c882ee4c09c2320e7b188a647ff785965b552b72ce3809500b67f2be4b388 (on-disk) machine # [ 23.840105] cat[919]: Checksum:fd1c882ee4c09c2320e7b188a647ff785965b552b72ce3809500b67f2be4b388 (in-memory) machine # [ 23.841457] cat[919]: Trying to read secondary LUKS2 header at offset 0x4000. machine # [ 23.842408] cat[919]: Reusing open ro fd on device /dev/vdb machine # [ 23.843192] cat[919]: LUKS2 header version 2 of size 16384 bytes, checksum sha256. machine # [ 23.848102] cat[919]: Checksum:c728f1ca2e9b348238f0bf25cc2717f8fa06dd27886a0f84154198f3fa6e1be5 (on-disk) machine # [ 23.849385] cat[919]: Checksum:c728f1ca2e9b348238f0bf25cc2717f8fa06dd27886a0f84154198f3fa6e1be5 (in-memory) machine # [ 23.850657] cat[919]: Device size 536870912, offset 16777216. machine # [ 23.851449] cat[919]: Device /dev/vdb READ lock released. machine # [ 23.853536] cat[919]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1. machine # [ 23.854630] cat[919]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 345486kB. machine # [ 23.855972] cat[919]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 345486, parallel_threads 1. machine # [ 23.861398] cat[919]: Requesting JSON for token 0. machine # [ 23.862096] cat[919]: Requesting JSON for token 1. machine # [ 23.862777] cat[919]: Requesting JSON for token 2. machine # [ 23.863456] cat[919]: Requesting JSON for token 3. machine # [ 23.868094] cat[919]: Requesting JSON for token 4. machine # [ 23.868834] cat[919]: Requesting JSON for token 5. machine # [ 23.869556] cat[919]: Requesting JSON for token 6. machine # [ 23.870231] cat[919]: Requesting JSON for token 7. machine # [ 23.870911] cat[919]: Requesting JSON for token 8. machine # [ 23.871594] cat[919]: Requesting JSON for token 9. machine # [ 23.876114] cat[919]: Requesting JSON for token 10. machine # [ 23.876865] cat[919]: Requesting JSON for token 11. machine # [ 23.877575] cat[919]: Requesting JSON for token 12. machine # [ 23.878247] cat[919]: Requesting JSON for token 13. machine # [ 23.878929] cat[919]: Requesting JSON for token 14. machine # [ 23.879620] cat[919]: Requesting JSON for token 15. machine # [ 23.884129] cat[919]: Requesting JSON for token 16. machine # [ 23.884881] cat[919]: Requesting JSON for token 17. machine # [ 23.885630] cat[919]: Requesting JSON for token 18. machine # [ 23.886308] cat[919]: Requesting JSON for token 19. machine # [ 23.886991] cat[919]: Requesting JSON for token 20. machine # [ 23.887664] cat[919]: Requesting JSON for token 21. machine # [ 23.896118] cat[919]: Requesting JSON for token 22. machine # [ 23.896917] cat[919]: Requesting JSON for token 23. machine # [ 23.897601] cat[919]: Requesting JSON for token 24. machine # [ 23.898272] cat[919]: Requesting JSON for token 25. machine # [ 23.899001] cat[919]: Requesting JSON for token 26. machine # [ 23.899678] cat[919]: Requesting JSON for token 27. machine # [ 23.904143] cat[919]: Requesting JSON for token 28. machine # [ 23.904962] cat[919]: Requesting JSON for token 29. machine # [ 23.905654] cat[919]: Requesting JSON for token 30. machine # [ 23.906340] cat[919]: Requesting JSON for token 31. machine # [ 23.907079] cat[919]: Keyslot 0 priority 1 != 2 (required), skipped. machine # [ 23.907931] cat[919]: Trying to open LUKS2 keyslot 0. machine # [ 23.912139] cat[919]: Running keyslot key derivation. machine # [ 24.205635] cat[919]: Reading keyslot area [0x8000]. machine # [ 24.207843] cat[919]: Acquiring read lock for device /dev/vdb. machine # [ 24.212200] cat[919]: Opening lock resource file /run/cryptsetup/L_254:16 machine # [ 24.213222] cat[919]: Verifying lock handle for /dev/vdb. machine # [ 24.213975] cat[919]: Device /dev/vdb READ lock taken. machine # [ 24.214668] cat[919]: Reusing open ro fd on device /dev/vdb machine # [ 24.215457] cat[919]: Device /dev/vdb READ lock released. machine # [ 24.218512] cat[919]: Verifying key from keyslot 0, digest 0. machine # [ 24.284313] cat[919]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory machine # [ 24.286038] cat[919]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory machine # [ 24.289492] cat[919]: Loaded shared library 'libtss2-esys.so.0' via dlopen(). machine # [ 24.291518] cat[919]: Loaded shared library 'libtss2-rc.so.0' via dlopen(). machine # [ 24.292812] cat[919]: Loaded shared library 'libtss2-mu.so.0' via dlopen(). machine # [ 24.294222] cat[919]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen(). machine # [ 24.295270] cat[919]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'. machine # [ 24.299387] cat[919]: Loaded 'libtss2-tcti-device.so.0' via dlopen() machine # [ 24.300476] cat[919]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2] machine # [ 24.302470] cat[919]: TPM successfully started up. machine # [ 24.303172] cat[919]: Getting TPM2 capability 0x0000 property 0x0001 count 127. machine # [ 24.305397] cat[919]: Getting TPM2 capability 0x0002 property 0x011f count 256. machine # [ 24.317968] cat[919]: Getting TPM2 capability 0x0008 property 0x0000 count 508. machine # [ 24.320959] cat[919]: Getting TPM2 capability 0x0005 property 0x0000 count 1. machine # [ 24.323768] cat[919]: Getting TPM2 capability 0x0006 property 0x012c count 1. machine # [ 24.329472] cat[919]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.517ms. machine # [ 24.330699] cat[919]: Getting TPM2 capability 0x0001 property 0x81000001 count 1. machine # [ 24.333254] cat[919]: TPM handle 0x81000001 not populated. machine # [ 24.335493] cat[919]: Creating primary key on TPM. machine # [ 24.346296] cat[919]: Successfully created primary key on TPM in 10ms. machine # [ 24.358681] cat[919]: Getting TPM2 capability 0x0001 property 0x81000001 count 1. machine # [ 24.400921] cat[919]: Starting HMAC encryption session. machine # [ 24.415935] cat[919]: Generating secret key data. machine # [ 24.420135] cat[919]: Creating HMAC key on TPM for shard 0. machine # [ 24.421385] cat[919]: Creating object on TPM. machine # [ 24.439005] cat[919]: Successfully created object on TPM in 21ms. machine # [ 24.442880] cat[919]: Marshalling private and public part of HMAC key for shard 0. machine # [ 24.444351] cat[919]: Completed TPM2 key sealing in 112.630ms. machine # [ 24.448784] cat[919]: Requesting JSON for token 0. machine # [ 24.449702] cat[919]: Requesting JSON for token 1. machine # [ 24.450543] cat[919]: Requesting JSON for token 2. machine # [ 24.451390] cat[919]: Requesting JSON for token 3. machine # [ 24.454275] cat[919]: Requesting JSON for token 4. machine # [ 24.455709] cat[919]: Requesting JSON for token 5. machine # [ 24.459094] cat[919]: Requesting JSON for token 6. machine # [ 24.459996] cat[919]: Requesting JSON for token 7. machine # [ 24.460861] cat[919]: Requesting JSON for token 8. machine # [ 24.461704] cat[919]: Requesting JSON for token 9. machine # [ 24.462528] cat[919]: Requesting JSON for token 10. machine # [ 24.463365] cat[919]: Requesting JSON for token 11. machine # [ 24.468349] cat[919]: Requesting JSON for token 12. machine # [ 24.472773] cat[919]: Requesting JSON for token 13. machine # [ 24.474498] cat[919]: Requesting JSON for token 14. machine # [ 24.475309] cat[919]: Requesting JSON for token 15. machine # [ 24.476157] cat[919]: Requesting JSON for token 16. machine # [ 24.477034] cat[919]: Requesting JSON for token 17. machine # [ 24.478279] cat[919]: Requesting JSON for token 18. machine # [ 24.481461] cat[919]: Requesting JSON for token 19. machine # [ 24.482257] cat[919]: Requesting JSON for token 20. machine # [ 24.483277] cat[919]: Requesting JSON for token 21. machine # [ 24.484232] cat[919]: Requesting JSON for token 22. machine # [ 24.485033] cat[919]: Requesting JSON for token 23. machine # [ 24.487716] cat[919]: Requesting JSON for token 24. machine # [ 24.492141] cat[919]: Requesting JSON for token 25. machine # [ 24.492993] cat[919]: Requesting JSON for token 26. machine # [ 24.493695] cat[919]: Requesting JSON for token 27. machine # [ 24.494388] cat[919]: Requesting JSON for token 28. machine # [ 24.495085] cat[919]: Requesting JSON for token 29. machine # [ 24.495778] cat[919]: Requesting JSON for token 30. machine # [ 24.499046] cat[919]: Requesting JSON for token 31. machine # [ 24.499830] cat[919]: PCR policy hash not yet enrolled, enrolling now. machine # [ 24.502856] cat[919]: Unsealing for verification... machine # [ 24.503682] cat[919]: Loading HMAC key into TPM for shard 0. machine # [ 24.506384] cat[919]: Loading object into TPM. machine # [ 24.507006] cat[919]: Starting HMAC encryption session. machine # [ 24.508878] cat[919]: Starting policy session. machine # [ 24.523662] cat[919]: Building sealing policy. machine # [ 24.524615] cat[919]: Acquiring policy digest. machine # [ 24.546106] cat[919]: Session policy digest: 0000000000000000000000000000000000000000000000000000000000000000 machine # [ 24.551838] cat[919]: Unsealing HMAC key for shard 0. machine # [ 24.624163] cat[919]: Completed TPM2 key unsealing in 167.598ms. machine # [ 24.625462] cat[919]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000). machine # [ 24.626647] cat[919]: Adding new keyslot -1 by passphrase, volume key provided by key (-1). machine # [ 24.628126] cat[919]: Selected keyslot 1. machine # [ 24.694499] cat[919]: Keyslot 1 assigned to digest 0. machine # [ 24.696034] cat[919]: Trying to allocate LUKS2 keyslot 1. machine # [ 24.700187] cat[919]: Found area 290816 -> 548864 machine # [ 24.700915] cat[919]: Reusing PBKDF values (no benchmark flag is set). machine # [ 24.701813] cat[919]: Calculating attributes for LUKS2 keyslot 1. machine # [ 24.702649] cat[919]: Acquiring write lock for device /dev/vdb. machine # [ 24.703436] cat[919]: Opening lock resource file /run/cryptsetup/L_254:16 machine # [ 24.707522] cat[919]: Verifying lock handle for /dev/vdb. machine # [ 24.708307] cat[919]: Device /dev/vdb WRITE lock taken. machine # [ 24.709041] cat[919]: Checking context sequence id matches value stored on disk. machine # [ 24.710015] cat[919]: Reusing open ro fd on device /dev/vdb machine # [ 24.710800] cat[919]: Running keyslot key derivation. machine # [ 24.712084] cat[919]: Updating keyslot area [0x47000]. machine # [ 24.713293] cat[919]: Opening locked device /dev/vdb machine # [ 24.714164] cat[919]: Verifying locked device handle (bdev) machine # [ 24.715101] cat[919]: Device size 536870912, offset 16777216. machine # [ 24.716005] cat[919]: Device /dev/vdb WRITE lock already held. machine # [ 24.717132] cat[919]: Trying to write LUKS2 header (1039 bytes) at offset 0. machine # [ 24.718240] cat[919]: Reusing open rw fd on device /dev/vdb machine # [ 24.719151] cat[919]: Checksum:4c6b2973069e1434f0c6a35496731145ba4d4f7a2c35953422abf34e52e91cd4 (in-memory) machine # [ 24.720626] cat[919]: Trying to write LUKS2 header (1039 bytes) at offset 16384. machine # [ 24.721787] cat[919]: Reusing open rw fd on device /dev/vdb machine # [ 24.723277] cat[919]: Checksum:48c81a085bfdafe49c2594a9e32dfdf9694f0110b49707b889451c8d34cdadf7 (in-memory) machine # [ 24.725353] cat[919]: Device /dev/vdb WRITE lock released. machine # [ 24.726149] cat[919]: Unknown hash algorithm id 0x0 machine # [ 24.726833] cat[919]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AIEdsAxP9djwDx4GtvKyGoxvBvltDVcVK52EvOK4iAlqPABAzHTY/tef/rAxGqhvjl+QgoQJWAAhnPuHgIyZexV+gHAv6+ZN6tiudBoC0VEFxQvgnIgmWxz8wSX1tCjmJa/lhgEjiLZ8c1WTkcVgVXTYXTM1ZUN2IGLF4JSRaTQHWTEf3NNVTC3/jzLXkNACl2zHVOtQzNcNMBm+vVwBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAIOZRWFwrPmco4Ivo+t2T3ARQUFnTV3qAEFKnVDcAConk","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAvJp7IqFhaE6IubHy+p729bRBwNiQCTiZiA91f2SC41pwAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAIMfMykrJ7hlNOQvuNDL4FWh0rp+0sJky2bolumhWnj9DACAoWXwr9ShQ+IiPtczr9wmT9ZAEOTQnnp/KTtbHmiHtaQ=="}> machine # [ 24.740368] cat[919]: Updating JSON for token -1. machine # [ 24.741255] cat[919]: Trying to load libcryptsetup-token-systemd-tpm2.so. machine # [ 24.742286] cat[919]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0. machine # [ 24.743289] cat[919]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0. machine # [ 24.744576] cat[919]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0. machine # [ 24.745878] cat[919]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0. machine # [ 24.746886] cat[919]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0. machine # [ 24.747902] cat[919]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0. machine # [ 24.755114] cat[919]: Token handler systemd-tpm2-1.0 systemd-v262~rc3 (262-e362a4e) loaded successfully. machine # [ 24.761645] cat[919]: Device size 536870912, offset 16777216. machine # [ 24.762501] cat[919]: Acquiring write lock for device /dev/vdb. machine # [ 24.763292] cat[919]: Opening lock resource file /run/cryptsetup/L_254:16 machine # [ 24.766975] [919]: Verifying lock handle for /dev/vdb. machine # [ 24.767723] [919]: Device /dev/vdb WRITE lock taken. machine # [ 24.772164] [919]: Checking context sequence id matches value stored on disk. machine # [ 24.773169] [919]: Reusing open ro fd on device /dev/vdb machine # [ 24.773886] [919]: Trying to write LUKS2 header (1742 bytes) at offset 0. machine # [ 24.774776] [919]: Reusing open rw fd on device /dev/vdb machine # [ 24.775500] [919]: Checksum:0832463bd6562bbfd6cfb2fa8522c08b3101527ed5ba4d21e9a27f6d30111a73 (in-memory) machine # [ 24.780482] [919]: Trying to write LUKS2 header (1742 bytes) at offset 16384. machine # [ 24.781485] [919]: Reusing open rw fd on device /dev/vdb machine # [ 24.782242] [919]: Checksum:29eb39d55f40e5a5e0d5fb8427577cd12c90d38ce2da55ed3c8440fbf532add4 (in-memory) machine # [ 24.783499] [919]: Device /dev/vdb WRITE lock released. machine # [ 24.785487] [919]: New TPM2 token enrolled as key slot 1. machine # [ 24.786267] [919]: Releasing crypt device /dev/vdb context. machine # [ 24.787029] [919]: Releasing device-mapper backend. machine # [ 24.787704] [919]: Closing read only fd for /dev/vdb. machine # [ 24.788558] [919]: Closing read write fd for /dev/vdb. machine # [ 24.789286] [919]: Unloading systemd-tpm2 token handler. machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 1.05 seconds) machine: must succeed: /nix/store/nczpdhkj5162qwmfm162vscx73k0x9bx-nixos-system-machine-test/bin/switch-to-configuration boot machine # Not checking switch inhibitors (action = boot) machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already. machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already. machine: (finished: must succeed: /nix/store/nczpdhkj5162qwmfm162vscx73k0x9bx-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.49 seconds) machine: must succeed: sync machine: (finished: must succeed: sync, in 0.07 seconds) machine: forced crash machine: waiting for the VM to power off additionally exposed symbols: machine, vlan1, 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 machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client disconnected, shutting down machine: (finished: waiting for the VM to power off, in 0.18 seconds) machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 112) machine # Starting virtiofs daemons... machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:59:25Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:59:25Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T02:59:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T02:59:25Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T02:59:25Z INFO virtiofsd] Client connected, servicing requests machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980) machine: Guest shell says: b'\x1b[2J\x1b[001;001H\x1b[=3h\x1b[2J\x1b[001;001H\x1b[2J\x1b[001;001H\x1b[8;042;160t\x1b[2J\x1b[001;001H' machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0) machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0)\r\n' machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0) machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x5,0x0)\r\n' machine: Guest shell says: b'\r \r\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H\x1b[020;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m NixOS \x1b[021;063' machine: Guest shell says: b'H\x1b[1m\x1b[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS (boot-luks) \x1b[022;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m' machine: Guest shell says: b' Reboot Into Firmware Interface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m ' machine: Guest shell says: b' Boot in 5s. \x1b[023;060H\x1b[1m\x1b[37m\x1b[40' machine: Guest shell says: b'm\x1b[0m\x1b[37m\x1b[40m------------------------------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------' machine: Guest shell says: b'---------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m' machine: Guest shell says: b'------------------------------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------' machine: Guest shell says: b'---------------------' machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. ' machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m' machine: Guest shell says: b'------------------------------------------' machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H' machine # NixOS NixOS (boot-luks) Reboot Into Firmware Interface Boot in 5s. ------------------------------------------ Boot in 4s. ------------------------------------------ Boot in 3s. ------------------------------------------ Boot in 2s. ------------------------------------------ Boot in 1s. ------------------------------------------[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 14 11:36:19 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] efi: EFI v2.7 by EDK II machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fc0000 MEMATTR=0x45ae7018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a76018 INITRD=0x45a86418 MEMRESERVE=0x45ae1298 machine # [ 0.000000] random: crng init done machine # [ 0.000000] ACPI: Early table checksum verification disabled machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS ) machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013) machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001822 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013) machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,9600 machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf1880-0x7fdf4fff] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045b0ffff] machine # [ 0.000000] node 0: [mem 0x0000000045b10000-0x0000000045b1ffff] machine # [ 0.000000] node 0: [mem 0x0000000045b20000-0x0000000045fcffff] machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff] machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff] machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff] machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff] machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff] machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff] machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff] machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from ACPI. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\m1dwn7qzlldg0j6mrqvh3hbcrj9iyc62-initrd-linux-6.18.52-initrd.efi init=/nix/store/nczpdhkj5162qwmfm162vscx73k0x9bx-nixos-system-machine-test/init console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74950 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @428f0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @42900000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000042910000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000042920000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000036] arm-pv: using stolen time PV machine # [ 0.000447] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000547] Console: colour dummy device 80x25 machine # [ 0.000552] printk: legacy console [tty0] enabled machine # [ 0.000772] ACPI: Core revision 20250807 machine # [ 0.000861] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000868] pid_max: default: 32768 minimum: 301 machine # [ 0.000930] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001073] landlock: Up and running. machine # [ 0.001076] Yama: becoming mindful. machine # [ 0.001579] LSM support for eBPF active machine # [ 0.001684] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001691] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002716] rcu: Hierarchical SRCU implementation. machine # [ 0.002721] rcu: Max phase no-delay instances is 1000. machine # [ 0.003380] fsl-mc MSI: ITS@0x8080000 domain created machine # [ 0.003401] Remapping and enabling EFI services. machine # [ 0.003510] smp: Bringing up secondary CPUs ... machine # [ 0.003519] smp: Brought up 1 node, 1 CPU machine # [ 0.003523] SMP: Total of 1 processors activated. machine # [ 0.003526] CPU: All CPU(s) started at EL1 machine # [ 0.003535] CPU features: detected: Branch Target Identification machine # [ 0.003539] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.003542] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.003546] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.003549] CPU features: detected: Common not Private translations machine # [ 0.003553] CPU features: detected: CRC32 instructions machine # [ 0.003555] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.003559] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.003563] CPU features: detected: Data independent timing control (DIT) machine # [ 0.003566] CPU features: detected: E0PD machine # [ 0.003568] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.003571] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.003574] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.003577] CPU features: detected: Fine Grained Traps machine # [ 0.003581] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.003585] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.003588] CPU features: detected: LSE atomic instructions machine # [ 0.003590] CPU features: detected: Privileged Access Never machine # [ 0.003593] CPU features: detected: PMUv3 machine # [ 0.003596] CPU features: detected: RAS Extension Support machine # [ 0.003598] CPU features: detected: RASv1p1 Extension Support machine # [ 0.003601] CPU features: detected: Random Number Generator machine # [ 0.003603] CPU features: detected: Speculation barrier (SB) machine # [ 0.003606] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.003609] CPU features: detected: TLB range maintenance instructions machine # [ 0.003613] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.003656] alternatives: applying system-wide alternatives machine # [ 0.006680] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.006835] Memory: 886320K/1048576K available (24448K kernel code, 7094K rwdata, 26372K rodata, 4736K init, 1107K bss, 120720K reserved, 32768K cma-reserved) machine # [ 0.007126] devtmpfs: initialized machine # [ 0.008021] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.008031] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.008202] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.008206] 0 pages in range for non-PLT usage machine # [ 0.008208] 508272 pages in range for PLT usage machine # [ 0.008290] pinctrl core: initialized pinctrl subsystem machine # [ 0.008831] SMBIOS 3.0.0 present. machine # [ 0.008837] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 machine # [ 0.008845] DMI: Memory slots populated: 1/1 machine # [ 0.010264] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.010930] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.011074] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.011228] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.011250] audit: initializing netlink subsys (disabled) machine # [ 0.011646] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.011648] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.011652] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.011655] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.011657] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.011681] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1 machine # [ 0.011692] cpuidle: using governor ladder machine # [ 0.011699] cpuidle: using governor menu machine # [ 0.011850] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.011869] ASID allocator initialised with 65536 entries machine # [ 0.012575] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.012757] Serial: AMBA PL011 UART driver machine # [ 0.018943] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.018950] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.018953] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.018956] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.018959] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.018962] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.018965] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.018967] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.019751] fbcon: Taking over console machine # [ 0.019790] ACPI: Added _OSI(Module Device) machine # [ 0.019793] ACPI: Added _OSI(Processor Device) machine # [ 0.019796] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.020806] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.026836] ACPI: Interpreter enabled machine # [ 0.026841] ACPI: Using GIC for interrupt routing machine # [ 0.026867] ACPI: MCFG table detected, 1 entries machine # [ 0.030811] ACPI: CPU0 has been hot-added machine # [ 0.031241] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA machine # [ 0.031319] printk: console [ttyAMA0] enabled machine # [ 0.081157] ACPI: PCI: Interrupt link L000 configured for IRQ 35 machine # [ 0.081173] ACPI: PCI: Interrupt link L001 configured for IRQ 36 machine # [ 0.081186] ACPI: PCI: Interrupt link L002 configured for IRQ 37 machine # [ 0.081198] ACPI: PCI: Interrupt link L003 configured for IRQ 38 machine # [ 0.081215] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.081261] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.081345] acpi PNP0A08:00: _OSC: platform does not support [LTR] machine # [ 0.081438] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] machine # [ 0.081698] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 machine # [ 0.081719] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.081741] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] machine # [ 0.082123] PCI host bridge to bus 0000:00 machine # [ 0.082149] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] machine # [ 0.082154] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] machine # [ 0.082157] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] machine # [ 0.082162] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.082166] PCI: OF: of_root node is NULL, cannot create PCI host bridge node machine # [ 0.082225] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.082704] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.082882] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f] machine # [ 0.082893] pci 0000:00:01.0: BAR 1 [mem 0x1004d000-0x1004dfff] machine # [ 0.082918] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] machine # [ 0.082929] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref] machine # [ 0.083418] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.084419] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f] machine # [ 0.084432] pci 0000:00:02.0: BAR 1 [mem 0x1004c000-0x1004cfff] machine # [ 0.084457] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref] machine # [ 0.085084] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.085938] pci 0000:00:03.0: BAR 0 [io 0x0100-0x017f] machine # [ 0.085949] pci 0000:00:03.0: BAR 1 [mem 0x1004b000-0x1004bfff] machine # [ 0.085974] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref] machine # [ 0.211617] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.211818] pci 0000:00:04.0: BAR 0 [io 0x0080-0x00ff] machine # [ 0.211835] pci 0000:00:04.0: BAR 1 [mem 0x1004a000-0x1004afff] machine # [ 0.211864] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref] machine # [ 0.212356] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.217585] pci 0000:00:05.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.217612] pci 0000:00:05.0: BAR 1 [mem 0x10049000-0x10049fff] machine # [ 0.217642] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref] machine # [ 0.218185] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.218384] pci 0000:00:06.0: BAR 0 [io 0x01e0-0x01ff] machine # [ 0.218400] pci 0000:00:06.0: BAR 1 [mem 0x10048000-0x10048fff] machine # [ 0.218431] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref] machine # [ 0.218447] pci 0000:00:06.0: ROM [mem 0xfffc0000-0xffffffff pref] machine # [ 0.218928] pci 0000:00:07.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.220232] pci 0000:00:07.0: BAR 1 [mem 0x10047000-0x10047fff] machine # [ 0.220268] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref] machine # [ 0.220789] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.220976] pci 0000:00:08.0: BAR 1 [mem 0x10046000-0x10046fff] machine # [ 0.221005] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref] machine # [ 0.233043] pci 0000:00:09.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.234010] pci 0000:00:09.0: BAR 0 [mem 0x10045000-0x10045fff] machine # [ 0.236028] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.236221] pci 0000:00:0a.0: BAR 1 [mem 0x10044000-0x10044fff] machine # [ 0.236251] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref] machine # [ 0.236769] pci 0000:00:0b.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.236955] pci 0000:00:0b.0: BAR 1 [mem 0x10043000-0x10043fff] machine # [ 0.236987] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref] machine # [ 0.237481] pci 0000:00:0c.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.237678] pci 0000:00:0c.0: BAR 1 [mem 0x10042000-0x10042fff] machine # [ 0.237709] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref] machine # [ 0.245827] pci 0000:00:0d.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.247632] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x01bf] machine # [ 0.247662] pci 0000:00:0d.0: BAR 1 [mem 0x10041000-0x10041fff] machine # [ 0.247693] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref] machine # [ 0.248231] pci 0000:00:0e.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.248971] pci 0000:00:0e.0: BAR 0 [io 0x01c0-0x01df] machine # [ 0.248997] pci 0000:00:0e.0: BAR 1 [mem 0x10040000-0x10040fff] machine # [ 0.249027] pci 0000:00:0e.0: BAR 4 [mem 0x8000030000-0x8000033fff 64bit pref] machine # [ 0.249596] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.249610] pci 0000:00:06.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.249617] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.249679] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.249727] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.249776] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.249824] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.249872] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.249920] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.265489] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.265562] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.265611] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.265675] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.265724] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned machine # [ 0.265772] pci 0000:00:0e.0: BAR 4 [mem 0x8000030000-0x8000033fff 64bit pref]: assigned machine # [ 0.265818] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.265841] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.265864] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.265886] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.265910] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.265933] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.265956] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.266637] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.266667] pci 0000:00:09.0: BAR 0 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.267217] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.267248] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.267273] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.267297] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned machine # [ 0.267320] pci 0000:00:0e.0: BAR 1 [mem 0x1008d000-0x1008dfff]: assigned machine # [ 0.267343] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.286172] pci 0000:00:04.0: BAR 0 [io 0x1080-0x10ff]: assigned machine # [ 0.286211] pci 0000:00:05.0: BAR 0 [io 0x1100-0x117f]: assigned machine # [ 0.288320] pci 0000:00:0d.0: BAR 0 [io 0x1180-0x11bf]: assigned machine # [ 0.288938] pci 0000:00:01.0: BAR 0 [io 0x11c0-0x11df]: assigned machine # [ 0.288971] pci 0000:00:02.0: BAR 0 [io 0x11e0-0x11ff]: assigned machine # [ 0.289542] pci 0000:00:06.0: BAR 0 [io 0x1200-0x121f]: assigned machine # [ 0.289572] pci 0000:00:0e.0: BAR 0 [io 0x1220-0x123f]: assigned machine # [ 0.290420] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] machine # [ 0.290442] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] machine # [ 0.290449] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] machine # [ 0.300484] iommu: Default domain type: Translated machine # [ 0.300505] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.302054] SCSI subsystem initialized machine # [ 0.302671] ACPI: bus type USB registered machine # [ 0.302713] usbcore: registered new interface driver usbfs machine # [ 0.302741] usbcore: registered new interface driver hub machine # [ 0.302760] usbcore: registered new device driver usb machine # [ 0.302972] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.302980] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.302993] PTP clock support registered machine # [ 0.303038] EDAC MC: Ver: 3.0.0 machine # [ 0.308266] scmi_core: SCMI protocol bus registered machine # [ 0.309009] efivars: Registered efivars operations machine # [ 0.310033] FPGA manager framework machine # [ 0.310936] vgaarb: loaded machine # [ 0.311534] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.314060] VFS: Disk quotas dquot_6.6.0 machine # [ 0.314105] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.315564] netfs: FS-Cache loaded machine # [ 0.315689] pnp: PnP ACPI init machine # [ 0.315910] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved machine # [ 0.315972] pnp: PnP ACPI: found 1 devices machine # [ 0.321277] NET: Registered PF_INET protocol family machine # [ 0.321346] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.341453] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.341515] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.341546] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.341592] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.341688] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.341784] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.341819] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.341846] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.341944] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.341978] NET: Registered PF_XDP protocol family machine # [ 0.342805] PCI: CLS 0 bytes, default 64 machine # [ 0.343052] Trying to unpack rootfs image as initramfs... machine # [ 0.360869] kvm [1]: HYP mode not available machine # [ 0.456505] Initialise system trusted keyrings machine # [ 0.457297] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.458472] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.459254] 9p: Installing v9fs 9p2000 file system support machine # [ 0.479949] Key type asymmetric registered machine # [ 0.479982] Asymmetric key parser 'x509' registered machine # [ 0.480065] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.487611] io scheduler mq-deadline registered machine # [ 0.487644] io scheduler kyber registered machine # [ 0.499592] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.501570] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 machine # [ 0.501629] ACPI: button: Power Button [PWRB] machine # [ 0.527157] ACPI: \_SB_.L001: Enabled at IRQ 36 machine # [ 0.527223] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.531087] ACPI: \_SB_.L002: Enabled at IRQ 37 machine # [ 0.531146] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007) machine # [ 0.534320] ACPI: \_SB_.L003: Enabled at IRQ 38 machine # [ 0.534361] virtio-pci 0000:00:03.0: enabling device (0005 -> 0007) machine # [ 0.544593] ACPI: \_SB_.L000: Enabled at IRQ 35 machine # [ 0.544649] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.547117] virtio-pci 0000:00:05.0: enabling device (0005 -> 0007) machine # [ 0.550826] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.562834] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.565833] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.575933] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0002) machine # [ 0.578479] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0002) machine # [ 0.580643] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007) machine # [ 0.582476] virtio-pci 0000:00:0e.0: enabling device (0005 -> 0007) machine # [ 0.600252] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.602787] msm_serial: driver initialized machine # [ 0.602922] SuperH (H)SCI(F) driver initialized machine # [ 0.602960] STM32 USART driver initialized machine # [ 0.622972] ACPI: bus type drm_connector registered machine # [ 0.633362] loop: module loaded machine # [ 0.633542] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.634270] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.639783] virtio_blk virtio3: 1/0/0 default/read/poll queues machine # [ 0.640488] virtio_blk virtio3: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB) machine # [ 0.643752] virtio_blk virtio4: 1/0/0 default/read/poll queues machine # [ 0.644434] virtio_blk virtio4: [vdc] 534561 512-byte logical blocks (274 MB/261 MiB) machine # [ 0.683625] vdc: vdc1 machine # [ 0.684396] megasas: 07.734.00.00-rc1 machine # [ 0.686590] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.689549] thunder_xcv, ver 1.0 machine # [ 0.689583] thunder_bgx, ver 1.0 machine # [ 0.689614] nicpf, ver 1.0 machine # [ 0.690189] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.690197] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.690223] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.690229] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.690255] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.690262] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.690293] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.690300] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.690420] sky2: driver version 1.30 machine # [ 0.692593] ehci-pci 0000:00:09.0: EHCI Host Controller machine # [ 0.692621] ehci-pci 0000:00:09.0: new USB bus registered, assigned bus number 1 machine # [ 0.692843] ehci-pci 0000:00:09.0: irq 45, io mem 0x10088000 machine # [ 0.703524] usbcore: registered new interface driver usb-storage machine # [ 0.703566] ehci-pci 0000:00:09.0: USB 2.0 started, EHCI 1.00 machine # [ 0.703883] hub 1-0:1.0: USB hub found machine # [ 0.703906] hub 1-0:1.0: 6 ports detected machine # [ 0.706742] usbcore: registered new interface driver usbserial_generic machine # [ 0.706763] usbserial: USB Serial support registered for generic machine # [ 0.707306] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.710124] rtc-efi rtc-efi.0: registered as rtc0 machine # [ 0.710159] rtc-efi rtc-efi.0: setting system clock to 2026-09-22T02:59:40 UTC (1790045980) machine # [ 0.710472] i2c_dev: i2c /dev entries driver machine # [ 0.715580] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.715593] sdhci: Copyright(c) Pierre Ossman machine # [ 0.715840] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.716156] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.717232] pstore: Using crash dump compression: deflate machine # [ 0.717241] pstore: Registered efi_pstore as persistent store backend machine # [ 0.728691] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.728989] usbcore: registered new interface driver usbhid machine # [ 0.728997] usbhid: USB HID core driver machine # [ 0.731684] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available machine # [ 0.733017] drop_monitor: Initializing network drop monitor service machine # [ 0.733210] NET: Registered PF_INET6 protocol family machine # [ 0.736220] Segment Routing with IPv6 machine # [ 0.736241] In-situ OAM (IOAM) with IPv6 machine # [ 0.736279] NET: Registered PF_PACKET protocol family machine # [ 0.737838] 9pnet: Installing 9P2000 support machine # [ 0.737888] Key type dns_resolver registered machine # [ 0.752306] registered taskstats version 1 machine # [ 0.752463] Loading compiled-in X.509 certificates machine # [ 0.775593] Demotion targets for Node 0: null machine # [ 0.776538] Key type .fscrypt registered machine # [ 0.776551] Key type fscrypt-provisioning registered machine # [ 0.776660] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.776682] ima: Allocated hash algorithm: sha1 machine # [ 0.776706] ima: No architecture policies found machine # [ 0.812842] clk: Disabling unused clocks machine # [ 0.812875] PM: genpd: Disabling unused power domains machine # [ 0.955581] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 0.975150] Freeing initrd memory: 26660K machine # [ 0.978564] Freeing unused kernel memory: 4736K machine # [ 0.978761] Run /init as init process machine # [ 0.999428] fuse: init (API version 7.45) machine # [ 1.002888] virtiofs virtio8: discovered new tag: nix-store machine # [ 1.004350] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.021691] virtiofs virtio9: discovered new tag: shared machine # [ 1.022458] virtiofs virtio9: virtio_fs_setup_dax: No cache capability machine # [ 1.025326] virtiofs virtio10: discovered new tag: xchg machine # [ 1.026090] virtiofs virtio10: virtio_fs_setup_dax: No cache capability machine # [ 1.039862] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.108252] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:09.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.179966] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:09.0-1/input0 machine # [ 1.303698] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.374882] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 1.386736] systemd[1]: Detected virtualization kvm. machine # [ 1.388722] systemd[1]: Detected architecture arm64. machine # [ 1.390592] systemd[1]: Running in initrd. machine # [ 1.393240] systemd[1]: Initializing machine ID from random generator. machine # [ 1.396052] systemd[1]: Hostname set to . machine # [ 1.500037] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:09.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.500338] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:09.0-2/input0 machine # [ 1.578874] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.636658] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.645483] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.646898] systemd[1]: Created slice Slice /system/systemd-cryptsetup. machine # [ 1.648001] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.648985] systemd[1]: Expecting device /dev/mapper/cryptroot... machine # [ 1.649775] systemd[1]: Expecting device /dev/tpm0... machine # [ 1.650421] systemd[1]: Expecting device /dev/tpmrm0... machine # [ 1.651080] systemd[1]: Expecting device /dev/vdb... machine # [ 1.651778] systemd[1]: Reached target Path Units. machine # [ 1.652396] systemd[1]: Reached target Slice Units. machine # [ 1.653021] systemd[1]: Reached target Swaps. machine # [ 1.653592] systemd[1]: Reached target Timer Units. machine # [ 1.654394] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.655333] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.656266] systemd[1]: Listening on Journal Sockets. machine # [ 1.656984] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.657684] systemd[1]: Reached target Socket Units. machine # [ 1.659658] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.660567] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.664992] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.682241] systemd[1]: Starting Journal Service... machine # [ 1.695194] systemd[1]: Starting Load Kernel Modules... machine # [ 1.709471] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.727655] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.728651] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.743508] systemd-journald[70]: Collecting audit messages is disabled. machine # [ 1.745078] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.764858] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.766667] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.784800] [drm] pci: virtio-gpu-pci detected at 0000:00:07.0 machine # [ 1.785047] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.785057] [drm] features: -context_init machine # [ 1.785802] [drm] number of scanouts: 1 machine # [ 1.785821] [drm] number of cap sets: 0 machine # [ 1.791702] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.794294] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.807893] virtio-pci 0000:00:07.0: [drm] Registered 1 planes with drm panic machine # [ 1.807916] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:07.0 on minor 0 machine # [ 1.828843] Console: switching to colour frame buffer device 160x50 machine # [ 1.852240] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.853284] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.854169] systemd[1]: Reached target Local File Systems. machine # [ 1.860232] virtio-pci 0000:00:07.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.864261] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.883848] systemd[1]: Finished Load Kernel Modules. machine # [ 1.887942] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.940271] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.944029] systemd[1]: Started Journal Service. machine # [ 1.920424] systemd-modules-load[71]: Inserted module 'dm_mod' machine # [ 1.928523] systemd-modules-load[71]: Module 'virtio_balloon' is built in machine # [ 1.929637] systemd-modules-load[71]: Module 'virtio_console' is built in machine # [ 1.930712] systemd-modules-load[71]: Inserted module 'virtio_gpu' machine # [ 1.931683] systemd-modules-load[71]: Module 'virtio_rng' is built in machine # [ 1.944438] systemd[1]: Starting Create System Files and Directories... machine # [ 1.964393] systemd-udevd[78]: Using default interface naming scheme 'v261'. machine # [ 1.971734] systemd[1]: Finished Create System Files and Directories. machine # [ 1.999225] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.064520] systemd[1]: Starting Virtual Console Setup... machine # [ 2.120583] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.124332] systemd[1]: Finished Virtual Console Setup. machine # [ 2.757158] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.929170] systemd[1]: Found device /dev/vdb. machine # [ 2.938384] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.944288] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.961633] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) machine # [ 4.084572] systemd[1]: Found device /dev/tpm0. machine # [ 4.097603] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.102765] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.104453] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.107525] systemd[1]: Starting Virtual Console Setup... machine # [ 4.111319] systemd[1]: Found device /dev/tpmrm0. machine # [ 4.115324] systemd[1]: Reached target Trusted Platform Module. machine # [ 4.116623] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.130049] systemd[1]: Starting Cryptography Setup for cryptroot... machine # [ 4.162521] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.164508] systemd[1]: Finished Virtual Console Setup. machine # [ 4.539466] Key type trusted registered machine # [ 4.543727] Key type encrypted registered machine # [ 4.558408] systemd[1]: Finished Cryptography Setup for cryptroot. machine # [ 4.560205] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 4.561116] systemd[1]: Reached target System Initialization. machine # [ 4.564186] systemd[1]: Reached target Basic System. machine # [ 4.566096] systemd[1]: Found device /dev/mapper/cryptroot. machine # [ 4.568257] systemd[1]: Reached target Initrd Root Device. machine # [ 4.569549] systemd[1]: Starting File System Check on /dev/mapper/cryptroot... machine # [ 4.600498] systemd-fsck[126]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks machine # [ 4.608252] systemd[1]: Finished File System Check on /dev/mapper/cryptroot. machine # [ 4.611510] systemd[1]: Mounting /sysroot... machine # [ 4.722144] EXT4-fs (dm-0): mounted filesystem 6163e7d9-5069-4a1b-b8bf-2da9fbbbbe99 r/w with ordered data mode. Quota mode: none. machine # [ 4.695223] systemd[1]: Mounted /sysroot. machine # [ 4.696319] systemd[1]: Reached target Initrd Root File System. machine # [ 4.698650] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 4.721227] systemd-sysroot-fstab-check[133]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 4.724800] systemd[1]: Reload requested from client PID 133 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 4.728158] systemd[1]: Reloading... machine # [ 4.847803] systemd[1]: Reloading finished in 120 ms. machine # [ 4.871427] systemd-sysroot-fstab-check[133]: Requesting initrd-fs.target/start/replace... machine # [ 4.874202] systemd-sysroot-fstab-check[133]: Requesting swap.target/start/replace... machine # [ 4.879471] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 4.881398] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 4.882387] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 5.135826] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 5.144405] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 5.158556] systemd[1]: Mounting /sysroot/run... machine # [ 5.177800] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 5.197784] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 5.214958] systemd[1]: Mounted /sysroot/run. machine # [ 5.223351] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 5.225579] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 5.243116] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 5.245694] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 5.254971] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 5.273191] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 5.274655] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 6.134977] systemd[1]: Mounting /sysroot/nix/store... machine # [ 6.201507] systemd[1]: Mounted /sysroot/nix/store. machine # [ 6.205284] systemd[1]: Reached target Initrd File Systems. machine # [ 6.208235] systemd[1]: Starting Find NixOS closure... machine # [ 6.213624] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 6.259938] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 6.261759] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 6.271824] systemd[1]: Finished Find NixOS closure. machine # [ 6.273956] systemd[1]: Reached target Initrd Default Target. machine # [ 6.277551] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 6.309593] systemd[1]: Stopped target Initrd Default Target. machine # [ 6.311862] systemd[1]: Stopped target Basic System. machine # [ 6.313392] systemd[1]: Stopped target Initrd Root Device. machine # [ 6.316400] systemd[1]: Stopped target Path Units. machine # [ 6.318510] systemd[1]: Stopped target Slice Units. machine # [ 6.321730] systemd[1]: Stopped target Socket Units. machine # [ 6.322757] systemd[1]: Stopped target System Initialization. machine # [ 6.328177] systemd[1]: Stopped target Local Encrypted Volumes. machine # [ 6.329369] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 6.330758] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 6.333600] systemd[1]: Stopped target Swaps. machine # [ 6.337044] systemd[1]: Stopped target Timer Units. machine # [ 6.339519] systemd[1]: Stopped target Trusted Platform Module. machine # [ 6.348244] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 6.349222] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 6.350157] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 6.351295] systemd[1]: Stopped Find NixOS closure. machine # [ 6.356289] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 6.358199] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 6.359222] systemd[1]: Stopped Apply Kernel Variables. machine # [ 6.359998] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 6.369147] systemd[1]: Stopped Load Kernel Modules. machine # [ 6.371320] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 6.376661] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 6.379843] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 6.384592] systemd[1]: Stopped Create System Files and Directories. machine # [ 6.385570] systemd[1]: Stopped target Local File Systems. machine # [ 6.386378] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 6.387304] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 6.390166] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 6.392237] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 6.394131] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.395284] systemd[1]: Stopped Virtual Console Setup. machine # [ 6.396128] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 6.397058] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 6.397966] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 6.398908] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 6.399903] systemd[1]: systemd-udevd.service: Consumed 1.573s CPU time over 4.538s wall clock time, 23.8M memory peak. machine # [ 6.404316] systemd[1]: Starting Cleanup udev Database... machine # [ 6.407254] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 6.412169] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 6.413151] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 6.414285] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 6.415263] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 6.420206] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 6.421091] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 6.422070] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 6.453700] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 6.456520] systemd[1]: Finished Cleanup udev Database. machine # [ 6.458122] systemd[1]: Reached target Switch Root. machine # [ 6.459336] systemd[1]: Starting NixOS Activation... machine # [ 6.546031] initrd-nixos-activation-start[186]: booting system configuration /nix/store/nczpdhkj5162qwmfm162vscx73k0x9bx-nixos-system-machine-test machine # [ 6.579944] initrd-nixos-activation-start[186]: running activation script... machine # [ 6.811108] initrd-nixos-activation-start[209]: setting up /etc... machine # [ 6.935884] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 6.939079] systemd[1]: Finished NixOS Activation. machine # [ 6.940255] systemd[1]: Starting Switch Root... machine # [ 6.964809] systemd[1]: Switching root. machine # [ 7.174519] systemd-journald[70]: Received SIGTERM from PID 1 (systemd). machine # [ 7.301731] NET: Registered PF_VSOCK protocol family machine # [ 7.673432] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 7.686157] systemd[1]: Detected virtualization kvm. machine # [ 7.689337] systemd[1]: Detected architecture arm64. machine # [ 7.692456] systemd[1]: Detected first boot. machine # [ 7.698780] systemd[1]: Initializing machine ID from random generator. machine # [ 7.860582] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 8.049435] systemd[1]: Applying preset policy. machine # [ 8.299156] systemd[1]: Populated /etc with preset unit settings. machine # [ 8.534065] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 8.535909] systemd[1]: Stopped initrd-switch-root.service. machine # [ 8.538957] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 8.543008] systemd[1]: Created slice Slice /system/getty. machine # [ 8.545328] systemd[1]: Created slice Slice /system/systemd-fsck. machine # [ 8.547368] systemd[1]: Created slice User and Session Slice. machine # [ 8.548833] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 8.550664] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 8.552527] systemd[1]: Expecting device /dev/disk/by-label/ESP... machine # [ 8.555030] systemd[1]: Expecting device /dev/hvc0... machine # [ 8.556126] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 8.558508] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 8.559687] systemd[1]: Stopped target initrd-fs.target. machine # [ 8.561188] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 8.562801] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 8.564730] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 8.567299] systemd[1]: Reached target Path Units. machine # [ 8.568304] systemd[1]: Reached target Remote File Systems. machine # [ 8.569884] systemd[1]: Reached target Slice Units. machine # [ 8.571420] systemd[1]: Reached target Swaps. machine # [ 8.575068] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 8.578061] systemd[1]: Listening on Process Core Dump Socket. machine # [ 8.580176] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 8.582354] systemd[1]: Listening on Factory Reset Management. machine # [ 8.583632] systemd[1]: Listening on Hostname Service Socket. machine # [ 8.588133] systemd[1]: Starting Journal Log Access Socket... machine # [ 8.589795] systemd[1]: Listening on Journal Audit Socket. machine # [ 8.592396] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 8.593933] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 8.596007] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.598741] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 8.605491] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 8.606952] systemd[1]: Listening on udev Varlink Socket. machine # [ 8.610722] systemd[1]: Mounting Huge Pages File System... machine # [ 8.615768] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 8.628552] systemd[1]: Mounting Kernel Debug File System... machine # [ 8.632352] systemd[1]: Mounting Kernel Trace File System... machine # [ 8.653623] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 8.656131] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.667997] systemd[1]: Mounting Kernel Configuration File System... machine # [ 8.673213] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 8.682075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 8.684035] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.707857] systemd[1]: Mounting FUSE Control File System... machine # [ 8.740399] systemd[1]: Starting seed-system-profile.service... machine # [ 8.746923] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully. machine # [ 8.751515] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service. machine # [ 8.756362] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 8.775707] systemd[1]: Starting Journal Service... machine # [ 8.793852] systemd[1]: Starting Load Kernel Modules... machine # [ 8.813844] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 8.828256] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 8.829660] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.849152] systemd[1]: Starting Coldplug All udev Devices... machine # [ 8.863072] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.868278] systemd[1]: Mounted Huge Pages File System. machine # [ 8.872150] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.878278] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.891139] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.901530] systemd-journald[281]: Collecting audit messages is enabled. machine # [ 8.905100] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.906882] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.914229] systemd[1]: Finished seed-system-profile.service. machine # [ 8.919029] systemd[1]: Mounted FUSE Control File System. machine # [ 8.896447] systemd[1]: Queued start job for default target Multi-User System. machine # [ 8.897644] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 8.905052] systemd-modules-load[282]: Module 'atkbd' is built in machine # [ 8.938040] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.938612] systemd[1]: Started Journal Service. machine # [ 8.943686] EXT4-fs (dm-0): re-mounted 6163e7d9-5069-4a1b-b8bf-2da9fbbbbe99. machine # [ 8.914795] systemd-modules-load[282]: Module 'loop' is built in machine # [ 8.937289] systemd[1]: Finished Load Kernel Modules. machine # [ 8.943813] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.954023] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.962753] systemd[1]: Starting Firewall... machine # [ 8.968354] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.969331] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.983248] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.985068] systemd-oomd[286]: No swap; memory pressure usage will be degraded machine # [ 9.004758] systemd[1]: Starting Apply Kernel Variables... machine # [ 9.008244] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 9.009480] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 9.115805] systemd-journald[281]: Received client request to flush runtime journal. machine # [ 9.126268] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 9.127217] systemd[1]: Reached target First Boot Complete. machine # [ 9.135832] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 9.143545] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 9.152431] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 9.191830] systemd[1]: Finished Apply Kernel Variables. machine # [ 9.384861] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 9.386333] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 9.393253] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 9.510516] systemd[1]: Mounting /run/wrappers... machine # [ 9.565836] systemd-udevd[320]: Using default interface naming scheme 'v261'. machine # [ 9.587244] systemd[1]: Mounted /run/wrappers. machine # [ 9.589827] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 9.706117] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 10.292130] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.377561] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 10.422421] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 10.568673] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 10.574682] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.703725] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 10.730261] systemd[1]: Found device /dev/tpmrm0. machine # [ 10.732305] systemd[1]: Expecting device /dev/tpm0... machine # [ 10.765050] (udev-worker)[349]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.772210] (udev-worker)[349]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.782025] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 10.964188] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.967350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 10.972786] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 10.973614] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 10.975710] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 11.092438] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped. machine # [ 11.102256] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP... machine # [ 11.107191] systemd[1]: Finished Firewall. machine # [ 11.211596] systemd-fsck[504]: fsck.fat 4.2 (2021-01-31) machine # [ 11.214992] systemd-fsck[504]: There are differences between boot sector and its backup. machine # [ 11.219117] systemd-fsck[504]: This is mostly harmless. Differences: (offset:original/backup) machine # [ 11.223360] systemd-fsck[504]: 65:01/00 machine # [ 11.226863] systemd-fsck[504]: Not automatically fixing this. machine # [ 11.227722] systemd-fsck[504]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. machine # [ 11.233566] systemd-fsck[504]: Automatically removing dirty bit. machine # [ 11.237357] systemd-fsck[504]: *** Filesystem was changed *** machine # [ 11.238216] systemd-fsck[504]: Writing changes. machine # [ 11.238848] systemd-fsck[504]: /dev/vdc1: 20 files, 29075/66398 clusters machine # [ 11.239860] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP. machine # [ 11.250377] systemd[1]: Mounting /boot... machine # [ 11.343030] systemd[1]: Mounted /boot. machine # [ 11.343748] systemd[1]: Reached target Local File Systems. machine # [ 11.348998] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 11.355205] systemd[1]: Starting Update Boot Loader Random Seed... machine # [ 11.360157] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 11.365907] systemd[1]: Starting Create System Files and Directories... machine # [ 11.444720] bootctl[526]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! machine # [ 11.452451] bootctl[526]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole! machine # [ 11.462199] bootctl[526]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes). machine # [ 11.472661] systemd[1]: Finished Update Boot Loader Random Seed. machine # [ 11.522738] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 11.535575] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 11.542492] systemd[1]: Finished Create System Files and Directories. machine # [ 11.579533] mousedev: PS/2 mouse device common for all mice machine # [ 11.549402] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 11.560300] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 11.636836] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 11.666462] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 11.673565] systemd[1]: Starting Update is Completed... machine # [ 11.725877] systemd[1]: Finished Update is Completed. machine # [ 11.740105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 11.742678] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 12.528414] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:08.0/virtio7/input/input3 machine # [ 12.630003] systemd[1]: Found device /dev/tpm0. machine # [ 12.634726] systemd[1]: Reached target Trusted Platform Module. machine # [ 12.635608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.641705] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.649056] systemd[1]: Reached target System Initialization. machine # [ 12.651145] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 12.653026] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 12.653954] systemd[1]: Reached target Timer Units. machine # [ 12.654685] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 12.655577] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 12.664259] systemd[1]: Reached target Socket Units. machine # [ 12.666705] systemd[1]: Reached target Basic System. machine # [ 12.669777] systemd[1]: Started backdoor.service. machine # [ 12.671351] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 12.674522] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 12.684739] systemd[1]: Starting Post-Boot Actions... machine # [ 12.701325] systemd[1]: Started Reset console on configuration changes. machine # [ 12.724145] systemd[1]: Starting resolvconf update... machine # [ 12.787605] systemd[1]: Starting D-Bus System Message Bus... machine # [ 12.837520] systemd[1]: Finished Post-Boot Actions. machine # [ 12.846197] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 12.847481] nsncd[580]: Sep 22 02:59:52.661 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # connecting to host... machine # [ 12.863154] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 12.866590] systemd[1]: Reached target User and Group Name Lookups. machine # [ 12.874575] systemd[1]: Starting User Login Management... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 27.14 seconds) machine: (finished: waiting for the VM to finish booting, in 27.41 seconds) machine # [ 12.989952] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 13.026623] dbus-broker-launch[586]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 13.035888] dbus-broker-launch[586]: NSS returned no entry for 'systemd-timesync' machine # [ 13.037822] dbus-broker-launch[586]: Invalid user-name in /nix/store/n82qmllck1wqkqlp3l88kfg1jmfr56mr-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 13.095422] systemd-logind[602]: New seat seat0. machine # [ 13.102779] systemd-logind[602]: Watching system buttons on /dev/input/event0 (Power Button) machine # [ 13.108540] systemd-logind[602]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 13.139282] dbus-broker-launch[586]: Ready machine # [ 13.165561] systemd-logind[602]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 13.193123] systemd[1]: Started D-Bus System Message Bus. machine # [ 13.196104] systemd[1]: Started User Login Management. machine # [ 13.238961] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 13.239995] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 13.244843] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 13.245727] systemd[1]: Stopping User and Group Name Lookups... machine # [ 13.252931] systemd[1]: Starting linger-users.service... machine # [ 13.253777] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 13.258872] systemd[1]: Starting Virtual Console Setup... machine # [ 13.259676] systemd[1]: nscd.service: Deactivated successfully. machine # [ 13.264400] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 13.299280] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 13.340135] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 13.348199] systemd[1]: Finished linger-users.service. machine # [ 13.359656] systemd[1]: Finished resolvconf update. machine # [ 13.362553] systemd[1]: Reached target Preparation for Network. machine # [ 13.367093] systemd[1]: Starting DHCP Client... machine # [ 13.385320] nsncd[674]: Sep 22 02:59:53.203 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 13.389759] systemd[1]: Starting Address configuration of eth1... machine # [ 13.394895] systemd[1]: Starting Extra networking commands.... machine # [ 13.402595] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 13.417862] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 13.421965] systemd[1]: Reached target User and Group Name Lookups. machine # [ 13.545072] network-addresses-eth1-start[684]: adding address 192.168.1.1/24... done machine # [ 13.563229] network-addresses-eth1-start[684]: adding address 2001:db8:1::1/64... done machine # [ 13.594361] systemd[1]: Finished Address configuration of eth1. machine # [ 13.649758] dhcpcd[703]: dhcpcd-10.3.2 starting machine # [ 13.658450] dhcpcd[751]: dev: loaded udev machine # [ 13.723869] 8021q: 802.1Q VLAN Support v1.8 machine # [ 13.724256] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 13.697346] systemd[1]: Finished Extra networking commands.. machine # [ 13.699884] systemd[1]: Reached target Network. machine # [ 13.706753] systemd[1]: Starting Permit User Sessions... machine # [ 13.735569] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.808479] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 13.790420] systemd[1]: Finished Permit User Sessions. machine # [ 13.796800] systemd[1]: Started Getty on tty1. machine # [ 13.801074] systemd[1]: Reached target Login Prompts. machine # [ 13.845281] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 13.845818] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 13.849334] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 13.849681] cfg80211: failed to load regulatory.db machine # [ 13.891062] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 13.862208] dhcpcd[751]: eth0: waiting for carrier machine # [ 13.863024] dhcpcd[751]: eth0: carrier acquired machine # [ 13.870295] dhcpcd[751]: DUID 00:01:00:01:32:44:ab:a9:52:54:00:12:34:56 machine # [ 13.871331] dhcpcd[751]: eth0: IAID 00:12:34:56 machine # [ 13.872343] dhcpcd[751]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.881931] systemd-vconsole-setup[664]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.885785] systemd[1]: Finished Virtual Console Setup. machine # [ 15.487245] dhcpcd[751]: eth0: soliciting a DHCP lease machine # [ 15.493091] dhcpcd[751]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 15.500475] dhcpcd[751]: eth0: probing address 10.0.2.15/24 machine # [ 16.338748] dhcpcd[751]: eth0: soliciting an IPv6 router machine # [ 16.342645] dhcpcd[751]: eth0: Router Advertisement from fe80::2 machine # [ 16.345241] dhcpcd[751]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 16.347989] dhcpcd[751]: eth0: adding route to fec0::/64 machine # [ 16.350268] dhcpcd[751]: eth0: adding default route via fe80::2 machine # [ 21.173483] dhcpcd[751]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 21.178794] dhcpcd[751]: eth0: adding route to 10.0.2.0/24 machine # [ 21.183701] dhcpcd[751]: eth0: adding default route via 10.0.2.2 machine # [ 21.306916] systemd[1]: Started DHCP Client. machine # [ 21.309796] systemd[1]: Reached target Multi-User System. machine # [ 21.311262] systemd[1]: Startup finished in 7.096s (firmware) + 6.429s (loader) + 951ms (kernel) + 6.292s (initrd) + 14.066s (userspace) = 34.836s. machine: (finished: waiting for unit multi-user.target, in 36.63 seconds) machine: must succeed: mount machine: (finished: must succeed: mount, in 0.03 seconds) (finished: run the VM test script, in 79.37 seconds) test script finished in 79.44s cleanup kill QemuMachine (pid 112) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14) machine # [2026-09-22T03:00:02Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T03:00:02Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T03:00:02Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.10 seconds)