vm-test-run-systemd-initrd-luks-tpm2
checks.aarch64-linux.systemd-initrd-luks-tpm2
· build #2
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/machine.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=2523922432 backing_file=/nix/store/vgfdfw0gwi972l4da3mxl3b0zid0yg75-nixos-disk-image/nixos.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=1613machine # Virtualisation disk image created.14machine # Formatting 'empty0.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=536870912 lazy_refcounts=off refcount_bits=1615machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)16machine: 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'17machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)18machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)19machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\nBdsDxe: starting Boot0002 "UEFI Misc Device" from Pc'20machine: Guest shell says: b'iRoot(0x0)/Pci(0x6,0x0)\r\n'21machine: 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 (boot-luks) \x1b[021;063'22machine: Guest shell says: b'H\x1b[1m\x1b[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS \x1b[022;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Reboot Into Firmware I'23machine: Guest shell says: b'nterface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot '24machine: Guest shell says: b'in 5s. \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m----------'25machine: Guest shell says: b'--------------------------------'26machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. '27machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'28machine: Guest shell says: b'------------------------------------------'29machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. '30machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'31machine: Guest shell says: b'---------------------'32machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. '33machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'34machine: Guest shell says: b'------------------------------------------'35machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '36machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'37machine: Guest shell says: b'---------------------'38machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'39machine # 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]40machine # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 23 12:27:10 UTC 202641machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] efi: EFI v2.7 by EDK II43machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fe0000 MEMATTR=0x45ad8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a6b018 INITRD=0x45ad0418 MEMRESERVE=0x45ad221844machine # [ 0.000000] random: crng init done45machine # [ 0.000000] ACPI: Early table checksum verification disabled46machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )47machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013)48machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)49machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001811 (v02 BOCHS BXPC 00000001 BXPC 00000001)50machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)51machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)52machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)53machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)54machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)55machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)56machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)57machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)58machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013)59machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,960060machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]61machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf2880-0x7fdf5fff]62machine # [ 0.000000] Zone ranges:63machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]64machine # [ 0.000000] DMA32 empty65machine # [ 0.000000] Normal empty66machine # [ 0.000000] Device empty67machine # [ 0.000000] Movable zone start for each node68machine # [ 0.000000] Early memory node ranges69machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045fcffff]70machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff]71machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff]72machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]73machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]74machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]75machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]76machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]77machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]78machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]79machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000080machine # [ 0.000000] psci: probing for conduit method from ACPI.81machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.82machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs83machine # [ 0.000000] psci: Trusted OS migration not required84machine # [ 0.000000] psci: SMC Calling Convention v1.185machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)86machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129687machine # [ 0.000000] Detected PIPT I-cache on CPU088machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)89machine # [ 0.000000] CPU features: detected: GICv3 CPU interface90machine # [ 0.000000] CPU features: detected: Spectre-v491machine # [ 0.000000] CPU features: detected: Spectre-BHB92machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3893machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2394machine # [ 0.000000] alternatives: applying boot alternatives95machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\1ff0054qr1yxya60am779rr3ihdkx8ac-initrd-linux-6.18.46-initrd.efi init=/nix/store/k5qfhlsk6gf5m2rayvri84dimg4dnxyl-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,bpf96machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes97machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)98machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)99machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB100machine # [ 0.000000] software IO TLB: area num 1.101machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)102machine # [ 0.000000] Fallback order for Node 0: 0103machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144104machine # [ 0.000000] Policy zone: DMA105machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off106machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1107machine # [ 0.000000] allocated 2097152 bytes of page_ext108machine # [ 0.000000] ftrace: allocating 74884 entries in 294 pages109machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups110machine # [ 0.000000] rcu: Hierarchical RCU implementation.111machine # [ 0.000000] rcu: RCU event tracing is enabled.112machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.113machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.114machine # [ 0.000000] Rude variant of Tasks RCU enabled.115machine # [ 0.000000] Tracing variant of Tasks RCU enabled.116machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.117machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1118machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.119machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.120machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.121machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0122machine # [ 0.000000] GICv3: 256 SPIs implemented123machine # [ 0.000000] GICv3: 0 Extended SPIs implemented124machine # [ 0.000000] Root IRQ handler: gic_handle_irq125machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI126machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0127machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000128machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]129machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)130machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)131machine # [ 0.000000] GICv3: using LPI property table @0x0000000040910000132machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000040930000133machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.134machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns135machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).136machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns137machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns138machine # [ 0.000031] arm-pv: using stolen time PV139machine # [ 0.000417] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)140machine # [ 0.000514] Console: colour dummy device 80x25141machine # [ 0.000519] printk: legacy console [tty0] enabled142machine # [ 0.000738] ACPI: Core revision 20250807143machine # [ 0.000816] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)144machine # [ 0.000824] pid_max: default: 32768 minimum: 301145machine # [ 0.000884] LSM: initializing lsm=capability,landlock,yama,bpf,ima146machine # [ 0.001013] landlock: Up and running.147machine # [ 0.001017] Yama: becoming mindful.148machine # [ 0.001485] LSM support for eBPF active149machine # [ 0.001580] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)150machine # [ 0.001588] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151machine # [ 0.002764] rcu: Hierarchical SRCU implementation.152machine # [ 0.002769] rcu: Max phase no-delay instances is 1000.153machine # [ 0.003485] fsl-mc MSI: ITS@0x8080000 domain created154machine # [ 0.003512] Remapping and enabling EFI services.155machine # [ 0.003675] smp: Bringing up secondary CPUs ...156machine # [ 0.003685] smp: Brought up 1 node, 1 CPU157machine # [ 0.003688] SMP: Total of 1 processors activated.158machine # [ 0.003691] CPU: All CPU(s) started at EL1159machine # [ 0.003702] CPU features: detected: Branch Target Identification160machine # [ 0.003708] CPU features: detected: ARMv8.4 Translation Table Level161machine # [ 0.003711] CPU features: detected: Instruction cache invalidation not required for I/D coherence162machine # [ 0.003715] CPU features: detected: Data cache clean to the PoU not required for I/D coherence163machine # [ 0.003718] CPU features: detected: Common not Private translations164machine # [ 0.003721] CPU features: detected: CRC32 instructions165machine # [ 0.003724] CPU features: detected: Data cache clean to Point of Deep Persistence166machine # [ 0.003728] CPU features: detected: Data cache clean to Point of Persistence167machine # [ 0.003731] CPU features: detected: Data independent timing control (DIT)168machine # [ 0.003734] CPU features: detected: E0PD169machine # [ 0.003736] CPU features: detected: Enhanced Counter Virtualization170machine # [ 0.003739] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)171machine # [ 0.003743] CPU features: detected: Enhanced Virtualization Traps172machine # [ 0.003746] CPU features: detected: Fine Grained Traps173machine # [ 0.003750] CPU features: detected: Generic authentication (architected QARMA5 algorithm)174machine # [ 0.003754] CPU features: detected: RCpc load-acquire (LDAPR)175machine # [ 0.003757] CPU features: detected: LSE atomic instructions176machine # [ 0.003760] CPU features: detected: Privileged Access Never177machine # [ 0.003763] CPU features: detected: PMUv3178machine # [ 0.003766] CPU features: detected: RAS Extension Support179machine # [ 0.003769] CPU features: detected: RASv1p1 Extension Support180machine # [ 0.003772] CPU features: detected: Random Number Generator181machine # [ 0.003774] CPU features: detected: Speculation barrier (SB)182machine # [ 0.003777] CPU features: detected: Stage-2 Force Write-Back183machine # [ 0.003780] CPU features: detected: TLB range maintenance instructions184machine # [ 0.003784] CPU features: detected: Speculative Store Bypassing Safe (SSBS)185machine # [ 0.003822] alternatives: applying system-wide alternatives186machine # [ 0.006646] CPU features: detected: BBM Level 2 without TLB conflict abort187machine # [ 0.006770] Memory: 887104K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120136K reserved, 32768K cma-reserved)188machine # [ 0.007075] devtmpfs: initialized189machine # [ 0.008045] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)190machine # [ 0.008055] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).191machine # [ 0.008227] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL192machine # [ 0.008232] 0 pages in range for non-PLT usage193machine # [ 0.008233] 508288 pages in range for PLT usage194machine # [ 0.008310] pinctrl core: initialized pinctrl subsystem195machine # [ 0.008876] SMBIOS 3.0.0 present.196machine # [ 0.008881] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022197machine # [ 0.008890] DMI: Memory slots populated: 1/1198machine # [ 0.010224] NET: Registered PF_NETLINK/PF_ROUTE protocol family199machine # [ 0.010889] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations200machine # [ 0.011034] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations201machine # [ 0.011191] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202machine # [ 0.011212] audit: initializing netlink subsys (disabled)203machine # [ 0.011636] thermal_sys: Registered thermal governor 'fair_share'204machine # [ 0.011685] thermal_sys: Registered thermal governor 'bang_bang'205machine # [ 0.011689] thermal_sys: Registered thermal governor 'step_wise'206machine # [ 0.011692] thermal_sys: Registered thermal governor 'user_space'207machine # [ 0.011695] thermal_sys: Registered thermal governor 'power_allocator'208machine # [ 0.011723] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1209machine # [ 0.011736] cpuidle: using governor ladder210machine # [ 0.011745] cpuidle: using governor menu211machine # [ 0.011907] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.212machine # [ 0.011929] ASID allocator initialised with 65536 entries213machine # [ 0.012672] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5214machine # [ 0.012861] Serial: AMBA PL011 UART driver215machine # [ 0.018915] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages216machine # [ 0.018921] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page217machine # [ 0.018925] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages218machine # [ 0.018927] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page219machine # [ 0.018930] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages220machine # [ 0.018933] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page221machine # [ 0.018936] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages222machine # [ 0.018939] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page223machine # [ 0.019803] fbcon: Taking over console224machine # [ 0.019837] ACPI: Added _OSI(Module Device)225machine # [ 0.019842] ACPI: Added _OSI(Processor Device)226machine # [ 0.019845] ACPI: Added _OSI(Processor Aggregator Device)227machine # [ 0.020867] ACPI: 1 ACPI AML tables successfully acquired and loaded228machine # [ 0.026781] ACPI: Interpreter enabled229machine # [ 0.026786] ACPI: Using GIC for interrupt routing230machine # [ 0.026819] ACPI: MCFG table detected, 1 entries231machine # [ 0.030775] ACPI: CPU0 has been hot-added232machine # [ 0.031192] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA233machine # [ 0.031261] printk: console [ttyAMA0] enabled234machine # [ 0.070735] ACPI: PCI: Interrupt link L000 configured for IRQ 35235machine # [ 0.070752] ACPI: PCI: Interrupt link L001 configured for IRQ 36236machine # [ 0.070765] ACPI: PCI: Interrupt link L002 configured for IRQ 37237machine # [ 0.070777] ACPI: PCI: Interrupt link L003 configured for IRQ 38238machine # [ 0.070796] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])239machine # [ 0.070838] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]240machine # [ 0.070921] acpi PNP0A08:00: _OSC: platform does not support [LTR]241machine # [ 0.071016] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]242machine # [ 0.071265] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00243machine # [ 0.071283] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]244machine # [ 0.071305] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]245machine # [ 0.071670] PCI host bridge to bus 0000:00246machine # [ 0.071697] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]247machine # [ 0.071703] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]248machine # [ 0.071706] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]249machine # [ 0.071710] pci_bus 0000:00: root bus resource [bus 00-ff]250machine # [ 0.071713] PCI: OF: of_root node is NULL, cannot create PCI host bridge node251machine # [ 0.071762] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint252machine # [ 0.072243] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint253machine # [ 0.072423] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]254machine # [ 0.072435] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]255machine # [ 0.072460] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]256machine # [ 0.072472] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]257machine # [ 0.072964] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint258machine # [ 0.073959] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]259machine # [ 0.073973] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]260machine # [ 0.073999] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]261machine # [ 0.074741] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint262machine # [ 0.074926] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]263machine # [ 0.074938] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]264machine # [ 0.074964] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]265machine # [ 0.075481] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint266machine # [ 0.215985] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]267machine # [ 0.216017] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]268machine # [ 0.216047] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]269machine # [ 0.216603] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint270machine # [ 0.219930] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]271machine # [ 0.219950] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]272machine # [ 0.219981] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]273machine # [ 0.220477] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.224641] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]275machine # [ 0.224666] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]276machine # [ 0.224698] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]277machine # [ 0.227444] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint278machine # [ 0.227628] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]279machine # [ 0.227656] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]280machine # [ 0.227686] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]281machine # [ 0.228183] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint282machine # [ 0.228364] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]283machine # [ 0.228381] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]284machine # [ 0.228411] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]285machine # [ 0.228429] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]286machine # [ 0.235916] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint287machine # [ 0.238121] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]288machine # [ 0.238164] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]289machine # [ 0.238695] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint290machine # [ 0.238883] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]291machine # [ 0.238914] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]292machine # [ 0.239346] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint293machine # [ 0.240060] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]294machine # [ 0.240369] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.241064] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]296machine # [ 0.241084] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]297machine # [ 0.249953] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]298machine # [ 0.250481] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.251278] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]300machine # [ 0.251299] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]301machine # [ 0.251330] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]302machine # [ 0.251992] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.252007] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.252016] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.252065] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.252112] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.252165] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.252213] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.252267] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.252319] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.252368] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.252417] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.253654] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.253711] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.253758] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned316machine # [ 0.253804] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.253827] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.253849] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.253873] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.253896] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.253920] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.253944] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.277362] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.277391] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.277951] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.277978] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.278485] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.278512] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned329machine # [ 0.278535] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.279044] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned331machine # [ 0.279068] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned332machine # [ 0.279090] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned333machine # [ 0.279590] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned334machine # [ 0.279616] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned335machine # [ 0.280133] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned336machine # [ 0.280159] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned337machine # [ 0.280184] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned338machine # [ 0.280207] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned339machine # [ 0.293939] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]340machine # [ 0.293956] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]341machine # [ 0.293963] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]342machine # [ 0.299560] iommu: Default domain type: Translated343machine # [ 0.299575] iommu: DMA domain TLB invalidation policy: strict mode344machine # [ 0.301128] SCSI subsystem initialized345machine # [ 0.301742] ACPI: bus type USB registered346machine # [ 0.301785] usbcore: registered new interface driver usbfs347machine # [ 0.301807] usbcore: registered new interface driver hub348machine # [ 0.301825] usbcore: registered new device driver usb349machine # [ 0.302046] pps_core: LinuxPPS API ver. 1 registered350machine # [ 0.302055] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>351machine # [ 0.302071] PTP clock support registered352machine # [ 0.302119] EDAC MC: Ver: 3.0.0353machine # [ 0.307360] scmi_core: SCMI protocol bus registered354machine # [ 0.308098] efivars: Registered efivars operations355machine # [ 0.309084] FPGA manager framework356machine # [ 0.309948] vgaarb: loaded357machine # [ 0.310541] clocksource: Switched to clocksource arch_sys_counter358machine # [ 0.310850] VFS: Disk quotas dquot_6.6.0359machine # [ 0.310879] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360machine # [ 0.314649] netfs: FS-Cache loaded361machine # [ 0.314774] pnp: PnP ACPI init362machine # [ 0.314975] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved363machine # [ 0.315030] pnp: PnP ACPI: found 1 devices364machine # [ 0.320449] NET: Registered PF_INET protocol family365machine # [ 0.320516] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)366machine # [ 0.340963] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)367machine # [ 0.341015] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)368machine # [ 0.341043] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)369machine # [ 0.341093] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370machine # [ 0.341171] TCP: Hash tables configured (established 8192 bind 8192)371machine # [ 0.341257] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)372machine # [ 0.341291] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)373machine # [ 0.341318] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)374machine # [ 0.341424] NET: Registered PF_UNIX/PF_LOCAL protocol family375machine # [ 0.341455] NET: Registered PF_XDP protocol family376machine # [ 0.342207] PCI: CLS 0 bytes, default 64377machine # [ 0.342456] Trying to unpack rootfs image as initramfs...378machine # [ 0.360254] kvm [1]: HYP mode not available379machine # [ 0.458287] Initialise system trusted keyrings380machine # [ 0.459110] workingset: timestamp_bits=42 max_order=18 bucket_order=0381machine # [ 0.460367] squashfs: version 4.0 (2009/01/31) Phillip Lougher382machine # [ 0.461151] 9p: Installing v9fs 9p2000 file system support383machine # [ 0.485193] Key type asymmetric registered384machine # [ 0.485229] Asymmetric key parser 'x509' registered385machine # [ 0.485315] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)386machine # [ 0.490620] io scheduler mq-deadline registered387machine # [ 0.490646] io scheduler kyber registered388machine # [ 0.498593] ledtrig-cpu: registered to indicate activity on CPUs389machine # [ 0.500624] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0390machine # [ 0.500686] ACPI: button: Power Button [PWRB]391machine # [ 0.525776] ACPI: \_SB_.L001: Enabled at IRQ 36392machine # [ 0.525844] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)393machine # [ 0.536180] ACPI: \_SB_.L002: Enabled at IRQ 37394machine # [ 0.536238] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)395machine # [ 0.538355] ACPI: \_SB_.L003: Enabled at IRQ 38396machine # [ 0.538396] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)397machine # [ 0.544017] ACPI: \_SB_.L000: Enabled at IRQ 35398machine # [ 0.544062] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)399machine # [ 0.546249] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)400machine # [ 0.564549] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)401machine # [ 0.566324] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)402machine # [ 0.570411] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)403machine # [ 0.582994] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)404machine # [ 0.585345] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)405machine # [ 0.587241] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)406machine # [ 0.599983] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled407machine # [ 0.602792] msm_serial: driver initialized408machine # [ 0.602931] SuperH (H)SCI(F) driver initialized409machine # [ 0.602976] STM32 USART driver initialized410machine # [ 0.628377] ACPI: bus type drm_connector registered411machine # [ 0.631259] loop: module loaded412machine # [ 0.631429] virtio_blk virtio5: 1/0/0 default/read/poll queues413machine # [ 0.632035] virtio_blk virtio5: [vda] 4929536 512-byte logical blocks (2.52 GB/2.35 GiB)414machine # [ 0.678620] vda: vda1 vda2415machine # [ 0.679072] virtio_blk virtio6: 1/0/0 default/read/poll queues416machine # [ 0.679831] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)417machine # [ 0.687305] megasas: 07.734.00.00-rc1418machine # [ 0.689691] tun: Universal TUN/TAP device driver, 1.6419machine # [ 0.693778] thunder_xcv, ver 1.0420machine # [ 0.693838] thunder_bgx, ver 1.0421machine # [ 0.693863] nicpf, ver 1.0422machine # [ 0.694453] e1000: Intel(R) PRO/1000 Network Driver423machine # [ 0.694465] e1000: Copyright (c) 1999-2006 Intel Corporation.424machine # [ 0.694495] e1000e: Intel(R) PRO/1000 Network Driver425machine # [ 0.694504] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.426machine # [ 0.698287] igb: Intel(R) Gigabit Ethernet Network Driver427machine # [ 0.698301] igb: Copyright (c) 2007-2014 Intel Corporation.428machine # [ 0.698344] igbvf: Intel(R) Gigabit Virtual Function Network Driver429machine # [ 0.698354] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.430machine # [ 0.698517] sky2: driver version 1.30431machine # [ 0.703310] usbcore: registered new interface driver usb-storage432machine # [ 0.703387] usbcore: registered new interface driver usbserial_generic433machine # [ 0.703406] usbserial: USB Serial support registered for generic434machine # [ 0.704063] hv_vmbus: registering driver hyperv_keyboard435machine # [ 0.705127] ehci-pci 0000:00:0b.0: EHCI Host Controller436machine # [ 0.705175] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 1437machine # [ 0.705441] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a000438machine # [ 0.711509] rtc-efi rtc-efi.0: registered as rtc0439machine # [ 0.712140] rtc-efi rtc-efi.0: setting system clock to 2026-08-29T14:07:34 UTC (1788012454)440machine # [ 0.712473] i2c_dev: i2c /dev entries driver441machine # [ 0.714772] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.00442machine # [ 0.715140] hub 1-0:1.0: USB hub found443machine # [ 0.715168] hub 1-0:1.0: 6 ports detected444machine # [ 0.719426] sdhci: Secure Digital Host Controller Interface driver445machine # [ 0.719441] sdhci: Copyright(c) Pierre Ossman446machine # [ 0.719705] Synopsys Designware Multimedia Card Interface Driver447machine # [ 0.720042] sdhci-pltfm: SDHCI platform and OF driver helper448machine # [ 0.721124] pstore: Using crash dump compression: deflate449machine # [ 0.721135] pstore: Registered efi_pstore as persistent store backend450machine # [ 0.731748] hid: raw HID events driver (C) Jiri Kosina451machine # [ 0.732049] usbcore: registered new interface driver usbhid452machine # [ 0.732060] usbhid: USB HID core driver453machine # [ 0.738933] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available454machine # [ 0.740504] drop_monitor: Initializing network drop monitor service455machine # [ 0.740680] NET: Registered PF_INET6 protocol family456machine # [ 0.743950] Segment Routing with IPv6457machine # [ 0.743977] In-situ OAM (IOAM) with IPv6458machine # [ 0.744022] NET: Registered PF_PACKET protocol family459machine # [ 0.745661] 9pnet: Installing 9P2000 support460machine # [ 0.752110] Key type dns_resolver registered461machine # [ 0.766715] registered taskstats version 1462machine # [ 0.766918] Loading compiled-in X.509 certificates463machine # [ 0.790591] Demotion targets for Node 0: null464machine # [ 0.791534] Key type .fscrypt registered465machine # [ 0.791550] Key type fscrypt-provisioning registered466machine # [ 0.791712] ima: No TPM chip found, activating TPM-bypass!467machine # [ 0.791734] ima: Allocated hash algorithm: sha1468machine # [ 0.791760] ima: No architecture policies found469machine # [ 0.829820] clk: Disabling unused clocks470machine # [ 0.829865] PM: genpd: Disabling unused power domains471machine # [ 0.970593] usb 1-1: new high-speed USB device number 2 using ehci-pci472machine # [ 0.999581] Freeing initrd memory: 26208K473machine # [ 1.003087] Freeing unused kernel memory: 4736K474machine # [ 1.003297] Run /init as init process475machine # [ 1.021558] fuse: init (API version 7.45)476machine # [ 1.035059] systemd[1]: Successfully made /usr/ read-only.477machine # [ 1.123024] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:0b.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1478machine # [ 1.195103] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0b.0-1/input0479machine # [ 1.318672] usb 1-2: new high-speed USB device number 3 using ehci-pci480machine # [ 1.370066] systemd[1]: systemd 262-a11144d 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)481machine # [ 1.383164] systemd[1]: Detected virtualization kvm.482machine # [ 1.385214] systemd[1]: Detected architecture arm64.483machine # [ 1.387188] systemd[1]: Running in initrd.484machine # [ 1.390013] systemd[1]: Initializing machine ID from random generator.485machine # [ 1.393136] systemd[1]: Hostname set to <machine>.486machine # [ 1.519078] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:0b.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2487machine # [ 1.519485] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input0488machine # [ 1.586579] systemd[1]: bpf-restrict-fs: LSM BPF program attached489machine # [ 1.644372] systemd[1]: Queued start job for default target Initrd Default Target.490machine # [ 1.652725] systemd[1]: Created slice Slice /system/modprobe.491machine # [ 1.653714] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492machine # [ 1.654811] systemd[1]: Expecting device /dev/disk/by-label/nixos...493machine # [ 1.655618] systemd[1]: Expecting device /dev/tpm0...494machine # [ 1.656280] systemd[1]: Expecting device /dev/tpmrm0...495machine # [ 1.656962] systemd[1]: Reached target Path Units.496machine # [ 1.657582] systemd[1]: Reached target Slice Units.497machine # [ 1.658216] systemd[1]: Reached target Swaps.498machine # [ 1.658844] systemd[1]: Reached target Timer Units.499machine # [ 1.659661] systemd[1]: Listening on D-Bus System Message Bus Socket.500machine # [ 1.660634] systemd[1]: Listening on Journal Socket (/dev/log).501machine # [ 1.661513] systemd[1]: Listening on Journal Sockets.502machine # [ 1.662186] systemd[1]: Listening on udev Kernel Socket.503machine # [ 1.663071] systemd[1]: Reached target Socket Units.504machine # [ 1.665265] systemd[1]: Starting Create List of Static Device Nodes...505machine # [ 1.671719] systemd[1]: Starting Load Kernel Module 9pnet_virtio...506machine # [ 1.672647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs507machine # [ 1.682430] systemd[1]: Mounting Kernel Configuration File System...508machine # [ 1.694988] systemd[1]: Starting Journal Service...509machine # [ 1.714812] systemd[1]: Starting Load Kernel Modules...510machine # [ 1.723958] systemd[1]: Starting Coldplug All udev Devices...511machine # [ 1.742740] systemd[1]: Finished Create List of Static Device Nodes.512machine # [ 1.744051] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513machine # [ 1.744370] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514machine # [ 1.744618] systemd[1]: Mounted Kernel Configuration File System.515machine # [ 1.763078] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...516machine # [ 1.783818] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.517machine # [ 1.793503] systemd-journald[72]: Collecting audit messages is disabled.518machine # [ 1.806655] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev519machine # [ 1.811459] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0520machine # [ 1.811701] [drm] features: -virgl +edid -resource_blob -host_visible521machine # [ 1.811713] [drm] features: -context_init522machine # [ 1.812447] [drm] number of scanouts: 1523machine # [ 1.812467] [drm] number of cap sets: 0524machine # [ 1.831362] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.525machine # [ 1.834097] systemd[1]: Starting Create Static Device Nodes in /dev...526machine # [ 1.839048] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic527machine # [ 1.839074] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0528machine # [ 1.855536] Console: switching to colour frame buffer device 160x50529machine # [ 1.883259] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device530machine # [ 1.896048] systemd[1]: Finished Load Kernel Modules.531machine # [ 1.902797] systemd[1]: Starting Apply Kernel Variables...532machine # [ 1.910842] systemd[1]: Finished Create Static Device Nodes in /dev.533machine # [ 1.911110] systemd[1]: Reached target Preparation for Local File Systems.534machine # [ 1.911152] systemd[1]: Reached target Local File Systems.535machine # [ 1.950760] systemd[1]: Starting Rule-based Manager for Device Events and Files...536machine # [ 1.971285] systemd[1]: Finished Apply Kernel Variables.537machine # [ 1.950142] systemd-modules-load[73]: Inserted module 'dm_mod'538machine # [ 1.985888] systemd[1]: Started Journal Service.539machine # [ 1.961284] systemd-modules-load[73]: Module 'virtio_balloon' is built in540machine # [ 1.962463] systemd-modules-load[73]: Module 'virtio_console' is built in541machine # [ 1.963563] systemd-modules-load[73]: Inserted module 'virtio_gpu'542machine # [ 1.972508] systemd-modules-load[73]: Module 'virtio_rng' is built in543machine # [ 1.977794] systemd[1]: Starting Create System Files and Directories...544machine # [ 2.006326] systemd-udevd[80]: Using default interface naming scheme 'v261'.545machine # [ 2.024214] systemd[1]: Finished Create System Files and Directories.546machine # [ 2.051193] systemd[1]: Started Rule-based Manager for Device Events and Files.547machine # [ 2.120140] systemd[1]: Starting Virtual Console Setup...548machine # [ 2.168652] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 2.172415] systemd[1]: Finished Virtual Console Setup.550machine # [ 2.910094] systemd[1]: Finished Coldplug All udev Devices.551machine # [ 3.091551] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.552machine # [ 3.097336] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.553machine # [ 3.100496] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.554machine # [ 3.260772] systemd[1]: Found device /dev/disk/by-label/nixos.555machine # [ 3.278474] systemd[1]: Reached target Initrd Root Device.556machine # [ 3.284544] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...557machine # [ 3.333277] systemd-fsck[110]: nixos: clean, 67477/137632 files, 417279/550144 blocks558machine # [ 3.345584] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.559machine # [ 3.348476] systemd[1]: Mounting /sysroot...560machine # [ 3.433615] EXT4-fs (vda2): mounted filesystem f222513b-ded1-49fa-b591-20ce86a2fe7f r/w with ordered data mode. Quota mode: none.561machine # [ 3.405821] systemd[1]: Mounted /sysroot.562machine # [ 3.408130] systemd[1]: Reached target Initrd Root File System.563machine # [ 3.414060] systemd[1]: Starting Mountpoints Configured in the Real Root...564machine # [ 3.446142] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.565machine # [ 3.452259] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...566machine # [ 3.460251] systemd[1]: Reloading...567machine # [ 3.709154] systemd[1]: Reloading finished in 257 ms.568machine # [ 3.743763] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...569machine # [ 3.748945] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...570machine # [ 3.756560] systemd[1]: Mounting /sysroot/nix/.rw-store...571machine # [ 3.762421] systemd[1]: sysroot-run.mount: Directory /sysroot/run to mount over is not empty, mounting anyway.572machine # [ 3.767010] systemd[1]: Mounting /sysroot/run...573machine # [ 3.786473] systemd[1]: Starting Load Kernel Module 9pnet_virtio...574machine # [ 3.789014] systemd[1]: initrd-parse-etc.service: Deactivated successfully.575machine # [ 3.793945] systemd[1]: Finished Mountpoints Configured in the Real Root.576machine # [ 3.796492] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.577machine # [ 3.842197] systemd[1]: Mounted /sysroot/nix/.rw-store.578machine # [ 3.855136] systemd[1]: Mounted /sysroot/run.579machine # [ 3.857772] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.580machine # [ 3.862134] systemd[1]: Finished Load Kernel Module 9pnet_virtio.581machine # [ 3.874110] systemd[1]: Mounting /sysroot/nix/.ro-store...582machine # [ 3.889885] systemd[1]: Mounting /sysroot/tmp/shared...583machine # [ 3.899420] systemd[1]: Mounting /sysroot/tmp/xchg...584machine # [ 3.923186] systemd[1]: Starting rw-sysroot-nix-store.service...585machine # [ 3.934541] systemd[1]: Mounted /sysroot/nix/.ro-store.586machine # [ 3.965304] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.587machine # [ 3.969684] systemd[1]: Finished rw-sysroot-nix-store.service.588machine # [ 3.986891] systemd[1]: sysroot-nix-store.mount: Directory /sysroot/nix/store to mount over is not empty, mounting anyway.589machine # [ 3.996220] systemd[1]: Mounting /sysroot/nix/store...590machine # [ 4.007694] systemd[1]: Mounted /sysroot/tmp/shared.591machine # [ 4.013829] systemd[1]: Mounted /sysroot/tmp/xchg.592machine # [ 4.055966] systemd[1]: Mounted /sysroot/nix/store.593machine # [ 4.058011] systemd[1]: Reached target Initrd File Systems.594machine # [ 4.062676] systemd[1]: Starting Find NixOS closure...595machine # [ 4.075607] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...596machine # [ 4.119664] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.597machine # [ 4.142510] systemd[1]: Finished Find NixOS closure.598machine # [ 4.736190] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)599machine # [ 4.870505] systemd[1]: Found device /dev/tpm0.600machine # [ 4.887390] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.601machine # [ 4.892846] systemd[1]: Stopped Virtual Console Setup.602machine # [ 4.893664] systemd[1]: Stopping Virtual Console Setup...603machine # [ 4.899768] systemd[1]: Starting Virtual Console Setup...604machine # [ 4.937016] systemd[1]: Found device /dev/tpmrm0.605machine # [ 4.940531] systemd[1]: Reached target Trusted Platform Module.606machine # [ 4.941485] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os607machine # [ 4.947669] systemd-vconsole-setup[164]: Configuration of first virtual console was skipped, ignoring remaining ones.608machine # [ 4.954271] systemd[1]: Finished Virtual Console Setup.609machine # [ 4.955131] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.610machine # [ 4.960527] systemd[1]: Reached target System Initialization.611machine # [ 4.961424] systemd[1]: Reached target Basic System.612machine # [ 4.962154] systemd[1]: Reached target Initrd Default Target.613machine # [ 4.962973] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...614machine # [ 4.988244] systemd[1]: initrd-cleanup.service: Deactivated successfully.615machine # [ 4.989821] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.616machine # [ 4.993182] systemd[1]: Stopped target Initrd Default Target.617machine # [ 4.994189] systemd[1]: Stopped target Basic System.618machine # [ 4.996185] systemd[1]: Stopped target Initrd Root Device.619machine # [ 4.998619] systemd[1]: Stopped target Path Units.620machine # [ 4.999415] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.621machine # [ 5.002169] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.622machine # [ 5.003255] systemd[1]: Stopped target Slice Units.623machine # [ 5.003963] systemd[1]: Stopped target Socket Units.624machine # [ 5.008252] systemd[1]: Stopped target System Initialization.625machine # [ 5.009134] systemd[1]: Stopped target Swaps.626machine # [ 5.009789] systemd[1]: Stopped target Timer Units.627machine # [ 5.010491] systemd[1]: Stopped target Trusted Platform Module.628machine # [ 5.011314] systemd[1]: dbus.socket: Deactivated successfully.629machine # [ 5.016293] systemd[1]: Closed D-Bus System Message Bus Socket.630machine # [ 5.017218] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.631machine # [ 5.022632] systemd[1]: Stopped Find NixOS closure.632machine # [ 5.024284] systemd[1]: Starting Load Kernel Module 9pnet_virtio...633machine # [ 5.028271] systemd[1]: Starting rw-sysroot-nix-store.service...634machine # [ 5.040208] systemd[1]: systemd-sysctl.service: Deactivated successfully.635machine # [ 5.041332] systemd[1]: Stopped Apply Kernel Variables.636machine # [ 5.043541] systemd[1]: systemd-modules-load.service: Deactivated successfully.637machine # [ 5.045781] systemd[1]: Stopped Load Kernel Modules.638machine # [ 5.049161] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.639machine # [ 5.055563] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.640machine # [ 5.059120] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.641machine # [ 5.061639] systemd[1]: Stopped Create System Files and Directories.642machine # [ 5.063679] systemd[1]: Stopped target Local File Systems.643machine # [ 5.065745] systemd[1]: Stopped target Preparation for Local File Systems.644machine # [ 5.067038] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.645machine # [ 5.070045] systemd[1]: Stopped Coldplug All udev Devices.646machine # [ 5.071896] systemd[1]: Stopping Rule-based Manager for Device Events and Files...647machine # [ 5.076288] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.648machine # [ 5.077397] systemd[1]: Stopped Virtual Console Setup.649machine # [ 5.079851] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.650machine # [ 5.081343] systemd[1]: Finished Load Kernel Module 9pnet_virtio.651machine # [ 5.082225] systemd[1]: systemd-udevd.service: Deactivated successfully.652machine # [ 5.083136] systemd[1]: Stopped Rule-based Manager for Device Events and Files.653machine # [ 5.085526] systemd[1]: systemd-udevd.service: Consumed 1.694s CPU time over 3.144s wall clock time, 22.9M memory peak.654machine # [ 5.086939] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.655machine # [ 5.087926] systemd[1]: Finished rw-sysroot-nix-store.service.656machine # [ 5.092340] systemd[1]: Starting Cleanup udev Database...657machine # [ 5.093239] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.658machine # [ 5.095971] systemd[1]: Stopped Create Static Device Nodes in /dev.659machine # [ 5.100309] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.660machine # [ 5.101564] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.661machine # [ 5.104139] systemd[1]: kmod-static-nodes.service: Deactivated successfully.662machine # [ 5.105200] systemd[1]: Stopped Create List of Static Device Nodes.663machine # [ 5.142228] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.664machine # [ 5.143910] systemd[1]: Finished Cleanup udev Database.665machine # [ 5.147366] systemd[1]: Reached target Switch Root.666machine # [ 5.152573] systemd[1]: Starting NixOS Activation...667machine # [ 5.342152] initrd-nixos-activation-start[177]: booting system configuration /nix/store/k5qfhlsk6gf5m2rayvri84dimg4dnxyl-nixos-system-machine-test668machine # [ 5.418861] initrd-nixos-activation-start[177]: running activation script...669machine # [ 5.900296] initrd-nixos-activation-start[200]: setting up /etc...670machine # [ 6.257485] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.671machine # [ 6.260189] systemd[1]: Finished NixOS Activation.672machine # [ 6.264233] systemd[1]: Starting Switch Root...673machine # [ 6.284653] systemd[1]: Switching root.674machine # [ 6.486436] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).675machine # [ 6.671149] NET: Registered PF_VSOCK protocol family676machine # [ 7.068026] systemd[1]: systemd 262-a11144d 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)677machine # [ 7.080809] systemd[1]: Detected virtualization kvm.678machine # [ 7.083952] systemd[1]: Detected architecture arm64.679machine # [ 7.087958] systemd[1]: Detected first boot.680machine # [ 7.094450] systemd[1]: Initializing machine ID from random generator.681machine # [ 7.271836] systemd[1]: bpf-restrict-fs: LSM BPF program attached682machine # [ 7.434120] systemd[1]: Applying preset policy.683machine # [ 7.927590] systemd[1]: Populated /etc with preset unit settings.684machine # [ 8.473735] systemd[1]: initrd-switch-root.service: Deactivated successfully.685machine # [ 8.475369] systemd[1]: Stopped initrd-switch-root.service.686machine # [ 8.477806] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.687machine # [ 8.481815] systemd[1]: Created slice Slice /system/getty.688machine # [ 8.485222] systemd[1]: Created slice Slice /system/systemd-fsck.689machine # [ 8.487381] systemd[1]: Created slice User and Session Slice.690machine # [ 8.489612] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.691machine # [ 8.492153] systemd[1]: Started Forward Password Requests to Wall Directory Watch.692machine # [ 8.494397] systemd[1]: Expecting device /dev/disk/by-label/ESP...693machine # [ 8.496508] systemd[1]: Expecting device /dev/hvc0...694machine # [ 8.498462] systemd[1]: Expecting device /dev/ttyAMA0...695machine # [ 8.500501] systemd[1]: Reached target Local Encrypted Volumes.696machine # [ 8.502522] systemd[1]: Stopped target initrd-fs.target.697machine # [ 8.504527] systemd[1]: Stopped target initrd-root-fs.target.698machine # [ 8.506490] systemd[1]: Stopped target initrd-switch-root.target.699machine # [ 8.508605] systemd[1]: Reached target Virtual Machines and Containers.700machine # [ 8.510932] systemd[1]: Reached target Path Units.701machine # [ 8.511922] systemd[1]: Reached target Remote File Systems.702machine # [ 8.513512] systemd[1]: Reached target Slice Units.703machine # [ 8.515900] systemd[1]: Reached target Swaps.704machine # [ 8.519727] systemd[1]: Listening on Query the User Interactively for a Password.705machine # [ 8.524628] systemd[1]: Listening on Process Core Dump Socket.706machine # [ 8.528635] systemd[1]: Listening on Credential Encryption/Decryption.707machine # [ 8.532471] systemd[1]: Listening on Factory Reset Management.708machine # [ 8.533714] systemd[1]: Listening on Hostname Service Socket.709machine # [ 8.539930] systemd[1]: Starting Journal Log Access Socket...710machine # [ 8.543100] systemd[1]: Listening on Journal Audit Socket.711machine # [ 8.547867] systemd[1]: Listening on Console Output Muting Service Socket.712machine # [ 8.550869] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.713machine # [ 8.554092] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os714machine # [ 8.554444] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki715machine # [ 8.566389] systemd[1]: Listening on Disk Repartitioning Service Socket.716machine # [ 8.566931] systemd[1]: Listening on udev Varlink Socket.717machine # [ 8.572754] systemd[1]: Mounting Huge Pages File System...718machine # [ 8.577666] systemd[1]: Mounting POSIX Message Queue File System...719machine # [ 8.587149] systemd[1]: Mounting Kernel Debug File System...720machine # [ 8.602718] systemd[1]: Mounting Kernel Trace File System...721machine # [ 8.615013] systemd[1]: Starting Create List of Static Device Nodes...722machine # [ 8.627430] systemd[1]: Starting Load Kernel Module 9pnet_virtio...723machine # [ 8.630396] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs724machine # [ 8.645604] systemd[1]: Mounting Kernel Configuration File System...725machine # [ 8.649318] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm726machine # [ 8.656090] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore727machine # [ 8.662148] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse728machine # [ 8.723849] systemd[1]: Mounting FUSE Control File System...729machine # [ 8.726487] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67730machine # [ 8.744997] systemd[1]: Starting Journal Service...731machine # [ 8.786862] systemd[1]: Starting Load Kernel Modules...732machine # [ 8.817491] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...733machine # [ 8.841287] systemd[1]: Starting Remount Root and Kernel File Systems...734machine # [ 8.846678] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os735machine # [ 8.847331] systemd-journald[272]: Collecting audit messages is enabled.736machine # [ 8.826674] systemd[1]: Queued start job for default target Multi-User System.737machine # [ 8.832394] systemd[1]: systemd-journald.service: Deactivated successfully.738machine # [ 8.874014] systemd[1]: Starting Coldplug All udev Devices...739machine # [ 8.885724] systemd[1]: Started Journal Service.740machine # [ 8.872246] systemd-modules-load[273]: Module 'atkbd' is built in741machine # [ 8.875075] systemd-modules-load[273]: Module 'loop' is built in742machine # [ 8.895192] systemd[1]: Listening on Journal Log Access Socket.743machine # [ 8.899963] systemd[1]: Mounted Huge Pages File System.744machine # [ 8.908122] systemd[1]: Mounted POSIX Message Queue File System.745machine # [ 8.911539] systemd[1]: Mounted Kernel Debug File System.[ 8.947789] EXT4-fs (vda2): re-mounted f222513b-ded1-49fa-b591-20ce86a2fe7f.746machine # 747machine # [ 8.923784] systemd[1]: Mounted Kernel Trace File System.748machine # [ 8.930121] systemd[1]: Finished Create List of Static Device Nodes.749machine # [ 8.935171] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.750machine # [ 8.940377] systemd[1]: Finished Load Kernel Module 9pnet_virtio.751machine # [ 8.944938] systemd[1]: Mounted Kernel Configuration File System.752machine # [ 8.947293] systemd[1]: Mounted FUSE Control File System.753machine # [ 8.952295] systemd[1]: Finished Load Kernel Modules.754machine # [ 8.959569] systemd[1]: Finished Remount Root and Kernel File Systems.755machine # [ 8.972694] systemd[1]: Listening on Disk Image Download Service Socket.756machine # [ 8.984216] systemd[1]: Starting Firewall...757machine # [ 8.994760] systemd[1]: Starting Flush Journal to Persistent Storage...758machine # [ 8.996274] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore759machine # [ 9.016373] systemd[1]: Starting Load/Save OS Random Seed...760machine # [ 9.036330] systemd-oomd[275]: No swap; memory pressure usage will be degraded761machine # [ 9.058942] systemd[1]: Starting Apply Kernel Variables...762machine # [ 9.095063] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...763machine # [ 9.105476] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os764machine # [ 9.118145] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.765machine # [ 9.164838] systemd-journald[272]: Received client request to flush runtime journal.766machine # [ 9.229016] systemd[1]: Finished Load/Save OS Random Seed.767machine # [ 9.237718] systemd[1]: Reached target First Boot Complete.768machine # [ 9.244398] systemd[1]: Finished Flush Journal to Persistent Storage.769machine # [ 9.269685] systemd[1]: Finished Apply Kernel Variables.770machine # [ 9.279459] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.771machine # [ 9.287333] systemd[1]: Starting Create Static Device Nodes in /dev...772machine # [ 9.401687] systemd[1]: Finished Create Static Device Nodes in /dev.773machine # [ 9.406044] systemd[1]: Reached target Preparation for Local File Systems.774machine # [ 9.410235] systemd[1]: Starting Rule-based Manager for Device Events and Files...775machine # [ 9.449951] systemd[1]: Mounting /run/wrappers...776machine # [ 9.526606] systemd[1]: Mounted /run/wrappers.777machine # [ 9.535406] systemd[1]: Starting Create SUID/SGID Wrappers...778machine # [ 9.563518] systemd-udevd[313]: Using default interface naming scheme 'v261'.779machine # [ 9.772214] systemd[1]: Started Rule-based Manager for Device Events and Files.780machine # [ 10.340310] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.781machine # [ 10.344211] systemd[1]: Finished Create SUID/SGID Wrappers.782machine # [ 10.761553] systemd[1]: Finished Coldplug All udev Devices.783machine # [ 10.828879] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs784machine # [ 10.860278] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse785machine # [ 10.927658] systemd[1]: Finished Firewall.786machine # [ 10.988096] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.787machine # [ 11.025149] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.788machine # [ 11.046432] systemd[1]: Found device /dev/tpmrm0.789machine # [ 11.047931] systemd[1]: Expecting device /dev/tpm0...790machine # [ 11.068000] (udev-worker)[364]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.791machine # [ 11.072779] (udev-worker)[364]: Network interface NamePolicy= disabled on kernel command line.792machine # [ 11.075542] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line.793machine # [ 11.191095] systemd[1]: Condition check resulted in Virtio network device being skipped.794machine # [ 11.195803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore795machine # [ 11.200632] systemd[1]: Starting Create SUID/SGID Wrappers...796machine # [ 11.204388] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67797machine # [ 11.211844] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore798machine # [ 11.288141] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.799machine # [ 11.297661] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...800machine # [ 11.404304] systemd-fsck[490]: fsck.fat 4.2 (2021-01-31)801machine # [ 11.408267] systemd-fsck[490]: /dev/vda1: 20 files, 28955/63671 clusters802machine # [ 11.416119] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.803machine # [ 11.426051] systemd[1]: Mounting /boot...804machine # [ 11.532893] systemd[1]: Mounted /boot.805machine # [ 11.537185] systemd[1]: Reached target Local File Systems.806machine # [ 11.541157] systemd[1]: Listening on Boot Loader Control Service Socket.807machine # [ 11.547393] systemd[1]: Starting register-nix-paths.service...808machine # [ 11.555660] systemd[1]: Starting Update Boot Loader Random Seed...809machine # [ 11.583562] systemd[1]: Starting Save Transient machine-id to Disk...810machine # [ 11.603708] systemd[1]: Starting Create System Files and Directories...811machine # [ 11.655492] bootctl[513]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 812machine # [ 11.674858] bootctl[513]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!813machine # [ 11.685857] bootctl[513]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).814machine # [ 11.704880] systemd[1]: Finished register-nix-paths.service.815machine # [ 11.712569] bootctl[513]: Successfully initialized system token in EFI variable with 32 bytes.816machine # [ 11.719156] systemd[1]: Finished Update Boot Loader Random Seed.817machine # [ 11.747043] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.818machine # [ 11.754999] systemd[1]: Finished Save Transient machine-id to Disk.819machine # [ 11.829801] mousedev: PS/2 mouse device common for all mice820machine # [ 11.820458] systemd[1]: Finished Create System Files and Directories.821machine # [ 11.829960] systemd[1]: Starting Rebuild Journal Catalog...822machine # [ 11.838446] systemd[1]: Starting Record System Boot/Shutdown in UTMP...823machine # [ 11.927241] systemd[1]: Finished Record System Boot/Shutdown in UTMP.824machine # [ 11.973035] systemd[1]: Finished Rebuild Journal Catalog.825machine # [ 11.979573] systemd[1]: Starting Update is Completed...826machine # [ 11.994963] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.827machine # [ 12.001645] systemd[1]: Finished Create SUID/SGID Wrappers.828machine # [ 12.031514] systemd[1]: Finished Update is Completed.829machine # [ 12.874941] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input3830machine # [ 12.897814] systemd[1]: Found device /dev/tpm0.831machine # [ 12.900458] systemd[1]: Reached target Trusted Platform Module.832machine # [ 12.903383] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os833machine # [ 12.907616] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os834machine # [ 12.912246] systemd[1]: Reached target System Initialization.835machine # [ 12.914592] systemd[1]: Started Discard unused filesystem blocks once a week.836machine # [ 12.921325] systemd[1]: Started Daily Cleanup of Temporary Directories.837machine # [ 12.923095] systemd[1]: Reached target Timer Units.838machine # [ 12.925059] systemd[1]: Listening on D-Bus System Message Bus Socket.839machine # [ 12.929036] systemd[1]: Listening on Nix Daemon Socket.840machine # [ 12.930546] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.841machine # [ 12.933784] systemd[1]: Reached target Socket Units.842machine # [ 12.936176] systemd[1]: Reached target Basic System.843machine # [ 12.941361] systemd[1]: Started backdoor.service.844machine # [ 12.943153] systemd[1]: Starting Import lastlog data into lastlog2 database...845machine # [ 12.949565] systemd[1]: Starting Name Service Cache Daemon (nsncd)...846machine # [ 12.972262] systemd[1]: Starting Post-Boot Actions...847machine # [ 12.994304] systemd[1]: Started Reset console on configuration changes.848machine # [ 13.034069] systemd[1]: Starting resolvconf update...849machine # connecting to host...850machine # [ 13.098867] nsncd[572]: Aug 29 14:07:46.918 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"851machine # [ 13.120190] systemd[1]: Starting D-Bus System Message Bus...852machine # [ 13.127098] systemd[1]: Started Name Service Cache Daemon (nsncd).853machine # [ 13.134365] systemd[1]: Reached target Host and Network Name Lookups.854machine # [ 13.135324] systemd[1]: Reached target User and Group Name Lookups.855machine: Guest shell says: b'Spawning backdoor root shell...\n'856machine # [ 13.169909] systemd[1]: Starting User Login Management...857machine # [ 13.179194] systemd[1]: Finished Post-Boot Actions.858machine: connected to guest root shell859machine: (connecting took 26.38 seconds)860machine: (finished: waiting for the VM to finish booting, in 26.81 seconds)861machine # [ 13.217825] systemd[1]: Finished Import lastlog data into lastlog2 database.862machine # [ 13.374389] dbus-broker-launch[593]: Looking up NSS user entry for 'systemd-timesync'...863machine # [ 13.412400] systemd-logind[596]: New seat seat0.864machine # [ 13.421234] systemd-logind[596]: Watching system buttons on /dev/input/event0 (Power Button)865machine # [ 13.424799] systemd-logind[596]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)866machine # [ 13.443585] systemd[1]: Started User Login Management.867machine # [ 13.467348] dbus-broker-launch[593]: NSS returned no entry for 'systemd-timesync'868machine # [ 13.468907] dbus-broker-launch[593]: Invalid user-name in /nix/store/5xp514rrzm1j611p5r6y4vxipzs3nz3z-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"869machine # [ 13.481870] systemd[1]: Stopped target Host and Network Name Lookups.870machine # [ 13.487266] systemd[1]: Stopping Host and Network Name Lookups...871machine # [ 13.494097] systemd[1]: Stopped target User and Group Name Lookups.872machine # [ 13.498112] systemd[1]: Stopping User and Group Name Lookups...873machine # [ 13.503994] systemd[1]: Starting linger-users.service...874machine # [ 13.506898] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...875machine # [ 13.516294] systemd[1]: Starting Virtual Console Setup...876machine # [ 13.517342] systemd[1]: nscd.service: Deactivated successfully.877machine # [ 13.518447] systemd[1]: Stopped Name Service Cache Daemon (nsncd).878machine # [ 13.548949] systemd[1]: Started D-Bus System Message Bus.879machine # [ 13.609352] dbus-broker-launch[593]: Ready880machine # [ 13.630043] systemd[1]: linger-users.service: Deactivated successfully.881machine # [ 13.630998] systemd-logind[596]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)882machine # [ 13.640241] systemd[1]: Finished linger-users.service.883machine # [ 13.665637] systemd[1]: Starting Name Service Cache Daemon (nsncd)...884machine # [ 13.723648] systemd[1]: Finished resolvconf update.885machine # [ 13.726431] systemd[1]: Reached target Preparation for Network.886machine # [ 13.734269] systemd[1]: Starting DHCP Client...887machine # [ 13.742701] systemd[1]: Starting Address configuration of eth1...888machine # [ 13.747054] nsncd[668]: Aug 29 14:07:47.568 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"889machine # [ 13.757401] systemd[1]: Starting Extra networking commands....890machine # [ 13.764872] systemd[1]: Started Name Service Cache Daemon (nsncd).891machine # [ 13.771360] systemd[1]: Reached target Host and Network Name Lookups.892machine # [ 13.774919] systemd[1]: Reached target User and Group Name Lookups.893machine # [ 13.901342] network-addresses-eth1-start[676]: adding address 192.168.1.1/24... done894machine # [ 13.923343] network-addresses-eth1-start[676]: adding address 2001:db8:1::1/64... done895machine # [ 13.958248] systemd[1]: Finished Address configuration of eth1.896machine # [ 14.003597] dhcpcd[694]: dhcpcd-10.3.2 starting897machine # [ 14.018924] dhcpcd[743]: dev: loaded udev898machine # [ 14.045370] systemd[1]: Finished Extra networking commands..899machine # [ 14.051783] systemd[1]: Reached target Network.900machine # [ 14.056654] systemd[1]: Starting Permit User Sessions...901machine # [ 14.106955] 8021q: 802.1Q VLAN Support v1.8902machine # [ 14.107340] 8021q: adding VLAN 0 to HW filter on device eth1903machine # [ 14.112421] systemd[1]: Finished Permit User Sessions.904machine # [ 14.126692] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.905machine # [ 14.136099] systemd[1]: Started Getty on tty1.906machine # [ 14.139771] systemd[1]: Reached target Login Prompts.907machine # [ 14.204224] cfg80211: Loading compiled-in X.509 certificates for regulatory database908machine # [ 14.235442] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'909machine # [ 14.235926] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'910machine # [ 14.241894] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2911machine # [ 14.242251] cfg80211: failed to load regulatory.db912machine # [ 14.305957] 8021q: adding VLAN 0 to HW filter on device eth0913machine # [ 14.273279] dhcpcd[743]: eth0: waiting for carrier914machine # [ 14.275161] dhcpcd[743]: eth0: carrier acquired915machine # [ 14.287102] dhcpcd[743]: DUID 00:01:00:01:32:25:a4:34:52:54:00:12:34:56916machine # [ 14.288549] dhcpcd[743]: eth0: IAID 00:12:34:56917machine # [ 14.289466] dhcpcd[743]: eth0: adding address fe80::5054:ff:fe12:3456918machine # [ 14.297031] systemd-vconsole-setup[649]: Configuration of first virtual console was skipped, ignoring remaining ones.919machine # [ 14.301407] systemd[1]: Finished Virtual Console Setup.920machine # [ 14.979601] dhcpcd[743]: eth0: soliciting a DHCP lease921machine # [ 14.985119] dhcpcd[743]: eth0: offered 10.0.2.15 from 10.0.2.2922machine # [ 14.988467] dhcpcd[743]: eth0: probing address 10.0.2.15/24923machine # [ 16.997550] dhcpcd[743]: eth0: soliciting an IPv6 router924machine # [ 16.998532] dhcpcd[743]: eth0: Router Advertisement from fe80::2925machine # [ 16.999482] dhcpcd[743]: eth0: adding address fec0::5054:ff:fe12:3456/64926machine # [ 17.001721] dhcpcd[743]: eth0: adding route to fec0::/64927machine # [ 17.002851] dhcpcd[743]: eth0: adding default route via fe80::2928machine # [ 19.819076] dhcpcd[743]: eth0: leased 10.0.2.15 for 86400 seconds929machine # [ 19.823646] dhcpcd[743]: eth0: adding route to 10.0.2.0/24930machine # [ 19.826662] dhcpcd[743]: eth0: adding default route via 10.0.2.2931machine # [ 19.991196] systemd[1]: Started DHCP Client.932machine # [ 19.994539] systemd[1]: Reached target Multi-User System.933machine # [ 19.996651] systemd[1]: Startup finished in 6.170s (firmware) + 6.341s (loader) + 973ms (kernel) + 5.607s (initrd) + 13.414s (userspace) = 32.508s.934machine: (finished: waiting for unit multi-user.target, in 33.97 seconds)935machine: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -936machine: (finished: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -, in 2.66 seconds)937machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot938machine # [ 23.616734] Key type trusted registered939machine # [ 23.622201] Key type encrypted registered940machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.69 seconds)941machine: must succeed: mkfs.ext4 /dev/mapper/cryptroot942machine # mke2fs 1.47.4 (6-Mar-2025)943machine: (finished: must succeed: mkfs.ext4 /dev/mapper/cryptroot, in 0.11 seconds)944machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat945machine # [ 23.874542] cat[917]: Successfully called mlockall().946machine # [ 23.875527] cat[917]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory947machine # [ 23.885718] cat[917]: Loaded shared library 'libcryptsetup.so.12' via dlopen().948machine # [ 23.887619] cat[917]: Allocating context for crypt device /dev/vdb.949machine # [ 23.888892] cat[917]: Trying to open device /dev/vdb with direct-io.950machine # [ 23.890675] cat[917]: Initialising device-mapper backend library.951machine # [ 23.891978] cat[917]: Trying to load LUKS2 crypt type from device /dev/vdb.952machine # [ 23.894451] cat[917]: Crypto backend (OpenSSL 3.6.3 9 Jun 2026 [default][legacy][threads][argon2]) initialized in cryptsetup library version 2.8.7.953machine # [ 23.896821] cat[917]: Detected kernel Linux 6.18.46 aarch64.954machine # [ 23.897674] cat[917]: Loading LUKS2 header (repair disabled).955machine # [ 23.898481] cat[917]: Acquiring read lock for device /dev/vdb.956machine # [ 23.899281] cat[917]: Opening lock resource file /run/cryptsetup/L_254:16957machine # [ 23.900690] cat[917]: Verifying lock handle for /dev/vdb.958machine # [ 23.904098] cat[917]: Device /dev/vdb READ lock taken.959machine # [ 23.904911] cat[917]: Trying to read primary LUKS2 header at offset 0x0.960machine # [ 23.905839] cat[917]: Opening locked device /dev/vdb961machine # [ 23.906526] cat[917]: Verifying locked device handle (bdev)962machine # [ 23.907284] cat[917]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.963machine # [ 23.916194] cat[917]: Checksum:d82507e51f1ca5e72a7aaaccb003e671bb9ed1ad5b58d4ba254c82248711e787 (on-disk)964machine # [ 23.917493] cat[917]: Checksum:d82507e51f1ca5e72a7aaaccb003e671bb9ed1ad5b58d4ba254c82248711e787 (in-memory)965machine # [ 23.918755] cat[917]: Trying to read secondary LUKS2 header at offset 0x4000.966machine # [ 23.919726] cat[917]: Reusing open ro fd on device /dev/vdb967machine # [ 23.924074] cat[917]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.968machine # [ 23.925115] cat[917]: Checksum:60f0e347dfff767b009ef3b27ba9823f4f42b1622494d96dc67ba54d1e76d3bf (on-disk)969machine # [ 23.926370] cat[917]: Checksum:60f0e347dfff767b009ef3b27ba9823f4f42b1622494d96dc67ba54d1e76d3bf (in-memory)970machine # [ 23.927641] cat[917]: Device size 536870912, offset 16777216.971machine # [ 23.932093] cat[917]: Device /dev/vdb READ lock released.972machine # [ 23.932881] cat[917]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1.973machine # [ 23.933971] cat[917]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 357560kB.974machine # [ 23.935311] cat[917]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 357560, parallel_threads 1.975machine # [ 23.940072] cat[917]: Requesting JSON for token 0.976machine # [ 23.940790] cat[917]: Requesting JSON for token 1.977machine # [ 23.941474] cat[917]: Requesting JSON for token 2.978machine # [ 23.942143] cat[917]: Requesting JSON for token 3.979machine # [ 23.942815] cat[917]: Requesting JSON for token 4.980machine # [ 23.943492] cat[917]: Requesting JSON for token 5.981machine # [ 23.952076] cat[917]: Requesting JSON for token 6.982machine # [ 23.952789] cat[917]: Requesting JSON for token 7.983machine # [ 23.953501] cat[917]: Requesting JSON for token 8.984machine # [ 23.954171] cat[917]: Requesting JSON for token 9.985machine # [ 23.954873] cat[917]: Requesting JSON for token 10.986machine # [ 23.955564] cat[917]: Requesting JSON for token 11.987machine # [ 23.960075] cat[917]: Requesting JSON for token 12.988machine # [ 23.960804] cat[917]: Requesting JSON for token 13.989machine # [ 23.961506] cat[917]: Requesting JSON for token 14.990machine # [ 23.962218] cat[917]: Requesting JSON for token 15.991machine # [ 23.962910] cat[917]: Requesting JSON for token 16.992machine # [ 23.963653] cat[917]: Requesting JSON for token 17.993machine # [ 23.968082] cat[917]: Requesting JSON for token 18.994machine # [ 23.968801] cat[917]: Requesting JSON for token 19.995machine # [ 23.969496] cat[917]: Requesting JSON for token 20.996machine # [ 23.970200] cat[917]: Requesting JSON for token 21.997machine # [ 23.970889] cat[917]: Requesting JSON for token 22.998machine # [ 23.971581] cat[917]: Requesting JSON for token 23.999machine # [ 23.976167] cat[917]: Requesting JSON for token 24.1000machine # [ 23.977003] cat[917]: Requesting JSON for token 25.1001machine # [ 23.977696] cat[917]: Requesting JSON for token 26.1002machine # [ 23.978378] cat[917]: Requesting JSON for token 27.1003machine # [ 23.979056] cat[917]: Requesting JSON for token 28.1004machine # [ 23.979746] cat[917]: Requesting JSON for token 29.1005machine # [ 23.984141] cat[917]: Requesting JSON for token 30.1006machine # [ 23.984939] cat[917]: Requesting JSON for token 31.1007machine # [ 23.985637] cat[917]: Keyslot 0 priority 1 != 2 (required), skipped.1008machine # [ 23.986509] cat[917]: Trying to open LUKS2 keyslot 0.1009machine # [ 23.987219] cat[917]: Running keyslot key derivation.1010machine # [ 24.272210] cat[917]: Reading keyslot area [0x8000].1011machine # [ 24.273096] cat[917]: Acquiring read lock for device /dev/vdb.1012machine # [ 24.273939] cat[917]: Opening lock resource file /run/cryptsetup/L_254:161013machine # [ 24.274860] cat[917]: Verifying lock handle for /dev/vdb.1014machine # [ 24.275617] cat[917]: Device /dev/vdb READ lock taken.1015machine # [ 24.277366] cat[917]: Reusing open ro fd on device /dev/vdb1016machine # [ 24.283444] cat[917]: Device /dev/vdb READ lock released.1017machine # [ 24.284367] cat[917]: Verifying key from keyslot 0, digest 0.1018machine # [ 24.348784] cat[917]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory1019machine # [ 24.350278] cat[917]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory1020machine # [ 24.354953] cat[917]: Loaded shared library 'libtss2-esys.so.0' via dlopen().1021machine # [ 24.357157] cat[917]: Loaded shared library 'libtss2-rc.so.0' via dlopen().1022machine # [ 24.358265] cat[917]: Loaded shared library 'libtss2-mu.so.0' via dlopen().1023machine # [ 24.360134] cat[917]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen().1024machine # [ 24.361544] cat[917]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'.1025machine # [ 24.363031] cat[917]: Loaded 'libtss2-tcti-device.so.0' via dlopen()1026machine # [ 24.363939] cat[917]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2]1027machine # [ 24.367206] cat[917]: TPM successfully started up.1028machine # [ 24.367909] cat[917]: Getting TPM2 capability 0x0000 property 0x0001 count 127.1029machine # [ 24.369045] cat[917]: Getting TPM2 capability 0x0002 property 0x011f count 256.1030machine # [ 24.377994] cat[917]: Getting TPM2 capability 0x0008 property 0x0000 count 508.1031machine # [ 24.380296] cat[917]: Getting TPM2 capability 0x0005 property 0x0000 count 1.1032machine # [ 24.382762] cat[917]: Getting TPM2 capability 0x0006 property 0x012c count 1.1033machine # [ 24.387978] cat[917]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.445ms.1034machine # [ 24.389159] cat[917]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1035machine # [ 24.391577] cat[917]: TPM handle 0x81000001 not populated.1036machine # [ 24.393742] cat[917]: Creating primary key on TPM.1037machine # [ 24.403163] cat[917]: Successfully created primary key on TPM in 9ms.1038machine # [ 24.412717] cat[917]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1039machine # [ 24.448631] cat[917]: Starting HMAC encryption session.1040machine # [ 24.465972] cat[917]: Generating secret key data.1041machine # [ 24.468074] cat[917]: Creating HMAC key on TPM for shard 0.1042machine # [ 24.469057] cat[917]: Creating object on TPM.1043machine # [ 24.486958] cat[917]: Successfully created object on TPM in 19ms.1044machine # [ 24.490210] cat[917]: Marshalling private and public part of HMAC key for shard 0.1045machine # [ 24.491470] cat[917]: Completed TPM2 key sealing in 101.719ms.1046machine # [ 24.495739] cat[917]: Requesting JSON for token 0.1047machine # [ 24.497002] cat[917]: Requesting JSON for token 1.1048machine # [ 24.497920] cat[917]: Requesting JSON for token 2.1049machine # [ 24.498797] cat[917]: Requesting JSON for token 3.1050machine # [ 24.499667] cat[917]: Requesting JSON for token 4.1051machine # [ 24.502089] cat[917]: Requesting JSON for token 5.1052machine # [ 24.502893] cat[917]: Requesting JSON for token 6.1053machine # [ 24.504192] cat[917]: Requesting JSON for token 7.1054machine # [ 24.504993] cat[917]: Requesting JSON for token 8.1055machine # [ 24.507969] cat[917]: Requesting JSON for token 9.1056machine # [ 24.508753] cat[917]: Requesting JSON for token 10.1057machine # [ 24.510283] cat[917]: Requesting JSON for token 11.1058machine # [ 24.511099] cat[917]: Requesting JSON for token 12.1059machine # [ 24.511858] cat[917]: Requesting JSON for token 13.1060machine # [ 24.517486] cat[917]: Requesting JSON for token 14.1061machine # [ 24.518272] cat[917]: Requesting JSON for token 15.1062machine # [ 24.519123] cat[917]: Requesting JSON for token 16.1063machine # [ 24.519887] cat[917]: Requesting JSON for token 17.1064machine # [ 24.521382] cat[917]: Requesting JSON for token 18.1065machine # [ 24.522103] cat[917]: Requesting JSON for token 19.1066machine # [ 24.522882] cat[917]: Requesting JSON for token 20.1067machine # [ 24.523628] cat[917]: Requesting JSON for token 21.1068machine # [ 24.524745] cat[917]: Requesting JSON for token 22.1069machine # [ 24.525444] cat[917]: Requesting JSON for token 23.1070machine # [ 24.528172] cat[917]: Requesting JSON for token 24.1071machine # [ 24.528973] cat[917]: Requesting JSON for token 25.1072machine # [ 24.529912] cat[917]: Requesting JSON for token 26.1073machine # [ 24.530597] cat[917]: Requesting JSON for token 27.1074machine # [ 24.536086] cat[917]: Requesting JSON for token 28.1075machine # [ 24.536835] cat[917]: Requesting JSON for token 29.1076machine # [ 24.537549] cat[917]: Requesting JSON for token 30.1077machine # [ 24.538241] cat[917]: Requesting JSON for token 31.1078machine # [ 24.538934] cat[917]: PCR policy hash not yet enrolled, enrolling now.1079machine # [ 24.539831] cat[917]: Unsealing for verification...1080machine # [ 24.544814] cat[917]: Loading HMAC key into TPM for shard 0.1081machine # [ 24.545672] cat[917]: Loading object into TPM.1082machine # [ 24.546410] cat[917]: Starting HMAC encryption session.1083machine # [ 24.547178] cat[917]: Starting policy session.1084machine # [ 24.566317] cat[917]: Building sealing policy.1085machine # [ 24.567154] cat[917]: Acquiring policy digest.1086machine # [ 24.588494] cat[917]: Session policy digest: 00000000000000000000000000000000000000000000000000000000000000001087machine # [ 24.592042] cat[917]: Unsealing HMAC key for shard 0.1088machine # [ 24.660076] cat[917]: Completed TPM2 key unsealing in 160.426ms.1089machine # [ 24.661299] cat[917]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000).1090machine # [ 24.662438] cat[917]: Adding new keyslot -1 by passphrase, volume key provided by key (-1).1091machine # [ 24.663845] cat[917]: Selected keyslot 1.1092machine # [ 24.729513] cat[917]: Keyslot 1 assigned to digest 0.1093machine # [ 24.730421] cat[917]: Trying to allocate LUKS2 keyslot 1.1094machine # [ 24.731657] cat[917]: Found area 290816 -> 5488641095machine # [ 24.736129] cat[917]: Reusing PBKDF values (no benchmark flag is set).1096machine # [ 24.737034] cat[917]: Calculating attributes for LUKS2 keyslot 1.1097machine # [ 24.737861] cat[917]: Acquiring write lock for device /dev/vdb.1098machine # [ 24.738665] cat[917]: Opening lock resource file /run/cryptsetup/L_254:161099machine # [ 24.739571] cat[917]: Verifying lock handle for /dev/vdb.1100machine # [ 24.742644] cat[917]: Device /dev/vdb WRITE lock taken.1101machine # [ 24.743385] cat[917]: Checking context sequence id matches value stored on disk.1102machine # [ 24.744867] cat[917]: Reusing open ro fd on device /dev/vdb1103machine # [ 24.745978] cat[917]: Running keyslot key derivation.1104machine # [ 24.746701] cat[917]: Updating keyslot area [0x47000].1105machine # [ 24.747409] cat[917]: Opening locked device /dev/vdb1106machine # [ 24.748285] cat[917]: Verifying locked device handle (bdev)1107machine # [ 24.749220] cat[917]: Device size 536870912, offset 16777216.1108machine # [ 24.750200] cat[917]: Device /dev/vdb WRITE lock already held.1109machine # [ 24.751217] cat[917]: Trying to write LUKS2 header (1039 bytes) at offset 0.1110machine # [ 24.752356] cat[917]: Reusing open rw fd on device /dev/vdb1111machine # [ 24.753151] cat[917]: Checksum:47807149e08de71ea187ac8616d0321b5a6676414918f12425c7a76ef55bbe05 (in-memory)1112machine # [ 24.754561] cat[917]: Trying to write LUKS2 header (1039 bytes) at offset 16384.1113machine # [ 24.755693] cat[917]: Reusing open rw fd on device /dev/vdb1114machine # [ 24.756862] cat[917]: Checksum:256166dd58b933a4574500a6ec1ea6974007477f7d1874ebd37ea2a47e046c6e (in-memory)1115machine # [ 24.758872] cat[917]: Device /dev/vdb WRITE lock released.1116machine # [ 24.760068] cat[917]: Unknown hash algorithm id 0x01117machine # [ 24.760925] cat[917]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AIAXiOEZTisJhkxbpQ/DMqiduP2fVnh2rNzQXRHL/UYJgABA0/nanFaam07eu8X3QgseDc36k73DEIvxNtTNJFatYsvwiQQw/fAyv6g87kJYW5yZ1MQIugBxaXVTDOFsFMK58BorAXkdUo7eYsPfsMfwSlLfZ9v/XOOTQHput+SIvzghYmVd6OLET2mEMQOsLGg5vQXCNid+8C4aU2QBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAIFKX3T9kuagTIQtzXLse9l+xwSwaCyOP9DMtPV4ljo2F","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAsWo/g+tOK4lpUqqxWv+elYEMCCfcXjLObJ7rofGNvgwAAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAIJg1YFFuTyDo0aZhIJPBPQ+2sh0g5ZQLB7ZwvP3vy1xEACD3BWXa0kdQXQ61l976dbeQr60Mtk2OizeAWeWa644C7Q=="}>1118machine # [ 24.784221] cat[917]: Updating JSON for token -1.1119machine # [ 24.784985] cat[917]: Trying to load libcryptsetup-token-systemd-tpm2.so.1120machine # [ 24.785998] cat[917]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0.1121machine # [ 24.786979] cat[917]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0.1122machine # [ 24.790804] cat[917]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0.1123machine # [ 24.791909] cat[917]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0.1124machine # [ 24.793634] cat[917]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0.1125machine # [ 24.794907] cat[917]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0.1126machine # [ 24.796093] cat[917]: Token handler systemd-tpm2-1.0 systemd-v262~devel (262-a11144d) loaded successfully.1127machine # [ 24.797549] [917]: Device size 536870912, offset 16777216.1128machine # [ 24.798431] [917]: Acquiring write lock for device /dev/vdb.1129machine # [ 24.799249] [917]: Opening lock resource file /run/cryptsetup/L_254:161130machine # [ 24.800361] [917]: Verifying lock handle for /dev/vdb.1131machine # [ 24.801198] [917]: Device /dev/vdb WRITE lock taken.1132machine # [ 24.801940] [917]: Checking context sequence id matches value stored on disk.1133machine # [ 24.802875] [917]: Reusing open ro fd on device /dev/vdb1134machine # [ 24.803658] [917]: Trying to write LUKS2 header (1742 bytes) at offset 0.1135machine # [ 24.804754] [917]: Reusing open rw fd on device /dev/vdb1136machine # [ 24.805479] [917]: Checksum:8845064e11460c81f0ad8e8b2db75782a36ef2c1e16f1a9425ce6e6d23cd02a4 (in-memory)1137machine # [ 24.806665] [917]: Trying to write LUKS2 header (1742 bytes) at offset 16384.1138machine # [ 24.807575] [917]: Reusing open rw fd on device /dev/vdb1139machine # [ 24.809326] [917]: Checksum:d73a9b4f97d894abbe2354e652ef8b9f47faf05b763313f40bbe81ed346d7224 (in-memory)1140machine # [ 24.810725] [917]: Device /dev/vdb WRITE lock released.1141machine # [ 24.811724] [917]: New TPM2 token enrolled as key slot 1.1142machine # [ 24.812818] [917]: Releasing crypt device /dev/vdb context.1143machine # [ 24.813751] [917]: Releasing device-mapper backend.1144machine # [ 24.814420] [917]: Closing read only fd for /dev/vdb.1145machine # [ 24.815104] [917]: Closing read write fd for /dev/vdb.1146machine # [ 24.815796] [917]: Unloading systemd-tpm2 token handler.1147machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 1.01 seconds)1148machine: must succeed: /nix/store/hfqx4b6pfbdbwr4scjn871iav48d6sm0-nixos-system-machine-test/bin/switch-to-configuration boot1149machine # Not checking switch inhibitors (action = boot)1150machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.1151machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.1152machine: (finished: must succeed: /nix/store/hfqx4b6pfbdbwr4scjn871iav48d6sm0-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.96 seconds)1153machine: must succeed: sync1154machine: (finished: must succeed: sync, in 0.04 seconds)1155machine: forced crash1156machine: waiting for the VM to power off1157additionally exposed symbols:1158 machine,1159 vlan1,1160 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_ssh1161machine: (finished: waiting for the VM to power off, in 0.00 seconds)1162machine: waiting for unit multi-user.target1163machine: waiting for the VM to finish booting1164machine: starting vm1165machine: QEMU running (pid 93)1166machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)1167machine: 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'1168machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1169machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1170machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1171machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1172machine: 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[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS (boot-luks) \x1b[021;063'1173machine: Guest shell says: b'H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m NixOS \x1b[022;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Reboot Into Firmware I'1174machine: Guest shell says: b'nterface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot '1175machine: Guest shell says: b'in 5s. \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m----------'1176machine: Guest shell says: b'--------------------------------'1177machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. '1178machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'1179machine: Guest shell says: b'---------------------'1180machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. '1181machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'1182machine: Guest shell says: b'------------------------------------------'1183machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. '1184machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'1185machine: Guest shell says: b'---------------------'1186machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '1187machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'1188machine: Guest shell says: b'------------------------------------------'1189machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'1190machine # 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]1191machine # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 23 12:27:10 UTC 20261192machine # [ 0.000000] KASLR enabled1193machine # [ 0.000000] efi: EFI v2.7 by EDK II1194machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fc0000 MEMATTR=0x45ae8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a7a018 INITRD=0x45ae0418 MEMRESERVE=0x45ae22981195machine # [ 0.000000] random: crng init done1196machine # [ 0.000000] ACPI: Early table checksum verification disabled1197machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )1198machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013)1199machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)1200machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001811 (v02 BOCHS BXPC 00000001 BXPC 00000001)1201machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)1202machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)1203machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)1204machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1205machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)1206machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)1207machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)1208machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)1209machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013)1210machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,96001211machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1212machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf1880-0x7fdf4fff]1213machine # [ 0.000000] Zone ranges:1214machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1215machine # [ 0.000000] DMA32 empty1216machine # [ 0.000000] Normal empty1217machine # [ 0.000000] Device empty1218machine # [ 0.000000] Movable zone start for each node1219machine # [ 0.000000] Early memory node ranges1220machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045b0ffff]1221machine # [ 0.000000] node 0: [mem 0x0000000045b10000-0x0000000045b1ffff]1222machine # [ 0.000000] node 0: [mem 0x0000000045b20000-0x0000000045fcffff]1223machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff]1224machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff]1225machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]1226machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]1227machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]1228machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]1229machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]1230machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]1231machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1232machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001233machine # [ 0.000000] psci: probing for conduit method from ACPI.1234machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1235machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1236machine # [ 0.000000] psci: Trusted OS migration not required1237machine # [ 0.000000] psci: SMC Calling Convention v1.11238machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1239machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961240machine # [ 0.000000] Detected PIPT I-cache on CPU01241machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1242machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1243machine # [ 0.000000] CPU features: detected: Spectre-v41244machine # [ 0.000000] CPU features: detected: Spectre-BHB1245machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381246machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231247machine # [ 0.000000] alternatives: applying boot alternatives1248machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\8x7sv22mipiy3q4ffv34ffnlmc9njajl-initrd-linux-6.18.46-initrd.efi init=/nix/store/hfqx4b6pfbdbwr4scjn871iav48d6sm0-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,bpf1249machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1250machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1251machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1252machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1253machine # [ 0.000000] software IO TLB: area num 1.1254machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1255machine # [ 0.000000] Fallback order for Node 0: 01256machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441257machine # [ 0.000000] Policy zone: DMA1258machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1259machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11260machine # [ 0.000000] allocated 2097152 bytes of page_ext1261machine # [ 0.000000] ftrace: allocating 74884 entries in 294 pages1262machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1263machine # [ 0.000000] rcu: Hierarchical RCU implementation.1264machine # [ 0.000000] rcu: RCU event tracing is enabled.1265machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1266machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1267machine # [ 0.000000] Rude variant of Tasks RCU enabled.1268machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1269machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1270machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11271machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1272machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1273machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1274machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01275machine # [ 0.000000] GICv3: 256 SPIs implemented1276machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1277machine # [ 0.000000] Root IRQ handler: gic_handle_irq1278machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1279machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01280machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001281machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1282machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)1283machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)1284machine # [ 0.000000] GICv3: using LPI property table @0x00000000409100001285machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000409200001286machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1287machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1288machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1289machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1290machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1291machine # [ 0.000036] arm-pv: using stolen time PV1292machine # [ 0.000477] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1293machine # [ 0.000579] Console: colour dummy device 80x251294machine # [ 0.000584] printk: legacy console [tty0] enabled1295machine # [ 0.000805] ACPI: Core revision 202508071296machine # [ 0.000885] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1297machine # [ 0.000892] pid_max: default: 32768 minimum: 3011298machine # [ 0.000950] LSM: initializing lsm=capability,landlock,yama,bpf,ima1299machine # [ 0.001098] landlock: Up and running.1300machine # [ 0.001102] Yama: becoming mindful.1301machine # [ 0.001606] LSM support for eBPF active1302machine # [ 0.001720] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1303machine # [ 0.001729] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1304machine # [ 0.002863] rcu: Hierarchical SRCU implementation.1305machine # [ 0.002869] rcu: Max phase no-delay instances is 1000.1306machine # [ 0.003572] fsl-mc MSI: ITS@0x8080000 domain created1307machine # [ 0.003594] Remapping and enabling EFI services.1308machine # [ 0.003737] smp: Bringing up secondary CPUs ...1309machine # [ 0.003747] smp: Brought up 1 node, 1 CPU1310machine # [ 0.003750] SMP: Total of 1 processors activated.1311machine # [ 0.003753] CPU: All CPU(s) started at EL11312machine # [ 0.003771] CPU features: detected: Branch Target Identification1313machine # [ 0.003776] CPU features: detected: ARMv8.4 Translation Table Level1314machine # [ 0.003779] CPU features: detected: Instruction cache invalidation not required for I/D coherence1315machine # [ 0.003783] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1316machine # [ 0.003786] CPU features: detected: Common not Private translations1317machine # [ 0.003789] CPU features: detected: CRC32 instructions1318machine # [ 0.003792] CPU features: detected: Data cache clean to Point of Deep Persistence1319machine # [ 0.003796] CPU features: detected: Data cache clean to Point of Persistence1320machine # [ 0.003799] CPU features: detected: Data independent timing control (DIT)1321machine # [ 0.003802] CPU features: detected: E0PD1322machine # [ 0.003805] CPU features: detected: Enhanced Counter Virtualization1323machine # [ 0.003808] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1324machine # [ 0.003811] CPU features: detected: Enhanced Virtualization Traps1325machine # [ 0.003814] CPU features: detected: Fine Grained Traps1326machine # [ 0.003817] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1327machine # [ 0.003822] CPU features: detected: RCpc load-acquire (LDAPR)1328machine # [ 0.003825] CPU features: detected: LSE atomic instructions1329machine # [ 0.003828] CPU features: detected: Privileged Access Never1330machine # [ 0.003831] CPU features: detected: PMUv31331machine # [ 0.003834] CPU features: detected: RAS Extension Support1332machine # [ 0.003837] CPU features: detected: RASv1p1 Extension Support1333machine # [ 0.003840] CPU features: detected: Random Number Generator1334machine # [ 0.003842] CPU features: detected: Speculation barrier (SB)1335machine # [ 0.003846] CPU features: detected: Stage-2 Force Write-Back1336machine # [ 0.003849] CPU features: detected: TLB range maintenance instructions1337machine # [ 0.003853] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1338machine # [ 0.003890] alternatives: applying system-wide alternatives1339machine # [ 0.006675] CPU features: detected: BBM Level 2 without TLB conflict abort1340machine # [ 0.006809] Memory: 886812K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120420K reserved, 32768K cma-reserved)1341machine # [ 0.007088] devtmpfs: initialized1342machine # [ 0.008072] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1343machine # [ 0.008083] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1344machine # [ 0.008258] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1345machine # [ 0.008263] 0 pages in range for non-PLT usage1346machine # [ 0.008264] 508288 pages in range for PLT usage1347machine # [ 0.008350] pinctrl core: initialized pinctrl subsystem1348machine # [ 0.008914] SMBIOS 3.0.0 present.1349machine # [ 0.008919] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/20221350machine # [ 0.008929] DMI: Memory slots populated: 1/11351machine # [ 0.010374] NET: Registered PF_NETLINK/PF_ROUTE protocol family1352machine # [ 0.011064] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1353machine # [ 0.011195] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1354machine # [ 0.011359] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1355machine # [ 0.011382] audit: initializing netlink subsys (disabled)1356machine # [ 0.011845] thermal_sys: Registered thermal governor 'fair_share'1357machine # [ 0.011848] thermal_sys: Registered thermal governor 'bang_bang'1358machine # [ 0.011852] thermal_sys: Registered thermal governor 'step_wise'1359machine # [ 0.011854] thermal_sys: Registered thermal governor 'user_space'1360machine # [ 0.011857] thermal_sys: Registered thermal governor 'power_allocator'1361machine # [ 0.011886] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=11362machine # [ 0.011899] cpuidle: using governor ladder1363machine # [ 0.011910] cpuidle: using governor menu1364machine # [ 0.012097] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1365machine # [ 0.012119] ASID allocator initialised with 65536 entries1366machine # [ 0.012882] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51367machine # [ 0.013067] Serial: AMBA PL011 UART driver1368machine # [ 0.018963] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1369machine # [ 0.018970] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1370machine # [ 0.018974] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1371machine # [ 0.018976] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1372machine # [ 0.018979] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1373machine # [ 0.018982] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1374machine # [ 0.018985] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1375machine # [ 0.018987] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1376machine # [ 0.019806] fbcon: Taking over console1377machine # [ 0.019847] ACPI: Added _OSI(Module Device)1378machine # [ 0.019851] ACPI: Added _OSI(Processor Device)1379machine # [ 0.019854] ACPI: Added _OSI(Processor Aggregator Device)1380machine # [ 0.020911] ACPI: 1 ACPI AML tables successfully acquired and loaded1381machine # [ 0.026826] ACPI: Interpreter enabled1382machine # [ 0.026831] ACPI: Using GIC for interrupt routing1383machine # [ 0.026856] ACPI: MCFG table detected, 1 entries1384machine # [ 0.031661] ACPI: CPU0 has been hot-added1385machine # [ 0.032052] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA1386machine # [ 0.036210] printk: console [ttyAMA0] enabled1387machine # [ 0.104671] ACPI: PCI: Interrupt link L000 configured for IRQ 351388machine # [ 0.104700] ACPI: PCI: Interrupt link L001 configured for IRQ 361389machine # [ 0.104715] ACPI: PCI: Interrupt link L002 configured for IRQ 371390machine # [ 0.104736] ACPI: PCI: Interrupt link L003 configured for IRQ 381391machine # [ 0.104756] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1392machine # [ 0.104795] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1393machine # [ 0.104880] acpi PNP0A08:00: _OSC: platform does not support [LTR]1394machine # [ 0.104979] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]1395machine # [ 0.105248] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:001396machine # [ 0.105266] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1397machine # [ 0.105289] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]1398machine # [ 0.105623] PCI host bridge to bus 0000:001399machine # [ 0.105651] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]1400machine # [ 0.105656] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]1401machine # [ 0.105659] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]1402machine # [ 0.105664] pci_bus 0000:00: root bus resource [bus 00-ff]1403machine # [ 0.105667] PCI: OF: of_root node is NULL, cannot create PCI host bridge node1404machine # [ 0.105721] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1405machine # [ 0.106210] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1406machine # [ 0.106385] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]1407machine # [ 0.106397] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]1408machine # [ 0.106421] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]1409machine # [ 0.106433] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]1410machine # [ 0.106920] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1411machine # [ 0.107835] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]1412machine # [ 0.107848] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]1413machine # [ 0.107872] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]1414machine # [ 0.108457] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1415machine # [ 0.108635] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]1416machine # [ 0.108645] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]1417machine # [ 0.108671] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]1418machine # [ 0.109179] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1419machine # [ 0.214003] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]1420machine # [ 0.214030] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]1421machine # [ 0.214060] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]1422machine # [ 0.214612] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1423machine # [ 0.214793] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]1424machine # [ 0.214810] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]1425machine # [ 0.219248] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]1426machine # [ 0.219741] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1427machine # [ 0.220538] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]1428machine # [ 0.220558] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]1429machine # [ 0.220588] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]1430machine # [ 0.221106] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1431machine # [ 0.221285] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]1432machine # [ 0.221301] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]1433machine # [ 0.221330] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]1434machine # [ 0.221858] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1435machine # [ 0.222049] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]1436machine # [ 0.222065] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]1437machine # [ 0.222095] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]1438machine # [ 0.222112] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]1439machine # [ 0.222610] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1440machine # [ 0.236342] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]1441machine # [ 0.236385] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]1442machine # [ 0.238439] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1443machine # [ 0.238626] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]1444machine # [ 0.238657] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]1445machine # [ 0.239087] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1446machine # [ 0.239760] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]1447machine # [ 0.240063] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1448machine # [ 0.246448] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]1449machine # [ 0.246471] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]1450machine # [ 0.246501] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]1451machine # [ 0.247018] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1452machine # [ 0.247819] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]1453machine # [ 0.247839] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]1454machine # [ 0.247869] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]1455machine # [ 0.248502] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1456machine # [ 0.248514] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1457machine # [ 0.248523] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1458machine # [ 0.248570] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1459machine # [ 0.248616] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1460machine # [ 0.248665] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1461machine # [ 0.248715] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1462machine # [ 0.248766] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1463machine # [ 0.261487] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1464machine # [ 0.261541] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1465machine # [ 0.261589] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1466machine # [ 0.266127] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1467machine # [ 0.266190] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1468machine # [ 0.266241] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1469machine # [ 0.266288] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1470machine # [ 0.266311] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1471machine # [ 0.266333] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1472machine # [ 0.266355] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1473machine # [ 0.266378] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1474machine # [ 0.266401] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1475machine # [ 0.274484] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1476machine # [ 0.274513] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1477machine # [ 0.274537] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1478machine # [ 0.277472] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1479machine # [ 0.277500] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned1480machine # [ 0.277987] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1481machine # [ 0.278013] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1482machine # [ 0.278035] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1483machine # [ 0.278521] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned1484machine # [ 0.278546] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned1485machine # [ 0.278569] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned1486machine # [ 0.279073] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned1487machine # [ 0.286607] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned1488machine # [ 0.287735] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned1489machine # [ 0.287761] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned1490machine # [ 0.289915] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned1491machine # [ 0.289939] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned1492machine # [ 0.290465] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]1493machine # [ 0.290479] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]1494machine # [ 0.290490] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]1495machine # [ 0.297470] iommu: Default domain type: Translated1496machine # [ 0.297487] iommu: DMA domain TLB invalidation policy: strict mode1497machine # [ 0.299475] SCSI subsystem initialized1498machine # [ 0.300110] ACPI: bus type USB registered1499machine # [ 0.300155] usbcore: registered new interface driver usbfs1500machine # [ 0.300178] usbcore: registered new interface driver hub1501machine # [ 0.300199] usbcore: registered new device driver usb1502machine # [ 0.300411] pps_core: LinuxPPS API ver. 1 registered1503machine # [ 0.300419] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1504machine # [ 0.300432] PTP clock support registered1505machine # [ 0.300473] EDAC MC: Ver: 3.0.01506machine # [ 0.305704] scmi_core: SCMI protocol bus registered1507machine # [ 0.306429] efivars: Registered efivars operations1508machine # [ 0.307409] FPGA manager framework1509machine # [ 0.308268] vgaarb: loaded1510machine # [ 0.308928] clocksource: Switched to clocksource arch_sys_counter1511machine # [ 0.309249] VFS: Disk quotas dquot_6.6.01512machine # [ 0.309280] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1513machine # [ 0.313248] netfs: FS-Cache loaded1514machine # [ 0.313362] pnp: PnP ACPI init1515machine # [ 0.313574] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved1516machine # [ 0.313639] pnp: PnP ACPI: found 1 devices1517machine # [ 0.319136] NET: Registered PF_INET protocol family1518machine # [ 0.319214] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1519machine # [ 0.338864] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1520machine # [ 0.338912] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1521machine # [ 0.338941] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1522machine # [ 0.338985] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1523machine # [ 0.339062] TCP: Hash tables configured (established 8192 bind 8192)1524machine # [ 0.339144] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1525machine # [ 0.339185] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1526machine # [ 0.339212] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1527machine # [ 0.339322] NET: Registered PF_UNIX/PF_LOCAL protocol family1528machine # [ 0.339346] NET: Registered PF_XDP protocol family1529machine # [ 0.340079] PCI: CLS 0 bytes, default 641530machine # [ 0.340325] Trying to unpack rootfs image as initramfs...1531machine # [ 0.358358] kvm [1]: HYP mode not available1532machine # [ 0.449486] Initialise system trusted keyrings1533machine # [ 0.450270] workingset: timestamp_bits=42 max_order=18 bucket_order=01534machine # [ 0.451546] squashfs: version 4.0 (2009/01/31) Phillip Lougher1535machine # [ 0.452321] 9p: Installing v9fs 9p2000 file system support1536machine # [ 0.481027] Key type asymmetric registered1537machine # [ 0.481060] Asymmetric key parser 'x509' registered1538machine # [ 0.481134] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1539machine # [ 0.483251] io scheduler mq-deadline registered1540machine # [ 0.483265] io scheduler kyber registered1541machine # [ 0.492963] ledtrig-cpu: registered to indicate activity on CPUs1542machine # [ 0.494986] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input01543machine # [ 0.495046] ACPI: button: Power Button [PWRB]1544machine # [ 0.520011] ACPI: \_SB_.L001: Enabled at IRQ 361545machine # [ 0.520067] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1546machine # [ 0.530499] ACPI: \_SB_.L002: Enabled at IRQ 371547machine # [ 0.530602] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)1548machine # [ 0.532223] ACPI: \_SB_.L003: Enabled at IRQ 381549machine # [ 0.532253] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1550machine # [ 0.537053] ACPI: \_SB_.L000: Enabled at IRQ 351551machine # [ 0.537090] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1552machine # [ 0.539201] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1553machine # [ 0.549275] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)1554machine # [ 0.551166] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1555machine # [ 0.561342] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)1556machine # [ 0.573332] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1557machine # [ 0.576085] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)1558machine # [ 0.577883] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)1559machine # [ 0.590378] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1560machine # [ 0.593066] msm_serial: driver initialized1561machine # [ 0.593200] SuperH (H)SCI(F) driver initialized1562machine # [ 0.593242] STM32 USART driver initialized1563machine # [ 0.620006] ACPI: bus type drm_connector registered1564machine # [ 0.626697] loop: module loaded1565machine # [ 0.626908] virtio_blk virtio5: 1/0/0 default/read/poll queues1566machine # [ 0.627540] virtio_blk virtio5: [vda] 4929536 512-byte logical blocks (2.52 GB/2.35 GiB)1567machine # [ 0.676992] vda: vda1 vda21568machine # [ 0.677423] virtio_blk virtio6: 1/0/0 default/read/poll queues1569machine # [ 0.678175] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1570machine # [ 0.685667] megasas: 07.734.00.00-rc11571machine # [ 0.688110] tun: Universal TUN/TAP device driver, 1.61572machine # [ 0.692224] thunder_xcv, ver 1.01573machine # [ 0.692281] thunder_bgx, ver 1.01574machine # [ 0.692309] nicpf, ver 1.01575machine # [ 0.692883] e1000: Intel(R) PRO/1000 Network Driver1576machine # [ 0.692894] e1000: Copyright (c) 1999-2006 Intel Corporation.1577machine # [ 0.695346] e1000e: Intel(R) PRO/1000 Network Driver1578machine # [ 0.695362] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1579machine # [ 0.695412] igb: Intel(R) Gigabit Ethernet Network Driver1580machine # [ 0.695420] igb: Copyright (c) 2007-2014 Intel Corporation.1581machine # [ 0.695449] igbvf: Intel(R) Gigabit Virtual Function Network Driver1582machine # [ 0.695458] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1583machine # [ 0.695599] sky2: driver version 1.301584machine # [ 0.697821] ehci-pci 0000:00:0b.0: EHCI Host Controller1585machine # [ 0.697853] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 11586machine # [ 0.698143] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a0001587machine # [ 0.705111] usbcore: registered new interface driver usb-storage1588machine # [ 0.705171] usbcore: registered new interface driver usbserial_generic1589machine # [ 0.705190] usbserial: USB Serial support registered for generic1590machine # [ 0.705764] hv_vmbus: registering driver hyperv_keyboard1591machine # [ 0.708984] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.001592machine # [ 0.709358] hub 1-0:1.0: USB hub found1593machine # [ 0.709387] hub 1-0:1.0: 6 ports detected1594machine # [ 0.711910] rtc-efi rtc-efi.0: registered as rtc01595machine # [ 0.712512] rtc-efi rtc-efi.0: setting system clock to 2026-08-29T14:08:15 UTC (1788012495)1596machine # [ 0.712829] i2c_dev: i2c /dev entries driver1597machine # [ 0.716836] sdhci: Secure Digital Host Controller Interface driver1598machine # [ 0.716851] sdhci: Copyright(c) Pierre Ossman1599machine # [ 0.725257] Synopsys Designware Multimedia Card Interface Driver1600machine # [ 0.725616] sdhci-pltfm: SDHCI platform and OF driver helper1601machine # [ 0.726710] pstore: Using crash dump compression: deflate1602machine # [ 0.726721] pstore: Registered efi_pstore as persistent store backend1603machine # [ 0.730525] hid: raw HID events driver (C) Jiri Kosina1604machine # [ 0.730826] usbcore: registered new interface driver usbhid1605machine # [ 0.730836] usbhid: USB HID core driver1606machine # [ 0.733816] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available1607machine # [ 0.735295] drop_monitor: Initializing network drop monitor service1608machine # [ 0.735460] NET: Registered PF_INET6 protocol family1609machine # [ 0.745532] Segment Routing with IPv61610machine # [ 0.745581] In-situ OAM (IOAM) with IPv61611machine # [ 0.745615] NET: Registered PF_PACKET protocol family1612machine # [ 0.747267] 9pnet: Installing 9P2000 support1613machine # [ 0.750077] Key type dns_resolver registered1614machine # [ 0.764722] registered taskstats version 11615machine # [ 0.764924] Loading compiled-in X.509 certificates1616machine # [ 0.783690] Demotion targets for Node 0: null1617machine # [ 0.784545] Key type .fscrypt registered1618machine # [ 0.784560] Key type fscrypt-provisioning registered1619machine # [ 0.784686] ima: No TPM chip found, activating TPM-bypass!1620machine # [ 0.784710] ima: Allocated hash algorithm: sha11621machine # [ 0.784736] ima: No architecture policies found1622machine # [ 0.822365] clk: Disabling unused clocks1623machine # [ 0.822406] PM: genpd: Disabling unused power domains1624machine # [ 0.964976] usb 1-1: new high-speed USB device number 2 using ehci-pci1625machine # [ 0.972037] Freeing initrd memory: 26424K1626machine # [ 0.975620] Freeing unused kernel memory: 4736K1627machine # [ 0.975813] Run /init as init process1628machine # [ 0.993748] fuse: init (API version 7.45)1629machine # [ 1.005106] systemd[1]: Successfully made /usr/ read-only.1630machine # [ 1.117239] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:0b.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11631machine # [ 1.189364] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0b.0-1/input01632machine # [ 1.313022] usb 1-2: new high-speed USB device number 3 using ehci-pci1633machine # [ 1.339855] systemd[1]: systemd 262-a11144d 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)1634machine # [ 1.351867] systemd[1]: Detected virtualization kvm.1635machine # [ 1.353938] systemd[1]: Detected architecture arm64.1636machine # [ 1.355782] systemd[1]: Running in initrd.1637machine # [ 1.358433] systemd[1]: Initializing machine ID from random generator.1638machine # [ 1.361291] systemd[1]: Hostname set to <machine>.1639machine # [ 1.491829] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:0b.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21640machine # [ 1.494358] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input01641machine # [ 1.517225] systemd[1]: bpf-restrict-fs: LSM BPF program attached1642machine # [ 1.578354] systemd[1]: Queued start job for default target Initrd Default Target.1643machine # [ 1.586886] systemd[1]: Created slice Slice /system/modprobe.1644machine # [ 1.588231] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1645machine # [ 1.589184] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1646machine # [ 1.590183] systemd[1]: Expecting device /dev/mapper/cryptroot...1647machine # [ 1.590937] systemd[1]: Expecting device /dev/tpm0...1648machine # [ 1.591560] systemd[1]: Expecting device /dev/tpmrm0...1649machine # [ 1.592203] systemd[1]: Expecting device /dev/vdb...1650machine # [ 1.592828] systemd[1]: Reached target Path Units.1651machine # [ 1.593497] systemd[1]: Reached target Slice Units.1652machine # [ 1.594124] systemd[1]: Reached target Swaps.1653machine # [ 1.594673] systemd[1]: Reached target Timer Units.1654machine # [ 1.595437] systemd[1]: Listening on D-Bus System Message Bus Socket.1655machine # [ 1.596347] systemd[1]: Listening on Journal Socket (/dev/log).1656machine # [ 1.597226] systemd[1]: Listening on Journal Sockets.1657machine # [ 1.597940] systemd[1]: Listening on udev Kernel Socket.1658machine # [ 1.598602] systemd[1]: Reached target Socket Units.1659machine # [ 1.600449] systemd[1]: Starting Create List of Static Device Nodes...1660machine # [ 1.608389] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1661machine # [ 1.609391] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1662machine # [ 1.625763] systemd[1]: Mounting Kernel Configuration File System...1663machine # [ 1.641173] systemd[1]: Starting Journal Service...1664machine # [ 1.643296] systemd[1]: Starting Load Kernel Modules...1665machine # [ 1.654014] systemd[1]: Starting Coldplug All udev Devices...1666machine # [ 1.673228] systemd[1]: Finished Create List of Static Device Nodes.1667machine # [ 1.674455] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1668machine # [ 1.674756] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1669machine # [ 1.701172] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1670machine # [ 1.701791] systemd[1]: Mounted Kernel Configuration File System.1671machine # [ 1.704629] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1672machine # [ 1.714357] systemd-journald[73]: Collecting audit messages is disabled.1673machine # [ 1.717122] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1674machine # [ 1.721982] [drm] pci: virtio-gpu-pci detected at 0000:00:09.01675machine # [ 1.722225] [drm] features: -virgl +edid -resource_blob -host_visible1676machine # [ 1.722234] [drm] features: -context_init1677machine # [ 1.722942] [drm] number of scanouts: 11678machine # [ 1.722959] [drm] number of cap sets: 01679machine # [ 1.737577] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1680machine # [ 1.741306] systemd[1]: Starting Create Static Device Nodes in /dev...1681machine # [ 1.749441] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic1682machine # [ 1.749462] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 01683machine # [ 1.765216] Console: switching to colour frame buffer device 160x501684machine # [ 1.790810] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device1685machine # [ 1.805709] systemd[1]: Finished Create Static Device Nodes in /dev.1686machine # [ 1.805982] systemd[1]: Reached target Preparation for Local File Systems.1687machine # [ 1.806034] systemd[1]: Reached target Local File Systems.1688machine # [ 1.811172] systemd[1]: Starting Rule-based Manager for Device Events and Files...1689machine # [ 1.829088] systemd[1]: Finished Load Kernel Modules.1690machine # [ 1.832323] systemd[1]: Starting Apply Kernel Variables...1691machine # [ 1.881105] systemd[1]: Finished Apply Kernel Variables.1692machine # [ 1.905233] systemd[1]: Started Journal Service.1693machine # [ 1.880349] systemd-modules-load[74]: Inserted module 'dm_mod'1694machine # [ 1.892336] systemd-modules-load[74]: Module 'virtio_balloon' is built in1695machine # [ 1.893603] systemd-modules-load[74]: Module 'virtio_console' is built in1696machine # [ 1.896326] systemd-modules-load[74]: Inserted module 'virtio_gpu'1697machine # [ 1.900407] systemd-modules-load[74]: Module 'virtio_rng' is built in1698machine # [ 1.908373] systemd[1]: Starting Create System Files and Directories...1699machine # [ 1.914466] systemd-udevd[79]: Using default interface naming scheme 'v261'.1700machine # [ 1.954204] systemd[1]: Finished Create System Files and Directories.1701machine # [ 1.980208] systemd[1]: Started Rule-based Manager for Device Events and Files.1702machine # [ 2.070221] systemd[1]: Starting Virtual Console Setup...1703machine # [ 2.144807] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.1704machine # [ 2.149468] systemd[1]: Finished Virtual Console Setup.1705machine # [ 2.957499] systemd[1]: Finished Coldplug All udev Devices.1706machine # [ 3.127406] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1707machine # [ 3.158524] systemd[1]: Found device /dev/vdb.1708machine # [ 3.169881] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1709machine # [ 3.174504] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1710machine # [ 4.308776] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)1711machine # [ 4.451516] systemd[1]: Found device /dev/tpm0.1712machine # [ 4.470625] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1713machine # [ 4.475453] systemd[1]: Stopped Virtual Console Setup.1714machine # [ 4.476702] systemd[1]: Stopping Virtual Console Setup...1715machine # [ 4.480442] systemd[1]: Starting Virtual Console Setup...1716machine # [ 4.488111] systemd[1]: Found device /dev/tpmrm0.1717machine # [ 4.489322] systemd[1]: Reached target Trusted Platform Module.1718machine # [ 4.490222] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1719machine # [ 4.497256] systemd[1]: Starting Cryptography Setup for cryptroot...1720machine # [ 4.534761] systemd-vconsole-setup[113]: Configuration of first virtual console was skipped, ignoring remaining ones.1721machine # [ 4.539827] systemd[1]: Finished Virtual Console Setup.1722machine # [ 4.910692] Key type trusted registered1723machine # [ 4.914462] Key type encrypted registered1724machine # [ 4.935026] systemd[1]: Finished Cryptography Setup for cryptroot.1725machine # [ 4.936677] systemd[1]: Reached target Local Encrypted Volumes.1726machine # [ 4.938793] systemd[1]: Reached target System Initialization.1727machine # [ 4.940808] systemd[1]: Reached target Basic System.1728machine # [ 4.955336] systemd[1]: Found device /dev/mapper/cryptroot.1729machine # [ 4.956447] systemd[1]: Reached target Initrd Root Device.1730machine # [ 4.964346] systemd[1]: Starting File System Check on /dev/mapper/cryptroot...1731machine # [ 4.992371] systemd-fsck[129]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks1732machine # [ 4.999745] systemd[1]: Finished File System Check on /dev/mapper/cryptroot.1733machine # [ 5.003292] systemd[1]: Mounting /sysroot...1734machine # [ 5.105378] EXT4-fs (dm-0): mounted filesystem 67957db4-9a00-402d-ba23-e850542b2318 r/w with ordered data mode. Quota mode: none.1735machine # [ 5.080979] systemd[1]: Mounted /sysroot.1736machine # [ 5.082354] systemd[1]: Reached target Initrd Root File System.1737machine # [ 5.084899] systemd[1]: Starting Mountpoints Configured in the Real Root...1738machine # [ 5.104196] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1739machine # [ 5.107469] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1740machine # [ 5.111416] systemd[1]: Reloading...1741machine # [ 5.237071] systemd[1]: Reloading finished in 127 ms.1742machine # [ 5.262483] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1743machine # [ 5.265104] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1744machine # [ 5.269052] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1745machine # [ 5.271078] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1746machine # [ 5.276317] systemd[1]: Finished Mountpoints Configured in the Real Root.1747machine # [ 5.277461] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1748machine # [ 5.292083] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1749machine # [ 5.293629] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1750machine # [ 5.503125] systemd[1]: Mounting /sysroot/nix/.ro-store...1751machine # [ 5.513995] systemd[1]: Mounting /sysroot/nix/.rw-store...1752machine # [ 5.535733] systemd[1]: Mounting /sysroot/run...1753machine # [ 5.563386] systemd[1]: Mounting /sysroot/tmp/shared...1754machine # [ 5.569506] systemd[1]: Mounting /sysroot/tmp/xchg...1755machine # [ 5.611243] systemd[1]: Mounted /sysroot/nix/.ro-store.1756machine # [ 5.624383] systemd[1]: Mounted /sysroot/nix/.rw-store.1757machine # [ 5.626268] systemd[1]: Mounted /sysroot/run.1758machine # [ 5.636303] systemd[1]: Starting rw-sysroot-nix-store.service...1759machine # [ 5.639034] systemd[1]: Mounted /sysroot/tmp/shared.1760machine # [ 5.639814] systemd[1]: Mounted /sysroot/tmp/xchg.1761machine # [ 5.656738] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1762machine # [ 5.660107] systemd[1]: Finished rw-sysroot-nix-store.service.1763machine # [ 5.661742] systemd[1]: Mounting /sysroot/nix/store...1764machine # [ 5.697964] systemd[1]: Mounted /sysroot/nix/store.1765machine # [ 5.700162] systemd[1]: Reached target Initrd File Systems.1766machine # [ 5.702303] systemd[1]: Starting Find NixOS closure...1767machine # [ 5.709222] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1768machine # [ 5.742066] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1769machine # [ 5.754080] systemd[1]: Finished Find NixOS closure.1770machine # [ 5.756221] systemd[1]: Reached target Initrd Default Target.1771machine # [ 5.758836] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1772machine # [ 5.784997] systemd[1]: initrd-cleanup.service: Deactivated successfully.1773machine # [ 5.786529] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1774machine # [ 5.789343] systemd[1]: Stopped target Initrd Default Target.1775machine # [ 5.792191] systemd[1]: Stopped target Basic System.1776machine # [ 5.793053] systemd[1]: Stopped target Initrd Root Device.1777machine # [ 5.794964] systemd[1]: Stopped target Path Units.1778machine # [ 5.795746] systemd[1]: Stopped target Slice Units.1779machine # [ 5.797951] systemd[1]: Stopped target Socket Units.1780machine # [ 5.800203] systemd[1]: Stopped target System Initialization.1781machine # [ 5.801112] systemd[1]: Stopped target Local Encrypted Volumes.1782machine # [ 5.801931] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1783machine # [ 5.802961] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1784machine # [ 5.807498] systemd[1]: Stopped target Swaps.1785machine # [ 5.808685] systemd[1]: Stopped target Timer Units.1786machine # [ 5.810991] systemd[1]: Stopped target Trusted Platform Module.1787machine # [ 5.820389] systemd[1]: dbus.socket: Deactivated successfully.1788machine # [ 5.825143] systemd[1]: Closed D-Bus System Message Bus Socket.1789machine # [ 5.831179] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1790machine # [ 5.836347] systemd[1]: Stopped Find NixOS closure.1791machine # [ 5.838454] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1792machine # [ 5.841345] systemd[1]: Starting rw-sysroot-nix-store.service...1793machine # [ 5.843178] systemd[1]: systemd-sysctl.service: Deactivated successfully.1794machine # [ 5.845292] systemd[1]: Stopped Apply Kernel Variables.1795machine # [ 5.847719] systemd[1]: systemd-modules-load.service: Deactivated successfully.1796machine # [ 5.850373] systemd[1]: Stopped Load Kernel Modules.1797machine # [ 5.852150] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1798machine # [ 5.855678] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1799machine # [ 5.857061] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1800machine # [ 5.858076] systemd[1]: Stopped Create System Files and Directories.1801machine # [ 5.858943] systemd[1]: Stopped target Local File Systems.1802machine # [ 5.859709] systemd[1]: Stopped target Preparation for Local File Systems.1803machine # [ 5.860794] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1804machine # [ 5.861796] systemd[1]: Stopped Coldplug All udev Devices.1805machine # [ 5.862562] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1806machine # [ 5.863564] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1807machine # [ 5.868272] systemd[1]: Stopped Virtual Console Setup.1808machine # [ 5.869082] systemd[1]: systemd-udevd.service: Deactivated successfully.1809machine # [ 5.872353] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1810machine # [ 5.873529] systemd[1]: systemd-udevd.service: Consumed 1.801s CPU time over 4.055s wall clock time, 22M memory peak.1811machine # [ 5.880149] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1812machine # [ 5.881203] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1813machine # [ 5.882047] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1814machine # [ 5.883025] systemd[1]: Finished rw-sysroot-nix-store.service.1815machine # [ 5.883833] systemd[1]: Starting Cleanup udev Database...1816machine # [ 5.888385] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1817machine # [ 5.889425] systemd[1]: Stopped Create Static Device Nodes in /dev.1818machine # [ 5.890261] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1819machine # [ 5.891316] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1820machine # [ 5.896211] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1821machine # [ 5.897181] systemd[1]: Stopped Create List of Static Device Nodes.1822machine # [ 5.923089] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1823machine # [ 5.926632] systemd[1]: Finished Cleanup udev Database.1824machine # [ 5.927404] systemd[1]: Reached target Switch Root.1825machine # [ 5.932271] systemd[1]: Starting NixOS Activation...1826machine # [ 6.103060] initrd-nixos-activation-start[190]: booting system configuration /nix/store/hfqx4b6pfbdbwr4scjn871iav48d6sm0-nixos-system-machine-test1827machine # [ 6.169319] initrd-nixos-activation-start[190]: running activation script...1828machine # [ 6.611871] initrd-nixos-activation-start[213]: setting up /etc...1829machine # [ 6.887486] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1830machine # [ 6.890457] systemd[1]: Finished NixOS Activation.1831machine # [ 6.891641] systemd[1]: Starting Switch Root...1832machine # [ 6.916893] systemd[1]: Switching root.1833machine # [ 7.118600] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1834machine # [ 7.319030] NET: Registered PF_VSOCK protocol family1835machine # [ 7.715951] systemd[1]: systemd 262-a11144d 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)1836machine # [ 7.728568] systemd[1]: Detected virtualization kvm.1837machine # [ 7.732419] systemd[1]: Detected architecture arm64.1838machine # [ 7.734583] systemd[1]: Detected first boot.1839machine # [ 7.741948] systemd[1]: Initializing machine ID from random generator.1840machine # [ 7.921516] systemd[1]: bpf-restrict-fs: LSM BPF program attached1841machine # [ 8.080984] systemd[1]: Applying preset policy.1842machine # [ 8.582617] systemd[1]: Populated /etc with preset unit settings.1843machine # [ 9.137954] systemd[1]: initrd-switch-root.service: Deactivated successfully.1844machine # [ 9.139682] systemd[1]: Stopped initrd-switch-root.service.1845machine # [ 9.142968] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1846machine # [ 9.147147] systemd[1]: Created slice Slice /system/getty.1847machine # [ 9.150275] systemd[1]: Created slice Slice /system/systemd-fsck.1848machine # [ 9.152283] systemd[1]: Created slice User and Session Slice.1849machine # [ 9.153613] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1850machine # [ 9.156273] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1851machine # [ 9.157724] systemd[1]: Expecting device /dev/disk/by-label/ESP...1852machine # [ 9.159315] systemd[1]: Expecting device /dev/hvc0...1853machine # [ 9.160818] systemd[1]: Expecting device /dev/ttyAMA0...1854machine # [ 9.162388] systemd[1]: Reached target Local Encrypted Volumes.1855machine # [ 9.163971] systemd[1]: Stopped target initrd-fs.target.1856machine # [ 9.165567] systemd[1]: Stopped target initrd-root-fs.target.1857machine # [ 9.167953] systemd[1]: Stopped target initrd-switch-root.target.1858machine # [ 9.169099] systemd[1]: Reached target Virtual Machines and Containers.1859machine # [ 9.171570] systemd[1]: Reached target Path Units.1860machine # [ 9.172530] systemd[1]: Reached target Remote File Systems.1861machine # [ 9.174151] systemd[1]: Reached target Slice Units.1862machine # [ 9.176411] systemd[1]: Reached target Swaps.1863machine # [ 9.180170] systemd[1]: Listening on Query the User Interactively for a Password.1864machine # [ 9.185096] systemd[1]: Listening on Process Core Dump Socket.1865machine # [ 9.189038] systemd[1]: Listening on Credential Encryption/Decryption.1866machine # [ 9.192710] systemd[1]: Listening on Factory Reset Management.1867machine # [ 9.194011] systemd[1]: Listening on Hostname Service Socket.1868machine # [ 9.199636] systemd[1]: Starting Journal Log Access Socket...1869machine # [ 9.201804] systemd[1]: Listening on Journal Audit Socket.1870machine # [ 9.206122] systemd[1]: Listening on Console Output Muting Service Socket.1871machine # [ 9.207704] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1872machine # [ 9.209745] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1873machine # [ 9.211553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1874machine # [ 9.222820] systemd[1]: Listening on Disk Repartitioning Service Socket.1875machine # [ 9.223284] systemd[1]: Listening on udev Varlink Socket.1876machine # [ 9.228593] systemd[1]: Mounting Huge Pages File System...1877machine # [ 9.232896] systemd[1]: Mounting POSIX Message Queue File System...1878machine # [ 9.243136] systemd[1]: Mounting Kernel Debug File System...1879machine # [ 9.252383] systemd[1]: Mounting Kernel Trace File System...1880machine # [ 9.265201] systemd[1]: Starting Create List of Static Device Nodes...1881machine # [ 9.279193] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1882machine # [ 9.282528] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1883machine # [ 9.296131] systemd[1]: Mounting Kernel Configuration File System...1884machine # [ 9.299264] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1885machine # [ 9.301896] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1886machine # [ 9.309128] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1887machine # [ 9.349128] systemd[1]: Mounting FUSE Control File System...1888machine # [ 9.349515] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully.1889machine # [ 9.349788] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service.1890machine # [ 9.364067] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671891machine # [ 9.401044] systemd[1]: Starting Journal Service...1892machine # [ 9.412760] systemd[1]: Starting Load Kernel Modules...1893machine # [ 9.430029] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1894machine # [ 9.456626] systemd[1]: Starting Remount Root and Kernel File Systems...1895machine # [ 9.458244] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1896machine # [ 9.468922] systemd[1]: Starting Coldplug All udev Devices...1897machine # [ 9.500146] systemd[1]: Listening on Journal Log Access Socket.1898machine # [ 9.520018] systemd[1]: Mounted Huge Pages File System.1899machine # [ 9.528543] systemd[1]: Mounted POSIX Message Queue File System.1900machine # [ 9.530928] systemd-journald[285]: Collecting audit messages is enabled.1901machine # [ 9.537322] systemd[1]: Mounted Kernel Debug File System.1902machine # [ 9.541076] systemd[1]: Mounted Kernel Trace File System.1903machine # [ 9.519331] systemd[1]: Queued start job for default target Multi-User System.[ 9.549460] systemd[1]: Finished Create List of Static Device Nodes.1904machine # [ 9.550135] systemd[1]: Started Journal Service.1905machine # 1906machine # [ 9.533057] systemd[1]: systemd-journald.service: Deactivated successfully.1907machine # [ 9.540722] systemd-modules-load[286]: Module 'atkbd' is built in1908machine # [ 9.550403] systemd-modules-load[286]: Module 'loop' is built in1909machine # [ 9.551747] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1910machine # [ 9.555391] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1911machine # [ 9.564562] systemd[1]: Mounted Kernel Configuration File System.1912machine # [ 9.570387] systemd[1]: Mounted FUSE Control File System.1913machine # [ 9.571315] systemd[1]: Finished Load Kernel Modules.1914machine # [ 9.575983] systemd[1]: Starting Firewall...1915machine # [ 9.582915] systemd[1]: Starting Apply Kernel Variables...1916machine # [ 9.593283] systemd-oomd[287]: No swap; memory pressure usage will be degraded1917machine # [ 9.596814] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1918machine # [ 9.628987] EXT4-fs (dm-0): re-mounted 67957db4-9a00-402d-ba23-e850542b2318.1919machine # [ 9.615426] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1920machine # [ 9.628061] systemd[1]: Finished Remount Root and Kernel File Systems.1921machine # [ 9.671879] systemd[1]: Listening on Disk Image Download Service Socket.1922machine # [ 9.684286] systemd[1]: Starting Flush Journal to Persistent Storage...1923machine # [ 9.685700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1924machine # [ 9.694647] systemd[1]: Starting Load/Save OS Random Seed...1925machine # [ 9.704873] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1926machine # [ 9.762404] systemd[1]: Finished Apply Kernel Variables.1927machine # [ 9.790190] systemd[1]: Finished Load/Save OS Random Seed.1928machine # [ 9.791319] systemd[1]: Reached target First Boot Complete.1929machine # [ 9.822822] systemd-journald[285]: Received client request to flush runtime journal.1930machine # [ 9.837354] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1931machine # [ 9.842088] systemd[1]: Starting Create Static Device Nodes in /dev...1932machine # [ 9.849922] systemd[1]: Finished Flush Journal to Persistent Storage.1933machine # [ 9.928192] systemd[1]: Finished Create Static Device Nodes in /dev.1934machine # [ 9.929577] systemd[1]: Reached target Preparation for Local File Systems.1935machine # [ 9.933030] systemd[1]: Starting Rule-based Manager for Device Events and Files...1936machine # [ 10.045489] systemd-udevd[323]: Using default interface naming scheme 'v261'.1937machine # [ 10.113108] systemd[1]: Mounting /run/wrappers...1938machine # [ 10.187544] systemd[1]: Mounted /run/wrappers.1939machine # [ 10.202862] systemd[1]: Starting Create SUID/SGID Wrappers...1940machine # [ 10.245009] systemd[1]: Started Rule-based Manager for Device Events and Files.1941machine # [ 10.968722] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1942machine # [ 10.973128] systemd[1]: Finished Create SUID/SGID Wrappers.1943machine # [ 11.366576] systemd[1]: Finished Coldplug All udev Devices.1944machine # [ 11.426510] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1945machine # [ 11.438682] systemd[1]: Finished Firewall.1946machine # [ 11.452444] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1947machine # [ 11.559598] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1948machine # [ 11.587300] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1949machine # [ 11.616135] systemd[1]: Found device /dev/tpmrm0.1950machine # [ 11.617466] systemd[1]: Expecting device /dev/tpm0...1951machine # [ 11.625935] (udev-worker)[358]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1952machine # [ 11.630935] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line.1953machine # [ 11.633971] (udev-worker)[358]: Network interface NamePolicy= disabled on kernel command line.1954machine # [ 11.744395] systemd[1]: Condition check resulted in Virtio network device being skipped.1955machine # [ 11.746731] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1956machine # [ 11.752168] systemd[1]: Starting Create SUID/SGID Wrappers...1957machine # [ 11.755040] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671958machine # [ 11.765142] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1959machine # [ 11.928176] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.1960machine # [ 11.937981] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...1961machine # [ 12.053974] systemd-fsck[512]: fsck.fat 4.2 (2021-01-31)1962machine # [ 12.055799] systemd-fsck[512]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.1963machine # [ 12.061966] systemd-fsck[512]: Automatically removing dirty bit.1964machine # [ 12.067511] systemd-fsck[512]: *** Filesystem was changed ***1965machine # [ 12.072497] systemd-fsck[512]: Writing changes.1966machine # [ 12.073195] systemd-fsck[512]: /dev/vda1: 20 files, 28955/63671 clusters1967machine # [ 12.074461] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.1968machine # [ 12.078749] systemd[1]: Mounting /boot...1969machine # [ 12.185206] systemd[1]: Mounted /boot.1970machine # [ 12.185950] systemd[1]: Reached target Local File Systems.1971machine # [ 12.189746] systemd[1]: Listening on Boot Loader Control Service Socket.1972machine # [ 12.221439] mousedev: PS/2 mouse device common for all mice1973machine # [ 12.198520] systemd[1]: Starting register-nix-paths.service...1974machine # [ 12.215142] systemd[1]: Starting Update Boot Loader Random Seed...1975machine # [ 12.225536] systemd[1]: Starting Save Transient machine-id to Disk...1976machine # [ 12.232142] systemd[1]: Starting Create System Files and Directories...1977machine # [ 12.312397] systemd[1]: Finished register-nix-paths.service.1978machine # [ 12.347927] bootctl[535]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 1979machine # [ 12.359226] bootctl[535]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!1980machine # [ 12.385138] bootctl[535]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).1981machine # [ 12.391459] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1982machine # [ 12.396947] systemd[1]: Finished Save Transient machine-id to Disk.1983machine # [ 12.404980] systemd[1]: Finished Update Boot Loader Random Seed.1984machine # [ 12.431160] systemd[1]: Finished Create System Files and Directories.1985machine # [ 12.440287] systemd[1]: Starting Rebuild Journal Catalog...1986machine # [ 12.447619] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1987machine # [ 12.502557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1988machine # [ 12.507361] systemd[1]: Finished Create SUID/SGID Wrappers.1989machine # [ 12.523679] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1990machine # [ 12.569237] systemd[1]: Finished Rebuild Journal Catalog.1991machine # [ 12.575283] systemd[1]: Starting Update is Completed...1992machine # [ 12.622962] systemd[1]: Finished Update is Completed.1993machine # [ 13.451090] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input31994machine # [ 13.484413] systemd[1]: Found device /dev/tpm0.1995machine # [ 13.488084] systemd[1]: Reached target Trusted Platform Module.1996machine # [ 13.489018] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1997machine # [ 13.490324] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1998machine # [ 13.491530] systemd[1]: Reached target System Initialization.1999machine # [ 13.499769] systemd[1]: Started Discard unused filesystem blocks once a week.2000machine # [ 13.503327] systemd[1]: Started Daily Cleanup of Temporary Directories.2001machine # [ 13.507017] systemd[1]: Reached target Timer Units.2002machine # [ 13.512446] systemd[1]: Listening on D-Bus System Message Bus Socket.2003machine # [ 13.515164] systemd[1]: Listening on Nix Daemon Socket.2004machine # [ 13.516805] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2005machine # [ 13.520187] systemd[1]: Reached target Socket Units.2006machine # [ 13.521710] systemd[1]: Reached target Basic System.2007machine # [ 13.525827] systemd[1]: Started backdoor.service.2008machine # [ 13.526620] systemd[1]: Starting Import lastlog data into lastlog2 database...2009machine # [ 13.529318] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2010machine # [ 13.554470] systemd[1]: Starting Post-Boot Actions...2011machine # [ 13.576744] systemd[1]: Started Reset console on configuration changes.2012machine # [ 13.594954] systemd[1]: Starting resolvconf update...2013machine # [ 13.657101] systemd[1]: Starting D-Bus System Message Bus...2014machine # connecting to host...2015machine # [ 13.716554] systemd[1]: Finished Post-Boot Actions.2016machine # [ 13.743492] nsncd[583]: Aug 29 14:08:28.558 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2017machine # [ 13.759167] systemd[1]: Started Name Service Cache Daemon (nsncd).2018machine: Guest shell says: b'Spawning backdoor root shell...\n'2019machine # [ 13.763615] systemd[1]: Reached target Host and Network Name Lookups.2020machine # [ 13.774084] systemd[1]: Reached target User and Group Name Lookups.2021machine # [ 13.774929] systemd[1]: Starting User Login Management...2022machine # [ 13.806096] systemd[1]: Finished Import lastlog data into lastlog2 database.2023machine: connected to guest root shell2024machine: (connecting took 26.88 seconds)2025machine: (finished: waiting for the VM to finish booting, in 29.27 seconds)2026machine # [ 13.903525] dbus-broker-launch[591]: Looking up NSS user entry for 'systemd-timesync'...2027machine # [ 13.911197] dbus-broker-launch[591]: NSS returned no entry for 'systemd-timesync'2028machine # [ 13.919160] dbus-broker-launch[591]: Invalid user-name in /nix/store/qf1x98x4gj8wlfy7y47x2r0p498iahwh-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2029machine # [ 13.983986] systemd-logind[609]: New seat seat0.2030machine # [ 13.994986] systemd-logind[609]: Watching system buttons on /dev/input/event0 (Power Button)2031machine # [ 13.997158] systemd-logind[609]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2032machine # [ 14.030449] dbus-broker-launch[591]: Ready2033machine # [ 14.048663] systemd[1]: Started D-Bus System Message Bus.2034machine # [ 14.052195] systemd[1]: Started User Login Management.2035machine # [ 14.086323] systemd[1]: Stopped target Host and Network Name Lookups.2036machine # [ 14.089242] systemd[1]: Stopping Host and Network Name Lookups...2037machine # [ 14.094807] systemd[1]: Stopped target User and Group Name Lookups.2038machine # [ 14.095679] systemd[1]: Stopping User and Group Name Lookups...2039machine # [ 14.104102] systemd[1]: Starting linger-users.service...2040machine # [ 14.104951] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2041machine # [ 14.120332] systemd[1]: Starting Virtual Console Setup...2042machine # [ 14.143692] systemd[1]: nscd.service: Deactivated successfully.2043machine # [ 14.147719] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2044machine # [ 14.195479] systemd-logind[609]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2045machine # [ 14.227369] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2046machine # [ 14.236284] systemd[1]: linger-users.service: Deactivated successfully.2047machine # [ 14.241864] systemd[1]: Finished linger-users.service.2048machine # [ 14.245039] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2049machine # [ 14.251618] systemd[1]: Stopped Virtual Console Setup.2050machine # [ 14.257531] systemd[1]: Finished resolvconf update.2051machine # [ 14.266727] systemd[1]: Reached target Preparation for Network.2052machine # [ 14.273473] systemd[1]: Starting DHCP Client...2053machine # [ 14.277932] systemd[1]: Starting Address configuration of eth1...2054machine # [ 14.297621] systemd[1]: Starting Extra networking commands....2055machine # [ 14.314987] nsncd[680]: Aug 29 14:08:29.129 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2056machine # [ 14.320254] systemd[1]: Starting Virtual Console Setup...2057machine # [ 14.328786] systemd[1]: Started Name Service Cache Daemon (nsncd).2058machine # [ 14.381374] systemd[1]: Reached target Host and Network Name Lookups.2059machine # [ 14.383989] systemd[1]: Reached target User and Group Name Lookups.2060machine # [ 14.449844] network-addresses-eth1-start[688]: adding address 192.168.1.1/24... done2061machine # [ 14.469397] network-addresses-eth1-start[688]: adding address 2001:db8:1::1/64... done2062machine # [ 14.501599] systemd[1]: Finished Address configuration of eth1.2063machine # [ 14.541729] dhcpcd[705]: dhcpcd-10.3.2 starting2064machine # [ 14.555429] dhcpcd[750]: dev: loaded udev2065machine # [ 14.626980] 8021q: 802.1Q VLAN Support v1.82066machine # [ 14.627376] 8021q: adding VLAN 0 to HW filter on device eth12067machine # [ 14.605142] systemd[1]: Finished Extra networking commands..2068machine # [ 14.608242] systemd[1]: Reached target Network.2069machine # [ 14.613504] systemd[1]: Starting Permit User Sessions...2070machine # [ 14.655294] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2071machine # [ 14.674444] systemd[1]: Finished Permit User Sessions.2072machine # [ 14.684860] systemd[1]: Started Getty on tty1.2073machine # [ 14.687894] systemd[1]: Reached target Login Prompts.2074machine # [ 14.737623] cfg80211: Loading compiled-in X.509 certificates for regulatory database2075machine # [ 14.769333] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2076machine # [ 14.769818] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2077machine # [ 14.774361] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22078machine # [ 14.774669] cfg80211: failed to load regulatory.db2079machine # [ 14.842013] 8021q: adding VLAN 0 to HW filter on device eth02080machine # [ 14.815057] dhcpcd[750]: eth0: waiting for carrier2081machine # [ 14.817010] dhcpcd[750]: eth0: carrier acquired2082machine # [ 14.828465] dhcpcd[750]: DUID 00:01:00:01:32:25:a4:5d:52:54:00:12:34:562083machine # [ 14.829407] dhcpcd[750]: eth0: IAID 00:12:34:562084machine # [ 14.830032] dhcpcd[750]: eth0: adding address fe80::5054:ff:fe12:34562085machine # [ 14.965865] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones.2086machine # [ 14.970519] systemd[1]: Finished Virtual Console Setup.2087machine # [ 16.468324] dhcpcd[750]: eth0: soliciting a DHCP lease2088machine # [ 16.472732] dhcpcd[750]: eth0: offered 10.0.2.15 from 10.0.2.22089machine # [ 16.480218] dhcpcd[750]: eth0: probing address 10.0.2.15/242090machine # [ 17.141608] dhcpcd[750]: eth0: soliciting an IPv6 router2091machine # [ 17.145333] dhcpcd[750]: eth0: Router Advertisement from fe80::22092machine # [ 17.147834] dhcpcd[750]: eth0: adding address fec0::5054:ff:fe12:3456/642093machine # [ 17.150761] dhcpcd[750]: eth0: adding route to fec0::/642094machine # [ 17.153099] dhcpcd[750]: eth0: adding default route via fe80::22095machine # [ 22.073942] dhcpcd[750]: eth0: leased 10.0.2.15 for 86400 seconds2096machine # [ 22.075530] dhcpcd[750]: eth0: adding route to 10.0.2.0/242097machine # [ 22.078871] dhcpcd[750]: eth0: adding default route via 10.0.2.22098machine # [ 22.227671] systemd[1]: Started DHCP Client.2099machine # [ 22.229139] systemd[1]: Reached target Multi-User System.2100machine # [ 22.230412] systemd[1]: Startup finished in 8.268s (firmware) + 6.289s (loader) + 951ms (kernel) + 6.272s (initrd) + 15.005s (userspace) = 36.788s.2101machine: (finished: waiting for unit multi-user.target, in 38.67 seconds)2102machine: must succeed: mount2103machine: (finished: must succeed: mount, in 0.04 seconds)2104(finished: run the VM test script, in 78.16 seconds)2105test script finished in 78.21s2106cleanup2107kill QemuMachine (pid 93)2108machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2109(finished: cleanup, in 0.01 seconds)